[Bug 393643] New: multi-second busy-loop on login ...
https://bugzilla.novell.com/show_bug.cgi?id=393643 Summary: multi-second busy-loop on login ... Product: openSUSE 11.0 Version: Factory Platform: Other OS/Version: Other Status: NEW Severity: Major Priority: P5 - None Component: GNOME AssignedTo: bnc-team-gnome@forge.provo.novell.com ReportedBy: mmeeks@novell.com QAContact: qa@suse.de Found By: --- I log-in in a loop (shortly after zapping my X server), after a couple of times - I take a ~10-15 second pause before I get the splash screen showing up (in which to admire the green background) ;-) The strace shows heinous crimes going on: 1094 1211470318.839534 pipe([15, 16]) = 0 1094 1211470318.839571 fcntl64(15, F_GETFL) = 0 (flags O_RDONLY) 1094 1211470318.839598 fcntl64(15, F_SETFL, O_RDONLY|O_NONBLOCK) = 0 1094 1211470318.839625 fcntl64(16, F_GETFL) = 0x1 (flags O_WRONLY) 1094 1211470318.839652 fcntl64(16, F_SETFL, O_WRONLY|O_NONBLOCK) = 0 1094 1211470318.839703 rt_sigaction(SIGINT, {0x8070880, [INT], SA_RESTART}, {SIG_DFL}, 8) = 0 1094 1211470318.839754 rt_sigaction(SIGHUP, {0x8070880, [HUP], SA_RESTART}, {SIG_DFL}, 8) = 0 1094 1211470318.839801 rt_sigaction(SIGTERM, {0x8070880, [TERM], SA_RESTART}, {SIG_DFL}, 8) = 0 1094 1211470318.839874 fstat64(19, {st_mode=S_IFIFO|0600, st_size=0, ..}) = 0 1094 1211470318.839939 fcntl64(19, F_GETFL) = 0 (flags O_RDONLY) 1094 1211470318.840004 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.840041 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.840070 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.840102 poll([{fd=5, events=POLLIN}, {fd=7, events=POLLIN|POLLPRI}, {fd=9, events=POLLIN|POLLPRI, revents=POLLIN|POLLHUP}, {fd=10, events=POLLIN|POLLPRI}, {fd=11, events=POLLIN|POLLPRI, revents=POLLIN|POLLHUP}, {fd=12, events=POLLIN, revents=POLLIN}, {fd=13, events=POLLIN}, {fd=14, events=POLLIN}, {fd=19, events=POLLIN}, {fd=15, events=POLLIN}], 10, -1) = 3 1094 1211470318.840177 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.840207 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.840255 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.840309 read(9, "", 12) = 0 1094 1211470318.840360 close(9) = 0 1094 1211470318.840424 read(11, "", 12) = 0 1094 1211470318.840455 close(11) = 0 1094 1211470318.840553 accept(12, {sa_family=AF_FILE, path="xÖü¿TªÀ·@ÑÍ·ÅÚî·ôÿï·"}, [2]) = 9 1094 1211470318.840647 mmap2(NULL, 16384, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f93000 1094 1211470318.840684 mlock(0xb7f93000, 16384) = 0 1094 1211470318.840752 mmap2(NULL, 8392704, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7228000 1094 1211470318.840799 mprotect(0xb7228000, 4096, PROT_NONE) = 0 1094 1211470318.840838 clone(child_stack=0xb7a28474, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tidptr=0xb7a28bd8, {entry_number:6, base_addr:0xb7a28b90, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}, child_tidptr=0xb7a28bd8) = 1095 1094 1211470318.840953 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.840984 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841020 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841053 poll( <unfinished ...> 1094 1211470318.841170 <... poll resumed> [{fd=5, events=POLLIN}, {fd=7, events=POLLIN|POLLPRI}, {fd=10, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN}, {fd=14, events=POLLIN}, {fd=19, events=POLLIN}, {fd=12, events=POLLIN}, {fd=15, events=POLLIN, revents=POLLIN}], 8, -1) = 1 1094 1211470318.841223 read(15, "\252", 1) = 1 1094 1211470318.841255 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841285 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841313 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841345 read(15, 0xbffcd6cf, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841377 sched_yield() = 0 1094 1211470318.841407 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841436 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841464 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841493 poll([{fd=5, events=POLLIN}, {fd=7, events=POLLIN|POLLPRI}, {fd=10, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN}, {fd=14, events=POLLIN}, {fd=19, events=POLLIN}, {fd=12, events=POLLIN}], 7, 0) = 0 1094 1211470318.841549 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841578 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841606 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841635 read(15, 0xbffcd6cf, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841662 sched_yield() = 0 1094 1211470318.841691 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841719 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841747 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841776 poll([{fd=5, events=POLLIN}, {fd=7, events=POLLIN|POLLPRI}, {fd=10, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN}, {fd=14, events=POLLIN}, {fd=19, events=POLLIN}, {fd=12, events=POLLIN}], 7, 0) = 0 1094 1211470318.841832 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841860 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841889 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841932 read(15, 0xbffcd6cf, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.841959 sched_yield() = 0 1094 1211470318.841988 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.842016 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.842044 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.842073 poll([{fd=5, events=POLLIN}, {fd=7, events=POLLIN|POLLPRI}, {fd=10, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN}, {fd=14, events=POLLIN}, {fd=19, events=POLLIN}, {fd=12, events=POLLIN}], 7, 0) = 0 1094 1211470318.842130 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.842158 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.842187 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.842215 read(15, 0xbffcd6cf, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470318.842242 sched_yield() = 0 And about 10+ seconds of repeating the poll, to sched-yield above: pretty depressing reading in fact :-) -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=393643 User mmeeks@novell.com added comment https://bugzilla.novell.com/show_bug.cgi?id=393643#c1 --- Comment #1 from Michael Meeks <mmeeks@novell.com> 2008-05-22 10:48:37 MST --- Ages later we buck out of our loop & get more output - note the time difference ;-) 1094 1211470404.267854 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470404.267883 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470404.267911 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470404.267941 poll([{fd=5, events=POLLIN}, {fd=7, events=POLLIN|POLLPRI}, {fd=10, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN}, {fd=14, events=POLLIN}, {fd=19, events=POLLIN}, {fd=11, events=POLLIN}, {fd=12, events=POLLIN}], 8, 0) = 0 1094 1211470404.268001 read(15, 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470404.268039 read(15, <unfinished ...> 1218 1211470404.268061 <... poll resumed> [{fd=3, events=POLLIN}, {fd=4, events=POLLIN}, {fd=8, events=POLLIN|POLLPRI}, {fd=10, events=POLLIN|POLLPRI}, {fd=11, events=POLLIN|POLLPRI}, {fd=12, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN}, {fd=14, events=POLLIN, revents=POLLIN}], 8, 11991) = 1 1094 1211470404.268114 <... read resumed> 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1230 1211470404.268136 <... poll resumed> [{fd=3, events=POLLIN}, {fd=4, events=POLLIN}, {fd=8, events=POLLIN|POLLPRI}, {fd=11, events=POLLIN|POLLPRI}, {fd=10, events=POLLIN|POLLPRI}, {fd=12, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN|POLLPRI}, {fd=14, events=POLLIN|POLLPRI}, {fd=16, events=POLLIN|POLLPRI}, {fd=17, events=POLLIN}, {fd=19, events=POLLIN|POLLPRI}, {fd=18, events=POLLIN, revents=POLLIN}], 12, -1) = 1 1094 1211470404.268200 read(15, <unfinished ...> 1218 1211470404.268217 gettimeofday( <unfinished ...> 1264 1211470404.268233 <... gettimeofday resumed> {1211470402, 242499}, NULL) = 0 1094 1211470404.268256 <... read resumed> 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1218 1211470404.268271 <... gettimeofday resumed> {1211470404, 268241}, NULL) = 0 1094 1211470404.268294 read(15, <unfinished ...> 1218 1211470404.268314 read(14, <unfinished ...> 1094 1211470404.268325 <... read resumed> 0xbffcd6cf, 1) = -1 EAGAIN (Resource temporarily unavailable) 1230 1211470404.268343 read(18, <unfinished ...> 1218 1211470404.268362 <... read resumed> "l\4\1\1%\0\0\0Q\0\0\0\211\0\0\0\1\1o\0\25\0\0\0/org/fre"..., 2048) = 394 1230 1211470404.268404 <... read resumed> "l\4\1\1%\0\0\0Q\0\0\0\211\0\0\0\1\1o\0\25\0\0\0/org/fre"..., 2048) = 394 1266 1211470404.268440 <... poll resumed> [{fd=3, events=POLLIN}, {fd=6, events=POLLIN}, {fd=10, events=POLLIN|POLLPRI}, {fd=12, events=POLLIN|POLLPRI}, {fd=13, events=POLLIN|POLLPRI}, {fd=14, events=POLLIN|POLLPRI}, {fd=4, events=POLLIN}, {fd=5, events=POLLIN, revents=POLLIN}], 8, -1) = 1 1218 1211470404.268496 read(14, <unfinished ...> 1230 1211470404.268513 read(18, <unfinished ...> 1094 1211470404.268527 sched_yield( <unfinished ...> 1218 1211470404.268541 <... read resumed> 0x809c610, 2048) = -1 EAGAIN (Resource temporarily unavailable) 1230 1211470404.268557 <... read resumed> 0x8117f08, 2048) = -1 EAGAIN (Resource temporarily unavailable) 1266 1211470404.268580 read(5, <unfinished ...> 1218 1211470404.268598 read(3, <unfinished ...> 1230 1211470404.268614 read(3, <unfinished ...> 1094 1211470404.268627 <... sched_yield resumed> ) = 0 1218 1211470404.268643 <... read resumed> 0x808231c, 4096) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470404.268659 read(15, <unfinished ...> 1230 1211470404.268674 <... read resumed> 0x809b274, 4096) = -1 EAGAIN (Resource temporarily unavailable) 1094 1211470404.268707 <... read resumed> 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) 1218 1211470404.268727 gettimeofday( <unfinished ...> 1094 1211470404.268742 read(15, <unfinished ...> 1218 1211470404.268757 <... gettimeofday resumed> {1211470404, 268749}, NULL) = 0 1094 1211470404.268776 <... read resumed> 0xbffcd6df, 1) = -1 EAGAIN (Resource temporarily unavailable) -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=393643 User jpr@novell.com added comment https://bugzilla.novell.com/show_bug.cgi?id=393643#c2 JP Rosevear <jpr@novell.com> changed: What |Removed |Added ---------------------------------------------------------------------------- Status|NEW |NEEDINFO Info Provider| |mmeeks@novell.com --- Comment #2 from JP Rosevear <jpr@novell.com> 2008-05-23 13:38:29 MDT --- What processes are you stracing? -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=393643 User mmeeks@novell.com added comment https://bugzilla.novell.com/show_bug.cgi?id=393643#c3 Michael Meeks <mmeeks@novell.com> changed: What |Removed |Added ---------------------------------------------------------------------------- Status|NEEDINFO |NEW Info Provider|mmeeks@novell.com | Summary|multi-second busy-loop on login ... |gnome-keyring-daemon: multi-second busy-loop on | |login ... --- Comment #3 from Michael Meeks <mmeeks@novell.com> 2008-05-27 04:51:37 MDT --- sorry: - I'm doing an strace -f -ttt of gdm ultimately, but by the time we get here we are in a thread of gnome-keyring-daemon: 1093 1211470318.791428 execve("/usr/bin/gnome-keyring-daemon", ["/usr/bin/gnome-keyring-daemon"...], [/* 86 vars */] <unfinished ...> .. 1093 1211470318.836707 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7b9bb78) = 1094 .. -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=393643 JP Rosevear <jpr@novell.com> changed: What |Removed |Added ---------------------------------------------------------------------------- AssignedTo|bnc-team-gnome@forge.provo.novell.com |hpj@novell.com Priority|P5 - None |P2 - High -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
participants (1)
-
bugzilla_noreply＠novell.com