https://bugs.kde.org/show_bug.cgi?id=407674
Rajeesh K V <rajeeshknamb...@gmail.com> changed:
What |Removed |Added
----------------------------------------------------------------------------
CC| |rajeeshknamb...@gmail.com
--- Comment #1 from Rajeesh K V <rajeeshknamb...@gmail.com> ---
Is this issue by any chance on Plasma 5.16 beta?
I can observe similar issue. On startup, WiFi is not automatically connected.
Clicking on a WiFi connection to `Connect` almost immediately fails but then
the connection succeeds (when I click the `Configure` button and opens up the
KCM). Following messages captured in journal:
May 19 11:52:50 athena systemd[1]: Started Load/Save RF Kill Switch Status.
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.5619] audit:
op="radio-control" arg="wireless-enabled" pid=1140 uid=1000 result="success"
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.5630] manager:
rfkill: Wi-Fi now enabled by radio killswitch
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.6088]
sup-iface[0x561361ac40e0,wlp1s0]: supports 5 scan SSIDs
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.6109] device
(wlp1s0): supplicant interface state: starting -> ready
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.6112] Wi-Fi P2P
device controlled by interface wlp1s0 created
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.6122] manager:
(p2p-dev-wlp1s0): new 802.11 Wi-Fi P2P device
(/org/freedesktop/NetworkManager/Devices/3)
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.6138] device
(p2p-dev-wlp1s0): state change: unmanaged -> unavailable (reason 'managed',
sys-iface-state: 'external')
May 19 11:52:50 athena NetworkManager[774]: <warn> [1558246970.6168]
sup-iface: failed to cancel p2p connect: P2P cancel failed
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.6185] device
(p2p-dev-wlp1s0): state change: unavailable -> disconnected (reason 'none',
sys-iface-state: 'managed')
May 19 11:52:50 athena NetworkManager[774]: <info> [1558246970.6198] device
(wlp1s0): state change: unavailable -> disconnected (reason
'supplicant-available', sys-iface-state: 'managed')
May 19 11:52:51 athena systemd[1]: Started
dbus-:1.3-org.kde.powerdevil.backlighthelper@1.service.
May 19 11:52:55 athena systemd[1]: systemd-rfkill.service: Succeeded.
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.8962] device
(wlp1s0): Activation: starting connection 'Rajeesh’s iPhone'
(924f1528-035a-48e3-bb27-91282420a80b)
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.8965] audit:
op="connection-activate" uuid="924f1528-035a-48e3-bb27-91282420a80b"
name="Rajeesh’s iPhone" pid=1140 uid=1000 result="success"
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.8969] device
(wlp1s0): state change: disconnected -> prepare (reason 'none',
sys-iface-state: 'managed')
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.8981] manager:
NetworkManager state is now CONNECTING
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9016] device
(wlp1s0): set-hw-addr: reset MAC address to A4:34:D9:1D:92:23 (preserve)
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9083] device
(wlp1s0): supplicant interface state: ready -> disabled
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9085] device
(p2p-dev-wlp1s0): supplicant management interface state: ready -> disabled
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9088] device
(wlp1s0): state change: prepare -> config (reason 'none', sys-iface-state:
'managed')
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9102] device
(wlp1s0): Activation: (wifi) access point 'Rajeesh’s iPhone' has security, but
secrets are required.
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9103] device
(wlp1s0): state change: config -> need-auth (reason 'none', sys-iface-state:
'managed')
May 19 11:52:56 athena NetworkManager[774]: <warn> [1558246976.9123] device
(wlp1s0): no secrets: No agents were available for this request.
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9123] device
(wlp1s0): state change: need-auth -> failed (reason 'no-secrets',
sys-iface-state: 'managed')
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9137] manager:
NetworkManager state is now DISCONNECTED
May 19 11:52:56 athena NetworkManager[774]: <warn> [1558246976.9143] device
(wlp1s0): Activation: failed for connection 'Rajeesh’s iPhone'
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9151] device
(wlp1s0): state change: failed -> disconnected (reason 'none', sys-iface-state:
'managed')
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9182] device
(wlp1s0): set-hw-addr: set MAC address to 12:25:EB:2F:BB:3C (scanning)
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9426] device
(wlp1s0): supplicant interface state: disabled -> inactive
May 19 11:52:56 athena NetworkManager[774]: <info> [1558246976.9428] device
(p2p-dev-wlp1s0): supplicant management interface state: disabled -> inactive
May 19 11:52:56 athena wpa_supplicant[867]: wlp1s0: Reject scan trigger since
one is already pending
May 19 11:53:02 athena systemd[1]:
dbus-:1.3-org.kde.powerdevil.backlighthelper@1.service: Succeeded.
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0713] device
(wlp1s0): Activation: starting connection 'Rajeesh’s iPhone'
(924f1528-035a-48e3-bb27-91282420a80b)
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0715] audit:
op="connection-activate" uuid="924f1528-035a-48e3-bb27-91282420a80b"
name="Rajeesh’s iPhone" pid=1140 uid=1000 result="success"
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0717] device
(wlp1s0): state change: disconnected -> prepare (reason 'none',
sys-iface-state: 'managed')
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0727] manager:
NetworkManager state is now CONNECTING
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0756] device
(wlp1s0): set-hw-addr: reset MAC address to A4:34:D9:1D:92:23 (preserve)
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0836] device
(wlp1s0): supplicant interface state: inactive -> disabled
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0837] device
(p2p-dev-wlp1s0): supplicant management interface state: inactive -> disabled
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0843] device
(wlp1s0): state change: prepare -> config (reason 'none', sys-iface-state:
'managed')
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0854] device
(wlp1s0): Activation: (wifi) access point 'Rajeesh’s iPhone' has security, but
secrets are required.
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0854] device
(wlp1s0): state change: config -> need-auth (reason 'none', sys-iface-state:
'managed')
May 19 11:53:03 athena NetworkManager[774]: <warn> [1558246983.0873] device
(wlp1s0): no secrets: No agents were available for this request.
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0874] device
(wlp1s0): state change: need-auth -> failed (reason 'no-secrets',
sys-iface-state: 'managed')
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0886] manager:
NetworkManager state is now DISCONNECTED
May 19 11:53:03 athena NetworkManager[774]: <warn> [1558246983.0897] device
(wlp1s0): Activation: failed for connection 'Rajeesh’s iPhone'
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0908] device
(wlp1s0): state change: failed -> disconnected (reason 'none', sys-iface-state:
'managed')
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.0948] device
(wlp1s0): set-hw-addr: set MAC address to 16:1B:7B:96:95:C9 (scanning)
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.1116] device
(wlp1s0): supplicant interface state: disabled -> inactive
May 19 11:53:03 athena NetworkManager[774]: <info> [1558246983.1118] device
(p2p-dev-wlp1s0): supplicant management interface state: disabled -> inactive
May 19 11:53:03 athena wpa_supplicant[867]: wlp1s0: Reject scan trigger since
one is already pending
May 19 11:53:06 athena systemd[1]: Starting Load/Save RF Kill Switch Status...
May 19 11:53:06 athena systemd[1]: Started Load/Save RF Kill Switch Status.
May 19 11:53:06 athena NetworkManager[774]: <info> [1558246986.3666] manager:
rfkill: Wi-Fi hardware radio set disabled
May 19 11:53:06 athena NetworkManager[774]: <info> [1558246986.3668] device
(wlp1s0): state change: disconnected -> unavailable (reason 'none',
sys-iface-state: 'managed')
May 19 11:53:06 athena wpa_supplicant[867]: rfkill: WLAN soft blocked
May 19 11:53:06 athena NetworkManager[774]: <info> [1558246986.3719] audit:
op="radio-control" arg="wireless-enabled" pid=1140 uid=1000 result="success"
May 19 11:53:06 athena wpa_supplicant[867]: nl80211: deinit
ifname=p2p-dev-wlp1s0 disabled_11b_rates=0
May 19 11:53:06 athena NetworkManager[774]: <info> [1558246986.3732] manager:
rfkill: Wi-Fi now disabled by radio killswitch
May 19 11:53:06 athena NetworkManager[774]: <info> [1558246986.3739] device
(p2p-dev-wlp1s0): state change: disconnected -> unavailable (reason
'supplicant-failed', sys-iface-state: 'managed')
May 19 11:53:06 athena wpa_supplicant[867]: nl80211: deinit ifname=wlp1s0
disabled_11b_rates=0
May 19 11:53:07 athena NetworkManager[774]: <info> [1558246987.5353] manager:
rfkill: Wi-Fi hardware radio set enabled
May 19 11:53:07 athena NetworkManager[774]: <info> [1558246987.8328] audit:
op="radio-control" arg="wireless-enabled" pid=1140 uid=1000 result="success"
May 19 11:53:07 athena NetworkManager[774]: <info> [1558246987.8339] manager:
rfkill: Wi-Fi now enabled by radio killswitch
May 19 11:53:07 athena NetworkManager[774]: <info> [1558246987.8675]
sup-iface[0x561361ac41c0,wlp1s0]: supports 5 scan SSIDs
May 19 11:53:07 athena NetworkManager[774]: <info> [1558246987.8691] device
(wlp1s0): supplicant interface state: starting -> ready
May 19 11:53:07 athena NetworkManager[774]: <info> [1558246987.8693] device
(p2p-dev-wlp1s0): state change: unavailable -> disconnected (reason
'supplicant-available', sys-iface-state: 'managed')
May 19 11:53:07 athena NetworkManager[774]: <info> [1558246987.8712] device
(wlp1s0): state change: unavailable -> disconnected (reason
'supplicant-available', sys-iface-state: 'managed')
May 19 11:53:11 athena systemd[805]: Created slice
dbus\x2d:1.2\x2dorg.kde.kded5.slice.
May 19 11:53:11 athena systemd[805]: Started dbus-:1.2-org.kde.kded5@0.service.
May 19 11:53:12 athena colord[1109]: failed to get session [pid 2391]: No data
available
May 19 11:53:12 athena NetworkManager[774]: <info> [1558246992.4864]
agent-manager: req[0x561361bc5ed0,
:1.284/org.kde.plasma.networkmanagement/1000]: agent registered
May 19 11:53:12 athena systemd[1]: systemd-rfkill.service: Succeeded.
May 19 11:53:16 athena systemd[805]: Starting Mark boot as successful...
May 19 11:53:16 athena systemd[805]: grub-boot-success.service: Succeeded.
May 19 11:53:16 athena systemd[805]: Started Mark boot as successful.
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.0916] device
(wlp1s0): Activation: starting connection 'Rajeesh’s iPhone'
(924f1528-035a-48e3-bb27-91282420a80b)
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.0918] audit:
op="connection-activate" uuid="924f1528-035a-48e3-bb27-91282420a80b"
name="Rajeesh’s iPhone" pid=1140 uid=1000 result="success"
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.0921] device
(wlp1s0): state change: disconnected -> prepare (reason 'none',
sys-iface-state: 'managed')
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.0931] manager:
NetworkManager state is now CONNECTING
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.0963] device
(wlp1s0): set-hw-addr: reset MAC address to A4:34:D9:1D:92:23 (preserve)
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1020] device
(wlp1s0): state change: prepare -> config (reason 'none', sys-iface-state:
'managed')
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1026] device
(wlp1s0): Activation: (wifi) access point 'Rajeesh’s iPhone' has security, but
secrets are required.
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1027] device
(wlp1s0): state change: config -> need-auth (reason 'none', sys-iface-state:
'managed')
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1164] device
(wlp1s0): supplicant interface state: ready -> disconnected
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1165] device
(p2p-dev-wlp1s0): supplicant management interface state: ready -> disconnected
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1207] device
(wlp1s0): supplicant interface state: disconnected -> inactive
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1207] device
(p2p-dev-wlp1s0): supplicant management interface state: disconnected ->
inactive
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1328] device
(wlp1s0): state change: need-auth -> prepare (reason 'none', sys-iface-state:
'managed')
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1337] device
(wlp1s0): state change: prepare -> config (reason 'none', sys-iface-state:
'managed')
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1341] device
(wlp1s0): Activation: (wifi) connection 'Rajeesh’s iPhone' has security, and
secrets exist. No new secrets needed.
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1342] Config:
added 'ssid' value 'Rajeesh’s iPhone'
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1342] Config:
added 'scan_ssid' value '1'
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1343] Config:
added 'bgscan' value 'simple:30:-80:86400'
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1343] Config:
added 'key_mgmt' value 'WPA-PSK WPA-PSK-SHA256'
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1343] Config:
added 'psk' value '<hidden>'
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1462] device
(wlp1s0): supplicant interface state: inactive -> scanning
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.1463] device
(p2p-dev-wlp1s0): supplicant management interface state: inactive -> scanning
May 19 11:53:22 athena wpa_supplicant[867]: wlp1s0: SME: Trying to authenticate
with f2:c5:f3:f2:eb:74 (SSID='Rajeesh\xe2\x80\x99s iPhone' freq=2412 MHz)
May 19 11:53:22 athena kernel: wlp1s0: authenticate with f2:c5:f3:f2:eb:74
May 19 11:53:22 athena kernel: wlp1s0: send auth to f2:c5:f3:f2:eb:74 (try 1/3)
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.8967] device
(wlp1s0): supplicant interface state: scanning -> authenticating
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.8968] device
(p2p-dev-wlp1s0): supplicant management interface state: scanning ->
authenticating
May 19 11:53:22 athena wpa_supplicant[867]: wlp1s0: Trying to associate with
f2:c5:f3:f2:eb:74 (SSID='Rajeesh\xe2\x80\x99s iPhone' freq=2412 MHz)
May 19 11:53:22 athena kernel: wlp1s0: authenticated
May 19 11:53:22 athena kernel: wlp1s0: associate with f2:c5:f3:f2:eb:74 (try
1/3)
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.9043] device
(wlp1s0): supplicant interface state: authenticating -> associating
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.9046] device
(p2p-dev-wlp1s0): supplicant management interface state: authenticating ->
associating
May 19 11:53:22 athena kernel: wlp1s0: RX AssocResp from f2:c5:f3:f2:eb:74
(capab=0x411 status=0 aid=1)
May 19 11:53:22 athena kernel: wlp1s0: associated
May 19 11:53:22 athena wpa_supplicant[867]: wlp1s0: Associated with
f2:c5:f3:f2:eb:74
May 19 11:53:22 athena wpa_supplicant[867]: wlp1s0:
CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.9176] device
(wlp1s0): supplicant interface state: associating -> associated
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.9177] device
(p2p-dev-wlp1s0): supplicant management interface state: associating ->
associated
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.9306] device
(wlp1s0): supplicant interface state: associated -> 4-way handshake
May 19 11:53:22 athena NetworkManager[774]: <info> [1558247002.9307] device
(p2p-dev-wlp1s0): supplicant management interface state: associated -> 4-way
handshake
May 19 11:53:23 athena wpa_supplicant[867]: wlp1s0: WPA: Key negotiation
completed with f2:c5:f3:f2:eb:74 [PTK=CCMP GTK=CCMP]
May 19 11:53:23 athena wpa_supplicant[867]: wlp1s0: CTRL-EVENT-CONNECTED -
Connection to f2:c5:f3:f2:eb:74 completed [id=0 id_str=]
May 19 11:53:23 athena kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp1s0: link
becomes ready
May 19 11:53:23 athena wpa_supplicant[867]: wlp1s0: CTRL-EVENT-SIGNAL-CHANGE
above=1 signal=-33 noise=9999 txrate=1000
May 19 11:53:23 athena NetworkManager[774]: <info> [1558247003.0382] device
(wlp1s0): supplicant interface state: 4-way handshake -> completed
May 19 11:53:23 athena NetworkManager[774]: <info> [1558247003.0383] device
(wlp1s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.
Connected to wireless network "Rajeesh\342\200\231s iPhone"
May 19 11:53:23 athena NetworkManager[774]: <info> [1558247003.0384] device
(p2p-dev-wlp1s0): supplicant management interface state: 4-way handshake ->
completed
May 19 11:53:23 athena NetworkManager[774]: <info> [1558247003.0503] device
(wlp1s0): state change: config -> ip-config (reason 'none', sys-iface-state:
'managed')
May 19 11:53:23 athena NetworkManager[774]: <info> [1558247003.0512] dhcp4
(wlp1s0): activation: beginning transaction (timeout in 45 seconds)
May 19 11:53:23 athena NetworkManager[774]: <info> [1558247003.0529] dhcp4
(wlp1s0): dhclient started with pid 2494
May 19 11:53:23 athena dhclient[2494]: DHCPDISCOVER on wlp1s0 to
255.255.255.255 port 67 interval 6 (xid=0xdd7a464d)
May 19 11:53:23 athena wpa_supplicant[867]: wlp1s0: CTRL-EVENT-SIGNAL-CHANGE
above=1 signal=-34 noise=9999 txrate=72200
May 19 11:53:29 athena dhclient[2494]: DHCPDISCOVER on wlp1s0 to
255.255.255.255 port 67 interval 11 (xid=0xdd7a464d)
May 19 11:53:29 athena dhclient[2494]: DHCPREQUEST on wlp1s0 to 255.255.255.255
port 67 (xid=0xdd7a464d)
May 19 11:53:29 athena dhclient[2494]: DHCPOFFER from 172.20.10.1
May 19 11:53:29 athena dhclient[2494]: DHCPACK from 172.20.10.1
(xid=0xdd7a464d)
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5376] dhcp4
(wlp1s0): address 172.20.10.2
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5377] dhcp4
(wlp1s0): plen 28 (255.255.255.240)
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5378] dhcp4
(wlp1s0): gateway 172.20.10.1
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5378] dhcp4
(wlp1s0): lease time 85536
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5379] dhcp4
(wlp1s0): nameserver '172.20.10.1'
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5380] dhcp4
(wlp1s0): state changed unknown -> bound
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5454] device
(wlp1s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state:
'managed')
May 19 11:53:29 athena dhclient[2494]: bound to 172.20.10.2 -- renewal in 36594
seconds.
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5495] device
(wlp1s0): state change: ip-check -> secondaries (reason 'none',
sys-iface-state: 'managed')
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5507] device
(wlp1s0): state change: secondaries -> activated (reason 'none',
sys-iface-state: 'managed')
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5527] manager:
NetworkManager state is now CONNECTED_LOCAL
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5600] manager:
NetworkManager state is now CONNECTED_SITE
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5604] policy:
set 'Rajeesh’s iPhone' (wlp1s0) as default for IPv4 routing and DNS
May 19 11:53:29 athena NetworkManager[774]: <info> [1558247009.5626] device
(wlp1s0): Activation: successful, device activated.
--
You are receiving this mail because:
You are watching all bug changes.
