USB3 Mass Storage XHCI timeout/hang

Hi,

I am trying to use a TI USB3.0->SATA bridge with Jetson TX2 but i am having some difficulties.

Everything appears to enumerate properly…

[ 8.010900] hub 1-0:1.0: hub_suspend
[ 8.010910] usb usb1: bus auto-suspend, wakeup 1
[ 8.010999] usb usb1: suspend raced with wakeup event
[ 8.011001] usb usb1: usb auto-resume
[ 8.026858] hub 1-0:1.0: hub_resume
[ 8.070816] hub 2-0:1.0: state 7 ports 3 chg 0002 evt 0000
[ 8.070831] usb usb2-port1: status 0203, change 0000, 5.0 Gb/s
[ 8.134817] hub 1-0:1.0: state 7 ports 4 chg 0000 evt 0000
[ 8.134821] hub 1-0:1.0: hub_suspend
[ 8.134832] usb usb1: bus auto-suspend, wakeup 1
[ 8.183297] usb 2-1: new SuperSpeed USB device number 2 using xhci-tegra
[ 8.203389] usb 2-1: skipped 1 descriptor after endpoint
[ 8.203391] usb 2-1: skipped 1 descriptor after endpoint
[ 8.203491] usb 2-1: default language 0x0409
[ 8.203799] usb 2-1: udev 2, busnum 2, minor = 129
[ 8.203801] usb 2-1: New USB device found, idVendor=0451, idProduct=9261
[ 8.203803] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 8.203805] usb 2-1: Product: TUSB9261 USB3.0 to SATA Bridge
[ 8.203806] usb 2-1: Manufacturer: Texas Instruments
[ 8.203808] usb 2-1: SerialNumber: 7B558A4C0655881C175403492EC5AD652
[ 8.203987] usb 2-1: usb_probe_device
[ 8.203990] usb 2-1: configuration #1 chosen from 1 choice
[ 8.204324] xhci-tegra 3530000.xhci: tegra_xhci_mbox_work mailbox command 6
[ 8.206065] usb 2-1: adding 2-1:1.0 (config #1, interface 0)
[ 8.206150] usb-storage 2-1:1.0: usb_probe_interface
[ 8.206155] usb-storage 2-1:1.0: usb_probe_interface - got id
[ 8.206159] usb-storage 2-1:1.0: USB Mass Storage device detected
[ 8.210303] scsi host2: usb-storage 2-1:1.0
[ 8.309114] l4tbr0: port 2(usb1) entered disabled state

[ 9.208712] scsi 2:0:0:0: Direct-Access Samsung SSD 850 EVO 250G 2B6Q PQ: 0 ANSI: 6
[ 9.209467] sd 2:0:0:0: [sda] 488397168 512-byte logical blocks: (250 GB/233 GiB)
[ 9.212681] sd 2:0:0:0: [sda] Write Protect is off
[ 9.212685] sd 2:0:0:0: [sda] Mode Sense: 17 00 00 00
[ 9.214382] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn’t support DPO or FUA
[ 9.220050] sda: sda1 sda2 sda3
[ 9.230597] sd 2:0:0:0: [sda] Attached SCSI disk
[ 9.241882] xhci-tegra 3530000.xhci: boost cpu freq 800000 kHz, with timeout 2000 ms
[ 9.242229] xhci-tegra 3530000.xhci: boost cpu freq 800000 kHz, with timeout 2000 ms

When i try to write to the disk (various block sizes) i get a timeout and subsequent errors.
I have tried different SATA drives with different filesystems but still get the same errors.

[ 141.819313] usb 2-1: usb-storage timed out on ep0out len=0/0
[ 141.825103] usb 2-1: Disable of device-initiated U1 failed.
[ 146.831286] usb 2-1: usb-storage timed out on ep0out len=0/0
[ 146.837046] usb 2-1: Disable of device-initiated U2 failed.
[ 148.602195] xhci-tegra 3530000.xhci: tegra_xhci_mbox_work mailbox command 6
[ 148.609274] usb 2-1: Device not responding to setup address.
[ 150.466332] usb 2-1: Device not responding to setup address.
[ 150.674865] usb 2-1: device not accepting address 2, error -71
[ 150.680992] hub 2-0:1.0: state 7 ports 3 chg 0000 evt 0002
[ 150.824470] usb 2-1: Device not responding to setup address.
[ 151.032273] usb 2-1: Device not responding to setup address.
[ 151.238873] usb 2-1: device not accepting address 2, error -71
[ 151.388451] usb 2-1: Device not responding to setup address.
[ 151.596275] usb 2-1: Device not responding to setup address.
[ 151.802865] usb 2-1: device not accepting address 2, error -71
[ 151.952466] usb 2-1: Device not responding to setup address.
[ 152.160278] usb 2-1: Device not responding to setup address.
[ 152.366890] usb 2-1: device not accepting address 2, error -71
[ 152.402948] usb usb2-port1: logical disconnect
[ 152.407495] usb usb2-port1: Not disabling port; link state is RxDetect
[ 152.414242] usb usb2-port1: status 02a0, change 0001, 5.0 Gb/s
[ 152.420283] usb 2-1: USB disconnect, device number 2
[ 152.425347] usb 2-1: unregistering device
[ 152.429461] usb 2-1: unregistering interface 2-1:1.0
[ 152.439359] sd 2:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00
[ 152.447551] sd 2:0:0:0: [sda] tag#0 CDB: opcode=0x2a 2a 00 0e 31 fd 00 00 40 00 00
[ 152.455135] blk_update_request: I/O error, dev sda, sector 238157056
[ 152.461495] Buffer I/O error on dev sda2, logical block 29743776, lost async page write
[ 152.469504] Buffer I/O error on dev sda2, logical block 29743777, lost async page write
[ 152.477508] Buffer I/O error on dev sda2, logical block 29743778, lost async page write
[ 152.485513] Buffer I/O error on dev sda2, logical block 29743779, lost async page write
[ 152.493517] Buffer I/O error on dev sda2, logical block 29743780, lost async page write
[ 152.501519] Buffer I/O error on dev sda2, logical block 29743781, lost async page write
[ 152.509524] Buffer I/O error on dev sda2, logical block 29743782, lost async page write
[ 152.517527] Buffer I/O error on dev sda2, logical block 29743783, lost async page write
[ 152.525529] Buffer I/O error on dev sda2, logical block 29743784, lost async page write
[ 152.533531] Buffer I/O error on dev sda2, logical block 29743785, lost async page write
[ 152.544843] sd 2:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00
[ 152.553022] sd 2:0:0:0: [sda] tag#0 CDB: opcode=0x2a 2a 00 0e 32 3d 00 00 10 70 00
[ 152.560591] blk_update_request: I/O error, dev sda, sector 238173440
[ 154.005145] sd 2:0:0:0: [sda] Synchronizing SCSI cache
[ 154.010511] sd 2:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00
[ 154.127248] usb 2-1: usb_disable_device nuking all URBs
[ 154.258871] usb usb2-port1: debounce total 100ms stable 100ms status 0x203
[ 154.376259] usb 2-1: Device not responding to setup address.
[ 154.584245] usb 2-1: Device not responding to setup address.
[ 154.790870] usb 2-1: device not accepting address 3, error -71
[ 154.940296] usb 2-1: Device not responding to setup address.
[ 155.148279] usb 2-1: Device not responding to setup address.
[ 155.354904] usb 2-1: device not accepting address 4, error -71
[ 155.504292] usb 2-1: Device not responding to setup address.
[ 155.712249] usb 2-1: Device not responding to setup address.
[ 155.918863] usb 2-1: device not accepting address 5, error -71
[ 156.068273] usb 2-1: Device not responding to setup address.
[ 156.276251] usb 2-1: Device not responding to setup address.
[ 156.482863] usb 2-1: device not accepting address 6, error -71
[ 156.519000] usb usb2-port1: unable to enumerate USB device
[ 156.524631] usb usb2-port1: Not disabling port; link state is RxDetect
[ 156.531282] hub 2-0:1.0: state 7 ports 3 chg 0000 evt 0002
[ 156.537037] usb usb2-port1: status 0203, change 0001, 5.0 Gb/s
[ 156.670902] usb usb2-port1: debounce total 100ms stable 100ms status 0x203
[ 156.788281] usb 2-1: Device not responding to setup address.
[ 156.996246] usb 2-1: Device not responding to setup address.
[ 157.202864] usb 2-1: device not accepting address 7, error -71
[ 157.352269] usb 2-1: Device not responding to setup address.
[ 157.560284] usb 2-1: Device not responding to setup address.
[ 157.766866] usb 2-1: device not accepting address 8, error -71
[ 157.916267] usb 2-1: Device not responding to setup address.
[ 158.124247] usb 2-1: Device not responding to setup address.
[ 158.330860] usb 2-1: device not accepting address 9, error -71
[ 158.480283] usb 2-1: Device not responding to setup address.
[ 158.688269] usb 2-1: Device not responding to setup address.
[ 158.894881] usb 2-1: device not accepting address 10, error -71
[ 158.931001] usb usb2-port1: unable to enumerate USB device
[ 158.936632] usb usb2-port1: Not disabling port; link state is RxDetect
[ 158.943280] hub 2-0:1.0: state 7 ports 3 chg 0000 evt 0002
[ 158.949040] usb usb2-port1: status 0203, change 0001, 5.0 Gb/s
[ 159.082899] usb usb2-port1: debounce total 100ms stable 100ms status 0x203
[ 159.200273] usb 2-1: Device not responding to setup address.
[ 159.408243] usb 2-1: Device not responding to setup address.
[ 159.614868] usb 2-1: device not accepting address 11, error -71
[ 159.764277] usb 2-1: Device not responding to setup address.
[ 159.972242] usb 2-1: Device not responding to setup address.
[ 160.178866] usb 2-1: device not accepting address 12, error -71
[ 160.328267] usb 2-1: Device not responding to setup address.
[ 160.536247] usb 2-1: Device not responding to setup address.
[ 160.742862] usb 2-1: device not accepting address 13, error -71
[ 160.892266] usb 2-1: Device not responding to setup address.
[ 161.100251] usb 2-1: Device not responding to setup address.
[ 161.306861] usb 2-1: device not accepting address 14, error -71
[ 161.343015] usb usb2-port1: unable to enumerate USB device
[ 161.348650] usb usb2-port1: Not disabling port; link state is RxDetect
[ 161.355299] hub 2-0:1.0: state 7 ports 3 chg 0000 evt 0002
[ 161.361053] usb usb2-port1: status 0203, change 0001, 5.0 Gb/s
[ 161.494901] usb usb2-port1: debounce total 100ms stable 100ms status 0x203
[ 161.612280] usb 2-1: Device not responding to setup address.
[ 161.820248] usb 2-1: Device not responding to setup address.
[ 162.026867] usb 2-1: device not accepting address 15, error -71
[ 162.176265] usb 2-1: Device not responding to setup address.
[ 162.384242] usb 2-1: Device not responding to setup address.
[ 162.590863] usb 2-1: device not accepting address 16, error -71
[ 162.740269] usb 2-1: Device not responding to setup address.
[ 162.948255] usb 2-1: Device not responding to setup address.
[ 163.154864] usb 2-1: device not accepting address 17, error -71
[ 163.304268] usb 2-1: Device not responding to setup address.
[ 163.512250] usb 2-1: Device not responding to setup address.
[ 163.718863] usb 2-1: device not accepting address 18, error -71
[ 163.755012] usb usb2-port1: unable to enumerate USB device
[ 163.760641] usb usb2-port1: Not disabling port; link state is RxDetect
[ 163.767286] hub 2-0:1.0: state 7 ports 3 chg 0000 evt 0002
[ 163.773028] usb usb2-port1: status 0203, change 0001, 5.0 Gb/s
[ 163.906905] usb usb2-port1: debounce total 100ms stable 100ms status 0x203
[ 164.024275] usb 2-1: Device not responding to setup address.
[ 164.232251] usb 2-1: Device not responding to setup address.
[ 164.438865] usb 2-1: device not accepting address 19, error -71
[ 164.588279] usb 2-1: Device not responding to setup address.
[ 164.796257] usb 2-1: Device not responding to setup address.
[ 165.002867] usb 2-1: device not accepting address 20, error -71
[ 165.152293] usb 2-1: Device not responding to setup address.
[ 165.360251] usb 2-1: Device not responding to setup address.
[ 165.566868] usb 2-1: device not accepting address 21, error -71
[ 165.627112] usb usb2-port1: Not disabling port; link state is RxDetect
[ 165.633789] usb usb2-port1: Not disabling port; link state is RxDetect
[ 165.640537] hub 2-0:1.0: state 7 ports 3 chg 0000 evt 0002
[ 165.646567] hub 2-0:1.0: hub_suspend
[ 165.650298] usb usb2: bus auto-suspend, wakeup 1
[ 165.655231] xhci-tegra 3530000.xhci: entering ELPG
[ 165.685193] xhci-tegra 3530000.xhci: WARN: xHC save state timeout
[ 165.691335] tegra-xusb-mbox 3538000.mailbox: Controller firmware hang
[ 165.697777] tegra-xusb-mbox 3538000.mailbox: XUSB_CFG_ARU_MBOX_OWNER 0x0
[ 165.704478] tegra-xusb-mbox 3538000.mailbox: XUSB_CFG_ARU_MBOX_CMD 0x80000000
[ 165.711612] tegra-xusb-mbox 3538000.mailbox: XUSB_CFG_ARU_MBOX_DATA_IN 0x0
[ 165.718486] tegra-xusb-mbox 3538000.mailbox: XUSB_CFG_ARU_MBOX_DATA_OUT 0x6000000
[ 165.727637] xhci-tegra 3530000.xhci: xhci_suspend() failed -110
[ 165.733588] xhci-tegra 3530000.xhci: entering ELPG failed

Have similiar issues been seen before?

Regards,
Chris

For info…

Using r28.2
The USB/SATA controller rig works with 14.04 desktop (intel x64 chipset) Ubuntu and Windows.

Cheers,
CHris

some more dbg…

[ 77.810972] xhci-tegra 3530000.xhci: Cancel URB ffffffc1e050cc00, dev 1, ep 0x83, starting at offset 0x80039740
[ 77.821101] xhci-tegra 3530000.xhci: // Ding dong!
[ 77.826176] xhci-tegra 3530000.xhci: Stopped on Transfer TRB
[ 77.831883] xhci-tegra 3530000.xhci: Removing canceled TD starting at 0x80039740 (dma).
[ 77.839909] xhci-tegra 3530000.xhci: Finding endpoint context
[ 77.845673] xhci-tegra 3530000.xhci: Cycle state = 0x1
[ 77.850828] xhci-tegra 3530000.xhci: New dequeue segment = ffffffc1e3d38380 (virtual)
[ 77.858669] xhci-tegra 3530000.xhci: New dequeue pointer = 0x80039750 (DMA)
[ 77.865650] xhci-tegra 3530000.xhci: Set TR Deq Ptr cmd, new deq seg = ffffffc1e3d38380 (0x80039000 dma), new deq ptr = ffffff800ba9e750 (0x80039750 dma1
[ 77.880688] xhci-tegra 3530000.xhci: // Ding dong!
[ 77.885737] xhci-tegra 3530000.xhci: Successful Set TR Deq Ptr cmd, deq = @80039750
[ 77.893702] xhci-tegra 3530000.xhci: Set up evaluate context for LPM MEL change.
[ 77.901159] xhci-tegra 3530000.xhci: Slot 1 Input Context:
[ 77.906812] xhci-tegra 3530000.xhci: @ffffff800931d000 (virt) @80023000 (dma) 0x000000 - drop flags
[ 77.915939] xhci-tegra 3530000.xhci: @ffffff800931d004 (virt) @80023004 (dma) 0x000001 - add flags
[ 77.925005] xhci-tegra 3530000.xhci: @ffffff800931d008 (virt) @80023008 (dma) 0x000000 - rsvd2[0]
[ 77.933970] xhci-tegra 3530000.xhci: @ffffff800931d00c (virt) @8002300c (dma) 0x000000 - rsvd2[1]
[ 77.942933] xhci-tegra 3530000.xhci: @ffffff800931d010 (virt) @80023010 (dma) 0x000000 - rsvd2[2]
[ 77.951844] xhci-tegra 3530000.xhci: @ffffff800931d014 (virt) @80023014 (dma) 0x000000 - rsvd2[3]
[ 77.960762] xhci-tegra 3530000.xhci: @ffffff800931d018 (virt) @80023018 (dma) 0x000000 - rsvd2[4]
[ 77.969654] xhci-tegra 3530000.xhci: @ffffff800931d01c (virt) @8002301c (dma) 0x000000 - rsvd2[5]
[ 77.978571] xhci-tegra 3530000.xhci: @ffffff800931d020 (virt) @80023020 (dma) 0x000000 - rsvd64[0]
[ 77.987542] xhci-tegra 3530000.xhci: @ffffff800931d028 (virt) @80023028 (dma) 0x000000 - rsvd64[1]
[ 77.996536] xhci-tegra 3530000.xhci: @ffffff800931d030 (virt) @80023030 (dma) 0x000000 - rsvd64[2]
[ 78.005520] xhci-tegra 3530000.xhci: @ffffff800931d038 (virt) @80023038 (dma) 0x000000 - rsvd64[3]
[ 78.014506] xhci-tegra 3530000.xhci: Slot Context:
[ 78.019319] xhci-tegra 3530000.xhci: @ffffff800931d040 (virt) @80023040 (dma) 0x38400000 - dev_info
[ 78.028380] xhci-tegra 3530000.xhci: @ffffff800931d044 (virt) @80023044 (dma) 0x010000 - dev_info2
[ 78.037356] xhci-tegra 3530000.xhci: @ffffff800931d048 (virt) @80023048 (dma) 0x000000 - tt_info
[ 78.046153] xhci-tegra 3530000.xhci: @ffffff800931d04c (virt) @8002304c (dma) 0x000000 - dev_state
[ 78.055132] xhci-tegra 3530000.xhci: @ffffff800931d050 (virt) @80023050 (dma) 0x000000 - rsvd[0]
[ 78.063939] xhci-tegra 3530000.xhci: @ffffff800931d054 (virt) @80023054 (dma) 0x000000 - rsvd[1]
[ 78.072734] xhci-tegra 3530000.xhci: @ffffff800931d058 (virt) @80023058 (dma) 0x000000 - rsvd[2]
[ 78.081530] xhci-tegra 3530000.xhci: @ffffff800931d05c (virt) @8002305c (dma) 0x000000 - rsvd[3]
[ 78.090314] xhci-tegra 3530000.xhci: @ffffff800931d060 (virt) @80023060 (dma) 0x000000 - rsvd64[0]
[ 78.099272] xhci-tegra 3530000.xhci: @ffffff800931d068 (virt) @80023068 (dma) 0x000000 - rsvd64[1]
[ 78.108225] xhci-tegra 3530000.xhci: @ffffff800931d070 (virt) @80023070 (dma) 0x000000 - rsvd64[2]
[ 78.117180] xhci-tegra 3530000.xhci: @ffffff800931d078 (virt) @80023078 (dma) 0x000000 - rsvd64[3]
[ 78.126134] xhci-tegra 3530000.xhci: IN Endpoint 00 Context (ep_index 00):
[ 78.133007] xhci-tegra 3530000.xhci: @ffffff800931d080 (virt) @80023080 (dma) 0x000000 - ep_info
[ 78.141790] xhci-tegra 3530000.xhci: @ffffff800931d084 (virt) @80023084 (dma) 0x000000 - ep_info2
[ 78.150659] xhci-tegra 3530000.xhci: @ffffff800931d088 (virt) @80023088 (dma) 0x000000 - deq
[ 78.159092] xhci-tegra 3530000.xhci: @ffffff800931d090 (virt) @80023090 (dma) 0x000000 - tx_info
[ 78.167873] xhci-tegra 3530000.xhci: @ffffff800931d094 (virt) @80023094 (dma) 0x000000 - rsvd[0]
[ 78.176652] xhci-tegra 3530000.xhci: @ffffff800931d098 (virt) @80023098 (dma) 0x000000 - rsvd[1]
[ 78.185434] xhci-tegra 3530000.xhci: @ffffff800931d09c (virt) @8002309c (dma) 0x000000 - rsvd[2]
[ 78.194211] xhci-tegra 3530000.xhci: @ffffff800931d0a0 (virt) @800230a0 (dma) 0x000000 - rsvd64[0]
[ 78.203167] xhci-tegra 3530000.xhci: @ffffff800931d0a8 (virt) @800230a8 (dma) 0x000000 - rsvd64[1]
[ 78.212121] xhci-tegra 3530000.xhci: @ffffff800931d0b0 (virt) @800230b0 (dma) 0x000000 - rsvd64[2]
[ 78.221076] xhci-tegra 3530000.xhci: @ffffff800931d0b8 (virt) @800230b8 (dma) 0x000000 - rsvd64[3]
[ 78.230031] xhci-tegra 3530000.xhci: // Ding dong!
[ 78.235316] xhci-tegra 3530000.xhci: Successful evaluate context command
[ 78.242014] xhci-tegra 3530000.xhci: Slot 1 Output Context:
[ 78.247591] xhci-tegra 3530000.xhci: Slot Context:
[ 78.252382] xhci-tegra 3530000.xhci: @ffffff8009a5d000 (virt) @80031000 (dma) 0x38400000 - dev_info
[ 78.261423] xhci-tegra 3530000.xhci: @ffffff8009a5d004 (virt) @80031004 (dma) 0x010000 - dev_info2
[ 78.270376] xhci-tegra 3530000.xhci: @ffffff8009a5d008 (virt) @80031008 (dma) 0x000000 - tt_info
[ 78.279159] xhci-tegra 3530000.xhci: @ffffff8009a5d00c (virt) @8003100c (dma) 0x18000001 - dev_state
[ 78.288283] xhci-tegra 3530000.xhci: @ffffff8009a5d010 (virt) @80031010 (dma) 0x1010300 - rsvd[0]
[ 78.297153] xhci-tegra 3530000.xhci: @ffffff8009a5d014 (virt) @80031014 (dma) 0x000000 - rsvd[1]
[ 78.305934] xhci-tegra 3530000.xhci: @ffffff8009a5d018 (virt) @80031018 (dma) 0x000000 - rsvd[2]
[ 78.314714] xhci-tegra 3530000.xhci: @ffffff8009a5d01c (virt) @8003101c (dma) 0x000000 - rsvd[3]
[ 78.323494] xhci-tegra 3530000.xhci: @ffffff8009a5d020 (virt) @80031020 (dma) 0x000000 - rsvd64[0]
[ 78.332450] xhci-tegra 3530000.xhci: @ffffff8009a5d028 (virt) @80031028 (dma) 0x000000 - rsvd64[1]
[ 78.341402] xhci-tegra 3530000.xhci: @ffffff8009a5d030 (virt) @80031030 (dma) 0x000000 - rsvd64[2]
[ 78.350354] xhci-tegra 3530000.xhci: @ffffff8009a5d038 (virt) @80031038 (dma) 0x000000 - rsvd64[3]
[ 78.359306] xhci-tegra 3530000.xhci: IN Endpoint 00 Context (ep_index 00):
[ 78.366179] xhci-tegra 3530000.xhci: @ffffff8009a5d040 (virt) @80031040 (dma) 0x000001 - ep_info
[ 78.374958] xhci-tegra 3530000.xhci: @ffffff8009a5d044 (virt) @80031044 (dma) 0x2000026 - ep_info2
[ 78.383913] xhci-tegra 3530000.xhci: @ffffff8009a5d048 (virt) @80031048 (dma) 0x800351e1 - deq
[ 78.392518] xhci-tegra 3530000.xhci: @ffffff8009a5d050 (virt) @80031050 (dma) 0x000000 - tx_info
[ 78.401301] xhci-tegra 3530000.xhci: @ffffff8009a5d054 (virt) @80031054 (dma) 0x8000000 - rsvd[0]
[ 78.410166] xhci-tegra 3530000.xhci: @ffffff8009a5d058 (virt) @80031058 (dma) 0x12c0000 - rsvd[1]
[ 78.419034] xhci-tegra 3530000.xhci: @ffffff8009a5d05c (virt) @8003105c (dma) 0x8000000 - rsvd[2]
[ 78.427900] xhci-tegra 3530000.xhci: @ffffff8009a5d060 (virt) @80031060 (dma) 0x004000 - rsvd64[0]
[ 78.436856] xhci-tegra 3530000.xhci: @ffffff8009a5d068 (virt) @80031068 (dma) 0x100000100080000 - rsvd64[1]
[ 78.446588] xhci-tegra 3530000.xhci: @ffffff8009a5d070 (virt) @80031070 (dma) 0x8400000 - rsvd64[2]
[ 78.455632] xhci-tegra 3530000.xhci: @ffffff8009a5d078 (virt) @80031078 (dma) 0x000000 - rsvd64[3]
[ 78.464590] xhci-tegra 3530000.xhci: Endpoint 0x0 ep reset callback called
[ 78.471471] xhci-tegra 3530000.xhci: get port status, actual port 0 status = 0x1203
[ 78.479198] xhci-tegra 3530000.xhci: Get port status returned 0x203
[ 78.485483] xhci-tegra 3530000.xhci: set port reset, actual port 0 status = 0x1211
[ 78.493137] xhci-tegra 3530000.xhci: Port Status Change Event for port 1
[ 78.499829] xhci-tegra 3530000.xhci: handle_port_status: starting port polling.
[ 78.546937] xhci-tegra 3530000.xhci: get port status, actual port 0 status = 0x201203
[ 78.554847] xhci-tegra 3530000.xhci: Get port status returned 0x100203
[ 78.561437] xhci-tegra 3530000.xhci: clear port reset change, actual port 0 status = 0x1203
[ 78.569931] xhci-tegra 3530000.xhci: clear port warm(BH) reset change, actual port 0 status = 0x1203
[ 78.579207] xhci-tegra 3530000.xhci: clear port link state change, actual port 0 status = 0x1203
[ 78.588131] xhci-tegra 3530000.xhci: clear port connect change, actual port 0 status = 0x1203
[ 78.596805] xhci-tegra 3530000.xhci: get port status, actual port 0 status = 0x1203
[ 78.604537] xhci-tegra 3530000.xhci: Get port status returned 0x203
[ 78.662909] xhci-tegra 3530000.xhci: Resetting device with slot ID 1
[ 78.669288] xhci-tegra 3530000.xhci: // Ding dong!
[ 78.674342] xhci-tegra 3530000.xhci: Completed reset device command.

repeated.

Regards,
Chris

Hi chris,
Is it a cable like Amazon.com ?

Do you connect it to usb3.0 type A on default board? Or your own custom board?

Hi Dane.

I’m using a usb 3 type b connector on the bridge via the type A on the jetson development kit.

Regards,
Chris

By the way. The TX2 + Dev Kit works with a different (JMicron) USB3->SATA bridge. The problem seems to be isolated to the TI TUSB9261 bridge.

Also, when it enumerates, i can mount the drive and see the filesystem. It only times out when i try to write to the disk.

Chris

Kernel trace…

**** Working Jmicron Bridge ****

          dd-2934  [000] ...1  1452.271751: scsi_dispatch_cmd_start: host_no=5 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196376 txlen=8 protect=0 raw=28 00 00 40 08 18 00 00 08 00)
 usb-storage-2856  [003] d..2  1452.273533: scsi_dispatch_cmd_done: host_no=5 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196376 txlen=8 protect=0 raw=28 00 00 40 08 18 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
 usb-storage-2856  [003] ..s2  1452.273565: scsi_dispatch_cmd_start: host_no=5 channel=0 id=0 lun=0 data_sgl=787 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(WRITE_10 lba=4802560 txlen=16384 protect=0 raw=2a 00 00 49 48 00 00 40 00 00)
 usb-storage-2856  [000] d..2  1452.503015: scsi_dispatch_cmd_done: host_no=5 channel=0 id=0 lun=0 data_sgl=787 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(WRITE_10 lba=4802560 txlen=16384 protect=0 raw=2a 00 00 49 48 00 00 40 00 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)

**** NOT WORKING - TI Bridge ****

          dd-2998  [000] ...1  1587.090641: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196392 txlen=8 protect=0 raw=28 00 00 40 08 28 00 00 08 00)
 usb-storage-2958  [004] d..2  1587.092526: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196392 txlen=8 protect=0 raw=28 00 00 40 08 28 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
          dd-2998  [000] ...1  1587.092619: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196400 txlen=8 protect=0 raw=28 00 00 40 08 30 00 00 08 00)
 usb-storage-2958  [004] d..2  1587.092964: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196400 txlen=8 protect=0 raw=28 00 00 40 08 30 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
          dd-2998  [000] ...1  1587.093025: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196384 txlen=8 protect=0 raw=28 00 00 40 08 20 00 00 08 00)
 usb-storage-2958  [004] d..2  1587.093429: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196384 txlen=8 protect=0 raw=28 00 00 40 08 20 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
          dd-2998  [000] ...1  1587.093492: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196376 txlen=8 protect=0 raw=28 00 00 40 08 18 00 00 08 00)
 usb-storage-2958  [004] d..2  1587.093870: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196376 txlen=8 protect=0 raw=28 00 00 40 08 18 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
          dd-2998  [000] ...1  1587.093934: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196368 txlen=8 protect=0 raw=28 00 00 40 08 10 00 00 08 00)
 usb-storage-2958  [004] d..2  1587.094286: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=4196368 txlen=8 protect=0 raw=28 00 00 40 08 10 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
