On 21/08/2020 15.29, Darryl Gregorash wrote:
The last two times my system has been rebooted, it failed to start the network service. I had to do a manual restart to get internet service. I have no idea where to look to correct the problem.
Here are the relevant log entries from the latest reboot (apologies for the long lines -- I did not write them :) ):
Long lines are good; wrapped log lines are bad.
2020-08-21T07:00:58.683449-06:00 hadron systemd[1]: Starting wicked DHCPv4 supplicant service... 2020-08-21T07:00:58.684634-06:00 hadron systemd[1]: Starting wicked AutoIPv4 supplicant service... 2020-08-21T07:00:58.685617-06:00 hadron systemd[1]: Starting wicked DHCPv6 supplicant service... 2020-08-21T07:00:58.708869-06:00 hadron systemd[1]: Started wicked AutoIPv4 supplicant service. 2020-08-21T07:00:58.709093-06:00 hadron systemd[1]: Started wicked DHCPv6 supplicant service. 2020-08-21T07:00:58.709203-06:00 hadron systemd[1]: Started wicked DHCPv4 supplicant service. 2020-08-21T07:00:58.710197-06:00 hadron systemd[1]: Starting wicked network management service daemon... 2020-08-21T07:00:58.727620-06:00 hadron systemd[1]: Started wicked network management service daemon. 2020-08-21T07:00:58.730168-06:00 hadron systemd[1]: Starting wicked network nanny service... 2020-08-21T07:00:58.750880-06:00 hadron systemd[1]: Started wicked network nanny service. 2020-08-21T07:00:58.751912-06:00 hadron systemd[1]: Starting wicked managed network interfaces... 2020-08-21T07:01:02.276106-06:00 hadron wickedd-dhcp4[1380]: eth0: Request to acquire DHCPv4 lease with UUID 8bc53f5f-8cf8-0400-7805-000004000000 2020-08-21T07:01:12.551065-06:00 hadron wickedd-dhcp4[1380]: unable to confirm lease 2020-08-21T07:01:17.550092-06:00 hadron wickedd-dhcp4[1380]: eth0: defer timeout 15 reached (state INIT) 2020-08-21T07:01:18.898020-06:00 hadron wickedd-dhcp4[1380]: eth0: Request to acquire DHCPv4 lease with UUID 8bc53f5f-8cf8-0400-7805-000004000000 2020-08-21T07:01:21.647605-06:00 hadron wickedd-dhcp4[1380]: eth0: Committed DHCPv4 lease with address 192.168.100.11 (lease time 20 sec, renew in 10 sec, rebind in 17 sec) 2020-08-21T07:01:24.416691-06:00 hadron wicked[1432]: lo up 2020-08-21T07:01:24.416892-06:00 hadron wicked[1432]: eth0 up 2020-08-21T07:01:24.417323-06:00 hadron systemd[1]: Started wicked managed network interfaces. 2020-08-21T07:01:32.711744-06:00 hadron wickedd-dhcp4[1380]: eth0: Committed DHCPv4 lease with address 192.168.100.11 (lease time 20 sec, renew in 10 sec, rebind in 17 sec) 2020-08-21T07:01:32.803748-06:00 hadron wickedd[1400]: route ipv4 0.0.0.0/0 via 192.168.100.1 dev eth0#2 type unicast table main scope universe protocol dhcp covered by a ipv4:dhcp lease
The network interface gets a LAN address and a route. Seems correct. Weird lease time of 20 seconds, though, too short. So short that the computer doesn't have time to renew and fails.
2020-08-21T07:01:43.747638-06:00 hadron wickedd-dhcp4[1380]: eth0: Committed DHCPv4 lease with address 192.168.100.11 (lease time 20 sec, renew in 10 sec, rebind in 17 sec) 2020-08-21T07:01:43.803702-06:00 hadron wickedd[1400]: route ipv4 0.0.0.0/0 via 192.168.100.1 dev eth0#2 type unicast table main scope universe protocol dhcp covered by a ipv4:dhcp lease 2020-08-21T07:02:00.782677-06:00 hadron wickedd-dhcp4[1380]: unable to renew lease within renewal period; trying to rebind
Here is where I restarted the network:
2020-08-21T07:03:10.496616-06:00 hadron systemd[1]: Stopping wicked managed network interfaces... 2020-08-21T07:03:10.510545-06:00 hadron wickedd-dhcp4[1380]: eth0: Request to release DHCPv4 lease with UUID 8bc53f5f-8cf8-0400-7805-000004000000: releasing... 2020-08-21T07:03:11.081974-06:00 hadron wicked[6657]: eth0 device-ready 2020-08-21T07:03:11.082735-06:00 hadron systemd[1]: Stopped wicked managed network interfaces. 2020-08-21T07:03:11.084097-06:00 hadron systemd[1]: Starting wicked managed network interfaces... 2020-08-21T07:03:14.447887-06:00 hadron wickedd-dhcp4[1380]: eth0: Request to acquire DHCPv4 lease with UUID 8bc53f5f-8cf8-0400-7805-00000a000000 2020-08-21T07:03:15.339660-06:00 hadron wickedd-dhcp4[1380]: eth0: Committed DHCPv4 lease with address 24.72.0.229 (lease time 172800 sec, renew in 86400 sec, rebind in 172500 sec)
Now this is weird, it is getting a very different network address, this time public. This is very weird. It seems you have two different DHCP servers in the same network, one from your ISP, another from the LAN.
2020-08-21T07:03:16.371503-06:00 hadron wicked[6774]: lo up 2020-08-21T07:03:16.371707-06:00 hadron wicked[6774]: eth0 up 2020-08-21T07:03:16.372201-06:00 hadron systemd[1]: Started wicked managed network interfaces.
-- Cheers / Saludos, Carlos E. R. (from 15.1 x86_64 at Telcontar)