USB3 Mass Storage XHCI timeout/hang

Autonomous Machines Jetson & Embedded Systems Jetson TX2
1

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

2

For info…

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

Cheers,
CHris

3

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

4

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?

5

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

6

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

7

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

8

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

9

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