NetworkManager no longer connects

karlmistelberger · October 15, 2020, 10:10am

NetworkManager worked fine, but stopped working when the host was renamed:

3400G:~ # nmcli 
eno1: connecting (getting IP configuration) to Kabelgebundene Verbindung 1
        "Realtek RTL8111/8168/8411"
        ethernet (r8169), xx:xx:xx:xx:xx:xx, hw, mtu 1500

lo: unmanaged
        "lo"
        loopback (unknown), 00:00:00:00:00:00, sw, mtu 65536

Use "nmcli device show" to get complete information about known devices and
"nmcli connection show" to get an overview on active connection profiles.

Consult nmcli(1) and nmcli-examples(7) manual pages for complete usage details.
3400G:~ #

Wicked connects readily:

3400G:~ # journalctl -b -u wicked* --since 09:50
-- Logs begin at Mon 2020-10-12 03:36:35 CEST, end at Thu 2020-10-15 10:00:02 CEST. --
Oct 15 09:54:36 3400G systemd[1]: Starting wicked AutoIPv4 supplicant service...
Oct 15 09:54:36 3400G systemd[1]: Starting wicked DHCPv4 supplicant service...
Oct 15 09:54:36 3400G systemd[1]: Starting wicked DHCPv6 supplicant service...
Oct 15 09:54:36 3400G systemd[1]: Started wicked AutoIPv4 supplicant service.
Oct 15 09:54:36 3400G systemd[1]: Started wicked DHCPv6 supplicant service.
Oct 15 09:54:36 3400G systemd[1]: Started wicked DHCPv4 supplicant service.
Oct 15 09:54:36 3400G systemd[1]: Starting wicked network management service daemon...
Oct 15 09:54:36 3400G systemd[1]: Started wicked network management service daemon.
Oct 15 09:54:36 3400G systemd[1]: Starting wicked network nanny service...
Oct 15 09:54:36 3400G systemd[1]: Started wicked network nanny service.
Oct 15 09:54:36 3400G systemd[1]: Starting wicked managed network interfaces...
Oct 15 09:54:36 3400G wickedd-dhcp4[14443]: eno1: Request to acquire DHCPv4 lease with UUID 3c00885f-1cbb-0c00-6d38-000003000000
Oct 15 09:54:37 3400G wickedd-dhcp4[14443]: eno1: Committed DHCPv4 lease with address 10.0.0.2 (lease time 86400 sec, renew in 43200 sec, rebind in 75600 sec)
Oct 15 09:54:38 3400G wicked[14448]: lo              up
Oct 15 09:54:38 3400G wicked[14448]: eno1            up
Oct 15 09:54:38 3400G systemd[1]: Finished wicked managed network interfaces.
3400G:~ #

Using Yast2 lan for switching to NetworkManager fails: No network.

