Alan Stern wrote: > The trace shows that your USB hardware is very flaky when running at > high speed. There's no way to know just from this whether the problem > lies in the EHCI controller, the cabling, or the JMicron bridge -- it > might even be a bad combination of ingredients. The device was > electrically disconnected and reconnected multiple times, until the > system finally gave up and connected to the drive at full speed. You > don't want that, it means you can use the drive only at 1/40th of its > rated speed. > > Have you tried plugging the cable into different USB ports? I tried one front-panel port then, when that didn't work, a back-panel port. I've now tried all six ports: 1. All four back-panel ports produce error messages in the syslog similar to those in my original post (i.e. "Medium Error"). 2. One of the front-panel ports (presumably the one I tried originally) doesn't even get that far, disconnecting and reconnecting repeatedly (sample log messages attached). 3. The other front-panel port works flawlessly. Nothing that looks like an error message in syslog, drive mounts quickly, can be read and written at ~25 Mbytes/sec, no sign of data corruption (files written to the drive from the Linux box were verified from the Windows box). Oh well; that's the immediate issue dealt with. Sorry about the noise and thanks for the help. I'm assuming that the problems with the other ports are down to analogue issues, and won't be affected by anything on the software side. -- Glynn Clements <glynn@xxxxxxxxxxxxxxxxxx>
Feb 13 00:17:07 cerise klogd: [199119.087255] hub 1-0:1.0: state 7 ports 8 chg 0000 evt ff80 Feb 13 00:17:07 cerise klogd: [199119.087280] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001803 0 ACK POWER sig=j CSC CONNECT Feb 13 00:17:07 cerise klogd: [199119.087298] hub 1-0:1.0: port 7, status 0501, change 0001, 480 Mb/s Feb 13 00:17:08 cerise klogd: [199119.206806] hub 1-0:1.0: debounce: port 7: total 100ms stable 100ms status 0x501 Feb 13 00:17:08 cerise klogd: [199119.260421] ehci_hcd 0000:00:10.4: port 7 high speed Feb 13 00:17:08 cerise klogd: [199119.260431] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001005 0 ACK POWER sig=se0 PE CONNECT Feb 13 00:17:08 cerise klogd: [199119.313493] usb 1-7: new high-speed USB device number 26 using ehci_hcd Feb 13 00:17:08 cerise klogd: [199119.370438] ehci_hcd 0000:00:10.4: port 7 high speed Feb 13 00:17:08 cerise klogd: [199119.370447] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001005 0 ACK POWER sig=se0 PE CONNECT Feb 13 00:17:08 cerise klogd: [199119.443965] usb 1-7: default language 0x0409 Feb 13 00:17:08 cerise klogd: [199119.444456] usb 1-7: udev 26, busnum 1, minor = 25 Feb 13 00:17:08 cerise klogd: [199119.444464] usb 1-7: New USB device found, idVendor=152d, idProduct=2329 Feb 13 00:17:08 cerise klogd: [199119.444473] usb 1-7: New USB device strings: Mfr=1, Product=2, SerialNumber=5 Feb 13 00:17:08 cerise klogd: [199119.444481] usb 1-7: Product: USB to ATA/ATAPI bridge Feb 13 00:17:08 cerise klogd: [199119.444487] usb 1-7: Manufacturer: JMicron Feb 13 00:17:08 cerise klogd: [199119.444493] usb 1-7: SerialNumber: 7D577A0A5680 Feb 13 00:17:08 cerise klogd: [199119.444670] usb 1-7: usb_probe_device Feb 13 00:17:08 cerise klogd: [199119.444679] usb 1-7: configuration #1 chosen from 1 choice Feb 13 00:17:08 cerise klogd: [199119.445334] usb 1-7: adding 1-7:1.0 (config #1, interface 0) Feb 13 00:17:08 cerise klogd: [199119.445509] usb-storage 1-7:1.0: usb_probe_interface Feb 13 00:17:08 cerise klogd: [199119.445524] usb-storage 1-7:1.0: usb_probe_interface - got id Feb 13 00:17:08 cerise klogd: [199119.445628] usb-storage 1-7:1.0: Quirks match for vid 152d pid 2329: 8020 Feb 13 00:17:08 cerise klogd: [199119.445682] scsi25 : usb-storage 1-7:1.0 Feb 13 00:17:08 cerise klogd: [199119.445826] drivers/usb/core/inode.c: creating file '026' Feb 13 00:17:08 cerise klogd: [199119.714654] hub 1-0:1.0: state 7 ports 8 chg 0000 evt ff80 Feb 13 00:17:08 cerise klogd: [199119.714679] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001002 0 ACK POWER sig=se0 CSC Feb 13 00:17:08 cerise klogd: [199119.714697] hub 1-0:1.0: port 7, status 0100, change 0001, 12 Mb/s Feb 13 00:17:08 cerise klogd: [199119.714707] usb 1-7: USB disconnect, device number 26 Feb 13 00:17:08 cerise klogd: [199119.714713] usb 1-7: unregistering device Feb 13 00:17:08 cerise klogd: [199119.714719] usb 1-7: unregistering interface 1-7:1.0 Feb 13 00:17:08 cerise klogd: [199119.714967] usb 1-7: usb_disable_device nuking all URBs Feb 13 00:17:08 cerise klogd: [199119.743489] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001803 0 ACK POWER sig=j CSC CONNECT Feb 13 00:17:08 cerise klogd: [199119.863472] hub 1-0:1.0: debounce: port 7: total 125ms stable 100ms status 0x501 Feb 13 00:17:08 cerise klogd: [199119.917146] ehci_hcd 0000:00:10.4: port 7 high speed Feb 13 00:17:08 cerise klogd: [199119.917157] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001005 0 ACK POWER sig=se0 PE CONNECT Feb 13 00:17:08 cerise klogd: [199119.970163] usb 1-7: new high-speed USB device number 27 using ehci_hcd Feb 13 00:17:08 cerise klogd: [199120.027040] ehci_hcd 0000:00:10.4: port 7 high speed Feb 13 00:17:08 cerise klogd: [199120.027049] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001005 0 ACK POWER sig=se0 PE CONNECT Feb 13 00:17:08 cerise klogd: [199120.100692] usb 1-7: default language 0x0409 Feb 13 00:17:08 cerise klogd: [199120.101180] usb 1-7: udev 27, busnum 1, minor = 26 Feb 13 00:17:08 cerise klogd: [199120.101188] usb 1-7: New USB device found, idVendor=152d, idProduct=2329 Feb 13 00:17:08 cerise klogd: [199120.101197] usb 1-7: New USB device strings: Mfr=1, Product=2, SerialNumber=5 Feb 13 00:17:08 cerise klogd: [199120.101204] usb 1-7: Product: USB to ATA/ATAPI bridge Feb 13 00:17:08 cerise klogd: [199120.101210] usb 1-7: Manufacturer: JMicron Feb 13 00:17:08 cerise klogd: [199120.101216] usb 1-7: SerialNumber: 7D577A0A5680 Feb 13 00:17:08 cerise klogd: [199120.101357] usb 1-7: usb_probe_device Feb 13 00:17:08 cerise klogd: [199120.101366] usb 1-7: configuration #1 chosen from 1 choice Feb 13 00:17:08 cerise klogd: [199120.101554] usb 1-7: adding 1-7:1.0 (config #1, interface 0) Feb 13 00:17:08 cerise klogd: [199120.101713] usb-storage 1-7:1.0: usb_probe_interface Feb 13 00:17:08 cerise klogd: [199120.101721] usb-storage 1-7:1.0: usb_probe_interface - got id Feb 13 00:17:08 cerise klogd: [199120.101910] usb-storage 1-7:1.0: Quirks match for vid 152d pid 2329: 8020 Feb 13 00:17:08 cerise klogd: [199120.101944] scsi26 : usb-storage 1-7:1.0 Feb 13 00:17:08 cerise klogd: [199120.102082] drivers/usb/core/inode.c: creating file '027' Feb 13 00:17:08 cerise klogd: [199120.102118] hub 1-0:1.0: state 7 ports 8 chg 0000 evt fe80 Feb 13 00:17:09 cerise klogd: [199120.313628] hub 1-0:1.0: state 7 ports 8 chg 0000 evt ff80 Feb 13 00:17:09 cerise klogd: [199120.313655] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001002 0 ACK POWER sig=se0 CSC Feb 13 00:17:09 cerise klogd: [199120.313673] hub 1-0:1.0: port 7, status 0100, change 0001, 12 Mb/s Feb 13 00:17:09 cerise klogd: [199120.313682] usb 1-7: USB disconnect, device number 27 Feb 13 00:17:09 cerise klogd: [199120.313689] usb 1-7: unregistering device Feb 13 00:17:09 cerise klogd: [199120.313696] usb 1-7: unregistering interface 1-7:1.0 Feb 13 00:17:09 cerise klogd: [199120.313989] usb 1-7: usb_disable_device nuking all URBs Feb 13 00:17:09 cerise klogd: [199120.343490] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001803 0 ACK POWER sig=j CSC CONNECT Feb 13 00:17:09 cerise klogd: [199120.463474] hub 1-0:1.0: debounce: port 7: total 125ms stable 100ms status 0x501 Feb 13 00:17:09 cerise klogd: [199120.517114] ehci_hcd 0000:00:10.4: port 7 high speed Feb 13 00:17:09 cerise klogd: [199120.517126] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001005 0 ACK POWER sig=se0 PE CONNECT Feb 13 00:17:09 cerise klogd: [199120.570167] usb 1-7: new high-speed USB device number 28 using ehci_hcd Feb 13 00:17:09 cerise klogd: [199120.627132] ehci_hcd 0000:00:10.4: port 7 high speed Feb 13 00:17:09 cerise klogd: [199120.627145] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001005 0 ACK POWER sig=se0 PE CONNECT Feb 13 00:17:09 cerise klogd: [199120.700658] usb 1-7: default language 0x0409 Feb 13 00:17:09 cerise klogd: [199120.701022] usb 1-7: udev 28, busnum 1, minor = 27 Feb 13 00:17:09 cerise klogd: [199120.701030] usb 1-7: New USB device found, idVendor=152d, idProduct=2329 Feb 13 00:17:09 cerise klogd: [199120.701038] usb 1-7: New USB device strings: Mfr=1, Product=2, SerialNumber=5 Feb 13 00:17:09 cerise klogd: [199120.701046] usb 1-7: Product: USB to ATA/ATAPI bridge Feb 13 00:17:09 cerise klogd: [199120.701053] usb 1-7: Manufacturer: JMicron Feb 13 00:17:09 cerise klogd: [199120.701059] usb 1-7: SerialNumber: 7D577A0A5680 Feb 13 00:17:09 cerise klogd: [199120.701236] usb 1-7: usb_probe_device Feb 13 00:17:09 cerise klogd: [199120.701248] usb 1-7: configuration #1 chosen from 1 choice Feb 13 00:17:09 cerise klogd: [199120.701520] usb 1-7: adding 1-7:1.0 (config #1, interface 0) Feb 13 00:17:09 cerise klogd: [199120.701678] usb-storage 1-7:1.0: usb_probe_interface Feb 13 00:17:09 cerise klogd: [199120.701687] usb-storage 1-7:1.0: usb_probe_interface - got id Feb 13 00:17:09 cerise klogd: [199120.701816] usb-storage 1-7:1.0: Quirks match for vid 152d pid 2329: 8020 Feb 13 00:17:09 cerise klogd: [199120.701852] scsi27 : usb-storage 1-7:1.0 Feb 13 00:17:09 cerise klogd: [199120.701994] drivers/usb/core/inode.c: creating file '028' Feb 13 00:17:09 cerise klogd: [199120.702031] hub 1-0:1.0: state 7 ports 8 chg 0000 evt fe80 Feb 13 00:17:09 cerise klogd: [199120.801835] hub 1-0:1.0: state 7 ports 8 chg 0000 evt ff80 Feb 13 00:17:09 cerise klogd: [199120.801862] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001002 0 ACK POWER sig=se0 CSC Feb 13 00:17:09 cerise klogd: [199120.801881] hub 1-0:1.0: port 7, status 0100, change 0001, 12 Mb/s Feb 13 00:17:09 cerise klogd: [199120.801891] usb 1-7: USB disconnect, device number 28 Feb 13 00:17:09 cerise klogd: [199120.801897] usb 1-7: unregistering device Feb 13 00:17:09 cerise klogd: [199120.801905] usb 1-7: unregistering interface 1-7:1.0 Feb 13 00:17:09 cerise klogd: [199120.802214] usb 1-7: usb_disable_device nuking all URBs Feb 13 00:17:09 cerise klogd: [199120.830160] ehci_hcd 0000:00:10.4: GetStatus port:7 status 001803 0 ACK POWER sig=j CSC CONNECT
