100% CPU, forever

[Fabien Tassin]

Binary package hint: indicator-weather

Found my desktop slow, compiz almost unusable. The reason was indicator-weather taking all the cpu.

strace showed zillions of:

write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)
write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)
write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)
write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)
write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)
write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)
write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)
write(2, "\n(indicator-weather:24083): LIBD"..., 135) = -1 EFBIG (File too large)

and indeed:
-rw------- 1 fta fta 2.0G 2011-03-29 09:36 ~/.xsession-errors

Looking at process 24083 in that file, it started like this:

/usr/bin/indicator-weather:1574: Warning: invalid cast from `(null)' to `DbusmenuMenuitem'
  gtk.main()

(indicator-weather:24083): LIBDBUSMENU-GLIB-CRITICAL **: dbusmenu_menuitem_build_variant: assertion `DBUSMENU_IS_MENUITEM(mi)' failed

(indicator-weather:24083): LIBDBUSMENU-GLIB-CRITICAL **: dbusmenu_menuitem_build_variant: assertion `DBUSMENU_IS_MENUITEM(mi)' failed

(indicator-weather:24083): LIBDBUSMENU-GLIB-CRITICAL **: dbusmenu_menuitem_build_variant: assertion `DBUSMENU_IS_MENUITEM(mi)' failed

(indicator-weather:24083): LIBDBUSMENU-GLIB-CRITICAL **: dbusmenu_menuitem_build_variant: assertion `DBUSMENU_IS_MENUITEM(mi)' failed
..

32 millions (!!!) times until i killed it.
So those 2Gigs of logs are all about from indicator-weather.

Nothing obvious in indicator-weather.log. It ends like this:

2011-03-29 09:09:19,779 - DEBUG - Indicator: updateWeather: setting rate to 15
2011-03-29 09:10:19,779 - DEBUG - Indicator: updating refresh label, 1 min. ago
2011-03-29 09:11:19,838 - DEBUG - Indicator: updating refresh label, 2 min. ago
2011-03-29 09:12:19,900 - DEBUG - Indicator: updating refresh label, 3 min. ago
2011-03-29 09:13:19,962 - DEBUG - Indicator: updating refresh label, 4 min. ago
2011-03-29 09:14:20,023 - DEBUG - Indicator: updating refresh label, 5 min. ago
2011-03-29 09:15:20,085 - DEBUG - Indicator: updating refresh label, 6 min. ago
2011-03-29 09:16:20,147 - DEBUG - Indicator: updating refresh label, 7 min. ago
2011-03-29 09:17:20,208 - DEBUG - Indicator: updating refresh label, 8 min. ago
2011-03-29 09:18:20,270 - DEBUG - Indicator: updating refresh label, 9 min. ago
2011-03-29 09:19:20,332 - DEBUG - Indicator: updating refresh label, 10 min. ago
2011-03-29 09:20:20,394 - DEBUG - Indicator: updating refresh label, 11 min. ago
2011-03-29 09:21:20,448 - DEBUG - Indicator: updating refresh label, 12 min. ago
2011-03-29 09:22:20,509 - DEBUG - Indicator: updating refresh label, 13 min. ago
2011-03-29 09:23:20,571 - DEBUG - Indicator: updating refresh label, 14 min. ago
2011-03-29 09:24:19,838 - DEBUG - Indicator: updateWeather: updating weather for ['55863565', 'Rueil-Malmaison']
2011-03-29 09:24:19,839 - DEBUG - Setting: getting cached weather for 55863565
2011-03-29 09:24:19,841 - DEBUG - Indicator: getWeather for location 'Rueil-Malmaison, Île-de-France, France'
2011-03-29 09:24:19,841 - DEBUG - Indicator: getWeather: updating weather report
2011-03-29 09:24:19,846 - DEBUG - Indicator: loading weather from cache for ['55863565', 'Rueil-Malmaison']
2011-03-29 09:24:19,846 - DEBUG - Indicator: menu_normal: filling in a menu for found places
2011-03-29 09:24:19,854 - DEBUG - Indicator: update_label: setting label to ''
2011-03-29 09:24:19,857 - DEBUG - Indicator: update_label: setting label to '7.8 C'
2011-03-29 09:24:20,010 - DEBUG - Weather: current condition: '34', '('weather-clear', 'weather-clear-night', False, 'Fair')'
2011-03-29 09:24:20,011 - DEBUG - Weather: got sunrise '07:35:00', sunset '20:14:00', night = False
2011-03-29 09:24:20,011 - DEBUG - Indicator: updateWeather: got condition 'Fair', icon 'weather-clear'
2011-03-29 09:24:20,011 - DEBUG - Weather: day, show 'weather-clear' icon
2011-03-29 09:24:20,013 - DEBUG - Indicator: fill in menu with params: city='Rueil-Malmaison', temp='Temperature: 7.8 C', humid='Humidity: 71%', wind='Wind: SE , 11.3 km/h', sunrise='Sunrise: 07:35 AM', sunset='Sunset: 08:14 PM', puretemp=7.8 C
2011-03-29 09:24:20,013 - DEBUG - Indicator: menu_normal: filling in a menu for found places
2011-03-29 09:24:20,033 - DEBUG - Indicator: update_label: setting label to ''
2011-03-29 09:24:20,039 - DEBUG - Setting: Saving cached weather data
2011-03-29 09:24:20,043 - DEBUG - Weather: day, show 'weather-clear' icon
2011-03-29 09:24:20,046 - DEBUG - Setting: getting cached weather for 55863565
2011-03-29 09:24:20,063 - DEBUG - Indicator: update_label: setting label to '7.8 C'
2011-03-29 09:24:20,074 - DEBUG - Setting: getting value for current
2011-03-29 09:24:20,094 - DEBUG - Setting: setting 'current'='Fair'
2011-03-29 09:24:20,094 - DEBUG - Setting: getting value for current
2011-03-29 09:24:20,103 - DEBUG - Setting: setting 'current' was updated
2011-03-29 09:24:20,109 - DEBUG - Indicator: updateWeather: setting rate to 15

