Bug#754218: boot hangs forever on LSB job "raise network interfaces"

Mon Dec 15 12:34:28 GMT 2014

Hi *,

I ran into the same problem. The boot time has increased almost by one
minute since an upgrade recently.

$ sudo systemd-analyze blame
     1min 1.970s networking.service
          1.158s systemd-udev-settle.service
          1.145s uml-utilities.service
           409ms tor.service
...

After having a look at the log files I found out that the DHCP client
tries to get an address on eth0. But I'm on WLAN (wlan0) and there isn't
even a cable plugged in on eth0.

As soon as I comment the eth0 lines in /etc/network/interfaces out, the
problem is gone. But I guess that's not a proper solution.

My /etc/network/interfaces:

# This file describes the network interfaces available on your system
# and how to activate them. For more information, see interfaces(5).

# The loopback network interface
auto lo
iface lo inet loopback

# The primary network interface
allow-hotplug eth0
iface eth0 inet dhcp

$ systemd  sudo systemctl status networking.service
  networking.service - LSB: Raise network interfaces.
   Loaded: loaded (/etc/init.d/networking)
  Drop-In: /run/systemd/generator/networking.service.d
           └─50-insserv.conf-$network.conf
   Active: active (running) since Mon 2014-12-15 12:57:02 CET; 20min ago
  Process: 1951 ExecStart=/etc/init.d/networking start (code=exited,
status=0/SUCCESS)
   CGroup: /system.slice/networking.service
           └─2176 dhclient -v -pf /run/dhclient.eth0.pid -lf
/var/lib/dhcp/dhclient.eth0.leases eth0

$ sudo journalctl _SYSTEMD_UNIT=networking.service
-- Logs begin at Mon 2014-12-15 12:55:59 CET, end at Mon 2014-12-15
13:19:21 CET. --
Dec 15 12:56:01 k0ld dhclient[2156]: Internet Systems Consortium DHCP
Client 4.3.1
Dec 15 12:56:01 k0ld dhclient[2156]: Copyright 2004-2014 Internet
Systems Consortium.
Dec 15 12:56:01 k0ld dhclient[2156]: All rights reserved.
Dec 15 12:56:01 k0ld dhclient[2156]: For info, please visit
https://www.isc.org/software/dhcp/
Dec 15 12:56:01 k0ld dhclient[2156]:
Dec 15 12:56:01 k0ld networking[1951]: Configuring network
interfaces...Internet Systems Consortium DHCP Client 4.3.1
Dec 15 12:56:01 k0ld networking[1951]: Copyright 2004-2014 Internet
Systems Consortium.
Dec 15 12:56:01 k0ld networking[1951]: All rights reserved.
Dec 15 12:56:01 k0ld networking[1951]: For info, please visit
https://www.isc.org/software/dhcp/
Dec 15 12:56:01 k0ld dhclient[2156]: Listening on LPF/eth0/f0:de:f1:90:28:7f
Dec 15 12:56:01 k0ld dhclient[2156]: Sending on   LPF/eth0/f0:de:f1:90:28:7f
Dec 15 12:56:01 k0ld dhclient[2156]: Sending on   Socket/fallback
Dec 15 12:56:01 k0ld dhclient[2156]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 7
Dec 15 12:56:01 k0ld networking[1951]: Listening on
LPF/eth0/f0:de:f1:90:28:7f
Dec 15 12:56:01 k0ld networking[1951]: Sending on
LPF/eth0/f0:de:f1:90:28:7f
Dec 15 12:56:01 k0ld networking[1951]: Sending on   Socket/fallback
Dec 15 12:56:01 k0ld networking[1951]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 7
Dec 15 12:56:08 k0ld dhclient[2156]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 13
Dec 15 12:56:08 k0ld networking[1951]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 13
Dec 15 12:56:21 k0ld dhclient[2156]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 16
Dec 15 12:56:21 k0ld networking[1951]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 16
Dec 15 12:56:37 k0ld dhclient[2156]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 16
Dec 15 12:56:37 k0ld networking[1951]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 16
Dec 15 12:56:53 k0ld dhclient[2156]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 9
Dec 15 12:56:53 k0ld networking[1951]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 9
Dec 15 12:57:02 k0ld dhclient[2156]: No DHCPOFFERS received.
Dec 15 12:57:02 k0ld dhclient[2156]: No working leases in persistent
database - sleeping.
Dec 15 12:57:02 k0ld networking[1951]: No DHCPOFFERS received.
Dec 15 12:57:02 k0ld networking[1951]: No working leases in persistent
database - sleeping.
Dec 15 12:57:02 k0ld networking[1951]: done.
Dec 15 13:00:20 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 8
Dec 15 13:00:28 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 13
Dec 15 13:00:41 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 18
Dec 15 13:00:59 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 20
Dec 15 13:01:19 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 2
Dec 15 13:01:21 k0ld dhclient[2176]: No DHCPOFFERS received.
Dec 15 13:01:21 k0ld dhclient[2176]: No working leases in persistent
database - sleeping.
Dec 15 13:04:11 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 6
Dec 15 13:04:17 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 12
Dec 15 13:04:29 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 20
Dec 15 13:04:49 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 10
Dec 15 13:04:59 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 11
Dec 15 13:05:10 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 2
Dec 15 13:05:12 k0ld dhclient[2176]: No DHCPOFFERS received.
Dec 15 13:05:12 k0ld dhclient[2176]: No working leases in persistent
database - sleeping.
Dec 15 13:10:52 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 6
Dec 15 13:10:58 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 7
Dec 15 13:11:05 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 9
Dec 15 13:11:14 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 14
Dec 15 13:11:28 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 17
Dec 15 13:11:45 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 8
Dec 15 13:11:53 k0ld dhclient[2176]: No DHCPOFFERS received.
Dec 15 13:11:53 k0ld dhclient[2176]: No working leases in persistent
database - sleeping.
Dec 15 13:15:50 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 7
Dec 15 13:15:57 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 14
Dec 15 13:16:11 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 17
Dec 15 13:16:28 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 7
Dec 15 13:16:35 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 14
Dec 15 13:16:49 k0ld dhclient[2176]: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 2
Dec 15 13:16:51 k0ld dhclient[2176]: No DHCPOFFERS received.
Dec 15 13:16:51 k0ld dhclient[2176]: No working leases in persistent
database - sleeping.

As you can see here, eth0 is down and it should be, since no cable is
plugged in.

$ ip link show
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN mode
DEFAULT group default
    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
2: eth0: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc fq_codel
state DOWN mode DEFAULT group default qlen 1000
    link/ether f0:de:f1:90:28:7f brd ff:ff:ff:ff:ff:ff
3: wlan0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP
mode DORMANT group default qlen 1000
    link/ether 9c:b7:0d:e7:48:1b brd ff:ff:ff:ff:ff:ff
4: wwan0: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN mode
DEFAULT group default qlen 1000
    link/ether 02:80:37:ec:02:00 brd ff:ff:ff:ff:ff:ff

Just let me know if you want me to do some other tests.

Best regards,

Jochen