[FS#177] ipq806x: USB3 ports fail if booted when USB3 flash drives inserted during boot time

Tue Sep 13 19:11:30 PDT 2016

A new Flyspray task has been opened.  Details are below. 

User who did this - J (jmomo) 

Attached to Project - LEDE Project
Summary - ipq806x: USB3 ports fail if booted when USB3 flash drives inserted during boot time
Task Type - Bug Report
Category - Base system
Status - Unconfirmed
Assigned To - 
Operating System - All
Severity - Low
Priority - Very Low
Reported Version - Trunk
Due in Version - Undecided
Due Date - Undecided
Details - I am seeing a strange problem on my new TRENDnet tew827dru, which is ipq8064 based. It has two USB3 ports.

I have noticed a problem with USB3 flash drives. If I boot the system with a USB3 flash drive in one of the USB ports, that port won't allow any USB3 drive to work in it until the next reboot.

It seems to be a xhci driver issue.

This behavior is somewhat intermittent and varied. Occasionally my Silicon Power USB3 drive will work fine after boot, and the SanDisk USB3 drive almost always appears in "lsusb", but the partitions can't be seen, and it still doesn't work right.

The USB3 flash drives works as-expected if I plug them in after boot is completed. The issue only appears if the drive was already in the USB port during boot time.

USB2 flash drives do not appear to be affected.

The USB3 hard drive I tested seems to be working normally.

USB flash drives tested:
    SanDisk Ultra Fit 16GB (USB3)
    Patriot Tab Series 32GB (USB3)
    Silicon Power 32GB (USB3)
    Kingston DTSE9 8GB (USB2)
    Patriot 8GB (USB2)

Below is an example boot log where I have a USB3 drive in each of the two ports. Neither works:

[    6.275249] usbcore: registered new interface driver usbfs
[    6.275322] usbcore: registered new interface driver hub
[    6.279713] usbcore: registered new device driver usb
[    6.320705] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    6.321204] ehci-platform: EHCI generic platform driver
[    6.331613] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    6.332310] ohci-platform: OHCI generic platform driver
[    6.841285] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    6.841329] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
[    6.845931] xhci-hcd xhci-hcd.0.auto: hcc params 0x0228f065 hci version 0x100 quirks 0x00010010
[    6.853327] xhci-hcd xhci-hcd.0.auto: irq 200, io mem 0x11000000
[    6.862602] hub 1-0:1.0: USB hub found
[    6.872028] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    6.875912] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
[    6.881170] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[    6.889250] hub 2-0:1.0: USB hub found
[    6.900865] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[    6.904684] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 3
[    6.910066] xhci-hcd xhci-hcd.1.auto: hcc params 0x0228f065 hci version 0x100 quirks 0x00010010
[    6.917541] xhci-hcd xhci-hcd.1.auto: irq 201, io mem 0x10000000
[    6.926734] hub 3-0:1.0: USB hub found
[    6.936227] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[    6.940023] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 4
[    6.945455] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
[    6.953458] hub 4-0:1.0: USB hub found
[    6.965885] of_get_named_gpiod_flags: parsed 'gpios' property of node '/gpio-leds/usb[0]' - status (0)
[    6.967608] usbcore: registered new interface driver usb-storage
[    7.182177] usb 1-1: new high-speed USB device number 2 using xhci-hcd
[    7.252035] usb 3-1: new high-speed USB device number 2 using xhci-hcd
[    7.382317] usb 2-1: new SuperSpeed USB device number 2 using xhci-hcd
[    7.417343] usb-storage 2-1:1.0: USB Mass Storage device detected
[    7.428209] scsi host0: usb-storage 2-1:1.0
[    7.442238] usb 4-1: new SuperSpeed USB device number 2 using xhci-hcd
[    7.465865] usb-storage 4-1:1.0: USB Mass Storage device detected
[    7.466672] scsi host1: usb-storage 4-1:1.0
[    8.462818] scsi 1:0:0:0: Direct-Access              USB DISK 3.0     PMAP PQ: 0 ANSI: 6
[   17.195224] xhci-hcd xhci-hcd.0.auto: xHCI host not responding to stop endpoint command.
[   17.195259] xhci-hcd xhci-hcd.0.auto: Assuming host is dying, halting host.
[   17.227985] xhci-hcd xhci-hcd.0.auto: Host not halted after 16000 microseconds.
[   17.228010] xhci-hcd xhci-hcd.0.auto: Non-responsive xHCI host is not halting.
[   17.234094] xhci-hcd xhci-hcd.0.auto: Completing active URBs anyway.
[   17.241418] xhci-hcd xhci-hcd.0.auto: HC died; cleaning up
[   17.248041] usb usb1-port1: couldn't allocate usb_device
[   17.253296] usb 2-1: USB disconnect, device number 2
[   17.263718] xhci-hcd xhci-hcd.1.auto: xHCI host not responding to stop endpoint command.
[   17.263722] xhci-hcd xhci-hcd.1.auto: Assuming host is dying, halting host.
[   17.289471] xhci-hcd xhci-hcd.1.auto: Host not halted after 16000 microseconds.
[   17.289481] xhci-hcd xhci-hcd.1.auto: Non-responsive xHCI host is not halting.
[   17.289491] xhci-hcd xhci-hcd.1.auto: Completing active URBs anyway.
[   17.289534] xhci-hcd xhci-hcd.1.auto: HC died; cleaning up
[   17.324608] usb usb3-port1: couldn't allocate usb_device
[   17.329821] usb 4-1: USB disconnect, device number 2

