You are not logged in.

Pages: 1

#1 2024-04-17 10:15:54

Ich Kaz
Member
Registered: 2024-04-17
Posts: 4

[Solved]WiFi disconnected every 10-20 min, completed -> authenticating

Hello. I am a uni student and when I am connected to uni WiFi, my laptop is disconnected like every 10-20 min ( sometimes every 5min), which is very frustrating.

When I find myself disconnected, I push disconnect button and then connect button on GUI (I'm on KDE) and it is successfully connected until it is suddenly disconnected again. The journalctl log shows "supplicant interface state: completed -> authenticating" when the disconnection happens. I dual boot Windows and this does not happen in Windows. Also, this does not happen in my home WiFi.

I am not familiar with networking and I would like to know the cause of this, and/or workaround.  Thanks in advance!

Environment:
- ThinkPad X1 Carbon Gen10
- Almost vanilla NetworkManager with only dhcp backend changed to dhcpcd.

Journalctl -u NetworkManager:

Apr 17 18:05:57 programming NetworkManager[1255]: <info>  [1713344757.2946] manager: NetworkManager state is now CONNECTED_GLOBAL
### Suddenly my PC is not able to connect to the internet. ###
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.1442] device (wlan0): supplicant interface state: completed -> authenticating
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.1442] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.1765] device (wlan0): supplicant interface state: authenticating -> associating
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.1765] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2051] device (wlan0): supplicant interface state: associating -> completed
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2055] device (wlan0): ip:dhcp4: restarting
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2055] dhcp4 (wlan0): canceled DHCP transaction, DHCP client pid 1602600
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2055] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2055] dhcp4 (wlan0): state changed no lease
Apr 17 18:31:12 programming dhcpcd[1602601]: received SIGTERM, stopping
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2056] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Apr 17 18:31:12 programming dhcpcd[1602601]: wlan0: removing interface
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2069] dhcp4 (wlan0): dhcpcd started with pid 1615039
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2070] device (p2p-dev-wlan0): supplicant management interface state: associating -> completed
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2089] dhcp4 (wlan0): client pid 1615039 exited with status 0
Apr 17 18:31:12 programming NetworkManager[1255]: <info>  [1713346272.2089] dhcp4 (wlan0): state changed no lease
Apr 17 18:31:12 programming NetworkManager[1255]: <warn>  [1713346272.2790] dhcp-listener: dhcp-event: (pid 1602600) unhandled DHCP event for interface wlan0
Apr 17 18:31:12 programming NetworkManager[1255]: <warn>  [1713346272.2909] dhcp-listener: dhcp-event: (pid 1602600) unhandled DHCP event for interface wlan0
Apr 17 18:31:12 programming dhcpcd[1602601]: dhcpcd exited
### Here, I noticed network disconnection and from GUI, I pushed disconnect button and then connect button. ###
Apr 17 18:31:23 programming NetworkManager[1255]: <info>  [1713346283.1731] audit: op="statistics" interface="wlan0" ifindex=2 args="2000" pid=1087847 uid=1000 result="success"
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.5256] device (wlan0): state change: activated -> deactivating (reason 'user-requested', sys-iface-state: 'managed')
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.5262] manager: NetworkManager state is now DISCONNECTING
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.5280] audit: op="device-disconnect" interface="wlan0" ifindex=2 pid=1087847 uid=1000 result="success"
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.5797] audit: op="statistics" interface="wlan0" ifindex=2 args="0" pid=1087847 uid=1000 result="success"
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.7945] device (wlan0): supplicant interface state: completed -> disconnected
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.7946] device (p2p-dev-wlan0): supplicant management interface state: completed -> disconnected
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.7952] device (wlan0): state change: deactivating -> disconnected (reason 'user-requested', sys-iface-state: 'managed')
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.7958] dhcp4 (wlan0): canceled DHCP transaction
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.7959] dhcp4 (wlan0): state changed no lease
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.8840] device (wlan0): set-hw-addr: set MAC address to [MAC address of my PC] (scanning)
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.8931] manager: NetworkManager state is now DISCONNECTED
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.8957] device (wlan0): supplicant interface state: disconnected -> interface_disabled
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.8958] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> interface_disabled
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.8975] device (wlan0): supplicant interface state: interface_disabled -> disconnected
Apr 17 18:31:25 programming NetworkManager[1255]: <info>  [1713346285.8975] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> disconnected
Apr 17 18:31:26 programming NetworkManager[1255]: <info>  [1713346286.2825] device (wlan0): Activation: starting connection '[SSID of my wifi]' ([UUID])
Apr 17 18:31:26 programming NetworkManager[1255]: <info>  [1713346286.2827] audit: op="connection-activate" uuid="[UUID]" name="[SSID of my wifi]" pid=1087847 uid=1000 result="success"
Apr 17 18:31:26 programming NetworkManager[1255]: <info>  [1713346286.2829] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Apr 17 18:31:26 programming NetworkManager[1255]: <info>  [1713346286.2834] manager: NetworkManager state is now CONNECTING

