[Bug 1160923] Re: udev gvfs timeout

[Martin Barlow]

warning on cmd line after timeout passes:

Error creating proxy: Error calling StartServiceByName for
org.gtk.vfs.Daemon: Timeout was reached (g-io-error-quark, 24)

(pwsafe:31636): GVFS-CRITICAL **: fill_mountable_info: assertion `proxy
!= NULL' failed

-- 
You received this bug notification because you are a member of Ubuntu
Foundations Bugs, which is subscribed to udev in Ubuntu.
https://bugs.launchpad.net/bugs/1160923

Title:
  udev gvfs timeout

Status in “udev” package in Ubuntu:
  New

Bug description:
  Running pwsafe has problems.

  It has two failure modes.

  1) It starts, waits 15 to 20 seconds then Window opens

  2) Does not start at all. The process is still running:

  For 1) an strace reveals:

  18966 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
  18966 open("/lib/x86_64-linux-gnu/libudev.so.0", O_RDONLY|O_CLOEXEC) = 9
  18966 read(9, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\2001\0\0\0\0\0\0"..., 832) = 832
  18966 fstat(9, {st_mode=S_IFREG|0644, st_size=51088, ...}) = 0
  18966 mmap(NULL, 2146352, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 9, 0) = 0x7f4abcdc0000
  18966 mprotect(0x7f4abcdcc000, 2093056, PROT_NONE) = 0
  18966 mmap(0x7f4abcfcb000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 9, 0xb000) = 0x7f4abcfcb000
  18966 close(9)                          = 0
  18966 mprotect(0x7f4abcfcb000, 4096, PROT_READ) = 0
  18966 mprotect(0x7f4abd226000, 20480, PROT_READ) = 0
  18966 mprotect(0x7f4abd45a000, 4096, PROT_READ) = 0
  18966 munmap(0x7f4abcfcd000, 146679)    = 0
  18966 rt_sigaction(SIGPIPE, {SIG_IGN, [PIPE], SA_RESTORER|SA_RESTART, 0x7f4ac7bb44a0}, {SIG_IGN, [PIPE], SA_RESTORER|SA_RESTART, 0x7f4ac7bb44a0}, 8) = 0
  18966 write(7, "\1\0\0\0\0\0\0\0", 8)   = 8
  18966 eventfd2(0, O_NONBLOCK|O_CLOEXEC) = 9
  18966 write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
  18966 write(7, "\1\0\0\0\0\0\0\0", 8)   = 8
  18966 poll([{fd=9, events=POLLIN}], 1, 25000) = 1 ([{fd=9, revents=POLLIN}])
  18966 poll([{fd=9, events=POLLIN}], 1, 25000) = 1 ([{fd=9, revents=POLLIN}])
  18966 read(9, "\1\0\0\0\0\0\0\0", 16)   = 8
  18966 poll([{fd=9, events=POLLIN}], 1, 25000) = 0 (Timeout)

  <WAITREALLYLONGTIMEHERE>

  18966 read(9, 0x7fff5a195540, 16)       = -1 EAGAIN (Resource temporarily unavailable)
  18966 poll([{fd=9, events=POLLIN}], 1, 0) = 0 (Timeout)
  18966 poll([{fd=9, events=POLLIN}], 1, 0) = 0 (Timeout)
  18966 write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
  18966 close(9)                          = 0
  18966 write(7, "\1\0\0\0\0\0\0\0", 8)   = 8
  18966 write(2, "Error creating proxy: Error call"..., 122) = 122
  18966 write(2, "\n(pwsafe:18966): GVFS-CRITICAL *"..., 89) = 89
  18966 openat(AT_FDCWD, "/usr/lib/x86_64-linux-gnu/gvfs/modules", O_RDONLY|O_NONBLOCK|O_DIRECTORY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
  <ContinuesOnOK.................>

  For 2) It reveals

  18897 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
  18897 open("/lib/x86_64-linux-gnu/libudev.so.0", O_RDONLY|O_CLOEXEC) = 10
  18897 read(10, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\2001\0\0\0\0\0\0"..., 832) = 832
  18897 fstat(10, {st_mode=S_IFREG|0644, st_size=51088, ...}) = 0
  18897 mmap(NULL, 2146352, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 10, 0) = 0x7fa408dc2000
  18897 mprotect(0x7fa408dce000, 2093056, PROT_NONE) = 0
  18897 mmap(0x7fa408fcd000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 10, 0xb000) = 0x7fa408fcd000
  18897 close(10)                         = 0
  18897 mprotect(0x7fa408fcd000, 4096, PROT_READ) = 0
  18897 mprotect(0x7fa409228000, 20480, PROT_READ) = 0
  18897 mprotect(0x7fa40945c000, 4096, PROT_READ) = 0
  18897 munmap(0x7fa408fcf000, 146679)    = 0
  18897 futex(0x7fa404005b80, FUTEX_WAIT_PRIVATE, 2, NULL) = ? ERESTARTSYS (To be restarted)
  18897 --- SIGINT (Interrupt) @ 0 (0) ---

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/udev/+bug/1160923/+subscriptions