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

Stefano Zacchiroli zack at debian.org
Tue Jul 8 21:50:27 BST 2014


On Tue, Jul 08, 2014 at 09:32:43PM +0200, Michael Biebl wrote:
> Did you actually wait forever, i.e. at least 90 seconds which is the
> usual timeout for devices to appear or services to start?

Obviously I didn't wait *forever* :), but yes, I did wait past usual
network timeouts. To be sure, I've just tried again, and after 10+
minutes the boot was still hanging.

The good news is...

> Can you please try the following:
> systemctl enable debug-shell.service

...thanks to this, which I didn't know about, I've tracked down the
culprit to my /etc/network/if-up.d/local-firewall script, which reads:

------------------------------------------------------------------------
#!/bin/sh
# This file is managed by Puppet, local modifications will be overwritten

FIREWALL=shorewall
FIREWALL6=shorewall6

service $FIREWALL restart
service $FIREWALL6 restart
------------------------------------------------------------------------

After a couple of killall local-firewall (one for each service
invocation, evidently) the boot continued and reached completion
properly.

> A systemctl list-jobs and ps aux output might be helpful in this case.

Both attached, just in case, but the cause seems to be clear.

Now the questions/comments:

- I've had that script since ever, basically, and it used to work fine
  in the past, both before and after switching to systemd as init. I'm
  not sure why/when it stopped working.

- As a mere user, the above script is perfectly reasonable, I *do* want
  to restart my firewall every time my network interface is brought up,
  and AFAICT I'm using the right "API" to do so.

HTH,
Cheers.
-- 
Stefano Zacchiroli  . . . . . . .  zack at upsilon.cc . . . . o . . . o . o
Maître de conférences . . . . . http://upsilon.cc/zack . . . o . . . o o
Former Debian Project Leader  . . @zack on identi.ca . . o o o . . . o .
« the first rule of tautology club is the first rule of tautology club »
-------------- next part --------------
  1 graphical.target                     start waiting
  2 multi-user.target                    start waiting
  3 basic.target                         start waiting
  4 sysinit.target                       start waiting
 64 networking.service                   start running
 65 network.target                       start waiting
 67 rpcbind.service                      start waiting
 68 rpcbind.target                       start waiting
 71 shorewall.service                    start waiting
 73 shorewall6.service                   start waiting
 74 nfs-common.service                   start waiting
 77 sockets.target                       start waiting
 79 cups.socket                          start waiting
 80 acpid.socket                         start waiting
 81 avahi-daemon.socket                  start waiting
 82 acpi-fakekey.socket                  start waiting
 85 dbus.socket                          start waiting
 86 timers.target                        start waiting
 87 systemd-tmpfiles-clean.timer         start waiting
 88 paths.target                         start waiting
 89 console-kit-log-system-start.service start waiting
 90 uptimed.service                      start waiting
 91 avahi-daemon.service                 start waiting
 92 atd.service                          start waiting
 93 binfmt-support.service               start waiting
 94 cups.path                            start waiting
 97 cups-browsed.service                 start waiting
 98 cups.service                         start waiting
 99 ModemManager.service                 start waiting