Last edited by Ich Kaz (2024-04-25 14:17:09)

Offline

#2 2024-04-17 10:41:32

V1del
Forum Moderator
Registered: 2012-10-16
Posts: 21,821

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

Since it has an issue with the DHCP transaction, have you tried not changing NetworkManagers dhcp backend and just relying on the internal implementation? Also for completeness sake: 

find /etc/systemd -type l -exec test -f {} \; -print | awk -F'/' '{ printf ("%-40s | %s\n", $(NF-0), $(NF-1)) }' | sort -f

Offline

#3 2024-04-17 14:46:23

Ich Kaz
Member
Registered: 2024-04-17
Posts: 4

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

Thank you for your reply!

After seeing your message, I changed to the default backend and the log is the following. Sudden change to authenticating still happens but the connection is recovered seamlessly, which is what I desired.

The reason I have been using dhcpcd backend is that one of the uni WiFis requires broadcast flag to be enabled so that DHCP Offer is broadcasted. The setting I found only in dhcpcd. Is there a way to do it for NetworkManager's default dhcp backend? If not, I might go with the default backend and switch to dhcpcd when necessary...

journalctl -u NetworkManager:

Apr 17 21:47:15 programming NetworkManager[1680300]: <info>  [1713358035.2470] dhcp4 (wlan0): state changed new lease, address=[IP address]
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.0522] device (wlan0): supplicant interface state: completed -> authenticating
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.0522] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.0826] device (wlan0): supplicant interface state: authenticating -> associating
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.0827] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1047] device (wlan0): supplicant interface state: associating -> 4way_handshake
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1048] device (p2p-dev-wlan0): supplicant management interface state: associating -> 4way_handshake
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1135] device (wlan0): supplicant interface state: 4way_handshake -> completed
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1139] device (wlan0): ip:dhcp4: restarting
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1140] dhcp4 (wlan0): canceled DHCP transaction
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1140] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1140] dhcp4 (wlan0): state changed no lease
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1140] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1141] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1224] dhcp4 (wlan0): state changed new lease, address=[IP address], acd pending
Apr 17 22:02:26 programming NetworkManager[1680300]: <info>  [1713358946.1225] dhcp4 (wlan0): state changed new lease, address=[IP address]
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8223] device (wlan0): supplicant interface state: completed -> authenticating
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8224] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8530] device (wlan0): supplicant interface state: authenticating -> associating
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8530] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8830] device (wlan0): supplicant interface state: associating -> completed
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8837] device (wlan0): ip:dhcp4: restarting
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8837] dhcp4 (wlan0): canceled DHCP transaction
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8837] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8838] dhcp4 (wlan0): state changed no lease
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8838] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8840] device (p2p-dev-wlan0): supplicant management interface state: associating -> completed
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8954] dhcp4 (wlan0): state changed new lease, address=[IP address], acd pending
Apr 17 22:07:28 programming NetworkManager[1680300]: <info>  [1713359248.8956] dhcp4 (wlan0): state changed new lease, address=[IP address]
Apr 17 22:12:31 programming NetworkManager[1680300]: <info>  [1713359551.6532] device (wlan0): supplicant interface state: completed -> authenticating

