Bug#656196: Stalls happen with 3.0
Am Dienstag, den 14.02.2012, 18:23 + schrieb Ben Hutchings: On Tue, Feb 14, 2012 at 06:35:36PM +0100, Michael Below wrote: The stall happens with 3.0.0-1-amd64 while it didn't happen with 2.6.39. Anything else I can try? [...] What about the current version, Linux 3.2? Same problem, see attached syslog. Feb 16 16:31:49 ossietzky spamd[10969]: Use of uninitialized value $selerr in concatenation (.) or string at /usr/share/perl5/Mail/SpamAssassin/SpamdForkScaling.pm line 332. Feb 16 16:31:49 ossietzky spamd[10969]: prefork: select returned error on server filehandle: Feb 16 16:31:49 ossietzky spamd[10981]: prefork: sysread(8) failed after 300 secs at /usr/share/perl5/Mail/SpamAssassin/SpamdForkScaling.pm line 654. Feb 16 16:31:49 ossietzky spamd[10980]: prefork: sysread(7) failed after 300 secs at /usr/share/perl5/Mail/SpamAssassin/SpamdForkScaling.pm line 654. Feb 16 16:31:49 ossietzky spamd[10969]: prefork: child states: II Feb 16 16:31:49 ossietzky rtkit-daemon[2287]: The canary thread is apparently starving. Taking action. Feb 16 16:31:49 ossietzky spamd[10969]: prefork: child states: II Feb 16 16:31:49 ossietzky rtkit-daemon[2287]: Demoting known real-time threads. Feb 16 16:31:49 ossietzky rtkit-daemon[2287]: Successfully demoted thread 3453 of process 3453 (/usr/bin/pulseaudio). Feb 16 16:31:49 ossietzky rtkit-daemon[2287]: Demoted 1 threads. Feb 16 16:31:49 ossietzky spamd[10969]: spamd: handled cleanup of child pid [10981] due to SIGCHLD: exit 0 Feb 16 16:31:49 ossietzky spamd[10969]: spamd: server successfully spawned child process, pid 16521 Feb 16 16:31:49 ossietzky spamd[10969]: spamd: handled cleanup of child pid [10980] due to SIGCHLD: exit 0 Feb 16 16:31:49 ossietzky spamd[10969]: prefork: child states: I Feb 16 16:31:49 ossietzky spamd[10969]: spamd: server successfully spawned child process, pid 16522 Feb 16 16:31:49 ossietzky spamd[10969]: prefork: child states: II Feb 16 16:31:49 ossietzky kernel: [12630.053529] INFO: rcu_sched detected stall on CPU 3 (t=74991 jiffies) Feb 16 16:31:50 ossietzky kernel: [12630.053529] sending NMI to all CPUs: Feb 16 16:31:50 ossietzky kernel: [12630.053529] NMI backtrace for cpu 3 Feb 16 16:31:50 ossietzky kernel: [12630.053529] CPU 3 Feb 16 16:31:50 ossietzky kernel: [12630.053529] Modules linked in: powernow_k8 mperf cpufreq_conservative cpufreq_userspace cpufreq_powersave cpufreq_stats parport_pc ppdev lp parport binfmt_misc fuse smsc47b397 loop dm_crypt tpm_infineon arc4 snd_hda_codec_analog radeon ttm drm_kms_helper drm i2c_algo_bit power_supply rt73usb crc_itu_t snd_hda_intel snd_hda_codec rt2x00usb rt2x00lib snd_hwdep shpchp pci_hotplug snd_pcm_oss snd_mixer_oss snd_pcm mac80211 cfg80211 snd_seq_midi joydev snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device snd soundcore snd_page_alloc processor k10temp usbhid hid sp5100_tco usb_storage edac_core uas edac_mce_amd hp_wmi i2c_piix4 evdev i2c_core sparse_keymap pcspkr rfkill psmouse serio_raw button wmi thermal_sys tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod sr_mod sd_mod cdrom crc_t10dif ohci_hcd tg3 libphy floppy ahci libahci libata ehci_hcd scsi_mod usbcore usb_common [last unloaded: scsi_wait_scan] Feb 16 16:31:50 ossietzky kernel: [12630.053529] Feb 16 16:31:50 ossietzky kernel: [12630.053529] Pid: 0, comm: swapper/3 Not tainted 3.2.0-1-amd64 #1 Hewlett-Packard HP Compaq dc5850 Microtower/3029h Feb 16 16:31:50 ossietzky kernel: [12630.053529] RIP: 0010:[811afc59] [811afc59] __const_udelay+0x17/0x20 Feb 16 16:31:50 ossietzky kernel: [12630.053529] RSP: 0018:88006fd83d00 EFLAGS: 0847 Feb 16 16:31:50 ossietzky kernel: [12630.053529] RAX: c31401c0 RBX: 2710 RCX: 0040 Feb 16 16:31:50 ossietzky kernel: [12630.053529] RDX: 00273fbe RSI: 0200 RDI: 00418958 Feb 16 16:31:50 ossietzky kernel: [12630.053529] RBP: 81621d00 R08: 0002 R09: 0001 Feb 16 16:31:50 ossietzky kernel: [12630.053529] R10: 7fff R11: 7fff R12: 81621e00 Feb 16 16:31:50 ossietzky kernel: [12630.053529] R13: 88006fd83e30 R14: 7fff R15: 8106ba90 Feb 16 16:31:50 ossietzky kernel: [12630.053529] FS: 7f071c36c7a0() GS:88006fd8() knlGS:f514cb70 Feb 16 16:31:50 ossietzky kernel: [12630.053529] CS: 0010 DS: ES: CR0: 8005003b Feb 16 16:31:50 ossietzky kernel: [12630.053529] CR2: 7f027476c7c0 CR3: 69f8c000 CR4: 06e0 Feb 16 16:31:50 ossietzky kernel: [12630.053529] DR0: DR1: DR2: Feb 16 16:31:50 ossietzky kernel: [12630.053529] DR3: DR6: 0ff0 DR7: 0400 Feb 16 16:31:50 ossietzky kernel: [12630.053529] Process swapper/3 (pid: 0, threadinfo 88006cc18000, task 88006cc14f40) Feb 16 16:31:50 ossietzky kernel: [12630.053529] Stack: Feb 16 16:31:50
Bug#656196: Stalls happen with 3.0
The stall happens with 3.0.0-1-amd64 while it didn't happen with 2.6.39. Anything else I can try? Feb 14 18:28:15 ossietzky rtkit-daemon[2292]: The canary thread is apparently starving. Taking action. Feb 14 18:28:15 ossietzky rtkit-daemon[2292]: Demoting known real-time threads. Feb 14 18:28:15 ossietzky rtkit-daemon[2292]: Successfully demoted thread 2947 of process 2947 (/usr/bin/pulseaudio). Feb 14 18:28:15 ossietzky rtkit-daemon[2292]: Demoted 1 threads. Feb 14 18:28:15 ossietzky kernel: [29198.215734] INFO: rcu_sched_state detected stall on CPU 3 (t=30528 jiffies) Feb 14 18:28:15 ossietzky kernel: [29198.215745] sending NMI to all CPUs: Feb 14 18:28:15 ossietzky kernel: [29198.215755] NMI backtrace for cpu 3 Feb 14 18:28:15 ossietzky kernel: [29198.215760] CPU 3 Feb 14 18:28:15 ossietzky kernel: [29198.215764] Modules linked in: powernow_k8 mperf cpufreq_conservative cpufreq_userspace cpufreq_powersave cpufreq_stats parport_pc ppdev lp parport binfmt_misc fuse smsc47b397 loop dm_crypt snd_hda_codec_analog arc4 tpm_infineon rt73usb crc_itu_t rt2x00usb rt2x00lib snd_hda_intel snd_hda_codec mac80211 snd_hwdep usb_storage snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_midi cfg80211 snd_rawmidi snd_seq_midi_event joydev snd_seq uas snd_timer usbhid hid radeon ttm drm_kms_helper drm sp5100_tco hp_wmi snd_seq_device snd i2c_piix4 i2c_algo_bit sparse_keymap soundcore i2c_core snd_page_alloc rfkill power_supply edac_core shpchp tpm_tis processor pci_hotplug pcspkr edac_mce_amd k10temp psmouse wmi serio_raw tpm evdev tpm_bios button thermal_sys ext3 jbd mbcache dm_mod sg sr_mod sd_mod cdrom crc_t10dif ohci_hcd floppy ahci libahci ehci_hcd libata tg3 libphy usbcore scsi_mod [last unloaded: scsi_wait_scan] Feb 14 18:28:15 ossietzky kernel: [29198.215911] Feb 14 18:28:15 ossietzky kernel: [29198.215918] Pid: 0, comm: kworker/0:1 Not tainted 3.0.0-1-amd64 #1 Hewlett-Packard HP Compaq dc5850 Microtower/3029h Feb 14 18:28:15 ossietzky kernel: [29198.215931] RIP: 0010:[811abade] [811abade] __const_udelay+0x4/0x28 Feb 14 18:28:15 ossietzky kernel: [29198.215950] RSP: 0018:88006fd83d08 EFLAGS: 0092 Feb 14 18:28:15 ossietzky kernel: [29198.215956] RAX: RBX: 2710 RCX: 000f Feb 14 18:28:15 ossietzky kernel: [29198.215963] RDX: 81684078 RSI: 0200 RDI: 00418958 Feb 14 18:28:15 ossietzky kernel: [29198.215970] RBP: 8161b800 R08: R09: fffe Feb 14 18:28:15 ossietzky kernel: [29198.215976] R10: R11: 0293 R12: 8161b900 Feb 14 18:28:15 ossietzky spamd[10246]: Use of uninitialized value $selerr in concatenation (.) or string at /usr/share/perl5/Mail/SpamAssassin/SpamdForkScaling.pm line 332. Feb 14 18:28:15 ossietzky spamd[10246]: prefork: select returned error on server filehandle: Feb 14 18:28:15 ossietzky kernel: [29198.215983] R13: 88006fd83e18 R14: 0001 R15: 8106cec8 Feb 14 18:28:15 ossietzky kernel: [29198.215991] FS: 7ff9c69cd700() GS:88006fd8() knlGS:f3f7bb70 Feb 14 18:28:15 ossietzky kernel: [29198.215998] CS: 0010 DS: ES: CR0: 8005003b Feb 14 18:28:15 ossietzky kernel: [29198.216003] CR2: 0440a1e8 CR3: 6c5de000 CR4: 06e0 Feb 14 18:28:15 ossietzky kernel: [29198.216010] DR0: DR1: DR2: Feb 14 18:28:15 ossietzky kernel: [29198.216016] DR3: DR6: 0ff0 DR7: 0400 Feb 14 18:28:15 ossietzky kernel: [29198.216024] Process kworker/0:1 (pid: 0, threadinfo 88006cca8000, task 88006cca4f60) Feb 14 18:28:15 ossietzky kernel: [29198.216029] Stack: Feb 14 18:28:15 ossietzky kernel: [29198.216033] 0096 8101ff51 88006fd8ecf0 81096ba8 Feb 14 18:28:15 ossietzky kernel: [29198.216045] 88006cc7c080 0003 0003 Feb 14 18:28:15 ossietzky kernel: [29198.216055] 88006fd83e18 0001 8106cec8 810971a9 Feb 14 18:28:15 ossietzky kernel: [29198.216065] Call Trace: Feb 14 18:28:15 ossietzky kernel: [29198.216069] IRQ Feb 14 18:28:15 ossietzky kernel: [29198.216083] [8101ff51] ? arch_trigger_all_cpu_backtrace+0x6c/0x7b Feb 14 18:28:15 ossietzky kernel: [29198.216094] [81096ba8] ? __rcu_pending+0x82/0x2ed Feb 14 18:28:15 ossietzky kernel: [29198.216104] [8106cec8] ? tick_nohz_handler+0xd0/0xd0 Feb 14 18:28:15 ossietzky kernel: [29198.216112] [810971a9] ? rcu_check_callbacks+0x7e/0xa9 Feb 14 18:28:15 ossietzky kernel: [29198.216122] [81053302] ? update_process_times+0x31/0x63 Feb 14 18:28:15 ossietzky kernel: [29198.216130] [8106cf32] ? tick_sched_timer+0x6a/0x90 Feb 14 18:28:15 ossietzky kernel: [29198.216140] [81062c56] ? __run_hrtimer+0xaf/0x13a Feb 14 18:28:15 ossietzky kernel:
Bug#656196: Stalls happen with 3.0
On Tue, Feb 14, 2012 at 06:35:36PM +0100, Michael Below wrote: The stall happens with 3.0.0-1-amd64 while it didn't happen with 2.6.39. Anything else I can try? [...] What about the current version, Linux 3.2? Ben. -- Ben Hutchings We get into the habit of living before acquiring the habit of thinking. - Albert Camus -- To UNSUBSCRIBE, email to debian-bugs-dist-requ...@lists.debian.org with a subject of unsubscribe. Trouble? Contact listmas...@lists.debian.org