And here I am plugging both drives in after the system booted normally.

[    6.193094] usbcore: registered new interface driver usbfs
[    6.193173] usbcore: registered new interface driver hub
[    6.197552] usbcore: registered new device driver usb
[    6.238600] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    6.239108] ehci-platform: EHCI generic platform driver
[    6.249525] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    6.250089] ohci-platform: OHCI generic platform driver
[    6.761332] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    6.761378] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
[    6.765992] xhci-hcd xhci-hcd.0.auto: hcc params 0x0228f065 hci version 0x100 quirks 0x00010010
[    6.773385] xhci-hcd xhci-hcd.0.auto: irq 200, io mem 0x11000000
[    6.782646] hub 1-0:1.0: USB hub found
[    6.792070] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    6.795937] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
[    6.801200] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[    6.809293] hub 2-0:1.0: USB hub found
[    6.820906] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[    6.824739] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 3
[    6.830118] xhci-hcd xhci-hcd.1.auto: hcc params 0x0228f065 hci version 0x100 quirks 0x00010010
[    6.837600] xhci-hcd xhci-hcd.1.auto: irq 201, io mem 0x10000000
[    6.846784] hub 3-0:1.0: USB hub found
[    6.856269] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[    6.860070] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 4
[    6.865495] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
[    6.873508] hub 4-0:1.0: USB hub found
[    6.885940] of_get_named_gpiod_flags: parsed 'gpios' property of node '/gpio-leds/usb[0]' - status (0)
[   27.122596] usb 4-1: new SuperSpeed USB device number 2 using xhci-hcd
[   27.144608] usb-storage 4-1:1.0: USB Mass Storage device detected
[   27.155356] scsi host0: usb-storage 4-1:1.0
[   28.153237] scsi 0:0:0:0: Direct-Access              USB DISK 3.0     PMAP PQ: 0 ANSI: 6
[   30.753700] usb 2-1: new SuperSpeed USB device number 2 using xhci-hcd
[   30.776011] usb-storage 2-1:1.0: USB Mass Storage device detected
[   30.776282] scsi host1: usb-storage 2-1:1.0

More information can be found at the following URL:
https://bugs.lede-project.org/index.php?do=details&task_id=177