find /etc/systemd -type l -exec test -f {} \; -print | awk -F'/' '{ printf ("%-40s | %s\n", $(NF-0), $(NF-1)) }' | sort -f:

cups.path                                | multi-user.target.wants
cups.service                             | multi-user.target.wants
cups.service                             | printer.target.wants
cups.socket                              | sockets.target.wants
dbus-org.freedesktop.nm-dispatcher.service | system
dbus-org.freedesktop.timesync1.service   | system
display-manager.service                  | system
getty@tty1.service                       | getty.target.wants
NetworkManager-wait-online.service       | network-online.target.wants
NetworkManager.service                   | multi-user.target.wants
p11-kit-server.socket                    | sockets.target.wants
pipewire-media-session.service           | pipewire.service.wants
pipewire-session-manager.service         | user
pipewire.socket                          | sockets.target.wants
pulseaudio.socket                        | sockets.target.wants
remote-fs.target                         | multi-user.target.wants
systemd-timesyncd.service                | sysinit.target.wants
tlp.service                              | multi-user.target.wants
var-lib-snapd-snap-bare-5.mount          | multi-user.target.wants
var-lib-snapd-snap-bare-5.mount          | snapd.mounts.target.wants
var-lib-snapd-snap-coq\x2dprover-33.mount | multi-user.target.wants
var-lib-snapd-snap-coq\x2dprover-33.mount | snapd.mounts.target.wants
var-lib-snapd-snap-core20-2105.mount     | multi-user.target.wants
var-lib-snapd-snap-core20-2105.mount     | snapd.mounts.target.wants
var-lib-snapd-snap-gnome\x2d3\x2d38\x2d2004-143.mount | multi-user.target.wants
var-lib-snapd-snap-gnome\x2d3\x2d38\x2d2004-143.mount | snapd.mounts.target.wants
var-lib-snapd-snap-gtk\x2dcommon\x2dthemes-1535.mount | multi-user.target.wants
var-lib-snapd-snap-gtk\x2dcommon\x2dthemes-1535.mount | snapd.mounts.target.wants
var-lib-snapd-snap-snapd-20290.mount     | multi-user.target.wants
var-lib-snapd-snap-snapd-20290.mount     | snapd.mounts.target.wants
vmware-networks.service                  | multi-user.target.wants
vmware-usbarbitrator.service             | multi-user.target.wants
xdg-user-dirs-update.service             | default.target.wants

Offline

#4 2024-04-17 15:33:09

V1del
Forum Moderator
Registered: 2012-10-16
Posts: 21,821

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

Two random things to try, try disabling wifi adapter power saving in TLP and maybe check behaviour without vmware-networks running.

Offline

#5 2024-04-17 15:46:33

seth
Member
Registered: 2012-09-03
Posts: 51,802

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

Please don't post random journal lines out of context, that's not even the entire NM output.
Please post your complete system journal for a boot covering the incident: 

sudo journalctl -b | curl -F 'file=@-' 0x0.st # for the current one

tlp and vmware could get in the way here - could also be the wifi module-

Probably unrelated: You most likely want to install pipewire-pulse (instead of pulseaudio) and wireplumber (instead of pipewire-media-session)

Edit: F5…

Last edited by seth (2024-04-17 15:46:51)

How to upload text · How to boot w/o GUI · Disable Windows Fast-Start! · Fix your xinitrc

Offline

#6 2024-04-22 08:58:26

Ich Kaz
Member
Registered: 2024-04-17
Posts: 4

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

I'm sorry for such a late reply. I have not been able to access uni. WiFi to test your suggestions.

V1del, thanks for your suggestions. I tried "WIFI_PWR_ON_BAT=off" for tlp setting and disabling "wifi.powersave = 2" setting for NetworkManager which I had enabled in the past, as well as disabling vmware-networks. Unfortunately, the problem (WiFi connection changing to authenticating) still persists.

seth, thank you for your attention on this. I have uploaded complete system journal to https://0x0.st/XoGg.txt . The journal was taken as soon as the problem occured. Also, thanks for the suggestions for pipewire-pulse and wireplumber. I'll look into those!

Offline

#7 2024-04-22 13:50:03

