Bug 1002437 - Excessive wakeups [NEEDINFO]
Summary: Excessive wakeups
Keywords:
Status: CLOSED NOTABUG
Alias: None
Product: Fedora
Classification: Fedora
Component: rygel
Version: 19
Hardware: Unspecified
OS: Unspecified
unspecified
unspecified
Target Milestone: ---
Assignee: Peter Robinson
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2013-08-29 08:14 UTC by David Woodhouse
Modified: 2014-03-11 09:21 UTC (History)
4 users (show)

Fixed In Version:
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed: 2014-03-11 09:21:52 UTC
Type: Bug
pbrobinson: needinfo? (dwmw2)


Attachments (Terms of Use)

Description David Woodhouse 2013-08-29 08:14:29 UTC
09:12:58.514326 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:58.614787 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:58.715166 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:58.815633 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:58.916004 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:59.016331 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:59.116598 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:59.216974 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)
09:12:59.317272 poll([{fd=3, events=POLLIN}, {fd=11, events=POLLIN}, {fd=14, events=POLLIN}, {fd=16, events=POLLIN}, {fd=12, events=POLLIN}, {fd=19, events=POLLIN}, {fd=21, events=POLLIN}, {fd=23, events=POLLIN}, {fd=24, events=POLLIN}, {fd=7, events=POLLIN}, {fd=22, events=POLLIN}, {fd=13, events=POLLIN}, {fd=20, events=POLLIN}], 13, 100) = 0 (Timeout)

Go The F*** To Sleep!

Comment 1 Zeeshan Ali 2013-08-29 14:43:31 UTC
In which conditions was this trace taken? How many UPnP devices/services you got running in your network (you can check with gupnp-universal-cp in gupnp-tools package). Are these just bursts of wake-ups or they keep going? Which plugins you got enabled? If you got media-export plugin enabled, how many files you got exported?

A trace of rygel not sleeping w/o any other info and ending it with a rather impolite phrase is not very motivating. :)

Comment 2 David Woodhouse 2013-08-29 15:06:42 UTC
It was idle when it was being traced. I think I had used a Sony BD player to view photos from it at some point a few days ago, and there is also a Serviio instance running on another machine on the network. Sometimes a Samsung Galaxy S4 too, but not doing anything DLNA-related at the moment.

The trace appears to show that it was doing nothing. There was no activity on its file descriptors, and it wasn't doing anything when it *did* wake up. It looks like just an excessively short timeout on the poll() call, as far as I can tell.

(gdb) bt
#0  0x0000003d570eab6d in poll () at ../sysdeps/unix/syscall-template.S:81
#1  0x0000003bb28480f4 in g_main_context_poll (priority=2147483647, n_fds=13, 
    fds=0x35c6940, timeout=100, context=0x259f9d0) at gmain.c:3995
#2  g_main_context_iterate (context=0x259f9d0, block=block@entry=1, 
    dispatch=dispatch@entry=1, self=<optimized out>) at gmain.c:3696
#3  0x0000003bb284855a in g_main_loop_run (loop=0x2af6450) at gmain.c:3895
#4  0x0000000000404721 in rygel_main_run (self=0x25b2430) at rygel-main.c:349
#5  rygel_main_main (args_length1=1, args=0x7fffcbdc3468) at rygel-main.c:1247
#6  main (argc=1, argv=<optimized out>) at rygel-main.c:1280


The final sentence is the name of a well-known "children's" book. It's not intended to be impolite, but a simple statement of the problem.

I've restarted rygel so I can trace *all* its threads, and now it seems to be behaving sanely again — each poll() call has a timeout of 4294967295. I'm not entirely sure what had trigger the previous behaviour.

Comment 3 Peter Robinson 2013-11-25 07:48:06 UTC
David did this problem reappear?

Comment 4 Peter Robinson 2014-03-11 09:21:52 UTC
No response, presuming this hasn't reoccurred


Note You need to log in before you can comment on or make changes to this bug.