Bug 465012 - plasma-nm applet cannot store wifi passwords
Summary: plasma-nm applet cannot store wifi passwords
Status: RESOLVED WORKSFORME
Alias: None
Product: systemsettings
Classification: Applications
Component: kcm_networkmanagement (other bugs)
Version First Reported In: unspecified
Platform: Arch Linux Linux
: NOR major
Target Milestone: ---
Assignee: Plasma Bugs List
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2023-01-29 21:44 UTC by Nicola Feltrin
Modified: 2024-12-23 18:27 UTC (History)
2 users (show)

See Also:
Latest Commit:
Version Fixed/Implemented In:
Sentry Crash Report:


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Nicola Feltrin 2023-01-29 21:44:03 UTC
SUMMARY

This is a clean archlinux installation, relevant installed packages: plasma-meta, sddm, kwallet-pam, plasma-wayland-session. After the first start, attempting to store the password for any wifi network fails with a "no agents were available for this request" error.

The steps at https://techbase.kde.org/Projects/Solid/Plasma-nm suggest first checking if the plasma-nm kded module is running. That does not seem to be the case (the provided script returns "not running") and a run of qdbus does not provide anything looking like a `org.kde.plasmanetworkmanagement` line (which I get on another, older installation).

I initially suspected something going wrong with kwallet (so I did re-create the wallet a few times, with either blank passwords or setting the password the same as the login password) but that had no effect. I suspect now for some other reason the kded module is not starting.

Connection using nmcli works, but does not store the password in Kwallet (it gets stored in cleartext in the connection file at `/etc/NetworkManager/system-connections` instead).

STEPS TO REPRODUCE
1. Start with a clean install (I tried a couple of times already)
2. Login (wayland session, but it looks the same on X11)
3. Try to connect to a password-protected wifi network from the applet
4. Connection fails, at any following attempt to connect or manage that network a message appears stating that "no agents were available for this request"; password is not saved; connection is not achieved

OBSERVED RESULT

The networkmanager cannot connect to password-protected networks.

EXPECTED RESULT

The networkmanager successfully connects to networks

SOFTWARE/OS VERSIONS
Linux: 5.15.90-1-lts
KDE Plasma Version: 5.26.5 
KDE Frameworks Version: 5.102.0
Qt Version: 5.15.8
Networkmanager Version: 1.40.12

ADDITIONAL INFORMATION

