ubuntuone-client generate 20 wakeups/sec in idle

[Oleksij Rempel]

ubuntuone-syncdaemon and ubuntuone-client generate 20 wakeups/sec in idle. It is too mach for netbook working on batterys.

Here are traces :

Wakeups-from-idle per second : 48.4 interval: 15.0s
no ACPI power usage estimate available
Top causes for wakeups:
  19.4% ( 9.9) ubuntuone-syncd : hrtimer_start_range_ns (hrtimer_wakeup)
  19.4% ( 9.9) ubuntuone-clien : hrtimer_start_range_ns (hrtimer_wakeup)
  17.7% ( 9.1) <interrupt> : extra timer interrupt
  10.3% ( 5.3) <kernel core> : hrtimer_start_range_ns (tick_sched_timer)
   8.7% ( 4.5) <kernel core> : hrtimer_start (tick_sched_timer)
   6.4% ( 3.3) <kernel IPI> : Rescheduling interrupts
   3.9% ( 2.0) <interrupt> : ahci
   3.9% ( 2.0) <kernel core> : clocksource_watchdog (clocksource_watchdog)
   2.2% ( 1.1) beam.smp : ep_poll (process_timeout)
   1.0% ( 0.5) <kernel core> : neigh_periodic_timer (neigh_periodic_timer)
   0.9% ( 0.5) <interrupt> : eth0

lex@mini:~$ ps aux | grep ubuntuone
lex 1937 0.3 1.2 55244 24996 ? Sl 09:55 0:06 /usr/bin/python /usr/bin/ubuntuone-client-applet
lex 2027 0.6 0.8 39164 17996 ? Sl 09:55 0:10 /usr/bin/python /usr/lib/ubuntuone-client/ubuntuone-syncdaemon

lex@mini:~$ time strace -p 1937
Process 1937 attached - interrupt to quit
restart_syscall(<... resuming interrupted call ...>) = 0
read(12, 0xbfcc2f7f, 1) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 128601}, NULL) = 0
read(4, 0xa308278, 4096) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 128892}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=7, events=POLLIN}, {fd=11, events=POLLIN}, {fd=12, events=POLLIN}, {fd=6, events=POLLIN}, {fd=3, events=POLLIN}, {fd=10, events=POLLIN}], 7, 0) = 0 (Timeout)
read(12, 0xbfcc2f7f, 1) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 129525}, NULL) = 0
gettimeofday({1254039804, 129722}, NULL) = 0
read(4, 0xa308278, 4096) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 130019}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=7, events=POLLIN}, {fd=11, events=POLLIN}, {fd=12, events=POLLIN}, {fd=6, events=POLLIN}, {fd=3, events=POLLIN}, {fd=10, events=POLLIN}], 7, 100) = 0 (Timeout)
read(12, 0xbfcc2f7f, 1) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 230733}, NULL) = 0
gettimeofday({1254039804, 230943}, NULL) = 0
gettimeofday({1254039804, 231136}, NULL) = 0
read(4, 0xa308278, 4096) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 231435}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=7, events=POLLIN}, {fd=11, events=POLLIN}, {fd=12, events=POLLIN}, {fd=6, events=POLLIN}, {fd=3, events=POLLIN}, {fd=10, events=POLLIN}], 7, 100) = 0 (Timeout)
read(12, 0xbfcc2f7f, 1) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 332153}, NULL) = 0
gettimeofday({1254039804, 332363}, NULL) = 0
gettimeofday({1254039804, 332555}, NULL) = 0
read(4, 0xa308278, 4096) = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1254039804, 332854}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=7, events=POLLIN}, {fd=11, events=POLLIN}, {fd=12, events=POLLIN}, {fd=6, events=POLLIN}, {fd=3, events=POLLIN}, {fd=10, events=POLLIN}], 7, 100^C <unfinished ...>
Process 1937 detached

real 0m0.352s
user 0m0.000s
sys 0m0.004s