9:24 -> 9:36.. 8 mins to fill 2Gigs of logs. and I killed it at 16:50. I'm glad xsession-errors is not LARGEFILE capable.

ProblemType: Bug
DistroRelease: Ubuntu 11.04
Package: indicator-weather 11.03.20+repack-0ubuntu2
ProcVersionSignature: Ubuntu 2.6.38-7.39-generic 2.6.38
Uname: Linux 2.6.38-7-generic i686
NonfreeKernelModules: nvidia
Architecture: i386
Date: Tue Mar 29 16:58:49 2011
InstallationMedia: Ubuntu 10.04 "Lucid Lynx" - Alpha i386 (20100331)
ProcEnviron:
 LANGUAGE=en_US:en
 PATH=(custom, user)
 LANG=en_US.UTF-8
 SHELL=/usr/bin/tcsh
SourcePackage: indicator-weather
UpgradeStatus: No upgrade log present (probably fresh install)

[Panagiotis Skintzos (ph7)]

Fabien, is it reproducible?
Are the indicators in the standard gnome-panel applet or in another dock program?
The messages indicate that something went wrong with the application indicator menu.
App-indicator was trying to update a deleted menuitem.
I suspect that it is related with #732569

[Vadim Rutkovsky (roignac)]

Fabien, please try this on a new version - 11.04.02
Marking as incomplete for now

[Fabien Tassin (fta)]

tag it incomplete if you want but looping like that is simply unacceptable.

I can't even boot once with this indicator not dying on something (dbus, dbusmenu, couchdb, you name it..).
I will probably end-up uninstalling it soon.

[Vadim Rutkovsky (roignac)]

Fabien, it is marked as incomplete as we don't have enough information to fix it.
I guess, the problem is in special characters in the lcoation name - could you please try this on location with plain ASCII characters.

[Vadim Rutkovsky (roignac)]

Marking this as Fix Committed for foggy release, as most likely this has been caused by desktopcouch and outdated appindicator bindings - please, check this again, when foggy build will land in PPA (unstable or main PPA)

[Vadim Rutkovsky (roignac)]

Fabien, the fix for dconf settings has landed in Weather Indicator Team PPA - could you please try to reproduce the issue using 11.05.31 version?

[Fabien Tassin (fta)]

I can't. indicator-weather is no longer usable for me (oneiric).
It crashes on startup.

[Vadim Rutkovsky (roignac)]

Could ypu please attach the logs or the stacktrace?