3400G:~ # journalctl -b -u NetworkManager.service --since 10:00
-- Logs begin at Mon 2020-10-12 03:36:35 CEST, end at Thu 2020-10-15 10:04:35 CEST. --
Oct 15 10:02:14 3400G systemd[1]: Starting Network Manager...
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.7192] NetworkManager (version 1.26.2) is starting... (after a restart)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.7193] Read config: /etc/NetworkManager/NetworkManager.conf
Oct 15 10:02:14 3400G systemd[1]: Started Network Manager.
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.7210] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager"
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.7242] manager[0x55fd6aa170c0]: monitoring kernel firmware directory '/lib/firmware'.
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8072] hostname: hostname: using hostnamed
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8072] hostname: hostname changed from (none) to "3400G"
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8077] dns-mgr[0x55fd6a9fd240]: init: dns=default,systemd-resolved rc-manager=netconfig
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8082] manager[0x55fd6aa170c0]: rfkill: Wi-Fi hardware radio set enabled
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8082] manager[0x55fd6aa170c0]: rfkill: WWAN hardware radio set enabled
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8100] Loaded device plugin: NMAtmManager (/usr/lib64/NetworkManager/1.26.2/libnm-device-plugin-adsl.so)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8121] Loaded device plugin: NMBluezManager (/usr/lib64/NetworkManager/1.26.2/libnm-device-plugin-bluetooth.so)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8127] Loaded device plugin: NMOvsFactory (/usr/lib64/NetworkManager/1.26.2/libnm-device-plugin-ovs.so)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8142] Loaded device plugin: NMTeamFactory (/usr/lib64/NetworkManager/1.26.2/libnm-device-plugin-team.so)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8147] Loaded device plugin: NMWifiFactory (/usr/lib64/NetworkManager/1.26.2/libnm-device-plugin-wifi.so)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8151] Loaded device plugin: NMWwanFactory (/usr/lib64/NetworkManager/1.26.2/libnm-device-plugin-wwan.so)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8156] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8159] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8161] manager: Networking is enabled by state file
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8164] dhcp-init: Using DHCP client 'internal'
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8166] settings: Loaded settings plugin: keyfile (internal)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8186] device (lo): carrier: link connected
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8190] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8203] manager: (eno1): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
Oct 15 10:02:14 3400G NetworkManager[17394]: <info>  [1602748934.8216] device (eno1): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Oct 15 10:02:15 3400G NetworkManager[17394]: <info>  [1602748935.0080] agent-manager: agent[73f88890cb9aed12,:1.19/org.kde.plasma.networkmanagement/1000]: agent registered
Oct 15 10:02:15 3400G NetworkManager[17394]: <info>  [1602748935.0081] ovsdb: Verbindung ist gescheitert: Datei oder Verzeichnis nicht gefunden
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5227] device (eno1): carrier: link connected
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5233] device (eno1): state change: unavailable -> disconnected (reason 'carrier-changed', sys-iface-state: 'managed')
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5250] policy: auto-activating connection 'Kabelgebundene Verbindung 1' (c1929f3c-a238-3096-8ca2-c34c3b4262f5)
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5262] device (eno1): Activation: starting connection 'Kabelgebundene Verbindung 1' (c1929f3c-a238-3096-8ca2-c34c3b4262f5)
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5264] device (eno1): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5273] manager: NetworkManager state is now CONNECTING
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5278] device (eno1): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5288] device (eno1): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Oct 15 10:02:16 3400G NetworkManager[17394]: <info>  [1602748936.5294] dhcp4 (eno1): activation: beginning transaction (timeout in 45 seconds)
Oct 15 10:03:02 3400G NetworkManager[17394]: <warn>  [1602748982.2103] dhcp4 (eno1): request timed out
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2103] dhcp4 (eno1): state changed unknown -> timeout
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2104] device (eno1): state change: ip-config -> failed (reason 'ip-config-unavailable', sys-iface-state: 'managed')
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2111] manager: NetworkManager state is now DISCONNECTED
Oct 15 10:03:02 3400G NetworkManager[17394]: <warn>  [1602748982.2124] device (eno1): Activation: failed for connection 'Kabelgebundene Verbindung 1'
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2130] device (eno1): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2423] dhcp4 (eno1): canceled DHCP transaction
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2423] dhcp4 (eno1): state changed timeout -> done
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2451] policy: auto-activating connection 'Kabelgebundene Verbindung 1' (c1929f3c-a238-3096-8ca2-c34c3b4262f5)
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2474] device (eno1): Activation: starting connection 'Kabelgebundene Verbindung 1' (c1929f3c-a238-3096-8ca2-c34c3b4262f5)
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2475] device (eno1): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2480] manager: NetworkManager state is now CONNECTING
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2482] device (eno1): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2488] device (eno1): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2493] dhcp4 (eno1): activation: beginning transaction (timeout in 45 seconds)
Oct 15 10:03:02 3400G NetworkManager[17394]: <info>  [1602748982.2564] dhcp4 (eno1): state changed unknown -> expire
3400G:~ #

Any idea?

nrickert · October 15, 2020, 2:13pm

While you are using “wicked”:

Remove any configuration files from “/etc/NetworkManager/system-connections”
Remove all state information from “/var/lib/NetworkManager”

Then reboot, and try again.

karlmistelberger · October 15, 2020, 3:38pm

Performed all of the actions to no avail:

3400G:~ # journalctl -b -u NetworkManager.service --since 15:24
-- Logs begin at Mon 2020-10-12 03:36:35 CEST, end at Thu 2020-10-15 15:32:07 CEST. --
Oct 15 15:24:33 3400G NetworkManager[540]: <warn>  [1602768273.2134] dhcp4 (eno1): request timed out
Oct 15 15:24:33 3400G NetworkManager[540]: <info>  [1602768273.2134] dhcp4 (eno1): state changed unknown -> timeout
Oct 15 15:24:33 3400G NetworkManager[540]: <info>  [1602768273.2135] device (eno1): state change: ip-config -> failed (reason 'ip-config-unavailable', sys-iface-state: 'managed')
Oct 15 15:24:33 3400G NetworkManager[540]: <info>  [1602768273.2143] manager: NetworkManager state is now DISCONNECTED
Oct 15 15:24:33 3400G NetworkManager[540]: <warn>  [1602768273.2159] device (eno1): Activation: failed for connection 'Kabelgebundene Verbindung 1'
Oct 15 15:24:33 3400G NetworkManager[540]: <info>  [1602768273.2164] device (eno1): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Oct 15 15:24:33 3400G NetworkManager[540]: <info>  [1602768273.2174] dhcp4 (eno1): canceled DHCP transaction
Oct 15 15:24:33 3400G NetworkManager[540]: <info>  [1602768273.2174] dhcp4 (eno1): state changed timeout -> done
Oct 15 15:24:59 3400G NetworkManager[540]: <info>  [1602768299.6233] device (eno1): Activation: starting connection 'Kabelgebundene Verbindung 1' (c1929f3c-a238-3096-8ca2-c34c3b4262f5)
Oct 15 15:24:59 3400G NetworkManager[540]: <info>  [1602768299.6235] audit: op="connection-activate" uuid="c1929f3c-a238-3096-8ca2-c34c3b4262f5" name="Kabelgebundene Verbindung 1" pid=1210 uid=1000 result="success"
Oct 15 15:24:59 3400G NetworkManager[540]: <info>  [1602768299.6237] device (eno1): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Oct 15 15:24:59 3400G NetworkManager[540]: <info>  [1602768299.6246] manager: NetworkManager state is now CONNECTING
Oct 15 15:24:59 3400G NetworkManager[540]: <info>  [1602768299.6252] device (eno1): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Oct 15 15:24:59 3400G NetworkManager[540]: <info>  [1602768299.6264] device (eno1): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Oct 15 15:24:59 3400G NetworkManager[540]: <info>  [1602768299.6270] dhcp4 (eno1): activation: beginning transaction (timeout in 45 seconds)
Oct 15 15:25:45 3400G NetworkManager[540]: <warn>  [1602768345.2090] dhcp4 (eno1): request timed out
Oct 15 15:25:45 3400G NetworkManager[540]: <info>  [1602768345.2090] dhcp4 (eno1): state changed unknown -> timeout
Oct 15 15:25:45 3400G NetworkManager[540]: <info>  [1602768345.2092] device (eno1): state change: ip-config -> failed (reason 'ip-config-unavailable', sys-iface-state: 'managed')
Oct 15 15:25:45 3400G NetworkManager[540]: <info>  [1602768345.2102] manager: NetworkManager state is now DISCONNECTED
Oct 15 15:25:45 3400G NetworkManager[540]: <warn>  [1602768345.2121] device (eno1): Activation: failed for connection 'Kabelgebundene Verbindung 1'
Oct 15 15:25:45 3400G NetworkManager[540]: <info>  [1602768345.2126] device (eno1): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Oct 15 15:25:45 3400G NetworkManager[540]: <info>  [1602768345.2140] dhcp4 (eno1): canceled DHCP transaction
Oct 15 15:25:45 3400G NetworkManager[540]: <info>  [1602768345.2141] dhcp4 (eno1): state changed timeout -> done
3400G:~ #

When switching to wicked the machine readily connects:

