xhci usb issues

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



Hello,

I am not able to figure out how to connect a 1.11 usb full speed
device to a USB 3.0 port.

This is the output in syslog when I rmmod xhci_hcd and modprobe
xhci-hcd: http://codepad.org/8mc0tABX

These are the messages that seem to be causing the issue:
Sep  1 15:57:03 master kernel: [ 1182.014895] usb 6-1: device not
accepting address 2, error -62
Sep  1 15:57:03 master kernel: [ 1182.014942] xhci_hcd 0000:03:00.0:
Bad Slot ID 1
Sep  1 15:57:03 master kernel: [ 1182.014945] xhci_hcd 0000:03:00.0:
Could not allocate xHCI USB device data structures
Sep  1 15:57:03 master kernel: [ 1182.014950] hub 6-0:1.0: couldn't
allocate port 1 usb_device

When I plug in the USB full speed device, these are the messages:

Sep  1 16:00:17 master kernel: [ 1376.248867] usb usb6: usb wakeup-resume
Sep  1 16:00:17 master kernel: [ 1376.248875] usb usb6: usb auto-resume
Sep  1 16:00:17 master kernel: [ 1376.248894] hub 6-0:1.0: hub_resume
Sep  1 16:00:17 master kernel: [ 1376.248905] hub 6-0:1.0: port 1:
status 0101 change 0000
Sep  1 16:00:17 master kernel: [ 1376.248910] hub 6-0:1.0: port 2:
status 0101 change 0001
Sep  1 16:00:17 master kernel: [ 1376.349888] hub 6-0:1.0: state 7
ports 2 chg 0006 evt 0000
Sep  1 16:00:17 master kernel: [ 1376.349898] hub 6-0:1.0: port 1,
status 0101, change 0000, 12 Mb/s
Sep  1 16:00:17 master kernel: [ 1376.451953] usb 6-1: new full-speed
USB device number 3 using xhci_hcd
Sep  1 16:00:22 master kernel: [ 1381.455764] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:27 master kernel: [ 1386.660767] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:27 master kernel: [ 1386.861922] usb 6-1: device not
accepting address 3, error -62
Sep  1 16:00:27 master kernel: [ 1386.861977] xhci_hcd 0000:03:00.0:
Bad Slot ID 2
Sep  1 16:00:27 master kernel: [ 1386.861980] xhci_hcd 0000:03:00.0:
Could not allocate xHCI USB device data structures
Sep  1 16:00:27 master kernel: [ 1386.861985] hub 6-0:1.0: couldn't
allocate port 1 usb_device
Sep  1 16:00:27 master kernel: [ 1386.862006] hub 6-0:1.0: port 2,
status 0101, change 0000, 12 Mb/s
Sep  1 16:00:27 master kernel: [ 1386.964011] usb 6-2: new full-speed
USB device number 4 using xhci_hcd
Sep  1 16:00:32 master kernel: [ 1391.967825] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:38 master kernel: [ 1397.172814] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:38 master kernel: [ 1397.373975] usb 6-2: device not
accepting address 4, error -62
Sep  1 16:00:38 master kernel: [ 1397.374027] xhci_hcd 0000:03:00.0:
Bad Slot ID 3
Sep  1 16:00:38 master kernel: [ 1397.374030] xhci_hcd 0000:03:00.0:
Could not allocate xHCI USB device data structures
Sep  1 16:00:38 master kernel: [ 1397.374035] hub 6-0:1.0: couldn't
allocate port 2 usb_device
Sep  1 16:00:38 master kernel: [ 1397.374052] hub 6-0:1.0: hub_suspend
Sep  1 16:00:38 master kernel: [ 1397.374077] usb usb6: bus
auto-suspend, wakeup 1

With the USB 2.0 hub, I could use usbmon to check out why the device
does not work. Using usbmon on a USB 3.0 hub does not seem to show any
valuable output. I tried both usbmon client and 'cat 6u' (where 6 is
the bus id) to check usbmon output.

I am the developer for this usb device and the device works fine on a
1.11 and a 2.0 hub. With the kernel xhci debugging option, there is a
lot of output, I am wondering if there is a usbmon-like debugging
mechanism for xhci.

Any thoughts, please?

Thanks
Joe

Complete syslog message on modprobe xhci-hcd and pluggin in the usb
1.11 full speed device:

