unknown delay in wicked

[yoctozepto]

I have two static interfaces: eth1 and eth2

It seems wicked is waiting for something for about 6 seconds each time it is stopped or started. This is openSUSE Leap 42.3.

opensuse:~ # journalctl -b | grep wicked
Mar 28 12:24:59 opensuse systemd[1]: Starting wicked AutoIPv4 supplicant service...
Mar 28 12:24:59 opensuse systemd[1]: Starting wicked DHCPv6 supplicant service...
Mar 28 12:24:59 opensuse systemd[1]: Starting wicked DHCPv4 supplicant service...
Mar 28 12:24:59 opensuse systemd[1]: Started wicked AutoIPv4 supplicant service.
Mar 28 12:24:59 opensuse systemd[1]: Started wicked DHCPv4 supplicant service.
Mar 28 12:24:59 opensuse systemd[1]: Started wicked DHCPv6 supplicant service.
Mar 28 12:24:59 opensuse systemd[1]: Starting wicked network management service daemon...
Mar 28 12:24:59 opensuse systemd[1]: Started wicked network management service daemon.
Mar 28 12:24:59 opensuse systemd[1]: Starting wicked network nanny service...
Mar 28 12:24:59 opensuse systemd[1]: Started wicked network nanny service.
Mar 28 12:24:59 opensuse systemd[1]: Starting wicked managed network interfaces...
Mar 28 12:25:06 opensuse wicked[825]: lo              up
Mar 28 12:25:06 opensuse wicked[825]: eth1            up
Mar 28 12:25:06 opensuse wicked[825]: eth2            up
Mar 28 12:25:06 opensuse systemd[1]: Started wicked managed network interfaces.
Mar 28 12:26:53 opensuse systemd[1]: Stopping wicked managed network interfaces...
Mar 28 12:26:58 opensuse wicked[1880]: eth1            device-ready
Mar 28 12:26:58 opensuse wicked[1880]: eth2            device-ready
Mar 28 12:26:58 opensuse systemd[1]: Stopped wicked managed network interfaces.
Mar 28 12:26:58 opensuse systemd[1]: Starting wicked managed network interfaces...
Mar 28 12:26:58 opensuse wickedd[802]: ni_process_reap: process 2207 has not exited yet; now doing a blocking waitpid()
Mar 28 12:26:58 opensuse wickedd[802]: ni_process_reap: process 2209 has not exited yet; now doing a blocking waitpid()
Mar 28 12:26:58 opensuse wickedd[802]: ni_process_reap: process 2211 has not exited yet; now doing a blocking waitpid()
Mar 28 12:27:05 opensuse wicked[2200]: lo              up
Mar 28 12:27:05 opensuse wicked[2200]: eth1            up
Mar 28 12:27:05 opensuse wicked[2200]: eth2            up
Mar 28 12:27:05 opensuse systemd[1]: Started wicked managed network interfaces.

Please let me know how I can debug it further.

[PowerSnail]

I seem to have the same issue, wicked waits a long time between some operations.

Jun 08 15:24:36 linux-g9vm systemd[1]: Starting wicked DHCPv4 supplicant service...
Jun 08 15:24:36 linux-g9vm systemd[1]: Starting wicked DHCPv6 supplicant service...
Jun 08 15:24:36 linux-g9vm systemd[1]: Starting wicked AutoIPv4 supplicant service...
Jun 08 15:24:36 linux-g9vm systemd[1]: Started wicked DHCPv6 supplicant service.
Jun 08 15:24:36 linux-g9vm systemd[1]: Started wicked DHCPv4 supplicant service.
Jun 08 15:24:36 linux-g9vm systemd[1]: Started wicked AutoIPv4 supplicant service.
Jun 08 15:24:36 linux-g9vm systemd[1]: Starting wicked network management service daemon...
Jun 08 15:24:36 linux-g9vm systemd[1]: Started wicked network management service daemon.
Jun 08 15:24:36 linux-g9vm systemd[1]: Starting wicked network nanny service...
Jun 08 15:24:36 linux-g9vm systemd[1]: Started wicked network nanny service.
Jun 08 15:24:36 linux-g9vm systemd[1]: Starting wicked managed network interfaces...
Jun 08 15:24:40 linux-g9vm wickedd-dhcp4[975]: enp4s0: Request to acquire DHCPv4 lease with UUID f5d71a5b-8798-0200-0d04-000005000000
Jun 08 15:24:40 linux-g9vm wickedd-dhcp6[983]: enp4s0: Request to acquire DHCPv6 lease with UUID f5d71a5b-8798-0200-0d04-000006000000 in mode auto
Jun 08 15:24:41 linux-g9vm wickedd-dhcp4[975]: enp4s0: Committed DHCPv4 lease with address 192.168.1.6 (lease time 86400 sec, renew in 43200 sec, rebind in 75600 sec)
Jun 08 15:24:55 linux-g9vm wicked[1209]: lo              up
Jun 08 15:24:55 linux-g9vm wicked[1209]: enp4s0          up
Jun 08 15:24:55 linux-g9vm systemd[1]: Started wicked managed network interfaces

[hwsmm]

Aug 20 18:18:19 opensuse systemd[1]: Starting wicked managed network interfaces...
Aug 20 18:18:23 opensuse wickedd-dhcp4[832]: enp4s0: Request to acquire DHCPv4 lease with UUID 5c731f61-3ac5-0100-6903-000005000000
Aug 20 18:18:23 opensuse wickedd-dhcp6[838]: enp4s0: Request to acquire DHCPv6 lease with UUID 5c731f61-3ac5-0100-6903-000006000000 in mode auto
Aug 20 18:18:23 opensuse wickedd-dhcp4[832]: enp4s0: Committed DHCPv4 lease with address 192.168.0.6 (lease time 7200 sec, renew in 3600 sec, rebind in 6300 sec)
Aug 20 18:18:38 opensuse wicked[888]: lo              up
Aug 20 18:18:38 opensuse wicked[888]: enp4s0          up
Aug 20 18:18:38 opensuse systemd[1]: Finished wicked managed network interfaces.

I have the same issue on Tumbleweed but it's about 20 seconds. It delays my boot process for quite long time

[mtomaschewski]

I have the same issue on Tumbleweed but it's about 20 seconds. It delays my boot process for quite long time

It waits 15sec for IPv6 RA policy + DHCPv6 lease before it returns with DHCPv4 lease only. Change to use BOOTPROTO=dhcp4 (instead BOOTPROTO=dhcp -> dhcp4 + dhcp6) if you're not using dhcp6 in your network (or set DHCLIENT6_MODE=managed when DHCPv6 server is there, but no IPv6 RA from router). The remaining ~5sec is caused by carrier detection on the network card. See also "man 5 ifcfg" + "man 5 ifcfg-dhcp".

[hwsmm]

Thanks a lot! My PC boots a lot faster now :)

EDIT: Oh, there was another issue mentioning the solution. Sorry for that