Big issues connecting and using wifi / nm + crda issues

This forum is for discussion about general software issues.

Big issues connecting and using wifi / nm + crda issues

Postby zimmy » Fri Aug 19, 2022 11:37 pm

Im legit ripping my hair out from a few hours.

Little intro:
Im running arch arm on raspberry pi 4, Im connecting to my home network using NetworkManager (enabled via systemctl). Im using my Pi to run a few web-apps on docker + portainer which works really well.
A while back i reinstalled arch linux since i had massive issues with connectivity with NetworkManager, it was fine for a few months until now, NetworkManager just disconnects randomly and never connects again.
I also ran my pi at 192.168.1.200/24 and set that using nmtui

Troubleshooting and stuff i done:
Reinstalled NetworkManager obv
I spent half of my day looking through wikis, forums and other simmilar issues but none resolved my troubles.
I made 2 files in /etc/NetworkManager/conf.d/ (directory was previously empty)

  • /etc/NetworkManager/conf.d/dhcp-client.conf

$this->bbcode_second_pass_code('', '[main]
dhcp=dhclient
')
  • /etc/NetworkManager/conf.d/wifi_rand_mac.conf

$this->bbcode_second_pass_code('', '[device]
wifi.scan-rand-mac-address=no')

Prior to setting a diffirent dhcp-client i have installed dhclient and ran sudo systemctl enable --now dhclient@wlan0.service
I have disabled all systemd-networkd services as recommended and dhcpcd, also installed gnome-polkit since network manager threw me an error that org.freedesktop.policykit1 is not a running .service
I fiddled a bit with nmcli and forgot + recconected my network using this troubleshooting guide

$this->bbcode_second_pass_code('', '$ nmcli connection delete SSID
$ nmcli device wifi connect SSID password password')

It worked but with massive latency pinging to google.com, i changed the ipv4 back 192.168.1.200/24 using nmcli this time but then it stopped working again

output from "journalctl -u NetworkManager"

$this->bbcode_second_pass_code('', '
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4228] Config: added 'ssid' value 'mizyx_net5g'
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4228] Config: added 'scan_ssid' value '1'
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4228] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4229] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK'
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4229] Config: added 'auth_alg' value 'OPEN'
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4229] Config: added 'psk' value '<hidden>'
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4642] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:50:38 raspi4 NetworkManager[375]: <info> [1660942238.4643] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:51:03 raspi4 NetworkManager[375]: <warn> [1660942263.6545] device (wlan0): Activation: (wifi) association took too long, failing activation
Aug 19 22:51:03 raspi4 NetworkManager[375]: <info> [1660942263.6546] device (wlan0): state change: config -> failed (reason 'ssid-not-found', sys-iface-state: 'managed')
Aug 19 22:51:03 raspi4 NetworkManager[375]: <info> [1660942263.6554] manager: NetworkManager state is now CONNECTED_LOCAL
Aug 19 22:51:03 raspi4 NetworkManager[375]: <warn> [1660942263.6565] device (wlan0): Activation: failed for connection 'mizyx_net5g'
Aug 19 22:51:03 raspi4 NetworkManager[375]: <info> [1660942263.6573] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:03 raspi4 NetworkManager[375]: <info> [1660942263.6758] device (wlan0): supplicant interface state: scanning -> disconnected
Aug 19 22:51:03 raspi4 NetworkManager[375]: <info> [1660942263.6759] device (p2p-dev-wlan0): supplicant management interface state: scanning -> disconnected
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8801] policy: auto-activating connection 'mizyx_net5g' (6729b7a9-e366-462c-bd76-f9811742d4e7)
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8817] device (wlan0): Activation: starting connection 'mizyx_net5g' (6729b7a9-e366-462c-bd76-f9811742d4e7)
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8821] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8829] manager: NetworkManager state is now CONNECTING
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8838] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8846] device (wlan0): Activation: (wifi) access point 'mizyx_net5g' has security, but secrets are required.
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8847] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8882] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8893] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8904] device (wlan0): Activation: (wifi) connection 'mizyx_net5g' has security, and secrets exist. No new secrets needed.
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8906] Config: added 'ssid' value 'mizyx_net5g'
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8907] Config: added 'scan_ssid' value '1'
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8907] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8908] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK'
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8908] Config: added 'auth_alg' value 'OPEN'
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.8908] Config: added 'psk' value '<hidden>'
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.9322] device (wlan0): supplicant interface state: disconnected -> associating
Aug 19 22:51:04 raspi4 NetworkManager[375]: <info> [1660942264.9322] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> associating
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.2177] device (wlan0): supplicant interface state: associating -> completed
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.2178] device (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "mizyx_net5g"
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.2178] device (p2p-dev-wlan0): supplicant management interface state: associating -> completed
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.2182] device (wlan0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.2214] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.2266] dhcp4 (wlan0): dhclient started with pid 2524
Aug 19 22:51:08 raspi4 dhclient[2524]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 6
Aug 19 22:51:08 raspi4 dhclient[2524]: DHCPOFFER of 192.168.1.104 from 192.168.1.1
Aug 19 22:51:08 raspi4 dhclient[2524]: DHCPREQUEST for 192.168.1.104 on wlan0 to 255.255.255.255 port 67
Aug 19 22:51:08 raspi4 dhclient[2524]: DHCPACK of 192.168.1.104 from 192.168.1.1
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3213] dhcp4 (wlan0): address 192.168.1.104
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3213] dhcp4 (wlan0): plen 24 (255.255.255.0)
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3214] dhcp4 (wlan0): gateway 192.168.1.1
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3214] dhcp4 (wlan0): lease time 7200
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3214] dhcp4 (wlan0): nameserver '192.168.1.1'
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3215] dhcp4 (wlan0): state changed new lease, address=192.168.1.104
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3229] policy: set 'mizyx_net5g' (wlan0) as default for IPv4 routing and DNS
Aug 19 22:51:08 raspi4 dhclient[2524]: bound to 192.168.1.104 -- renewal in 3147 seconds.
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3370] device (wlan0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3705] device (wlan0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3713] device (wlan0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3723] manager: NetworkManager state is now CONNECTED_SITE
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.3751] device (wlan0): Activation: successful, device activated.
Aug 19 22:51:08 raspi4 NetworkManager[375]: <info> [1660942268.9513] manager: NetworkManager state is now CONNECTED_GLOBAL
Aug 19 22:54:26 raspi4 NetworkManager[375]: <info> [1660942466.8787] device (wlan0): supplicant interface state: completed -> disconnected
Aug 19 22:54:26 raspi4 NetworkManager[375]: <info> [1660942466.8788] device (p2p-dev-wlan0): supplicant management interface state: completed -> disconnected
Aug 19 22:54:26 raspi4 NetworkManager[375]: <info> [1660942466.9759] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:54:26 raspi4 NetworkManager[375]: <info> [1660942466.9760] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:54:42 raspi4 NetworkManager[375]: <warn> [1660942482.5338] device (wlan0): link timed out.
Aug 19 22:54:42 raspi4 NetworkManager[375]: <info> [1660942482.5339] device (wlan0): state change: activated -> failed (reason 'ssid-not-found', sys-iface-state: 'managed')
Aug 19 22:54:42 raspi4 NetworkManager[375]: <warn> [1660942482.5358] device (wlan0): Activation: failed for connection 'mizyx_net5g'
Aug 19 22:54:42 raspi4 NetworkManager[375]: <info> [1660942482.5375] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Aug 19 22:54:42 raspi4 NetworkManager[375]: <info> [1660942482.5475] dhcp4 (wlan0): canceled DHCP transaction, DHCP client pid 2524
Aug 19 22:54:42 raspi4 NetworkManager[375]: <info> [1660942482.5476] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Aug 19 22:54:42 raspi4 NetworkManager[375]: <info> [1660942482.5477] dhcp4 (wlan0): state changed no lease
Aug 19 22:54:42 raspi4 NetworkManager[375]: <info> [1660942482.6090] manager: NetworkManager state is now CONNECTED_LOCAL
Aug 19 22:54:50 raspi4 NetworkManager[375]: <info> [1660942490.8633] audit: op="connection-update" uuid="6729b7a9-e366-462c-bd76-f9811742d4e7" name="mizyx_net5g" args="connection.timestamp,ipv4.gateway,ipv4.method,ipv4.addresses" pid=2559 uid=0 result="success"
Aug 19 22:54:51 raspi4 NetworkManager[375]: <info> [1660942491.6436] device (wlan0): supplicant interface state: scanning -> inactive
Aug 19 22:54:51 raspi4 NetworkManager[375]: <info> [1660942491.6437] device (p2p-dev-wlan0): supplicant management interface state: scanning -> inactive
Aug 19 22:55:19 raspi4 NetworkManager[375]: <info> [1660942519.5587] audit: op="connection-update" uuid="6729b7a9-e366-462c-bd76-f9811742d4e7" name="mizyx_net5g" args="connection.timestamp,ipv4.gateway,ipv4.method,ipv4.addresses" pid=2591 uid=0 result="success"
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3651] policy: auto-activating connection 'mizyx_net5g' (6729b7a9-e366-462c-bd76-f9811742d4e7)
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3664] device (wlan0): Activation: starting connection 'mizyx_net5g' (6729b7a9-e366-462c-bd76-f9811742d4e7)
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3668] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3675] manager: NetworkManager state is now CONNECTING
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3683] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3691] device (wlan0): Activation: (wifi) access point 'mizyx_net5g' has security, but secrets are required.
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3692] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3722] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3730] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3738] device (wlan0): Activation: (wifi) connection 'mizyx_net5g' has security, and secrets exist. No new secrets needed.
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3739] Config: added 'ssid' value 'mizyx_net5g'
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3739] Config: added 'scan_ssid' value '1'
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3740] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3741] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK'
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3741] Config: added 'auth_alg' value 'OPEN'
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.3741] Config: added 'psk' value '<hidden>'
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.4137] device (wlan0): supplicant interface state: inactive -> associating
Aug 19 22:55:25 raspi4 NetworkManager[375]: <info> [1660942525.4138] device (p2p-dev-wlan0): supplicant management interface state: inactive -> associating
Aug 19 22:55:28 raspi4 NetworkManager[375]: <info> [1660942528.2371] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:55:28 raspi4 NetworkManager[375]: <info> [1660942528.2373] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:55:28 raspi4 NetworkManager[375]: <info> [1660942528.7562] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:55:28 raspi4 NetworkManager[375]: <info> [1660942528.7563] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:55:31 raspi4 NetworkManager[375]: <info> [1660942531.5689] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:55:31 raspi4 NetworkManager[375]: <info> [1660942531.5690] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:55:34 raspi4 NetworkManager[375]: <info> [1660942534.3859] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:55:34 raspi4 NetworkManager[375]: <info> [1660942534.3860] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:55:35 raspi4 NetworkManager[375]: <info> [1660942535.4059] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:55:35 raspi4 NetworkManager[375]: <info> [1660942535.4060] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:55:38 raspi4 NetworkManager[375]: <info> [1660942538.2246] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:55:38 raspi4 NetworkManager[375]: <info> [1660942538.2246] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1375] device (wlan0): supplicant interface state: associating -> completed
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1376] device (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "mizyx_net5g"
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1376] device (p2p-dev-wlan0): supplicant management interface state: associating -> completed
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1380] device (wlan0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1398] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1449] dhcp4 (wlan0): dhclient started with pid 2598
Aug 19 22:55:42 raspi4 dhclient[2598]: DHCPREQUEST for 192.168.1.104 on wlan0 to 255.255.255.255 port 67
Aug 19 22:55:42 raspi4 dhclient[2598]: DHCPACK of 192.168.1.104 from 192.168.1.1
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1893] dhcp4 (wlan0): address 192.168.1.104
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1894] dhcp4 (wlan0): plen 24 (255.255.255.0)
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1894] dhcp4 (wlan0): gateway 192.168.1.1
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1894] dhcp4 (wlan0): lease time 7200
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1895] dhcp4 (wlan0): nameserver '192.168.1.1'
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1895] dhcp4 (wlan0): state changed new lease, address=192.168.1.104
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.1933] policy: set 'mizyx_net5g' (wlan0) as default for IPv4 routing and DNS
Aug 19 22:55:42 raspi4 dhclient[2598]: bound to 192.168.1.104 -- renewal in 3516 seconds.
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.2139] device (wlan0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.2260] device (wlan0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.2266] device (wlan0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.2275] manager: NetworkManager state is now CONNECTED_SITE
Aug 19 22:55:42 raspi4 NetworkManager[375]: <info> [1660942542.2466] device (wlan0): Activation: successful, device activated.
Aug 19 22:55:45 raspi4 NetworkManager[375]: <info> [1660942545.0844] manager: NetworkManager state is now CONNECTED_GLOBAL
Aug 19 22:58:14 raspi4 NetworkManager[375]: <info> [1660942694.6287] device (wlan0): supplicant interface state: completed -> disconnected
Aug 19 22:58:14 raspi4 NetworkManager[375]: <info> [1660942694.6288] device (p2p-dev-wlan0): supplicant management interface state: completed -> disconnected
Aug 19 22:58:14 raspi4 NetworkManager[375]: <info> [1660942694.7276] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:58:14 raspi4 NetworkManager[375]: <info> [1660942694.7277] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:58:17 raspi4 NetworkManager[375]: <info> [1660942697.5355] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:58:17 raspi4 NetworkManager[375]: <info> [1660942697.5356] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:58:20 raspi4 NetworkManager[375]: <info> [1660942700.3522] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:58:20 raspi4 NetworkManager[375]: <info> [1660942700.3523] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:58:20 raspi4 NetworkManager[375]: <info> [1660942700.8711] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:58:20 raspi4 NetworkManager[375]: <info> [1660942700.8712] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:58:23 raspi4 NetworkManager[375]: <info> [1660942703.6813] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:58:23 raspi4 NetworkManager[375]: <info> [1660942703.6814] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:58:26 raspi4 NetworkManager[375]: <info> [1660942706.4909] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:58:26 raspi4 NetworkManager[375]: <info> [1660942706.4910] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:58:27 raspi4 NetworkManager[375]: <info> [1660942707.5104] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:58:27 raspi4 NetworkManager[375]: <info> [1660942707.5105] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:58:29 raspi4 NetworkManager[375]: <warn> [1660942709.5308] device (wlan0): link timed out.
Aug 19 22:58:29 raspi4 NetworkManager[375]: <info> [1660942709.5308] device (wlan0): state change: activated -> failed (reason 'supplicant-timeout', sys-iface-state: 'managed')
Aug 19 22:58:29 raspi4 NetworkManager[375]: <warn> [1660942709.5327] device (wlan0): Activation: failed for connection 'mizyx_net5g'
Aug 19 22:58:29 raspi4 NetworkManager[375]: <info> [1660942709.5344] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:29 raspi4 NetworkManager[375]: <info> [1660942709.5410] dhcp4 (wlan0): canceled DHCP transaction, DHCP client pid 2598
Aug 19 22:58:29 raspi4 NetworkManager[375]: <info> [1660942709.5411] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Aug 19 22:58:29 raspi4 NetworkManager[375]: <info> [1660942709.5411] dhcp4 (wlan0): state changed no lease
Aug 19 22:58:29 raspi4 NetworkManager[375]: <info> [1660942709.5637] manager: NetworkManager state is now CONNECTED_LOCAL
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3237] device (wlan0): supplicant interface state: scanning -> disconnected
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3238] device (p2p-dev-wlan0): supplicant management interface state: scanning -> disconnected
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3248] policy: auto-activating connection 'mizyx_net5g' (6729b7a9-e366-462c-bd76-f9811742d4e7)
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3263] device (wlan0): Activation: starting connection 'mizyx_net5g' (6729b7a9-e366-462c-bd76-f9811742d4e7)
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3266] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3274] manager: NetworkManager state is now CONNECTING
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3281] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3291] device (wlan0): Activation: (wifi) access point 'mizyx_net5g' has security, but secrets are required.
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3291] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3327] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3335] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3344] device (wlan0): Activation: (wifi) connection 'mizyx_net5g' has security, and secrets exist. No new secrets needed.
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3345] Config: added 'ssid' value 'mizyx_net5g'
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3346] Config: added 'scan_ssid' value '1'
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3346] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3347] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK'
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3347] Config: added 'auth_alg' value 'OPEN'
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3347] Config: added 'psk' value '<hidden>'
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3597] device (wlan0): supplicant interface state: disconnected -> associating
Aug 19 22:58:30 raspi4 NetworkManager[375]: <info> [1660942710.3598] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> associating
Aug 19 22:58:33 raspi4 NetworkManager[375]: <info> [1660942713.1708] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:58:33 raspi4 NetworkManager[375]: <info> [1660942713.1709] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:58:38 raspi4 NetworkManager[375]: <info> [1660942718.1917] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:58:38 raspi4 NetworkManager[375]: <info> [1660942718.1918] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:58:43 raspi4 NetworkManager[375]: <info> [1660942723.0364] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:58:43 raspi4 NetworkManager[375]: <info> [1660942723.0365] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:58:45 raspi4 NetworkManager[375]: <info> [1660942725.8531] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:58:45 raspi4 NetworkManager[375]: <info> [1660942725.8533] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:58:55 raspi4 NetworkManager[375]: <warn> [1660942735.5295] device (wlan0): Activation: (wifi) association took too long
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5296] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:55 raspi4 NetworkManager[375]: <warn> [1660942735.5305] device (wlan0): Activation: (wifi) asking for new secrets
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5330] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5338] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5350] device (wlan0): Activation: (wifi) connection 'mizyx_net5g' has security, and secrets exist. No new secrets needed.
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5350] Config: added 'ssid' value 'mizyx_net5g'
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5351] Config: added 'scan_ssid' value '1'
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5351] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5351] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK'
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5352] Config: added 'auth_alg' value 'OPEN'
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5352] Config: added 'psk' value '<hidden>'
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5744] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:58:55 raspi4 NetworkManager[375]: <info> [1660942735.5744] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:59:06 raspi4 NetworkManager[375]: <info> [1660942746.2520] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:59:06 raspi4 NetworkManager[375]: <info> [1660942746.2521] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:59:09 raspi4 NetworkManager[375]: <info> [1660942749.0660] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:59:09 raspi4 NetworkManager[375]: <info> [1660942749.0661] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:59:19 raspi4 NetworkManager[375]: <info> [1660942759.0873] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:59:19 raspi4 NetworkManager[375]: <info> [1660942759.0874] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:59:20 raspi4 NetworkManager[375]: <warn> [1660942760.5304] device (wlan0): Activation: (wifi) association took too long
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5304] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Aug 19 22:59:20 raspi4 NetworkManager[375]: <warn> [1660942760.5315] device (wlan0): Activation: (wifi) asking for new secrets
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5344] device (wlan0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5352] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5361] device (wlan0): Activation: (wifi) connection 'mizyx_net5g' has security, and secrets exist. No new secrets needed.
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5362] Config: added 'ssid' value 'mizyx_net5g'
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5363] Config: added 'scan_ssid' value '1'
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5363] Config: added 'bgscan' value 'simple:30:-70:86400'
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5364] Config: added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256 FT-PSK'
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5364] Config: added 'auth_alg' value 'OPEN'
Aug 19 22:59:20 raspi4 NetworkManager[375]: <info> [1660942760.5365] Config: added 'psk' value '<hidden>'
Aug 19 22:59:21 raspi4 NetworkManager[375]: <info> [1660942761.9215] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:59:21 raspi4 NetworkManager[375]: <info> [1660942761.9216] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:59:24 raspi4 NetworkManager[375]: <info> [1660942764.7364] device (wlan0): supplicant interface state: associating -> disconnected
Aug 19 22:59:24 raspi4 NetworkManager[375]: <info> [1660942764.7365] device (p2p-dev-wlan0): supplicant management interface state: associating -> disconnected
Aug 19 22:59:34 raspi4 NetworkManager[375]: <info> [1660942774.7638] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 22:59:34 raspi4 NetworkManager[375]: <info> [1660942774.7639] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 22:59:37 raspi4 NetworkManager[375]: <info> [1660942777.5966] device (wlan0): supplicant interface state: scanning -> associating
Aug 19 22:59:37 raspi4 NetworkManager[375]: <info> [1660942777.5967] device (p2p-dev-wlan0): supplicant management interface state: scanning -> associating
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.6860] device (wlan0): supplicant interface state: associating -> completed
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.6861] device (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "mizyx_net5g"
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.6862] device (p2p-dev-wlan0): supplicant management interface state: associating -> completed
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.6865] device (wlan0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.6880] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.6925] dhcp4 (wlan0): dhclient started with pid 2649
Aug 19 22:59:40 raspi4 dhclient[2649]: DHCPREQUEST for 192.168.1.104 on wlan0 to 255.255.255.255 port 67
Aug 19 22:59:40 raspi4 dhclient[2649]: DHCPACK of 192.168.1.104 from 192.168.1.1
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7487] dhcp4 (wlan0): address 192.168.1.104
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7487] dhcp4 (wlan0): plen 24 (255.255.255.0)
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7488] dhcp4 (wlan0): gateway 192.168.1.1
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7488] dhcp4 (wlan0): lease time 7200
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7488] dhcp4 (wlan0): nameserver '192.168.1.1'
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7489] dhcp4 (wlan0): state changed new lease, address=192.168.1.104
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7514] policy: set 'mizyx_net5g' (wlan0) as default for IPv4 routing and DNS
Aug 19 22:59:40 raspi4 dhclient[2649]: bound to 192.168.1.104 -- renewal in 2940 seconds.
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7711] device (wlan0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7858] device (wlan0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7864] device (wlan0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7873] manager: NetworkManager state is now CONNECTED_SITE
Aug 19 22:59:40 raspi4 NetworkManager[375]: <info> [1660942780.7910] device (wlan0): Activation: successful, device activated.
Aug 19 22:59:43 raspi4 NetworkManager[375]: <info> [1660942783.0865] manager: NetworkManager state is now CONNECTED_GLOBAL
Aug 19 23:00:50 raspi4 NetworkManager[375]: <info> [1660942850.0651] audit: op="connection-update" uuid="6729b7a9-e366-462c-bd76-f9811742d4e7" name="mizyx_net5g" args="connection.timestamp,ipv4.addresses" pid=2693 uid=1000 result="success"
Aug 19 23:01:42 raspi4 NetworkManager[375]: <info> [1660942902.8871] device (wlan0): supplicant interface state: completed -> disconnected
Aug 19 23:01:42 raspi4 NetworkManager[375]: <info> [1660942902.8872] device (p2p-dev-wlan0): supplicant management interface state: completed -> disconnected
Aug 19 23:01:42 raspi4 NetworkManager[375]: <info> [1660942902.9849] device (wlan0): supplicant interface state: disconnected -> scanning
Aug 19 23:01:42 raspi4 NetworkManager[375]: <info> [1660942902.9849] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> scanning
Aug 19 23:01:54 raspi4 NetworkManager[375]: <info> [1660942914.3529] audit: op="connection-update" uuid="6729b7a9-e366-462c-bd76-f9811742d4e7" name="mizyx_net5g" args="ipv4.gateway" pid=2707 uid=0 result="success"
Aug 19 23:01:58 raspi4 NetworkManager[375]: <warn> [1660942918.5332] device (wlan0): link timed out.
Aug 19 23:01:58 raspi4 NetworkManager[375]: <info> [1660942918.5333] device (wlan0): state change: activated -> failed (reason 'ssid-not-found', sys-iface-state: 'managed')
Aug 19 23:01:58 raspi4 NetworkManager[375]: <warn> [1660942918.5351] device (wlan0): Activation: failed for connection 'mizyx_net5g'
Aug 19 23:01:58 raspi4 NetworkManager[375]: <info> [1660942918.5368] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Aug 19 23:01:58 raspi4 NetworkManager[375]: <info> [1660942918.5545] dhcp4 (wlan0): canceled DHCP transaction, DHCP client pid 2649
Aug 19 23:01:58 raspi4 NetworkManager[375]: <info> [1660942918.5546] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
Aug 19 23:01:58 raspi4 NetworkManager[375]: <info> [1660942918.5546] dhcp4 (wlan0): state changed no lease
Aug 19 23:01:58 raspi4 NetworkManager[375]: <info> [1660942918.5895] manager: NetworkManager state is now CONNECTED_LOCAL
Aug 19 23:02:07 raspi4 NetworkManager[375]: <info> [1660942927.6453] device (wlan0): supplicant interface state: scanning -> inactive
Aug 19 23:02:07 raspi4 NetworkManager[375]: <info> [1660942927.6454] device (p2p-dev-wlan0): supplicant management interface state: scanning -> inactive
Aug 19 23:02:10 raspi4 NetworkManager[375]: <info> [1660942930.7734] audit: op="connections-reload" pid=2722 uid=0 result="success"
Aug 19 23:02:13 raspi4 NetworkManager[375]: <info> [1660942933.1752] audit: op="connections-reload" pid=2728 uid=0 result="success"
Aug 19 23:02:53 raspi4 NetworkManager[375]: <info> [1660942973.2471] audit: op="connection-update" uuid="6729b7a9-e366-462c-bd76-f9811742d4e7" name="mizyx_net5g" args="connection.timestamp,ipv4.dns" pid=2756 uid=0 result="success"
Aug 19 23:03:09 raspi4 NetworkManager[375]: <info> [1660942989.2793] audit: op="connection-update" uuid="6729b7a9-e366-462c-bd76-f9811742d4e7" name="mizyx_net5g" pid=2760 uid=1000 result="success"')

