[Solved] Network dies about every hour and have restart NetworkManager

LittleSandra · 2023-03-12 11:47:07

Dear all

Here is an odd one. About every one hour or so the wireless dies, and I have to

sudo systemctl restart NetworkManager.service

to get it back.

The wireless connectivity is good and worked perfectly with Fedora.

Does anyone know how to debug this?

It is a ThinkPad T470s. lshw|grep wifi gives

configuration: broadcast=yes driver=iwlwifi driverversion=6.2.2-arch2-1 firmware=36.ca7b901d.0 8265-36.ucode ip=192.168.0.133 latency=0 link=yes multicast=yes wireless=IEEE 802.11

[a@t470s ~]$ sudo lsmod
Module                  Size  Used by
ccm                    20480  6
algif_aead             16384  0
des_generic            16384  0
libdes                 24576  1 des_generic
ecb                    16384  0
algif_skcipher         16384  0
cmac                   16384  0
md4                    16384  0
algif_hash             16384  0
af_alg                 36864  3 algif_hash,algif_skcipher,algif_aead
dm_crypt               65536  1
cbc                    16384  0
encrypted_keys         28672  1 dm_crypt
trusted                53248  2 encrypted_keys,dm_crypt
asn1_encoder           16384  1 trusted
tee                    45056  1 trusted
snd_soc_avs           217088  0
snd_soc_hda_codec      28672  1 snd_soc_avs
snd_hda_codec_hdmi     94208  1
intel_rapl_msr         20480  0
intel_rapl_common      36864  1 intel_rapl_msr
snd_soc_skl           241664  0
snd_soc_hdac_hda       28672  1 snd_soc_skl
intel_tcc_cooling      16384  0
snd_hda_ext_core       36864  4 snd_soc_avs,snd_soc_hda_codec,snd_soc_hdac_hda,snd_soc_skl
x86_pkg_temp_thermal    20480  0
intel_powerclamp       20480  0
snd_soc_sst_ipc        20480  1 snd_soc_skl
uvcvideo              180224  0
coretemp               20480  0
snd_ctl_led            24576  0
snd_soc_sst_dsp        45056  1 snd_soc_skl
kvm_intel             434176  0
videobuf2_vmalloc      20480  1 uvcvideo
snd_soc_acpi_intel_match    73728  1 snd_soc_skl
snd_hda_codec_realtek   196608  1
joydev                 28672  0
videobuf2_memops       20480  1 videobuf2_vmalloc
snd_hda_codec_generic   114688  1 snd_hda_codec_realtek
videobuf2_v4l2         45056  1 uvcvideo
snd_soc_acpi           16384  2 snd_soc_acpi_intel_match,snd_soc_skl
btusb                  77824  0
snd_soc_core          446464  4 snd_soc_avs,snd_soc_hda_codec,snd_soc_hdac_hda,snd_soc_skl
btrtl                  28672  1 btusb
rmi_smbus              16384  0
kvm                  1327104  1 kvm_intel
videodev              356352  2 videobuf2_v4l2,uvcvideo
snd_compress           32768  2 snd_soc_avs,snd_soc_core
btbcm                  24576  1 btusb
ac97_bus               16384  1 snd_soc_core
snd_pcm_dmaengine      20480  1 snd_soc_core
btintel                53248  1 btusb
rmi_core              131072  1 rmi_smbus
mousedev               24576  0
videobuf2_common       90112  4 videobuf2_vmalloc,videobuf2_v4l2,uvcvideo,videobuf2_memops
iTCO_wdt               16384  0
irqbypass              16384  1 kvm
mei_pxp                20480  0
snd_hda_intel          65536  3
btmtk                  16384  1 btusb
mei_hdcp               28672  0
intel_pmc_bxt          16384  1 iTCO_wdt
i915                 3801088  33
crct10dif_pclmul       16384  1
mc                     86016  4 videodev,videobuf2_v4l2,uvcvideo,videobuf2_common
snd_intel_dspcfg       36864  3 snd_soc_avs,snd_hda_intel,snd_soc_skl
crc32_pclmul           16384  0
ee1004                 20480  0
iTCO_vendor_support    16384  1 iTCO_wdt
snd_intel_sdw_acpi     20480  1 snd_intel_dspcfg
think_lmi              40960  0
polyval_clmulni        16384  0
polyval_generic        16384  1 polyval_clmulni
wmi_bmof               16384  0
bluetooth            1077248  6 btrtl,btmtk,btintel,btbcm,btusb
intel_wmi_thunderbolt    20480  0
gf128mul               16384  1 polyval_generic
ghash_clmulni_intel    16384  0
iwlmvm                614400  0
firmware_attributes_class    16384  1 think_lmi
sha512_ssse3           57344  0
ecdh_generic           16384  1 bluetooth
aesni_intel           401408  6
mac80211             1503232  1 iwlmvm
snd_hda_codec         217088  8 snd_hda_codec_generic,snd_soc_avs,snd_hda_codec_hdmi,snd_soc_hda_codec,snd_hda_intel,snd_hda_codec_realtek,snd_soc_hdac_hda,snd_soc_skl
crypto_simd            16384  1 aesni_intel
snd_hda_core          139264  10 snd_hda_codec_generic,snd_soc_avs,snd_hda_codec_hdmi,snd_soc_hda_codec,snd_hda_intel,snd_hda_ext_core,snd_hda_codec,snd_hda_codec_realtek,snd_soc_hdac_hda,snd_soc_skl
drm_buddy              20480  1 i915
ttm                   102400  1 i915
snd_hwdep              20480  1 snd_hda_codec
cryptd                 32768  3 crypto_simd,ghash_clmulni_intel
rapl                   20480  0
libarc4                16384  1 mac80211
ext4                 1163264  1
mei_me                 61440  2
drm_display_helper    208896  1 i915
uas                    40960  0
intel_cstate           24576  0
snd_pcm               200704  9 snd_soc_avs,snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec,snd_compress,snd_soc_core,snd_soc_skl,snd_hda_core,snd_pcm_dmaengine
i2c_i801               45056  0
ucsi_acpi              16384  0
crc16                  16384  2 bluetooth,ext4
thinkpad_acpi         204800  0
mbcache                16384  1 ext4
psmouse               237568  0
typec_ucsi             61440  1 ucsi_acpi
usb_storage            86016  1 uas
pcspkr                 16384  0
iwlwifi               544768  1 iwlmvm
snd_timer              53248  1 snd_pcm
e1000e                372736  0
ledtrig_audio          16384  3 snd_ctl_led,snd_hda_codec_generic,thinkpad_acpi
intel_uncore          249856  0
cec                    86016  2 drm_display_helper,i915
usbhid                 86016  0
mei                   192512  5 mei_hdcp,mei_pxp,mei_me
i2c_smbus              20480  1 i2c_i801
intel_pch_thermal      20480  0
jbd2                  217088  1 ext4
intel_xhci_usb_role_switch    16384  0
typec                 106496  1 typec_ucsi
intel_gtt              28672  1 i915
platform_profile       16384  1 thinkpad_acpi
roles                  20480  2 typec_ucsi,intel_xhci_usb_role_switch
snd                   151552  18 snd_ctl_led,snd_hda_codec_generic,snd_hda_codec_hdmi,snd_hwdep,snd_hda_intel,snd_hda_codec,snd_hda_codec_realtek,snd_timer,snd_compress,thinkpad_acpi,snd_soc_core,snd_pcm
video                  73728  2 thinkpad_acpi,i915
soundcore              16384  2 snd_ctl_led,snd
wmi                    45056  4 video,intel_wmi_thunderbolt,wmi_bmof,think_lmi
acpi_pad               24576  0
cfg80211             1277952  3 iwlmvm,iwlwifi,mac80211
rfkill                 40960  8 iwlmvm,bluetooth,thinkpad_acpi,cfg80211
mac_hid                16384  0
squashfs               98304  5
pkcs8_key_parser       16384  0
loop                   36864  10
fuse                  204800  3
dm_mod                221184  3 dm_crypt
bpf_preload            24576  0
ip_tables              40960  0
x_tables               61440  1 ip_tables
serio_raw              20480  0
atkbd                  40960  0
nvme                   69632  3
libps2                 20480  2 atkbd,psmouse
vivaldi_fmap           16384  1 atkbd
nvme_core             241664  4 nvme
xhci_pci               24576  0
i8042                  53248  0
xhci_pci_renesas       24576  1 xhci_pci
nvme_common            24576  1 nvme_core
serio                  28672  8 rmi_core,serio_raw,atkbd,psmouse,i8042
btrfs                2039808  2
blake2b_generic        20480  0
xor                    24576  1 btrfs
raid6_pq              122880  1 btrfs
libcrc32c              16384  1 btrfs
crc32c_generic         16384  0
crc32c_intel           24576  4
[a@t470s ~]$