400G:~ # journalctl -b -u wicked*
-- Logs begin at Mon 2020-10-12 03:36:35 CEST, end at Thu 2020-10-15 15:36:57 CEST. --
Oct 15 15:26:28 3400G systemd[1]: Starting wicked AutoIPv4 supplicant service...
Oct 15 15:26:28 3400G systemd[1]: Starting wicked DHCPv4 supplicant service...
Oct 15 15:26:28 3400G systemd[1]: Starting wicked DHCPv6 supplicant service...
Oct 15 15:26:28 3400G systemd[1]: Started wicked AutoIPv4 supplicant service.
Oct 15 15:26:28 3400G systemd[1]: Started wicked DHCPv6 supplicant service.
Oct 15 15:26:28 3400G systemd[1]: Started wicked DHCPv4 supplicant service.
Oct 15 15:26:28 3400G systemd[1]: Starting wicked network management service daemon...
Oct 15 15:26:28 3400G systemd[1]: Started wicked network management service daemon.
Oct 15 15:26:28 3400G systemd[1]: Starting wicked network nanny service...
Oct 15 15:26:28 3400G systemd[1]: Started wicked network nanny service.
Oct 15 15:26:28 3400G systemd[1]: Starting wicked managed network interfaces...
Oct 15 15:26:28 3400G wickedd-dhcp4[4017]: eno1: Request to acquire DHCPv4 lease with UUID 044e885f-e167-0700-b30f-000002000000
Oct 15 15:26:29 3400G wickedd-dhcp4[4017]: eno1: Committed DHCPv4 lease with address 10.0.0.2 (lease time 86400 sec, renew in 43200 sec, rebind in 75600 sec)
Oct 15 15:26:30 3400G wicked[4022]: lo              up
Oct 15 15:26:30 3400G wicked[4022]: eno1            up
Oct 15 15:26:30 3400G systemd[1]: Finished wicked managed network interfaces.
3400G:~ #

Sauerland · October 15, 2020, 3:42pm

Is this a Laptop?

karlmistelberger · October 15, 2020, 3:54pm

It’s a desktop:

3400G:~ # inxi -zaN
Network:   Device-1: Realtek RTL8111/8168/8411 PCI Express Gigabit Ethernet vendor: Gigabyte driver: r8169 v: kernel 
           port: f000 bus ID: 03:00.0 chip ID: 10ec:8168 
           IF: eno1 state: up speed: 100 Mbps duplex: full mac: <filter> 
3400G:~ #

karlmistelberger · October 15, 2020, 4:28pm

While wicked worked well the router got confused when connecting to NetworkManager. Rebooting the router fixed the problem.

nrickert · October 15, 2020, 4:52pm

It might be due to some of the funky stuff that NetworkManager does, such as randomizing the MAC address. This is supposed to enhance privacy. I guess when you cannot connect at all, that is the highest level of privacy

suse_rasputin · March 24, 2021, 3:06pm

Can’t confirm MAC randomization, I use reserved IPs by MAC on the level of my DHCP-server, never had any problems with the MACs…

karlmistelberger · December 14, 2022, 7:13am

NetworkManager made a big leap forward since it became the default option. Checked functionality and found it superior to systemd-network.

karlmistelberger · December 25, 2022, 6:53am

Renaming the host no longer confuses NetworkManager. I get what I expect:

3400G:~ # nmcli

enp3s0: connected to enp3s0
        "Realtek RTL8111/8168/8411"
        ethernet (r8169), XX:XX:XX:XX:XX:XX, hw, mtu 1500
        ip4 default
        inet4 10.0.0.2/24
        route4 10.0.0.0/24 metric 100
        route4 default via 10.0.0.138 metric 100

lo: unmanaged
        "lo"
        loopback (unknown), 00:00:00:00:00:00, sw, mtu 65536

DNS configuration:
        servers: 10.0.0.138
        domains: lan
        interface: enp3s0

Use "nmcli device show" to get complete information about known devices and
"nmcli connection show" to get an overview on active connection profiles.

Consult nmcli(1) and nmcli-examples(7) manual pages for complete usage details.
3400G:~ #