On Mon, Aug 26, 2024 at 09:19:46PM +0200, Johannes Berg wrote: > On Mon, 2024-08-26 at 21:14 +0200, Johannes Berg wrote: > > On Mon, 2024-08-26 at 15:06 -0400, Alan Stern wrote: > > > > > > Is there any way to debug those INVALID_TE and PREV_AUTH_NOT_VALID errors? > > > > > > > The kernel doesn't use those codes for its own deauth, if that were to > > happen, so you'll want to look at the wpa_supplicant log, perhaps > > increasing the logging verbosity for it (I think how to do that probably > > depends on the distro, and I don't know off the top of my head.) > > > > Then again, while what I said is still true, reading the log more > carefully shows that wpa_s decided to roam and then got into those bad > situations that caused it to deauth. So you'd want to figure out why it > decides to roam there. > > Or perhaps roaming would be OK, if it weren't for the failures during > it. Well, I'd prefer to avoid unnecessary roaming because of the short interruptions in service that it causes. Below is an extract from the system log for a period of about two minutes, running with wpa_supplicant's -dd option set for verbose debugging. As of the start of the extract, the system had been associated with an AP for about five minutes. The log shows a few spontaneous reassociations and some errors. I hardly understand any of it, so thanks for your efforts to make sense of what it shows. Alan Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:97:41 1 Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:ac:33 1 Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: SME: Trying to authenticate with 48:b4:c3:81:b7:d3 (SSID='Harvard Secure' freq=6535 MHz) Aug 27 14:48:56 strephon kernel: wlan0: disconnect from AP 48:b4:c3:81:b8:03 for new auth to 48:b4:c3:81:b7:d3 Aug 27 14:48:56 strephon kernel: wlan0: authenticate with 48:b4:c3:81:b7:d3 (local address=3e:de:7e:33:e6:22) Aug 27 14:48:56 strephon kernel: wlan0: send auth to 48:b4:c3:81:b7:d3 (try 1/3) Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.8123] device (wlan0): supplicant interface state: completed -> authenticating Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.8124] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating Aug 27 14:48:56 strephon kernel: wlan0: authenticated Aug 27 14:48:56 strephon kernel: wlan0: associate with 48:b4:c3:81:b7:d3 (try 1/3) Aug 27 14:48:56 strephon wpa_supplicant[5906]: nl80211: kernel reports: key not allowed Aug 27 14:48:56 strephon wpa_supplicant[5906]: FT: Failed to set PTK to the driver Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: Trying to associate with 48:b4:c3:81:b7:d3 (SSID='Harvard Secure' freq=6535 MHz) Aug 27 14:48:56 strephon kernel: wlan0: RX ReassocResp from 48:b4:c3:81:b7:d3 (capab=0x11 status=0 aid=16) Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.8326] device (wlan0): supplicant interface state: authenticating -> associating Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.8326] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating Aug 27 14:48:56 strephon kernel: wlan0: associated Aug 27 14:48:56 strephon kernel: wlan0: deauthenticating from 48:b4:c3:81:b7:d3 by local choice (Reason: 13=INVALID_IE) Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: FT: RSNE mismatch between Beacon/ProbeResp and FT protocol Reassociation Response frame Aug 27 14:48:56 strephon wpa_supplicant[5906]: RSNE in Beacon/ProbeResp - hexdump(len=32): 30 1e 01 00 00 0f ac 04 01 00 00 0f ac 04 02 00 00 0f ac 05 00 0f ac 03 e8 00 00 00 00 0f ac 06 Aug 27 14:48:56 strephon wpa_supplicant[5906]: RSNE in FT protocol Reassociation Response frame - hexdump(len=44): 30 2a 01 00 00 0f ac 04 01 00 00 0f ac 04 02 00 00 0f ac 01 00 0f ac 03 e8 00 01 00 ff 84 62 84 5a a3 06 82 4f b4 2d 43 36 76 87 4b Aug 27 14:48:56 strephon kernel: iwlwifi 0000:72:00.0: Unhandled alg: 0x707 Aug 27 14:48:56 strephon kernel: iwlwifi 0000:72:00.0: Unhandled alg: 0x707 Aug 27 14:48:56 strephon wpa_supplicant[5906]: nl80211: send_event_marker failed: Source based routing not supported Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DISCONNECTED bssid=48:b4:c3:81:b7:d3 reason=13 locally_generated=1 Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: BSSID 48:b4:c3:81:b7:d3 ignore list count incremented to 3, ignoring for 60 seconds Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Aug 27 14:48:56 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.8677] device (wlan0): supplicant interface state: associating -> disconnected Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.8678] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.9676] device (wlan0): supplicant interface state: disconnected -> scanning Aug 27 14:48:56 strephon NetworkManager[978]: <info> [1724784536.9677] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning Aug 27 14:49:00 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b7:e3 1 Aug 27 14:49:00 strephon wpa_supplicant[5906]: wlan0: SME: Trying to authenticate with 48:b4:c3:81:b8:03 (SSID='Harvard Secure' freq=6215 MHz) Aug 27 14:49:00 strephon kernel: wlan0: authenticate with 48:b4:c3:81:b8:03 (local address=3e:de:7e:33:e6:22) Aug 27 14:49:00 strephon kernel: wlan0: send auth to 48:b4:c3:81:b8:03 (try 1/3) Aug 27 14:49:00 strephon NetworkManager[978]: <info> [1724784540.4148] device (wlan0): supplicant interface state: scanning -> authenticating Aug 27 14:49:00 strephon NetworkManager[978]: <info> [1724784540.4148] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating Aug 27 14:49:00 strephon kernel: wlan0: authenticated Aug 27 14:49:00 strephon wpa_supplicant[5906]: wlan0: Trying to associate with 48:b4:c3:81:b8:03 (SSID='Harvard Secure' freq=6215 MHz) Aug 27 14:49:00 strephon NetworkManager[978]: <info> [1724784540.4170] device (wlan0): supplicant interface state: authenticating -> associating Aug 27 14:49:00 strephon NetworkManager[978]: <info> [1724784540.4170] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating Aug 27 14:49:00 strephon kernel: wlan0: associate with 48:b4:c3:81:b8:03 (try 1/3) Aug 27 14:49:00 strephon kernel: iwlwifi 0000:72:00.0: Unhandled alg: 0x707 Aug 27 14:49:00 strephon kernel: wlan0: RX AssocResp from 48:b4:c3:81:b8:03 (capab=0x1 status=30 aid=0) Aug 27 14:49:00 strephon kernel: wlan0: 48:b4:c3:81:b8:03 rejected association temporarily; comeback duration 4882 TU (4999 ms) Aug 27 14:49:05 strephon kernel: wlan0: aborting association with 48:b4:c3:81:b8:03 by local choice (Reason: 3=DEAUTH_LEAVING) Aug 27 14:49:05 strephon wpa_supplicant[5906]: nl80211: send_event_marker failed: Source based routing not supported Aug 27 14:49:05 strephon wpa_supplicant[5906]: wlan0: Added BSSID 48:b4:c3:81:b8:03 into ignore list, ignoring for 10 seconds Aug 27 14:49:05 strephon wpa_supplicant[5906]: wlan0: BSSID 48:b4:c3:81:b8:03 ignore list count incremented to 2, ignoring for 10 seconds Aug 27 14:49:05 strephon NetworkManager[978]: <info> [1724784545.4458] device (wlan0): supplicant interface state: associating -> disconnected Aug 27 14:49:05 strephon NetworkManager[978]: <info> [1724784545.4459] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected Aug 27 14:49:05 strephon NetworkManager[978]: <info> [1724784545.9462] device (wlan0): supplicant interface state: disconnected -> scanning Aug 27 14:49:05 strephon NetworkManager[978]: <info> [1724784545.9463] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: SME: Trying to authenticate with 48:b4:c3:81:b1:a0 (SSID='Harvard Secure' freq=5975 MHz) Aug 27 14:49:06 strephon kernel: wlan0: authenticate with 48:b4:c3:81:b1:a0 (local address=3e:de:7e:33:e6:22) Aug 27 14:49:06 strephon kernel: wlan0: send auth to 48:b4:c3:81:b1:a0 (try 1/3) Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.5417] device (wlan0): supplicant interface state: scanning -> authenticating Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.5417] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating Aug 27 14:49:06 strephon kernel: wlan0: authenticated Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: Trying to associate with 48:b4:c3:81:b1:a0 (SSID='Harvard Secure' freq=5975 MHz) Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.5504] device (wlan0): supplicant interface state: authenticating -> associating Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.5505] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating Aug 27 14:49:06 strephon kernel: wlan0: associate with 48:b4:c3:81:b1:a0 (try 1/3) Aug 27 14:49:06 strephon kernel: wlan0: RX AssocResp from 48:b4:c3:81:b1:a0 (capab=0x111 status=0 aid=17) Aug 27 14:49:06 strephon kernel: wlan0: associated Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: Associated with 48:b4:c3:81:b1:a0 Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-STARTED EAP authentication started Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.5694] device (wlan0): supplicant interface state: associating -> associated Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.5695] device (p2p-dev-wlan0): supplicant management interface state: associating -> associated Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=13 Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-METHOD EAP vendor 0 method 13 (TLS) selected Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-CERT depth=2 subject='/C=US/ST=New Jersey/L=Jersey City/O=The USERTRUST Network/CN=USERTrust RSA Certification Authority' hash=e793c9b02fd8aa13e21c31228accb08119643b749c898964b1746d46c3d4cbd2 Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-CERT depth=1 subject='/C=US/O=Internet2/CN=InCommon RSA Server CA 2' hash=87e01cc4dd0c9d92a3dbd49092ff13f9cd387445cdc57e5b984e1b7721b5b029 Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-CERT depth=0 subject='/C=US/ST=Massachusetts/O=President and Fellows of Harvard College/CN=getonline.noc.harvard.edu' hash=3f49c12863e8b1acf739e8ab4c55e165d9466d1ba18287d0ef1ffa1e743a3d88 Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:getonline.noc.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:autoreg.fas.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:autoreg1-10wa.noc.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:autoreg1-60ox.noc.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:getonline.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:registration.noc.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:sc-cppm-pub1.net.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:sc-cppm-sub1.net.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:sc-cppm-sub10.net.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PEER-ALT depth=0 DNS:sc-cppm-sub11.net.harvard.edu Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-SUCCESS EAP authentication completed successfully Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b1:a0 1 Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b1:a0 1 Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8164] device (wlan0): supplicant interface state: associated -> 4way_handshake Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8165] device (p2p-dev-wlan0): supplicant management interface state: associated -> 4way_handshake Aug 27 14:49:06 strephon kernel: iwlwifi 0000:72:00.0: Unhandled alg: 0x707 Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: WPA: Key negotiation completed with 48:b4:c3:81:b1:a0 [PTK=CCMP GTK=CCMP] Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:b4:c3:81:b1:a0 completed [id=1 id_str=] Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8649] device (wlan0): supplicant interface state: 4way_handshake -> completed Aug 27 14:49:06 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-68 noise=9999 txrate=29200 Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8660] device (wlan0): ip:dhcp4: restarting Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8660] dhcp4 (wlan0): canceled DHCP transaction Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8660] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8660] dhcp4 (wlan0): state changed no lease Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8661] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.8661] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.9397] dhcp4 (wlan0): state changed new lease, address=10.250.66.194, acd pending Aug 27 14:49:06 strephon NetworkManager[978]: <info> [1724784546.9401] dhcp4 (wlan0): state changed new lease, address=10.250.66.194 Aug 27 14:49:06 strephon systemd[1]: Starting NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service... Aug 27 14:49:06 strephon systemd[1]: Started NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service. Aug 27 14:49:17 strephon systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully. Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:80:58:a1 1 Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:c8:e2 1 Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: SME: Trying to authenticate with 48:b4:c3:81:b8:03 (SSID='Harvard Secure' freq=6215 MHz) Aug 27 14:49:41 strephon kernel: wlan0: disconnect from AP 48:b4:c3:81:b1:a0 for new auth to 48:b4:c3:81:b8:03 Aug 27 14:49:41 strephon kernel: wlan0: authenticate with 48:b4:c3:81:b8:03 (local address=3e:de:7e:33:e6:22) Aug 27 14:49:41 strephon kernel: wlan0: send auth to 48:b4:c3:81:b8:03 (try 1/3) Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.2208] device (wlan0): supplicant interface state: completed -> authenticating Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.2209] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating Aug 27 14:49:41 strephon kernel: wlan0: authenticated Aug 27 14:49:41 strephon wpa_supplicant[5906]: nl80211: kernel reports: key not allowed Aug 27 14:49:41 strephon wpa_supplicant[5906]: FT: Failed to set PTK to the driver Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: Trying to associate with 48:b4:c3:81:b8:03 (SSID='Harvard Secure' freq=6215 MHz) Aug 27 14:49:41 strephon kernel: wlan0: associate with 48:b4:c3:81:b8:03 (try 1/3) Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.2321] device (wlan0): supplicant interface state: authenticating -> associating Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.2322] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating Aug 27 14:49:41 strephon kernel: wlan0: RX ReassocResp from 48:b4:c3:81:b8:03 (capab=0x11 status=0 aid=17) Aug 27 14:49:41 strephon kernel: wlan0: associated Aug 27 14:49:41 strephon kernel: wlan0: deauthenticating from 48:b4:c3:81:b8:03 by local choice (Reason: 13=INVALID_IE) Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: FT: RSNE mismatch between Beacon/ProbeResp and FT protocol Reassociation Response frame Aug 27 14:49:41 strephon wpa_supplicant[5906]: RSNE in Beacon/ProbeResp - hexdump(len=32): 30 1e 01 00 00 0f ac 04 01 00 00 0f ac 04 02 00 00 0f ac 05 00 0f ac 03 e8 00 00 00 00 0f ac 06 Aug 27 14:49:41 strephon wpa_supplicant[5906]: RSNE in FT protocol Reassociation Response frame - hexdump(len=44): 30 2a 01 00 00 0f ac 04 01 00 00 0f ac 04 02 00 00 0f ac 01 00 0f ac 03 e8 00 01 00 8c 34 e8 c2 21 bb 8a 04 04 fa 5b bb 29 23 ed eb Aug 27 14:49:41 strephon kernel: iwlwifi 0000:72:00.0: Unhandled alg: 0x707 Aug 27 14:49:41 strephon wpa_supplicant[5906]: nl80211: send_event_marker failed: Source based routing not supported Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DISCONNECTED bssid=48:b4:c3:81:b8:03 reason=13 locally_generated=1 Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: BSSID 48:b4:c3:81:b8:03 ignore list count incremented to 3, ignoring for 60 seconds Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Aug 27 14:49:41 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.2793] device (wlan0): supplicant interface state: associating -> disconnected Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.2794] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.3794] device (wlan0): supplicant interface state: disconnected -> scanning Aug 27 14:49:41 strephon NetworkManager[978]: <info> [1724784581.3795] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: SME: Trying to authenticate with 48:b4:c3:81:b1:a0 (SSID='Harvard Secure' freq=5975 MHz) Aug 27 14:49:44 strephon kernel: wlan0: authenticate with 48:b4:c3:81:b1:a0 (local address=3e:de:7e:33:e6:22) Aug 27 14:49:44 strephon kernel: wlan0: send auth to 48:b4:c3:81:b1:a0 (try 1/3) Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.7189] device (wlan0): supplicant interface state: scanning -> authenticating Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.7189] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating Aug 27 14:49:44 strephon kernel: wlan0: authenticated Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: Trying to associate with 48:b4:c3:81:b1:a0 (SSID='Harvard Secure' freq=5975 MHz) Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.7253] device (wlan0): supplicant interface state: authenticating -> associating Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.7254] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating Aug 27 14:49:44 strephon kernel: wlan0: associate with 48:b4:c3:81:b1:a0 (try 1/3) Aug 27 14:49:44 strephon kernel: wlan0: RX AssocResp from 48:b4:c3:81:b1:a0 (capab=0x111 status=0 aid=17) Aug 27 14:49:44 strephon kernel: wlan0: associated Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: Associated with 48:b4:c3:81:b1:a0 Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-STARTED EAP authentication started Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.7446] device (wlan0): supplicant interface state: associating -> associated Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.7447] device (p2p-dev-wlan0): supplicant management interface state: associating -> associated Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=13 Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-METHOD EAP vendor 0 method 13 (TLS) selected Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-SUCCESS EAP authentication completed successfully Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b1:a0 1 Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b1:a0 1 Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.8524] device (wlan0): supplicant interface state: associated -> 4way_handshake Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.8525] device (p2p-dev-wlan0): supplicant management interface state: associated -> 4way_handshake Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: WPA: Key negotiation completed with 48:b4:c3:81:b1:a0 [PTK=CCMP GTK=CCMP] Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:b4:c3:81:b1:a0 completed [id=1 id_str=] Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.9010] device (wlan0): supplicant interface state: 4way_handshake -> completed Aug 27 14:49:44 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-66 noise=9999 txrate=29200 Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.9021] device (wlan0): ip:dhcp4: restarting Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.9022] dhcp4 (wlan0): canceled DHCP transaction Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.9022] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.9022] dhcp4 (wlan0): state changed no lease Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.9023] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:49:44 strephon NetworkManager[978]: <info> [1724784584.9024] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed Aug 27 14:49:46 strephon NetworkManager[978]: <info> [1724784586.9194] dhcp4 (wlan0): state changed new lease, address=10.250.66.194, acd pending Aug 27 14:49:46 strephon NetworkManager[978]: <info> [1724784586.9197] dhcp4 (wlan0): state changed new lease, address=10.250.66.194 Aug 27 14:49:46 strephon systemd[1]: Starting NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service... Aug 27 14:49:46 strephon systemd[1]: Started NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service. Aug 27 14:49:53 strephon kernel: wlan0: deauthenticating from 48:b4:c3:81:b1:a0 by local choice (Reason: 2=PREV_AUTH_NOT_VALID) Aug 27 14:49:54 strephon wpa_supplicant[5906]: nl80211: send_event_marker failed: Source based routing not supported Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DISCONNECTED bssid=48:b4:c3:81:b1:a0 reason=2 locally_generated=1 Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: Added BSSID 48:b4:c3:81:b1:a0 into ignore list, ignoring for 10 seconds Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: BSSID 48:b4:c3:81:b1:a0 ignore list count incremented to 2, ignoring for 10 seconds Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.0228] device (wlan0): supplicant interface state: completed -> disconnected Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.0229] device (p2p-dev-wlan0): supplicant management interface state: completed -> disconnected Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.1210] device (wlan0): supplicant interface state: disconnected -> scanning Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.1210] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: SME: Trying to authenticate with 48:b4:c3:81:b7:b3 (SSID='Harvard Secure' freq=5220 MHz) Aug 27 14:49:54 strephon kernel: wlan0: authenticate with 48:b4:c3:81:b7:b3 (local address=3e:de:7e:33:e6:22) Aug 27 14:49:54 strephon kernel: wlan0: send auth to 48:b4:c3:81:b7:b3 (try 1/3) Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: Trying to associate with 48:b4:c3:81:b7:b3 (SSID='Harvard Secure' freq=5220 MHz) Aug 27 14:49:54 strephon kernel: wlan0: authenticated Aug 27 14:49:54 strephon kernel: wlan0: associate with 48:b4:c3:81:b7:b3 (try 1/3) Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.9699] device (wlan0): supplicant interface state: scanning -> associating Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.9699] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating Aug 27 14:49:54 strephon kernel: wlan0: RX AssocResp from 48:b4:c3:81:b7:b3 (capab=0x1111 status=0 aid=3) Aug 27 14:49:54 strephon kernel: wlan0: associated Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: Associated with 48:b4:c3:81:b7:b3 Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-STARTED EAP authentication started Aug 27 14:49:54 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.9854] device (wlan0): supplicant interface state: associating -> associated Aug 27 14:49:54 strephon NetworkManager[978]: <info> [1724784594.9855] device (p2p-dev-wlan0): supplicant management interface state: associating -> associated Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=13 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-METHOD EAP vendor 0 method 13 (TLS) selected Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-SUCCESS EAP authentication completed successfully Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b7:d3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b7:c3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED e8:10:98:7c:2d:42 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 54:d7:e3:d9:91:22 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b1:80 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED e8:10:98:7c:2d:52 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b7:f3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b1:90 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:af:c3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED dc:b7:ac:e3:18:b1 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED dc:b7:ac:e3:18:a1 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:c7:93 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:cc:33 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 54:d7:e3:d9:91:32 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 54:d7:e3:d9:91:12 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:4a:e9:c1:6c:31 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:af:a3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:97:51 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:c8:c2 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:c8:d2 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:ac:23 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:c1:b2 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:c7:83 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:af:b3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:97:41 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:ac:33 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b7:e3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:80:58:a1 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:c8:e2 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b7:b3 1 Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b7:b3 1 Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.0976] device (wlan0): supplicant interface state: associated -> 4way_handshake Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.0976] device (p2p-dev-wlan0): supplicant management interface state: associated -> 4way_handshake Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: WPA: Key negotiation completed with 48:b4:c3:81:b7:b3 [PTK=CCMP GTK=CCMP] Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:b4:c3:81:b7:b3 completed [id=1 id_str=] Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1426] device (wlan0): supplicant interface state: 4way_handshake -> completed Aug 27 14:49:55 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-40 noise=9999 txrate=58500 Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1431] device (wlan0): ip:dhcp4: restarting Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1498] dhcp4 (wlan0): canceled DHCP transaction Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1498] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1498] dhcp4 (wlan0): state changed no lease Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1499] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1501] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1609] dhcp4 (wlan0): state changed new lease, address=10.250.66.194, acd pending Aug 27 14:49:55 strephon NetworkManager[978]: <info> [1724784595.1610] dhcp4 (wlan0): state changed new lease, address=10.250.66.194 Aug 27 14:50:02 strephon kernel: wlan0: deauthenticating from 48:b4:c3:81:b7:b3 by local choice (Reason: 2=PREV_AUTH_NOT_VALID) Aug 27 14:50:02 strephon wpa_supplicant[5906]: nl80211: send_event_marker failed: Source based routing not supported Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DISCONNECTED bssid=48:b4:c3:81:b7:b3 reason=2 locally_generated=1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: Added BSSID 48:b4:c3:81:b7:b3 into ignore list, ignoring for 10 seconds Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: BSSID 48:b4:c3:81:b7:b3 ignore list count incremented to 2, ignoring for 10 seconds Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.2273] device (wlan0): supplicant interface state: completed -> disconnected Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.2275] device (p2p-dev-wlan0): supplicant management interface state: completed -> disconnected Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.3249] device (wlan0): supplicant interface state: disconnected -> scanning Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.3249] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b7:d3 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b7:c3 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b7:e3 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b7:f3 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 54:d7:e3:d9:91:22 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED e8:10:98:7c:2d:52 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b1:80 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED e8:10:98:7c:2d:42 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b1:90 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED dc:b7:ac:e3:18:b1 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED dc:b7:ac:e3:18:a1 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:c7:93 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:af:c3 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:80:58:a1 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 54:d7:e3:d9:91:32 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 54:d7:e3:d9:91:12 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:af:b3 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:4a:e9:c1:6c:31 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:ac:23 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:cc:33 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:c8:d2 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:ac:33 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:c8:e2 1 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: SME: Trying to authenticate with 48:b4:c3:81:b7:d3 (SSID='Harvard Secure' freq=6535 MHz) Aug 27 14:50:02 strephon kernel: wlan0: authenticate with 48:b4:c3:81:b7:d3 (local address=3e:de:7e:33:e6:22) Aug 27 14:50:02 strephon kernel: wlan0: send auth to 48:b4:c3:81:b7:d3 (try 1/3) Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: Trying to associate with 48:b4:c3:81:b7:d3 (SSID='Harvard Secure' freq=6535 MHz) Aug 27 14:50:02 strephon kernel: wlan0: authenticated Aug 27 14:50:02 strephon kernel: wlan0: associate with 48:b4:c3:81:b7:d3 (try 1/3) Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.9674] device (wlan0): supplicant interface state: scanning -> authenticating Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.9674] device (p2p-dev-wlan0): supplicant management interface state: scanning -> authenticating Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.9675] device (wlan0): supplicant interface state: authenticating -> associating Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.9675] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating Aug 27 14:50:02 strephon kernel: wlan0: RX AssocResp from 48:b4:c3:81:b7:d3 (capab=0x111 status=0 aid=16) Aug 27 14:50:02 strephon kernel: wlan0: associated Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: Associated with 48:b4:c3:81:b7:d3 Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-STARTED EAP authentication started Aug 27 14:50:02 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.9837] device (wlan0): supplicant interface state: associating -> associated Aug 27 14:50:02 strephon NetworkManager[978]: <info> [1724784602.9838] device (p2p-dev-wlan0): supplicant management interface state: associating -> associated Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=13 Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-METHOD EAP vendor 0 method 13 (TLS) selected Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-EAP-SUCCESS EAP authentication completed successfully Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-REMOVED 48:b4:c3:81:b7:d3 1 Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: PMKSA-CACHE-ADDED 48:b4:c3:81:b7:d3 1 Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1089] device (wlan0): supplicant interface state: associated -> 4way_handshake Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1090] device (p2p-dev-wlan0): supplicant management interface state: associated -> 4way_handshake Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: WPA: Key negotiation completed with 48:b4:c3:81:b7:d3 [PTK=CCMP GTK=CCMP] Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: Removed BSSID 48:b4:c3:81:b7:d3 from ignore list Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:b4:c3:81:b7:d3 completed [id=1 id_str=] Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1655] device (wlan0): supplicant interface state: 4way_handshake -> completed Aug 27 14:50:03 strephon wpa_supplicant[5906]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-43 noise=9999 txrate=245000 Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1665] device (wlan0): ip:dhcp4: restarting Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1778] dhcp4 (wlan0): canceled DHCP transaction Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1778] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1778] dhcp4 (wlan0): state changed no lease Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1779] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds) Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1780] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1851] dhcp4 (wlan0): state changed new lease, address=10.250.66.194, acd pending Aug 27 14:50:03 strephon NetworkManager[978]: <info> [1724784603.1853] dhcp4 (wlan0): state changed new lease, address=10.250.66.194 Aug 27 14:50:13 strephon systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.