Last edited by LittleSandra (2023-03-17 14:48:01)

Irets · 2023-03-12 12:14:27

Upon losing wireless, what does

# journalctl -b-0

print?

LittleSandra · 2023-03-14 01:08:00

Irets wrote:

Upon losing wireless, what does
# journalctl -b-0
print?

This is what I get

Mar 14 01:57:24 t470s systemd[704]: vte-spawn-d034b2da-9277-498f-803f-0c7136fce1c6.scope: Consumed 4.996s CPU time.
Mar 14 01:59:46 t470s systemd[1]: Started Getty on tty5.
Mar 14 01:59:50 t470s dbus-daemon[589]: [system] Activating via systemd: service name='org.freedesktop.home1' unit='dbus-org.freedesktop.home1.service' reque
sted by ':1.108' (uid=0 pid=8262 comm="/bin/login -p --  ")
Mar 14 01:59:50 t470s dbus-daemon[589]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.home1.service': Unit dbus-org.freedesktop.home1
.service not found.
Mar 14 01:59:50 t470s login[8262]: pam_systemd_home(login:auth): systemd-homed is not available: Unit dbus-org.freedesktop.home1.service not found.
Mar 14 01:59:50 t470s login[8262]: pam_unix(login:session): session opened for user a(uid=1000) by LOGIN(uid=0)
Mar 14 01:59:50 t470s systemd-logind[591]: New session 3 of user a.
Mar 14 01:59:50 t470s systemd[1]: Started Session 3 of User a.
Mar 14 01:59:50 t470s login[8262]: LOGIN ON tty5 BY a
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: SME: Trying to authenticate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 14 02:00:06 t470s systemd-networkd[261]: wlan0: Lost carrier
Mar 14 02:00:06 t470s systemd-networkd[261]: wlan0: DHCP lease lost
Mar 14 02:00:06 t470s kernel: wlan0: disconnect from AP 00:1e:80:b0:56:44 for new auth to 00:1e:80:b0:56:40
Mar 14 02:00:06 t470s kernel: wlan0: authenticate with 00:1e:80:b0:56:40
Mar 14 02:00:06 t470s kernel: wlan0: 80 MHz not supported, disabling VHT
Mar 14 02:00:06 t470s kernel: wlan0: send auth to 00:1e:80:b0:56:40 (try 1/3)
Mar 14 02:00:06 t470s dbus-daemon[589]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.servic
e' requested by ':1.2' (uid=980 pid=261 comm="/usr/lib/systemd/systemd-networkd")
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.8005] device (wlan0): supplicant interface state: completed -> authenticating
Mar 14 02:00:06 t470s kernel: wlan0: authenticated
Mar 14 02:00:06 t470s kernel: wlan0: associate with 00:1e:80:b0:56:40 (try 1/3)
Mar 14 02:00:06 t470s kernel: wlan0: RX ReassocResp from 00:1e:80:b0:56:40 (capab=0x411 status=0 aid=5)
Mar 14 02:00:06 t470s kernel: wlan0: associated
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.8005] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticati
ng
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: Trying to associate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 14 02:00:06 t470s iwd[590]: Unexpected connection related event -- is another supplicant running?
Mar 14 02:00:06 t470s iwd[590]: Unexpected connection related event -- is another supplicant running?
Mar 14 02:00:06 t470s systemd-networkd[261]: wlan0: DHCPv6 lease lost
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: Associated with 00:1e:80:b0:56:40
Mar 14 02:00:06 t470s systemd-timesyncd[574]: No network connectivity, watching for changes.
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.8286] device (wlan0): supplicant interface state: authenticating -> associating
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.8286] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.8432] device (wlan0): supplicant interface state: associating -> 4way_handshake
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.8432] device (p2p-dev-wlan0): supplicant management interface state: associating -> 4way_handshake
Mar 14 02:00:06 t470s systemd[1]: Starting Hostname Service...
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: WPA: Key negotiation completed with 00:1e:80:b0:56:40 [PTK=CCMP GTK=CCMP]
Mar 14 02:00:06 t470s systemd-networkd[261]: wlan0: Gained carrier
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:1e:80:b0:56:40 completed [id=0 id_str=]
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-75 noise=9999 txrate=6000
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.9019] device (wlan0): supplicant interface state: 4way_handshake -> completed
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.9026] device (wlan0): ip:dhcp4: restarting
Mar 14 02:00:06 t470s systemd-timesyncd[574]: Network configuration changed, trying to establish connection.
Mar 14 02:00:06 t470s dbus-daemon[589]: [system] Successfully activated service 'org.freedesktop.hostname1'
Mar 14 02:00:06 t470s systemd[1]: Started Hostname Service.
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.9189] dhcp4 (wlan0): canceled DHCP transaction
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.9190] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.9190] dhcp4 (wlan0): state changed no lease
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.9190] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 14 02:00:06 t470s NetworkManager[593]: <info>  [1678755606.9191] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Mar 14 02:00:06 t470s wpa_supplicant[680]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet
Mar 14 02:00:07 t470s wpa_supplicant[680]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet
Mar 14 02:00:08 t470s NetworkManager[593]: <info>  [1678755608.9313] device (wlan0): supplicant interface state: completed -> 4way_handshake
Mar 14 02:00:08 t470s NetworkManager[593]: <info>  [1678755608.9314] device (p2p-dev-wlan0): supplicant management interface state: completed -> 4way_handshake
Mar 14 02:00:09 t470s systemd-resolved[573]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 192.168.0.1.
Mar 14 02:00:12 t470s systemd-resolved[573]: Using degraded feature set TCP instead of UDP for DNS server 192.168.0.1.
Mar 14 02:00:12 t470s kernel: wlan0: deauthenticated from 00:1e:80:b0:56:40 (Reason: 15=4WAY_HANDSHAKE_TIMEOUT)
Mar 14 02:00:12 t470s systemd-networkd[261]: wlan0: Lost carrier
Mar 14 02:00:12 t470s systemd-networkd[261]: wlan0: DHCPv6 lease lost
Mar 14 02:00:12 t470s systemd-timesyncd[574]: No network connectivity, watching for changes.
Mar 14 02:00:12 t470s wpa_supplicant[680]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15
Mar 14 02:00:12 t470s wpa_supplicant[680]: BSSID 00:1e:80:b0:56:40 ignore list count incremented to 2, ignoring for 10 seconds
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0182] device (wlan0): supplicant interface state: 4way_handshake -> disconnected
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0182] device (wlan0): Activation: (wifi) disconnected during association, asking for new key
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0184] device (wlan0): state change: activated -> need-auth (reason 'supplicant-disconnect', sys-iface-state: 'managed')
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0322] dhcp4 (wlan0): canceled DHCP transaction
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0322] dhcp4 (wlan0): state changed no lease
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0326] manager: NetworkManager state is now CONNECTING
Mar 14 02:00:13 t470s dbus-daemon[589]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.5' (uid=0 pid=593 comm="/usr/bin/NetworkManager --no-daemon")
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0333] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> disconnected
Mar 14 02:00:13 t470s systemd-resolved[573]: Switching to fallback DNS server 1.1.1.1#cloudflare-dns.com.
Mar 14 02:00:13 t470s systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 14 02:00:13 t470s dbus-daemon[589]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 14 02:00:13 t470s systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 14 02:00:13 t470s NetworkManager[593]: <warn>  [1678755613.0960] device (wlan0): no secrets: No agents were available for this request.
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0960] device (wlan0): state change: need-auth -> failed (reason 'no-secrets', sys-iface-state: 'managed')
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.0964] manager: NetworkManager state is now DISCONNECTED
Mar 14 02:00:13 t470s systemd-networkd[261]: wlan0: Link DOWN
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1164] device (wlan0): set-hw-addr: set MAC address to E6:39:91:E0:6A:14 (scanning)
Mar 14 02:00:13 t470s NetworkManager[593]: <warn>  [1678755613.1219] device (wlan0): Activation: failed for connection 'FTTH_XM9145'
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1221] device (wlan0): supplicant interface state: disconnected -> inactive
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1222] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> inactive
Mar 14 02:00:13 t470s systemd-networkd[261]: wlan0: Link UP
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1222] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1223] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1227] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 14 02:00:13 t470s iwd[590]: Could not register frame watch type 00d0: -114
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1470] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 14 02:00:13 t470s NetworkManager[593]: <info>  [1678755613.1471] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 14 02:00:13 t470s wpa_supplicant[680]: wlan0: CTRL-EVENT-SCAN-FAILED ret=-16
Mar 14 02:00:18 t470s wpa_supplicant[680]: wlan0: Reject scan trigger since one is already pending
Mar 14 02:00:23 t470s systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 14 02:00:36 t470s systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Mar 14 02:01:13 t470s systemd[704]: Started VTE child process 8541 launched by gnome-terminal-server process 1917.
Mar 14 02:01:17 t470s su[8674]: (to root) a on pts/3
Mar 14 02:01:17 t470s su[8674]: pam_unix(su-l:session): session opened for user root(uid=0) by (uid=1000)