Im seriously out of ideas... I hope somebody is able to help
Here is the full output of journalctl -u NetworkManager, hosted on zerobin.net (password is "archisawesome")
Last edited by zimmy on Sat Aug 20, 2022 5:38 pm, edited 1 time in total.
zimmy
 
Posts: 3
Joined: Fri Aug 19, 2022 11:27 pm

Re: Big issues connecting and using wifi / NetworkManager

Postby zimmy » Sat Aug 20, 2022 5:35 pm

Ok, i debugged an entire day, disabled and enabled back systemd-resolved and switched dhclient back to dhcp in systemd. And switched from NetworkManager to nmctl.
I did iw reg get and found out that my country was country 00:, so i switched it to PL using iw reg set PL. Although it changes automatically to 00 after reboot. And netctl throws me an error that i couldnt authenticate WPA for the connection

- iw reg get
$this->bbcode_second_pass_code('', 'global
country PL: DFS-ETSI
(2400 - 2483 @ 40), (N/A, 20), (N/A)
(5150 - 5250 @ 80), (N/A, 23), (N/A), NO-OUTDOOR, AUTO-BW
(5250 - 5350 @ 80), (N/A, 20), (0 ms), NO-OUTDOOR, DFS, AUTO-BW
(5470 - 5725 @ 160), (N/A, 26), (0 ms), DFS
(5725 - 5875 @ 80), (N/A, 13), (N/A)
(5945 - 6425 @ 160), (N/A, 23), (N/A), NO-OUTDOOR
(57000 - 66000 @ 2160), (N/A, 40), (N/A)

phy#0
country 99: DFS-UNSET
(2402 - 2482 @ 40), (6, 20), (N/A)
(2474 - 2494 @ 20), (6, 20), (N/A)
(5140 - 5360 @ 160), (6, 20), (N/A)
(5460 - 5860 @ 160), (6, 20), (N/A)')
I scanned my network and set both my networks (5g and 2.4) to use set channels (5g uses 44 instead of auto)

List of services currently running
$this->bbcode_second_pass_code('', ' UNIT LOAD ACTIVE SUB DESCRIPTION
auditd.service loaded inactive dead Security Auditing Service
dbus.service loaded active running D-Bus System Message Bus
● display-manager.service not-found inactive dead display-manager.service
dm-event.service loaded inactive dead Device-mapper event daemon
docker.service loaded active running Docker Application Container Engine
emergency.service loaded inactive dead Emergency Shell
● firewalld.service not-found inactive dead firewalld.service
getty@tty1.service loaded active running Getty on tty1
getty@tty2.service loaded active running Getty on tty2
initrd-cleanup.service loaded inactive dead Cleaning Up and Shutting Down Daemons
initrd-parse-etc.service loaded inactive dead Reload Configuration from the Real Root
initrd-switch-root.service loaded inactive dead Switch Root
initrd-udevadm-cleanup-db.service loaded inactive dead Cleanup udev Database
kmod-static-nodes.service loaded active exited Create List of Static Device Nodes
ldconfig.service loaded inactive dead Rebuild Dynamic Linker Cache
mkinitcpio-generate-shutdown-ramfs.serv… loaded inactive dead Generate shutdown-ramfs
modprobe@configfs.service loaded inactive dead Load Kernel Module configfs
modprobe@drm.service loaded inactive dead Load Kernel Module drm
modprobe@fuse.service loaded inactive dead Load Kernel Module fuse
netctl.service loaded inactive dead (Re)store the netctl profile state
● netctl@mizyx_net5g\x2dstatic.service loaded failed failed Networking for netctl profile mizyx_net5…
netctl@wlan0\x2dmizyx_net0.service loaded active exited Automatically generated profile by wifi-…
netctl@wlan0\x2dmizyx_net5g.service loaded inactive dead Automatically generated profile by wifi-…
● plymouth-quit-wait.service not-found inactive dead plymouth-quit-wait.service
● plymouth-start.service not-found inactive dead plymouth-start.service
rescue.service loaded inactive dead Rescue Shell
serial-getty@ttyS1.service loaded active running Serial Getty on ttyS1
shadow.service loaded inactive dead Verify integrity of password and group f…
sshd.service loaded active running OpenSSH Daemon
sshdgenkeys.service loaded inactive dead SSH Key Generation
● syslog.service not-found inactive dead syslog.service
systemd-ask-password-console.service loaded inactive dead Dispatch Password Requests to Console
systemd-ask-password-wall.service loaded inactive dead Forward Password Requests to Wall
systemd-binfmt.service loaded inactive dead Set Up Additional Binary Formats
systemd-boot-system-token.service loaded inactive dead Store a System Token in an EFI Variable
systemd-firstboot.service loaded inactive dead First Boot Wizard
systemd-fsck-root.service loaded inactive dead File System Check on Root Device
systemd-hwdb-update.service loaded inactive dead Rebuild Hardware Database
systemd-journal-catalog-update.service loaded inactive dead Rebuild Journal Catalog
systemd-journal-flush.service loaded active exited Flush Journal to Persistent Storage
systemd-journald.service loaded active running Journal Service
systemd-logind.service loaded active running User Login Management
systemd-machine-id-commit.service loaded inactive dead Commit a transient machine-id on disk
systemd-modules-load.service loaded inactive dead Load Kernel Modules
systemd-random-seed.service loaded active exited Load/Save Random Seed
systemd-remount-fs.service loaded active exited Remount Root and Kernel File Systems
systemd-repart.service loaded inactive dead Repartition Root Disk
systemd-resolved.service loaded active running Network Name Resolution
systemd-rfkill.service loaded inactive dead Load/Save RF Kill Switch Status
systemd-sysctl.service loaded active exited Apply Kernel Variables
systemd-sysusers.service loaded inactive dead Create System Users
systemd-timesyncd.service loaded active running Network Time Synchronization
systemd-tmpfiles-clean.service loaded inactive dead Cleanup of Temporary Directories
systemd-tmpfiles-setup-dev.service loaded active exited Create Static Device Nodes in /dev
systemd-tmpfiles-setup.service loaded active exited Create Volatile Files and Directories
systemd-udev-settle.service loaded inactive dead Wait for udev To Complete Device Initial…
systemd-udev-trigger.service loaded active exited Coldplug All udev Devices
systemd-udevd.service loaded active running Rule-based Manager for Device Events and…
systemd-update-done.service loaded inactive dead Update is Completed
systemd-update-utmp.service loaded active exited Record System Boot/Shutdown in UTMP
systemd-user-sessions.service loaded active exited Permit User Sessions
systemd-vconsole-setup.service loaded inactive dead Setup Virtual Console
user-runtime-dir@1000.service loaded active exited User Runtime Directory /run/user/1000
user@1000.service loaded active running User Manager for UID 1000')

My configs in /etc/netctl/, generated using wifi-menu and edited to use a static ip

- cat /etc/netctl/wlan0-mizyx_net0
$this->bbcode_second_pass_code('', 'Description='Automatically generated profile by wifi-menu'
Interface=wlan0
Connection=wireless
Security=wpa
ESSID=mizyx_net0
IP=static
Key=superprivatekey
Address=('192.168.1.200/24')
Gateway='192.168.1.1'
DNS=('1.1.1.1' '1.0.0.1')')
- cat /etc/netctl/wlan0-mizyx_net5g
$this->bbcode_second_pass_code('', 'Description='Automatically generated profile by wifi-menu'
Interface=wlan0
Connection=wireless
Security=wpa
ESSID=mizyx_net5g
IP=static
Key=superprivatekey
Address=('192.168.1.200/24')
Gateway='192.168.1.1'
DNS=('1.1.1.1' '1.0.0.1')')

Now im using the 2.4 network which (sometimes) has stable connection when pinging, but im facing an issue where when i use the 5g one, i have massive latency while pinging to eg. google.com, it goes like 34, 43, 334, 421, 53 etc, or having overall slower response times (avg. 14ms to google.com on 2.4 and avg. 45ms on 5g).
I also observed that when idle pinging to google.com, it has around 50-90ms response time, but when i load my hosted webpage in docker, it fixes itself and i get a stable 14ms
I used raspi for a few minutes now just fine but the connection seems to sometimes be really slow
Last edited by zimmy on Sat Aug 20, 2022 6:14 pm, edited 2 times in total.
zimmy
 
Posts: 3
Joined: Fri Aug 19, 2022 11:27 pm

Re: Big issues connecting and using wifi / nm + crda issues

Postby zimmy » Sat Aug 20, 2022 6:04 pm

UPDATE
the regdom kept getting reset after each reboot so i uncomented the line with WIRELESS_REGDOM="PL" in /etc/conf.d/wireless_regdom. now works fine

But after reboot it auto connected to the 5g connection and threw me an error like this:

$this->bbcode_second_pass_code('', '× netctl@wlan0\x2dmizyx_net5g.service - Automatically generated profile by wifi-menu
Loaded: loaded (/usr/lib/systemd/system/netctl@.service; enabled; preset: disabled)
Drop-In: /etc/systemd/system/netctl@wlan0\x2dmizyx_net5g.service.d
└─profile.conf
Active: failed (Result: exit-code) since Sat 2022-08-20 19:54:52 CEST; 1min 46s ago
Duration: 6.240s
Docs: man:netctl.profile(5)
Process: 2762 ExecStart=/usr/lib/netctl/network start wlan0-mizyx_net5g (code=exited, status=1/FAILURE)
Main PID: 2762 (code=exited, status=1/FAILURE)
CPU: 668ms

Aug 20 19:54:46 raspi4 systemd[1]: Starting Automatically generated profile by wifi-menu...
Aug 20 19:54:46 raspi4 network[2762]: Starting network profile 'wlan0-mizyx_net5g'...
Aug 20 19:54:46 raspi4 systemd[1]: Started Automatically generated profile by wifi-menu.
Aug 20 19:54:52 raspi4 network[2948]: RTNETLINK answers: File exists
Aug 20 19:54:52 raspi4 network[2762]: Could not add address '192.168.1.200/24' to interface 'wlan0'
Aug 20 19:54:52 raspi4 network[2762]: Failed to bring the network up for profile 'wlan0-mizyx_net5g'
Aug 20 19:54:52 raspi4 systemd[1]: netctl@wlan0\x2dmizyx_net5g.service: Main process exited, code=exited, status=1/FAILURE
Aug 20 19:54:52 raspi4 systemd[1]: netctl@wlan0\x2dmizyx_net5g.service: Failed with result 'exit-code'.')
I disabled the 5g profile and after a reboot the 2.4 one worked just fine, i switched manually to the 5g one and it worked too, not sure what is causing this

ANOTHER UPDATE AFTER A FEW HOURS
Did some research, faced some more errors. Disable power managment in iw config for my interface.
Disabled both profiles with netctl and started netctl-auto@wlan0.service so it can auto chose the network.
Added TimeoutDHCP=20 in both my profiles and removed the broken symlinks that i had in journalctl for nmctl.

Rebooted a few times and it seems like its somewhat fixed, ill test it for a few days and see if any issues appear.
At this point this thread is literally a personal blog post :lol:
zimmy
 
Posts: 3
Joined: Fri Aug 19, 2022 11:27 pm


Return to General

Who is online

Users browsing this forum: No registered users and 7 guests