In case someone likes to debug weird harware behaviour remotely:
I have an Iomega DVD/CDRW(+7in1, which I have not yet used) drive which seems to work if I plug it into one of the USB port of my mainboard (Epox 8HDA), but produces reproducible errors on another on-board port. This happens with an x86_64 biarch 2.6.6.
The message when I plug it into the working port is:
May 26 14:51:54 prony kernel: USB Mass Storage device found at 2 May 26 14:51:56 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 1 status 003802 POWER OWNER sig=j CSC May 26 14:51:56 prony kernel: hub 1-0:1.0: port 1, status 0, change 1, 12 Mb/s May 26 14:51:56 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT May 26 14:51:56 prony kernel: hub 1-0:1.0: port 2, status 501, change 1, 480 Mb/s May 26 14:51:56 prony kernel: hub 1-0:1.0: debounce: port 2: delay 100ms stable 4 status 0x501 May 26 14:51:56 prony kernel: ehci_hcd 0000:00:10.4: port 2 high speed May 26 14:51:56 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 2 status 001005 POWER sig=se0 PE CONNECT May 26 14:51:56 prony kernel: usb 1-2: new high speed USB device using address 3 May 26 14:51:56 prony kernel: usb 1-2: new device strings: Mfr=0, Product=1, SerialNumber=2 May 26 14:51:56 prony kernel: usb 1-2: default language 0x0409 May 26 14:51:56 prony kernel: usb 1-2: Product: IOMEGA CDDVD522416EC3-C May 26 14:51:56 prony kernel: usb 1-2: SerialNumber: <something> May 26 14:51:56 prony kernel: usb 1-2: hotplug May 26 14:51:56 prony kernel: usb 1-2: adding 1-2:1.0 (config #1, interface 0) May 26 14:51:56 prony kernel: usb 1-2:1.0: hotplug
Then I can mount it and do something like find . | xargs wc -c without problems. Then I plug it into the other port and it is recognized, too:
May 26 15:15:02 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 1 status 003802 POWER OWNER sig=j CSC May 26 15:15:02 prony kernel: hub 1-0:1.0: port 1, status 0, change 1, 12 Mb/s May 26 15:15:02 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 2 status 001002 POWER sig=se0 CSC May 26 15:15:02 prony kernel: hub 1-0:1.0: port 2, status 100, change 1, 12 Mb/s May 26 15:15:02 prony kernel: usb 1-2: USB disconnect, address 3 May 26 15:15:02 prony kernel: usb 1-2: usb_disable_device nuking all URBs May 26 15:15:02 prony kernel: usb 1-2: unregistering interface 1-2:1.0 May 26 15:15:02 prony kernel: usb-storage: storage_disconnect() called May 26 15:15:02 prony kernel: usb-storage: usb_stor_stop_transport called May 26 15:15:02 prony kernel: usb-storage: -- dissociate_dev May 26 15:15:02 prony kernel: usb-storage: -- sending exit command to thread May 26 15:15:02 prony kernel: usb-storage: *** thread awakened. May 26 15:15:02 prony kernel: usb-storage: -- exit command received May 26 15:15:02 prony kernel: usb-storage: -- usb_stor_release_resources finished May 26 15:15:02 prony kernel: usb 1-2:1.0: hotplug May 26 15:15:02 prony kernel: usb 1-2: unregistering device May 26 15:15:02 prony kernel: usb 1-2: hotplug May 26 15:15:06 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 1 status 003802 POWER OWNER sig=j CSC May 26 15:15:06 prony kernel: hub 1-0:1.0: port 1, status 0, change 1, 12 Mb/s May 26 15:15:06 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 4 status 001803 POWER sig=j CSC CONNECT May 26 15:15:06 prony kernel: hub 1-0:1.0: port 4, status 501, change 1, 480 Mb/s May 26 15:15:06 prony kernel: hub 1-0:1.0: debounce: port 4: delay 100ms stable 4 status 0x501 May 26 15:15:06 prony kernel: ehci_hcd 0000:00:10.4: port 4 high speed May 26 15:15:06 prony kernel: ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT May 26 15:15:06 prony kernel: usb 1-4: new high speed USB device using address 4 May 26 15:15:06 prony kernel: usb 1-4: new device strings: Mfr=0, Product=1, SerialNumber=2 May 26 15:15:06 prony kernel: usb 1-4: default language 0x0409 May 26 15:15:06 prony kernel: usb 1-4: Product: IOMEGA CDDVD522416EC3-C May 26 15:15:06 prony kernel: usb 1-4: SerialNumber: <something> May 26 15:15:06 prony kernel: usb 1-4: hotplug May 26 15:15:06 prony kernel: usb 1-4: adding 1-4:1.0 (config #1, interface 0) May 26 15:15:06 prony kernel: usb 1-4:1.0: hotplug May 26 15:15:06 prony kernel: usb-storage 1-4:1.0: usb_probe_interface May 26 15:15:06 prony kernel: usb-storage 1-4:1.0: usb_probe_interface - got id May 26 15:15:06 prony kernel: usb-storage: USB Mass Storage device detected May 26 15:15:06 prony kernel: usb-storage: altsetting is 0, id_index is 91 May 26 15:15:06 prony kernel: usb-storage: -- associate_dev May 26 15:15:06 prony kernel: usb-storage: Transport: Bulk May 26 15:15:06 prony kernel: usb-storage: Protocol: Transparent SCSI May 26 15:15:06 prony kernel: usb-storage: Endpoints: In: 0x000001003f9b41c0 Out: 0x000001003f9b41e0 Int: 0x0000000000000000 (Period 0) May 26 15:15:06 prony kernel: usb-storage: usb_stor_control_msg: rq=fe rqtype=a1 value=0000 index=00 len=1 May 26 15:15:06 prony kernel: usb-storage: GetMaxLUN command result is 1, data is 0 May 26 15:15:06 prony kernel: usb-storage: *** thread sleeping. May 26 15:15:06 prony kernel: scsi10 : SCSI emulation for USB Mass Storage devices May 26 15:15:06 prony kernel: usb-storage: queuecommand called May 26 15:15:06 prony kernel: usb-storage: *** thread awakened. May 26 15:15:06 prony kernel: usb-storage: Command INQUIRY (6 bytes) May 26 15:15:06 prony kernel: usb-storage: 12 00 00 00 24 00 May 26 15:15:06 prony kernel: usb-storage: Bulk Command S 0x43425355 T 0x2d6e L 36 F 128 Trg 0 LUN 0 CL 6 May 26 15:15:06 prony kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes May 26 15:15:06 prony kernel: usb-storage: Status code 0; transferred 31/31 May 26 15:15:06 prony kernel: usb-storage: -- transfer complete May 26 15:15:06 prony kernel: usb-storage: Bulk command transfer result=0 May 26 15:15:06 prony kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 36 bytes May 26 15:15:06 prony kernel: usb-storage: Status code 0; transferred 36/36 May 26 15:15:06 prony kernel: usb-storage: -- transfer complete May 26 15:15:06 prony kernel: usb-storage: Bulk data transfer result 0x0 May 26 15:15:06 prony kernel: usb-storage: Attempting to get CSW... May 26 15:15:06 prony kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes May 26 15:15:06 prony kernel: usb-storage: Status code 0; transferred 13/13 May 26 15:15:06 prony kernel: usb-storage: -- transfer complete May 26 15:15:06 prony kernel: usb-storage: Bulk status result = 0 May 26 15:15:06 prony kernel: usb-storage: Bulk Status S 0x53425355 T 0x2d6e R 0 Stat 0x0 May 26 15:15:06 prony kernel: usb-storage: Fixing INQUIRY data to show SCSI rev 2 - was 0 May 26 15:15:06 prony kernel: usb-storage: scsi cmd done, result=0x0 May 26 15:15:06 prony kernel: usb-storage: *** thread sleeping. May 26 15:15:06 prony kernel: Vendor: IOMEGA Model: CDDVD522416EC3-C Rev: 0P5B May 26 15:15:06 prony kernel: Type: CD-ROM ANSI SCSI revision: 02
At first it seems to work, but if I try to access all the data (again with find | xargs wc), it bails out after a while, always at the same position, I get:
May 26 15:17:16 prony kernel: usb-storage: *** thread awakened. May 26 15:17:16 prony kernel: usb-storage: Command READ_10 (10 bytes) May 26 15:17:16 prony kernel: usb-storage: 28 00 00 00 a6 ef 00 00 3c 00 May 26 15:17:16 prony kernel: usb-storage: Bulk Command S 0x43425355 T 0x3343 L 122880 F 128 Trg 0 LUN 0 CL 10 May 26 15:17:16 prony kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes May 26 15:17:16 prony kernel: usb-storage: Status code 0; transferred 31/31 May 26 15:17:16 prony kernel: usb-storage: -- transfer complete May 26 15:17:16 prony kernel: usb-storage: Bulk command transfer result=0 May 26 15:17:16 prony kernel: usb-storage: usb_stor_bulk_transfer_sglist: xfer 122880 bytes, 30 entries May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: devpath 4 ep1in 3strikes May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel qh 000001003fac21e0 n3fac2002 info 42002104 40000000 qtd 3faab7e0 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: overlay td 000001003fac21f0 n3faab840 3faab008 t02000148 p0=1fd78e00 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab840 n3faab8a0 3faab000 t10000d80 p0=1fdef000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab8a0 n3faab900 3faab000 t10000d80 p0=1fdee000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab900 n3faab960 3faab000 t10000d80 p0=1fded000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab960 n3faab9c0 3faab000 t10000d80 p0=1fdec000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab9c0 n3faaba20 3faab000 t10000d80 p0=1fdeb000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faaba20 n3faaba80 3faab000 t10000d80 p0=1fdea000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faaba80 n3faabae0 3faab000 t10000d80 p0=1fde9000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faabae0 n3faabb40 3faab000 t10000d80 p0=1fde8000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faabb40 n3faabba0 3faab000 t10000d80 p0=1fe7f000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faabba0 n3faabc00 3faab000 t10000d80 p0=1fe7e000 May 26 15:17:16 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faabc00 n3faabc60 3faab000 t10008d80 p0=1fe7d000 May 26 15:17:16 prony kernel: usb-storage: Status code -71; transferred 77312/122880 May 26 15:17:16 prony kernel: usb-storage: -- unknown error May 26 15:17:16 prony kernel: usb-storage: Bulk data transfer result 0x4 May 26 15:17:16 prony kernel: usb-storage: -- transport indicates error, resetting May 26 15:17:16 prony kernel: usb-storage: usb_stor_Bulk_reset called May 26 15:17:16 prony kernel: usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0 May 26 15:17:22 prony kernel: usb-storage: Soft reset: clearing bulk-in endpoint halt May 26 15:17:22 prony kernel: usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=81 len=0 May 26 15:17:22 prony kernel: usb-storage: usb_stor_clear_halt: result = 0 May 26 15:17:22 prony kernel: usb-storage: Soft reset: clearing bulk-out endpoint halt May 26 15:17:22 prony kernel: usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=02 len=0 May 26 15:17:22 prony kernel: usb-storage: usb_stor_clear_halt: result = 0 May 26 15:17:22 prony kernel: usb-storage: Soft reset done May 26 15:17:22 prony kernel: usb-storage: scsi cmd done, result=0x70000 May 26 15:17:22 prony kernel: usb-storage: *** thread sleeping. May 26 15:17:22 prony kernel: usb-storage: queuecommand called May 26 15:17:22 prony kernel: usb-storage: *** thread awakened. May 26 15:17:22 prony kernel: usb-storage: Command READ_10 (10 bytes) May 26 15:17:22 prony kernel: usb-storage: 28 00 00 00 a6 ef 00 00 3c 00 May 26 15:17:22 prony kernel: usb-storage: Bulk Command S 0x43425355 T 0x3344 L 122880 F 128 Trg 0 LUN 0 CL 10 May 26 15:17:22 prony kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes May 26 15:17:22 prony kernel: usb-storage: Status code 0; transferred 31/31 May 26 15:17:22 prony kernel: usb-storage: -- transfer complete May 26 15:17:22 prony kernel: usb-storage: Bulk command transfer result=0 May 26 15:17:22 prony kernel: usb-storage: usb_stor_bulk_transfer_sglist: xfer 122880 bytes, 30 entries May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel qh 000001003fac21e0 n3fac2142 info 42002104 40000000 qtd 3faabc60 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: overlay td 000001003fac21f0 n3faab120 3faab008 t10000d40 p0=1fc9a000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab120 n3faab180 3faab000 t10000d80 p0=1fc99000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab180 n3faab1e0 3faab000 t10000d80 p0=1fc98000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab1e0 n3faab240 3faab000 t10000d80 p0=1fcef000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab240 n3faab2a0 3faab000 t10000d80 p0=1fcee000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab2a0 n3faab300 3faab000 t10000d80 p0=1fced000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab300 n3faab360 3faab000 t10000d80 p0=1fcec000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab360 n3faab3c0 3faab000 t10000d80 p0=1fceb000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab3c0 n3faab420 3faab000 t10000d80 p0=1fcea000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab420 n3faab480 3faab000 t10000d80 p0=1fce9000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab480 n3faab4e0 3faab000 t10000d80 p0=1fce8000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab4e0 n3faab540 3faab000 t10000d80 p0=1fd7f000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab540 n3faab5a0 3faab000 t10000d80 p0=1fd7e000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab5a0 n3faab600 3faab000 t10000d80 p0=1fd7d000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab600 n3faab660 3faab000 t10000d80 p0=1fd7c000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab660 n3faab6c0 3faab000 t10000d80 p0=1fd7b000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab6c0 n3faab720 3faab000 t10000d80 p0=1fd7a000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab720 n3faab780 3faab000 t10000d80 p0=1fd79000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab780 n3faab7e0 3faab000 t10000d80 p0=1fd78000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab7e0 n3faab840 3faab000 t10000d80 p0=1fdef000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab840 n3faab8a0 3faab000 t10000d80 p0=1fdee000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab8a0 n3faab900 3faab000 t10000d80 p0=1fded000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab900 n3faab960 3faab000 t10000d80 p0=1fdec000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab960 n3faab9c0 3faab000 t10000d80 p0=1fdeb000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faab9c0 n3faaba20 3faab000 t10000d80 p0=1fdea000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faaba20 n3faaba80 3faab000 t10000d80 p0=1fde9000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faaba80 n3faabae0 3faab000 t10000d80 p0=1fde8000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faabae0 n3faabb40 3faab000 t10000d80 p0=1fe7f000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faabb40 n3faabba0 3faab000 t10000d80 p0=1fe7e000 May 26 15:17:22 prony kernel: ehci_hcd 0000:00:10.4: cancel td 000001003faabba0 n3faabc00 3faab000 t10008d80 p0=1fe7d000 May 26 15:17:22 prony kernel: usb-storage: Status code -32; transferred 0/122880 May 26 15:17:22 prony kernel: usb-storage: clearing endpoint halt for pipe 0xc0008480 May 26 15:17:22 prony kernel: usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=81 len=0 May 26 15:17:22 prony kernel: usb-storage: usb_stor_clear_halt: result = 0 May 26 15:17:22 prony kernel: usb-storage: Bulk data transfer result 0x2 May 26 15:17:22 prony kernel: usb-storage: Attempting to get CSW... May 26 15:17:22 prony kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes May 26 15:17:22 prony kernel: usb-storage: Status code -75; transferred 0/13 May 26 15:17:22 prony kernel: usb-storage: -- babble May 26 15:17:22 prony kernel: usb-storage: Bulk status result = 3 May 26 15:17:22 prony kernel: usb-storage: -- transport indicates error, resetting May 26 15:17:22 prony kernel: usb-storage: usb_stor_Bulk_reset called May 26 15:17:22 prony kernel: usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0 May 26 15:17:28 prony kernel: usb-storage: Soft reset: clearing bulk-in endpoint halt May 26 15:17:28 prony kernel: usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=81 len=0 May 26 15:17:28 prony kernel: usb-storage: usb_stor_clear_halt: result = 0 May 26 15:17:28 prony kernel: usb-storage: Soft reset: clearing bulk-out endpoint halt May 26 15:17:28 prony kernel: usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=02 len=0 May 26 15:17:28 prony kernel: usb-storage: usb_stor_clear_halt: result = 0 May 26 15:17:28 prony kernel: usb-storage: Soft reset done May 26 15:17:28 prony kernel: usb-storage: scsi cmd done, result=0x70000 May 26 15:17:28 prony kernel: usb-storage: *** thread sleeping.
Huh?
Yours, Florian.
-------------------------------------------------------
This SF.Net email is sponsored by: Oracle 10g
Get certified on the hottest thing ever to hit the market... Oracle 10g. Take an Oracle 10g class now, and we'll give you the exam FREE.
http://ads.osdn.com/?ad_id=3149&alloc_id=8166&op=click
_______________________________________________
[EMAIL PROTECTED]
To unsubscribe, use the last form field at:
https://lists.sourceforge.net/lists/listinfo/linux-usb-devel
