You are not logged in.
Hi
Activating the airplane mode while my laptop is connected to a wi-fi network almost always fails.
Sometimes, after pressing the special keyboard key to activate the airplane mode, the network gets stuck at 'connecting...' state for ~1 minute and then the airplane mode is not activated. The laptop disconnects from the wi-fi network and the wi-fi adapter remains enabled instead.
My wifi adapter:
02:00.0 Network controller: Intel Corporation Centrino Wireless-N 135 (rev c4)
Subsystem: Intel Corporation Centrino Wireless-N 135 BGN
Flags: bus master, fast devsel, latency 0, IRQ 28
Memory at e0400000 (64-bit, non-prefetchable) [size=8K]
Capabilities: [c8] Power Management version 3
Capabilities: [d0] MSI: Enable+ Count=1/1 Maskable- 64bit+
Capabilities: [e0] Express Endpoint, MSI 00
Capabilities: [100] Advanced Error Reporting
Capabilities: [140] Device Serial Number 0c-d2-92-ff-ff-b5-4e-33
Kernel driver in use: iwlwifi
Kernel modules: iwlwifiI use Gnome and manage the wi-fi with iwd and networkmanager. I'm using linux-zen 6.0.9.zen1-1.
After reproducing the problem, the kernel prints these messages:
[sáb nov 26 17:38:51 2022] audit: type=1111 audit(1669495133.053:514): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=16274 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:01 2022] audit: type=1131 audit(1669495143.071:515): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:04 2022] wlan0: deauthenticating from 18:34:af:29:8d:e6 by local choice (Reason: 3=DEAUTH_LEAVING)
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio.
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: reporting RF_KILL (radio disabled)
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 17:39:04 2022] wlan0: failed to remove key (1, ff:ff:ff:ff:ff:ff) from hardware (-5)
[sáb nov 26 17:39:04 2022] audit: type=1130 audit(1669495146.510:516): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 17:39:04 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 17:39:05 2022] audit: type=1111 audit(1669495146.619:517): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wwan-enabled:off" pid=1956 uid=1000 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:05 2022] audit: type=1130 audit(1669495146.635:518): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:05 2022] audit: type=1131 audit(1669495146.659:519): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=ntpd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:05 2022] audit: type=1111 audit(1669495146.782:520): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=16555 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:05 2022] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio.
[sáb nov 26 17:39:05 2022] iwlwifi 0000:02:00.0: reporting RF_KILL (radio enabled)
[sáb nov 26 17:39:05 2022] iwlwifi 0000:02:00.0: Radio type=0x0-0x0-0x0
[sáb nov 26 17:39:05 2022] iwlwifi 0000:02:00.0: Radio type=0x0-0x0-0x0
[sáb nov 26 17:39:05 2022] audit: type=1111 audit(1669495147.058:521): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=16591 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:06 2022] wlan0: authenticate with 18:34:af:29:8d:e6
[sáb nov 26 17:39:06 2022] wlan0: bad VHT capabilities, disabling VHT
[sáb nov 26 17:39:06 2022] wlan0: 80 MHz not supported, disabling VHT
[sáb nov 26 17:39:06 2022] wlan0: send auth to 18:34:af:29:8d:e6 (try 1/3)
[sáb nov 26 17:39:06 2022] wlan0: authenticated
[sáb nov 26 17:39:06 2022] wlan0: waiting for beacon from 18:34:af:29:8d:e6
[sáb nov 26 17:39:06 2022] wlan0: aborting association with 18:34:af:29:8d:e6 by local choice (Reason: 3=DEAUTH_LEAVING)
[sáb nov 26 17:39:10 2022] audit: type=1131 audit(1669495151.805:522): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 17:39:15 2022] audit: type=1131 audit(1669495157.074:523): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'Sometiimes the apirplane mode fails in a different way: I press the keyboard key and the wi-fi just disconnects and immediately reconnects.
Here is the kernel log for this case:
[sáb nov 26 18:06:58 2022] wlan0: deauthenticating from 18:34:af:29:8d:e6 by local choice (Reason: 3=DEAUTH_LEAVING)
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio.
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: reporting RF_KILL (radio disabled)
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: Not sending command - RF KILL
[sáb nov 26 18:06:58 2022] audit: type=1130 audit(1669496820.067:574): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:06:58 2022] audit: type=1111 audit(1669496820.176:575): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wwan-enabled:off" pid=1956 uid=1000 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:06:58 2022] audit: type=1130 audit(1669496820.196:576): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:06:58 2022] audit: type=1131 audit(1669496820.217:577): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=ntpd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:06:58 2022] audit: type=1111 audit(1669496820.320:578): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=19240 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio.
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: reporting RF_KILL (radio enabled)
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: Radio type=0x0-0x0-0x0
[sáb nov 26 18:06:58 2022] iwlwifi 0000:02:00.0: Radio type=0x0-0x0-0x0
[sáb nov 26 18:06:58 2022] audit: type=1111 audit(1669496820.461:579): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=19254 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:06:59 2022] wlan0: authenticate with 18:34:af:29:8d:e6
[sáb nov 26 18:06:59 2022] wlan0: bad VHT capabilities, disabling VHT
[sáb nov 26 18:06:59 2022] wlan0: 80 MHz not supported, disabling VHT
[sáb nov 26 18:06:59 2022] wlan0: send auth to 18:34:af:29:8d:e6 (try 1/3)
[sáb nov 26 18:06:59 2022] wlan0: send auth to 18:34:af:29:8d:e6 (try 2/3)
[sáb nov 26 18:06:59 2022] wlan0: authenticated
[sáb nov 26 18:06:59 2022] wlan0: waiting for beacon from 18:34:af:29:8d:e6
[sáb nov 26 18:06:59 2022] wlan0: associate with 18:34:af:29:8d:e6 (try 1/3)
[sáb nov 26 18:06:59 2022] wlan0: RX AssocResp from 18:34:af:29:8d:e6 (capab=0x411 status=0 aid=3)
[sáb nov 26 18:06:59 2022] wlan0: associated
[sáb nov 26 18:06:59 2022] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[sáb nov 26 18:07:00 2022] audit: type=1111 audit(1669496822.002:580): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=19336 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:07:00 2022] audit: type=1130 audit(1669496822.036:581): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=ntpd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:07:00 2022] audit: type=1111 audit(1669496822.085:582): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=19351 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:07:00 2022] audit: type=1111 audit(1669496822.140:583): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=19361 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:07:03 2022] kauditd_printk_skb: 1 callbacks suppressed
[sáb nov 26 18:07:03 2022] audit: type=1131 audit(1669496825.333:585): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[sáb nov 26 18:07:04 2022] audit: type=1111 audit(1669496825.777:586): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=19493 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'Any idea on how to make the airplane mode to work consistently?
Thanks for reading.
Last edited by Strangiato (2022-11-27 11:05:42)
Offline
What event does pressing the key trigger? The bit of the journal you didn't post should tell you or you can use a tool such as xev to find out what the key produces. I'd always assumed airplane mode would hard block wifi etc., but it seems it often uses soft block. In your case something is immediately unblocking it. I'm guessing that something is NetworkManager, so you'd need to stop that to get it working. What you want is to process the event the key triggers so that NetworkManager disables wifi, bluetooth is disabled (if applicable) and any other radio things and that rfkill soft blocks the relevant devices. At least, I think that's what you want if the key isn't handled directly by the firmware (which it seems it isn't).
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline
Here is the journal log after reproducing the first case:
nov 27 07:56:02 arch-laptop iwd[551]: rfkill id 0 not found in a RFKILL_OP_CHANGE event
nov 27 07:56:02 arch-laptop kernel: wlan0: deauthenticating from 18:34:af:29:8d:e6 by local choice (Reason: 3=DEAUTH_LEAVING)
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4157] manager: rfkill: Wi-Fi now disabled by radio killswitch
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4159] device (wlan0): state change: activated -> unavailable (reason 'none', sys-iface-state: 'managed')
nov 27 07:56:02 arch-laptop dnsmasq[751]: setting upstream servers from DBus
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4161] dhcp4 (wlan0): canceled DHCP transaction
nov 27 07:56:02 arch-laptop dnsmasq[751]: cleared cache
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4161] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4161] dhcp4 (wlan0): state changed no lease
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4163] dhcp6 (wlan0): canceled DHCP transaction
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4163] dhcp6 (wlan0): activation: beginning transaction (timeout in 45 seconds)
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4163] dhcp6 (wlan0): state changed no lease
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4169] dns-mgr: Writing DNS information to /usr/bin/resolvconf
nov 27 07:56:02 arch-laptop systemd[1]: Starting Load/Save RF Kill Switch Status...
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio.
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: reporting RF_KILL (radio disabled)
nov 27 07:56:02 arch-laptop systemd[1]: Started Load/Save RF Kill Switch Status.
nov 27 07:56:02 arch-laptop audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop kernel: audit: type=1130 audit(1669546562.427:787): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: Not sending command - RF KILL
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: Not sending command - RF KILL
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Interface wlan0.IPv6 no longer relevant for mDNS.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Leaving mDNS multicast group on interface wlan0.IPv6 with address 2804:14d:4cd1:acde:87d1:5924:6784:bef3.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Interface wlan0.IPv4 no longer relevant for mDNS.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.10.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Withdrawing address record for 2804:14d:4cd1:acde::1001 on wlan0.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Withdrawing address record for 2804:14d:4cd1:acde::1000 on wlan0.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Withdrawing address record for 2804:14d:4cd1:acde:87d1:5924:6784:bef3 on wlan0.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Withdrawing address record for 192.168.0.10 on wlan0.
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.4725] manager: NetworkManager state is now DISCONNECTED
nov 27 07:56:02 arch-laptop dbus-daemon[495]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.3' (uid=0 pid=507 comm="/usr/bin/NetworkManager --no-daemon")
nov 27 07:56:02 arch-laptop systemd[1]: Starting Network Manager Script Dispatcher Service...
nov 27 07:56:02 arch-laptop audit[507]: USYS_CONFIG pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wwan-enabled:off" pid=28724 uid=1000 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop kernel: audit: type=1111 audit(1669546562.524:788): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wwan-enabled:off" pid=28724 uid=1000 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.5253] audit: op="radio-control" arg="wwan-enabled:off" pid=28724 uid=1000 result="success"
nov 27 07:56:02 arch-laptop dbus-daemon[495]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
nov 27 07:56:02 arch-laptop systemd[1]: Started Network Manager Script Dispatcher Service.
nov 27 07:56:02 arch-laptop audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop kernel: audit: type=1130 audit(1669546562.525:789): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop ntpd[63865]: ntpd exiting on signal 15 (Terminated)
nov 27 07:56:02 arch-laptop systemd[1]: Stopping Network Time Service...
nov 27 07:56:02 arch-laptop audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=ntpd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop systemd[1]: ntpd.service: Deactivated successfully.
nov 27 07:56:02 arch-laptop systemd[1]: Stopped Network Time Service.
nov 27 07:56:02 arch-laptop kernel: audit: type=1131 audit(1669546562.552:790): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=ntpd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop audit[507]: USYS_CONFIG pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=64213 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6648] manager: rfkill: Wi-Fi hardware radio set enabled
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6651] audit: op="radio-control" arg="wireless-enabled:on" pid=64213 uid=0 result="success"
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6652] device (wlan0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
nov 27 07:56:02 arch-laptop kernel: audit: type=1111 audit(1669546562.664:791): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=64213 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6695] device (wlan0): Activation: starting connection '56Kbps' (94ba3369-3e0a-4d47-a8a7-05b9b9ccbdcc)
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio.
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: reporting RF_KILL (radio enabled)
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6710] manager: rfkill: Wi-Fi now enabled by radio killswitch
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6714] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6719] manager: NetworkManager state is now CONNECTING
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.6724] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: Radio type=0x0-0x0-0x0
nov 27 07:56:02 arch-laptop iwd[551]: [DHCPv4] l_dhcp_client_stop:1249 Entering state: DHCP_STATE_INIT
nov 27 07:56:02 arch-laptop iwd[551]: rfkill id 0 not found in a RFKILL_OP_CHANGE event
nov 27 07:56:02 arch-laptop kernel: iwlwifi 0000:02:00.0: Radio type=0x0-0x0-0x0
nov 27 07:56:02 arch-laptop iwd[551]: Could not register frame watch type 00d0: -114
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.8633] device (wlan0): new IWD device state is disconnected
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.8717] device (wlan0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.8731] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::169:9d8a:22cd:eb2a.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: New relevant interface wlan0.IPv6 for mDNS.
nov 27 07:56:02 arch-laptop avahi-daemon[494]: Registering new address record for fe80::169:9d8a:22cd:eb2a on wlan0.*.
nov 27 07:56:02 arch-laptop audit[507]: USYS_CONFIG pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=64283 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop NetworkManager[507]: <info> [1669546562.9264] audit: op="radio-control" arg="wireless-enabled:on" pid=64283 uid=0 result="success"
nov 27 07:56:02 arch-laptop kernel: audit: type=1111 audit(1669546562.925:792): pid=507 uid=0 auid=4294967295 ses=4294967295 msg='op=radio-control arg="wireless-enabled:on" pid=64283 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
nov 27 07:56:02 arch-laptop PackageKit[965]: get-updates transaction /1784_eebbdced from uid 1000 finished with success after 3ms
nov 27 07:56:03 arch-laptop PackageKit[965]: get-updates transaction /1785_adacbacd from uid 1000 finished with success after 4ms
nov 27 07:56:03 arch-laptop PackageKit[965]: get-updates transaction /1786_ddedebda from uid 1000 finished with success after 2ms
nov 27 07:56:03 arch-laptop PackageKit[965]: get-updates transaction /1787_dceaebeb from uid 1000 finished with success after 2ms
nov 27 07:56:03 arch-laptop kernel: wlan0: authenticate with 18:34:af:29:8d:e6
nov 27 07:56:03 arch-laptop kernel: wlan0: bad VHT capabilities, disabling VHT
nov 27 07:56:03 arch-laptop kernel: wlan0: 80 MHz not supported, disabling VHT
nov 27 07:56:03 arch-laptop kernel: wlan0: send auth to 18:34:af:29:8d:e6 (try 1/3)
nov 27 07:56:03 arch-laptop NetworkManager[507]: <info> [1669546563.6143] device (wlan0): new IWD device state is connecting
nov 27 07:56:03 arch-laptop kernel: wlan0: authenticated
nov 27 07:56:03 arch-laptop NetworkManager[507]: <info> [1669546563.6160] device (wlan0): new IWD device state is disconnecting
nov 27 07:56:03 arch-laptop kernel: wlan0: waiting for beacon from 18:34:af:29:8d:e6
nov 27 07:56:03 arch-laptop kernel: wlan0: aborting association with 18:34:af:29:8d:e6 by local choice (Reason: 3=DEAUTH_LEAVING)
nov 27 07:56:03 arch-laptop NetworkManager[507]: <info> [1669546563.6408] device (wlan0): new IWD device state is disconnected
nov 27 07:56:04 arch-laptop gnome-shell[28507]: Impossível conectar a https://openweathermap.org/city/3452925
Erro ao resolver “openweathermap.org”: Falha temporário na resolução de nome
nov 27 07:56:05 arch-laptop gnome-shell[28507]: Impossível conectar a https://openweathermap.org/city/3452925
Erro ao resolver “openweathermap.org”: Falha temporário na resolução de nome
nov 27 07:56:07 arch-laptop systemd[1]: systemd-rfkill.service: Deactivated successfully.
nov 27 07:56:07 arch-laptop audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:07 arch-laptop kernel: audit: type=1131 audit(1669546567.678:793): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:12 arch-laptop systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
nov 27 07:56:12 arch-laptop audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:12 arch-laptop kernel: audit: type=1131 audit(1669546572.938:794): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
nov 27 07:56:15 arch-laptop gnome-shell[28507]: Impossível conectar a https://openweathermap.org/city/3452925
Erro ao resolver “openweathermap.org”: Falha temporário na resolução de nome
nov 27 07:56:45 arch-laptop gnome-shell[28507]: Impossível conectar a https://openweathermap.org/city/3452925
Erro ao resolver “openweathermap.org”: Falha temporário na resolução de nome
nov 27 07:57:02 arch-laptop NetworkManager[507]: <info> [1669546622.8902] device (wlan0): state change: ip-config -> failed (reason 'ip-config-unavailable', sys-iface-state: 'managed')
nov 27 07:57:02 arch-laptop NetworkManager[507]: <info> [1669546622.8917] manager: NetworkManager state is now DISCONNECTED
nov 27 07:57:02 arch-laptop NetworkManager[507]: <warn> [1669546622.8923] device (wlan0): Activation: failed for connection '56Kbps'
nov 27 07:57:02 arch-laptop NetworkManager[507]: <info> [1669546622.8931] device (wlan0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
nov 27 07:57:02 arch-laptop avahi-daemon[494]: Withdrawing address record for fe80::169:9d8a:22cd:eb2a on wlan0.
nov 27 07:57:02 arch-laptop NetworkManager[507]: <info> [1669546622.8938] dhcp4 (wlan0): canceled DHCP transaction
nov 27 07:57:02 arch-laptop avahi-daemon[494]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::169:9d8a:22cd:eb2a.
nov 27 07:57:02 arch-laptop NetworkManager[507]: <info> [1669546622.8938] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
nov 27 07:57:02 arch-laptop avahi-daemon[494]: Interface wlan0.IPv6 no longer relevant for mDNS.
nov 27 07:57:02 arch-laptop NetworkManager[507]: <info> [1669546622.8938] dhcp4 (wlan0): state changed no lease
nov 27 07:57:02 arch-laptop gnome-shell[28507]: JS ERROR: TypeError: this._settings is null
_sync@resource:///org/gnome/shell/ui/dateMenu.js:767:28
_updateCount@resource:///org/gnome/shell/ui/dateMenu.js:763:14
_onSourceAdded@resource:///org/gnome/shell/ui/dateMenu.js:750:14
_addSource@resource:///org/gnome/shell/ui/messageTray.js:983:14
_onSourceEnableChanged@resource:///org/gnome/shell/ui/messageTray.js:1002:22
add@resource:///org/gnome/shell/ui/messageTray.js:973:14
_onActivationFailed@resource:///org/gnome/shell/ui/status/network.js:1958:26
_init/</<@resource:///org/gnome/shell/ui/status/network.js:1888:49
_deviceStateChanged@resource:///org/gnome/shell/ui/status/network.js:1638:18
nov 27 07:57:02 arch-laptop gnome-shell[28507]: Object .Gjs_ui_calendar_NotificationSection (0x564dbadde060), has been already disposed — impossible to connect to any signal on it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.
nov 27 07:57:02 arch-laptop gnome-shell[28507]: == Stack trace for context 0x564db9b6d320 ==
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #0 564dbbee8628 i resource:///org/gnome/shell/misc/signalTracker.js:118 (b63ee4b1330 @ 92)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #1 564dbbee8570 i resource:///org/gnome/shell/misc/signalTracker.js:152 (b63ee4b1510 @ 51)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #2 7fff4abdae10 b resource:///org/gnome/shell/misc/signalTracker.js:240 (b63ee4b16f0 @ 763)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #3 7fff4abdaef0 b resource:///org/gnome/shell/ui/environment.js:331 (b63ee48cfb0 @ 121)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #4 7fff4abdb600 b resource:///org/gnome/shell/ui/calendar.js:840 (272e4ad28e20 @ 48)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #5 564dbbee84a0 i self-hosted:1115 (b63ee47eec0 @ 463)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #6 564dbbee83f8 i resource:///org/gnome/shell/ui/messageTray.js:983 (272e4ad22b50 @ 116)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #7 564dbbee8358 i resource:///org/gnome/shell/ui/messageTray.js:1002 (272e4ad22c90 @ 98)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #8 564dbbee82b8 i resource:///org/gnome/shell/ui/messageTray.js:973 (272e4ad22ab0 @ 205)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #9 564dbbee8200 i resource:///org/gnome/shell/ui/status/network.js:1958 (90002e59b50 @ 320)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #10 564dbbee8180 i resource:///org/gnome/shell/ui/status/network.js:1888 (90002e59920 @ 12)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #11 564dbbee80e8 i resource:///org/gnome/shell/ui/status/network.js:1638 (90002e58d30 @ 136)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: #12 564dbbee8018 i self-hosted:1115 (b63ee47eec0 @ 546)
nov 27 07:57:02 arch-laptop gnome-shell[28507]: Object .Gjs_ui_calendar_NotificationSection (0x564dbadde060), has been already disposed — impossible to connect to any signal on it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.The airpane mode works consistently when the Network Manager service is inactive.
Last edited by Strangiato (2022-11-27 11:40:05)
Offline
You don't have iwd.service enabled, do you? If so, disable it and configure NetworkManager to use iwd instead.
If you're sure you're only running NetworkManager, I would look first for a setting in gnome which would allow you to match actions to the keypress event (assuming NetworkManager doesn't have some configuration option for this). Failing that, see https://wiki.archlinux.org/title/Acpid but note the warning at the top of the page about conflicts.
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline
iwd is disabled.
$ systemctl status iwd.service
● iwd.service - Internet Wireless Daemon (IWD)
Loaded: loaded (/etc/systemd/system/iwd.service; disabled; preset: disabled)
Active: active (running) since Sun 2022-11-27 12:17:06 -03; 9h ago
Main PID: 586 (iwd)
Tasks: 1 (limit: 9391)
Memory: 2.8M
CPU: 4.819s
CGroup: /system.slice/iwd.service
└─586 /usr/lib/iwd/iwdI don't think there is a problem with acpi events that acpid could solve. This bug with airplane mode is a relatively recent regression.
And events like...
Pressing special keys, including the Power/Sleep/Suspend button
(Un)Plugging an AC power adapter from a notebook
(Un)Plugging phone jack.
are working as they should.
I have no idea what to configure on Gnome regarding airplane mode. I can't find anything by searching on the internet.
Offline
I don't think there is a problem with acpi events that acpid could solve. This bug with airplane mode is a relatively recent regression.
In that case, I would probably search for bug reports upstream. You could also try the LTS kernel (or the current kernel, if you're using LTS). Another possibility would be to try a different network manager. Just to try to narrow down the problem. pacman's log will tell you what was updated and when. That may also provide clues to the culprit.
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline
LTS kernel + nm + iwd does not fix the bug. Tried to replace iwd with wpa_supplicant, but apparently the iwlwifi driver crashes on boot and my wi-fi adapter is not activated. I did not find any bug report about airplane mode in kernel and networkmanager bug trackers.
I do not know where the bug tracker of iwd is.
Offline
Since my previous comment, networkmanager was updated to version 1.40.6-1 and the issue persists. I have replaced iwd with wpa_supplicant a few hours ago and nothing changed. I have another distribution called neon unstable based on Ubuntu 22.04, running KDE Plasma DE and kernel 6.0.9 installed on the
same laptop, and the airplane mode works as expected on it. I have also tested a live usb of Fedora 37 running Gnome 43 and kernel 6.0.6, the airplane mode
works as expected on it too. I have no idea what is wrong with my Arch install.
Offline
I would compare NetworkManager's config on the machines where it works and in Arch. If you can't find anything, you could also enable debug for NetworkManager.
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline