You are not logged in.

#1 2022-08-12 11:51:29

laudin
Member
Registered: 2017-01-28
Posts: 16

NetworkManager not connecting to one specific wifi network

I have the problem that my laptop is not able to connect to one specific wifi network. Other networks work without problems.
The network manager tries to connect, that takes some time and afterwards it again asks for the password. If I enter the password there the same procedure starts again.
I have no idea what is going wrong or how to investigate further.

Below the related logs:

sudo journalctl -fu wpa_supplicant.service

Aug 12 13:40:47 chris-msi-laptop wpa_supplicant[1238]: wlan0: SME: Trying to authenticate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:40:47 chris-msi-laptop wpa_supplicant[1238]: wlan0: Trying to associate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:40:49 chris-msi-laptop wpa_supplicant[1238]: wlan0: SME: Trying to authenticate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:40:49 chris-msi-laptop wpa_supplicant[1238]: wlan0: Trying to associate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:41:00 chris-msi-laptop wpa_supplicant[1238]: wlan0: SME: Trying to authenticate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:41:00 chris-msi-laptop wpa_supplicant[1238]: wlan0: Trying to associate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:41:03 chris-msi-laptop wpa_supplicant[1238]: wlan0: SME: Trying to authenticate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:41:03 chris-msi-laptop wpa_supplicant[1238]: wlan0: Trying to associate with 98:da:c4:96:e5:7e (SSID='UnserNetzAC' freq=2412 MHz)
Aug 12 13:41:03 chris-msi-laptop wpa_supplicant[1238]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="UnserNetzAC" auth_failures=1 duration=10 reason=CONN_FAILED
Aug 12 13:41:17 chris-msi-laptop wpa_supplicant[1238]: wlan0: WPS-CANCEL