Irets · 2023-03-14 07:05:46

Are you running multiple network managers simultaneously?
I see both networkmanager and systemd-networkd talk in your output.

seth · 2023-03-14 09:06:29

There's also iwd and wpa_supplicat in parallel.
Please post the output of

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

LittleSandra · 2023-03-14 13:01:05

seth wrote:

There's also iwd and wpa_supplicat in parallel.
Please post the output of
find /etc/systemd -type l -exec test -f {} \; -print | awk -F'/' '{ printf ("%-40s | %s\n", $(NF-0), $(NF-1)) }' | sort -f

I get

[a@t470s ~]$ find /etc/systemd -type l -exec test -f {} \; -print | awk -F'/' '{ printf ("%-40s | %s\n", $(NF-0), $(NF-1)) }' | sort -f
cockpit.socket                           | sockets.target.wants
dbus-org.freedesktop.network1.service    | system
dbus-org.freedesktop.nm-dispatcher.service | system
dbus-org.freedesktop.resolve1.service    | system
dbus-org.freedesktop.timesync1.service   | system
fstrim.timer                             | timers.target.wants
getty@tty1.service                       | getty.target.wants
input-remapper.service                   | default.target.wants
iwd.service                              | multi-user.target.wants
NetworkManager.service                   | multi-user.target.wants
NetworkManager-wait-online.service       | network-online.target.wants
p11-kit-server.socket                    | sockets.target.wants
podman.socket                            | sockets.target.wants
pulseaudio.socket                        | sockets.target.wants
remote-fs.target                         | multi-user.target.wants
snapd.apparmor.service                   | multi-user.target.wants
snapd.socket                             | sockets.target.wants
systemd-networkd.service                 | multi-user.target.wants
systemd-networkd.socket                  | sockets.target.wants
systemd-networkd-wait-online.service     | network-online.target.wants
systemd-network-generator.service        | sysinit.target.wants
systemd-resolved.service                 | sysinit.target.wants
systemd-timesyncd.service                | sysinit.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-core-14447.mount      | multi-user.target.wants
var-lib-snapd-snap-core-14447.mount      | snapd.mounts.target.wants
var-lib-snapd-snap-core18-2667.mount     | multi-user.target.wants
var-lib-snapd-snap-core18-2667.mount     | snapd.mounts.target.wants
var-lib-snapd-snap-gnome\x2d3\x2d28\x2d1804-161.mount | multi-user.target.wants
var-lib-snapd-snap-gnome\x2d3\x2d28\x2d1804-161.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

LittleSandra · 2023-03-14 13:02:34

Irets wrote:

Are you running multiple network managers simultaneously?
I see both networkmanager and systemd-networkd talk in your output.

Not on purpose. Now that you mention it, during the installation, I choose "copy network settings" I think it was called, and then later I changed it to NetworkManager.

Could that be the issue?

seth · 2023-03-14 13:10:34

Yes. If you want to use NM, stop/disable all systemd-network* sockets and services and also iwd.service

LittleSandra · 2023-03-14 23:12:49

Thanks a lot. That did the trick

LittleSandra · 2023-03-15 20:18:39