100 plymouth-quit-wait.service           start waiting
101 ssh.service                          start waiting
102 NetworkManager.service               start waiting
103 cron.service                         start waiting
104 privoxy.service                      start waiting
105 plymouth-quit.service                start waiting
106 anacron.service                      start waiting
107 rsyslog.service                      start waiting
110 rc-local.service                     start waiting
111 systemd-user-sessions.service        start waiting
113 getty.target                         start waiting
114 getty at tty1.service                   start waiting
115 dbus.service                         start waiting
116 systemd-logind.service               start waiting
117 systemd-update-utmp-runlevel.service start waiting
118 speech-dispatcher.service            start waiting
119 gdomap.service                       start waiting
120 puppetqd.service                     start waiting
121 gdm3.service                         start waiting
122 x-display-manager.target             start waiting
123 acpi-support.service                 start waiting
124 bootlogs.service                     start waiting
125 apache2.service                      start waiting
126 sysfsutils.service                   start waiting
127 ntp.service                          start waiting
128 dictd.service                        start waiting
129 minissdpd.service                    start waiting
130 openvpn.service                      start waiting
131 motd.service                         start waiting
132 winbind.service                      start waiting
133 postfix.service                      start waiting
134 mail-transport-agent.target          start waiting
135 tor.service                          start waiting
136 smbd.service                         start waiting
137 samba-ad-dc.service                  start waiting
138 autofs.service                       start waiting
139 exim4.service                        start waiting
140 postgresql.service                   start waiting
141 saned.service                        start waiting
142 pulseaudio.service                   start waiting
143 hdapsd.service                       start waiting
144 nmbd.service                         start waiting
145 hddtemp.service                      start waiting
146 schroot.service                      start waiting
149 accounts-daemon.service              start waiting
155 bluetooth.target                     start waiting
156 bluetooth.service                    start waiting
-------------- next part --------------
USER       PID %CPU %MEM    VSZ   RSS TTY      STAT START   TIME COMMAND
root         1  0.5  0.0  48452  5004 ?        Ss   21:49   0:00 /bin/systemd
root         2  0.0  0.0      0     0 ?        S    21:49   0:00 [kthreadd]
root         3  0.0  0.0      0     0 ?        S    21:49   0:00 [ksoftirqd/0]
root         4  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/0:0]
root         5  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/0:0H]
root         6  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/u16:0]
root         7  0.0  0.0      0     0 ?        S    21:49   0:00 [rcu_sched]
root         8  0.0  0.0      0     0 ?        S    21:49   0:00 [rcu_bh]
root         9  0.0  0.0      0     0 ?        S    21:49   0:00 [migration/0]
root        10  0.0  0.0      0     0 ?        S    21:49   0:00 [watchdog/0]
root        11  0.0  0.0      0     0 ?        S    21:49   0:00 [watchdog/1]
root        12  0.0  0.0      0     0 ?        S    21:49   0:00 [migration/1]
root        13  0.0  0.0      0     0 ?        S    21:49   0:00 [ksoftirqd/1]
root        14  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/1:0]
root        15  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/1:0H]
root        16  0.0  0.0      0     0 ?        S    21:49   0:00 [watchdog/2]
root        17  0.0  0.0      0     0 ?        S    21:49   0:00 [migration/2]
root        18  0.0  0.0      0     0 ?        S    21:49   0:00 [ksoftirqd/2]
root        19  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/2:0]
root        20  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/2:0H]
root        21  0.0  0.0      0     0 ?        S    21:49   0:00 [watchdog/3]
root        22  0.0  0.0      0     0 ?        S    21:49   0:00 [migration/3]
root        23  0.0  0.0      0     0 ?        S    21:49   0:00 [ksoftirqd/3]
root        24  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/3:0]
root        25  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/3:0H]
root        26  0.0  0.0      0     0 ?        S<   21:49   0:00 [khelper]
root        27  0.0  0.0      0     0 ?        S    21:49   0:00 [kdevtmpfs]
root        28  0.0  0.0      0     0 ?        S<   21:49   0:00 [netns]
root        29  0.0  0.0      0     0 ?        S<   21:49   0:00 [writeback]
root        30  0.0  0.0      0     0 ?        SN   21:49   0:00 [ksmd]
root        31  0.0  0.0      0     0 ?        SN   21:49   0:00 [khugepaged]
root        32  0.0  0.0      0     0 ?        S<   21:49   0:00 [kintegrityd]
root        33  0.0  0.0      0     0 ?        S<   21:49   0:00 [bioset]
root        34  0.0  0.0      0     0 ?        S<   21:49   0:00 [crypto]
root        35  0.0  0.0      0     0 ?        S<   21:49   0:00 [kblockd]
root        36  0.1  0.0      0     0 ?        S    21:49   0:00 [kworker/1:1]
root        37  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/0:1]
root        38  0.0  0.0      0     0 ?        S    21:49   0:00 [khungtaskd]
root        39  0.0  0.0      0     0 ?        S    21:49   0:00 [kswapd0]
root        40  0.0  0.0      0     0 ?        S    21:49   0:00 [fsnotify_mark]
root        45  0.0  0.0      0     0 ?        S<   21:49   0:00 [kthrotld]
root        46  0.2  0.0      0     0 ?        S    21:49   0:00 [kworker/2:1]
root        47  0.0  0.0      0     0 ?        S<   21:49   0:00 [ipv6_addrconf]
root        48  0.0  0.0      0     0 ?        S<   21:49   0:00 [deferwq]
root        49  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/u16:1]
root        61  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/3:1]
root        91  0.0  0.0      0     0 ?        S    21:49   0:00 [khubd]
root        92  0.0  0.0      0     0 ?        S<   21:49   0:00 [ata_sff]
root       126  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/u16:2]
root       127  0.0  0.0      0     0 ?        S    21:49   0:00 [scsi_eh_0]
root       128  0.0  0.0      0     0 ?        S<   21:49   0:00 [scsi_tmf_0]
root       129  0.0  0.0      0     0 ?        S    21:49   0:00 [scsi_eh_1]
root       130  0.0  0.0      0     0 ?        S<   21:49   0:00 [scsi_tmf_1]
root       131  0.0  0.0      0     0 ?        S    21:49   0:00 [scsi_eh_2]
root       132  0.0  0.0      0     0 ?        S<   21:49   0:00 [scsi_tmf_2]
root       133  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/u16:3]
root       134  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/u16:4]
root       136  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/2:1H]
root       137  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/0:1H]
root       138  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/3:1H]
root       139  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/1:1H]
root       183  0.0  0.0      0     0 ?        S<   21:49   0:00 [kdmflush]
root       184  0.0  0.0      0     0 ?        S<   21:49   0:00 [bioset]
root       185  0.0  0.0      0     0 ?        S<   21:49   0:00 [kcryptd_io]
root       186  0.0  0.0      0     0 ?        S<   21:49   0:00 [kcryptd]
root       187  0.0  0.0      0     0 ?        S<   21:49   0:00 [bioset]
root       193  0.0  0.0      0     0 ?        S<   21:49   0:00 [kdmflush]
root       194  0.0  0.0      0     0 ?        S<   21:49   0:00 [bioset]
root       196  0.0  0.0      0     0 ?        S<   21:49   0:00 [kdmflush]
root       197  0.0  0.0      0     0 ?        S<   21:49   0:00 [bioset]
root       199  0.0  0.0      0     0 ?        S<   21:49   0:00 [kdmflush]
root       201  0.0  0.0      0     0 ?        S<   21:49   0:00 [bioset]
root       202  0.0  0.0      0     0 ?        S<   21:49   0:00 [kdmflush]
root       203  0.0  0.0      0     0 ?        S<   21:49   0:00 [bioset]
root       227  0.0  0.0      0     0 ?        S    21:49   0:00 [jbd2/dm-2-8]
root       228  0.0  0.0      0     0 ?        S<   21:49   0:00 [ext4-rsv-conver]
root       252  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/2:2]
root       253  0.0  0.0 125488 10664 ?        Ss   21:49   0:00 /lib/systemd/systemd-journald
root       254  0.0  0.0      0     0 ?        S    21:49   0:00 [kauditd]
root       259  0.0  0.0  18340  2280 tty9     Ss   21:49   0:00 /bin/bash
root       265  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/3:2]
root       267  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/3:3]
root       272  0.0  0.0  43072  2356 ?        Ss   21:49   0:00 /lib/systemd/systemd-udevd
root       297  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/1:2]
root       305  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/0:2]
root       343  0.0  0.0      0     0 ?        S    21:49   0:00 [irq/62-mei_me]
root       356  0.0  0.0      0     0 ?        S<   21:49   0:00 [ktpacpid]
root       368  0.0  0.0      0     0 ?        S<   21:49   0:00 [kmemstick]
root       374  0.0  0.0      0     0 ?        S<   21:49   0:00 [cfg80211]
root       376  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/u17:0]
root       378  0.0  0.0      0     0 ?        S<   21:49   0:00 [hci0]
root       379  0.0  0.0      0     0 ?        S<   21:49   0:00 [hci0]
root       384  0.0  0.0      0     0 ?        S    21:49   0:00 [irq/63-iwlwifi]
root       390  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/u17:1]
root       393  0.0  0.0      0     0 ?        S<   21:49   0:00 [kworker/u17:2]
root       395  0.0  0.0      0     0 ?        S<   21:49   0:00 [kpsmoused]
root       399  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/2:3]
root       436  0.0  0.0      0     0 ?        S<   21:49   0:00 [kvm-irqfd-clean]
root       618  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/2:4]
root       906  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/1:3]
root      1031  0.0  0.0      0     0 ?        S<   21:49   0:00 [ext4-rsv-conver]
root      1033  0.0  0.0      0     0 ?        S    21:49   0:00 [jbd2/dm-3-8]
root      1035  0.0  0.0      0     0 ?        S<   21:49   0:00 [ext4-rsv-conver]
root      1045  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/0:3]
root      1050  0.0  0.0      0     0 ?        S<   21:49   0:00 [hd-audio1]
root      1055  0.0  0.0      0     0 ?        S<   21:49   0:00 [hd-audio0]
root      1058  0.0  0.0      0     0 ?        S    21:49   0:00 [kworker/0:4]
root      1065  0.0  0.0      0     0 ?        S    21:49   0:00 [jbd2/dm-4-8]
root      1066  0.0  0.0      0     0 ?        S<   21:49   0:00 [ext4-rsv-conver]
root      1070  0.0  0.0   4312   760 ?        Ss   21:49   0:00 /bin/sh -e /etc/init.d/networking start
root      1082  0.0  0.0   4248   644 ?        S    21:49   0:00 ifup -a
root      1090  0.0  0.0   4248   640 ?        Ss   21:49   0:00 /sbin/ifup --allow=hotplug eth0
root      1127  0.0  0.0   4312   644 ?        S    21:49   0:00 /bin/sh -c run-parts --exit-on-error /etc/network/if-up.d
root      1128  0.0  0.0   4208   612 ?        S    21:49   0:00 run-parts --exit-on-error /etc/network/if-up.d
root      1136  0.0  0.0   4312   640 ?        S    21:49   0:00 /bin/sh /etc/network/if-up.d/local-firewall
root      1137  0.0  0.0  27164  1076 ?        S    21:49   0:00 systemctl restart shorewall.service
avahi-a+  1199  0.0  0.0  14716   888 ?        S    21:50   0:00 avahi-autoipd: [eth0] bound 169.254.7.253
root      1200  0.0  0.0   6304   312 ?        S    21:50   0:00 avahi-autoipd: [eth0] callout dispatcher
root      1275  0.0  0.0  10088  2464 ?        Ss   21:50   0:00 dhclient -v -pf /run/dhclient.eth0.pid -lf /var/lib/dhcp/dhclient.eth0.leases eth0
root      1276  0.0  0.0   4312   644 ?        S    21:50   0:00 /bin/sh -c run-parts --exit-on-error /etc/network/if-up.d
root      1277  0.0  0.0   4208   608 ?        S    21:50   0:00 run-parts --exit-on-error /etc/network/if-up.d
root      1297  0.0  0.0   4312   636 ?        S    21:50   0:00 /bin/sh /etc/network/if-up.d/local-firewall
root      1298  0.0  0.0  27164  1080 ?        S    21:50   0:00 systemctl restart shorewall.service
root      1305  0.0  0.0  17484  1152 tty9     R+   21:51   0:00 ps auxw
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 811 bytes
Desc: Digital signature
URL: <http://alioth-lists.debian.net/pipermail/pkg-systemd-maintainers/attachments/20140708/7f3bf148/attachment-0002.sig>


More information about the Pkg-systemd-maintainers mailing list