seth
Member
Registered: 2012-09-03
Posts: 51,802

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

Apr 22 17:24:49 programming wpa_supplicant[1362]: wlan0: Trying to associate with a8:9d:21:3a:85:1b (SSID='ist_members' freq=5320 MHz)
Apr 22 17:29:52 programming wpa_supplicant[1362]: wlan0: SME: Trying to authenticate with 74:a2:e6:a7:a4:eb (SSID='ist_members' freq=5500 MHz)

There two 5GHz APs w/ the same SSID on slightly different channels.

Apr 22 17:24:49 programming wpa_supplicant[1362]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-59 noise=9999 txrate=26000
Apr 22 17:29:52 programming wpa_supplicant[1362]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-60 noise=9999 txrate=1000
Apr 22 17:30:40 programming wpa_supplicant[1362]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-59 noise=9999 txrate=1000

Signal is constant, not great but also not terrible.

There five failed conection attempts

Apr 22 17:24:41 programming NetworkManager[1264]: <info>  [1713774281.6669] device (wlan0): state change: need-auth -> failed (reason 'no-secrets', sys-iface-state: 'managed')
Apr 22 17:24:41 programming NetworkManager[1264]: <info>  [1713774281.6671] manager: NetworkManager state is now DISCONNECTED

likely https://wiki.archlinux.org/title/Networ … et_on_boot

Finally

Apr 22 17:24:49 programming kernel: wlan0: Limiting TX power to 9 dBm as advertised by a8:9d:21:3a:85:1b
…
Apr 22 17:24:50 programming NetworkManager[1264]: <info>  [1713774290.5999] manager: NetworkManager state is now CONNECTED_GLOBAL
…
Apr 22 17:29:52 programming wpa_supplicant[1362]: wlan0: SME: Trying to authenticate with 74:a2:e6:a7:a4:eb (SSID='ist_members' freq=5500 MHz)
…
Apr 22 17:30:38 programming NetworkManager[1264]: <info>  [1713774638.1071] dhcp4 (wlan0): canceled DHCP transaction
Apr 22 17:30:38 programming NetworkManager[1264]: <info>  [1713774638.1071] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Apr 22 17:30:38 programming NetworkManager[1264]: <info>  [1713774638.1071] dhcp4 (wlan0): state changed no lease
…
Apr 22 17:30:38 programming NetworkManager[1264]: <info>  [1713774638.0414] device (wlan0): state change: activated -> failed (reason 'ip-config-unavailable', sys-iface-state: 'managed')
Apr 22 17:30:38 programming NetworkManager[1264]: <info>  [1713774638.0422] manager: NetworkManager state is now DISCONNECTED
Apr 22 17:30:38 programming kernel: wlan0: deauthenticating from 74:a2:e6:a7:a4:eb by local choice (Reason: 3=DEAUTH_LEAVING)
…
Apr 22 17:30:40 programming wpa_supplicant[1362]: wlan0: Associated with 74:a2:e6:a7:a4:eb

So what happens is you were connected to a8:9d:21:3a:85:1b then NM figured 74:a2:e6:a7:a4:eb looks prettier, but initially gets no lease but then one (after a decent dhcp timeout) on the subsequent connection to 74:a2:e6:a7:a4:eb
=> try to lock the BSSID, https://wiki.archlinux.org/title/Networ … ets_(WiFi)

How to upload text · How to boot w/o GUI · Disable Windows Fast-Start! · Fix your xinitrc

Offline

#8 2024-04-24 08:18:36

Ich Kaz
Member
Registered: 2024-04-17
Posts: 4

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

I locked  BSSID and the problem disappeared. Thank you!

Offline

#9 2024-04-24 12:21:46

seth
Member
Registered: 2012-09-03
Posts: 51,802

Re: [Solved]WiFi disconnected every 10-20 min, completed -> authenticating

\o/
Please always remember to mark resolved threads by editing your initial posts subject - so others will know that there's no task left, but maybe a solution to find.
Thanks.

How to upload text · How to boot w/o GUI · Disable Windows Fast-Start! · Fix your xinitrc

Offline

Pages: 1

Board footer

Powered by FluxBB