You are not logged in.

#1 2016-07-18 17:15:23

hilltownboy
Member
From: Massachusetts
Registered: 2013-08-15
Posts: 100

[Solved]wifi often hardblocked by rfkill

On booting my system, wifi is sometimes up but often not.  Head_on_a_Stick provided a workaround:

# rmmod -f iwl4965
# rfkill unblock all
# modprobe iwl4965

Is there a way to adjust booting to make wifi always come up?

I am using:

[username@arch 4.2.3-1-ARCH]$ cat modules.dep | grep iwl4965
kernel/drivers/net/wireless/iwlegacy/iwl4965.ko.gz: kernel/drivers/net/wireless/iwlegacy/iwlegacy.ko.gz kernel/drivers/leds/led-class.ko.gz kernel/net/mac80211/mac80211.ko.gz kernel/net/wireless/cfg80211.ko.gz kernel/net/rfkill/rfkill.ko.gz

Here are some excerpts from journalctl -b (line numbers on left) from unsuccessful and successful wifi boots.  The first few lines show the hard block in unsuccesful and the orderly progression in successful.

Unsuccessful:

   723  Jul 14 07:30:22 arch systemd[1]: Created slice system-rfkill\x2dunblock.slice.
   883  Jul 14 07:30:26 arch systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
   928  Jul 14 07:30:26 arch kernel: iwl4965 0000:10:00.0: loaded firmware version 228.61.2.24
   929  Jul 14 07:30:26 arch systemd[1]: Starting Load/Save RF Kill Switch Status...
   932  Jul 14 07:30:26 arch kernel: ieee80211 phy0: Selected rate control algorithm 'iwl-4965-rs'
   998  Jul 14 07:30:27 arch systemd[1]: Started Load/Save RF Kill Switch Status.
   1029 Jul 14 07:30:30 arch kernel: iwl4965 0000:10:00.0: RF_KILL bit toggled to disable radio.
   1030 Jul 14 07:30:30 arch kernel: iwl4965 0000:10:00.0: RF_KILL bit toggled to enable radio.
   1031 Jul 14 07:30:30 arch kernel: iwl4965 0000:10:00.0: On demand firmware reload
   1032 Jul 14 07:30:30 arch kernel: iwl4965 0000:10:00.0: RF_KILL bit toggled to disable radio.
   1033 Jul 14 07:30:30 arch kernel: ieee80211 phy0: Hardware restart was requested
   1034 Jul 14 07:30:30 arch systemd[1]: Starting Network Service...
   1035 Jul 14 07:30:30 arch systemd[1]: Starting RFKill-Unblock all...
   1036 Jul 14 07:30:30 arch systemd[1]: Starting Automatic wireless network connection using netctl profiles...
   1039 Jul 14 07:30:30 arch systemd[1]: Starting WPA supplicant...
   1041 Jul 14 07:30:30 arch systemd[1]: Started dhcpcd on all interfaces.
   1044 Jul 14 07:30:30 arch systemd[1]: Started RFKill-Unblock all.
   1049 Jul 14 07:30:31 arch dhcpcd[244]: wlp16s0: if_up: Operation not possible due to RF-kill
   1050 Jul 14 07:30:31 arch dhcpcd[244]: wlp16s0: waiting for carrier
   1051 Jul 14 07:30:31 arch netctl-auto[258]: Included profile 'Matviak'
   1052 Jul 14 07:30:31 arch netctl-auto[258]: Included profile 'WIRELESS'
   1062 Jul 14 07:30:31 arch systemd-networkd[256]: wlp16s0: Renamed to wlan0
   1063 Jul 14 07:30:31 arch systemd-networkd[256]: wlan0: Renamed to wlp16s0
   1064 Jul 14 07:30:31 arch systemd[1]: Started Network Service.
   1067 Jul 14 07:30:32 arch wpa_supplicant[261]: Successfully initialized wpa_supplicant
   1068 Jul 14 07:30:32 arch systemd[1]: Started WPA supplicant.
   1070 Jul 14 07:30:33 arch systemd[1]: Started Automatic wireless network connection using netctl profiles.
   1071 Jul 14 07:30:33 arch wpa_actiond[310]: Starting wpa_actiond session for interface 'wlp16s0'
   1072 Jul 14 07:30:38 arch wpa_actiond[310]: Terminating wpa_actiond session for interface 'wlp16s0'
   1079 Jul 14 07:31:00 arch systemd[1]: Reached target Network.

