Netplan

  1. Bug #1951586
  2. Comment #16

Comment 16 for bug 1951586

Revision history for this message
Jerry Vonau (jvonau) wrote :

Connection via NetworkManager to AP

2993 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5017] device (wlp2s0): Activation: starting connection '181-rpi4-64bit-raspios-LARGE' (9a51eba2-3723-4750-8a72-aa2e4c723140)
2994 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5083] audit: op="connection-add-activate" uuid="9a51eba2-3723-4750-8a72-aa2e4c723140" name="181-rpi4-64bit-raspios-LARGE" pid=1342 uid=1000 result="success"
2995 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5173] device (wlp2s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
2996 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5309] device (wlp2s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
2997 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5364] device (wlp2s0): Activation: (wifi) connection '181-rpi4-64bit-raspios-LARGE' requires no security. No secrets needed.
2998 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5365] Config: added 'ssid' value '181-rpi4-64bit-raspios-LARGE'
2999 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5366] Config: added 'scan_ssid' value '1'
3000 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5366] Config: added 'bgscan' value 'simple:30:-70:86400'
3001 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5367] Config: added 'key_mgmt' value 'NONE'
3002 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5508] device (wlp2s0): supplicant interface state: disconnected -> scanning
3003 May 6 09:55:54 124-u2204-desk NetworkManager[641]: <info> [1651845354.5509] device (p2p-dev-wlp2s0): supplicant management interface state: disconnected -> scanning
3004 May 6 09:55:55 124-u2204-desk wpa_supplicant[683]: wlp2s0: SME: Trying to authenticate with 02:72:82:96:ac:1e (SSID='181-rpi4-64bit-raspios-LARGE' freq=2437 MHz)
3005 May 6 09:55:55 124-u2204-desk kernel: [ 686.915199] wlp2s0: authenticate with 02:72:82:96:ac:1e
3006 May 6 09:55:55 124-u2204-desk kernel: [ 686.919826] wlp2s0: send auth to 02:72:82:96:ac:1e (try 1/3)
3007 May 6 09:55:55 124-u2204-desk kernel: [ 686.922147] wlp2s0: authenticated
3008 May 6 09:55:55 124-u2204-desk wpa_supplicant[683]: wlp2s0: Trying to associate with 02:72:82:96:ac:1e (SSID='181-rpi4-64bit-raspios-LARGE' freq=2437 MHz)
3009 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1109] device (wlp2s0): supplicant interface state: scanning -> authenticating
3010 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1111] device (p2p-dev-wlp2s0): supplicant management interface state: scanning -> authenticating
3011 May 6 09:55:55 124-u2204-desk kernel: [ 686.929202] wlp2s0: associate with 02:72:82:96:ac:1e (try 1/3)
3012 May 6 09:55:55 124-u2204-desk wpa_supplicant[683]: wlp2s0: Associated with 02:72:82:96:ac:1e
3013 May 6 09:55:55 124-u2204-desk kernel: [ 686.937597] wlp2s0: RX AssocResp from 02:72:82:96:ac:1e (capab=0x401 status=0 aid=1)
3014 May 6 09:55:55 124-u2204-desk kernel: [ 686.938943] wlp2s0: associated
3015 May 6 09:55:55 124-u2204-desk kernel: [ 686.940900] IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0: link becomes ready
3016 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1276] device (wlp2s0): supplicant interface state: authenticating -> associating
3017 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1277] device (p2p-dev-wlp2s0): supplicant management interface state: authenticating -> associating
3018 May 6 09:55:55 124-u2204-desk wpa_supplicant[683]: wlp2s0: CTRL-EVENT-CONNECTED - Connection to 02:72:82:96:ac:1e completed [id=0 id_str=]
3019 May 6 09:55:55 124-u2204-desk wpa_supplicant[683]: wlp2s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
3020 May 6 09:55:55 124-u2204-desk wpa_supplicant[683]: wlp2s0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US
3021 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1389] device (wlp2s0): supplicant interface state: associating -> completed
3022 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1390] device (wlp2s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "181-rpi4-64bit-raspios-LARGE"
3023 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1391] device (p2p-dev-wlp2s0): supplicant management interface state: associating -> completed
3024 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1457] device (wlp2s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
3025 May 6 09:55:55 124-u2204-desk NetworkManager[641]: <info> [1651845355.1504] dhcp4 (wlp2s0): activation: beginning transaction (timeout in 45 seconds)
3026 May 6 09:55:55 124-u2204-desk avahi-daemon[636]: Joining mDNS multicast group on interface wlp2s0.IPv6 with address fe80::8b52:89de:a53d:e20f.
3027 May 6 09:55:55 124-u2204-desk avahi-daemon[636]: New relevant interface wlp2s0.IPv6 for mDNS.
3028 May 6 09:55:55 124-u2204-desk avahi-daemon[636]: Registering new address record for fe80::8b52:89de:a53d:e20f on wlp2s0.*.
3029 May 6 09:55:55 124-u2204-desk wpa_supplicant[683]: wlp2s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-21 noise=9999 txrate=72200
3030 May 6 09:55:55 124-u2204-desk kernel: [ 686.987544] wlp2s0: Limiting TX power to 30 (30 - 0) dBm as advertised by 02:72:82:96:ac:1e
3031 May 6 09:55:58 124-u2204-desk NetworkManager[641]: <info> [1651845358.3182] dhcp4 (wlp2s0): state changed new lease, address=172.18.118.149
3032 May 6 09:55:58 124-u2204-desk avahi-daemon[636]: Joining mDNS multicast group on interface wlp2s0.IPv4 with address 172.18.118.149.
3033 May 6 09:55:58 124-u2204-desk avahi-daemon[636]: New relevant interface wlp2s0.IPv4 for mDNS.
3034 May 6 09:55:58 124-u2204-desk avahi-daemon[636]: Registering new address record for 172.18.118.149 on wlp2s0.IPv4.
3035 May 6 09:55:58 124-u2204-desk dbus-daemon[640]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.8' (uid=0 pid=641 comm="/usr/sbin/NetworkManager --no-daemon " label="unconfined")
3036 May 6 09:55:58 124-u2204-desk NetworkManager[641]: <info> [1651845358.3303] device (wlp2s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
3037 May 6 09:55:58 124-u2204-desk systemd[1]: Starting Network Manager Script Dispatcher Service...
3038 May 6 09:55:58 124-u2204-desk dbus-daemon[640]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
3039 May 6 09:55:58 124-u2204-desk systemd[1]: Started Network Manager Script Dispatcher Service.
3040 May 6 09:55:58 124-u2204-desk NetworkManager[641]: <info> [1651845358.3644] device (wlp2s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
3041 May 6 09:55:58 124-u2204-desk NetworkManager[641]: <info> [1651845358.3649] device (wlp2s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
3042 May 6 09:55:58 124-u2204-desk NetworkManager[641]: <info> [1651845358.3793] device (wlp2s0): Activation: successful, device activated

Disconnection from AP

3098 May 6 09:58:44 124-u2204-desk kernel: [ 856.512766] wlp2s0: deauthenticating from 02:72:82:96:ac:1e by local choice (Reason: 3=DEAUTH_LEAVING)
3099 May 6 09:58:44 124-u2204-desk wpa_supplicant[683]: wlp2s0: CTRL-EVENT-DISCONNECTED bssid=02:72:82:96:ac:1e reason=3 locally_generated=1
3100 May 6 09:58:44 124-u2204-desk wpa_supplicant[683]: wlp2s0: CTRL-EVENT-DSCP-POLICY clear_all
3101 May 6 09:58:44 124-u2204-desk wpa_supplicant[683]: wlp2s0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
3102 May 6 09:58:44 124-u2204-desk NetworkManager[641]: <info> [1651845524.7590] device (wlp2s0): supplicant interface state: completed -> disconnected
3103 May 6 09:58:44 124-u2204-desk NetworkManager[641]: <info> [1651845524.7590] device (p2p-dev-wlp2s0): supplicant management interface state: completed -> disconnected
3104 May 6 09:58:44 124-u2204-desk NetworkManager[641]: <info> [1651845524.7594] device (wlp2s0): state change: deactivating -> disconnected (reason 'new-activation', sys-iface-state: 'managed')

Note:

CTRL-EVENT-REGDOM-CHANGE changes as the connection is toggled on and off. Think everything is fine on that front. I think all the variables for wpa_supplicant.conf are passed across dbus from NetworkManager, I can't seem to find any temporary file within /run/ that has any mention of the wifi connection.

Think the easiest path would be for netplan's systemd-network backend to populate wpa_supplicant.conf with a country_code entry from within the 'wifis' section of the yamal file, that would be the equivalent to how RaspOS handles setting up it's wpa_supplicant.conf file.