Bug 214097

Summary: rtw_8822ce drops connection randomly
Product: Networking Reporter: Łukasz Żarnowiecki (lukasz)
Component: WirelessAssignee: networking_wireless (networking_wireless)
Status: NEW ---    
Severity: high CC: pavel.pyshkin, someuniquename
Priority: P1    
Hardware: Intel   
OS: Linux   
Kernel Version: 5.13.10 Subsystem:
Regression: No Bisected commit-id:
Attachments: lspci

Description Łukasz Żarnowiecki 2021-08-18 15:22:32 UTC
Created attachment 298349 [details]
lspci

Hello,

I noticed a problem with my rtw_8822ce wifi recently, it drops connection randomly.  Hard reboot is required.  From NetworkManager it looks like it is connected, but there is no internet connection.

In dmesg I have:
[  521.400458] rtw_8822ce 0000:01:00.0: AMD-Vi: Event logged [IO_PAGE_FAULT domain=0x0009 address=0xfbc81414 flags=0x0000]

When I am reconnection with NetworkManager in dmesg I have lots of these
[  629.991505] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]

but from logs you can observe that it is in fact connected

Full log:
[   45.038243] rtw_8822ce 0000:01:00.0: enabling device (0000 -> 0003)
[   45.044230] rtw_8822ce 0000:01:00.0: Firmware version 9.9.4, H2C version 15
[   45.044485] rtw_8822ce 0000:01:00.0: Firmware version 9.9.10, H2C version 15
[   45.282040] rtw_8822ce 0000:01:00.0 wlp1s0: renamed from wlan0
[   46.264046] rtw_8822ce 0000:01:00.0: start vif 28:cd:c4:6b:a5:37 on port 0
[   46.265701] rtw_8822ce 0000:01:00.0: stop vif 28:cd:c4:6b:a5:37 on port 0
[   46.493493] rtw_8822ce 0000:01:00.0: start vif de:2a:1e:61:0c:c0 on port 0
[   50.739107] rtw_8822ce 0000:01:00.0: stop vif de:2a:1e:61:0c:c0 on port 0
[   50.967006] rtw_8822ce 0000:01:00.0: start vif 28:cd:c4:6b:a5:37 on port 0
[   50.971579] rtw_8822ce 0000:01:00.0: stop vif 28:cd:c4:6b:a5:37 on port 0
[   51.205701] rtw_8822ce 0000:01:00.0: start vif a6:28:ed:35:f0:f0 on port 0
[   55.285903] rtw_8822ce 0000:01:00.0: stop vif a6:28:ed:35:f0:f0 on port 0
[   55.515710] rtw_8822ce 0000:01:00.0: start vif 28:cd:c4:6b:a5:37 on port 0
[   60.163246] rtw_8822ce 0000:01:00.0: sta 5a:ef:68:a6:25:96 joined with macid 0
[  521.400458] rtw_8822ce 0000:01:00.0: AMD-Vi: Event logged [IO_PAGE_FAULT domain=0x0009 address=0xfbc81414 flags=0x0000]
[  629.991505] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  629.991610] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  629.991746] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  629.991844] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  630.262274] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  630.262383] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  630.262481] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  630.262611] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  630.262710] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  630.262808] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  630.535608] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  630.535724] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  630.535832] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  630.536046] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  630.536152] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  630.536319] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  630.805493] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  630.805605] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  630.805711] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  630.805850] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  630.805956] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  630.806061] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.075730] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.075905] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.076020] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.076190] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.076301] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.076411] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.345485] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.345591] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.345690] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.345819] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.345918] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.346016] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.611191] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.611304] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.611408] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.619071] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.619186] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.619329] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.619462] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.619603] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.619716] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.758882] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.759001] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.759101] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.759170] rtw_8822ce 0000:01:00.0: sta 5a:ef:68:a6:25:96 with macid 0 left
[  631.759969] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.760085] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.760192] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.806738] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[1]
[  631.806848] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[3]
[  631.806951] rtw_8822ce 0000:01:00.0: timed out to flush pci tx ring[5]
[  631.807875] rtw_8822ce 0000:01:00.0: stop vif 28:cd:c4:6b:a5:37 on port 0
[  632.045414] rtw_8822ce 0000:01:00.0: start vif 1e:1d:ec:3c:e2:36 on port 0
[  638.202205] rtw_8822ce 0000:01:00.0: stop vif 1e:1d:ec:3c:e2:36 on port 0
[  638.433525] rtw_8822ce 0000:01:00.0: start vif 28:cd:c4:6b:a5:37 on port 0
[  642.517419] wlp1s0: authenticate with 5a:ef:68:a6:25:96
[  642.828846] wlp1s0: send auth to 5a:ef:68:a6:25:96 (try 1/3)
[  642.855321] wlp1s0: authenticated
[  642.862073] wlp1s0: associate with 5a:ef:68:a6:25:96 (try 1/3)
[  642.880388] wlp1s0: RX AssocResp from 5a:ef:68:a6:25:96 (capab=0x11 status=0 aid=3)
[  642.880423] rtw_8822ce 0000:01:00.0: sta 5a:ef:68:a6:25:96 joined with macid 0
[  642.880750] wlp1s0: associated
[  643.010990] IPv6: ADDRCONF(NETDEV_CHANGE): wlp1s0: link becomes ready
Comment 1 Roman Evstifeev 2022-01-15 09:01:22 UTC
Originally reported here: https://github.com/lwfinger/rtw88/issues/61
Comment 2 Roman Evstifeev 2022-01-15 09:02:31 UTC
Whoops, i accidentally  submitted my message to the wrong bugreport ^^
Comment 3 Pavlо Pуshkіn 2022-08-20 01:35:26 UTC
I have a long time problem on my laptop HP ProBook 455 G7. Wifi connection suddenly stops after some time after boot. This time can be relatively long (2-3 days). Only reboot can restore wifi connection. I use LinuxMint20.2.

