On 03/06/2014 01:30 PM, David C. Rankin wrote:
On 03/06/2014 01:06 PM, David C. Rankin wrote:
On 03/06/2014 12:55 PM, David C. Rankin wrote:
On 03/06/2014 12:29 PM, Timothy Pearson wrote:
On 03/06/2014 10:52 AM, Dr. Nikolaus Klepp wrote:
Am Donnerstag, 6. März 2014 schrieb David C. Rankin: > All, > > Testing the new soft-freeze packages has disclosed a horrible problem > with > tdepowersave taking nearly 100% of the CPU. My laptop was nearly on > fire this > morning: > > [screenshot] > http://www.3111skyline.com/dl/dt/trinity/ss/tdeowersave-97percent.jpg > > Earlier in development I saw tdepowesave in the 20-40% range, but > never at > near 100% of CPU. What to try? >
What kernel do you use? I had the same problem on wheezy with 3.5.13.2. tdepowersave took 100% of one core. It occured after tdepowersave put the x61 to powersave the second time. It looks like the problem went away after changing to kernel 3.12-0.bpo.1.
nik
Kernel is 3.13-5.1 (just a few days old), So this is happening with current kernels.
-- David C. Rankin, J.D.,P.E.
Try attaching gdb to the runaway tdepowersave process--that should at least show you where it is stuck.
Tim
Will do - and report back.
Darn,
On attaching the debugger to the launch, you get some interesting output, but then tdepowersave goes back to taking its normal 5-7% of CPU instead of 97% of CPU. Maybe this just happens on initial startup? Is its failure to register with systemd the problem? Here is the output:
[Thread debugging using libthread_db enabled] Using host libthread_db library "/usr/lib/libthread_db.so.1". [FIXME] UNCLASSIFIED DEVICE name: broadcast type: (null) subsystem: clockevents driver: (null) [Node Path: (null)] [Syspath: /sys/devices/system/clockevents/broadcast] [(null):(null)] [FIXME] UNCLASSIFIED DEVICE name: clockevent0 type: (null) subsystem: clockevents driver: (null) [Node Path: (null)] [Syspath: /sys/devices/system/clockevents/clockevent0] [(null):(null)] TQSocketNotifier: Multiple socket notifiers for same socket 12 and type read tdepowersave: WARNING: The session is not registered with systemd [Inferior 1 (process 31672) exited normally]
Is there a way I can configure it to start with the debugger attached on tde start?
Tim,
tdepowersave starts at it's normal 5-7% and then steadily climbs in CPU use until it will take 100% on my box. Attaching the pid to gdb yielded the following:
sudo gdb attach 674 ... 0xb7795424 in __kernel_vsyscall () (gdb) continue
Continuing the tdepowersave process I watch the CPU use steadily climbing over the next few minutes. I captured a screenshot at 14%, now it is well over 26% of the CPU:
http://www.3111skyline.com/dl/dt/trinity/ss/tdeowersave-14percent.jpg
Interrupting tdepowesave in gdb output the following:
^C Program received signal SIGINT, Interrupt. 0xb5ac1b1f in ?? () from /usr/lib/libdbus-1.so.3
I don't know if that is where it is stuck or if it is stuck at the __kernel_vsyscall ()?
What would you like me to try?
Checking the journal, it looks like tdepowersave is in a fight with dbus-1, the following set of messages repeats over-and-over in the logs. It did not do this prior to the soft-freeze build yesterday:
Mar 06 13:31:28 valhalla dbus[176]: [system] Rejected send message, 2 matched rules; type="method_call", sender=":1.37" (uid=1000 pid=674 comm="tdepowersave [tdeinit] ") interface="org.trinitydesktop.hardwarecontrol.InputEvents" member="GetActiveSwitches" error name="(unset)" requested_reply="0" destination="org.trinitydesktop.hardwarecontrol" (uid=0 pid=12964 comm="/opt/trinity/bin/tde_dbus_hardwarecontrol ") Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Name request failed with error 'Rejected send message, 2 matched rules; type="method_call", sender=":1.37" (uid=1000 pid=674 comm="tdepowersave [tdeinit] ") interface="org.trinitydesktop.hardwarecontrol.InputEvents" member="GetActiveSwitches" error name="(unset)" requested_reply="0" destination="org.trinitydesktop.hardwarecontrol" (uid=0 pid=12964 comm="/opt/trinity/bin/tde_dbus_hardwarecontrol ")' Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Not primary owner (-1), exiting! Mar 06 13:31:28 valhalla dbus[176]: [system] Activated service 'org.trinitydesktop.hardwarecontrol' failed: Launch helper exited with unknown return code 1 Mar 06 13:31:28 valhalla dbus[176]: [system] Activating service name='org.trinitydesktop.hardwarecontrol' (using servicehelper) Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Listening... Mar 06 13:31:28 valhalla dbus[176]: [system] Successfully activated service 'org.trinitydesktop.hardwarecontrol' Mar 06 13:31:28 valhalla dbus[176]: [system] Rejected send message, 2 matched rules; type="method_call", sender=":1.37" (uid=1000 pid=674 comm="tdepowersave [tdeinit] ") interface="org.trinitydesktop.hardwarecontrol.InputEvents" member="GetProvidedSwitches" error name="(unset)" requested_reply="0" destination="org.trinitydesktop.hardwarecontrol" (uid=0 pid=12966 comm="/opt/trinity/bin/tde_dbus_hardwarecontrol ") Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Name request failed with error 'Rejected send message, 2 matched rules; type="method_call", sender=":1.37" (uid=1000 pid=674 comm="tdepowersave [tdeinit] ") interface="org.trinitydesktop.hardwarecontrol.InputEvents" member="GetProvidedSwitches" error name="(unset)" requested_reply="0" destination="org.trinitydesktop.hardwarecontrol" (uid=0 pid=12966 comm="/opt/trinity/bin/tde_dbus_hardwarecontrol ")' Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Not primary owner (-1), exiting! Mar 06 13:31:28 valhalla dbus[176]: [system] Activated service 'org.trinitydesktop.hardwarecontrol' failed: Launch helper exited with unknown return code 1 Mar 06 13:31:28 valhalla dbus[176]: [system] Activating service name='org.trinitydesktop.hardwarecontrol' (using servicehelper) Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Listening... Mar 06 13:31:28 valhalla dbus[176]: [system] Successfully activated service 'org.trinitydesktop.hardwarecontrol' Mar 06 13:31:28 valhalla dbus[176]: [system] Rejected send message, 2 matched rules; type="method_call", sender=":1.37" (uid=1000 pid=674 comm="tdepowersave [tdeinit] ") interface="org.trinitydesktop.hardwarecontrol.InputEvents" member="GetActiveSwitches" error name="(unset)" requested_reply="0" destination="org.trinitydesktop.hardwarecontrol" (uid=0 pid=12968 comm="/opt/trinity/bin/tde_dbus_hardwarecontrol ") Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Name request failed with error 'Rejected send message, 2 matched rules; type="method_call", sender=":1.37" (uid=1000 pid=674 comm="tdepowersave [tdeinit] ") interface="org.trinitydesktop.hardwarecontrol.InputEvents" member="GetActiveSwitches" error name="(unset)" requested_reply="0" destination="org.trinitydesktop.hardwarecontrol" (uid=0 pid=12968 comm="/opt/trinity/bin/tde_dbus_hardwarecontrol ")' Mar 06 13:31:28 valhalla org.trinitydesktop.hardwarecontrol[176]: [tde_dbus_hardwarecontrol] Not primary owner (-1), exiting! Mar 06 13:31:28 valhalla dbus[176]: [system] Activated service 'org.trinitydesktop.hardwarecontrol' failed: Launch helper exited with unknown return code 1