Well, seems like the bug is not reproducing quite often. I get this today:

[11614.111551] ------------[ cut here ]------------
[11614.111555] kernel BUG at
/build/buildd-linux-2.6_2.6.32-35squeeze2-amd64-OT816k/linux-2.6-2.6.32/debian/build/source_amd64_none/mm/slub.c:2969!
[11614.111558] invalid opcode: 0000 [#1] SMP
[11614.111561] last sysfs file:
/sys/devices/system/cpu/cpu0/cpufreq/cpuinfo_max_freq
[11614.111564] CPU 1
[11614.111566] Modules linked in: sha1_generic arc4 ecb ppp_mppe ppp_async
crc_ccitt ppp_generic slhc acpi_cpufreq cpufreq_stats cpufreq_userspace
cpufreq_powersave cpufreq_conservative parport_pc ppdev lp parport sco
bridge stp bnep rfcomm l2cap bluetooth rfkill vboxnetadp vboxnetflt vboxdrv
fuse loop usbhid hid snd_usb_audio snd_usb_lib uvcvideo
snd_hda_codec_atihdmi videodev snd_seq_midi snd_seq_midi_event v4l1_compat
snd_rawmidi v4l2_compat_ioctl32 snd_hda_codec_realtek snd_hda_intel
snd_hda_codec snd_hwdep snd_pcm snd_seq radeon ttm drm_kms_helper drm
i2c_algo_bit i2c_i801 i2c_core snd_timer snd_seq_device snd soundcore
snd_page_alloc processor evdev pcspkr button asus_atk0110 psmouse serio_raw
ext4 mbcache jbd2 crc16 sg sr_mod cdrom sd_mod crc_t10dif thermal
ata_generic pata_marvell ata_piix libata thermal_sys scsi_mod uhci_hcd atl1e
ehci_hcd usbcore nls_base [last unloaded: scsi_wait_scan]
[11614.111630] Pid: 1433, comm: hald-addon-stor Not tainted 2.6.32-5-amd64
#1 P5QL PRO
[11614.111633] RIP: 0010:[<ffffffff810e72b3>]  [<ffffffff810e72b3>]
kfree+0x55/0xcb
[11614.111641] RSP: 0018:ffff880128ef9a48  EFLAGS: 00010246
[11614.111644] RAX: 0200000000080000 RBX: ffff88012cfa4870 RCX:
00000000002a0028
[11614.111646] RDX: ffff88012cfa4840 RSI: ffffea000419ea58 RDI:
ffffea0003800000
[11614.111649] RBP: ffff880100000000 R08: 0000000000000000 R09:
ffffffff81453930
[11614.111652] R10: ffff880005495780 R11: ffffffff810b5adf R12:
ffffffffa00ed6db
[11614.111654] R13: 0000000000000001 R14: ffff880100000000 R15:
ffff88012f6f0020
[11614.111657] FS:  00007fb8dae10700(0000) GS:ffff880005480000(0000)
knlGS:0000000000000000
[11614.111660] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[11614.111662] CR2: 00007f83d6c16000 CR3: 0000000128f77000 CR4:
00000000000006e0
[11614.111665] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
0000000000000000
[11614.111667] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7:
0000000000000400
[11614.111670] Process hald-addon-stor (pid: 1433, threadinfo
ffff880128ef8000, task ffff88012e5ee2e0)
[11614.111672] Stack:
[11614.111674]  ffff88012cfa4870 ffff88012cfa4840 0000000000000000
ffffffffa00ed6db
[11614.111678] <0> 0000000000000296 ffff880128ef9a98 ffff880128ef9ef8
ffffffff81067bdb
[11614.111682] <0> ffff880128ef9b88 ffffffff812fb91f ffff8800054901b0
0000000000000000
[11614.111686] Call Trace:
[11614.111693]  [<ffffffffa00ed6db>] ? sr_media_change+0x253/0x27a [sr_mod]
[11614.111698]  [<ffffffff81067bdb>] ? hrtimer_cancel+0xc/0x16
[11614.111703]  [<ffffffff812fb91f>] ? schedule_hrtimeout_range+0xd5/0x112
[11614.111709]  [<ffffffffa00df074>] ? media_changed+0x42/0x74 [cdrom]
[11614.111714]  [<ffffffff81111b16>] ? check_disk_change+0x22/0x53
[11614.111720]  [<ffffffffa00e384c>] ? cdrom_open+0x8d2/0x962 [cdrom]
[11614.111724]  [<ffffffff810fbdaa>] ? do_sys_poll+0x316/0x391
[11614.111728]  [<ffffffff810fca57>] ? __pollwait+0x0/0xd6
[11614.111732]  [<ffffffff810fcb2d>] ? pollwake+0x0/0x5b
[11614.111735]  [<ffffffff810fcb2d>] ? pollwake+0x0/0x5b
[11614.111740]  [<ffffffff8118f2bf>] ? kobject_get+0x12/0x17
[11614.111744]  [<ffffffff811840ac>] ? get_disk+0x95/0xb4
[11614.111749]  [<ffffffff812227d4>] ? kobj_lookup+0x169/0x1a1
[11614.111752]  [<ffffffff8118f2bf>] ? kobject_get+0x12/0x17
[11614.111757]  [<ffffffffa00ed464>] ? sr_block_open+0x86/0x9f [sr_mod]
[11614.111762]  [<ffffffff81112827>] ? __blkdev_get+0xc6/0x342
[11614.111765]  [<ffffffff81112aaa>] ? blkdev_open+0x0/0x96
[11614.111769]  [<ffffffff81112b11>] ? blkdev_open+0x67/0x96
[11614.111773]  [<ffffffff810ed402>] ? __dentry_open+0x19d/0x2bf
[11614.111777]  [<ffffffff810f8c63>] ? do_filp_open+0x4e4/0x94b
[11614.111782]  [<ffffffffa00e0ecd>] ? cdrom_release+0x1ae/0x1fe [cdrom]
[11614.111787]  [<ffffffff81097c92>] ? rcu_start_gp+0x197/0x1c0
[11614.111792]  [<ffffffff8101657d>] ? read_tsc+0xa/0x20
[11614.111796]  [<ffffffff81101cb5>] ? alloc_fd+0x67/0x10c
[11614.111799]  [<ffffffff810ed193>] ? do_sys_open+0x55/0xfc
[11614.111803]  [<ffffffff81010b42>] ? system_call_fastpath+0x16/0x1b
[11614.111805] Code: 83 c3 08 48 83 3b 00 eb ec 48 83 fd 10 0f 86 89 00 00
00 48 89 ef e8 b9 e8 ff ff 48 89 c7 48 8b 00 84 c0 78 13 66 a9 00 c0 75 04
<0f> 0b eb fe 5b 5d 41 5c e9 ac 56 fd ff 48 8b 4c 24 18 4c 8b 4f
[11614.111837] RIP  [<ffffffff810e72b3>] kfree+0x55/0xcb
[11614.111841]  RSP <ffff880128ef9a48>
[11614.111844] ---[ end trace e0a06e1b835cfa95 ]---
[11614.362678] stack segment: 0000 [#2] SMP
[11614.362683] last sysfs file:
/sys/devices/system/cpu/cpu0/cpufreq/cpuinfo_max_freq
[11614.362685] CPU 1
[11614.362687] Modules linked in: sha1_generic arc4 ecb ppp_mppe ppp_async
crc_ccitt ppp_generic slhc acpi_cpufreq cpufreq_stats cpufreq_userspace
cpufreq_powersave cpufreq_conservative parport_pc ppdev lp parport sco
bridge stp bnep rfcomm l2cap bluetooth rfkill vboxnetadp vboxnetflt vboxdrv
fuse loop usbhid hid snd_usb_audio snd_usb_lib uvcvideo
snd_hda_codec_atihdmi videodev snd_seq_midi snd_seq_midi_event v4l1_compat
snd_rawmidi v4l2_compat_ioctl32 snd_hda_codec_realtek snd_hda_intel
snd_hda_codec snd_hwdep snd_pcm snd_seq radeon ttm drm_kms_helper drm
i2c_algo_bit i2c_i801 i2c_core snd_timer snd_seq_device snd soundcore
snd_page_alloc processor evdev pcspkr button asus_atk0110 psmouse serio_raw
ext4 mbcache jbd2 crc16 sg sr_mod cdrom sd_mod crc_t10dif thermal
ata_generic pata_marvell ata_piix libata thermal_sys scsi_mod uhci_hcd atl1e
ehci_hcd usbcore nls_base [last unloaded: scsi_wait_scan]
[11614.362752] Pid: 2475, comm: pulseaudio Tainted: G      D
 2.6.32-5-amd64 #1 P5QL PRO
[11614.362755] RIP: 0010:[<ffffffff810e712e>]  [<ffffffff810e712e>]
kmem_cache_alloc+0x61/0xf0
[11614.362764] RSP: 0018:ffff88012b7c1b18  EFLAGS: 00010082
[11614.362766] RAX: 0000000000000000 RBX: 0000000000000246 RCX:
ffff88000001aa00
[11614.362769] RDX: ffff880005492090 RSI: 0000000000000010 RDI:
ffffffff81455f10
[11614.362771] RBP: ffbcbcbcffbcbcbc R08: 0000000000000001 R09:
0000000000000001
[11614.362774] R10: ffff88012bf9df00 R11: ffff88012bf9df00 R12:
0000000000000010
[11614.362776] R13: ffffffff81455f10 R14: ffffffffa000f6a1 R15:
0000000000000008
[11614.362779] FS:  00007f6a1da92700(0000) GS:ffff880005480000(0000)
knlGS:0000000000000000
[11614.362782] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[11614.362784] CR2: 00007fbd3da1bd60 CR3: 000000012dd5c000 CR4:
00000000000006e0
[11614.362787] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
0000000000000000
[11614.362789] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7:
0000000000000400
[11614.362792] Process pulseaudio (pid: 2475, threadinfo ffff88012b7c0000,
task ffff88012d55d4c0)
[11614.362794] Stack:
[11614.362796]  00000010000280d2 ffff88012ebda400 ffff88012ced7800
0000000000000001
[11614.362800] <0> 0000000000000000 0000000000000001 0000000000000001
ffffffffa000f6a1
[11614.362803] <0> 000080d000000010 800002000b7c0001 ffff88012ced7800
00000000000080d2
[11614.362808] Call Trace:
[11614.362818]  [<ffffffffa000f6a1>] ? usb_control_msg+0x3d/0x135 [usbcore]
[11614.362826]  [<ffffffffa000f9ec>] ? usb_set_interface+0xcd/0x19a
[usbcore]
[11614.362832]  [<ffffffffa0324e0f>] ? snd_usb_hw_params+0x29e/0x986
[snd_usb_audio]
[11614.362838]  [<ffffffffa02bff0d>] ? snd_pcm_hw_params+0xe9/0x317
[snd_pcm]
[11614.362844]  [<ffffffffa02c0614>] ? snd_pcm_common_ioctl1+0x24f/0xcff
[snd_pcm]
[11614.362850]  [<ffffffffa02bf54a>] ? snd_pcm_open+0x21f/0x250 [snd_pcm]
[11614.362855]  [<ffffffff8104a449>] ? default_wake_function+0x0/0x9
[11614.362862]  [<ffffffffa00ab68d>] ? snd_open+0x12d/0x138 [snd]
[11614.362866]  [<ffffffff810f1655>] ? chrdev_open+0x11f/0x13e
[11614.362869]  [<ffffffff810f603b>] ? acl_permission_check+0x4f/0x7e
[11614.362873]  [<ffffffff810e782d>] ? __kmalloc_track_caller+0x12a/0x13c
[11614.362878]  [<ffffffff811160b0>] ? fsnotify_create_event+0xb1/0x174
[11614.362882]  [<ffffffff81190c79>] ? prio_tree_insert+0x185/0x20d
[11614.362887]  [<ffffffff812fb826>] ? mutex_lock+0xd/0x31
[11614.362892]  [<ffffffffa02c151f>] ? snd_pcm_playback_ioctl1+0x204/0x221
[snd_pcm]
[11614.362898]  [<ffffffffa02c1e7a>] ? snd_pcm_playback_ioctl+0x2e/0x36
[snd_pcm]
[11614.362902]  [<ffffffff810fa94e>] ? vfs_ioctl+0x21/0x6c
[11614.362906]  [<ffffffff810fae9c>] ? do_vfs_ioctl+0x48d/0x4cb
[11614.362909]  [<ffffffff810faf2b>] ? sys_ioctl+0x51/0x70
[11614.362913]  [<ffffffff81010b42>] ? system_call_fastpath+0x16/0x1b
[11614.362915] Code: 48 89 c3 fa 66 0f 1f 44 00 00 65 8b 04 25 a8 e3 00 00
48 98 49 8b 94 c5 f0 02 00 00 48 8b 2a 44 8b 7a 18 48 85 ed 74 0d 8b 42 14
<48> 8b 44 c5 00 48 89 02 eb 17 49 89 d0 4c 89 f1 83 ca ff 44 89
[11614.362945] RIP  [<ffffffff810e712e>] kmem_cache_alloc+0x61/0xf0
[11614.362949]  RSP <ffff88012b7c1b18>
[11614.362952] ---[ end trace e0a06e1b835cfa96 ]---
[11614.362956] note: pulseaudio[2475] exited with preempt_count 1

-- 
with best regards, Volodymyr

2011/9/30 Ben Hutchings <b...@decadent.org.uk>

> On Fri, 2011-09-30 at 10:01 +0200, Volodymyr Shcherbyna wrote:
> > It seems like it just happens once.
> >
> > I will try to repro it with vbox. Will make sure that I have a solid
> > test-case scenario and then will test it without vbox.
> >
> > Speaking of testing modules. Is there any thing in Linux as Driver
> > Verifier which is used in Windows? It allows to check for pool
> > corruptions, page faults when called at high IRQLs, etc. I assume
> > there are none for Linux.
> [...]
>
> There are build-time options to enable such checking in the kernel.  See
> the options under "Kernel debugging" (CONFIG_DEBUG_KERNEL).
>
> Ben.
>
> --
> Ben Hutchings
> Everything should be made as simple as possible, but not simpler.
>                                                           - Albert Einstein
>

Reply via email to