Matthew,
I have been having issues with repeated kernel panics using a USB hard
drive enclosure, and I was hoping you might be able to help me track down
the cause. I'm hoping that it is a bug in the kernel, but I fear the
problem may be the device itself. The device has a USB 2.0 interface and
a firewire interface. I get lockups on the device using either one,
although the panics appear to be specific to the usb interface. Rebooting
the device causes it to show up again as a new USB device.
I've attached dmesg output from 2.6.7-rc3. I see panics under 2.6.6 as
well, and I believe 2.6.5. I have no tried earlier than that. I also
attached output from lsusb -v for the device.
Please let me know if there is any other information I can provide, or if
I can just out of luck due to a bad device.
Greg Boyce
us0/target1/lun0: p1
Attached scsi disk sdb at scsi0, channel 0, id 1, lun 0
Attached scsi generic sg0 at scsi0, channel 0, id 0, lun 0, type 0
Attached scsi generic sg1 at scsi0, channel 0, id 1, lun 0, type 0
USB Universal Host Controller Interface driver v2.2
uhci_hcd 0000:00:1f.2: Intel Corp. 82801AA USB
PCI: Setting latency timer of device 0000:00:1f.2 to 64
uhci_hcd 0000:00:1f.2: irq 19, io base 0000ff80
uhci_hcd 0000:00:1f.2: new USB bus registered, assigned bus number 1
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 2 ports detected
usbcore: registered new driver usblp
drivers/usb/class/usblp.c: v0.13: USB Printer Device Class driver
usbcore: registered new driver usbhid
drivers/usb/input/hid-core.c: v2.0:USB HID core driver
mice: PS/2 mouse device common for all mice
serio: i8042 AUX port at 0x60,0x64 irq 12
serio: i8042 KBD port at 0x60,0x64 irq 1
input: AT Translated Set 2 keyboard on isa0060/serio0
Advanced Linux Sound Architecture Driver Version 1.0.4 (Mon May 17 14:31:44 2004 UTC).
ALSA device list:
#0: Sound Blaster Audigy (rev.3) at 0xdc60, irq 16
NET: Registered protocol family 2
IP: routing cache hash table of 4096 buckets, 32Kbytes
TCP: Hash tables configured (established 32768 bind 65536)
NET: Registered protocol family 1
NET: Registered protocol family 17
EXT3-fs: INFO: recovery required on readonly filesystem.
EXT3-fs: write access will be enabled during recovery.
usb 1-1: new full speed USB device using address 2
hub 1-1:1.0: USB hub found
hub 1-1:1.0: 4 ports detected
usb 1-1.1: new low speed USB device using address 3
input: USB HID v1.00 Mouse [Microsoft Microsoft IntelliMouse� Optical] on
usb-0000:00:1f.2-1.1
usb 1-1.3: new low speed USB device using address 4
usb 1-1.4: new low speed USB device using address 5
input: USB HID v1.10 Keyboard [Logitech Logitech USB Keyboard] on usb-0000:00:1f.2-1.4
input: USB HID v1.10 Mouse [Logitech Logitech USB Keyboard] on usb-0000:00:1f.2-1.4
kjournald starting. Commit interval 5 seconds
EXT3-fs: sda2: orphan cleanup on readonly fs
ext3_orphan_cleanup: deleting unreferenced inode 371391
ext3_orphan_cleanup: deleting unreferenced inode 248455
ext3_orphan_cleanup: deleting unreferenced inode 248456
ext3_orphan_cleanup: deleting unreferenced inode 248457
ext3_orphan_cleanup: deleting unreferenced inode 248458
ext3_orphan_cleanup: deleting unreferenced inode 397503
ext3_orphan_cleanup: deleting unreferenced inode 397502
ext3_orphan_cleanup: deleting unreferenced inode 397501
ext3_orphan_cleanup: deleting unreferenced inode 397499
ext3_orphan_cleanup: deleting unreferenced inode 397498
ext3_orphan_cleanup: deleting unreferenced inode 397496
ext3_orphan_cleanup: deleting unreferenced inode 397495
ext3_orphan_cleanup: deleting unreferenced inode 453168
ext3_orphan_cleanup: deleting unreferenced inode 453188
ext3_orphan_cleanup: deleting unreferenced inode 453172
ext3_orphan_cleanup: deleting unreferenced inode 772670
ext3_orphan_cleanup: deleting unreferenced inode 475690
ext3_orphan_cleanup: deleting unreferenced inode 475685
ext3_orphan_cleanup: deleting unreferenced inode 475628
ext3_orphan_cleanup: deleting unreferenced inode 475711
ext3_orphan_cleanup: deleting unreferenced inode 273801
ext3_orphan_cleanup: deleting unreferenced inode 179719
ext3_orphan_cleanup: deleting unreferenced inode 276791
ext3_orphan_cleanup: deleting unreferenced inode 276792
ext3_orphan_cleanup: deleting unreferenced inode 354408
ext3_orphan_cleanup: deleting unreferenced inode 187386
ext3_orphan_cleanup: deleting unreferenced inode 187393
ext3_orphan_cleanup: deleting unreferenced inode 187428
ext3_orphan_cleanup: deleting unreferenced inode 187404
ext3_orphan_cleanup: deleting unreferenced inode 196817
ext3_orphan_cleanup: deleting unreferenced inode 196953
EXT3-fs: sda2: 31 orphan inodes deleted
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
VFS: Mounted root (ext3 filesystem) readonly.
Mounted devfs on /dev
Freeing unused kernel memory: 184k freed
Adding 530136k swap on /dev/sda3. Priority:-1 extents:1
EXT3 FS on sda2, internal journal
kjournald starting. Commit interval 5 seconds
EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
EXT3 FS on sda5, internal journal
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
kjournald starting. Commit interval 5 seconds
EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
EXT3 FS on sdb1, internal journal
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
kjournald starting. Commit interval 5 seconds
EXT3 FS on sda6, internal journal
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
ohci1394: $Rev: 1203 $ Ben Collins <[EMAIL PROTECTED]>
ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[17] MMIO=[fafff000-fafff7ff] Max
Packet=[2048]
ieee1394: Host added: ID:BUS[0-00:1023] GUID[00023c00200485da]
Linux video capture interface: v1.00
usbcore: registered new driver dsbr100
drivers/usb/media/dsbr100.c: v0.40:D-Link DSB-R100 USB FM radio driver
atkbd.c: Spurious ACK on isa0060/serio0. Some program, like XFree86, might be trying
access hardware directly.
atkbd.c: Spurious ACK on isa0060/serio0. Some program, like XFree86, might be trying
access hardware directly.
usb 1-2: new full speed USB device using address 6
Initializing USB Mass Storage driver...
scsi2 : SCSI emulation for USB Mass Storage devices
Vendor: Maxtor 6 Model: Y160P0 Rev: YAR4
Type: Direct-Access ANSI SCSI revision: 02
SCSI device sdc: 320173057 512-byte hdwr sectors (163929 MB)
sdc: assuming drive cache: write through
/dev/scsi/host2/bus0/target0/lun0: p1
Attached scsi disk sdc at scsi2, channel 0, id 0, lun 0
Attached scsi generic sg2 at scsi2, channel 0, id 0, lun 0, type 0
USB Mass Storage device found at 6
usbcore: registered new driver usb-storage
USB Mass Storage support registered.
kjournald starting. Commit interval 5 seconds
EXT3 FS on sdc1, internal journal
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
SCSI error : <2 0 0 0> return code = 0x8000002
Current sdc: sense = 70 0
Raw sense data:0x70 0x00 0x00 0x00 0x00 0x00 0x00 0x0a 0x00 0x00 0x00 0x00 0x00 0x00
0x00 0x00 0x00 0x00
end_request: I/O error, dev sdc, sector 9945151
EXT3-fs error (device sdc1): ext3_find_entry: reading directory #606209 offset 0
Aborting journal on device sdc1.
ext3_abort called.
EXT3-fs abort (device sdc1): ext3_journal_start: Detected aborted journal
Remounting filesystem read-only
usb 1-2: reset full speed USB device using address 6
usb 1-2: USB disconnect, address 6
scsi: Device offlined - not ready after error recovery: host 2 channel 0 id 0 lun 0
sd 2:0:0:0: Illegal state transition cancel->offline
Badness in scsi_device_set_state at drivers/scsi/scsi_lib.c:1640
[<c0106f2e>] dump_stack+0x1e/0x30
[<c0291186>] scsi_device_set_state+0xc6/0x120
[<c028ee7e>] scsi_eh_offline_sdevs+0x6e/0x90
[<c028f40f>] scsi_unjam_host+0xbf/0xd0
[<c028f508>] scsi_error_handler+0xe8/0x130
[<c0104375>] kernel_thread_helper+0x5/0x10
SCSI error : <2 0 0 0> return code = 0x10000
end_request: I/O error, dev sdc, sector 4247
Buffer I/O error on device sdc1, logical block 523
lost page write due to I/O error on sdc1
SCSI error : <2 0 0 0> return code = 0x10000
end_request: I/O error, dev sdc, sector 111
Buffer I/O error on device sdc1, logical block 6
lost page write due to I/O error on sdc1
Unable to handle kernel paging request at virtual address 38383737
printing eip:
c025e49b
*pde = 00000000
Oops: 0000 [#1]
PREEMPT
Modules linked in: usb_storage dsbr100 videodev ohci1394 ieee1394
CPU: 0
EIP: 0060:[<c025e49b>] Not tainted
EFLAGS: 00210046 (2.6.7-rc3)
EIP is at as_find_arq_hash+0x2b/0xb0
eax: 00000000 ebx: 00000000 ecx: c55c2698 edx: 38383737
esi: c55c2698 edi: 38383737 ebp: c33f9bfc esp: c33f9be0
ds: 007b es: 007b ss: 0068
Process rsync (pid: 19175, threadinfo=c33f8000 task=db85adb0)
Stack: c01153f8 db7df8d0 00000000 00000000 00000000 c55c2698 00000000 c33f9c30
c02603ec c55c2698 00000000 00000000 c04df128 0000363e 00000008 00000000
c55c2698 00000000 dfcd68ec 00000000 c33f9c44 c02575b9 dfcd68ec c33f9c74
Call Trace:
[<c0106eef>] show_stack+0x7f/0xa0
[<c0107096>] show_registers+0x156/0x1b0
[<c0107239>] die+0x89/0x100
[<c0114496>] do_page_fault+0x1f6/0x59f
[<c0106b75>] error_code+0x2d/0x38
[<c02603ec>] as_merge+0x11c/0x200
[<c02575b9>] elv_merge+0x29/0x30
[<c025a615>] __make_request+0xa5/0x570
[<c025ac3a>] generic_make_request+0x15a/0x1e0
[<c025ad1b>] submit_bio+0x5b/0x100
[<c0154a4e>] sync_dirty_buffer+0x4e/0xb0
[<c0192e7d>] ext3_handle_error+0x7d/0xb0
[<c0192f04>] ext3_error+0x54/0x60
[<c018fed2>] ext3_find_entry+0x342/0x3e0
[<c01901bf>] ext3_lookup+0x3f/0xc0
[<c015d823>] real_lookup+0xe3/0x110
[<c015daa6>] do_lookup+0x86/0xa0
[<c015df81>] link_path_walk+0x4c1/0x950
[<c015e668>] path_lookup+0x78/0x140
[<c015e8e0>] __user_walk+0x40/0x60
[<c015981b>] vfs_lstat+0x1b/0x60
[<c0159efb>] sys_lstat64+0x1b/0x40
[<c010614b>] syscall_call+0x7/0xb
Code: 8b 37 39 fe 74 3e eb 0d 90 90 90 90 90 90 90 90 90 90 90 90
<6>note: rsync[19175] exited with preempt_count 1
Debug: sleeping function called from invalid context at include/linux/rwsem.h:43
in_atomic():1, irqs_disabled():0
[<c0106f2e>] dump_stack+0x1e/0x30
[<c0116ea7>] __might_sleep+0xb7/0xe0
[<c011b701>] do_exit+0xb1/0x450
[<c01072a9>] die+0xf9/0x100
[<c0114496>] do_page_fault+0x1f6/0x59f
[<c0106b75>] error_code+0x2d/0x38
[<c02603ec>] as_merge+0x11c/0x200
[<c02575b9>] elv_merge+0x29/0x30
[<c025a615>] __make_request+0xa5/0x570
[<c025ac3a>] generic_make_request+0x15a/0x1e0
[<c025ad1b>] submit_bio+0x5b/0x100
[<c0154a4e>] sync_dirty_buffer+0x4e/0xb0
[<c0192e7d>] ext3_handle_error+0x7d/0xb0
[<c0192f04>] ext3_error+0x54/0x60
[<c018fed2>] ext3_find_entry+0x342/0x3e0
[<c01901bf>] ext3_lookup+0x3f/0xc0
[<c015d823>] real_lookup+0xe3/0x110
[<c015daa6>] do_lookup+0x86/0xa0
[<c015df81>] link_path_walk+0x4c1/0x950
[<c015e668>] path_lookup+0x78/0x140
[<c015e8e0>] __user_walk+0x40/0x60
[<c015981b>] vfs_lstat+0x1b/0x60
[<c0159efb>] sys_lstat64+0x1b/0x40
[<c010614b>] syscall_call+0x7/0xb
bad: scheduling while atomic!
[<c0106f2e>] dump_stack+0x1e/0x30
[<c03a1e96>] schedule+0x4b6/0x4c0
[<c01403e6>] unmap_vmas+0x1a6/0x1c0
[<c014455d>] exit_mmap+0x7d/0x160
[<c01175f6>] mmput+0x66/0x90
[<c011b760>] do_exit+0x110/0x450
[<c01072a9>] die+0xf9/0x100
[<c0114496>] do_page_fault+0x1f6/0x59f
[<c0106b75>] error_code+0x2d/0x38
[<c02603ec>] as_merge+0x11c/0x200
[<c02575b9>] elv_merge+0x29/0x30
[<c025a615>] __make_request+0xa5/0x570
[<c025ac3a>] generic_make_request+0x15a/0x1e0
[<c025ad1b>] submit_bio+0x5b/0x100
[<c0154a4e>] sync_dirty_buffer+0x4e/0xb0
[<c0192e7d>] ext3_handle_error+0x7d/0xb0
[<c0192f04>] ext3_error+0x54/0x60
[<c018fed2>] ext3_find_entry+0x342/0x3e0
[<c01901bf>] ext3_lookup+0x3f/0xc0
[<c015d823>] real_lookup+0xe3/0x110
[<c015daa6>] do_lookup+0x86/0xa0
[<c015df81>] link_path_walk+0x4c1/0x950
[<c015e668>] path_lookup+0x78/0x140
[<c015e8e0>] __user_walk+0x40/0x60
[<c015981b>] vfs_lstat+0x1b/0x60
[<c0159efb>] sys_lstat64+0x1b/0x40
[<c010614b>] syscall_call+0x7/0xb
Unable to handle kernel NULL pointer dereference at virtual address 00000044
printing eip:
c025e49b
*pde = 00000000
Oops: 0000 [#2]
PREEMPT
Modules linked in: usb_storage dsbr100 videodev ohci1394 ieee1394
CPU: 0
EIP: 0060:[<c025e49b>] Not tainted
EFLAGS: 00210803 (2.6.7-rc3)
EIP is at as_find_arq_hash+0x2b/0xb0
eax: 00000008 ebx: 00000000 ecx: c55c2698 edx: 00000004
esi: c55c2698 edi: 00000044 ebp: d8285d48 esp: d8285d2c
ds: 007b es: 007b ss: 0068
Process bash (pid: 19284, threadinfo=d8284000 task=db85adb0)
Stack: c0419000 c1053220 00001030 00000000 00000000 c55c2698 00000000 d8285d7c
c02603ec c55c2698 00001030 00000000 00000008 c98e2ba8 00001038 00000000
c55c2698 00000000 dfcd68ec 00000000 d8285d90 c02575b9 dfcd68ec d8285dc0
Call Trace:
[<c0106eef>] show_stack+0x7f/0xa0
[<c0107096>] show_registers+0x156/0x1b0
[<c0107239>] die+0x89/0x100
[<c0114496>] do_page_fault+0x1f6/0x59f
[<c0106b75>] error_code+0x2d/0x38
[<c02603ec>] as_merge+0x11c/0x200
[<c02575b9>] elv_merge+0x29/0x30
[<c025a615>] __make_request+0xa5/0x570
[<c025ac3a>] generic_make_request+0x15a/0x1e0
[<c025ad1b>] submit_bio+0x5b/0x100
[<c01549dd>] ll_rw_block+0x6d/0x90
[<c018be4c>] ext3_bread+0x6c/0xb0
[<c0188d88>] ext3_readdir+0x128/0x4c0
[<c01624eb>] vfs_readdir+0x9b/0xb0
[<c016293b>] sys_getdents64+0x6b/0xa5
[<c010614b>] syscall_call+0x7/0xb
Code: 8b 37 39 fe 74 3e eb 0d 90 90 90 90 90 90 90 90 90 90 90 90
<6>note: bash[19284] exited with preempt_count 1
Debug: sleeping function called from invalid context at include/linux/rwsem.h:43
in_atomic():1, irqs_disabled():0
[<c0106f2e>] dump_stack+0x1e/0x30
[<c0116ea7>] __might_sleep+0xb7/0xe0
[<c011b701>] do_exit+0xb1/0x450
[<c01072a9>] die+0xf9/0x100
[<c0114496>] do_page_fault+0x1f6/0x59f
[<c0106b75>] error_code+0x2d/0x38
[<c02603ec>] as_merge+0x11c/0x200
[<c02575b9>] elv_merge+0x29/0x30
[<c025a615>] __make_request+0xa5/0x570
[<c025ac3a>] generic_make_request+0x15a/0x1e0
[<c025ad1b>] submit_bio+0x5b/0x100
[<c01549dd>] ll_rw_block+0x6d/0x90
[<c018be4c>] ext3_bread+0x6c/0xb0
[<c0188d88>] ext3_readdir+0x128/0x4c0
[<c01624eb>] vfs_readdir+0x9b/0xb0
[<c016293b>] sys_getdents64+0x6b/0xa5
[<c010614b>] syscall_call+0x7/0xb
bad: scheduling while atomic!
[<c0106f2e>] dump_stack+0x1e/0x30
[<c03a1e96>] schedule+0x4b6/0x4c0
[<c01403e6>] unmap_vmas+0x1a6/0x1c0
[<c014455d>] exit_mmap+0x7d/0x160
[<c01175f6>] mmput+0x66/0x90
[<c011b760>] do_exit+0x110/0x450
[<c01072a9>] die+0xf9/0x100
[<c0114496>] do_page_fault+0x1f6/0x59f
[<c0106b75>] error_code+0x2d/0x38
[<c02603ec>] as_merge+0x11c/0x200
[<c02575b9>] elv_merge+0x29/0x30
[<c025a615>] __make_request+0xa5/0x570
[<c025ac3a>] generic_make_request+0x15a/0x1e0
[<c025ad1b>] submit_bio+0x5b/0x100
[<c01549dd>] ll_rw_block+0x6d/0x90
[<c018be4c>] ext3_bread+0x6c/0xb0
[<c0188d88>] ext3_readdir+0x128/0x4c0
[<c01624eb>] vfs_readdir+0x9b/0xb0
[<c016293b>] sys_getdents64+0x6b/0xa5
[<c010614b>] syscall_call+0x7/0xb
usb 1-2: new full speed USB device using address 7
scsi3 : SCSI emulation for USB Mass Storage devices
Vendor: Maxtor 6 Model: Y160P0 Rev: YAR4
Type: Direct-Access ANSI SCSI revision: 02
SCSI device sdd: 320173057 512-byte hdwr sectors (163929 MB)
sdd: assuming drive cache: write through
/dev/scsi/host3/bus0/target0/lun0: p1
Attached scsi disk sdd at scsi3, channel 0, id 0, lun 0
Attached scsi generic sg2 at scsi3, channel 0, id 0, lun 0, type 0
USB Mass Storage device found at 7
usb 1-1.4: usbfs: process 19484 (lsusb) did not claim interface 0 before use
usb 1-1.4: usbfs: process 19484 (lsusb) did not claim interface 1 before use
usb 1-1.1: usbfs: USBDEVFS_CONTROL failed cmd lsusb rqt 128 rq 6 len 256 ret -32
usb 1-1.1: usbfs: USBDEVFS_CONTROL failed cmd lsusb rqt 128 rq 6 len 256 ret -32
usb 1-1.1: usbfs: process 19484 (lsusb) did not claim interface 0 before use
usb 1-1: usbfs: USBDEVFS_CONTROL failed cmd lsusb rqt 128 rq 6 len 256 ret -32
usb 1-1: usbfs: USBDEVFS_CONTROL failed cmd lsusb rqt 128 rq 6 len 256 ret -32
Bus 001 Device 007: ID 2116:0320
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.00
bDeviceClass 0 Interface
bDeviceSubClass 0
bDeviceProtocol 0
bMaxPacketSize0 64
idVendor 0x2116
idProduct 0x0320
bcdDevice 0.01
iManufacturer 1 Prolific Technology Inc.
iProduct 2 ATAPI-6 Bridge Controller
iSerial 3 40000000297E
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 32
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 2mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 2
bInterfaceClass 8 Mass Storage
bInterfaceSubClass 6 SCSI
bInterfaceProtocol 80 Bulk (Zip)
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type none
wMaxPacketSize 64
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x82 EP 2 IN
bmAttributes 2
Transfer Type Bulk
Synch Type none
wMaxPacketSize 64
bInterval 0
Language IDs: (length=4)
0409 English(US)