Log for the latest run of NetworkManager, in case it might be useful...
```
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.1295] NetworkManager (version 1.40.12-1) is starting... (after a restart, boot:c4c553c6-bc51-4cc2-88e0-d19e62e45644)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.1296] Read config: /etc/NetworkManager/NetworkManager.conf (lib: 20-connectivity.conf)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.1442] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager"
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.1659] manager[0x559423a9a090]: monitoring kernel firmware directory '/lib/firmware'.
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3621] hostname: hostname: using hostnamed
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3621] hostname: static hostname changed from (none) to "Hostname"
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3629] dns-mgr: init: dns=default,systemd-resolved rc-manager=symlink
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3687] rfkill1: found Wi-Fi radio killswitch (at /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/ieee80211/phy0/rfkill1) (driver ath9k)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3693] manager[0x559423a9a090]: rfkill: Wi-Fi hardware radio set enabled
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3693] manager[0x559423a9a090]: rfkill: WWAN hardware radio set enabled
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3759] Loaded device plugin: NMAtmManager (/usr/lib/NetworkManager/1.40.12-1/libnm-device-plugin-adsl.so)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3849] Loaded device plugin: NMBluezManager (/usr/lib/NetworkManager/1.40.12-1/libnm-device-plugin-bluetooth.so)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.3886] Loaded device plugin: NMOvsFactory (/usr/lib/NetworkManager/1.40.12-1/libnm-device-plugin-ovs.so)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4021] Loaded device plugin: NMTeamFactory (/usr/lib/NetworkManager/1.40.12-1/libnm-device-plugin-team.so)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4034] Loaded device plugin: NMWifiFactory (/usr/lib/NetworkManager/1.40.12-1/libnm-device-plugin-wifi.so)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4044] Loaded device plugin: NMWwanFactory (/usr/lib/NetworkManager/1.40.12-1/libnm-device-plugin-wwan.so)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4051] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4056] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4061] manager: Networking is enabled by state file
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4066] settings: Loaded settings plugin: keyfile (internal)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4158] dhcp: init: Using DHCP client 'internal'
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4159] device (lo): carrier: link connected
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4165] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4211] manager: (enp3s0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4232] device (enp3s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4310] device (wlp2s0): driver supports Access Point (AP) mode
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4334] manager: (wlp2s0): new 802.11 Wi-Fi device (/org/freedesktop/NetworkManager/Devices/3)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4349] device (wlp2s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4511] device (wlp2s0): set-hw-addr: set MAC address to XX:XX:XX:XX:XX:XX (scanning)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.4784] ovsdb: disconnected from ovsdb
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.5377] device (wlp2s0): supplicant interface state: internal-starting -> disconnected
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.5384] Wi-Fi P2P device controlled by interface wlp2s0 created
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.5390] manager: (p2p-dev-wlp2s0): new 802.11 Wi-Fi P2P device (/org/freedesktop/NetworkManager/Devices/4)
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.5394] device (p2p-dev-wlp2s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.5403] device (wlp2s0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
Jan 29 22:22:47 Hostname NetworkManager[3295]: <info>  [1675027367.5413] device (p2p-dev-wlp2s0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8451] policy: auto-activating connection 'MyNetwork' (e44c22f1-99f9-4da1-991a-13d993014369)
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8464] device (wlp2s0): Activation: starting connection 'MyNetwork' (e44c22f1-99f9-4da1-991a-13d993014369)
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8467] device (wlp2s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8482] manager: NetworkManager state is now CONNECTING
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8621] device (wlp2s0): set-hw-addr: reset MAC address to XX:XX:XX:XX:XX:XX (preserve)
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8798] device (wlp2s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8811] device (wlp2s0): Activation: (wifi) access point 'MyNetwork' has security, but secrets are required.
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8814] device (wlp2s0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8829] device (wlp2s0): supplicant interface state: disconnected -> interface_disabled
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8832] device (p2p-dev-wlp2s0): supplicant management interface state: disconnected -> interface_disabled
Jan 29 22:22:48 Hostname NetworkManager[3295]: <warn>  [1675027368.8836] device (wlp2s0): no secrets: No agents were available for this request.
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8840] device (wlp2s0): state change: need-auth -> failed (reason 'no-secrets', sys-iface-state: 'managed')
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8856] manager: NetworkManager state is now DISCONNECTED
Jan 29 22:22:48 Hostname NetworkManager[3295]: <warn>  [1675027368.8873] device (wlp2s0): Activation: failed for connection 'MyNetwork'
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.8890] device (wlp2s0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.9022] device (wlp2s0): set-hw-addr: set MAC address to XX:XX:XX:XX:XX:XX (scanning)
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.9606] device (wlp2s0): supplicant interface state: interface_disabled -> inactive
Jan 29 22:22:48 Hostname NetworkManager[3295]: <info>  [1675027368.9607] device (p2p-dev-wlp2s0): supplicant management interface state: interface_disabled -> inactive
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.5803] device (wlp2s0): Activation: starting connection 'MyNetwork' (e44c22f1-99f9-4da1-991a-13d993014369)
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.5807] audit: op="connection-activate" uuid="e44c22f1-99f9-4da1-991a-13d993014369" name="MyNetwork" pid=2372 uid=1000 result="success"
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.5809] device (wlp2s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.5814] manager: NetworkManager state is now CONNECTING
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.5966] device (wlp2s0): set-hw-addr: reset MAC address to XX:XX:XX:XX:XX:XX (preserve)
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6132] device (wlp2s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6138] device (wlp2s0): Activation: (wifi) access point 'MyNetwork' has security, but secrets are required.
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6138] device (wlp2s0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6144] device (wlp2s0): supplicant interface state: inactive -> interface_disabled
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6145] device (p2p-dev-wlp2s0): supplicant management interface state: inactive -> interface_disabled
Jan 29 22:22:52 Hostname NetworkManager[3295]: <warn>  [1675027372.6146] device (wlp2s0): no secrets: No agents were available for this request.
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6146] device (wlp2s0): state change: need-auth -> failed (reason 'no-secrets', sys-iface-state: 'managed')
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6151] manager: NetworkManager state is now DISCONNECTED
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6312] device (wlp2s0): set-hw-addr: set MAC address to XX:XX:XX:XX:XX:XX (scanning)
Jan 29 22:22:52 Hostname NetworkManager[3295]: <warn>  [1675027372.6505] device (wlp2s0): Activation: failed for connection 'MyNetwork'
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.6512] device (wlp2s0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.7113] device (wlp2s0): supplicant interface state: interface_disabled -> inactive
Jan 29 22:22:52 Hostname NetworkManager[3295]: <info>  [1675027372.7114] device (p2p-dev-wlp2s0): supplicant management interface state: interface_disabled -> inactive
Jan 29 22:22:54 Hostname NetworkManager[3295]: <info>  [1675027374.0466] manager: startup complete
Jan 29 22:29:43 Hostname NetworkManager[3295]: <info>  [1675027783.9347] device (wlp2s0): set-hw-addr: set MAC address to XX:XX:XX:XX:XX:XX (scanning)
Jan 29 22:29:44 Hostname NetworkManager[3295]: <info>  [1675027784.0104] device (wlp2s0): supplicant interface state: inactive -> disconnected
Jan 29 22:29:44 Hostname NetworkManager[3295]: <info>  [1675027784.0105] device (p2p-dev-wlp2s0): supplicant management interface state: inactive -> disconnected
Jan 29 22:29:44 Hostname NetworkManager[3295]: <info>  [1675027784.0182] device (wlp2s0): supplicant interface state: disconnected -> inactive
Jan 29 22:29:44 Hostname NetworkManager[3295]: <info>  [1675027784.0183] device (p2p-dev-wlp2s0): supplicant management interface state: disconnected -> inactive
```
Comment 1 David Edmundson 2023-01-29 21:59:00 UTC
If you run:

 qdbus org.kde.kded5