sudo journalctl -fu NetworkManager.service

Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3110] device (wlan0): Activation: starting connection 'UnserNetzAC 1' (45fb36c6-da70-4191-bb77-b073714798dd)
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3112] audit: op="connection-activate" uuid="45fb36c6-da70-4191-bb77-b073714798dd" name="UnserNetzAC 1" pid=2190 uid=1000 result="success"
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3114] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3119] manager: NetworkManager state is now CONNECTING
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3168] device (wlan0): set-hw-addr: reset MAC address to 74:D8:3E:CE:BD:14 (preserve)
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3231] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3235] device (wlan0): Activation: (wifi) access point 'UnserNetzAC 1' has security, but secrets are required.
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3236] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3255] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3259] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3263] device (wlan0): Activation: (wifi) connection 'UnserNetzAC 1' has security, and secrets exist.  No new secrets needed.
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3264] Config: added 'ssid' value 'UnserNetzAC'
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3264] Config: added 'scan_ssid' value '1'
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3264] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3265] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK SAE FT-SAE'
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3265] Config: added 'auth_alg' value 'OPEN'
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3265] Config: added 'psk' value '<hidden>'
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3907] device (wlan0): supplicant interface state: disconnected -> authenticating
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.3908] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> authenticating
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.4252] device (wlan0): supplicant interface state: authenticating -> associating
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.4253] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.8012] device (wlan0): supplicant interface state: associating -> disconnected
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.8013] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.9009] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 12 13:45:04 chris-msi-laptop NetworkManager[1097]: <info>  [1660304704.9010] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 12 13:45:06 chris-msi-laptop NetworkManager[1097]: <info>  [1660304706.9549] device (wlan0): supplicant interface state: scanning -> authenticating
Aug 12 13:45:06 chris-msi-laptop NetworkManager[1097]: <info>  [1660304706.9550] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating
Aug 12 13:45:06 chris-msi-laptop NetworkManager[1097]: <info>  [1660304706.9599] device (wlan0): supplicant interface state: authenticating -> associating
Aug 12 13:45:06 chris-msi-laptop NetworkManager[1097]: <info>  [1660304706.9599] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Aug 12 13:45:07 chris-msi-laptop NetworkManager[1097]: <info>  [1660304707.3109] device (wlan0): supplicant interface state: associating -> disconnected
Aug 12 13:45:07 chris-msi-laptop NetworkManager[1097]: <info>  [1660304707.3109] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 12 13:45:07 chris-msi-laptop NetworkManager[1097]: <info>  [1660304707.8112] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 12 13:45:07 chris-msi-laptop NetworkManager[1097]: <info>  [1660304707.8113] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 12 13:45:09 chris-msi-laptop NetworkManager[1097]: <info>  [1660304709.3200] device (wlan0): supplicant interface state: scanning -> authenticating
Aug 12 13:45:09 chris-msi-laptop NetworkManager[1097]: <info>  [1660304709.3201] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating
Aug 12 13:45:09 chris-msi-laptop NetworkManager[1097]: <info>  [1660304709.4277] device (wlan0): supplicant interface state: authenticating -> associating
Aug 12 13:45:09 chris-msi-laptop NetworkManager[1097]: <info>  [1660304709.4278] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Aug 12 13:45:09 chris-msi-laptop NetworkManager[1097]: <info>  [1660304709.7837] device (wlan0): supplicant interface state: associating -> disconnected
Aug 12 13:45:09 chris-msi-laptop NetworkManager[1097]: <info>  [1660304709.7838] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 12 13:45:10 chris-msi-laptop NetworkManager[1097]: <info>  [1660304710.7843] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 12 13:45:10 chris-msi-laptop NetworkManager[1097]: <info>  [1660304710.7844] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 12 13:45:12 chris-msi-laptop NetworkManager[1097]: <info>  [1660304712.0684] device (wlan0): supplicant interface state: scanning -> authenticating
Aug 12 13:45:12 chris-msi-laptop NetworkManager[1097]: <info>  [1660304712.0685] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating
Aug 12 13:45:12 chris-msi-laptop NetworkManager[1097]: <info>  [1660304712.0728] device (wlan0): supplicant interface state: authenticating -> associating
Aug 12 13:45:12 chris-msi-laptop NetworkManager[1097]: <info>  [1660304712.0728] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Aug 12 13:45:12 chris-msi-laptop NetworkManager[1097]: <info>  [1660304712.4318] device (wlan0): supplicant interface state: associating -> disconnected
Aug 12 13:45:12 chris-msi-laptop NetworkManager[1097]: <info>  [1660304712.4318] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 12 13:45:17 chris-msi-laptop NetworkManager[1097]: <info>  [1660304717.4339] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 12 13:45:17 chris-msi-laptop NetworkManager[1097]: <info>  [1660304717.4340] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 12 13:45:22 chris-msi-laptop NetworkManager[1097]: <info>  [1660304722.4903] device (wlan0): supplicant interface state: scanning -> authenticating
Aug 12 13:45:22 chris-msi-laptop NetworkManager[1097]: <info>  [1660304722.4904] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating
Aug 12 13:45:22 chris-msi-laptop NetworkManager[1097]: <info>  [1660304722.4951] device (wlan0): supplicant interface state: authenticating -> associating
Aug 12 13:45:22 chris-msi-laptop NetworkManager[1097]: <info>  [1660304722.4952] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Aug 12 13:45:22 chris-msi-laptop NetworkManager[1097]: <info>  [1660304722.8569] device (wlan0): supplicant interface state: associating -> disconnected
Aug 12 13:45:22 chris-msi-laptop NetworkManager[1097]: <info>  [1660304722.8569] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 12 13:45:29 chris-msi-laptop NetworkManager[1097]: <warn>  [1660304729.9888] device (wlan0): Activation: (wifi) association took too long
Aug 12 13:45:29 chris-msi-laptop NetworkManager[1097]: <info>  [1660304729.9889] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 12 13:45:29 chris-msi-laptop NetworkManager[1097]: <warn>  [1660304729.9895] device (wlan0): Activation: (wifi) asking for new secrets
Aug 12 13:45:32 chris-msi-laptop NetworkManager[1097]: <warn>  [1660304732.0304] device (wlan0): no secrets: User canceled the secrets request.
Aug 12 13:45:32 chris-msi-laptop NetworkManager[1097]: <info>  [1660304732.0305] device (wlan0): state change: need-auth -> failed (reason 'no-secrets', sys-iface-state: 'managed')
Aug 12 13:45:32 chris-msi-laptop NetworkManager[1097]: <info>  [1660304732.0309] manager: NetworkManager state is now CONNECTED_LOCAL
Aug 12 13:45:32 chris-msi-laptop NetworkManager[1097]: <info>  [1660304732.0343] device (wlan0): set-hw-addr: set MAC address to 36:34:83:D4:7C:0E (scanning)
Aug 12 13:45:32 chris-msi-laptop NetworkManager[1097]: <warn>  [1660304732.0398] device (wlan0): Activation: failed for connection 'UnserNetzAC 1'

Offline

#2 2022-08-12 15:11:13

twelveeighty
Member
From: Alberta, Canada
Registered: 2011-09-04
Posts: 1,096

Re: NetworkManager not connecting to one specific wifi network

Try a couple of things: 1) does the behavior change if you (on purpose) supply an incorrect password? 2) Try to establish if it's authentication that fails, or something completely different: connect to a network that works without problems and compare the logs, is there a clear point where you expect the authentication to happen and it fails? 3) Some (mostly private corporate) networks use custom certificates that have to be installed first, does this network come with specific instructions? 4) Examine your entire journal during a connection failure, not just wpa_supplicant and NetworkManager, perhaps there's another component that fails?

Offline

#3 2022-08-12 17:05:22

laudin
Member
Registered: 2017-01-28
Posts: 16