Ok, so I thought it was fixed... Here is what the logs gives:

Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2229] policy: auto-activating connection 'FTTH_XM9145' (4c443077-e550-4d18-a83e-9c707133d1da)
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2239] device (wlan0): Activation: starting connection 'FTTH_XM9145' (4c443077-e550-4d18-a83e-9c707133d1da)
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2241] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2247] manager: NetworkManager state is now CONNECTING
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2518] device (wlan0): set-hw-addr: reset MAC address to 00:28:F8:75:2C:9F (preserve)
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2580] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2587] device (wlan0): Activation: (wifi) access point 'FTTH_XM9145' has security, but secrets are required.
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2587] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2591] sup-iface[fbd1893b23ead18e,8,wlan0]: wps: type pbc start...
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2597] device (wlan0): supplicant interface state: disconnected -> interface_disabled
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2598] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> interface_disabled
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2617] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2626] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2633] device (wlan0): Activation: (wifi) connection 'FTTH_XM9145' has security, and secrets exist.  No new secrets needed.
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2634] Config: added 'ssid' value 'FTTH_XM9145'
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2634] Config: added 'scan_ssid' value '1'
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2634] Config: added 'bgscan' value 'simple:30:-70:86400'
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2635] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK SAE FT-SAE'
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2635] Config: added 'auth_alg' value 'OPEN'
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2635] Config: added 'psk' value '<hidden>'
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: WPS-CANCEL
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2832] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.2833] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 19:59:48 t470s wpa_supplicant[623]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: SME: Trying to authenticate with 00:1e:80:b0:56:44 (SSID='FTTH_XM9145' freq=5180 MHz)
Mar 15 19:59:48 t470s kernel: wlan0: authenticate with 00:1e:80:b0:56:44
Mar 15 19:59:48 t470s kernel: wlan0: send auth to 00:1e:80:b0:56:44 (try 1/3)
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3180] device (wlan0): supplicant interface state: inactive -> authenticating
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3181] device (p2p-dev-wlan0): supplicant management interface state: inactive -> authenticating
Mar 15 19:59:48 t470s kernel: wlan0: authenticated
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: Trying to associate with 00:1e:80:b0:56:44 (SSID='FTTH_XM9145' freq=5180 MHz)
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3251] device (wlan0): supplicant interface state: authenticating -> associating
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3252] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Mar 15 19:59:48 t470s kernel: wlan0: associate with 00:1e:80:b0:56:44 (try 1/3)
Mar 15 19:59:48 t470s kernel: wlan0: RX AssocResp from 00:1e:80:b0:56:44 (capab=0x1511 status=0 aid=85)
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: Associated with 00:1e:80:b0:56:44
Mar 15 19:59:48 t470s wpa_supplicant[623]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 15 19:59:48 t470s kernel: wlan0: associated
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3445] device (wlan0): supplicant interface state: associating -> associated
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3446] device (p2p-dev-wlan0): supplicant management interface state: associating -> associated
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3937] device (wlan0): supplicant interface state: associated -> 4way_handshake
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.3938] device (p2p-dev-wlan0): supplicant management interface state: associated -> 4way_handshake
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: WPA: Key negotiation completed with 00:1e:80:b0:56:44 [PTK=CCMP GTK=CCMP]
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:1e:80:b0:56:44 completed [id=0 id_str=]
Mar 15 19:59:48 t470s kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.4751] device (wlan0): supplicant interface state: 4way_handshake -> completed
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.4752] device (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "FTTH_XM9145"
Mar 15 19:59:48 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-79 noise=9999 txrate=6000
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.4752] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.4757] device (wlan0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.4767] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.4881] dhcp4 (wlan0): state changed new lease, address=192.168.0.133
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.4892] policy: set 'FTTH_XM9145' (wlan0) as default for IPv4 routing and DNS
Mar 15 19:59:48 t470s systemd-resolved[564]: wlan0: Bus client set default route setting: yes
Mar 15 19:59:48 t470s systemd-resolved[564]: wlan0: Bus client set DNS server list to: 192.168.0.1
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.5338] device (wlan0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.5378] device (wlan0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.5384] device (wlan0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.5396] manager: NetworkManager state is now CONNECTED_SITE
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.5417] device (wlan0): Activation: successful, device activated.
Mar 15 19:59:48 t470s NetworkManager[582]: <info>  [1678906788.6579] manager: NetworkManager state is now CONNECTED_GLOBAL
Mar 15 19:59:49 t470s systemd[1]: systemd-rfkill.service: Deactivated successfully.
Mar 15 19:59:49 t470s systemd-logind[581]: Lid closed.
Mar 15 19:59:51 t470s systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 15 20:00:02 t470s NetworkManager[582]: <info>  [1678906802.5888] policy: set 'FTTH_XM9145' (wlan0) as default for IPv6 routing and DNS
Mar 15 20:00:02 t470s systemd-resolved[564]: wlan0: Bus client set DNS server list to: 192.168.0.1, 2606:4700:4700::1111, 2606:4700:4700::1001
Mar 15 20:02:08 t470s wpa_supplicant[623]: wlan0: SME: Trying to authenticate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 15 20:02:08 t470s kernel: wlan0: disconnect from AP 00:1e:80:b0:56:44 for new auth to 00:1e:80:b0:56:40
Mar 15 20:02:08 t470s kernel: wlan0: authenticate with 00:1e:80:b0:56:40
Mar 15 20:02:08 t470s kernel: wlan0: 80 MHz not supported, disabling VHT
Mar 15 20:02:08 t470s kernel: wlan0: send auth to 00:1e:80:b0:56:40 (try 1/3)
Mar 15 20:02:08 t470s NetworkManager[582]: <info>  [1678906928.9144] device (wlan0): supplicant interface state: completed -> authenticating
Mar 15 20:02:08 t470s NetworkManager[582]: <info>  [1678906928.9153] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating
Mar 15 20:02:08 t470s wpa_supplicant[623]: wlan0: Trying to associate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 15 20:02:08 t470s kernel: wlan0: authenticated
Mar 15 20:02:08 t470s kernel: wlan0: associate with 00:1e:80:b0:56:40 (try 1/3)
Mar 15 20:02:08 t470s kernel: wlan0: RX ReassocResp from 00:1e:80:b0:56:40 (capab=0x411 status=0 aid=5)
Mar 15 20:02:08 t470s NetworkManager[582]: <info>  [1678906928.9387] device (wlan0): supplicant interface state: authenticating -> associating
Mar 15 20:02:08 t470s NetworkManager[582]: <info>  [1678906928.9390] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Mar 15 20:02:08 t470s wpa_supplicant[623]: wlan0: Associated with 00:1e:80:b0:56:40
Mar 15 20:02:08 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 15 20:02:08 t470s kernel: wlan0: associated
Mar 15 20:02:08 t470s NetworkManager[582]: <info>  [1678906928.9469] device (wlan0): supplicant interface state: associating -> 4way_handshake
Mar 15 20:02:08 t470s NetworkManager[582]: <info>  [1678906928.9473] device (p2p-dev-wlan0): supplicant management interface state: associating -> 4way_handshake
Mar 15 20:02:09 t470s wpa_supplicant[623]: wlan0: WPA: Key negotiation completed with 00:1e:80:b0:56:40 [PTK=CCMP GTK=CCMP]
Mar 15 20:02:09 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:1e:80:b0:56:40 completed [id=0 id_str=]
Mar 15 20:02:09 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-73 noise=9999 txrate=6000
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0298] device (wlan0): supplicant interface state: 4way_handshake -> completed
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0305] device (wlan0): ip:dhcp4: restarting
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0539] dhcp4 (wlan0): canceled DHCP transaction
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0539] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0540] dhcp4 (wlan0): state changed no lease
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0541] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0543] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Mar 15 20:02:09 t470s NetworkManager[582]: <info>  [1678906929.0608] dhcp4 (wlan0): state changed new lease, address=192.168.0.133
Mar 15 20:02:09 t470s dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=582 comm="/usr/bin/NetworkManager --no-daemon")
Mar 15 20:02:09 t470s systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 15 20:02:09 t470s dbus-daemon[580]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 15 20:02:09 t470s systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 15 20:02:19 t470s systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 15 20:05:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-73 noise=9999 txrate=57800
Mar 15 20:05:37 t470s wpa_supplicant[623]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF
Mar 15 20:05:37 t470s wpa_supplicant[623]: wlan0: SME: Trying to authenticate with 00:1e:80:b0:56:44 (SSID='FTTH_XM9145' freq=5180 MHz)
Mar 15 20:05:37 t470s kernel: wlan0: disconnect from AP 00:1e:80:b0:56:40 for new auth to 00:1e:80:b0:56:44
Mar 15 20:05:37 t470s kernel: wlan0: authenticate with 00:1e:80:b0:56:44
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.7867] device (wlan0): supplicant interface state: completed -> authenticating
Mar 15 20:05:37 t470s kernel: wlan0: send auth to 00:1e:80:b0:56:44 (try 1/3)
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.7878] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating
Mar 15 20:05:37 t470s wpa_supplicant[623]: wlan0: Trying to associate with 00:1e:80:b0:56:44 (SSID='FTTH_XM9145' freq=5180 MHz)
Mar 15 20:05:37 t470s kernel: wlan0: authenticated
Mar 15 20:05:37 t470s kernel: wlan0: associate with 00:1e:80:b0:56:44 (try 1/3)
Mar 15 20:05:37 t470s kernel: wlan0: RX ReassocResp from 00:1e:80:b0:56:44 (capab=0x1511 status=0 aid=86)
Mar 15 20:05:37 t470s wpa_supplicant[623]: wlan0: Associated with 00:1e:80:b0:56:44
Mar 15 20:05:37 t470s wpa_supplicant[623]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF
Mar 15 20:05:37 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 15 20:05:37 t470s kernel: wlan0: associated
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.8100] device (wlan0): supplicant interface state: authenticating -> associating
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.8100] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.8104] device (wlan0): supplicant interface state: associating -> associated
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.8105] device (p2p-dev-wlan0): supplicant management interface state: associating -> associated
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.8646] device (wlan0): supplicant interface state: associated -> 4way_handshake
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.8649] device (p2p-dev-wlan0): supplicant management interface state: associated -> 4way_handshake
Mar 15 20:05:37 t470s wpa_supplicant[623]: wlan0: WPA: Key negotiation completed with 00:1e:80:b0:56:44 [PTK=CCMP GTK=CCMP]
Mar 15 20:05:37 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:1e:80:b0:56:44 completed [id=0 id_str=]
Mar 15 20:05:37 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-82 noise=9999 txrate=6000
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9125] device (wlan0): supplicant interface state: 4way_handshake -> completed
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9134] device (wlan0): ip:dhcp4: restarting
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9139] dhcp4 (wlan0): canceled DHCP transaction
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9141] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9142] dhcp4 (wlan0): state changed no lease
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9144] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9147] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Mar 15 20:05:37 t470s NetworkManager[582]: <info>  [1678907137.9329] dhcp4 (wlan0): state changed new lease, address=192.168.0.133
Mar 15 20:05:37 t470s dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=582 comm="/usr/bin/NetworkManager --no-daemon")
Mar 15 20:05:37 t470s systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 15 20:05:38 t470s dbus-daemon[580]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 15 20:05:38 t470s systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 15 20:05:48 t470s systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: SME: Trying to authenticate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 15 20:13:03 t470s kernel: wlan0: disconnect from AP 00:1e:80:b0:56:44 for new auth to 00:1e:80:b0:56:40
Mar 15 20:13:03 t470s kernel: wlan0: authenticate with 00:1e:80:b0:56:40
Mar 15 20:13:03 t470s kernel: wlan0: 80 MHz not supported, disabling VHT
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9269] device (wlan0): supplicant interface state: completed -> authenticating
Mar 15 20:13:03 t470s kernel: wlan0: send auth to 00:1e:80:b0:56:40 (try 1/3)
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9275] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: Trying to associate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 15 20:13:03 t470s kernel: wlan0: authenticated
Mar 15 20:13:03 t470s kernel: wlan0: associate with 00:1e:80:b0:56:40 (try 1/3)
Mar 15 20:13:03 t470s kernel: wlan0: RX ReassocResp from 00:1e:80:b0:56:40 (capab=0x411 status=0 aid=3)
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: Associated with 00:1e:80:b0:56:40
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 15 20:13:03 t470s kernel: wlan0: associated
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9506] device (wlan0): supplicant interface state: authenticating -> associating
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9520] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9525] device (wlan0): supplicant interface state: associating -> 4way_handshake
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9528] device (p2p-dev-wlan0): supplicant management interface state: associating -> 4way_handshake
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: WPA: Key negotiation completed with 00:1e:80:b0:56:40 [PTK=CCMP GTK=CCMP]
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:1e:80:b0:56:40 completed [id=0 id_str=]
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-74 noise=9999 txrate=6000
Mar 15 20:13:03 t470s wpa_supplicant[623]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9865] device (wlan0): supplicant interface state: 4way_handshake -> completed
Mar 15 20:13:03 t470s NetworkManager[582]: <info>  [1678907583.9870] device (wlan0): ip:dhcp4: restarting
Mar 15 20:13:04 t470s NetworkManager[582]: <info>  [1678907584.0038] dhcp4 (wlan0): canceled DHCP transaction
Mar 15 20:13:04 t470s NetworkManager[582]: <info>  [1678907584.0041] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 20:13:04 t470s NetworkManager[582]: <info>  [1678907584.0042] dhcp4 (wlan0): state changed no lease
Mar 15 20:13:04 t470s NetworkManager[582]: <info>  [1678907584.0044] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 20:13:04 t470s NetworkManager[582]: <info>  [1678907584.0047] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Mar 15 20:13:04 t470s wpa_supplicant[623]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet
Mar 15 20:13:05 t470s wpa_supplicant[623]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet
Mar 15 20:13:06 t470s NetworkManager[582]: <info>  [1678907586.9882] device (wlan0): supplicant interface state: completed -> 4way_handshake
Mar 15 20:13:06 t470s NetworkManager[582]: <info>  [1678907586.9883] device (p2p-dev-wlan0): supplicant management interface state: completed -> 4way_handshake
Mar 15 20:13:09 t470s systemd-resolved[564]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 2606:4700:4700::1001.
Mar 15 20:13:09 t470s systemd-resolved[564]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 2606:4700:4700::1001.
Mar 15 20:13:09 t470s kernel: wlan0: deauthenticated from 00:1e:80:b0:56:40 (Reason: 15=4WAY_HANDSHAKE_TIMEOUT)
Mar 15 20:13:10 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15
Mar 15 20:13:10 t470s wpa_supplicant[623]: BSSID 00:1e:80:b0:56:40 ignore list count incremented to 2, ignoring for 10 seconds
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.0865] device (wlan0): supplicant interface state: 4way_handshake -> disconnected
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.0866] device (wlan0): Activation: (wifi) disconnected during association, asking for new key
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.0867] device (wlan0): state change: activated -> need-auth (reason 'supplicant-disconnect', sys-iface-state: 'managed')
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.1139] dhcp4 (wlan0): canceled DHCP transaction
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.1140] dhcp4 (wlan0): state changed no lease
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.1145] manager: NetworkManager state is now CONNECTING
Mar 15 20:13:10 t470s dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=582 comm="/usr/bin/NetworkManager --no-daemon")
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.1154] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> disconnected
Mar 15 20:13:10 t470s systemd-resolved[564]: wlan0: Bus client set default route setting: no
Mar 15 20:13:10 t470s systemd-resolved[564]: wlan0: Bus client reset DNS server list.
Mar 15 20:13:10 t470s systemd-resolved[564]: Switching to fallback DNS server 1.1.1.1#cloudflare-dns.com.
Mar 15 20:13:10 t470s systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 15 20:13:10 t470s dbus-daemon[580]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 15 20:13:10 t470s systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 15 20:13:10 t470s NetworkManager[582]: <warn>  [1678907590.1915] device (wlan0): no secrets: No agents were available for this request.
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.1918] device (wlan0): state change: need-auth -> failed (reason 'no-secrets', sys-iface-state: 'managed')
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.1926] manager: NetworkManager state is now DISCONNECTED
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2102] device (wlan0): set-hw-addr: set MAC address to A2:B5:FF:FE:97:1B (scanning)
Mar 15 20:13:10 t470s NetworkManager[582]: <warn>  [1678907590.2161] device (wlan0): Activation: failed for connection 'FTTH_XM9145'
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2163] device (wlan0): supplicant interface state: disconnected -> inactive
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2163] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> inactive
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2164] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2164] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2169] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2311] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 20:13:10 t470s NetworkManager[582]: <info>  [1678907590.2312] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 20:13:20 t470s systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 15 20:20:04 t470s NetworkManager[582]: <info>  [1678908004.2850] device (wlan0): set-hw-addr: set MAC address to 26:96:11:0E:DA:99 (scanning)
Mar 15 20:20:04 t470s NetworkManager[582]: <info>  [1678908004.2908] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 20:20:04 t470s NetworkManager[582]: <info>  [1678908004.2909] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 20:20:04 t470s NetworkManager[582]: <info>  [1678908004.3086] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 20:20:04 t470s NetworkManager[582]: <info>  [1678908004.3086] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 20:26:56 t470s NetworkManager[582]: <info>  [1678908416.1979] device (wlan0): set-hw-addr: set MAC address to FE:0C:3B:4D:EE:10 (scanning)
Mar 15 20:26:56 t470s NetworkManager[582]: <info>  [1678908416.2034] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 20:26:56 t470s NetworkManager[582]: <info>  [1678908416.2035] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 20:26:56 t470s NetworkManager[582]: <info>  [1678908416.2287] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 20:26:56 t470s NetworkManager[582]: <info>  [1678908416.2288] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 20:33:46 t470s NetworkManager[582]: <info>  [1678908826.2147] device (wlan0): set-hw-addr: set MAC address to E6:DF:E3:16:9C:E0 (scanning)
Mar 15 20:33:46 t470s NetworkManager[582]: <info>  [1678908826.2208] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 20:33:46 t470s NetworkManager[582]: <info>  [1678908826.2208] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 20:33:46 t470s NetworkManager[582]: <info>  [1678908826.2385] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 20:33:46 t470s NetworkManager[582]: <info>  [1678908826.2386] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 20:40:38 t470s NetworkManager[582]: <info>  [1678909238.2851] device (wlan0): set-hw-addr: set MAC address to 4A:FE:0C:9D:75:D5 (scanning)
Mar 15 20:40:38 t470s NetworkManager[582]: <info>  [1678909238.2913] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 20:40:38 t470s NetworkManager[582]: <info>  [1678909238.2913] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 20:40:38 t470s NetworkManager[582]: <info>  [1678909238.3152] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 20:40:38 t470s NetworkManager[582]: <info>  [1678909238.3153] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 20:47:30 t470s NetworkManager[582]: <info>  [1678909650.2316] device (wlan0): set-hw-addr: set MAC address to 4A:D9:9E:AB:3B:29 (scanning)
Mar 15 20:47:30 t470s NetworkManager[582]: <info>  [1678909650.2378] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 20:47:30 t470s NetworkManager[582]: <info>  [1678909650.2379] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 20:47:30 t470s NetworkManager[582]: <info>  [1678909650.2388] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 20:47:30 t470s NetworkManager[582]: <info>  [1678909650.2388] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 20:54:24 t470s NetworkManager[582]: <info>  [1678910064.2615] device (wlan0): set-hw-addr: set MAC address to 82:FF:C3:9E:5D:F7 (scanning)
Mar 15 20:54:24 t470s NetworkManager[582]: <info>  [1678910064.2679] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 20:54:24 t470s NetworkManager[582]: <info>  [1678910064.2680] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 20:54:24 t470s NetworkManager[582]: <info>  [1678910064.2852] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 20:54:24 t470s NetworkManager[582]: <info>  [1678910064.2853] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive

After NetworkManager restart it died again after a few minutes again

Mar 15 21:01:17 t470s NetworkManager[582]: <info>  [1678910477.2814] device (wlan0): set-hw-addr: set MAC address to D2:13:C2:6B:FC:17 (scanning)
Mar 15 21:01:17 t470s NetworkManager[582]: <info>  [1678910477.2876] device (wlan0): supplicant interface state: inactive -> interface_disabled
Mar 15 21:01:17 t470s NetworkManager[582]: <info>  [1678910477.2876] device (p2p-dev-wlan0): supplicant management interface state: inactive -> interface_disabled
Mar 15 21:01:17 t470s NetworkManager[582]: <info>  [1678910477.3250] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 21:01:17 t470s NetworkManager[582]: <info>  [1678910477.3251] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 21:01:31 t470s systemd[648]: Started VTE child process 17742 launched by gnome-terminal-server process 1713.
Mar 15 21:01:42 t470s dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.home1' unit='dbus-org.freedesktop.home1.service' requested by ':1.91' (uid=0 pid=17879 comm="sudo systemctl restart NetworkManager")
Mar 15 21:01:42 t470s dbus-daemon[580]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.home1.service': Unit dbus-org.freedesktop.home1.service not found.
Mar 15 21:01:42 t470s sudo[17879]: pam_systemd_home(sudo:auth): systemd-homed is not available: Unit dbus-org.freedesktop.home1.service not found.
Mar 15 21:01:43 t470s sudo[17879]:        a : TTY=pts/1 ; PWD=/home/a ; USER=root ; COMMAND=/usr/bin/systemctl restart NetworkManager
Mar 15 21:01:43 t470s sudo[17879]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 15 21:01:43 t470s systemd[1]: NetworkManager-wait-online.service: Deactivated successfully.
Mar 15 21:01:43 t470s systemd[1]: Stopped Network Manager Wait Online.
Mar 15 21:01:43 t470s systemd[1]: Stopping Network Manager Wait Online...
Mar 15 21:01:43 t470s NetworkManager[582]: <info>  [1678910503.3743] caught SIGTERM, shutting down normally.
Mar 15 21:01:43 t470s systemd[1]: Stopping Network Manager...
Mar 15 21:01:43 t470s NetworkManager[582]: <info>  [1678910503.3759] device (wlan0): state change: disconnected -> unmanaged (reason 'unmanaged', sys-iface-state: 'managed')
Mar 15 21:01:43 t470s NetworkManager[582]: <info>  [1678910503.4083] device (wlan0): set-hw-addr: reset MAC address to 00:28:F8:75:2C:9F (unmanage)
Mar 15 21:01:43 t470s wpa_supplicant[623]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Mar 15 21:01:43 t470s wpa_supplicant[623]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Mar 15 21:01:43 t470s NetworkManager[582]: <info>  [1678910503.4183] device (p2p-dev-wlan0): state change: disconnected -> unmanaged (reason 'removed', sys-iface-state: 'removed')
Mar 15 21:01:43 t470s wpa_supplicant[623]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Mar 15 21:01:43 t470s dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=582 comm="/usr/bin/NetworkManager --no-daemon")
Mar 15 21:01:43 t470s NetworkManager[582]: <info>  [1678910503.4693] exiting (success)
Mar 15 21:01:43 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Mar 15 21:01:43 t470s systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 15 21:01:43 t470s dbus-daemon[580]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 15 21:01:43 t470s systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 15 21:01:43 t470s systemd[1]: NetworkManager.service: Deactivated successfully.
Mar 15 21:01:43 t470s systemd[1]: Stopped Network Manager.
Mar 15 21:01:43 t470s systemd[1]: NetworkManager.service: Consumed 12.037s CPU time.
Mar 15 21:01:43 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Mar 15 21:01:43 t470s wpa_supplicant[623]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Mar 15 21:01:43 t470s systemd[1]: Starting Network Manager...
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.6103] NetworkManager (version 1.42.4-1) is starting... (after a restart, boot:4088cd27-39eb-4994-8f02-8a4ae45abca7)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.6104] Read config: /etc/NetworkManager/NetworkManager.conf (lib: 20-connectivity.conf)
Mar 15 21:01:43 t470s systemd[1]: Started Network Manager.
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.6129] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager"
Mar 15 21:01:43 t470s sudo[17879]: pam_unix(sudo:session): session closed for user root
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.6173] manager[0x5600e7edfd40]: monitoring kernel firmware directory '/lib/firmware'.
Mar 15 21:01:43 t470s dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.93' (uid=0 pid=17891 comm="/usr/bin/NetworkManager --no-daemon")
Mar 15 21:01:43 t470s systemd[1]: Starting Network Manager Wait Online...
Mar 15 21:01:43 t470s systemd[1]: Starting Hostname Service...
Mar 15 21:01:43 t470s dbus-daemon[580]: [system] Successfully activated service 'org.freedesktop.hostname1'
Mar 15 21:01:43 t470s systemd[1]: Started Hostname Service.
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7046] hostname: hostname: using hostnamed
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7046] hostname: static hostname changed from (none) to "t470s"
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7050] dns-mgr: init: dns=default,systemd-resolved rc-manager=symlink
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7068] rfkill2: found Wi-Fi radio killswitch (at /sys/devices/pci0000:00/0000:00:1c.2/0000:3a:00.0/ieee80211/phy0/rfkill2) (driver iwlwifi)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7071] manager[0x5600e7edfd40]: rfkill: Wi-Fi hardware radio set enabled
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7071] manager[0x5600e7edfd40]: rfkill: WWAN hardware radio set enabled
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7089] Loaded device plugin: NMAtmManager (/usr/lib/NetworkManager/1.42.4-1/libnm-device-plugin-adsl.so)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7104] Loaded device plugin: NMBluezManager (/usr/lib/NetworkManager/1.42.4-1/libnm-device-plugin-bluetooth.so)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7107] Loaded device plugin: NMOvsFactory (/usr/lib/NetworkManager/1.42.4-1/libnm-device-plugin-ovs.so)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7144] Loaded device plugin: NMTeamFactory (/usr/lib/NetworkManager/1.42.4-1/libnm-device-plugin-team.so)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7146] Loaded device plugin: NMWifiFactory (/usr/lib/NetworkManager/1.42.4-1/libnm-device-plugin-wifi.so)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7148] Loaded device plugin: NMWwanFactory (/usr/lib/NetworkManager/1.42.4-1/libnm-device-plugin-wwan.so)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7151] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7151] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7152] manager: Networking is enabled by state file
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7153] settings: Loaded settings plugin: keyfile (internal)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7183] dhcp: init: Using DHCP client 'internal'
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7186] manager: (lo): new Loopback device (/org/freedesktop/NetworkManager/Devices/1)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7192] device (lo): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7196] device (lo): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external')
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7204] device (lo): Activation: starting connection 'lo' (4d474e5c-37ef-4a40-b163-cf145e1c0a77)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7213] manager: (enp0s31f6): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7217] device (enp0s31f6): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7231] device (wlan0): driver supports Access Point (AP) mode
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7239] manager: (wlan0): new 802.11 Wi-Fi device (/org/freedesktop/NetworkManager/Devices/3)
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7243] device (wlan0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Mar 15 21:01:43 t470s NetworkManager[17891]: <info>  [1678910503.7694] device (wlan0): set-hw-addr: set MAC address to 82:64:78:67:26:9A (scanning)
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0209] ovsdb: disconnected from ovsdb
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0216] device (lo): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0229] device (lo): state change: prepare -> config (reason 'none', sys-iface-state: 'external')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0244] device (lo): state change: config -> ip-config (reason 'none', sys-iface-state: 'external')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0266] device (lo): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0380] device (lo): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0389] device (lo): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0405] device (lo): Activation: successful, device activated.
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0751] device (wlan0): supplicant interface state: internal-starting -> disconnected
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0753] Wi-Fi P2P device controlled by interface wlan0 created
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0758] manager: (p2p-dev-wlan0): new 802.11 Wi-Fi P2P device (/org/freedesktop/NetworkManager/Devices/4)
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0763] device (p2p-dev-wlan0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0775] device (wlan0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
Mar 15 21:01:44 t470s NetworkManager[17891]: <info>  [1678910504.0786] device (p2p-dev-wlan0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4621] policy: auto-activating connection 'FTTH_XM9145' (4c443077-e550-4d18-a83e-9c707133d1da)
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4625] device (wlan0): Activation: starting connection 'FTTH_XM9145' (4c443077-e550-4d18-a83e-9c707133d1da)
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4626] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4629] manager: NetworkManager state is now CONNECTING
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4849] device (wlan0): set-hw-addr: reset MAC address to 00:28:F8:75:2C:9F (preserve)
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4907] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4915] device (wlan0): Activation: (wifi) access point 'FTTH_XM9145' has security, but secrets are required.
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4915] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4920] sup-iface[1787705af70909b7,9,wlan0]: wps: type pbc start...
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4926] device (wlan0): supplicant interface state: disconnected -> interface_disabled
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4927] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> interface_disabled
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4943] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4951] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4957] device (wlan0): Activation: (wifi) connection 'FTTH_XM9145' has security, and secrets exist.  No new secrets needed.
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4958] Config: added 'ssid' value 'FTTH_XM9145'
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4959] Config: added 'scan_ssid' value '1'
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4959] Config: added 'bgscan' value 'simple:30:-70:86400'
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4959] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK SAE FT-SAE'
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4959] Config: added 'auth_alg' value 'OPEN'
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.4960] Config: added 'psk' value '<hidden>'
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: WPS-CANCEL
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5152] device (wlan0): supplicant interface state: interface_disabled -> inactive
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5152] device (p2p-dev-wlan0): supplicant management interface state: interface_disabled -> inactive
Mar 15 21:01:47 t470s wpa_supplicant[623]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: SME: Trying to authenticate with 00:1e:80:b0:56:44 (SSID='FTTH_XM9145' freq=5180 MHz)
Mar 15 21:01:47 t470s kernel: wlan0: authenticate with 00:1e:80:b0:56:44
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5480] device (wlan0): supplicant interface state: inactive -> authenticating
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5481] device (p2p-dev-wlan0): supplicant management interface state: inactive -> authenticating
Mar 15 21:01:47 t470s kernel: wlan0: send auth to 00:1e:80:b0:56:44 (try 1/3)
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: Trying to associate with 00:1e:80:b0:56:44 (SSID='FTTH_XM9145' freq=5180 MHz)
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5553] device (wlan0): supplicant interface state: authenticating -> associating
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5554] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Mar 15 21:01:47 t470s kernel: wlan0: authenticated
Mar 15 21:01:47 t470s kernel: wlan0: associate with 00:1e:80:b0:56:44 (try 1/3)
Mar 15 21:01:47 t470s kernel: wlan0: RX AssocResp from 00:1e:80:b0:56:44 (capab=0x1511 status=0 aid=90)
Mar 15 21:01:47 t470s kernel: wlan0: associated
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: Associated with 00:1e:80:b0:56:44
Mar 15 21:01:47 t470s wpa_supplicant[623]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5829] device (wlan0): supplicant interface state: associating -> associated
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.5829] device (p2p-dev-wlan0): supplicant management interface state: associating -> associated
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.6481] device (wlan0): supplicant interface state: associated -> 4way_handshake
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.6482] device (p2p-dev-wlan0): supplicant management interface state: associated -> 4way_handshake
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: WPA: Key negotiation completed with 00:1e:80:b0:56:44 [PTK=CCMP GTK=CCMP]
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:1e:80:b0:56:44 completed [id=0 id_str=]
Mar 15 21:01:47 t470s kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7217] device (wlan0): supplicant interface state: 4way_handshake -> completed
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7218] device (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "FTTH_XM9145"
Mar 15 21:01:47 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-85 noise=9999 txrate=6000
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7219] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7221] device (wlan0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7234] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7336] dhcp4 (wlan0): state changed new lease, address=192.168.0.133
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7344] policy: set 'FTTH_XM9145' (wlan0) as default for IPv4 routing and DNS
Mar 15 21:01:47 t470s systemd-resolved[564]: wlan0: Bus client set default route setting: yes
Mar 15 21:01:47 t470s systemd-resolved[564]: wlan0: Bus client set DNS server list to: 192.168.0.1
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7776] device (wlan0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7853] device (wlan0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7859] device (wlan0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7870] manager: NetworkManager state is now CONNECTED_SITE
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.7892] device (wlan0): Activation: successful, device activated.
Mar 15 21:01:47 t470s NetworkManager[17891]: <info>  [1678910507.8997] manager: NetworkManager state is now CONNECTED_GLOBAL
Mar 15 21:01:49 t470s NetworkManager[17891]: <info>  [1678910509.0727] policy: set 'FTTH_XM9145' (wlan0) as default for IPv6 routing and DNS
Mar 15 21:01:49 t470s systemd-resolved[564]: wlan0: Bus client set DNS server list to: 192.168.0.1, 2606:4700:4700::1111, 2606:4700:4700::1001
Mar 15 21:01:49 t470s NetworkManager[17891]: <info>  [1678910509.7236] manager: startup complete
Mar 15 21:01:49 t470s systemd[1]: Finished Network Manager Wait Online.
Mar 15 21:01:53 t470s systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 15 21:02:05 t470s su[17723]: pam_unix(su-l:session): session closed for user root
Mar 15 21:02:13 t470s systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Mar 15 21:07:53 t470s wpa_supplicant[623]: wlan0: SME: Trying to authenticate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 15 21:07:53 t470s kernel: wlan0: disconnect from AP 00:1e:80:b0:56:44 for new auth to 00:1e:80:b0:56:40
Mar 15 21:07:53 t470s kernel: wlan0: authenticate with 00:1e:80:b0:56:40
Mar 15 21:07:53 t470s kernel: wlan0: 80 MHz not supported, disabling VHT
Mar 15 21:07:53 t470s kernel: wlan0: send auth to 00:1e:80:b0:56:40 (try 1/3)
Mar 15 21:07:53 t470s NetworkManager[17891]: <info>  [1678910873.9205] device (wlan0): supplicant interface state: completed -> authenticating
Mar 15 21:07:53 t470s NetworkManager[17891]: <info>  [1678910873.9227] device (p2p-dev-wlan0): supplicant management interface state: completed -> authenticating
Mar 15 21:07:53 t470s wpa_supplicant[623]: wlan0: Trying to associate with 00:1e:80:b0:56:40 (SSID='FTTH_XM9145' freq=2412 MHz)
Mar 15 21:07:53 t470s kernel: wlan0: authenticated
Mar 15 21:07:53 t470s NetworkManager[17891]: <info>  [1678910873.9458] device (wlan0): supplicant interface state: authenticating -> associating
Mar 15 21:07:53 t470s NetworkManager[17891]: <info>  [1678910873.9463] device (p2p-dev-wlan0): supplicant management interface state: authenticating -> associating
Mar 15 21:07:53 t470s kernel: wlan0: associate with 00:1e:80:b0:56:40 (try 1/3)
Mar 15 21:07:53 t470s kernel: wlan0: RX ReassocResp from 00:1e:80:b0:56:40 (capab=0x411 status=0 aid=1)
Mar 15 21:07:53 t470s kernel: wlan0: associated
Mar 15 21:07:53 t470s wpa_supplicant[623]: wlan0: Associated with 00:1e:80:b0:56:40
Mar 15 21:07:53 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 15 21:07:53 t470s NetworkManager[17891]: <info>  [1678910873.9569] device (wlan0): supplicant interface state: associating -> 4way_handshake
Mar 15 21:07:53 t470s NetworkManager[17891]: <info>  [1678910873.9570] device (p2p-dev-wlan0): supplicant management interface state: associating -> 4way_handshake
Mar 15 21:07:54 t470s wpa_supplicant[623]: wlan0: WPA: Key negotiation completed with 00:1e:80:b0:56:40 [PTK=CCMP GTK=CCMP]
Mar 15 21:07:54 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:1e:80:b0:56:40 completed [id=0 id_str=]
Mar 15 21:07:54 t470s wpa_supplicant[623]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet
Mar 15 21:07:54 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-76 noise=9999 txrate=6000
Mar 15 21:07:54 t470s NetworkManager[17891]: <info>  [1678910874.0766] device (wlan0): supplicant interface state: 4way_handshake -> completed
Mar 15 21:07:54 t470s NetworkManager[17891]: <info>  [1678910874.0771] device (wlan0): ip:dhcp4: restarting
Mar 15 21:07:54 t470s NetworkManager[17891]: <info>  [1678910874.0937] dhcp4 (wlan0): canceled DHCP transaction
Mar 15 21:07:54 t470s NetworkManager[17891]: <info>  [1678910874.0938] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 21:07:54 t470s NetworkManager[17891]: <info>  [1678910874.0938] dhcp4 (wlan0): state changed no lease
Mar 15 21:07:54 t470s NetworkManager[17891]: <info>  [1678910874.0939] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 21:07:54 t470s NetworkManager[17891]: <info>  [1678910874.0940] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> completed
Mar 15 21:07:55 t470s NetworkManager[17891]: <info>  [1678910875.0792] device (wlan0): supplicant interface state: completed -> 4way_handshake
Mar 15 21:07:55 t470s NetworkManager[17891]: <info>  [1678910875.0793] device (p2p-dev-wlan0): supplicant management interface state: completed -> 4way_handshake
Mar 15 21:07:57 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-66 noise=9999 txrate=57800
Mar 15 21:07:59 t470s systemd-resolved[564]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 2606:4700:4700::1111.
Mar 15 21:07:59 t470s systemd-resolved[564]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 2606:4700:4700::1111.
Mar 15 21:08:00 t470s kernel: wlan0: deauthenticated from 00:1e:80:b0:56:40 (Reason: 15=4WAY_HANDSHAKE_TIMEOUT)
Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-9999 noise=9999 txrate=0
Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-9999 noise=9999 txrate=0
Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15
Mar 15 21:08:00 t470s wpa_supplicant[623]: BSSID 00:1e:80:b0:56:40 ignore list count incremented to 2, ignoring for 10 seconds
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2109] device (wlan0): supplicant interface state: 4way_handshake -> disconnected
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2117] device (wlan0): Activation: (wifi) disconnected during association, asking for new key
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2129] device (wlan0): state change: activated -> need-auth (reason 'supplicant-disconnect', sys-iface-state: 'managed')
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2268] dhcp4 (wlan0): canceled DHCP transaction
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2271] dhcp4 (wlan0): state changed no lease
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2284] manager: NetworkManager state is now CONNECTING
Mar 15 21:08:00 t470s dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.93' (uid=0 pid=17891 comm="/usr/bin/NetworkManager --no-daemon")
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2340] device (p2p-dev-wlan0): supplicant management interface state: 4way_handshake -> disconnected
Mar 15 21:08:00 t470s systemd-resolved[564]: wlan0: Bus client set default route setting: no
Mar 15 21:08:00 t470s systemd-resolved[564]: wlan0: Bus client reset DNS server list.
Mar 15 21:08:00 t470s systemd-resolved[564]: Switching to fallback DNS server 1.1.1.1#cloudflare-dns.com.
Mar 15 21:08:00 t470s systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 15 21:08:00 t470s dbus-daemon[580]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 15 21:08:00 t470s systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 15 21:08:00 t470s NetworkManager[17891]: <warn>  [1678910880.2983] device (wlan0): no secrets: No agents were available for this request.
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2983] device (wlan0): state change: need-auth -> failed (reason 'no-secrets', sys-iface-state: 'managed')
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.2992] manager: NetworkManager state is now DISCONNECTED
Mar 15 21:08:00 t470s NetworkManager[17891]: <warn>  [1678910880.2994] device (wlan0): Activation: failed for connection 'FTTH_XM9145'
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.3002] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.3390] device (wlan0): set-hw-addr: set MAC address to E2:35:50:34:51:52 (scanning)
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.3452] device (wlan0): supplicant interface state: disconnected -> inactive
Mar 15 21:08:00 t470s NetworkManager[17891]: <info>  [1678910880.3454] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> inactive
Mar 15 21:08:10 t470s systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.