kworker/0:1H-347   [000] ...1  1587.385643: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=10248 txlen=8 protect=0 raw=28 00 00 00 28 08 00 00 08 00)
 usb-storage-2958  [004] d..2  1587.387405: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=10248 txlen=8 protect=0 raw=28 00 00 00 28 08 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
kworker/0:1H-347   [000] ...1  1587.387476: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=10256 txlen=8 protect=0 raw=28 00 00 00 28 10 00 00 08 00)
 usb-storage-2958  [004] d..2  1587.387835: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=10256 txlen=8 protect=0 raw=28 00 00 00 28 10 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
kworker/0:1H-347   [000] ...1  1587.395067: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=10264 txlen=8 protect=0 raw=28 00 00 00 28 18 00 00 08 00)
 usb-storage-2958  [005] d..2  1587.395411: scsi_dispatch_cmd_done: host_no=6 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(READ_10 lba=10264 txlen=8 protect=0 raw=28 00 00 00 28 18 00 00 08 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)
 usb-storage-2958  [005] ..s2  1587.395450: scsi_dispatch_cmd_start: host_no=6 channel=0 id=0 lun=0 data_sgl=956 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(WRITE_10 lba=280576 txlen=16384 protect=0 raw=2a 00 00 04 48 00 00 40 00 00)
      <idle>-0     [000] d.s3  1617.898881: scsi_dispatch_cmd_timeout: host_no=6 channel=0 id=0 lun=0 data_sgl=956 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(WRITE_10 lba=280576 txlen=16384 protect=0 raw=2a 00 00 04 48 00 00 40 00 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD)

kworker/u12:3-151 [000] d…3 1617.906957: xhci_dbg_cancel_urb: Cancel URB ffffffc1ce919b00, dev 2.7, ep 0x3, starting at offset 0x80047a60

It is specific to TI bridge. For now we don’t have the device. Hope other users can share experience if there is any.

+1 on this, I’m having the same problem, has anyone made any progress?