This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

TUSB9261: USB repetitive RESET Burst during boot after Super Speed negotiation

Part Number: TUSB9261
Other Parts Discussed in Thread: AM5K2E04, , ,

Hello  to everybody,

We have a boot issue during the mount of a Mass Storage on Sata interface, through the TI USB to Sata bridge.

For some random boot sequences, SSD mount is sometime delayed for several seconds to several tens of seconds.

We identifyed as symptom, multiple USB BUS Reset burst traced by the Bridge message 'USB Reset event occurred', transmitted on Tx out link as debug out only.

TUSB messages are timestamped by Terraterm log recorder.

Herafter are compared a bad case (left/red) and a quasi nominal case ( green / right) 

USB BUS Reset sequences seems to beguin after the USB switches to Super Speed mode, traced as 'Connected at SUPER speed' message

Bridge is directly connected to SoC USB interface

SoC is Keystone AM5K2E04 with an OS derivated from FreeBSD USB driver Mass storage class and file system  

Does anyone have experienced such behavior of Bridge / Keystone SoC together inducing a delayed mount of Mass storage ( with these long lasting Reset USB bursts)

Thanks for any help

Best regards

Frédéric

BAD case log (Delayed SSD ready by 17s) Nominal case SSD Ready obtained in 10s after power ON
States view from TUSB9261  Bridge debug Tx line States view from TUSB9261  Bridge debug Tx line
[2023-10-04 22:20:06.033]  [2023-10-04 22:19:43.022] 
[2023-10-04 22:20:06.033] ======================================================== [2023-10-04 22:19:43.022] ========================================================
[2023-10-04 22:20:06.033] ||   TUSB926x Firmware v1.06 [Jan  5 2018 12:01:57]   || [2023-10-04 22:19:43.022] ||   TUSB926x Firmware v1.06 [Jan  5 2018 12:01:57]   ||
[2023-10-04 22:20:06.043] ||                 Device ID: 0x0000                  || [2023-10-04 22:19:43.031] ||                 Device ID: 0x0000                  ||
[2023-10-04 22:20:06.043] ======================================================== [2023-10-04 22:19:43.031] ========================================================
[2023-10-04 22:20:06.084] [0000000057] SATA Gen-1 speed negotiated. [2023-10-04 22:19:43.073] [0000000057] SATA Gen-1 speed negotiated.
[2023-10-04 22:20:06.374] [0000000341]  [2023-10-04 22:19:43.365] [0000000341] 
[2023-10-04 22:20:06.374] [0000000341] ================================================ [2023-10-04 22:19:43.365] [0000000341] ================================================
[2023-10-04 22:20:06.374] [0000000341]              IDENTIFY DEVICE INFO [2023-10-04 22:19:43.365] [0000000341]              IDENTIFY DEVICE INFO
[2023-10-04 22:20:06.384] [0000000341] ================================================ [2023-10-04 22:19:43.371] [0000000341] ================================================
[2023-10-04 22:20:06.384] [0000000341]  [2023-10-04 22:19:43.371] [0000000341] 
[2023-10-04 22:20:06.384] [0000000341]   Model:  32GB NANDrive                            [2023-10-04 22:19:43.371] [0000000341]   Model:  32GB NANDrive                           
[2023-10-04 22:20:06.455] [0000000341] ================================================ [2023-10-04 22:19:43.443] [0000000341] ================================================
[2023-10-04 22:20:06.455]  [2023-10-04 22:19:43.443] 
[2023-10-04 22:20:06.455] [0000000350] Connected to 1 AHCI device(s). [2023-10-04 22:19:43.443] [0000000350] Connected to 1 AHCI device(s).
[2023-10-04 22:20:12.374] [0000006340] LTSSM state = (0x5) RX DETECT. [2023-10-04 22:19:49.361] [0000006340] LTSSM state = (0x5) RX DETECT.
[2023-10-04 22:20:12.374] [0000006341] USB Reset event occurred. [2023-10-04 22:19:49.361] [0000006341] USB Reset event occurred.   instability ?
[2023-10-04 22:20:12.374] [0000006341] -> ahci_reset_lun(0) [2023-10-04 22:19:49.361] [0000006341] -> ahci_reset_lun(0)  
[2023-10-04 22:20:12.379] [0000006341] LTSSM state = (0x7) POLLING. [2023-10-04 22:19:49.366] [0000006341] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:12.393] [0000006360] HS/FS/LS state = (0x0) ON. [2023-10-04 22:19:49.382] [0000006360] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:12.393] [0000006363] HS/FS/LS state = (0x5) EARLY SUSPEND. [2023-10-04 22:19:49.382] [0000006363] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:12.393] [0000006366] HS/FS/LS state = (0x3) SUSPEND. [2023-10-04 22:19:49.382] [0000006366] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:13.071] [0000007037] USB Reset event occurred. [2023-10-04 22:19:50.054] [0000007036] USB Reset event occurred.  
[2023-10-04 22:20:13.071] [0000007037] -> ahci_reset_lun(0) [2023-10-04 22:19:50.054] [0000007036] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.071] [0000007038] Connected at SUPER speed. [2023-10-04 22:19:50.054] [0000007037] Connected at SUPER speed.  
[2023-10-04 22:20:13.071] [0000007038] USB Reset event occurred. [2023-10-04 22:19:50.054] [0000007037] USB Reset event occurred.  
[2023-10-04 22:20:13.081] [0000007038] -> ahci_reset_lun(0) [2023-10-04 22:19:50.064] [0000007038] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.081] [0000007038] LTSSM state = (0x7) POLLING. [2023-10-04 22:19:50.064] [0000007038] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:13.093] [0000007059] HS/FS/LS state = (0x0) ON. [2023-10-04 22:19:50.064] [0000007045] Connected at SUPER speed.  
[2023-10-04 22:20:13.093] [0000007059] USB Reset event occurred. [2023-10-04 22:19:50.444] [0000007430] USB Reset event occurred.  
[2023-10-04 22:20:13.093] [0000007059] -> ahci_reset_lun(0) [2023-10-04 22:19:50.444] [0000007430] -> ahci_reset_lun(0)
[2023-10-04 22:20:13.103] [0000007060] Connected at SUPER speed.   [2023-10-04 22:19:50.444] [0000007430] Connected at SUPER speed.    
[2023-10-04 22:20:13.103] [0000007061] USB Reset event occurred. start of reset cycles [2023-10-04 22:19:50.734] [0000007726] -> usb_hal_set_address() - addr: 0x1. Nominal activity
[2023-10-04 22:20:13.103] [0000007061] -> ahci_reset_lun(0)   [2023-10-04 22:19:50.754] [0000007743] -> handle_usb_set_configuration() - val = 1.    
[2023-10-04 22:20:13.103] [0000007061] LTSSM state = (0x7) POLLING.   [2023-10-04 22:19:51.775] [0000008758] -> ums_bot_case_handler() - case 5.    
[2023-10-04 22:20:13.112] [0000007077] HS/FS/LS state = (0x0) ON.   [2023-10-04 22:19:51.795] [0000008781] -> ums_bot_case_handler() - case 5.    
[2023-10-04 22:20:13.112] [0000007078] USB Reset event occurred. 2 ATA E5 command received by SSD
[2023-10-04 22:20:13.122] [0000007078] -> ahci_reset_lun(0)   no further reset cycle or USB error
[2023-10-04 22:20:13.122] [0000007079] Connected at SUPER speed.  
[2023-10-04 22:20:13.122] [0000007079] USB Reset event occurred. 3
[2023-10-04 22:20:13.134] [0000007079] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.134] [0000007079] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:13.134] [0000007095] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:13.144] [0000007098] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:13.144] [0000007101] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:13.709] [0000007677] USB Reset event occurred. 4
[2023-10-04 22:20:13.709] [0000007677] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.709] [0000007678] Connected at SUPER speed.  
[2023-10-04 22:20:13.709] [0000007678] USB Reset event occurred. 5
[2023-10-04 22:20:13.719] [0000007678] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.719] [0000007678] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:13.729] [0000007699] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:13.729] [0000007699] USB Reset event occurred. 6
[2023-10-04 22:20:13.729] [0000007699] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.739] [0000007701] Connected at SUPER speed.  
[2023-10-04 22:20:13.739] [0000007701] USB Reset event occurred. 7
[2023-10-04 22:20:13.739] [0000007701] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.739] [0000007701] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:13.749] [0000007701] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:13.749] [0000007722] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:13.759] [0000007723] USB Reset event occurred. 8
[2023-10-04 22:20:13.759] [0000007723] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.759] [0000007724] Connected at SUPER speed.  
[2023-10-04 22:20:13.769] [0000007724] USB Reset event occurred. 9
[2023-10-04 22:20:13.769] [0000007724] -> ahci_reset_lun(0)  
[2023-10-04 22:20:13.769] [0000007724] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:13.779] [0000007724] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:13.779] [0000007740] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:13.779] [0000007743] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:13.789] [0000007746] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:14.344] [0000008317] USB Reset event occurred. 10
[2023-10-04 22:20:14.344] [0000008317] -> ahci_reset_lun(0)  
[2023-10-04 22:20:14.344] [0000008318] Connected at SUPER speed.  
[2023-10-04 22:20:14.344] [0000008318] USB Reset event occurred. 11
[2023-10-04 22:20:14.354] [0000008318] -> ahci_reset_lun(0)  
[2023-10-04 22:20:14.354] [0000008318] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:14.364] [0000008318] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:14.364] [0000008339] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:14.364] [0000008340] USB Reset event occurred. 12
[2023-10-04 22:20:14.374] [0000008340] -> ahci_reset_lun(0)  
[2023-10-04 22:20:14.374] [0000008341] Connected at SUPER speed.  
[2023-10-04 22:20:14.374] [0000008341] USB Reset event occurred. 13
[2023-10-04 22:20:14.384] [0000008341] -> ahci_reset_lun(0)  
[2023-10-04 22:20:14.384] [0000008341] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:14.384] [0000008362] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:14.394] [0000008362] USB Reset event occurred.  
[2023-10-04 22:20:14.394] [0000008362] -> ahci_reset_lun(0)  
[2023-10-04 22:20:14.394] [0000008363] Connected at SUPER speed.  
[2023-10-04 22:20:14.404] [0000008363] USB Reset event occurred. 14
[2023-10-04 22:20:14.404] [0000008363] -> ahci_reset_lun(0)  
[2023-10-04 22:20:14.404] [0000008363] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:14.414] [0000008379] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:14.414] [0000008382] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:14.414] [0000008385] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:14.991] [0000008957] USB Reset event occurred. 15
[2023-10-04 22:20:14.991] [0000008957] -> ahci_reset_lun(0)  
[2023-10-04 22:20:14.991] [0000008958] Connected at SUPER speed.  
[2023-10-04 22:20:14.991] [0000008958] USB Reset event occurred. 16
[2023-10-04 22:20:15.001] [0000008958] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.001] [0000008958] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:15.011] [0000008978] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:15.011] [0000008979] USB Reset event occurred. 17
[2023-10-04 22:20:15.011] [0000008979] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.021] [0000008980] Connected at SUPER speed.  
[2023-10-04 22:20:15.021] [0000008980] USB Reset event occurred. 18
[2023-10-04 22:20:15.021] [0000008980] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.021] [0000008980] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:15.031] [0000008997] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:15.031] [0000008997] USB Reset event occurred. 19
[2023-10-04 22:20:15.041] [0000008997] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.041] [0000008998] Connected at SUPER speed.  
[2023-10-04 22:20:15.041] [0000008998] USB Reset event occurred. 20
[2023-10-04 22:20:15.051] [0000008998] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.051] [0000008998] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:15.051] [0000009020] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:15.061] [0000009023] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:15.061] [0000009026] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:15.628] [0000009597] USB Reset event occurred. 21
[2023-10-04 22:20:15.628] [0000009597] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.628] [0000009598] Connected at SUPER speed.  
[2023-10-04 22:20:15.628] [0000009598] USB Reset event occurred. 22
[2023-10-04 22:20:15.638] [0000009598] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.638] [0000009598] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:15.648] [0000009618] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:15.648] [0000009619] USB Reset event occurred. 23
[2023-10-04 22:20:15.648] [0000009619] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.658] [0000009620] Connected at SUPER speed.  
[2023-10-04 22:20:15.658] [0000009620] USB Reset event occurred. 24
[2023-10-04 22:20:15.658] [0000009620] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.658] [0000009620] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:15.668] [0000009637] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:15.668] [0000009637] USB Reset event occurred. 25
[2023-10-04 22:20:15.678] [0000009637] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.678] [0000009638] Connected at SUPER speed.  
[2023-10-04 22:20:15.678] [0000009638] USB Reset event occurred. 26
[2023-10-04 22:20:15.688] [0000009638] -> ahci_reset_lun(0)  
[2023-10-04 22:20:15.688] [0000009638] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:15.688] [0000009655] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:15.698] [0000009658] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:15.698] [0000009661] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:16.264] [0000010237] USB Reset event occurred. 27
[2023-10-04 22:20:16.264] [0000010237] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.264] [0000010238] Connected at SUPER speed.  
[2023-10-04 22:20:16.264] [0000010238] USB Reset event occurred. 28
[2023-10-04 22:20:16.274] [0000010238] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.274] [0000010238] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:16.284] [0000010238] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:16.284] [0000010258] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:16.284] [0000010259] USB Reset event occurred. 29
[2023-10-04 22:20:16.294] [0000010259] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.294] [0000010260] Connected at SUPER speed.  
[2023-10-04 22:20:16.294] [0000010260] USB Reset event occurred. 30
[2023-10-04 22:20:16.304] [0000010260] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.304] [0000010260] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:16.304] [0000010282] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:16.314] [0000010282] USB Reset event occurred. 31
[2023-10-04 22:20:16.314] [0000010282] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.314] [0000010283] Connected at SUPER speed.  
[2023-10-04 22:20:16.324] [0000010283] USB Reset event occurred. 32
[2023-10-04 22:20:16.324] [0000010283] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.324] [0000010283] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:16.334] [0000010300] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:16.334] [0000010303] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:16.334] [0000010306] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:16.904] [0000010877] USB Reset event occurred. 33
[2023-10-04 22:20:16.904] [0000010877] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.904] [0000010878] Connected at SUPER speed.  
[2023-10-04 22:20:16.904] [0000010878] USB Reset event occurred. 34
[2023-10-04 22:20:16.914] [0000010878] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.914] [0000010878] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:16.924] [0000010898] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:16.924] [0000010899] USB Reset event occurred. 35
[2023-10-04 22:20:16.924] [0000010899] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.934] [0000010900] Connected at SUPER speed.  
[2023-10-04 22:20:16.934] [0000010900] USB Reset event occurred. 36
[2023-10-04 22:20:16.934] [0000010900] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.934] [0000010900] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:16.944] [0000010921] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:16.944] [0000010921] USB Reset event occurred. 37
[2023-10-04 22:20:16.954] [0000010921] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.954] [0000010922] Connected at SUPER speed.  
[2023-10-04 22:20:16.954] [0000010922] USB Reset event occurred. 38
[2023-10-04 22:20:16.964] [0000010922] -> ahci_reset_lun(0)  
[2023-10-04 22:20:16.964] [0000010922] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:16.964] [0000010939] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:16.974] [0000010942] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:16.974] [0000010945] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:17.551] [0000011517] USB Reset event occurred. 39
[2023-10-04 22:20:17.551] [0000011517] -> ahci_reset_lun(0)  
[2023-10-04 22:20:17.551] [0000011518] Connected at SUPER speed.  
[2023-10-04 22:20:17.551] [0000011518] USB Reset event occurred. 40
[2023-10-04 22:20:17.561] [0000011518] -> ahci_reset_lun(0)  
[2023-10-04 22:20:17.561] [0000011518] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:17.571] [0000011518] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:17.571] [0000011537] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:17.571] [0000011538] USB Reset event occurred. 41
[2023-10-04 22:20:17.581] [0000011538] -> ahci_reset_lun(0)  
[2023-10-04 22:20:17.581] [0000011539] Connected at SUPER speed.  
[2023-10-04 22:20:17.581] [0000011539] USB Reset event occurred. 42
[2023-10-04 22:20:17.591] [0000011539] -> ahci_reset_lun(0)  
[2023-10-04 22:20:17.591] [0000011539] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:17.591] [0000011556] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:17.601] [0000011556] USB Reset event occurred. 43
[2023-10-04 22:20:17.601] [0000011556] -> ahci_reset_lun(0)  
[2023-10-04 22:20:17.601] [0000011557] Connected at SUPER speed.  
[2023-10-04 22:20:17.611] [0000011557] USB Reset event occurred. 44
[2023-10-04 22:20:17.611] [0000011557] -> ahci_reset_lun(0)  
[2023-10-04 22:20:17.611] [0000011557] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:17.621] [0000011557] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:17.621] [0000011579] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:17.621] [0000011582] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:17.621] [0000011585] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:18.188] [0000012157] USB Reset event occurred. 45
[2023-10-04 22:20:18.188] [0000012157] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.188] [0000012158] Connected at SUPER speed.  
[2023-10-04 22:20:18.188] [0000012158] USB Reset event occurred. 46
[2023-10-04 22:20:18.196] [0000012158] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.196] [0000012158] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:18.206] [0000012177] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:18.206] [0000012178] USB Reset event occurred. 47
[2023-10-04 22:20:18.206] [0000012178] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.226] [0000012192] Connected at SUPER speed.  
[2023-10-04 22:20:18.226] [0000012192] USB Reset event occurred. 48
[2023-10-04 22:20:18.226] [0000012192] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.226] [0000012192] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:18.236] [0000012209] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:18.236] [0000012212] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:18.236] [0000012215] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:18.825] [0000012797] USB Reset event occurred. 49
[2023-10-04 22:20:18.825] [0000012797] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.825] [0000012798] Connected at SUPER speed.  
[2023-10-04 22:20:18.825] [0000012798] USB Reset event occurred. 50
[2023-10-04 22:20:18.835] [0000012798] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.835] [0000012798] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:18.855] [0000012820] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:18.855] [0000012821] USB Reset event occurred. 51
[2023-10-04 22:20:18.855] [0000012821] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.865] [0000012822] Connected at SUPER speed.  
[2023-10-04 22:20:18.865] [0000012822] USB Reset event occurred. 52
[2023-10-04 22:20:18.865] [0000012822] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.865] [0000012822] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:18.875] [0000012839] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:18.875] [0000012839] USB Reset event occurred. 53
[2023-10-04 22:20:18.885] [0000012839] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.885] [0000012840] Connected at SUPER speed.  
[2023-10-04 22:20:18.885] [0000012840] USB Reset event occurred. 54
[2023-10-04 22:20:18.895] [0000012840] -> ahci_reset_lun(0)  
[2023-10-04 22:20:18.895] [0000012840] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:18.895] [0000012857] HS/FS/LS state = (0x0) ON.  
[2023-10-04 22:20:18.905] [0000012860] HS/FS/LS state = (0x5) EARLY SUSPEND.  
[2023-10-04 22:20:18.905] [0000012863] HS/FS/LS state = (0x3) SUSPEND.  
[2023-10-04 22:20:19.465] [0000013437] USB Reset event occurred. 55
[2023-10-04 22:20:19.465] [0000013437] -> ahci_reset_lun(0)  
[2023-10-04 22:20:19.465] [0000013438] Connected at SUPER speed.  
[2023-10-04 22:20:19.465] [0000013438] USB Reset event occurred. 56
[2023-10-04 22:20:19.475] [0000013438] -> ahci_reset_lun(0)  
[2023-10-04 22:20:19.475] [0000013438] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:19.485] [0000013438] LTSSM state = (0x7) POLLING.  
[2023-10-04 22:20:19.485] [0000013443] Connected at SUPER speed.  
[2023-10-04 22:20:19.865] [0000013831] USB Reset event occurred. 57: last reset
[2023-10-04 22:20:19.865] [0000013831] -> ahci_reset_lun(0)  
[2023-10-04 22:20:19.865] [0000013831] Connected at SUPER speed.
[2023-10-04 22:20:20.153] [0000014127] -> usb_hal_set_address() - addr: 0x1. nominal activity recovered: no more rest
[2023-10-04 22:20:20.173] [0000014144] -> handle_usb_set_configuration() - val = 1.
[2023-10-04 22:20:21.188] [0000015159] -> ums_bot_case_handler() - case 5.
[2023-10-04 22:20:21.208] [0000015181] -> ums_bot_case_handler() - case 5.
ATA E5 command received by SSD
  • Hi Frédéric,

    There was a similar issue with multiple resets caused due to power sag on VBUS that could be related.  Do you think this could be the case here?
    (6) TUSB9261DEMO: Keeps resetting when connected to SATA SSD - Interface forum - Interface - TI E2E support forums

    Regards,

    Nicholaus

  • Hello Nicholaus,

    Thank you for your advices,nice finding, 

    this acceditate the hypothesis we have concerning the Vbus :  our current design seems suspicious with a Vbus signal provided to Bridge and SoC using a zener +5.1Vvoltage derivated from a local +12V line. this 5.1V is then divided by resitors 40.2k 10K. 

    We let you informed of our finding and results of a Vbus signal modification to see if it solves the USB Bus Reset events

    Thanks again

    Best Regards

    Frederic

  • There is a more detailed specification of Vbus signal Input in version -Q1  (automotive qualified) of  TUSB9261

    compared to basic TUSB9261 spec in which one could think it is 5V ( if you did not read the VBUS pad voltage  limitation to 1.155V)

    Does -Q1 version description of VBus could be retained as  complementary information for  standard version ?

    Best regards

    Fred

  • Hi Fred,

    Good question.  After reviewing, they do have the same USB_VBUS spec and are complementary to each other.  The maximum rating is missing from the TUSB9261 datasheet.

    TUSB9261
    Max Ratings - Not Listed (1.2V)
    Recommended - 1.155V
    Design requirements - 90.9kohm (1%) and 10kohm (1%) voltage divider

    TUSB9261-Q1
    Max Ratings - 1.2V
    Recommended - 1.155V
    Design requirements - 90.9kohm (1%) and 10kohm (1%) voltage divider

    Regards,

    Nicholaus

  • Hi Nicholaus,

    thanks for this precision, we are now cleaner with the limits for reviewing the design.

    But on thing seems still missing to determine the margin we have toward the VBUS loss detection is the threshold level of this monitoring input.

    As is seems to be a 1.2V CMOS input shall we consider a trip point at  0.6V   or lower ?

    it stays a mystery , and with  Design requirements recommanding a 90.9k/10K divider , for a nominal 5V VBUS this lead to present to VBUS monitoring input 

    a voltage of 5 x 10/(90.9+10) = 0.495 V  which shall be above the treshold level of VBUS monitoring with a little marging for noise robustness  and this doesn't match with the 0.6V hypothesis .

    Have you access to more data concerning the input characteristics of the VBUS monitoring input to design a robust interface.

    Thanks for your support.

    Best regards

    Fred

  • Hi Fred,

    I'm sorry I can't find this threshold information for the TUSB9261 yet, but I will keep looking.

    In your case the acceptable range of Vbus values from the USB spec are: 
    Min: 4.4V 
    Max: 5.5V

    Is the system within spec during the power sag?  If not, then it should be corrected to be USB-compliant. 

    The required voltage divider will create the min/max voltages for TUSB9261 VBUS input.  I imagine they will trip around these values with some margin:
    Min: 0.436V
    Max: 0.545V

    Regards,

    Nicholaus

  • OK, Thank you for theses informations.

    We are still spying Vbus.

    up to now we have only  found a lonely glitch on VBUS just 8ms after USB VBUS activation ( commanded by Keystone), as depicted on the screen hardcopy hereafter, but nothing that seems sufficent to induce a repetitive USB Bus Reset over a large period of time.

    our investigations will be pushed forward: we wander now if the keystone itself could not Reset the USB bus from his own side, as his USB interface also monitors the VBUS voltage ( directly from the 5V USB VBUS without divider) on a dedicated analog input .

    There are some register dedicated to adjust the voltage level for the VBUS valid threshold.

    in SPRUHJ7A–April 2014–Revised August 2017 page157
    USB Registers

    But there is no detail of how is encoded the adjustement  by steps of +/-1,5% into the 3 bits format, neither the nominal Voltage ( presumed to be 5.00V)

    we have the following values after the OS initialisation:

    • USB_PHY_CTL2 = 0x2C28CDC4

    => PHY_PC_OTGTUNE = 100b

    => PHY_PC_COMPDISTUNE = 100b

    same untouched default values as after a reset

     

    other register allow to select the external VBUS valid source

    • USB_PHY_CTL4 = 0xA9F0C000

    => PHY_OTG_VBUSVLDEXTSEL = 0

    => PHY_OTG_OTGDISABLE = 1

    same untouched default values as after a reset

    But this tricky set up needs more investigations to be understand, and probably only a TI USB specialist could help us to understand it.

    Best Regards

    Fred

  • Yes, it might be best to ask a separate question about the KeyStone II architecture.  I have no experience with it, but if you have a USB protocol analyzer it would be useful to capture a trace between the TUSB9261 and host.

    However, I can help you with anything regarding the TUSB9261.

    Although the power sag is a one-time event, it seems like the previous E2E post I referenced had the same symptom:

    "When the industrial SSD is connected, the TUSB9261DEMO seems to be resetting periodically, about every second or so, appearing and disappearing in the Windows device manager."

    This is so similar that I think we should ensure this 8ms glitch isn't the root cause.  Do you have one of our TUSB9261DEMO boards to test?  Alternatively, is there anything you can do to remove the glitch?

    Regards,

    Nicholaus

  • Hi Frederic,

    Any more questions here?  If not I will close the issue.

    Regards,

    Nicholaus

  • Hello Nicholaus,

    We succeeded to  remove the VUSB glitch by enabling the VBUS power earlyer after SoC ready after power on and bypassing the SoC command which induced the VBUS glitch, but the repetivive USB bus reset remains for some power on sequences.

    We just received our new Total Phase Beagle USB 5000 USB3.0 Analyzer.

    Investigations will resume to try to identfy on USB protocole which actor from Host (Soc) or device (Bridge) is originating the Reset Commands burst.

    Instrumentation is not so easy as we are connectorless between actors , as Soc,Bridge,SSD are linked by trace only on a single PCB. We have to intercept signals between Soc and Bridge and send them through the USB Protocole analyzer. Hope we will not be exposed to signal integrity problem on the SS link  doing so..

    So we are not at the end...

  • Hi Frederic,

    Alright I will mark this issue as "waiting for customer".  Let me know if you have any questions.

    Regards,

    Nicholaus