On Thu, 2020-05-28 at 00:37 -0700, Samuel Sieb wrote:
On 5/27/20 3:46 PM, Robert G (Doc) Savage via users wrote:
Is that the only references to rfkill? Did the log start at boot up?
Try searching also for "KILL", it's likely in the wifi device
initialization.
No, it was just a group of four repeating lines. Here's the entire
output since rebooting yesterday:
Immediately after reboot, from 00:05:17 - 00:05:38
# journalctl -b | grep rfkill
May 29 00:05:17
tiger.protogeek.org kernel: thinkpad_acpi: rfkill
switch tpacpi_bluetooth_sw: radio is unblocked
May 29 00:05:19
tiger.protogeek.org systemd[1]: Listening on Load/Save
RF Kill Switch Status /dev/rfkill Watch.
May 29 00:05:19
tiger.protogeek.org audit[1]: SERVICE_START pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
May 29 00:05:24
tiger.protogeek.org systemd[1]: systemd-rfkill.service:
Succeeded.
May 29 00:05:24
tiger.protogeek.org audit[1]: SERVICE_STOP pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
May 29 00:05:24
tiger.protogeek.org kernel: audit: type=1131
audit(1590728724.799:94): pid=1 uid=0 auid=4294967295 ses=4294967295
subj=system_u:system_r:init_t:s0 msg='unit=systemd-rfkill
comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=?
terminal=? res=success'
May 29 00:05:30
tiger.protogeek.org NetworkManager[1132]:
<info> [1590728730.2538] rfkill2: found Wi-Fi radio killswitch (at
/sys/devices/pci0000:00/0000:00:14.3/ieee80211/phy0/rfkill2) (driver
iwlwifi)
May 29 00:05:30
tiger.protogeek.org NetworkManager[1132]:
<info> [1590728730.2540] manager[0x560023bbe080]: rfkill: Wi-Fi
hardware radio set enabled
May 29 00:05:30
tiger.protogeek.org NetworkManager[1132]:
<info> [1590728730.2540] manager[0x560023bbe080]: rfkill: WWAN
hardware radio set disabled
May 29 00:05:30
tiger.protogeek.org NetworkManager[1132]:
<info> [1590728730.2638] manager: rfkill: Wi-Fi disabled by radio
killswitch; enabled by state file
May 29 00:05:30
tiger.protogeek.org NetworkManager[1132]:
<info> [1590728730.2639] manager: rfkill: WWAN enabled by radio
killswitch; disabled by state file
May 29 00:05:30
tiger.protogeek.org audit[1]: SERVICE_START pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
May 29 00:05:30
tiger.protogeek.org NetworkManager[1132]:
<info> [1590728730.4670] manager: rfkill: Wi-Fi now enabled by radio
killswitch
May 29 00:05:33
tiger.protogeek.org NetworkManager[1132]:
<info> [1590728733.9596] manager: rfkill: Wi-Fi now disabled by radio
killswitch
May 29 00:05:38
tiger.protogeek.org systemd[1]: systemd-rfkill.service:
Succeeded.
May 29 00:05:38
tiger.protogeek.org audit[1]: SERVICE_STOP pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
Here I disconnected the copper Ethernet cable, from 00:07:33 -
00:18:14
May 29 00:07:33
tiger.protogeek.org kernel: rfkill: input handler
disabled
May 29 00:07:33
tiger.protogeek.org gsd-media-keys[8459]: Failed to
grab accelerator for keybinding settings:rfkill
May 29 00:07:57
tiger.protogeek.org kernel: rfkill: input handler
enabled
May 29 00:18:09
tiger.protogeek.org NetworkManager[1132]:
<info> [1590729489.0225] manager: rfkill: Wi-Fi now enabled by radio
killswitch
May 29 00:18:09
tiger.protogeek.org audit[1]: SERVICE_START pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
May 29 00:18:14
tiger.protogeek.org systemd[1]: systemd-rfkill.service:
Succeeded.
May 29 00:18:14
tiger.protogeek.org audit[1]: SERVICE_STOP pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
Reconnected the copper Ethernet cable, from 00:31:43 - 00:31:48
May 29 00:31:43
tiger.protogeek.org NetworkManager[1132]:
<info> [1590730303.2728] manager: rfkill: Wi-Fi now disabled by radio
killswitch
May 29 00:31:43
tiger.protogeek.org audit[1]: SERVICE_START pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
May 29 00:31:48
tiger.protogeek.org systemd[1]: systemd-rfkill.service:
Succeeded.
May 29 00:31:48
tiger.protogeek.org audit[1]: SERVICE_STOP pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
Several hours later, I disconnected the copper Ethernet cable again,
from 15:44:59 - 15:45:04
May 29 15:44:59
tiger.protogeek.org audit[1]: SERVICE_START pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
May 29 15:44:59
tiger.protogeek.org NetworkManager[1132]:
<info> [1590785099.5945] manager: rfkill: Wi-Fi now enabled by radio
killswitch
May 29 15:45:04
tiger.protogeek.org systemd[1]: systemd-rfkill.service:
Succeeded.
May 29 15:45:04
tiger.protogeek.org audit[1]: SERVICE_STOP pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
Then reconnected it again, from 15:45:19 - 15:45:24
May 29 15:45:19
tiger.protogeek.org NetworkManager[1132]:
<info> [1590785119.9723] manager: rfkill: Wi-Fi now disabled by radio
killswitch
May 29 15:45:19
tiger.protogeek.org audit[1]: SERVICE_START pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
May 29 15:45:24
tiger.protogeek.org systemd[1]: systemd-rfkill.service:
Succeeded.
May 29 15:45:24
tiger.protogeek.org audit[1]: SERVICE_STOP pid=1 uid=0
auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0
msg='unit=systemd-rfkill comm="systemd"
exe="/usr/lib/systemd/systemd"
hostname=? addr=? terminal=? res=success'
I wish I could decode this output line by line in detail, but that's
behond my skill set. I long for the simple old days of ifup and ifdown.
As I said in my last message about rfkill, I strongly suspect
NetworkManager is controlling these sequences.
--Doc Savage
Fairview Heights, IL