Greetings, I'm wondering if someone would be able to impart some wisdom regarding problems I'm having with a USB 2.0 external drive enclosure.
Currently running kernel 2.4.25, with USB support compiled into the kernel. I have tried this with both the onboard USB (VIA chipset, UHCI/EHCI), and with the onboard USB disabled with an addin PCI card (NEC, OHCI/EHCI). dmesg shows the USB controller being recognized fine. I can plug in the external drive, it is recognized fine. I can mount the drive and list its contents fine. However, whenever I attempt to copy data from the drive, it will copy 20 or so files and then hang for a long time. This may continue a few times -- copy some files and then hang -- until the device times out. I have tried the device on a WinXP system, accessing the drive with explore2fs, and have been able to copy gigs of data without a problem. Can anyone explain why this might be happening and what can be done to resolve it? Logs (rather long) are below. If there's any other info that may be helpful, I'd be glad to provide it. Thanks, Patrick -- Without verbose debug messages enabled, this is what appears in the logs (logs with verbose enabled are to follow): (preceded by many timeout errors) Feb 9 13:19:34 praeter usb_control/bulk_msg: timeout Feb 9 13:20:14 praeter usb_control/bulk_msg: timeout Feb 9 13:20:14 praeter scsi: device set offline - not ready or command retry failed after bus reset: host 1 channel 0 id 0 lun 0 Feb 9 13:20:14 praeter SCSI disk error : host 1 channel 0 id 0 lun 0 return code = 50000 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 4998032 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 4998040 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 4998280 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 4552 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 4568 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 4998032 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 5243064 Feb 9 13:20:14 praeter EXT3-fs error (device sd(8,2)): ext3_get_inode_loc: unable to read inod e block - inode=327081, block=655383 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 0 Feb 9 13:20:14 praeter I/O error: dev 08:02, sector 36962488 (this continues: I/O errors, followed by EXT3-fs errors) With verbose debug enabled: (when device is plugged in:) Feb 18 17:27:16 praeter ehci_hcd 00:08.2: GetStatus port 1 status 001803 POWER sig=j CSC CONNE CT Feb 18 17:27:16 praeter hub.c: port 1, portstatus 501, change 1, 480 Mb/s Feb 18 17:27:16 praeter hub.c: port 1 connection change Feb 18 17:27:16 praeter hub.c: port 1, portstatus 501, change 1, 480 Mb/s Feb 18 17:27:16 praeter hub.c: port 1, portstatus 501, change 0, 480 Mb/s Feb 18 17:27:17 praeter hub.c: port 1, portstatus 501, change 0, 480 Mb/s Feb 18 17:27:17 praeter hub.c: port 1, portstatus 501, change 0, 480 Mb/s Feb 18 17:27:17 praeter hub.c: port 1, portstatus 501, change 0, 480 Mb/s Feb 18 17:27:17 praeter hub.c: port 1, portstatus 511, change 0, 480 Mb/s Feb 18 17:27:17 praeter hub.c: port 1 of hub 1 not reset yet, waiting 10ms Feb 18 17:27:17 praeter hub.c: port 1, portstatus 511, change 0, 480 Mb/s Feb 18 17:27:17 praeter hub.c: port 1 of hub 1 not reset yet, waiting 10ms Feb 18 17:27:17 praeter ehci_hcd 00:08.2: port 1 high speed Feb 18 17:27:17 praeter ehci_hcd 00:08.2: GetStatus port 1 status 001005 POWER sig=se0 PE CONN ECT Feb 18 17:27:17 praeter hub.c: port 1, portstatus 503, change 10, 480 Mb/s Feb 18 17:27:17 praeter hub.c: new USB device 00:08.2-1, assigned address 2 Feb 18 17:27:17 praeter usb.c: kmalloc IF dd41dc40, numif 1 Feb 18 17:27:17 praeter usb.c: new device strings: Mfr=0, Product=1, SerialNumber=0 Feb 18 17:27:17 praeter usb.c: USB device number 2 default language ID 0x409 Feb 18 17:27:17 praeter Product: USB TO IDE Feb 18 17:27:17 praeter usb-storage: act_altsettting is 0 Feb 18 17:27:17 praeter usb-storage: id_index calculated to be: 89 Feb 18 17:27:17 praeter usb-storage: Array length appears to be: 91 Feb 18 17:27:17 praeter usb-storage: USB Mass Storage device detected Feb 18 17:27:17 praeter usb-storage: Endpoints: In: 0xdd7c5d40 Out: 0xdd7c5d54 Int: 0x00000000 (Period 0) Feb 18 17:27:17 praeter usb-storage: New GUID 05e307020000000000000000 Feb 18 17:27:17 praeter usb-storage: GetMaxLUN command result is 1, data is 0 Feb 18 17:27:17 praeter usb-storage: Transport: Bulk Feb 18 17:27:17 praeter usb-storage: Protocol: Transparent SCSI Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter scsi1 : SCSI emulation for USB Mass Storage devices Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Command INQUIRY (6 bytes) Feb 18 17:27:17 praeter usb-storage: 12 00 00 00 ff 00 77 df e1 8d 20 c0 Feb 18 17:27:17 praeter usb-storage: Bulk command S 0x43425355 T 0x1 Trg 0 LUN 0 L 255 F 128 CL 6 Feb 18 17:27:17 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:27:17 praeter usb-storage: usb_stor_transfer_partial(): xfer 255 bytes Feb 18 17:27:17 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 40/255 Feb 18 17:27:17 praeter usb-storage: Bulk data transfer result 0x1 Feb 18 17:27:17 praeter usb-storage: Attempting to get CSW... Feb 18 17:27:17 praeter usb-storage: clearing endpoint halt for pipe 0xc0008280 Feb 18 17:27:17 praeter usb-storage: usb_stor_clear_halt: result=0 Feb 18 17:27:17 praeter usb-storage: Attempting to get CSW (2nd try)... Feb 18 17:27:17 praeter usb-storage: Bulk status result = 0 Feb 18 17:27:17 praeter usb-storage: Bulk status Sig 0x53425355 T 0x1 R 215 Stat 0x0 Feb 18 17:27:17 praeter usb-storage: Fixing INQUIRY data to show SCSI rev 2 - was 0 Feb 18 17:27:17 praeter usb-storage: scsi cmd done, result=0x0 Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter Vendor: Maxtor 9 Model: 2040U6 Rev: 0811 Feb 18 17:27:17 praeter Type: Direct-Access ANSI SCSI revision: 02 Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad LUN (0/1) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad target number (1/0) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad target number (2/0) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad target number (3/0) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad target number (4/0) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad target number (5/0) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad target number (6/0) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Bad target number (7/0) Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter Attached scsi disk sda at scsi1, channel 0, id 0, lun 0 Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Command TEST_UNIT_READY (6 bytes) Feb 18 17:27:17 praeter usb-storage: 00 00 00 00 00 00 00 00 00 00 00 00 Feb 18 17:27:17 praeter usb-storage: Bulk command S 0x43425355 T 0x2 Trg 0 LUN 0 L 0 F 0 CL 6 Feb 18 17:27:17 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:27:17 praeter usb-storage: Attempting to get CSW... Feb 18 17:27:17 praeter usb-storage: Bulk status result = 0 Feb 18 17:27:17 praeter usb-storage: Bulk status Sig 0x53425355 T 0x2 R 0 Stat 0x0 Feb 18 17:27:17 praeter usb-storage: scsi cmd done, result=0x0 Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Command READ_CAPACITY (10 bytes) Feb 18 17:27:17 praeter usb-storage: 25 00 00 00 00 00 00 00 00 00 00 00 Feb 18 17:27:17 praeter usb-storage: Bulk command S 0x43425355 T 0x3 Trg 0 LUN 0 L 8 F 128 CL 1 0 Feb 18 17:27:17 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:27:17 praeter usb-storage: usb_stor_transfer_partial(): xfer 8 bytes Feb 18 17:27:17 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 8/8 Feb 18 17:27:17 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:27:17 praeter usb-storage: Bulk data transfer result 0x0 Feb 18 17:27:17 praeter usb-storage: Attempting to get CSW... Feb 18 17:27:17 praeter usb-storage: Bulk status result = 0 Feb 18 17:27:17 praeter usb-storage: Bulk status Sig 0x53425355 T 0x3 R 0 Stat 0x0 Feb 18 17:27:17 praeter usb-storage: scsi cmd done, result=0x0 Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter SCSI device sda: 39882528 512-byte hdwr sectors (20420 MB) Feb 18 17:27:17 praeter /dev/scsi/host1/bus0/target0/lun0:<7>usb-storage: queuecommand() called Feb 18 17:27:17 praeter usb-storage: *** thread awakened. Feb 18 17:27:17 praeter usb-storage: Command READ_10 (10 bytes) Feb 18 17:27:17 praeter usb-storage: 28 00 00 00 00 00 00 00 08 00 00 00 Feb 18 17:27:17 praeter usb-storage: Bulk command S 0x43425355 T 0x4 Trg 0 LUN 0 L 4096 F 128 C L 10 Feb 18 17:27:17 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:27:17 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:27:17 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 Feb 18 17:27:17 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:27:17 praeter usb-storage: Bulk data transfer result 0x0 Feb 18 17:27:17 praeter usb-storage: Attempting to get CSW... Feb 18 17:27:17 praeter usb-storage: Bulk status result = 0 Feb 18 17:27:17 praeter usb-storage: Bulk status Sig 0x53425355 T 0x4 R 0 Stat 0x0 Feb 18 17:27:17 praeter usb-storage: scsi cmd done, result=0x0 Feb 18 17:27:17 praeter usb-storage: *** thread sleeping. Feb 18 17:27:17 praeter p1 p2 p3 Feb 18 17:27:17 praeter WARNING: USB Mass Storage data integrity not assured Feb 18 17:27:17 praeter USB Mass Storage device found at 2 Feb 18 17:27:17 praeter usb.c: usb-storage driver claimed interface dd41dc40 Feb 18 17:27:17 praeter usb.c: kusbd: /sbin/hotplug add 2 Feb 18 17:27:17 praeter usb.c: kusbd policy returned 0xfffffffe Feb 18 17:27:17 praeter hub.c: port 2, portstatus 100, change 0, 12 Mb/s Feb 18 17:27:17 praeter hub.c: port 3, portstatus 100, change 0, 12 Mb/s Feb 18 17:27:17 praeter hub.c: port 4, portstatus 100, change 0, 12 Mb/s Feb 18 17:27:17 praeter hub.c: port 5, portstatus 100, change 0, 12 Mb/s Feb 18 17:28:00 praeter usb-storage: queuecommand() called Feb 18 17:28:00 praeter usb-storage: *** thread awakened. . . . (timeouts start occurring) Feb 18 17:28:28 praeter usb-storage: Command READ_10 (10 bytes) Feb 18 17:28:28 praeter usb-storage: 28 00 01 57 8d fd 00 00 90 00 00 00 Feb 18 17:28:28 praeter usb-storage: Bulk command S 0x43425355 T 0x4b Trg 0 LUN 0 L 73728 F 128 CL 10 Feb 18 17:28:28 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:28:28 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:28:28 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:28:28 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 . . . Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:28:28 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 Feb 18 17:28:28 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:28:28 praeter usb-storage: Bulk data transfer result 0x0 Feb 18 17:28:28 praeter usb-storage: Attempting to get CSW... Feb 18 17:28:58 praeter usb-storage: command_abort() called Feb 18 17:28:58 praeter usb-storage: -- transport indicates command was aborted Feb 18 17:28:58 praeter usb-storage: Bulk reset requested Feb 18 17:29:03 praeter usb_control/bulk_msg: timeout Feb 18 17:29:03 praeter usb-storage: Bulk soft reset failed -110 Feb 18 17:29:03 praeter usb-storage: scsi command aborted Feb 18 17:29:03 praeter usb-storage: *** thread sleeping. Feb 18 17:29:03 praeter usb-storage: queuecommand() called Feb 18 17:29:03 praeter usb-storage: *** thread awakened. Feb 18 17:29:03 praeter usb-storage: Command TEST_UNIT_READY (6 bytes) Feb 18 17:29:03 praeter usb-storage: 00 00 00 00 00 00 00 00 90 00 00 00 Feb 18 17:29:03 praeter usb-storage: Bulk command S 0x43425355 T 0x4c Trg 0 LUN 0 L 0 F 0 CL 6 Feb 18 17:29:03 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:29:03 praeter usb-storage: Attempting to get CSW... Feb 18 17:29:13 praeter usb-storage: command_abort() called Feb 18 17:29:13 praeter usb-storage: -- transport indicates command was aborted Feb 18 17:29:13 praeter usb-storage: Bulk reset requested Feb 18 17:29:18 praeter usb_control/bulk_msg: timeout Feb 18 17:29:18 praeter usb-storage: Bulk soft reset failed -110 Feb 18 17:29:18 praeter usb-storage: scsi command aborted Feb 18 17:29:18 praeter usb-storage: *** thread sleeping. Feb 18 17:29:18 praeter usb-storage: device_reset() called Feb 18 17:29:18 praeter usb-storage: Bulk reset requested Feb 18 17:29:23 praeter usb_control/bulk_msg: timeout Feb 18 17:29:23 praeter usb-storage: Bulk soft reset failed -110 Feb 18 17:29:23 praeter usb-storage: bus_reset() called Feb 18 17:29:23 praeter hub.c: port 1, portstatus 511, change 0, 480 Mb/s Feb 18 17:29:23 praeter hub.c: port 1 of hub 1 not reset yet, waiting 10ms Feb 18 17:29:23 praeter hub.c: port 1, portstatus 511, change 0, 480 Mb/s Feb 18 17:29:23 praeter hub.c: port 1 of hub 1 not reset yet, waiting 10ms Feb 18 17:29:23 praeter ehci_hcd 00:08.2: port 1 high speed Feb 18 17:29:23 praeter ehci_hcd 00:08.2: GetStatus port 1 status 001005 POWER sig=se0 PE CONN ECT Feb 18 17:29:23 praeter hub.c: port 1, portstatus 503, change 10, 480 Mb/s Feb 18 17:29:23 praeter usb.c: ignoring set_interface for dev 2, iface 0, alt 0 Feb 18 17:29:23 praeter usb-storage: Examinging driver usb-storage...skipping ourselves. Feb 18 17:29:23 praeter usb-storage: bus_reset() complete Feb 18 17:29:28 praeter usb-storage: queuecommand() called Feb 18 17:29:28 praeter usb-storage: *** thread awakened. Feb 18 17:29:28 praeter usb-storage: Command TEST_UNIT_READY (6 bytes) Feb 18 17:29:28 praeter usb-storage: 00 00 00 00 00 00 00 00 90 00 00 00 Feb 18 17:29:28 praeter usb-storage: Bulk command S 0x43425355 T 0x4d Trg 0 LUN 0 L 0 F 0 CL 6 Feb 18 17:29:28 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:29:28 praeter usb-storage: Attempting to get CSW... Feb 18 17:29:28 praeter usb-storage: Bulk status result = 0 Feb 18 17:29:28 praeter usb-storage: Bulk status Sig 0x53425355 T 0x4d R 0 Stat 0x0 Feb 18 17:29:28 praeter usb-storage: scsi cmd done, result=0x0 Feb 18 17:29:28 praeter usb-storage: *** thread sleeping. Feb 18 17:29:28 praeter usb-storage: queuecommand() called Feb 18 17:29:28 praeter usb-storage: *** thread awakened. . . . (transfer again and then final timeout) Feb 18 17:29:28 praeter usb-storage: Command READ_10 (10 bytes) Feb 18 17:29:28 praeter usb-storage: 28 00 01 57 8d fd 00 00 90 00 00 00 Feb 18 17:29:28 praeter usb-storage: Bulk command S 0x43425355 T 0x4e Trg 0 LUN 0 L 73728 F 128 CL 10 Feb 18 17:29:28 praeter usb-storage: Bulk command transfer result=0 Feb 18 17:29:28 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:29:28 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 Feb 18 17:29:28 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:29:28 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:29:28 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 . . . Feb 18 17:29:28 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:29:28 praeter usb-storage: usb_stor_transfer_partial(): xfer 4096 bytes Feb 18 17:29:28 praeter usb-storage: usb_stor_bulk_msg() returned 0 xferred 4096/4096 Feb 18 17:29:28 praeter usb-storage: usb_stor_transfer_partial(): transfer complete Feb 18 17:29:28 praeter usb-storage: Bulk data transfer result 0x0 Feb 18 17:29:28 praeter usb-storage: Attempting to get CSW... Feb 18 17:29:58 praeter usb-storage: command_abort() called Feb 18 17:29:58 praeter usb-storage: -- transport indicates command was aborted Feb 18 17:29:58 praeter usb-storage: Bulk reset requested Feb 18 17:30:00 praeter CRON[1264]: (root) CMD (test -x /usr/sbin/run-crons && /usr/sbin/run-cr ons ) Feb 18 17:30:03 praeter usb_control/bulk_msg: timeout Feb 18 17:30:03 praeter usb-storage: Bulk soft reset failed -110 Feb 18 17:30:03 praeter usb-storage: scsi command aborted Feb 18 17:30:03 praeter usb-storage: *** thread sleeping. Feb 18 17:30:03 praeter scsi: device set offline - not ready or command retry failed after bus reset: host 1 channel 0 id 0 lun 0 Feb 18 17:30:03 praeter SCSI disk error : host 1 channel 0 id 0 lun 0 return code = 50000 Feb 18 17:30:03 praeter I/O error: dev 08:02, sector 22306352 Feb 18 17:30:03 praeter I/O error: dev 08:02, sector 22306360 . . . etc. ------------------------------------------------------- SF.Net is sponsored by: Speed Start Your Linux Apps Now. Build and deploy apps & Web services for Linux with a free DVD software kit from IBM. Click Now! http://ads.osdn.com/?ad_id=1356&alloc_id=3438&op=click _______________________________________________ [EMAIL PROTECTED] To unsubscribe, use the last form field at: https://lists.sourceforge.net/lists/listinfo/linux-usb-users
