On Sun 2013-03-10 23:14:35 -0400, Daniel Kahn Gillmor wrote:
> On 03/10/2013 08:33 PM, Ben Hutchings wrote:
>> You can try applying the quirk by adding 'acpi_osi=Linux' to the kernel
>> command line.
>
> thanks, i'll give that a try when i'm in front of the machine tomorrow.
this changed the log message to the following (from a 3.2 boot), but the
behavior of the system remained the same, including the null
pointer dereference in pulseaudio:
[ 0.588857] [Firmware Bug]: ACPI: BIOS _OSI(Linux) query honored via cmdline
>
>>> * just 3.2:
>>> [ 1.676960] [Firmware Bug]: cpu 0, try to use APIC500 (LVT offset 0)
>>> for vector 0x10400, but the register is already in use for vector 0xf9
>>> on another cpu
>>> [ 1.690776] [Firmware Bug]: cpu 0, IBS interrupt offset 0 not
>>> available (MSRC001103A=0x0000000000000100)
>>> [ 1.700255] Failed to setup IBS, -22
>>>
>>> * various hda-intel weirdnesses.
>>
>> Does it still crash when starting PulseAudio?
>
> kernel 3.2 (which has the above output) does have a null dereference
> within pulseaudio -- you can see it at 185.6 seconds into the first of
> the three boots. neither 3.7 and 3.8 have this null dereference.
>
> using all three kernels, there is still a hang just before "setting
> preliminary keymap", which is in /etc/rcS.d/S05keyboard-setup. So it's
> presumably hanging in one of:
>
> S01mountkernfs.sh
> S02udev
> S03mountdevsubfs.sh
> S04bootlogd
>
> i'm not sure what userspace process is causing that hang (that is, which
> one is being terminated when i send ctrl-c through the console), but i
> can try to track it down.
Ah. i discovered that if i just wait > 3 minutes at that hang instead
of pressing ctrl+C impatiently, the boot process does continue, showing
the following error messages:
udevd[416]: worker [495] unexpectedly returned with status 0x0100
^M
udevd[416]: worker [495] failed while handling '/devices/pci0000:00/0000:00:15.2/0000:03:00.3'
^M
done.
Setting preliminary keymap...done.
So it is almost certainly udev that is failing in this way.
Again, with the 3.2 kernel, pulseaudio crashes, but it is slightly
different. it's no longer a null pointer dereference.
(fwiw, uid 109 appears to be the Debian-gdm user) Here is the backtrace
From the crash after letting the boot process timeout with the
acpi_osi=Linux parameter:
[ 201.019945] kernel tried to execute NX-protected page - exploit attempt? (uid: 109)
[ 201.020006] BUG: unable to handle kernel paging request at f62b7940
[ 201.020006] IP: [<f62b7940>] 0xf62b793f
[ 201.020006] *pdpt = 0000000001484001 *pde = 80000000362001e3
[ 201.020006] Oops: 0011 [#1] SMP
[ 201.020006] Modules linked in: sha1_generic hmac cbc cts bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi snd_hda_intel snd_hda_codec snd_hwdep snd_pcm powernow_k8 snd_seq snd_timer snd_seq_device mperf crc32c_intel ipmi_si(+) i2c_piix4 i2c_core tpm_tis aesni_intel cryptd snd aes_i586 tpm ipmi_msghandler processor psmouse soundcore snd_page_alloc aes_generic serio_raw evdev tpm_bios pcspkr thermal_sys ext3 jbd mbcache dm_mod microcode usb_storage sg usbhid hid sd_mod sr_mod cdrom crc_t10dif ohci_hcd ehci_hcd xhci_hcd ahci libahci libata r8169 mii scsi_mod usbcore usb_common button [last unloaded: scsi_wait_scan]
[ 201.052254]
[ 201.052254] Pid: 3299, comm: pulseaudio Not tainted 3.2.0-4-686-pae #1 Debian 3.2.35-2 LENOVO 4865A14/Annapurna CRB
[ 201.052254] EIP: 0060:[<f62b7940>] EFLAGS: 00010202 CPU: 3
[ 201.052254] EIP is at 0xf62b7940
[ 201.052254] EAX: f37f6e2c EBX: 00000080 ECX: f365e4c0 EDX: f6ee5400
[ 201.052254] ESI: f843b05c EDI: f692ef00 EBP: f6ee5a4c ESP: f6f71d98
[ 201.052254] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 201.052254] Process pulseaudio (pid: 3299, ti=f6f70000 task=f2e0ea80 task.ti=f6f70000)
[ 201.052254] Stack:
[ 201.052254] f8438515 00000080 00000080 f2ea5400 f365e4c0 f6deee00 f37f6e2c f692ef00
[ 201.052254] f6deee38 f6f71e04 00000000 f843c518 f6c31b00 f84e9bcb f365e4c0 f367ea00
[ 201.052254] f2e0ea80 f84e9cbf f6f71e04 f367eb18 f367eb2c 00000000 00000000 f2e0ea80
[ 201.052254] Call Trace:
[ 201.052254] [<f8438515>] ? azx_pcm_open+0x171/0x1f7 [snd_hda_intel]
[ 201.052254] [<f84e9bcb>] ? snd_pcm_open_substream+0x36/0x68 [snd_pcm]
[ 201.052254] [<f84e9cbf>] ? snd_pcm_open+0xc2/0x1be [snd_pcm]
[ 201.052254] [<c10320e5>] ? try_to_wake_up+0x155/0x155
[ 201.052254] [<f84e9e33>] ? snd_pcm_playback_open+0x31/0x46 [snd_pcm]
[ 201.052254] [<f83af49e>] ? snd_open+0xf5/0x133 [snd]
[ 201.052254] [<c10cf2d7>] ? chrdev_open+0xf3/0x111
[ 201.052254] [<c10cafb3>] ? __dentry_open+0x17a/0x253
[ 201.052254] [<c10cbd01>] ? nameidata_to_filp+0x3a/0x45
[ 201.052254] [<c10cf1e4>] ? cdev_put+0x17/0x17
[ 201.052254] [<c10d5dac>] ? do_last+0x4f8/0x513
[ 201.052254] [<c10d606e>] ? path_openat+0xa1/0x28b
[ 201.052254] [<c10d6301>] ? do_filp_open+0x23/0x5c
[ 201.052254] [<c102a0e5>] ? should_resched+0x5/0x1e
[ 201.052254] [<c12c0c39>] ? _cond_resched+0x5/0x18
[ 201.052254] [<c10cbd60>] ? do_sys_open+0x54/0xcd
[ 201.052254] [<c10d6f81>] ? do_fcntl+0x151/0x3b0
[ 201.052254] [<c10cbdf7>] ? sys_open+0x1e/0x23
[ 201.052254] [<c12c641f>] ? sysenter_do_call+0x12/0x28
[ 201.052254] Code: 78 2b f6 34 79 2b f6 00 00 00 00 2c 00 02 80 6c 1b ae f3 1f 00 00 00 ff ff ff ff 01 00 00 00 14 79 2b f6 94 60 2b f6 00 00 00 00 <6c> 00 02 80 8c b3 b4 f3 05 00 00 00 ff ff ff ff 01 00 00 00 f4
[ 201.052254] EIP: [<f62b7940>] 0xf62b7940 SS:ESP 0068:f6f71d98
[ 201.052254] CR2: 00000000f62b7940
[ 201.052254] ---[ end trace 0c50fc02d3f42b41 ]---
Booting again without the acpi_osi=Linux parameter, letting the computer
sit idle for several minutes resulted in the following bugginess (note the
non-monotonic increases in timestamps!), which continues to output a
backtrace or two this every few minutes:
Stopping the hotplug events dispatcher: udevd[ 195.289201] BUG: unable to handle kernel NULL pointer dereference at 00000020
[ 195.292593] IP: [<c1029b15>] task_waking_fair+0x9/0x27
[ 195.292593] *pdpt = 00000000337fa001 *pde = 0000000000000000
[ 195.292593] Oops: 0000 [#1] SMP
[ 195.292593] Modules linked in: bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi powernow_k8 mperf crc32c_intel aesni_intel cryptd i2c_piix4 snd_hda_intel snd_hda_codec aes_i586 i2c_core snd_seq snd_seq_device snd_hwdep snd_pcm snd_timer snd soundcore snd_page_alloc processor psmouse serio_raw pcspkr thermal_sys ipmi_si(+) evdev ipmi_msghandler aes_generic tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod microcode sg sd_mod sr_mod cdrom crc_t10dif usb_storage usbhid hid ohci_hcd ahci libahci libata xhci_hcd ehci_hcd scsi_mod r8169 mii button usbcore usb_common [last unloaded: scsi_wait_scan]
[ 195.292593]
[ 195.292593] Pid: 2406, comm: start-stop-daem Not tainted 3.2.0-4-686-pae #1 Debian 3.2.35-2 LENOVO 4865A14/Annapurna CRB
[ 195.292593] EIP: 0060:[<c1029b15>] EFLAGS: 00010086 CPU: 1
[ 195.292593] EIP is at task_waking_fair+0x9/0x27
[ 195.292593] EAX: f68d6200 EBX: f68d6200 ECX: 0000000c EDX: 00000000
[ 195.292593] ESI: 00000000 EDI: 00000001 EBP: 00000000 ESP: f67e9e64
[ 195.292593] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 195.292593] Process start-stop-daem (pid: 2406, ti=f67e8000 task=f6cc68c0 task.ti=f67e8000)
[ 195.292593] Stack:
[ 195.292593] f68d6200 00000000 00000001 c1032036 f68d6514 00000046 f68d6200 00000000
[ 195.292593] f6d0c804 f68d6200 c1043c59 f6d0c7d8 f67e9f3c c1044240 0000000f f68e859c
[ 195.292593] f67e9f1c f68d6200 f6cc68c0 0000000f c10442b0 00000001 00000000 f68d6200
[ 195.292593] Call Trace:
[ 195.292593] [<c1032036>] ? try_to_wake_up+0xa6/0x155
[ 195.292593] [<c1043c59>] ? signal_wake_up+0x20/0x30
[ 195.292593] [<c1044240>] ? __send_signal+0x242/0x259
[ 195.292593] [<c10442b0>] ? send_signal+0x59/0x60
[ 195.292593] [<c10449e4>] ? do_send_sig_info+0x3a/0x5b
[ 195.292593] [<c1044b34>] ? group_send_sig_info+0x23/0x28
[ 195.292593] [<c1044bce>] ? kill_pid_info+0x21/0x31
[ 195.292593] [<c1045a96>] ? sys_kill+0x72/0x13a
[ 195.292593] [<c12c0bf0>] ? __schedule+0x54b/0x55b
[ 195.292593] [<c107b127>] ? __call_rcu+0x1b/0xe1
[ 195.292593] [<c10da3bb>] ? dput+0x21/0xc2
[ 195.292593] [<c10cd53e>] ? fput+0x148/0x160
[ 195.292593] [<c10df02b>] ? mntput_no_expire+0x1b/0xb0
[ 195.292593] [<c10cb2e0>] ? filp_close+0x52/0x58
[ 195.292593] [<c12c641f>] ? sysenter_do_call+0x12/0x28
[ 195.292593] Code: 00 75 19 8b 0a 29 48 64 8b 72 14 8d 4a 14 8b 5a 18 89 5e 04 89 33 89 4a 14 89 4a 18 5b ff 48 08 5e c3 8b 90 80 00 00 00 57 56 53 <8b> 7a 20 8b 72 24 8b 5a 1c 8b 4a 18 39 f3 75 f0 39 f9 75 ec 29
[ 195.292593] EIP: [<c1029b15>] task_waking_fair+0x9/0x27 SS:ESP 0068:f67e9e64
[ 195.292593] CR2: 0000000000000020
[ 195.292593] ---[ end trace 839383ef87675224 ]---
Killed
[31mfailed![39;49m
Starting the hotplug events dispatcher: udevderror binding control socket, seems udevd is already running
[31mfailed![39;49m
startpar: service(s) returned failure: nfs-common rc.local ... [31mfailed![39;49m
[ 201.178100] BUG: unable to handle kernel NULL pointer dereference at 00000084
[ 201.180005] IP: [<f84bc923>] hinfo_to_pin_index+0x4/0x36 [snd_hda_codec_hdmi]
[ 201.180005] *pdpt = 00000000367bc001 *pde = 0000000000000000
[ 201.180005] Oops: 0000 [#2] SMP
[ 201.180005] Modules linked in: bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi powernow_k8 mperf crc32c_intel aesni_intel cryptd i2c_piix4 snd_hda_intel snd_hda_codec aes_i586 i2c_core snd_seq snd_seq_device snd_hwdep snd_pcm snd_timer snd soundcore snd_page_alloc processor psmouse serio_raw pcspkr thermal_sys ipmi_si(+) evdev ipmi_msghandler aes_generic tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod microcode sg sd_mod sr_mod cdrom crc_t10dif usb_storage usbhid hid ohci_hcd ahci libahci libata xhci_hcd ehci_hcd scsi_mod r8169 mii button usbcore usb_common [last unloaded: scsi_wait_scan]
[ 201.180005]
[ 201.180005] Pid: 2679, comm: pulseaudio Tainted: G D 3.2.0-4-686-pae #1 Debian 3.2.35-2 LENOVO 4865A14/Annapurna CRB
[ 201.180005] EIP: 0060:[<f84bc923>] EFLAGS: 00010296 CPU: 2
[ 201.180005] EIP is at hinfo_to_pin_index+0x4/0x36 [snd_hda_codec_hdmi]
[ 201.180005] EAX: 00000000 EBX: 00000000 ECX: 00000000 EDX: f68d4e2c
[ 201.180005] ESI: f68d4e2c EDI: 00000000 EBP: f694fe4c ESP: f6fabd60
[ 201.180005] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 201.180005] Process pulseaudio (pid: 2679, ti=f6faa000 task=f36c65e0 task.ti=f6faa000)
[ 201.180005] Stack:
[ 201.180005] 00000000 f68d4e2c f84bca30 f843305c f6a4b400 f694f800 f848ccdc f6a4b400
[ 201.180005] 00000000 f349e0c0 00000080 f843305c f695b900 f694fe4c f8430515 00000080
[ 201.180005] 00000080 f6a4b400 f349e0c0 f6dc1a00 f68d4e2c f695b900 f6dc1a38 f6fabe04
[ 201.180005] Call Trace:
[ 201.180005] [<f84bca30>] ? hdmi_pcm_open+0x26/0x170 [snd_hda_codec_hdmi]
[ 201.180005] [<f848ccdc>] ? snd_pcm_hw_constraint_step+0x14/0x18 [snd_pcm]
[ 201.180005] [<f8430515>] ? azx_pcm_open+0x171/0x1f7 [snd_hda_intel]
[ 201.180005] [<f848bbcb>] ? snd_pcm_open_substream+0x36/0x68 [snd_pcm]
[ 201.180005] [<f848bcbf>] ? snd_pcm_open+0xc2/0x1be [snd_pcm]
[ 201.180005] [<c10320e5>] ? try_to_wake_up+0x155/0x155
[ 201.180005] [<f848be33>] ? snd_pcm_playback_open+0x31/0x46 [snd_pcm]
[ 201.180005] [<f83fd49e>] ? snd_open+0xf5/0x133 [snd]
[ 201.180005] [<c10cf2d7>] ? chrdev_open+0xf3/0x111
[ 201.180005] [<c10cafb3>] ? __dentry_open+0x17a/0x253
[ 201.180005] [<c10cbd01>] ? nameidata_to_filp+0x3a/0x45
[ 201.180005] [<c10cf1e4>] ? cdev_put+0x17/0x17
[ 201.180005] [<c10d5dac>] ? do_last+0x4f8/0x513
[ 201.180005] [<c10d606e>] ? path_openat+0xa1/0x28b
[ 201.180005] [<c10d6301>] ? do_filp_open+0x23/0x5c
[ 201.180005] [<c102a0e5>] ? should_resched+0x5/0x1e
[ 201.180005] [<c12c0c39>] ? _cond_resched+0x5/0x18
[ 201.180005] [<c10cbd60>] ? do_sys_open+0x54/0xcd
[ 201.180005] [<c10d6f81>] ? do_fcntl+0x151/0x3b0
[ 201.180005] [<c10cbdf7>] ? sys_open+0x1e/0x23
[ 201.180005] [<c12c641f>] ? sysenter_do_call+0x12/0x28
[ 201.180005] Code: f0 47 8b 54 24 18 e8 d5 13 00 00 83 c4 10 8b 04 24 3b b8 84 00 00 00 0f 8c 32 ff ff ff 83 c4 0c 31 c0 5b 5e 5f 5d c3 56 89 c1 53 <8b> 98 84 00 00 00 31 c0 eb 0f 6b f0 70 8d b4 31 2c 0e 00 00 39
[ 201.180005] EIP: [<f84bc923>] hinfo_to_pin_index+0x4/0x36 [snd_hda_codec_hdmi] SS:ESP 0068:f6fabd60
[ 201.180005] CR2: 0000000000000084
[ 201.489094] ---[ end trace 839383ef87675225 ]---
[ 202.544023] eth0: no IPv6 routers present
[ 201.856097] ------------[ cut here ]------------
[ 201.856097] WARNING: at /build/buildd-linux_3.2.35-2-i386-pOtnxQ/linux-3.2.35/kernel/watchdog.c:241 watchdog_overflow_callback+0x81/0x8d()
[ 201.856097] Hardware name: 4865A14
[ 201.856097] Watchdog detected hard LOCKUP on cpu 3
[ 201.856097] Modules linked in: bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi powernow_k8 mperf crc32c_intel aesni_intel cryptd i2c_piix4 snd_hda_intel snd_hda_codec aes_i586 i2c_core snd_seq snd_seq_device snd_hwdep snd_pcm snd_timer snd soundcore snd_page_alloc processor psmouse serio_raw pcspkr thermal_sys ipmi_si(+) evdev ipmi_msghandler aes_generic tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod microcode sg sd_mod sr_mod cdrom crc_t10dif usb_storage usbhid hid ohci_hcd ahci libahci libata xhci_hcd ehci_hcd scsi_mod r8169 mii button usbcore usb_common [last unloaded: scsi_wait_scan]
[ 201.856097] Pid: 2643, comm: ps Tainted: G D 3.2.0-4-686-pae #1 Debian 3.2.35-2
[ 201.856097] Call Trace:
[ 201.856097] [<c10383ac>] ? warn_slowpath_common+0x68/0x79
[ 201.856097] [<c1076fe6>] ? watchdog_overflow_callback+0x81/0x8d
[ 201.856097] [<c1076f65>] ? touch_nmi_watchdog+0x4e/0x4e
[ 201.856097] [<c1038425>] ? warn_slowpath_fmt+0x29/0x2d
[ 201.856097] [<c1076fe6>] ? watchdog_overflow_callback+0x81/0x8d
[ 201.856097] [<c1092218>] ? __perf_event_overflow+0x13a/0x1b1
[ 201.856097] [<c1014f3a>] ? x86_perf_event_set_period+0x1a9/0x1b3
[ 201.856097] [<c10927c3>] ? perf_event_overflow+0xd/0xf
[ 201.856097] [<c101530f>] ? x86_pmu_handle_irq+0xba/0xe9
[ 201.856097] [<c12c36aa>] ? perf_event_nmi_handler+0x14/0x15
[ 201.856097] [<c12c30c4>] ? nmi_handle.isra.0+0x2f/0x4a
[ 201.856097] [<c12c314a>] ? do_nmi+0x6b/0x294
[ 201.856097] [<c10daf8a>] ? __d_lookup_rcu+0x6e/0xfb
[ 201.856097] [<c12c2a4c>] ? nmi_stack_correct+0x2f/0x34
[ 201.856097] [<c105d6bb>] ? do_raw_spin_lock+0x13/0x18
[ 201.856097] [<c104489d>] ? __lock_task_sighand+0x34/0x51
[ 201.856097] [<c1106b28>] ? do_task_stat+0x138/0x6b7
[ 201.856097] [<c10e1316>] ? seq_open+0x4f/0x6b
[ 201.856097] [<c10e1301>] ? seq_open+0x3a/0x6b
[ 201.856097] [<c10cafd3>] ? __dentry_open+0x19a/0x253
[ 201.856097] [<c11034a8>] ? sched_open+0x12/0x12
[ 201.856097] [<c10da3bb>] ? dput+0x21/0xc2
[ 201.856097] [<c10df02b>] ? mntput_no_expire+0x1b/0xb0
[ 201.856097] [<c10d5d68>] ? do_last+0x4b4/0x513
[ 201.856097] [<c10da3bb>] ? dput+0x21/0xc2
[ 201.856097] [<c10df02b>] ? mntput_no_expire+0x1b/0xb0
[ 201.856097] [<c10d6243>] ? path_openat+0x276/0x28b
[ 201.856097] [<c10d6301>] ? do_filp_open+0x23/0x5c
[ 201.856097] [<c1107640>] ? proc_tgid_stat+0xb/0xe
[ 201.856097] [<c110437f>] ? proc_single_show+0x3c/0x57
[ 201.856097] [<c10e1101>] ? seq_read+0x167/0x32d
[ 201.856097] [<c10e0f9a>] ? seq_lseek+0x12b/0x12b
[ 201.856097] [<c10cc910>] ? vfs_read+0x80/0xd1
[ 201.856097] [<c10cc99e>] ? sys_read+0x3d/0x61
[ 201.856097] [<c12c641f>] ? sysenter_do_call+0x12/0x28
[ 201.856097] ---[ end trace 839383ef87675226 ]---
[ 260.300006] INFO: rcu_sched detected stalls on CPUs/tasks: { 3} (detected by 2, t=15002 jiffies)
[ 260.304002] sending NMI to all CPUs:
[ 260.304002] NMI backtrace for cpu 2
[ 260.304002] Modules linked in: bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi powernow_k8 mperf crc32c_intel aesni_intel cryptd i2c_piix4 snd_hda_intel snd_hda_codec aes_i586 i2c_core snd_seq snd_seq_device snd_hwdep snd_pcm snd_timer snd soundcore snd_page_alloc processor psmouse serio_raw pcspkr thermal_sys ipmi_si(+) evdev ipmi_msghandler aes_generic tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod microcode sg sd_mod sr_mod cdrom crc_t10dif usb_storage usbhid hid ohci_hcd ahci libahci libata xhci_hcd ehci_hcd scsi_mod r8169 mii button usbcore usb_common [last unloaded: scsi_wait_scan]
[ 260.304002]
[ 260.304002] Pid: 0, comm: swapper/2 Tainted: G D W 3.2.0-4-686-pae #1 Debian 3.2.35-2 LENOVO 4865A14/Annapurna CRB
[ 260.304002] EIP: 0060:[<c1163db6>] EFLAGS: 00000817 CPU: 2
[ 260.304002] EIP is at delay_tsc+0x0/0x54
[ 260.304002] EAX: 0030587e EBX: 00002710 ECX: fffff000 EDX: 0030587d
[ 260.304002] ESI: c13eb700 EDI: c13eb880 EBP: c13eb780 ESP: f74a5e84
[ 260.304002] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 260.304002] Process swapper/2 (pid: 0, ti=f74a4000 task=f749d140 task.ti=f74a4000)
[ 260.304002] Stack:
[ 260.304002] c1163d8b c101ef32 f79d2b1c c107b6f7 00000003 00000001 c13eb880 00000002
[ 260.304002] 00000000 00000002 f79d2954 c107ba88 f749d140 00000000 c1042606 f74a5f4c
[ 260.304002] 9b16d769 0000003c c105978a f79d2954 ffffffff f79d2880 f79d28b0 c104fca5
[ 260.304002] Call Trace:
[ 260.304002] [<c1163d8b>] ? __delay+0x6/0x7
[ 260.304002] [<c101ef32>] ? arch_trigger_all_cpu_backtrace+0x4d/0x5b
[ 260.304002] [<c107b6f7>] ? __rcu_pending+0x1c5/0x2ab
[ 260.304002] [<c107ba88>] ? rcu_check_callbacks+0x79/0xad
[ 260.304002] [<c1042606>] ? update_process_times+0x2a/0x53
[ 260.304002] [<c105978a>] ? tick_sched_timer+0x61/0x8e
[ 260.304002] [<c104fca5>] ? __run_hrtimer+0x99/0x10d
[ 260.304002] [<c1059729>] ? tick_nohz_handler+0xd5/0xd5
[ 260.304002] [<c1050530>] ? hrtimer_interrupt+0xe8/0x1e4
[ 260.304002] [<c101e510>] ? smp_apic_timer_interrupt+0x56/0x65
[ 260.304002] [<c12c2761>] ? apic_timer_interrupt+0x31/0x38
[ 260.304002] [<c10243f0>] ? native_safe_halt+0x2/0x3
[ 260.304002] [<c1010820>] ? default_idle+0x40/0x6d
[ 260.304002] [<c100acc7>] ? cpu_idle+0x95/0xaf
[ 260.304002] [<c12b8d01>] ? start_secondary+0x1be/0x1c3
[ 260.304002] Code: c3 64 8b 15 1c 0a 48 c1 6b d2 3e c1 e0 02 f7 e2 8d 42 01 e9 e2 ff ff ff 69 c0 c7 10 00 00 e9 de ff ff ff 8d 04 80 e9 d6 ff ff ff <55> 57 56 53 89 c3 64 8b 3d 2c bf 47 c1 0f ae f0 8d 76 00 e8 82
[ 260.304002] Call Trace:
[ 260.304002] [<c1163d8b>] ? __delay+0x6/0x7
[ 260.304002] [<c101ef32>] ? arch_trigger_all_cpu_backtrace+0x4d/0x5b
[ 260.304002] [<c107b6f7>] ? __rcu_pending+0x1c5/0x2ab
[ 260.304002] [<c107ba88>] ? rcu_check_callbacks+0x79/0xad
[ 260.304002] [<c1042606>] ? update_process_times+0x2a/0x53
[ 260.304002] [<c105978a>] ? tick_sched_timer+0x61/0x8e
[ 260.304002] [<c104fca5>] ? __run_hrtimer+0x99/0x10d
[ 260.304002] [<c1059729>] ? tick_nohz_handler+0xd5/0xd5
[ 260.304002] [<c1050530>] ? hrtimer_interrupt+0xe8/0x1e4
[ 260.304002] [<c101e510>] ? smp_apic_timer_interrupt+0x56/0x65
[ 260.304002] [<c12c2761>] ? apic_timer_interrupt+0x31/0x38
[ 260.304002] [<c10243f0>] ? native_safe_halt+0x2/0x3
[ 260.304002] [<c1010820>] ? default_idle+0x40/0x6d
[ 260.304002] [<c100acc7>] ? cpu_idle+0x95/0xaf
[ 260.304002] [<c12b8d01>] ? start_secondary+0x1be/0x1c3
[ 201.856097] NMI backtrace for cpu 3
[ 201.856097] Modules linked in: bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi powernow_k8 mperf crc32c_intel aesni_intel cryptd i2c_piix4 snd_hda_intel snd_hda_codec aes_i586 i2c_core snd_seq snd_seq_device snd_hwdep snd_pcm snd_timer snd soundcore snd_page_alloc processor psmouse serio_raw pcspkr thermal_sys ipmi_si(+) evdev ipmi_msghandler aes_generic tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod microcode sg sd_mod sr_mod cdrom crc_t10dif usb_storage usbhid hid ohci_hcd ahci libahci libata xhci_hcd ehci_hcd scsi_mod r8169 mii button usbcore usb_common [last unloaded: scsi_wait_scan]
[ 201.856097]
[ 201.856097] Pid: 2643, comm: ps Tainted: G D W 3.2.0-4-686-pae #1 Debian 3.2.35-2 LENOVO 4865A14/Annapurna CRB
[ 201.856097] EIP: 0060:[<c105d6bb>] EFLAGS: 00000097 CPU: 3
[ 201.856097] EIP is at do_raw_spin_lock+0x13/0x18
[ 201.856097] EAX: f68f8fc4 EBX: f6749eec ECX: 00000014 EDX: 00001413
[ 201.856097] ESI: f68d6200 EDI: f68f8ac0 EBP: 00000001 ESP: f6749e18
[ 201.856097] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 201.856097] Process ps (pid: 2643, ti=f6748000 task=f6d8b5e0 task.ti=f6748000)
[ 201.856097] Stack:
[ 201.856097] c104489d f68d6200 f68d6200 f2cceac0 c1106b28 f6e9e240 c10e1316 f68e9900
[ 201.856097] 00000001 f6e9e240 f3ae0388 c10e1301 f36d8c80 c13e9644 f3ae0388 00000000
[ 201.856097] 00000000 c10cafd3 b76cc424 bfabdfc0 f6749efc f3ade398 f36d8c80 f6c95940
[ 201.856097] Call Trace:
[ 201.856097] [<c104489d>] ? __lock_task_sighand+0x34/0x51
[ 201.856097] [<c1106b28>] ? do_task_stat+0x138/0x6b7
[ 201.856097] [<c10e1316>] ? seq_open+0x4f/0x6b
[ 201.856097] [<c10e1301>] ? seq_open+0x3a/0x6b
[ 201.856097] [<c10cafd3>] ? __dentry_open+0x19a/0x253
[ 201.856097] [<c11034a8>] ? sched_open+0x12/0x12
[ 201.856097] [<c10da3bb>] ? dput+0x21/0xc2
[ 201.856097] [<c10df02b>] ? mntput_no_expire+0x1b/0xb0
[ 201.856097] [<c10d5d68>] ? do_last+0x4b4/0x513
[ 201.856097] [<c10da3bb>] ? dput+0x21/0xc2
[ 201.856097] [<c10df02b>] ? mntput_no_expire+0x1b/0xb0
[ 201.856097] [<c10d6243>] ? path_openat+0x276/0x28b
[ 201.856097] [<c10d6301>] ? do_filp_open+0x23/0x5c
[ 201.856097] [<c1107640>] ? proc_tgid_stat+0xb/0xe
[ 201.856097] [<c110437f>] ? proc_single_show+0x3c/0x57
[ 201.856097] [<c10e1101>] ? seq_read+0x167/0x32d
[ 201.856097] [<c10e0f9a>] ? seq_lseek+0x12b/0x12b
[ 201.856097] [<c10cc910>] ? vfs_read+0x80/0xd1
[ 201.856097] [<c10cc99e>] ? sys_read+0x3d/0x61
[ 201.856097] [<c12c641f>] ? sysenter_do_call+0x12/0x28
[ 201.856097] Code: 08 79 05 e8 f0 72 10 00 c3 f0 81 28 00 00 10 00 74 05 e8 c5 72 10 00 c3 ba 00 01 00 00 f0 66 0f c1 10 0f b6 ce 38 ca 74 06 f3 90 <8a> 10 eb f6 c3 53 66 8b 10 89 c1 31 c0 38 d6 75 16 8d 9a 00 01
[ 201.856097] Call Trace:
[ 201.856097] [<c104489d>] ? __lock_task_sighand+0x34/0x51
[ 201.856097] [<c1106b28>] ? do_task_stat+0x138/0x6b7
[ 201.856097] [<c10e1316>] ? seq_open+0x4f/0x6b
[ 201.856097] [<c10e1301>] ? seq_open+0x3a/0x6b
[ 201.856097] [<c10cafd3>] ? __dentry_open+0x19a/0x253
[ 201.856097] [<c11034a8>] ? sched_open+0x12/0x12
[ 201.856097] [<c10da3bb>] ? dput+0x21/0xc2
[ 201.856097] [<c10df02b>] ? mntput_no_expire+0x1b/0xb0
[ 201.856097] [<c10d5d68>] ? do_last+0x4b4/0x513
[ 201.856097] [<c10da3bb>] ? dput+0x21/0xc2
[ 201.856097] [<c10df02b>] ? mntput_no_expire+0x1b/0xb0
[ 201.856097] [<c10d6243>] ? path_openat+0x276/0x28b
[ 201.856097] [<c10d6301>] ? do_filp_open+0x23/0x5c
[ 201.856097] [<c1107640>] ? proc_tgid_stat+0xb/0xe
[ 201.856097] [<c110437f>] ? proc_single_show+0x3c/0x57
[ 201.856097] [<c10e1101>] ? seq_read+0x167/0x32d
[ 201.856097] [<c10e0f9a>] ? seq_lseek+0x12b/0x12b
[ 201.856097] [<c10cc910>] ? vfs_read+0x80/0xd1
[ 201.856097] [<c10cc99e>] ? sys_read+0x3d/0x61
[ 201.856097] [<c12c641f>] ? sysenter_do_call+0x12/0x28
[ 260.316011] NMI backtrace for cpu 1
[ 260.316011] Modules linked in: bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi powernow_k8 mperf crc32c_intel aesni_intel cryptd i2c_piix4 snd_hda_intel snd_hda_codec aes_i586 i2c_core snd_seq snd_seq_device snd_hwdep snd_pcm snd_timer snd soundcore snd_page_alloc processor psmouse serio_raw pcspkr thermal_sys ipmi_si(+) evdev ipmi_msghandler aes_generic tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod microcode sg sd_mod sr_mod cdrom crc_t10dif usb_storage usbhid hid ohci_hcd ahci libahci libata xhci_hcd ehci_hcd scsi_mod r8169 mii button usbcore usb_common [last unloaded: scsi_wait_scan]
[ 260.316011]
[ 260.316011] Pid: 0, comm: swapper/1 Tainted: G D W 3.2.0-4-686-pae #1 Debian 3.2.35-2 LENOVO 4865A14/Annapurna CRB
[ 260.316011] EIP: 0060:[<c10243f0>] EFLAGS: 00000246 CPU: 1
[ 260.316011] EIP is at native_safe_halt+0x2/0x3
[ 260.316011] EAX: 00000000 EBX: c1416a5c ECX: f79c3f80 EDX: 00000003
[ 260.316011] ESI: 00000001 EDI: 00000001 EBP: 00000000 ESP: f7493f88
[ 260.316011] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 260.316011] Process swapper/1 (pid: 0, ti=f7492000 task=f74868c0 task.ti=f7492000)
[ 260.316011] Stack:
[ 260.316011] c1010820 c100acc7 5d615e6b 22b369c2 4a00bd6a 00000000 c12b8d01 8b2e9364
[ 260.316011] 4a00bd6a 01040800 00000000 00000000 00000000 00000000 00000000 00000000
[ 260.316011] 00000000 00000000 00000000 00000000 000000d8 000000e0 00000000 00000000
[ 260.316011] Call Trace:
[ 260.316011] [<c1010820>] ? default_idle+0x40/0x6d
[ 260.316011] [<c100acc7>] ? cpu_idle+0x95/0xaf
[ 260.316011] [<c12b8d01>] ? start_secondary+0x1be/0x1c3
[ 260.316011] Code: 89 f0 83 c4 14 5b 5e 5f 5d c3 90 56 89 c6 53 89 d3 8b 00 8b 56 04 f0 0f c7 0e 75 fa 5b 5e c3 9c 58 c3 50 9d c3 fa c3 fb c3 fb f4 <c3> f4 c3 8d b6 00 00 00 00 c3 8d b6 00 00 00 00 c3 0f 06 c3 0f
[ 260.316011] Call Trace:
[ 260.316011] [<c1010820>] ? default_idle+0x40/0x6d
[ 260.316011] [<c100acc7>] ? cpu_idle+0x95/0xaf
[ 260.316011] [<c12b8d01>] ? start_secondary+0x1be/0x1c3
[ 260.316011] NMI backtrace for cpu 0
[ 261.188106] Modules linked in: bridge stp bnep rfcomm bluetooth rfkill crc16 rpcsec_gss_krb5 uinput fuse nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc loop snd_hda_codec_realtek snd_hda_codec_hdmi powernow_k8 mperf crc32c_intel aesni_intel cryptd i2c_piix4 snd_hda_intel snd_hda_codec aes_i586 i2c_core snd_seq snd_seq_device snd_hwdep snd_pcm snd_timer snd soundcore snd_page_alloc processor psmouse serio_raw pcspkr thermal_sys ipmi_si(+) evdev ipmi_msghandler aes_generic tpm_tis tpm tpm_bios ext3 jbd mbcache dm_mod microcode sg sd_mod sr_mod cdrom crc_t10dif usb_storage usbhid hid ohci_hcd ahci libahci libata xhci_hcd ehci_hcd scsi_mod r8169 mii button usbcore usb_common [last unloaded: scsi_wait_scan]
[ 261.188106]
[ 261.188106] Pid: 0, comm: swapper/0 Tainted: G D W 3.2.0-4-686-pae #1 Debian 3.2.35-2 LENOVO 4865A14/Annapurna CRB
[ 261.188106] EIP: 0060:[<c10243f0>] EFLAGS: 00000246 CPU: 0
[ 261.188106] EIP is at native_safe_halt+0x2/0x3
[ 261.188106] EAX: 00000000 EBX: c1416a5c ECX: f79b5f80 EDX: 00000003
[ 261.188106] ESI: 00000000 EDI: c13de000 EBP: 01988003 ESP: c13dbfd0
[ 261.188106] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 261.188106] Process swapper/0 (pid: 0, ti=c13da000 task=c13e0fe0 task.ti=c13da000)
[ 261.188106] Stack:
[ 261.188106] c1010820 c100acc7 3d08cfe6 08c08cc0 c144f1d4 0008d800 c141a6fe 83e450fd
[ 261.188106] 29aba1b8 c144f1d4 00040800 00000000
[ 261.188106] Call Trace:
[ 261.188106] [<c1010820>] ? default_idle+0x40/0x6d
[ 261.188106] [<c100acc7>] ? cpu_idle+0x95/0xaf
[ 261.188106] [<c141a6fe>] ? start_kernel+0x320/0x325
[ 261.188106] Code: 89 f0 83 c4 14 5b 5e 5f 5d c3 90 56 89 c6 53 89 d3 8b 00 8b 56 04 f0 0f c7 0e 75 fa 5b 5e c3 9c 58 c3 50 9d c3 fa c3 fb c3 fb f4 <c3> f4 c3 8d b6 00 00 00 00 c3 8d b6 00 00 00 00 c3 0f 06 c3 0f
[ 261.188106] Call Trace:
[ 261.188106] [<c1010820>] ? default_idle+0x40/0x6d
[ 261.188106] [<c100acc7>] ? cpu_idle+0x95/0xaf
[ 261.188106] [<c141a6fe>] ? start_kernel+0x320/0x325
None of these warnings or backtraces show up on 3.8, and pulseaudio also
does not crash on 3.8.
>> The standard diagnostic script for ALSA is:
>> http://www.alsa-project.org/alsa-info.sh
>>
>> If sound is still broken on 3.8 then please run this script there.
>
> Will do.
I'm still not able to get any sound on 3.8, however.
I've run the script in question, and posted its data here:
http://www.alsa-project.org/db/?f=0a6f72f8128767a735b8cc1f25682fc3bc34b378
--dkg
Attachment:
pgpH1yq2NQjyo.pgp
Description: PGP signature