seth · 2023-03-15 20:42:09

Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-9999 noise=9999 txrate=0
Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-9999 noise=9999 txrate=0

Is the journal filtered?
Please post your complete system journal for the boot:

sudo journalctl -b | curl -F 'file=@-' 0x0.st

LittleSandra · 2023-03-15 21:01:56

seth wrote:

Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-9999 noise=9999 txrate=0
Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-9999 noise=9999 txrate=0

Is the journal filtered?
Please post your complete system journal for the boot:

sudo journalctl -b | curl -F 'file=@-' 0x0.st

I haven't added any filters to my knowledge. Here is the complete since boot

http://0x0.st/H-qy.txt

seth · 2023-03-15 22:29:01

Mar 14 14:50:45 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 14 21:19:23 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=3 locally_generated=1
Mar 14 22:03:18 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 01:10:36 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 08:27:42 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 12:34:05 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 16:44:33 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 19:11:31 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 20:13:10 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15
Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15
Mar 15 21:31:41 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15

So there's a bunch of disconnects by local choice and finally the most recent three are because of a 4way handshake timeout.

At this time you get

wpa_supplicant[623]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet

The signal is generally not great (most of the time it's poor, sometimes abysmal)
There're two APs w/ the same SSID, try to pin the connection to the 2.4GHz AP w/ the bssid 00:1e:80:b0:56:40

LittleSandra · 2023-03-17 14:47:43

seth wrote:

Mar 14 14:50:45 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 14 21:19:23 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=3 locally_generated=1
Mar 14 22:03:18 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 01:10:36 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 08:27:42 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 12:34:05 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 16:44:33 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 19:11:31 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:44 reason=3 locally_generated=1
Mar 15 20:13:10 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15
Mar 15 21:08:00 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15
Mar 15 21:31:41 t470s wpa_supplicant[623]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:1e:80:b0:56:40 reason=15

So there's a bunch of disconnects by local choice and finally the most recent three are because of a 4way handshake timeout.

At this time you get

wpa_supplicant[623]: wlan0: WPA: EAPOL-Key Replay Counter did not increase - dropping packet

The signal is generally not great (most of the time it's poor, sometimes abysmal)
There're two APs w/ the same SSID, try to pin the connection to the 2.4GHz AP w/ the bssid 00:1e:80:b0:56:40

I have now disabled the 5GHz signal, so now ther eis only one SSID and pinned the BSSID in NetworkManager.

Thanks again for your help

Arch Linux

#1 2023-03-12 11:47:07

[Solved] Network dies about every hour and have restart NetworkManager

#2 2023-03-12 12:14:27

Re: [Solved] Network dies about every hour and have restart NetworkManager

#3 2023-03-14 01:08:00

Re: [Solved] Network dies about every hour and have restart NetworkManager

#4 2023-03-14 07:05:46

Re: [Solved] Network dies about every hour and have restart NetworkManager

#5 2023-03-14 09:06:29

Re: [Solved] Network dies about every hour and have restart NetworkManager

#6 2023-03-14 13:01:05

Re: [Solved] Network dies about every hour and have restart NetworkManager

#7 2023-03-14 13:02:34

Re: [Solved] Network dies about every hour and have restart NetworkManager

#8 2023-03-14 13:10:34

Re: [Solved] Network dies about every hour and have restart NetworkManager

#9 2023-03-14 23:12:49

Re: [Solved] Network dies about every hour and have restart NetworkManager

#10 2023-03-15 20:18:39

Re: [Solved] Network dies about every hour and have restart NetworkManager

#11 2023-03-15 20:42:09

Re: [Solved] Network dies about every hour and have restart NetworkManager

#12 2023-03-15 21:01:56

Re: [Solved] Network dies about every hour and have restart NetworkManager

#13 2023-03-15 22:29:01

Re: [Solved] Network dies about every hour and have restart NetworkManager

#14 2023-03-17 14:47:43

Re: [Solved] Network dies about every hour and have restart NetworkManager

Board footer