lex@mini:~$ time ltrace -p 1937
pthread_self(0xa793e00, 1428, 0xbfcc2f0c, 0xbfcc2f08, 0x123d17) = 0xb80e76c0
sem_wait(0xa098988, 0, 0xbfcc2f08, 0xa30822c, 2) = 0
sem_post(0xa098988, 1428, 0xbfcc2f0c, 0xbfcc2f08, 0x123d17) = 0
__errno_location() = 0xb80e7688
sem_wait(0xa4a6b60, 1, 1, 0x8104c51, 0xa098988) = 0
pthread_self(0xa4a6b60, 1, 1, 0x8104c51, 0xa098988) = 0xb80e76c0
sem_wait(0xa098988, 0, 0xa098988, 0x8104a4d, 0xa098988) = 0
sem_post(0xa098988, 1, 1, 0x8104c51, 0xa098988) = 0
sem_post(0xa4a6b60, 1, 0xbfcc2ef8, 0x8104cf0, 0x9a96ac) = 0
pthread_self(0xa098988, 0, 0xa098988, 0x8104a4d, 0xa098988) = 0xb80e76c0
sem_wait(0xa098988, 2, 0xbfcc2ea8, 0x435db7c, 0xa793e00) = 0
sem_post(0xa098988, 0, 0xa098988, 0x8104a4d, 0xa098988) = 0
__errno_location() = 0xb80e7688
sem_wait(0xa4a6b60, 1, 1, 0x8104c51, 0xa098988) = 0
__ctype_b_loc() = 0xb80e768c
__ctype_b_loc() = 0xb80e768c
gettimeofday(0xbfcc2924, NULL) = 0
sem_post(0xa4a6b60, 0x4abf21e6, 777498, 0xa804fec, 0xa804eac) = 0
sem_wait(0xa4a6b60, 0xa55416c, 0xa804fec, 0x8104741, 0xa4a6b60) = 0
__finite(0x9999999a, 0x3fb99999, 0xbfcc28d8, 0x808e938, 0xa66cf0c) = 1
_setjmp(0x8294920, 0x8242cc0, 0x8245f58, 0xa0ac6fc, 0xa0ac6fc) = 0
strchr("|Oi:int", ':') = ":int"
modf(0, 0x40594000, 0xbfcc2908, 0, -1) = 0
__ctype_b_loc() = 0xb80e768c
__ctype_b_loc() = 0xb80e768c
pthread_self(0xa098988, 0, 0xa098988, 0xb80a702c, 0x8068370) = 0xb80e76c0
sem_wait(0xa098988, 2, 0xbfcc2ea8, 0x435db7c, 0xa793e00) = 0
sem_post(0xa098988, 0, 0xa098988, 0xb80a702c, 0x8068370) = 0
sem_post(0xa4a6b60, 1, 0xbfcc2ec8, 0x8104cf0, 0xa995964) = 0
pthread_self(0xa098988, 1, 0xa098050, 0x8104741, 0xa4a6b60) = 0xb80e76c0
sem_wait(0xa098988, 0, 0xa098988, 0xb80a702c, 0x8068370) = 0
sem_post(0xa098988, 1, 0xa098050, 0x8104741, 0xa4a6b60) = 0
__errno_location() = 0xb80e7688
sem_wait(0xa4a6b60, 1, 1, 0x8104c51, 0xa098988) = 0
pthread_self(0xa098988, 1, 0xa098050, 0x8104741, 0xa4a6b60) = 0xb80e76c0
sem_wait(0xa098988, 0, 0xa098988, 0xb80a702c, 0x8068370) = 0
sem_post(0xa098988, 1, 0xa098050, 0x8104741, 0xa4a6b60) = 0
sem_post(0xa4a6b60, 0x68231c, 0xbfcc2ef8, 0x8104cf0, 0xa69024c) = 0
^C
real 0m0.164s
user 0m0.012s
sys 0m0.008s

lex@mini:~$ time ltrace -p 1937 -c
^C% time seconds usecs/call calls function
------ ----------- ----------- --------- --------------------
 25.15 0.059060 92 637 sem_wait
 24.61 0.057801 90 637 sem_post
 15.91 0.037370 92 402 pthread_self
 10.96 0.025732 96 268 __ctype_b_loc
  7.87 0.018478 91 201 __errno_location
  4.59 0.010772 160 67 gettimeofday
  2.77 0.006514 97 67 modf
  2.75 0.006450 96 67 _setjmp
  2.72 0.006389 95 67 __finite
  2.69 0.006310 94 67 strchr
------ ----------- ----------- --------- --------------------
100.00 0.234876 2480 total

real 0m7.166s
user 0m0.124s
sys 0m0.320s

[Oleksij Rempel (olerem)]

i use
ubuntu karmic 9.10

apt-cache policy ubuntuone-client
ubuntuone-client:
  Installiert: 0.95.1-0ubuntu1
  Kandidat: 0.95.1-0ubuntu1
  Versions-Tabelle:
 *** 0.95.1-0ubuntu1 0
        500 http://de.archive.ubuntu.com karmic/main Packages
        100 /var/lib/dpkg/status

[Joshua Hoover (joshuahoover)]

Hi fishor,

Thank you for taking the time to provide a very detailed analysis of the problem! I believe this is related to another bug that was filed a while ago. I'm going to mark this as a duplicate and follow up on the status of the original bug to see if the fix committed against that bug was ever merged or was put on hold for some reason.

Thank you,

Joshua