I noticed that for kernels before 5.17 the problem was much worse: wifi stopped even during using speedtest site. It was like wifi card could not transfer big amount of data with big speed (so, my solution was to buy another slow router). Also, bluetooth didn't work properly in kernels older than 5.17 (frequent loss of connection). 
After 5.17 Kernel situation became much better. Now I use hi-speed 5GHz wifi, stable bluetooth headphones. However, still I need to reboot laptop from time to time after wifi randomly stops after 1 hour - 3 days of stable working.

The output of "sudo dmesg" command after recent wifi stopping (I don't write repeated lines before and after), LinuxMint20.2, manually compiled kernel 5.19.1:



[238971.462080] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[5]
[238971.462206] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[1]
[238971.462307] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[3]
[238971.462406] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[5]
[238971.801858] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[1]
[238971.801964] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[3]
[238971.802063] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[5]
[238971.802187] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[1]
[238971.802288] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[3]
[238971.802387] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[5]
[238989.885874] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[1]
[238989.885986] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[3]
[238989.886092] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[5]
[238998.188837] wlp2s0: deauthenticated from 6c:ba:b8:36:eb:06 (Reason: 2=PREV_AUTH_NOT_VALID)
[238998.201933] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[1]
[238998.202028] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[3]
[238998.202119] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[5]
[238998.211890] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[1]
[238998.211987] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[3]
[238998.212077] rtw_8822ce 0000:02:00.0: timed out to flush pci tx ring[5]
[238998.602436] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[238998.921851] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[238999.949809] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 2/3)
[239000.973831] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 3/3)
[239001.933763] wlp2s0: authentication with 6c:ba:b8:36:eb:06 timed out
[239012.480873] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[239012.797847] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[239013.018684] wlp2s0: aborting authentication with 6c:ba:b8:36:eb:06 by local choice (Reason: 3=DEAUTH_LEAVING)
[239017.214291] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[239017.533839] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[239018.957822] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 2/3)
[239019.949821] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 3/3)
[239020.941763] wlp2s0: authentication with 6c:ba:b8:36:eb:06 timed out
[239031.251785] wlp2s0: authenticate with 6c:ba:b8:36:eb:00
[239031.251802] wlp2s0: bad VHT capabilities, disabling VHT
[239031.735335] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 1/3)
[239032.973798] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 2/3)
[239033.933806] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 3/3)
[239034.957754] wlp2s0: authentication with 6c:ba:b8:36:eb:00 timed out
[239046.200393] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[239046.679338] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[239047.953804] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 2/3)
[239048.941835] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 3/3)
[239049.937760] wlp2s0: authentication with 6c:ba:b8:36:eb:06 timed out
[239060.251215] wlp2s0: authenticate with 6c:ba:b8:36:eb:00
[239060.251232] wlp2s0: bad VHT capabilities, disabling VHT
[239060.751341] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 1/3)
[239061.965801] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 2/3)
[239062.957805] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 3/3)
[239063.981755] wlp2s0: authentication with 6c:ba:b8:36:eb:00 timed out
[239075.183944] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[239075.663333] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[239076.941804] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 2/3)
[239077.970195] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 3/3)
[239078.989764] wlp2s0: authentication with 6c:ba:b8:36:eb:06 timed out
[239093.443419] wlp2s0: authenticate with 6c:ba:b8:36:eb:00
[239093.443437] wlp2s0: bad VHT capabilities, disabling VHT
[239093.801932] rtw_8822ce 0000:02:00.0: failed to do dpk calibration
[239093.927364] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 1/3)
[239094.925806] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 2/3)
[239095.949810] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 3/3)
[239096.973775] wlp2s0: authentication with 6c:ba:b8:36:eb:00 timed out
[239400.020191] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[239400.429919] rtw_8822ce 0000:02:00.0: failed to do dpk calibration
[239400.495304] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[239401.933798] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 2/3)
[239402.925825] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 3/3)
[239403.985755] wlp2s0: authentication with 6c:ba:b8:36:eb:06 timed out
[239415.203459] wlp2s0: authenticate with 6c:ba:b8:36:eb:00
[239415.203471] wlp2s0: bad VHT capabilities, disabling VHT
[239415.687338] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 1/3)
[239416.977805] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 2/3)
[239417.966047] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 3/3)
[239418.957770] wlp2s0: authentication with 6c:ba:b8:36:eb:00 timed out
[239429.255524] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[239429.743342] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[239430.957801] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 2/3)
[239431.949827] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 3/3)
[239432.941760] wlp2s0: authentication with 6c:ba:b8:36:eb:06 timed out
[239443.259603] wlp2s0: authenticate with 6c:ba:b8:36:eb:00
[239443.259624] wlp2s0: bad VHT capabilities, disabling VHT
[239443.759336] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 1/3)
[239444.941806] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 2/3)
[239445.933805] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 3/3)
[239446.989780] wlp2s0: authentication with 6c:ba:b8:36:eb:00 timed out
[239456.204548] wlp2s0: authenticate with 6c:ba:b8:36:eb:06
[239456.617948] rtw_8822ce 0000:02:00.0: failed to do dpk calibration
[239456.679312] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 1/3)
[239457.969798] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 2/3)
[239458.989830] wlp2s0: send auth to 6c:ba:b8:36:eb:06 (try 3/3)
[239459.949757] wlp2s0: authentication with 6c:ba:b8:36:eb:06 timed out
[239470.151360] wlp2s0: authenticate with 6c:ba:b8:36:eb:00
[239470.151377] wlp2s0: bad VHT capabilities, disabling VHT
[239470.635340] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 1/3)
[239471.981804] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 2/3)
[239472.973808] wlp2s0: send auth to 6c:ba:b8:36:eb:00 (try 3/3)
[239473.965765] wlp2s0: authentication with 6c:ba:b8:36:eb:00 timed out