You've got two problems; 1) Communication with the device isn't working well. 2) The EXT3 fs layer can't deal well with #1.
If you turn on USB Mass Storage Verbose Debugging you should be able to generate a log which may help us figure out why you have problem #1. Matt On Tue, Jun 08, 2004 at 10:55:52AM -0400, [EMAIL PROTECTED] wrote: > 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) -- Matthew Dharm Home: [EMAIL PROTECTED] Maintainer, Linux USB Mass Storage Driver It was a new hope. -- Dust Puppy User Friendly, 12/25/1998
pgpvHGeRgVu6k.pgp
Description: PGP signature
