Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

zconfig and zfault failed, debian wheezy, kernel 3.2 #743

Closed
michaelletzgus opened this issue May 13, 2012 · 3 comments
Closed

zconfig and zfault failed, debian wheezy, kernel 3.2 #743

michaelletzgus opened this issue May 13, 2012 · 3 comments
Labels
Component: Test Suite Indicates an issue with the test framework or a test case
Milestone
0.6.0-rc12

Comments

@michaelletzgus
Copy link

Another test run, maybe the clearest so far:

*spl and zfs from current (13.05.12) git master

  1. many successful runs of "splat -a"
  2. many successful runs of "zconfig -c -v"
  3. many successful runs of "zpios-sanity.sh -c"
  4. "zfault.sh -c -v" gives (probably during the raidz1 test):

May 13 19:51:35 debian kernel: [ 1011.137281] BUG: unable to handle kernel NULL pointer dereference at 00000000000002ae
May 13 19:51:35 debian kernel: [ 1011.140045] IP: [] __blkdev_get+0x7b/0x3a9
May 13 19:51:35 debian kernel: [ 1011.140045] PGD 2ee97067 PUD 25da2067 PMD 0
May 13 19:51:35 debian kernel: [ 1011.140045] Oops: 0000 [#1] SMP
May 13 19:51:35 debian kernel: [ 1011.140045] CPU 0
May 13 19:51:35 debian kernel: [ 1011.140045] Modules linked in: zfs(P) zcommon(P) zunicode(P) znvpair(P) zavl(P) splat(O) spl(O) faulty md_mod ext2 loop zlib_deflate psmouse pcspkr serio_raw snd_intel8x0 snd_ac97_codec parport_pc parport evdev snd_pcm ac joydev power_supply processor thermal_sys i2c_piix4 snd_page_alloc button i2c_core snd_timer vboxguest(O) snd soundcore ac97_bus ext3 mbcache jbd usbhid sd_mod hid crc_t10dif ohci_hcd ahci libahci libata scsi_mod ehci_hcd usbcore usb_common e1000 [last unloaded: spl]
May 13 19:51:35 debian kernel: [ 1011.140045]
May 13 19:51:35 debian kernel: [ 1011.140045] Pid: 7039, comm: zvol_id Tainted: P O 3.2.0-2-amd64 #1 innotek GmbH VirtualBox
May 13 19:51:35 debian kernel: [ 1011.140045] RIP: 0010:[] [] __blkdev_get+0x7b/0x3a9
May 13 19:51:35 debian kernel: [ 1011.140045] RSP: 0018:ffff8800324c5c38 EFLAGS: 00010282
May 13 19:51:35 debian kernel: [ 1011.140045] RAX: ffffffffffffff86 RBX: ffff880019d82cc0 RCX: 00000000000000ff
May 13 19:51:35 debian kernel: [ 1011.140045] RDX: ffffffffffffff86 RSI: ffff8800324c5c54 RDI: ffffffffa03b9560
May 13 19:51:35 debian kernel: [ 1011.140045] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff88003e00a960
May 13 19:51:35 debian kernel: [ 1011.140045] R10: ffff880031a57180 R11: ffff880031a57180 R12: ffffffffffffff86
May 13 19:51:35 debian kernel: [ 1011.140045] R13: 000000000000001d R14: ffff880019d82cd8 R15: ffff88003e2a0780
May 13 19:51:35 debian kernel: [ 1011.140045] FS: 00007f4703531740(0000) GS:ffff88003fc00000(0000) knlGS:0000000000000000
May 13 19:51:35 debian kernel: [ 1011.140045] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
May 13 19:51:35 debian kernel: [ 1011.140045] CR2: 00000000000002ae CR3: 0000000025da3000 CR4: 00000000000006f0
May 13 19:51:35 debian kernel: [ 1011.140045] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
May 13 19:51:35 debian kernel: [ 1011.140045] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
May 13 19:51:35 debian kernel: [ 1011.140045] Process zvol_id (pid: 7039, threadinfo ffff8800324c4000, task ffff88002d608970)
May 13 19:51:35 debian kernel: [ 1011.140045] Stack:
May 13 19:51:35 debian kernel: [ 1011.140045] ffffffff8110b675 00000000324c5cd4 ffff880019d82d98 000000003e1c2400
May 13 19:51:35 debian kernel: [ 1011.140045] ffffffff811200f4 ffff880019d82cc0 0000000000000000 ffff880031a57180
May 13 19:51:35 debian kernel: [ 1011.196879] ffffffff81121762 ffff88003db73350 ffff88003e2a0780 ffffffff81121682
May 13 19:51:35 debian kernel: [ 1011.196879] Call Trace:
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? inode_init_always+0xfa/0x1aa
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? I_BDEV+0x8/0x8
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? blkdev_get+0x1c7/0x2a7
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? unlock_new_inode+0x43/0x4c
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? bdget+0x114/0x11e
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? __dentry_open+0x19c/0x2b3
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? dget+0x12/0x1e
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? do_last+0x553/0x58d
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? path_openat+0xce/0x32a
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? user_path_at_empty+0x53/0x7b
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? do_filp_open+0x2a/0x6e
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? _cond_resched+0x7/0x1c
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? __strncpy_from_user+0x18/0x48
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? alloc_fd+0x64/0x109
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? do_sys_open+0x5e/0xe5
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? system_call_fastpath+0x16/0x1b
May 13 19:51:35 debian kernel: [ 1011.196879] Code: e8 a5 70 06 00 85 c0 89 c5 0f 85 30 03 00 00 4c 8d 73 18 8b 3b 48 8d 74 24 1c e8 df c3 07 00 48 85 c0 49 89 c4 0f 84 0f 03 00 00 <48> 8b 80 28 03 00 00 4c 89 e7 48 8b 40 58 48 89 04 24 e8 cf cb
May 13 19:51:35 debian kernel: [ 1011.196879] RIP [] __blkdev_get+0x7b/0x3a9
May 13 19:51:35 debian kernel: [ 1011.196879] RSP
May 13 19:51:35 debian kernel: [ 1011.196879] CR2: 00000000000002ae
May 13 19:51:35 debian kernel: [ 1011.253469] ---[ end trace 85d4e84335277f34 ]---

  1. Another run of "zconfig -c -v" gives at test 2:

May 13 19:55:21 debian kernel: [ 1237.703229] BUG: unable to handle kernel NULL pointer dereference at 00000000000002ae
May 13 19:55:21 debian kernel: [ 1237.705552] IP: [] __blkdev_get+0x7b/0x3a9
May 13 19:55:21 debian kernel: [ 1237.705552] PGD 27e3e067 PUD 31f4d067 PMD 0
May 13 19:55:21 debian kernel: [ 1237.705552] Oops: 0000 [#2] SMP
May 13 19:55:21 debian kernel: [ 1237.705552] CPU 0
May 13 19:55:21 debian kernel: [ 1237.705552] Modules linked in: zfs(P) zcommon(P) zunicode(P) znvpair(P) zavl(P) splat(O) spl(O) faulty md_mod ext2 loop zlib_deflate psmouse pcspkr serio_raw snd_intel8x0 snd_ac97_codec parport_pc parport evdev snd_pcm ac joydev power_supply processor thermal_sys i2c_piix4 snd_page_alloc button i2c_core snd_timer vboxguest(O) snd soundcore ac97_bus ext3 mbcache jbd usbhid sd_mod hid crc_t10dif ohci_hcd ahci libahci libata scsi_mod ehci_hcd usbcore usb_common e1000 [last unloaded: spl]
May 13 19:55:21 debian kernel: [ 1237.719427]
May 13 19:55:21 debian kernel: [ 1237.719427] Pid: 16504, comm: zpool Tainted: P D O 3.2.0-2-amd64 #1 innotek GmbH VirtualBox
May 13 19:55:21 debian kernel: [ 1237.719427] RIP: 0010:[] [] __blkdev_get+0x7b/0x3a9
May 13 19:55:21 debian kernel: [ 1237.719427] RSP: 0018:ffff8800369b7c38 EFLAGS: 00010282
May 13 19:55:21 debian kernel: [ 1237.719427] RAX: ffffffffffffff86 RBX: ffff880019d82cc0 RCX: 00000000000000ff
May 13 19:55:21 debian kernel: [ 1237.719427] RDX: ffffffffffffff86 RSI: ffff8800369b7c54 RDI: ffffffffa039a560
May 13 19:55:21 debian kernel: [ 1237.719427] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff88003e00a960
May 13 19:55:21 debian kernel: [ 1237.719427] R10: ffff88003c7c05c0 R11: ffff88003c7c05c0 R12: ffffffffffffff86
May 13 19:55:21 debian kernel: [ 1237.719427] R13: 000000000000001d R14: ffff880019d82cd8 R15: ffff88003e1e88c0
May 13 19:55:21 debian kernel: [ 1237.719427] FS: 00007ffd86e30c00(0000) GS:ffff88003fc00000(0000) knlGS:0000000000000000
May 13 19:55:21 debian kernel: [ 1237.719427] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
May 13 19:55:21 debian kernel: [ 1237.719427] CR2: 00000000000002ae CR3: 00000000249fd000 CR4: 00000000000006f0
May 13 19:55:21 debian kernel: [ 1237.719427] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
May 13 19:55:21 debian kernel: [ 1237.719427] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
May 13 19:55:21 debian kernel: [ 1237.719427] Process zpool (pid: 16504, threadinfo ffff8800369b6000, task ffff8800374d9890)
May 13 19:55:21 debian kernel: [ 1237.719427] Stack:
May 13 19:55:21 debian kernel: [ 1237.719427] 0000000000000000 000000001d8492e0 ffff8800369b7c78 0000000000000000
May 13 19:55:21 debian kernel: [ 1237.719427] 0000000000000001 ffff880019d82cc0 0000000000000000 ffff88003c7c05c0
May 13 19:55:21 debian kernel: [ 1237.719427] ffffffff81121762 ffff88003d4cd390 ffff88003e1e88c0 ffffffff81121682
May 13 19:55:21 debian kernel: [ 1237.719427] Call Trace:
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? blkdev_get+0x1c7/0x2a7
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? __dentry_open+0x19c/0x2b3
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? dget+0x12/0x1e
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? do_last+0x553/0x58d
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? path_openat+0xce/0x32a
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? user_path_at_empty+0x53/0x7b
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? do_filp_open+0x2a/0x6e
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? _cond_resched+0x7/0x1c
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? __strncpy_from_user+0x18/0x48
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? alloc_fd+0x64/0x109
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? do_sys_open+0x5e/0xe5
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? system_call_fastpath+0x16/0x1b
May 13 19:55:21 debian kernel: [ 1237.719427] Code: e8 a5 70 06 00 85 c0 89 c5 0f 85 30 03 00 00 4c 8d 73 18 8b 3b 48 8d 74 24 1c e8 df c3 07 00 48 85 c0 49 89 c4 0f 84 0f 03 00 00 <48> 8b 80 28 03 00 00 4c 89 e7 48 8b 40 58 48 89 04 24 e8 cf cb
May 13 19:55:21 debian kernel: [ 1237.719427] RIP [] __blkdev_get+0x7b/0x3a9
May 13 19:55:21 debian kernel: [ 1237.719427] RSP
May 13 19:55:21 debian kernel: [ 1237.719427] CR2: 00000000000002ae
May 13 19:55:21 debian kernel: [ 1237.822849] ---[ end trace 85d4e84335277f35 ]---
May 13 19:59:44 debian kernel: [ 1500.730750] md: nonpersistent superblock ...
May 13 19:59:44 debian kernel: [ 1500.731923] md: bind
May 13 19:59:44 debian kernel: [ 1500.765170] bio: create slab at 1
May 13 19:59:44 debian kernel: [ 1500.766254] md0: detected capacity change from 0 to 16777216
May 13 19:59:44 debian kernel: [ 1500.782670] md0: unknown partition table
May 13 19:59:45 debian kernel: [ 1501.725298] md0: unknown partition table
May 13 19:59:45 debian kernel: [ 1501.744710] md0: detected capacity change from 16777216 to 0
May 13 19:59:45 debian kernel: [ 1501.746020] md: md0 stopped.
May 13 19:59:45 debian kernel: [ 1501.747249] md: unbind
May 13 19:59:45 debian kernel: [ 1501.772625] md: export_rdev(loop4)
root@debian:/var/log# cat kern.log | grep -i 1011
May 13 14:38:44 debian kernel: [ 0.210114] ACPI: PCI Interrupt Link [LNKB](IRQs 5 9 10 *11)
May 13 16:00:55 debian kernel: [ 1016.440834] [] ? child_rip+0xa/0x20
May 13 16:00:55 debian kernel: [ 1016.440834] [] ? child_rip+0x0/0x20
May 13 16:00:55 debian kernel: [ 1016.720058] [] ? child_rip+0xa/0x20
May 13 16:00:55 debian kernel: [ 1016.720058] [] ? child_rip+0x0/0x20
May 13 16:00:58 debian kernel: [ 1019.729066] [] ? common_interrupt+0xe/0x13
May 13 18:27:53 debian kernel: [ 7360.364043] [] ? child_rip+0xa/0x20
May 13 18:27:53 debian kernel: [ 7360.364043] [] ? child_rip+0x0/0x20
May 13 19:51:35 debian kernel: [ 1011.137281] BUG: unable to handle kernel NULL pointer dereference at 00000000000002ae
May 13 19:51:35 debian kernel: [ 1011.140045] IP: [] __blkdev_get+0x7b/0x3a9
May 13 19:51:35 debian kernel: [ 1011.140045] PGD 2ee97067 PUD 25da2067 PMD 0
May 13 19:51:35 debian kernel: [ 1011.140045] Oops: 0000 [#1] SMP
May 13 19:51:35 debian kernel: [ 1011.140045] CPU 0
May 13 19:51:35 debian kernel: [ 1011.140045] Modules linked in: zfs(P) zcommon(P) zunicode(P) znvpair(P) zavl(P) splat(O) spl(O) faulty md_mod ext2 loop zlib_deflate psmouse pcspkr serio_raw snd_intel8x0 snd_ac97_codec parport_pc parport evdev snd_pcm ac joydev power_supply processor thermal_sys i2c_piix4 snd_page_alloc button i2c_core snd_timer vboxguest(O) snd soundcore ac97_bus ext3 mbcache jbd usbhid sd_mod hid crc_t10dif ohci_hcd ahci libahci libata scsi_mod ehci_hcd usbcore usb_common e1000 [last unloaded: spl]
May 13 19:51:35 debian kernel: [ 1011.140045]
May 13 19:51:35 debian kernel: [ 1011.140045] Pid: 7039, comm: zvol_id Tainted: P O 3.2.0-2-amd64 #1 innotek GmbH VirtualBox
May 13 19:51:35 debian kernel: [ 1011.140045] RIP: 0010:[] [] __blkdev_get+0x7b/0x3a9
May 13 19:51:35 debian kernel: [ 1011.140045] RSP: 0018:ffff8800324c5c38 EFLAGS: 00010282
May 13 19:51:35 debian kernel: [ 1011.140045] RAX: ffffffffffffff86 RBX: ffff880019d82cc0 RCX: 00000000000000ff
May 13 19:51:35 debian kernel: [ 1011.140045] RDX: ffffffffffffff86 RSI: ffff8800324c5c54 RDI: ffffffffa03b9560
May 13 19:51:35 debian kernel: [ 1011.140045] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff88003e00a960
May 13 19:51:35 debian kernel: [ 1011.140045] R10: ffff880031a57180 R11: ffff880031a57180 R12: ffffffffffffff86
May 13 19:51:35 debian kernel: [ 1011.140045] R13: 000000000000001d R14: ffff880019d82cd8 R15: ffff88003e2a0780
May 13 19:51:35 debian kernel: [ 1011.140045] FS: 00007f4703531740(0000) GS:ffff88003fc00000(0000) knlGS:0000000000000000
May 13 19:51:35 debian kernel: [ 1011.140045] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
May 13 19:51:35 debian kernel: [ 1011.140045] CR2: 00000000000002ae CR3: 0000000025da3000 CR4: 00000000000006f0
May 13 19:51:35 debian kernel: [ 1011.140045] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
May 13 19:51:35 debian kernel: [ 1011.140045] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
May 13 19:51:35 debian kernel: [ 1011.140045] Process zvol_id (pid: 7039, threadinfo ffff8800324c4000, task ffff88002d608970)
May 13 19:51:35 debian kernel: [ 1011.140045] Stack:
May 13 19:51:35 debian kernel: [ 1011.140045] ffffffff8110b675 00000000324c5cd4 ffff880019d82d98 000000003e1c2400
May 13 19:51:35 debian kernel: [ 1011.140045] ffffffff811200f4 ffff880019d82cc0 0000000000000000 ffff880031a57180
May 13 19:51:35 debian kernel: [ 1011.196879] ffffffff81121762 ffff88003db73350 ffff88003e2a0780 ffffffff81121682
May 13 19:51:35 debian kernel: [ 1011.196879] Call Trace:
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? inode_init_always+0xfa/0x1aa
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? I_BDEV+0x8/0x8
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? blkdev_get+0x1c7/0x2a7
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? unlock_new_inode+0x43/0x4c
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? bdget+0x114/0x11e
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? __dentry_open+0x19c/0x2b3
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? dget+0x12/0x1e
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? do_last+0x553/0x58d
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? path_openat+0xce/0x32a
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? user_path_at_empty+0x53/0x7b
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? do_filp_open+0x2a/0x6e
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? _cond_resched+0x7/0x1c
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? __strncpy_from_user+0x18/0x48
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? alloc_fd+0x64/0x109
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? do_sys_open+0x5e/0xe5
May 13 19:51:35 debian kernel: [ 1011.196879] [] ? system_call_fastpath+0x16/0x1b
May 13 19:51:35 debian kernel: [ 1011.196879] Code: e8 a5 70 06 00 85 c0 89 c5 0f 85 30 03 00 00 4c 8d 73 18 8b 3b 48 8d 74 24 1c e8 df c3 07 00 48 85 c0 49 89 c4 0f 84 0f 03 00 00 <48> 8b 80 28 03 00 00 4c 89 e7 48 8b 40 58 48 89 04 24 e8 cf cb
May 13 19:51:35 debian kernel: [ 1011.196879] RIP [] __blkdev_get+0x7b/0x3a9
May 13 19:51:35 debian kernel: [ 1011.196879] RSP
May 13 19:51:35 debian kernel: [ 1011.196879] CR2: 00000000000002ae
May 13 19:51:35 debian kernel: [ 1011.253469] ---[ end trace 85d4e84335277f34 ]---
May 13 19:51:35 debian kernel: [ 1011.739453] md0: detected capacity change from 268435456 to 0
May 13 19:51:35 debian kernel: [ 1011.741695] md: md0 stopped.
May 13 19:51:35 debian kernel: [ 1011.743868] md: unbind
May 13 19:51:35 debian kernel: [ 1011.752173] md: export_rdev(loop0)
May 13 19:51:35 debian kernel: [ 1011.812962] md1: detected capacity change from 268435456 to 0
May 13 19:51:35 debian kernel: [ 1011.814182] md: md1 stopped.
May 13 19:51:35 debian kernel: [ 1011.815105] md: unbind
May 13 19:51:35 debian kernel: [ 1011.828115] md: export_rdev(loop1)
May 13 19:51:35 debian kernel: [ 1011.919598] md2: detected capacity change from 268435456 to 0
May 13 19:51:35 debian kernel: [ 1011.921193] md: md2 stopped.
May 13 19:51:35 debian kernel: [ 1011.926113] md: unbind
May 13 19:51:35 debian kernel: [ 1011.948134] md: export_rdev(loop2)
root@debian:/var/log#
Message from syslogd@debian at May 13 20:05:51 ...
kernel:[ 1867.428044] Oops: 0000 [#3] SMP

Message from syslogd@debian at May 13 20:05:51 ...
kernel:[ 1867.437758] Stack:

Message from syslogd@debian at May 13 20:05:51 ...
kernel:[ 1867.437758] Call Trace:

Message from syslogd@debian at May 13 20:05:51 ...
kernel:[ 1867.437758] Code: e8 a5 70 06 00 85 c0 89 c5 0f 85 30 03 00 00 4c 8d 73 18 8b 3b 48 8d 74 24 1c e8 df c3 07 00 48 85 c0 49 89 c4 0f 84 0f 03 00 00 <48> 8b 80 28 03 00 00 4c 89 e7 48 8b 40 58 48 89 04 24 e8 cf cb

Message from syslogd@debian at May 13 20:05:51 ...
kernel:[ 1867.437758] CR2: 00000000000002ae
cat kern.log | grep -i 1237
May 13 19:07:55 debian kernel: [ 0.187508] pci 0000:00:00.0: [8086:1237] type 0 class 0x000600
May 13 19:34:58 debian kernel: [ 0.186717] pci 0000:00:00.0: [8086:1237] type 0 class 0x000600
May 13 19:55:20 debian kernel: [ 1237.114603] ZFS: Loaded module v0.6.0-rc8, ZFS pool version 28, ZFS filesystem version 5
May 13 19:55:21 debian kernel: [ 1237.703229] BUG: unable to handle kernel NULL pointer dereference at 00000000000002ae
May 13 19:55:21 debian kernel: [ 1237.705552] IP: [] __blkdev_get+0x7b/0x3a9
May 13 19:55:21 debian kernel: [ 1237.705552] PGD 27e3e067 PUD 31f4d067 PMD 0
May 13 19:55:21 debian kernel: [ 1237.705552] Oops: 0000 [#2] SMP
May 13 19:55:21 debian kernel: [ 1237.705552] CPU 0
May 13 19:55:21 debian kernel: [ 1237.705552] Modules linked in: zfs(P) zcommon(P) zunicode(P) znvpair(P) zavl(P) splat(O) spl(O) faulty md_mod ext2 loop zlib_deflate psmouse pcspkr serio_raw snd_intel8x0 snd_ac97_codec parport_pc parport evdev snd_pcm ac joydev power_supply processor thermal_sys i2c_piix4 snd_page_alloc button i2c_core snd_timer vboxguest(O) snd soundcore ac97_bus ext3 mbcache jbd usbhid sd_mod hid crc_t10dif ohci_hcd ahci libahci libata scsi_mod ehci_hcd usbcore usb_common e1000 [last unloaded: spl]
May 13 19:55:21 debian kernel: [ 1237.719427]
May 13 19:55:21 debian kernel: [ 1237.719427] Pid: 16504, comm: zpool Tainted: P D O 3.2.0-2-amd64 #1 innotek GmbH VirtualBox
May 13 19:55:21 debian kernel: [ 1237.719427] RIP: 0010:[] [] __blkdev_get+0x7b/0x3a9
May 13 19:55:21 debian kernel: [ 1237.719427] RSP: 0018:ffff8800369b7c38 EFLAGS: 00010282
May 13 19:55:21 debian kernel: [ 1237.719427] RAX: ffffffffffffff86 RBX: ffff880019d82cc0 RCX: 00000000000000ff
May 13 19:55:21 debian kernel: [ 1237.719427] RDX: ffffffffffffff86 RSI: ffff8800369b7c54 RDI: ffffffffa039a560
May 13 19:55:21 debian kernel: [ 1237.719427] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff88003e00a960
May 13 19:55:21 debian kernel: [ 1237.719427] R10: ffff88003c7c05c0 R11: ffff88003c7c05c0 R12: ffffffffffffff86
May 13 19:55:21 debian kernel: [ 1237.719427] R13: 000000000000001d R14: ffff880019d82cd8 R15: ffff88003e1e88c0
May 13 19:55:21 debian kernel: [ 1237.719427] FS: 00007ffd86e30c00(0000) GS:ffff88003fc00000(0000) knlGS:0000000000000000
May 13 19:55:21 debian kernel: [ 1237.719427] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
May 13 19:55:21 debian kernel: [ 1237.719427] CR2: 00000000000002ae CR3: 00000000249fd000 CR4: 00000000000006f0
May 13 19:55:21 debian kernel: [ 1237.719427] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
May 13 19:55:21 debian kernel: [ 1237.719427] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
May 13 19:55:21 debian kernel: [ 1237.719427] Process zpool (pid: 16504, threadinfo ffff8800369b6000, task ffff8800374d9890)
May 13 19:55:21 debian kernel: [ 1237.719427] Stack:
May 13 19:55:21 debian kernel: [ 1237.719427] 0000000000000000 000000001d8492e0 ffff8800369b7c78 0000000000000000
May 13 19:55:21 debian kernel: [ 1237.719427] 0000000000000001 ffff880019d82cc0 0000000000000000 ffff88003c7c05c0
May 13 19:55:21 debian kernel: [ 1237.719427] ffffffff81121762 ffff88003d4cd390 ffff88003e1e88c0 ffffffff81121682
May 13 19:55:21 debian kernel: [ 1237.719427] Call Trace:
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? blkdev_get+0x1c7/0x2a7
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? blkdev_get+0x2a7/0x2a7
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? __dentry_open+0x19c/0x2b3
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? dget+0x12/0x1e
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? do_last+0x553/0x58d
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? path_openat+0xce/0x32a
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? user_path_at_empty+0x53/0x7b
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? do_filp_open+0x2a/0x6e
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? _cond_resched+0x7/0x1c
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? __strncpy_from_user+0x18/0x48
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? alloc_fd+0x64/0x109
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? do_sys_open+0x5e/0xe5
May 13 19:55:21 debian kernel: [ 1237.719427] [] ? system_call_fastpath+0x16/0x1b
May 13 19:55:21 debian kernel: [ 1237.719427] Code: e8 a5 70 06 00 85 c0 89 c5 0f 85 30 03 00 00 4c 8d 73 18 8b 3b 48 8d 74 24 1c e8 df c3 07 00 48 85 c0 49 89 c4 0f 84 0f 03 00 00 <48> 8b 80 28 03 00 00 4c 89 e7 48 8b 40 58 48 89 04 24 e8 cf cb
May 13 19:55:21 debian kernel: [ 1237.719427] RIP [] __blkdev_get+0x7b/0x3a9
May 13 19:55:21 debian kernel: [ 1237.719427] RSP
May 13 19:55:21 debian kernel: [ 1237.719427] CR2: 00000000000002ae
May 13 19:55:21 debian kernel: [ 1237.822849] ---[ end trace 85d4e84335277f35 ]---

A reboot is necessary to make "zconfig" running successfully again.
@behlendorf
Copy link
Contributor

Ugh, yes that clearly looks like a bug related to zvol block device handling. However, it's interesting that the zfs code itself appears no where in the stack aside from the zvol id utility in user space.

@dajhorn
Copy link
Contributor

dajhorn commented May 15, 2012

IIRC, this bug has been reported a few other times and is caused by an unknown interaction with Virtual Box. An easy solution is to use a different virtual machine implementation.

@behlendorf behlendorf mentioned this issue Sep 10, 2012
Closed
@behlendorf
Copy link
Contributor

Closing issue, this is a duplicate of #949 which has more context so we'll track it there.

behlendorf pushed a commit that referenced this issue Oct 3, 2012
@cwedgwood @behlendorf
zvol_probe should return NULL when the device isn't found.
23a61cc 
Previously we returned ERR_PTR(-ENOENT) which the rest of the kernel
doesn't expect and as such we can oops.

Signed-off-by: Chris Wedgwood <[email protected]>
Signed-off-by: Brian Behlendorf <[email protected]>
Closes #949
Closes #931
Closes #789
Closes #743
Closes #730
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
Component: Test Suite Indicates an issue with the test framework or a test case
Projects
None yet
Milestone
0.6.0-rc12
Development

No branches or pull requests
3 participants
@behlendorf @dajhorn @michaelletzgus