Successful:

 732  Jul 13 07:46:09 arch systemd[1]: Created slice system-rfkill\x2dunblock.slice.
 958  Jul 13 07:46:09 arch systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
 960  Jul 13 07:46:09 arch systemd[1]: Starting Load/Save RF Kill Switch Status...
 965  Jul 13 07:46:09 arch systemd[1]: Started Load/Save RF Kill Switch Status.
 990  Jul 13 07:46:09 arch kernel: iwl4965 0000:10:00.0: loaded firmware version 228.61.2.24
 991  Jul 13 07:46:09 arch kernel: ieee80211 phy0: Selected rate control algorithm 'iwl-4965-rs'
1037 Jul 13 07:46:10 arch systemd[1]: Starting WPA supplicant...
1044 Jul 13 07:46:12 arch kernel: iwl4965 0000:10:00.0: RF_KILL bit toggled to disable radio.
1045 Jul 13 07:46:12 arch kernel: iwl4965 0000:10:00.0: RF_KILL bit toggled to enable radio.
1046 Jul 13 07:46:12 arch kernel: iwl4965 0000:10:00.0: On demand firmware reload
1047 Jul 13 07:46:12 arch kernel: ieee80211 phy0: Hardware restart was requested 
1052 Jul 13 07:46:12 arch dbus[249]: [system] Successfully activated service 'org.freedesktop.systemd1'
1053 Jul 13 07:46:12 arch systemd[1]: Started WPA supplicant.
1054 Jul 13 07:46:12 arch systemd[1]: Starting Network Service...
1055 Jul 13 07:46:12 arch systemd[1]: Starting RFKill-Unblock all...
1058 Jul 13 07:46:12 arch systemd[1]: Started dhcpcd on all interfaces.
1063 Jul 13 07:46:12 arch netctl-auto[243]: Included profile 'Matviak'
1068 Jul 13 07:46:12 arch systemd[1]: Started RFKill-Unblock all.
1069 Jul 13 07:46:12 arch netctl-auto[243]: Included profile 'WIRELESS'
1070 Jul 13 07:46:12 arch dhcpcd[255]: wlp16s0: waiting for carrier
1071 Jul 13 07:46:12 arch dhcpcd[255]: wlp16s0: carrier acquired
1072 Jul 13 07:46:12 arch dhcpcd[255]: wlp16s0: adding address fe80::ea40:c74b:8e70:d43a
1073 Jul 13 07:46:12 arch kernel: IPv6: ADDRCONF(NETDEV_UP): wlp16s0: link is not ready
1074 Jul 13 07:46:12 arch dhcpcd[255]: DUID 00:01:00:01:1d:2b:5d:43:00:1b:38:ba:55:64
1075 Jul 13 07:46:12 arch dhcpcd[255]: wlp16s0: IAID e0:20:c5:69
1076 Jul 13 07:46:12 arch dhcpcd[255]: wlp16s0: carrier lost
1077 Jul 13 07:46:12 arch dhcpcd[255]: wlp16s0: deleting address fe80::ea40:c74b:8e70:d43a
1078 Jul 13 07:46:13 arch systemd-networkd[282]: Enumeration completed
1079 Jul 13 07:46:13 arch systemd[1]: Started Network Service.
1080 Jul 13 07:46:13 arch systemd-networkd[282]: enp0s25: Renamed to eth0
1081 Jul 13 07:46:13 arch systemd-networkd[282]: eth0: Renamed to enp0s25
1082 Jul 13 07:46:13 arch systemd-networkd[282]: wlp16s0: Renamed to wlan0
1083 Jul 13 07:46:13 arch systemd-networkd[282]: wlan0: Renamed to wlp16s0
1084 Jul 13 07:46:13 arch systemd-networkd[282]: wlp16s0: Removing non-existent address:        fe80::ea40:c74b:8e70:d43a/64 (valid   1084  forever)
1086 Jul 13 07:46:13 arch systemd[1]: Started Automatic wireless network connection using netctl profiles.
1087 Jul 13 07:46:13 arch wpa_actiond[313]: Starting wpa_actiond session for interface 'wlp16s0'
1088 Jul 13 07:46:13 arch systemd[1]: Started Verify integrity of password and group files.
1089 Jul 13 07:46:15 arch kernel: wlp16s0: authenticate with f8:1a:67:d3:6f:aa
1090 Jul 13 07:46:15 arch kernel: wlp16s0: send auth to f8:1a:67:d3:6f:aa (try 1/3)
1091 Jul 13 07:46:15 arch kernel: wlp16s0: authenticated
1092 Jul 13 07:46:15 arch kernel: wlp16s0: waiting for beacon from f8:1a:67:d3:6f:aa
1093 Jul 13 07:46:15 arch kernel: wlp16s0: associate with f8:1a:67:d3:6f:aa (try 1/3)
1094 Jul 13 07:46:15 arch kernel: wlp16s0: RX AssocResp from f8:1a:67:d3:6f:aa (capab=0x421 status=0 aid=1)
1095 Jul 13 07:46:15 arch kernel: wlp16s0: associated
1096 Jul 13 07:46:15 arch kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp16s0: link becomes ready
1097 Jul 13 07:46:15 arch systemd-networkd[282]: wlp16s0: Gained carrier
1098 Jul 13 07:46:15 arch dhcpcd[255]: wlp16s0: carrier acquired
1099 Jul 13 07:46:15 arch dhcpcd[255]: wlp16s0: adding address fe80::ad30:b256:e3a3:dbd0
1100 Jul 13 07:46:15 arch wpa_actiond[313]: Interface 'wlp16s0' connected to network 'WIRELESS'
1101 Jul 13 07:46:15 arch dhcpcd[255]: wlp16s0: IAID e0:20:c5:69
1102 Jul 13 07:46:15 arch dhcpcd[322]: sending commands to master dhcpcd process
1103 Jul 13 07:46:15 arch dhcpcd[255]: control command: dhcpcd -4 -q -t 30 -K -L wlp16s0
1104 Jul 13 07:46:16 arch dhcpcd[255]: wlp16s0: soliciting an IPv6 router
1105 Jul 13 07:46:16 arch dhcpcd[255]: wlp16s0: soliciting a DHCP lease
1106 Jul 13 07:46:17 arch systemd-networkd[282]: wlp16s0: Gained IPv6LL
1107 Jul 13 07:46:17 arch dhcpcd[255]: wlp16s0: offered 192.168.0.100 from 192.168.0.1
1108 Jul 13 07:46:17 arch dhcpcd[255]: wlp16s0: probing address 192.168.0.100/24
1109 Jul 13 07:46:22 arch dhcpcd[255]: wlp16s0: leased 192.168.0.100 for 7200 seconds
1110 Jul 13 07:46:22 arch dhcpcd[255]: wlp16s0: adding route to 192.168.0.0/24
1111 Jul 13 07:46:22 arch dhcpcd[255]: wlp16s0: adding default route via 192.168.0.1
1112 Jul 13 07:46:29 arch dhcpcd[255]: wlp16s0: no IPv6 Routers available
1113 Jul 13 07:46:42 arch dhcpcd[247]: timed out
1114 Jul 13 07:46:42 arch dhcpcd[247]: dhcpcd exited
1115 Jul 13 07:46:42 arch systemd[1]: dhcpcd@enp0s25.service: Control process exited, code=exited status=1
1119 Jul 13 07:46:42 arch systemd[1]: Reached target Network.

Last edited by hilltownboy (2016-12-18 15:58:25)

Offline

#2 2016-07-31 19:53:21

hilltownboy
Member
From: Massachusetts
Registered: 2013-08-15
Posts: 100

Re: [Solved]wifi often hardblocked by rfkill

Answer: from ArchWiki netctl, next-to-last item:

If you want netctl-auto to automatically unblock your wireless card to connect to a particular network, set RFKill=++auto++ option for the wireless connection of your choice, as specified in the netctl.profile man page.

That did work for several boots in a row, but alas not for every time.

Last edited by hilltownboy (2016-08-09 19:45:27)

Offline

#3 2016-12-18 15:57:38

hilltownboy
Member
From: Massachusetts
Registered: 2013-08-15
Posts: 100

Re: [Solved]wifi often hardblocked by rfkill

The problem has gone away with most recent update (to linux-4.8.13-1).  Now wifi always turns on automatically after booting.

Offline

Board footer

Powered by FluxBB