Re: NetworkManager not connecting to one specific wifi network

1): No, same behavior.
2):
NetworkManager:

Aug 12 18:54:41 chris-msi-laptop NetworkManager[1097]: <info>  [1660323281.9963] device (wlan0): Activation: starting connection 'UnserNetz5 1' (7b2bc0c3-b17a-4bb9-9340-b87a2e79e09d)
Aug 12 18:54:41 chris-msi-laptop NetworkManager[1097]: <info>  [1660323281.9965] audit: op="connection-activate" uuid="7b2bc0c3-b17a-4bb9-9340-b87a2e79e09d" name="UnserNetz5 1" pid=2190 uid=1000 result="success"
Aug 12 18:54:41 chris-msi-laptop NetworkManager[1097]: <info>  [1660323281.9967] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 12 18:54:41 chris-msi-laptop NetworkManager[1097]: <info>  [1660323281.9973] manager: NetworkManager state is now CONNECTING
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0033] device (wlan0): set-hw-addr: reset MAC address to 74:D8:3E:CE:BD:14 (preserve)
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0092] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0096] device (wlan0): Activation: (wifi) access point 'UnserNetz5 1' has security, but secrets are required.
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0096] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0099] sup-iface[83711e17138bb0f1,0,wlan0]: wps: type pbc start...
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0104] device (wlan0): supplicant interface state: disconnected -> interface_disabled
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0105] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> interface_disabled
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0118] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0124] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0130] device (wlan0): Activation: (wifi) connection 'UnserNetz5 1' has security, and secrets exist.  No new secrets needed.
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0130] Config: added 'ssid' value 'UnserNetz5'
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0130] Config: added 'scan_ssid' value '1'
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0131] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0131] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK SAE FT-SAE'
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0131] Config: added 'auth_alg' value 'OPEN'
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0131] Config: added 'psk' value '<hidden>'
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0663] device (wlan0): supplicant interface state: interface_disabled -> disconnected
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0664] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> disconnected
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0787] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 12 18:54:42 chris-msi-laptop NetworkManager[1097]: <info>  [1660323282.0788] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.3497] device (wlan0): supplicant interface state: scanning -> authenticating
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.3498] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.3862] device (wlan0): supplicant interface state: authenticating -> associating
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.3863] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.4490] device (wlan0): supplicant interface state: associating -> 4way_handshake
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.4491] device (p2p-dev-wlan0): supplicant management interface state: associating -> 4way_handshake
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.5906] device (wlan0): supplicant interface state: 4way_handshake -> completed
Aug 12 18:54:44 chris-msi-laptop NetworkManager[1097]: <info>  [1660323284.5907] device (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "UnserNetz5"

wpa_supplicant

Aug 12 18:54:35 chris-msi-laptop wpa_supplicant[1238]: wlan0: Reject scan trigger since one is already pending
Aug 12 18:54:42 chris-msi-laptop wpa_supplicant[1238]: wlan0: WPS-CANCEL
Aug 12 18:54:44 chris-msi-laptop wpa_supplicant[1238]: wlan0: SME: Trying to authenticate with 9c:c7:a6:28:d5:07 (SSID='UnserNetz5' freq=5280 MHz)
Aug 12 18:54:44 chris-msi-laptop wpa_supplicant[1238]: wlan0: Trying to associate with 9c:c7:a6:28:d5:07 (SSID='UnserNetz5' freq=5280 MHz)
Aug 12 18:54:44 chris-msi-laptop wpa_supplicant[1238]: wlan0: Associated with 9c:c7:a6:28:d5:07
Aug 12 18:54:44 chris-msi-laptop wpa_supplicant[1238]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Aug 12 18:54:44 chris-msi-laptop wpa_supplicant[1238]: wlan0: WPA: Key negotiation completed with 9c:c7:a6:28:d5:07 [PTK=CCMP GTK=TKIP]
Aug 12 18:54:44 chris-msi-laptop wpa_supplicant[1238]: wlan0: CTRL-EVENT-CONNECTED - Connection to 9c:c7:a6:28:d5:07 completed [id=0 id_str=]
Aug 12 18:54:44 chris-msi-laptop wpa_supplicant[1238]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-56 noise=9999 txrate=108000

3) No, normal home network, no special configuration.
4) Can not find any other log that differs between working and not working.

Offline

#4 2022-08-15 16:09:50

twelveeighty
Member
From: Alberta, Canada
Registered: 2011-09-04
Posts: 1,096

Re: NetworkManager not connecting to one specific wifi network

If you supply the purposely incorrect password and get the same result, it is entirely possible that you do not have the correct password, or there's characters in the password that get mangled/changed before they make it to NetworkManager. Are the connection logs identical when you try the 'proper' and incorrect password? Also make sure you remove the connection and any cached passwords before you do your tests, to take password caching out of the equation.

Offline

Board footer

Powered by FluxBB