linux-kernel - ASM2142: Transfer event TRB DMA ptr not part of current TD ep_index 6 comp

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <04cfcd19-5bd8-2ec1-4840-3865dfec398e@salscheider.org>
Date:   Wed, 31 Mar 2021 11:46:20 +0200
From:   Ole Salscheider <ole@...scheider.org>
To:     linux-kernel <linux-kernel@...r.kernel.org>
Subject: ASM2142: Transfer event TRB DMA ptr not part of current TD ep_index 6
 comp_code 13

Hello,

I have a PCIe card with ASM2142 USB Host Controllers on them. I have 
attached a SuperSpeed UVC camera to it. This camera works on other host 
controllers, but with the ASM2142 the transfer stops after a frame or 
so. Dmesg shows me the following error:

 > Transfer event TRB DMA ptr not part of current TD ep_index 6 comp_code 13

I have tried different XHCI quirks but did not have success with any.
The full log with xhci_hcd debugging enabled is as follows:

[   30.458244] xhci_hcd 0000:60:00.0: Get port status 10-1 read: 0x2a0, 
return 0x2a0
[   30.458254] xhci_hcd 0000:60:00.0: Get port status 10-2 read: 0x1263, 
return 0x263
[   30.458264] xhci_hcd 0000:60:00.0: Get port status 10-2 read: 0x1263, 
return 0x263
[   30.458271] xhci_hcd 0000:60:00.0: Set port 10-2 link state, portsc: 
0x1263, write 0x11201
[   30.458749] xhci_hcd 0000:60:00.0: Port change event, 10-2, id 2, 
portsc: 0x401203
[   30.458757] xhci_hcd 0000:60:00.0: resume SS port 2 finished
[   30.458762] xhci_hcd 0000:60:00.0: handle_port_status: starting port 
polling.
[   30.503906] xhci_hcd 0000:60:00.0: Get port status 10-2 read: 
0x401203, return 0x400203
[   30.523908] xhci_hcd 0000:60:00.0: clear port2 link state change, 
portsc: 0x1203
[   30.524884] xhci_hcd 0000:60:00.0: Get port status 10-2 read: 0x1203, 
return 0x203
[   30.553470] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.553860] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.554278] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.554667] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.555067] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.555454] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.555848] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.556160] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
30388 bytes untransferred
[   30.559697] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.560083] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.560484] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.560904] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.561290] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.561693] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.562079] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.562515] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.562876] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.563278] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.563678] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.564072] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.564466] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.564860] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.565263] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.565666] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.566067] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.566455] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.566847] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.567251] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.567652] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.568055] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.568447] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.568847] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.569229] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.569640] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.570040] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.570443] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.570834] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.571217] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.571615] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.572028] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.572428] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.572831] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.573205] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.573611] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.574028] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.574416] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.574817] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.575204] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.575599] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.576015] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.576402] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.576804] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.577204] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.577583] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.577983] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.578402] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.578776] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.579191] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.579578] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.579980] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.580387] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.580777] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.581177] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.581584] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.581967] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.582361] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.582762] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.583165] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.583552] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.583946] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.584351] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.584764] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.585150] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.585540] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.585946] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.586338] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.586736] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.587138] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.587538] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.587941] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.588323] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.588723] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.589114] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.589527] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.589927] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.590334] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.590708] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.591022] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
30468 bytes untransferred
[   30.594565] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.594947] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.595346] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.595750] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.596152] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.596553] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.596940] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.597333] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.597735] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.598138] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.598538] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.598941] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.599327] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.599731] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.600112] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.600526] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.600927] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.601330] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.601720] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.602099] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.602512] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.602915] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.603302] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.603704] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.604096] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.604513] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.604913] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.605303] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.605695] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.606082] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.606482] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.606901] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.607288] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.607691] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.608070] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.608480] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.608869] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.609276] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.609690] xhci_hcd 0000:60:00.0: ep 0x83 - asked for 32768 bytes, 
16388 bytes untransferred
[   30.610065] xhci_hcd 0000:60:00.0: ERROR Transfer event TRB DMA ptr 
not part of current TD ep_index 6 comp_code 13
[   30.610071] xhci_hcd 0000:60:00.0: Looking for event-dma 
00000000fffb8010 trb-start 00000000fffb9fe0 trb-end 00000000fffb9fe0 
seg-start 00000000fffb9000 seg-end 00000000fffb9ff0
[   30.610433] xhci_hcd 0000:60:00.0: ERROR Transfer event TRB DMA ptr 
not part of current TD ep_index 6 comp_code 1
[   30.610437] xhci_hcd 0000:60:00.0: Looking for event-dma 
00000000fffb8020 trb-start 00000000fffb9fe0 trb-end 00000000fffb9fe0 
seg-start 00000000fffb9000 seg-end 00000000fffb9ff0
[   30.610469] xhci_hcd 0000:60:00.0: ERROR Transfer event TRB DMA ptr 
not part of current TD ep_index 6 comp_code 13
[   30.610473] xhci_hcd 0000:60:00.0: Looking for event-dma 
00000000fffb8030 trb-start 00000000fffb9fe0 trb-end 00000000fffb9fe0 
seg-start 00000000fffb9000 seg-end 00000000fffb9ff0
[   30.767918] xhci_hcd 0000:60:00.0: xhci_hub_status_data: stopping 
port polling.

Do you have any idea what might cause this, or any suggestions how I can 
debug this further?

Thank you in advance!

Best regards,
Ole