Sep  1 15:56:33 master kernel: [ 1152.169082] xhci_hcd 0000:03:00.0:
remove, state 4
Sep  1 15:56:33 master kernel: [ 1152.169087] xhci_hcd 0000:03:00.0:
roothub graceful disconnect
Sep  1 15:56:33 master kernel: [ 1152.169091] usb usb7: USB
disconnect, device number 1
Sep  1 15:56:33 master kernel: [ 1152.169092] usb usb7: unregistering device
Sep  1 15:56:33 master kernel: [ 1152.169094] usb usb7: unregistering
interface 7-0:1.0
Sep  1 15:56:33 master kernel: [ 1152.169152] usb usb7:
usb_disable_device nuking all URBs
Sep  1 15:56:33 master kernel: [ 1152.169154] xHCI xhci_drop_endpoint
called for root hub
Sep  1 15:56:33 master kernel: [ 1152.169155] xHCI
xhci_check_bandwidth called for root hub
Sep  1 15:56:33 master kernel: [ 1152.169224] xhci_hcd 0000:03:00.0:
USB bus 7 deregistered
Sep  1 15:56:33 master kernel: [ 1152.169256] xhci_hcd 0000:03:00.0:
remove, state 4
Sep  1 15:56:33 master kernel: [ 1152.169258] xhci_hcd 0000:03:00.0:
roothub graceful disconnect
Sep  1 15:56:33 master kernel: [ 1152.169260] usb usb6: USB
disconnect, device number 1
Sep  1 15:56:33 master kernel: [ 1152.169262] usb usb6: unregistering device
Sep  1 15:56:33 master kernel: [ 1152.169263] usb usb6: unregistering
interface 6-0:1.0
Sep  1 15:56:33 master kernel: [ 1152.169297] usb usb6:
usb_disable_device nuking all URBs
Sep  1 15:56:33 master kernel: [ 1152.169299] xHCI xhci_drop_endpoint
called for root hub
Sep  1 15:56:33 master kernel: [ 1152.169300] xHCI
xhci_check_bandwidth called for root hub
Sep  1 15:56:33 master kernel: [ 1152.169374] xhci_hcd 0000:03:00.0:
USB bus 6 deregistered
Sep  1 15:56:52 master kernel: [ 1171.302259] xhci_hcd 0000:03:00.0:
xHCI Host Controller
Sep  1 15:56:52 master kernel: [ 1171.302426] xhci_hcd 0000:03:00.0:
new USB bus registered, assigned bus number 6
Sep  1 15:56:52 master kernel: [ 1171.302536] xhci_hcd 0000:03:00.0:
supports USB remote wakeup
Sep  1 15:56:52 master kernel: [ 1171.302572] usb usb6: default language 0x0409
Sep  1 15:56:52 master kernel: [ 1171.302577] usb usb6: udev 1, busnum
6, minor = 640
Sep  1 15:56:52 master kernel: [ 1171.302579] usb usb6: New USB device
found, idVendor=1d6b, idProduct=0002
Sep  1 15:56:52 master kernel: [ 1171.302581] usb usb6: New USB device
strings: Mfr=3, Product=2, SerialNumber=1
Sep  1 15:56:52 master kernel: [ 1171.302582] usb usb6: Product: xHCI
Host Controller
Sep  1 15:56:52 master kernel: [ 1171.302584] usb usb6: Manufacturer:
Linux 3.10.10 xhci_hcd
Sep  1 15:56:52 master kernel: [ 1171.302585] usb usb6: SerialNumber:
0000:03:00.0
Sep  1 15:56:52 master kernel: [ 1171.302679] usb usb6: usb_probe_device
Sep  1 15:56:52 master kernel: [ 1171.302682] usb usb6: configuration
#1 chosen from 1 choice
Sep  1 15:56:52 master kernel: [ 1171.302684] xHCI xhci_add_endpoint
called for root hub
Sep  1 15:56:52 master kernel: [ 1171.302685] xHCI
xhci_check_bandwidth called for root hub
Sep  1 15:56:52 master kernel: [ 1171.302690] usb usb6: adding 6-0:1.0
(config #1, interface 0)
Sep  1 15:56:52 master kernel: [ 1171.302725] hub 6-0:1.0: usb_probe_interface
Sep  1 15:56:52 master kernel: [ 1171.302727] hub 6-0:1.0:
usb_probe_interface - got id
Sep  1 15:56:52 master kernel: [ 1171.302729] hub 6-0:1.0: USB hub found
Sep  1 15:56:52 master kernel: [ 1171.302736] hub 6-0:1.0: 2 ports detected
Sep  1 15:56:52 master kernel: [ 1171.302737] hub 6-0:1.0: standalone hub
Sep  1 15:56:52 master kernel: [ 1171.302738] hub 6-0:1.0: individual
port power switching
Sep  1 15:56:52 master kernel: [ 1171.302739] hub 6-0:1.0: individual
port over-current protection
Sep  1 15:56:52 master kernel: [ 1171.302741] hub 6-0:1.0: Single TT
Sep  1 15:56:52 master kernel: [ 1171.302742] hub 6-0:1.0: TT requires
at most 8 FS bit times (666 ns)
Sep  1 15:56:52 master kernel: [ 1171.302744] hub 6-0:1.0: power on to
power good time: 20ms
Sep  1 15:56:52 master kernel: [ 1171.302746] hub 6-0:1.0: local power
source is good
Sep  1 15:56:52 master kernel: [ 1171.302764] hub 6-0:1.0: enabling
power on all ports
Sep  1 15:56:52 master kernel: [ 1171.306685] xhci_hcd 0000:03:00.0:
xHCI Host Controller
Sep  1 15:56:52 master kernel: [ 1171.306726] xhci_hcd 0000:03:00.0:
new USB bus registered, assigned bus number 7
Sep  1 15:56:52 master kernel: [ 1171.306751] xhci_hcd 0000:03:00.0:
supports USB remote wakeup
Sep  1 15:56:52 master kernel: [ 1171.306788] usb usb7: skipped 1
descriptor after endpoint
Sep  1 15:56:52 master kernel: [ 1171.306981] usb usb7: default language 0x0409
Sep  1 15:56:52 master kernel: [ 1171.306986] usb usb7: udev 1, busnum
7, minor = 768
Sep  1 15:56:52 master kernel: [ 1171.306988] usb usb7: New USB device
found, idVendor=1d6b, idProduct=0003
Sep  1 15:56:52 master kernel: [ 1171.306989] usb usb7: New USB device
strings: Mfr=3, Product=2, SerialNumber=1
Sep  1 15:56:52 master kernel: [ 1171.306991] usb usb7: Product: xHCI
Host Controller
Sep  1 15:56:52 master kernel: [ 1171.306992] usb usb7: Manufacturer:
Linux 3.10.10 xhci_hcd
Sep  1 15:56:52 master kernel: [ 1171.306994] usb usb7: SerialNumber:
0000:03:00.0
Sep  1 15:56:52 master kernel: [ 1171.307042] usb usb7: usb_probe_device
Sep  1 15:56:52 master kernel: [ 1171.307044] usb usb7: configuration
#1 chosen from 1 choice
Sep  1 15:56:52 master kernel: [ 1171.307047] xHCI xhci_add_endpoint
called for root hub
Sep  1 15:56:52 master kernel: [ 1171.307048] xHCI
xhci_check_bandwidth called for root hub
Sep  1 15:56:52 master kernel: [ 1171.307052] usb usb7: adding 7-0:1.0
(config #1, interface 0)
Sep  1 15:56:52 master kernel: [ 1171.307582] hub 7-0:1.0: usb_probe_interface
Sep  1 15:56:52 master kernel: [ 1171.307585] hub 7-0:1.0:
usb_probe_interface - got id
Sep  1 15:56:52 master kernel: [ 1171.307587] hub 7-0:1.0: USB hub found
Sep  1 15:56:52 master kernel: [ 1171.307651] hub 7-0:1.0: 2 ports detected
Sep  1 15:56:52 master kernel: [ 1171.307653] hub 7-0:1.0: standalone hub
Sep  1 15:56:52 master kernel: [ 1171.307654] hub 7-0:1.0: individual
port power switching
Sep  1 15:56:52 master kernel: [ 1171.307655] hub 7-0:1.0: individual
port over-current protection
Sep  1 15:56:52 master kernel: [ 1171.307657] hub 7-0:1.0: TT requires
at most 8 FS bit times (666 ns)
Sep  1 15:56:52 master kernel: [ 1171.307658] hub 7-0:1.0: power on to
power good time: 20ms
Sep  1 15:56:52 master kernel: [ 1171.307661] hub 7-0:1.0: local power
source is good
Sep  1 15:56:52 master kernel: [ 1171.307729] hub 7-0:1.0: enabling
power on all ports
Sep  1 15:56:52 master kernel: [ 1171.402762] hub 6-0:1.0: port 1:
status 0101 change 0001
Sep  1 15:56:52 master kernel: [ 1171.407863] hub 7-0:1.0: state 7
ports 2 chg 0000 evt 0000
Sep  1 15:56:52 master kernel: [ 1171.407892] hub 7-0:1.0: hub_suspend
Sep  1 15:56:52 master kernel: [ 1171.407896] usb usb7: bus
auto-suspend, wakeup 1
Sep  1 15:56:52 master kernel: [ 1171.502935] hub 6-0:1.0: state 7
ports 2 chg 0002 evt 0000
Sep  1 15:56:52 master kernel: [ 1171.502947] hub 6-0:1.0: port 1,
status 0101, change 0000, 12 Mb/s
Sep  1 15:56:52 master kernel: [ 1171.604927] usb 6-1: new full-speed
USB device number 2 using xhci_hcd
Sep  1 15:56:57 master kernel: [ 1176.608751] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 15:57:02 master kernel: [ 1181.813744] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 15:57:03 master kernel: [ 1182.014895] usb 6-1: device not
accepting address 2, error -62
Sep  1 15:57:03 master kernel: [ 1182.014942] xhci_hcd 0000:03:00.0:
Bad Slot ID 1
Sep  1 15:57:03 master kernel: [ 1182.014945] xhci_hcd 0000:03:00.0:
Could not allocate xHCI USB device data structures
Sep  1 15:57:03 master kernel: [ 1182.014950] hub 6-0:1.0: couldn't
allocate port 1 usb_device
Sep  1 15:57:03 master kernel: [ 1182.014967] hub 6-0:1.0: hub_suspend
Sep  1 15:57:03 master kernel: [ 1182.014983] usb usb6: bus
auto-suspend, wakeup 1
Sep  1 16:00:17 master kernel: [ 1376.248867] usb usb6: usb wakeup-resume
Sep  1 16:00:17 master kernel: [ 1376.248875] usb usb6: usb auto-resume
Sep  1 16:00:17 master kernel: [ 1376.248894] hub 6-0:1.0: hub_resume
Sep  1 16:00:17 master kernel: [ 1376.248905] hub 6-0:1.0: port 1:
status 0101 change 0000
Sep  1 16:00:17 master kernel: [ 1376.248910] hub 6-0:1.0: port 2:
status 0101 change 0001
Sep  1 16:00:17 master kernel: [ 1376.349888] hub 6-0:1.0: state 7
ports 2 chg 0006 evt 0000
Sep  1 16:00:17 master kernel: [ 1376.349898] hub 6-0:1.0: port 1,
status 0101, change 0000, 12 Mb/s
Sep  1 16:00:17 master kernel: [ 1376.451953] usb 6-1: new full-speed
USB device number 3 using xhci_hcd
Sep  1 16:00:22 master kernel: [ 1381.455764] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:27 master kernel: [ 1386.660767] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:27 master kernel: [ 1386.861922] usb 6-1: device not
accepting address 3, error -62
Sep  1 16:00:27 master kernel: [ 1386.861977] xhci_hcd 0000:03:00.0:
Bad Slot ID 2
Sep  1 16:00:27 master kernel: [ 1386.861980] xhci_hcd 0000:03:00.0:
Could not allocate xHCI USB device data structures
Sep  1 16:00:27 master kernel: [ 1386.861985] hub 6-0:1.0: couldn't
allocate port 1 usb_device
Sep  1 16:00:27 master kernel: [ 1386.862006] hub 6-0:1.0: port 2,
status 0101, change 0000, 12 Mb/s
Sep  1 16:00:27 master kernel: [ 1386.964011] usb 6-2: new full-speed
USB device number 4 using xhci_hcd
Sep  1 16:00:32 master kernel: [ 1391.967825] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:38 master kernel: [ 1397.172814] xhci_hcd 0000:03:00.0:
Timeout while waiting for address device command
Sep  1 16:00:38 master kernel: [ 1397.373975] usb 6-2: device not
accepting address 4, error -62
Sep  1 16:00:38 master kernel: [ 1397.374027] xhci_hcd 0000:03:00.0:
Bad Slot ID 3
Sep  1 16:00:38 master kernel: [ 1397.374030] xhci_hcd 0000:03:00.0:
Could not allocate xHCI USB device data structures
Sep  1 16:00:38 master kernel: [ 1397.374035] hub 6-0:1.0: couldn't
allocate port 2 usb_device
Sep  1 16:00:38 master kernel: [ 1397.374052] hub 6-0:1.0: hub_suspend
Sep  1 16:00:38 master kernel: [ 1397.374077] usb usb6: bus
auto-suspend, wakeup 1
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at  http://vger.kernel.org/majordomo-info.html




[Index of Archives]     [Linux Media]     [Linux Input]     [Linux Audio Users]     [Yosemite News]     [Linux Kernel]     [Linux SCSI]     [Old Linux USB Devel Archive]

  Powered by Linux