Crazy slow boot (5 minutes!)

Questions about Grub, UEFI,the liveCD and the installer
Forum rules
Before you post read how to get help. Topics in this forum are automatically closed 6 months after creation.
Locked
User avatar
bernd.wechner
Level 3
Level 3
Posts: 141
Joined: Sat Sep 05, 2015 6:22 am

Crazy slow boot (5 minutes!)

Post by bernd.wechner »

Yep, Linux Mint is taking over 5 minutes to boot:

Code: Select all

$ systemd-analyze
Startup finished in 5.877s (kernel) + 5min 17.192s (userspace) = 5min 23.070s 
graphical.target reached after 5min 17.184s in userspace
$ systemd-analyze blame
5min 10.367s networking.service                                   
      4.710s rabbitmq-server.service                              
      3.013s postgresql@12-main.service                           
      1.287s docker.service                                       
      1.286s media-Backups.mount          
...
What could be causing the networking service so much grief at startup time?

I bet this is where those 5 mins go:

Code: Select all

$ journalctl -b
...
Nov 27 22:45:50 bigfoot systemd[1]: NetworkManager-dispatcher.service: Succeeded.
Nov 27 22:45:54 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 14 (xid=0x4ac7de67)
Nov 27 22:45:54 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 14 (xid=0x4ac7de67)
Nov 27 22:46:02 bigfoot kernel: e1000e: eno1 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx
Nov 27 22:46:02 bigfoot kernel: e1000e 0000:00:19.0 eno1: 10/100 speed: disabling TSO
Nov 27 22:46:02 bigfoot kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eno1: link becomes ready
Nov 27 22:46:02 bigfoot NetworkManager[1203]: <info>  [1669549562.6067] device (eno1): carrier: link connected
Nov 27 22:46:03 bigfoot avahi-daemon[1198]: Joining mDNS multicast group on interface eno1.IPv6 with address fe80::e23f:49ff:fe2c:560c.
Nov 27 22:46:03 bigfoot avahi-daemon[1198]: New relevant interface eno1.IPv6 for mDNS.
Nov 27 22:46:03 bigfoot avahi-daemon[1198]: Registering new address record for fe80::e23f:49ff:fe2c:560c on eno1.*.
Nov 27 22:46:04 bigfoot avahi-daemon[1198]: Leaving mDNS multicast group on interface eno1.IPv6 with address fe80::e23f:49ff:fe2c:560c.
Nov 27 22:46:04 bigfoot avahi-daemon[1198]: Joining mDNS multicast group on interface eno1.IPv6 with address fd55:c3f2:2a6:0:e23f:49ff:fe2c:560c.
Nov 27 22:46:04 bigfoot avahi-daemon[1198]: Registering new address record for fd55:c3f2:2a6:0:e23f:49ff:fe2c:560c on eno1.*.
Nov 27 22:46:04 bigfoot avahi-daemon[1198]: Withdrawing address record for fe80::e23f:49ff:fe2c:560c on eno1.
Nov 27 22:46:08 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 21 (xid=0x4ac7de67)
Nov 27 22:46:08 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 21 (xid=0x4ac7de67)
Nov 27 22:46:09 bigfoot systemd[1]: systemd-fsckd.service: Succeeded.
Nov 27 22:46:10 bigfoot systemd[1]: systemd-hostnamed.service: Succeeded.
Nov 27 22:46:29 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 15 (xid=0x4ac7de67)
Nov 27 22:46:29 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 15 (xid=0x4ac7de67)
Nov 27 22:46:39 bigfoot earlyoom[1193]: mem avail: 31437 of 32054 MiB (98 %), swap free: 2047 of 2047 MiB (100 %)
Nov 27 22:46:44 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 14 (xid=0x4ac7de67)
Nov 27 22:46:44 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 14 (xid=0x4ac7de67)
Nov 27 22:46:58 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 16 (xid=0x4ac7de67)
Nov 27 22:46:58 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 16 (xid=0x4ac7de67)
Nov 27 22:47:14 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 12 (xid=0x4ac7de67)
Nov 27 22:47:14 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 12 (xid=0x4ac7de67)
Nov 27 22:47:26 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 8 (xid=0x4ac7de67)
Nov 27 22:47:26 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 8 (xid=0x4ac7de67)
Nov 27 22:47:34 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 10 (xid=0x4ac7de67)
Nov 27 22:47:34 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 10 (xid=0x4ac7de67)
Nov 27 22:47:39 bigfoot earlyoom[1193]: mem avail: 31436 of 32054 MiB (98 %), swap free: 2047 of 2047 MiB (100 %)
Nov 27 22:47:44 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 18 (xid=0x4ac7de67)
Nov 27 22:47:44 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 18 (xid=0x4ac7de67)
Nov 27 22:48:02 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 9 (xid=0x4ac7de67)
Nov 27 22:48:02 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 9 (xid=0x4ac7de67)
Nov 27 22:48:11 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 13 (xid=0x4ac7de67)
Nov 27 22:48:11 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 13 (xid=0x4ac7de67)
Nov 27 22:48:24 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 12 (xid=0x4ac7de67)
Nov 27 22:48:24 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 12 (xid=0x4ac7de67)
Nov 27 22:48:36 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 18 (xid=0x4ac7de67)
Nov 27 22:48:36 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 18 (xid=0x4ac7de67)
Nov 27 22:48:39 bigfoot earlyoom[1193]: mem avail: 31436 of 32054 MiB (98 %), swap free: 2047 of 2047 MiB (100 %)
Nov 27 22:48:54 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 11 (xid=0x4ac7de67)
Nov 27 22:48:54 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 11 (xid=0x4ac7de67)
Nov 27 22:49:05 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 19 (xid=0x4ac7de67)
Nov 27 22:49:05 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 19 (xid=0x4ac7de67)
Nov 27 22:49:24 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 20 (xid=0x4ac7de67)
Nov 27 22:49:24 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 20 (xid=0x4ac7de67)
Nov 27 22:49:39 bigfoot earlyoom[1193]: mem avail: 31436 of 32054 MiB (98 %), swap free: 2047 of 2047 MiB (100 %)
Nov 27 22:49:44 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 17 (xid=0x4ac7de67)
Nov 27 22:49:44 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 17 (xid=0x4ac7de67)
Nov 27 22:49:52 bigfoot kernel: logitech-hidpp-device 0003:046D:4003.0007: HID++ 2.0 device connected.
Nov 27 22:50:01 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 18 (xid=0x4ac7de67)
Nov 27 22:50:01 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 18 (xid=0x4ac7de67)
Nov 27 22:50:19 bigfoot dhclient[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 21 (xid=0x4ac7de67)
Nov 27 22:50:19 bigfoot sh[1166]: DHCPDISCOVER on eno1 to 255.255.255.255 port 67 interval 21 (xid=0x4ac7de67)
Nov 27 22:50:39 bigfoot systemd[1]: networking.service: start operation timed out. Terminating.
...
What's all this DHCPDISCOVER stuff and why is it timing out? Surely it's not taking my DHCP server that long to issue an IP?
Last edited by LockBot on Sat May 27, 2023 10:00 pm, edited 1 time in total.
Reason: Topic automatically closed 6 months after creation. New replies are no longer allowed.
vansloneker

Re: Crazy slow boot (5 minutes!)

Post by vansloneker »

Have you tried it with a fixed IP?
User avatar
bernd.wechner
Level 3
Level 3
Posts: 141
Joined: Sat Sep 05, 2015 6:22 am

Re: Crazy slow boot (5 minutes!)

Post by bernd.wechner »

vansloneker wrote: Sun Nov 27, 2022 5:16 pm Have you tried it with a fixed IP?
Not lately. But why would DHCP take 5 mins! Guess I can try it, but makes no sense to me. Will report back when I give it a shot. Motivation is low as my box is up 24/7 not least because reboots are so painfully slow and time-consuming ;-)
valemax
Level 1
Level 1
Posts: 2
Joined: Sat Dec 03, 2022 12:44 pm

Re: Crazy slow boot (5 minutes!)

Post by valemax »

Does it get an IP finally?
If it does I would have a look at your router's logs.
If it does not, do you expect that it gets an IP on that network interface?
linux-rox
Level 10
Level 10
Posts: 3334
Joined: Sun Jul 19, 2020 9:17 pm

Re: Crazy slow boot (5 minutes!)

Post by linux-rox »

bernd.wechner wrote: Sun Nov 27, 2022 8:17 am What's all this DHCPDISCOVER stuff and why is it timing out?
An internet search for DHCPDISCOVER slow boot turns up a bunch of hits. Take a look.
Locked

Return to “Installation & Boot”