Post by Alan SternPost by sean darcyPost by Alan SternPost by seandarcyuname -r
2.6.23.8-63.fc8
I connected my new Western Digital My Book 500G external drive to the
usb port.
Jan 5 21:53:35 testbox kernel: usb 1-4: new high speed USB device using
ehci_hcd and address 2
Jan 5 21:53:50 testbox kernel: usb 1-4: device descriptor read/64,
error -110
Jan 5 21:54:05 testbox kernel: usb 1-4: device descriptor read/64,
error -110
Jan 5 21:54:05 testbox kernel: usb 1-4: new high speed USB device using
ehci_hcd and address 3
Jan 5 21:54:20 testbox kernel: usb 1-4: device descriptor read/64,
error -110
Jan 5 21:54:36 testbox kernel: usb 1-4: device descriptor read/64,
error -110
Jan 5 21:54:36 testbox kernel: usb 1-4: new high speed USB device using
ehci_hcd and address 4
Jan 5 21:54:41 testbox kernel: usb 1-4: device descriptor read/8, error
-110
.................
Any help apprecoated.
It certainly looks like either the disk drive's USB interface or your
computer's USB controller isn't working.
You can try attaching the drive to a different computer or attaching
different high-speed USB devices to your computer. That should
indicate which component is at fault.
Alan Stern
It's a dual boot desktop. XP sees the usb hard drive, and I can run the
WD extended diagnostics on the drive.
googling did show some other reports, e.g.
http://forum.freespire.org/archive/index.php/t-6479.html, but no solutions.
Any linux diagnostics that would be useful?
Like Matt said, it would help to see the complete system log starting
from the time you plugged in the drive. You could also get a usbmon
trace (see the instructions in the kernel source file
Documentation/usb/usbmon.txt).
Alan Stern
rmmod'd and modprobe'd ehci_hcd, the pluged in the usb cable.
/var/log/messages:
Jan 8 18:19:44 testbox kernel: ehci_hcd 0000:00:1d.7: EHCI Host Controller
Jan 8 18:19:44 testbox kernel: ehci_hcd 0000:00:1d.7: new USB bus
registered, assigned bus number 1
Jan 8 18:19:44 testbox kernel: ehci_hcd 0000:00:1d.7: debug port 1
Jan 8 18:19:44 testbox kernel: ehci_hcd 0000:00:1d.7: irq 23, io mem
0x901c4400
Jan 8 18:19:44 testbox kernel: ehci_hcd 0000:00:1d.7: USB 2.0 started,
EHCI 1.00, driver 10 Dec 2004
Jan 8 18:19:44 testbox kernel: usb usb1: configuration #1 chosen from 1
choice
Jan 8 18:19:44 testbox kernel: hub 1-0:1.0: USB hub found
Jan 8 18:19:44 testbox kernel: hub 1-0:1.0: 8 ports detected
Jan 8 18:20:09 testbox kernel: usb 1-2: new high speed USB device using
ehci_hcd and address 2
Jan 8 18:20:24 testbox kernel: usb 1-2: device descriptor read/64,
error -110
Jan 8 18:20:39 testbox kernel: usb 1-2: device descriptor read/64,
error -110
Jan 8 18:20:39 testbox kernel: usb 1-2: new high speed USB device using
ehci_hcd and address 3
Jan 8 18:20:54 testbox kernel: usb 1-2: device descriptor read/64,
error -110
Jan 8 18:21:10 testbox kernel: usb 1-2: device descriptor read/64,
error -110
Jan 8 18:21:10 testbox kernel: usb 1-2: new high speed USB device using
ehci_hcd and address 4
Jan 8 18:21:15 testbox kernel: usb 1-2: device descriptor read/8, error
-110
Jan 8 18:21:20 testbox kernel: usb 1-2: device descriptor read/8, error
-110
Jan 8 18:21:20 testbox kernel: usb 1-2: new high speed USB device using
ehci_hcd and address 5
Jan 8 18:21:25 testbox kernel: usb 1-2: device descriptor read/8, error
-110
.........
Unplugged the cable, rmmod'd ehci_hcd and plugged the cable back in:
Jan 8 18:21:30 testbox kernel: usb 1-2: device descriptor read/8, error
-110
Jan 8 18:28:39 testbox kernel: ehci_hcd 0000:00:1d.7: remove, state 4
Jan 8 18:28:39 testbox kernel: usb usb1: USB disconnect, address 1
Jan 8 18:28:39 testbox kernel: ehci_hcd 0000:00:1d.7: USB bus 1
deregistered
Jan 8 18:28:39 testbox kernel: ACPI: PCI interrupt for device
0000:00:1d.7 disabled
Jan 8 18:29:01 testbox kernel: usb 2-2: new full speed USB device using
uhci_hcd and address 6
Jan 8 18:29:16 testbox kernel: usb 2-2: device descriptor read/64,
error -110
Jan 8 18:29:31 testbox kernel: usb 2-2: device descriptor read/64,
error -110
Jan 8 18:29:31 testbox kernel: usb 2-2: new full speed USB device using
uhci_hcd and address 7
Jan 8 18:29:46 testbox kernel: usb 2-2: device descriptor read/64,
error -110
Jan 8 18:30:02 testbox kernel: usb 2-2: device descriptor read/64,
error -110
Jan 8 18:30:02 testbox kernel: usb 2-2: new full speed USB device using
uhci_hcd and address 8
Jan 8 18:30:07 testbox kernel: usb 2-2: device descriptor read/8, error
-110
Jan 8 18:30:12 testbox kernel: usb 2-2: device descriptor read/8, error
-110
Jan 8 18:30:12 testbox kernel: usb 2-2: new full speed USB device using
uhci_hcd and address 9
Jan 8 18:30:17 testbox kernel: usb 2-2: device descriptor read/8, error
-110
Jan 8 18:30:22 testbox kernel: usb 2-2: device descriptor read/8, error
-110
Jan 8 18:31:47 testbox kernel: usb 2-2: new full speed USB device using
uhci_hcd and address 10
.................
Setting up usbmon was not a success:
[***@testbox 2.6.23.9-85.fc8-x86_64]# mount -t debugfs none_debugs
/sys/kernel/debug
[***@testbox 2.6.23.9-85.fc8-x86_64]# modprobe usbmon
FATAL: Module usbmon not found.
Maybe usbmon is compiled in for Fedora??
But I kept going:
ls /sys/kernel/debug/usbmon
0s 0u 2s 2t 2u 3s 3t 3u 4s 4t 4u 5s 5t 5u
cat /proc/bus/usb/devices
showed only the 4 host controllers.
But unplugged the cable, entered
cat /sys/kernel/debug/usbmon/2u > /tmp/1.mon.out
and plugged in the cable. head /tmp/1.mon.out:
head -20 /tmp/1.mon.out
ffff810037f38d80 3045534577 S Ii:2:001:1 -115:128 2 <
ffff81000fe64cc0 3045534596 S Ci:2:001:0 s a3 00 0000 0001 0004 4 <
ffff81000fe64cc0 3045534603 C Ci:2:001:0 0 4 = 00010000
ffff81000fe64cc0 3045534606 S Ci:2:001:0 s a3 00 0000 0002 0004 4 <
ffff81000fe64cc0 3045534612 C Ci:2:001:0 0 4 = 01010100
ffff81000fe64cc0 3045534614 S Co:2:001:0 s 23 01 0010 0002 0000 0
ffff81000fe64cc0 3045534618 C Co:2:001:0 0 0
ffff81000fe64cc0 3045534620 S Ci:2:001:0 s a3 00 0000 0002 0004 4 <
ffff81000fe64cc0 3045534626 C Ci:2:001:0 0 4 = 01010000
ffff81000fe64cc0 3045560573 S Ci:2:001:0 s a3 00 0000 0002 0004 4 <
ffff81000fe64cc0 3045560581 C Ci:2:001:0 0 4 = 01010000
ffff81000fe64cc0 3045586574 S Ci:2:001:0 s a3 00 0000 0002 0004 4 <
ffff81000fe64cc0 3045586581 C Ci:2:001:0 0 4 = 01010000
ffff81000fe64cc0 3045612576 S Ci:2:001:0 s a3 00 0000 0002 0004 4 <
ffff81000fe64cc0 3045612584 C Ci:2:001:0 0 4 = 01010000
ffff81000fe64cc0 3045638578 S Ci:2:001:0 s a3 00 0000 0002 0004 4 <
ffff81000fe64cc0 3045638587 C Ci:2:001:0 0 4 = 01010000
ffff81000fe64cc0 3045638597 S Co:2:001:0 s 23 03 0004 0002 0000 0
ffff81000fe64cc0 3045638603 C Co:2:001:0 0 0
ffff81000fe64cc0 3045689574 S Ci:2:001:0 s a3 00 0000 0002 0004 4 <
Thanks for all the time and attention.
sean