Random disconnection on 17.01
Username: Emmanuel Lepage Vallée
Origin: https://bugs.openwrt.org/index.php?do=details&task_id=600
Problem:
I upgrade my router from some years old dd-wrt to LEDE. “It works” and both the throughput and latency are vastly superior. However, it disconnect every couple hours for 2 minutes. Both my phone and my thinkpad are affected, so it is not a suddent regression in the client side. The old firmware showed no such interruption and could run a single connection TCP for months. At first, all packets stop being received and all sent timeout. After a while NetworkManager drop the (dead) Wifi conenction. Restarting networkmanager doesn’t restore the connection, only time does. The encryption and channel are the same as before.
Info:
Hostname LEDE Model D-Link DIR-615 rev. I1 Firmware Version LEDE Reboot 17.01.0 r3205-59508e30 / LuCI lede-17.01 branch (git-17.051.53299-a100738) Kernel Version 4.4.50
SSHed into the rounter show nothing interesting in dmesg or the logs.
dmesg (client side)
[1750975.095083] wlp3s0: authenticate with c8:d3:a3:57:c1:0d [1750975.097291] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 1/3) [1750975.182387] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 2/3) [1750975.340969] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 3/3) [1750975.433683] wlp3s0: authentication with c8:d3:a3:57:c1:0d timed out [1750986.745947] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1750986.783926] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1750986.784247] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1750986.973972] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1750986.974238] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1750986.988274] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1751024.037294] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1751024.037564] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1751024.232261] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1751024.232531] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1751024.246198] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1751035.933932] wlp3s0: authenticate with c8:d3:a3:57:c1:0d [1751035.936358] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 1/3) [1751035.941892] wlp3s0: authenticated [1751035.942083] wlp3s0: associate with c8:d3:a3:57:c1:0d (try 1/3) [1751035.946355] wlp3s0: RX AssocResp from c8:d3:a3:57:c1:0d (capab=0x431 status=0 aid=1) [1751035.947757] wlp3s0: associated [1751035.947784] IPv6: ADDRCONF(NETDEV_CHANGE): wlp3s0: link becomes ready [1753524.568775] iwlwifi 0000:03:00.0: invalid BA notification: Q 16, tid 0, flow 65535 [1754028.350307] wlp3s0: deauthenticating from c8:d3:a3:57:c1:0d by local choice (Reason: 3=DEAUTH_LEAVING) [1754029.418400] IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready [1754029.423879] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754029.435347] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754029.435766] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754029.643875] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754029.644146] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754029.658379] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754029.708225] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754033.134519] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754033.134793] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754033.338532] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754033.338803] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754033.352845] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754058.434794] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754058.447119] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754058.447392] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754058.645058] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754058.645328] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754058.659098] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754062.836641] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754062.836915] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754063.041653] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754063.041914] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754063.055581] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754063.070786] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754066.513509] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754066.513776] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754066.712341] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754066.712663] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754066.727003] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754082.615329] wlp3s0: authenticate with c8:d3:a3:57:c1:0d [1754082.617891] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 1/3) [1754082.711318] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 2/3) [1754082.800197] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 3/3) [1754082.890379] wlp3s0: authentication with c8:d3:a3:57:c1:0d timed out [1754092.431334] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754092.442752] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754092.443037] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754092.642763] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754092.643027] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754092.657436] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754096.103393] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754096.103667] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754096.305383] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754096.305650] iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled [1754096.320213] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready [1754099.851495] wlp3s0: authenticate with c8:d3:a3:57:c1:0d [1754099.853971] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 1/3) [1754100.000973] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 2/3) [1754100.100010] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 3/3) [1754100.234954] wlp3s0: authentication with c8:d3:a3:57:c1:0d timed out [1754104.050494] wlp3s0: authenticate with c8:d3:a3:57:c1:0d [1754104.052754] wlp3s0: send auth to c8:d3:a3:57:c1:0d (try 1/3) [1754104.126844] wlp3s0: authenticated [1754104.127569] wlp3s0: associate with c8:d3:a3:57:c1:0d (try 1/3) [1754104.135916] wlp3s0: RX AssocResp from c8:d3:a3:57:c1:0d (capab=0x431 status=0 aid=1) [1754104.138461] wlp3s0: associated [1754104.138810] IPv6: ADDRCONF(NETDEV_CHANGE): wlp3s0: link becomes ready
What should I do to further debug this? I can build new images if necessary.