[Bug 393643] New: multi-second busy-loop on login ...

22 May 2008

      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.

[Bug 393643] New: multi-second busy-loop on login ...

bugzilla_noreply＠novell.com