do you see

/modules/networkmanagement
Comment 2 Nicola Feltrin 2023-01-30 07:36:53 UTC
No, I get

```
Error: org.freedesktop.DBus.Error.NoReply
Message recipient disconnected from message bus without replying
```

not sure if it's related or another issue entirely :/
Comment 3 David Edmundson 2023-01-30 10:12:27 UTC
ok, so kded isn't running which is what hosts the agent.

kded is a collection of multiple small applications for a range of background services.

This probably means something is crashing kded, probably completely unrelated to networking. Please look for coredumps for kded5.
Comment 4 Nicola Feltrin 2023-01-30 13:16:32 UTC
Thank you very much for your fast replies and sorry in advance for the silly question:

(In reply to David Edmundson from comment #3) 
> This probably means something is crashing kded, probably completely
> unrelated to networking. Please look for coredumps for kded5.

Where would I find those? It looks like kded5 is not being run as a systemd unit (system or user) and there are no obvious errors showing up (searches for kded5 coredumps mention bad crashes of the entire desktop environment with the dump in clear sight, in my case everything else seems to be working fine).
Comment 5 Nicola Feltrin 2023-02-01 19:55:24 UTC
So, I went on with the installation (mostly apparently unrelated stuff like firewall, backup, graphics drivers etc) and at some point I noticed that kded5 was running (qdbus org.kde.kded5 now gives a list of modules). Networkmanager passwords are now stored properly in Kwallett.

I still wonder what the issue was and I'll report again if I ever figure it out, but for the time being I think the ticket can be closed. Thank you very much for the support!