[Gelöst] Boot-Prozess trödelt bei DHCP

gehrke · 14 März 2014

Moin *,

ich habe das Problem, dass mein OpenSUSE 13.1 viel Zeit beim Booten vertrödelt. systemd-analyze sagt, es ist das Netzwerk:

Code:

...
 20.802s network@enp3s0.service
   2.854s systemd-cryptsetup@cr_ata\x2dSAMSUNG_HD204UI_XXX\x2dpart1.service
...

Ein Blick in die Logs deutet auf DHCP:

Code:

2014-03-14T19:37:00.551520+01:00 j2 ifup-dhcp[1379]: Starting DHCP4+DHCP6 client on enp3s0
2014-03-14T19:37:00.555111+01:00 j2 dhcpcd[1717]: enp3s0: dhcpcd 3.2.3 starting
2014-03-14T19:37:00.555713+01:00 j2 dhcpcd[1717]: enp3s0: hardware address = f8:d1:xx:xx:xx:xx
2014-03-14T19:37:00.628797+01:00 j2 dhcpcd[1717]: enp3s0: broadcasting for a lease
2014-03-14T19:37:00.999551+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:01.789204+01:00 j2 dhclient[1733]: send_packet6: Cannot assign requested address
2014-03-14T19:37:01.789578+01:00 j2 dhclient[1733]: dhc6: send_packet6() sent -1 of 58 bytes
2014-03-14T19:37:02.098376+01:00 j2 avahi-daemon[798]: Joining mDNS multicast group on interface enp3s0.IPv6 with address fe80::fad1:xxxx:xxxx:xxxx.
2014-03-14T19:37:02.098748+01:00 j2 avahi-daemon[798]: New relevant interface enp3s0.IPv6 for mDNS.
2014-03-14T19:37:02.099020+01:00 j2 avahi-daemon[798]: Registering new address record for fe80::fad1::xxxx:xxxx:xxxx on enp3s0.*.
2014-03-14T19:37:03.635650+01:00 j2 dhcpcd[1717]: enp3s0: offered 172.16.11.6 from 172.16.11.1
2014-03-14T19:37:03.690254+01:00 j2 dhcpcd[1717]: enp3s0: checking 172.16.11.6 is available on attached networks
2014-03-14T19:37:04.889669+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:05.143568+01:00 j2 dhcpcd[1717]: enp3s0: leased 172.16.11.6 for 7200 seconds
2014-03-14T19:37:05.144051+01:00 j2 dhcpcd[1717]: enp3s0: no renewal time supplied, assuming 3600 seconds
2014-03-14T19:37:05.144418+01:00 j2 dhcpcd[1717]: enp3s0: no rebind time supplied, assuming 6300 seconds
2014-03-14T19:37:05.144733+01:00 j2 dhcpcd[1717]: enp3s0: adding IP address 172.16.11.6/24
2014-03-14T19:37:05.145058+01:00 j2 avahi-daemon[798]: Joining mDNS multicast group on interface enp3s0.IPv4 with address 172.16.11.6.
2014-03-14T19:37:05.145437+01:00 j2 avahi-daemon[798]: New relevant interface enp3s0.IPv4 for mDNS.
2014-03-14T19:37:05.145798+01:00 j2 avahi-daemon[798]: Registering new address record for 172.16.11.6 on enp3s0.IPv4.
2014-03-14T19:37:05.146113+01:00 j2 dhcpcd[1717]: enp3s0: adding default route via 172.16.11.1 metric 0
2014-03-14T19:37:05.400117+01:00 j2 ifdown[2108]:     enp3s0    device: Realtek Semiconductor Co., Ltd. RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (rev 01)
2014-03-14T19:37:05.467344+01:00 j2 dhcpcd[1717]: enp3s0: setting hostname to `j2'
2014-03-14T19:37:05.553698+01:00 j2 ifup[2198]:     enp3s0    device: Realtek Semiconductor Co., Ltd. RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (rev 01)
2014-03-14T19:37:05.652903+01:00 j2 SuSEfirewall2: /run/SuSEfirewall2.booting exists which means system boot in progress, exit.
2014-03-14T19:37:05.658521+01:00 j2 avahi-autoipd(enp3s0)[2312]: Found user 'avahi-autoipd' (UID 499) and group 'avahi-autoipd' (GID 498).
2014-03-14T19:37:05.658854+01:00 j2 avahi-autoipd(enp3s0)[2312]: Successfully called chroot().
2014-03-14T19:37:05.659284+01:00 j2 avahi-autoipd(enp3s0)[2312]: Successfully dropped root privileges.
2014-03-14T19:37:05.659578+01:00 j2 avahi-autoipd(enp3s0)[2312]: Starting with address 169.xxx.xxx.xxx
2014-03-14T19:37:05.659851+01:00 j2 avahi-autoipd(enp3s0)[2312]: Routable address already assigned, sleeping.
2014-03-14T19:37:05.855577+01:00 j2 dhcpcd[1717]: enp3s0: exiting
2014-03-14T19:37:08.728314+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:13.179126+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:16.339449+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:20.669853+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:24.324141+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:28.966666+01:00 j2 ifup-dhcp[1379]: .
2014-03-14T19:37:31.183789+01:00 j2 ifup[1296]: Starting DHCP4+DHCP6 client on enp3s0. . . . . . . .
2014-03-14T19:37:31.185626+01:00 j2 ifup-dhcp[1379]: 
2014-03-14T19:37:31.186474+01:00 j2 ifup[1296]: enp3s0    IP address: 172.16.11.6/24 (j2)
2014-03-14T19:37:31.187693+01:00 j2 ifup-dhcp[1379]:     enp3s0    IP address: 172.16.11.6/24 (j2)
2014-03-14T19:37:31.188522+01:00 j2 ifup[1296]: enp3s0    DHCP6 continues in background
2014-03-14T19:37:31.189799+01:00 j2 ifup-dhcp[1379]:     enp3s0    DHCP6 continues in background
2014-03-14T19:37:31.232155+01:00 j2 systemd[1]: Started ifup managed network interface enp3s0.
2014-03-14T19:37:31.251317+01:00 j2 network[879]: ..skipped..doneSetting up service network  .  .  .  .  .  .  .  .  .  .  .  .  ...done

Als DHCP-Server fungiert hier eine pfSense-Box. Aus deren Logs:

Code:

Mar 14 19:37:05 	dhcpd: DHCPACK on 172.16.11.6 to f8:d1:11:xx:xx:xx via lagg0_vlan11
Mar 14 19:37:05 	dhcpd: DHCPREQUEST for 172.16.11.6 (172.16.11.1) from f8:d1:11:xx:xx:xx via lagg0_vlan11
Mar 14 19:37:05 	dhcpd: DHCPOFFER on 172.16.11.6 to f8:d1:11:xx:xx:xx via lagg0_vlan11
Mar 14 19:37:05 	dhcpd: DHCPDISCOVER from f8:d1:11:xx:xx:xx via lagg0_vlan11

Was läuft da schief? Wie kann ich das beschleunigen?
TNX

cu, gehrke

Sauerland · 14 März 2014

Evtl. das?
http://forum.linux-club.de/viewtopic.php?f=86&t=118556

gehrke · 14 März 2014

Sauerland schrieb:
Evtl. das?
http://forum.linux-club.de/viewtopic.php?f=86&t=118556

Ja, da bin ich offensichtlich schon mal sehr nah dran. Danke für den Tipp!

Wenn ich den Wert für DHCLIENT_WAIT_AT_BOOT von 15 auf 0 Sekunden runter schraube, dann fliegt das System.

Allerdings funktionieren dann beim Booten nicht mehr die NFS-Mounts, welche ich in /etc/fstab definiert habe:

Code:

2014-03-14T22:14:54.355303+01:00 j2 mount[1681]: mount.nfs4: Failed to resolve server j4-private: Name or service not known
2014-03-14T22:14:54.361464+01:00 j2 systemd[1]: home-gehrke-j4.nfs.mount mount process exited, code=exited status=32
2014-03-14T22:14:54.361735+01:00 j2 systemd[1]: Failed to mount /home/gehrke/j4.nfs.
2014-03-14T22:14:54.361998+01:00 j2 systemd[1]: Unit home-gehrke-j4.nfs.mount entered failed state.

Später geht das via 'mount -a' problemlos und auch sonst scheint das Netzwerk ok, aber zu diesem Zeitpunkt beim Booten scheint es nicht zu funktionieren. Das übrigens auch mit einem konfigurierten Wert von 5 Sekunden.

gehrke · 14 März 2014

Ein temporäres Löschen von /etc/sysconfig/network/if-up.d/avahi-* brachte übrigens nix.

Das Abschalten von NTP über YaST greift nicht, ist beim nächsten Start von YaST oder Reboot wieder aktiv.

Die Verwendung von NetworkManager ist ebenfalls schnell, verursacht aber die selben Probleme mit den NFS-Mounts.

Und diese Datei existiert zwar, hat aber keinen Inhalt und das testweise Löschen brachte nix:

Code:

-rw-r--r-- 1 root root 0 Mar 14 23:09 /etc/udev/rules.d/70-persistent-net.rules

spezi · 14 März 2014

Probiers mal mit autofs

mfg
spezi

gehrke · 15 März 2014

spezi schrieb:
Probiers mal mit autofs

Du meinst für die NFS-Mounts anstatt in /etc/fstab ?

spezi · 15 März 2014

ja das meinte ich. Es hat jede Menge Literatur dazu.

mfg
spezi

gehrke · 15 März 2014

Die Kombination von DHCLIENT_WAIT_AT_BOOT="0" und NFS-Mounts via 'autofs' hat mein Problem scheinbar vollständig gelöst.

Aktuelles Bootverhalten:

Code:

j2:~ # systemd-analyze blame
          3.706s systemd-cryptsetup@cr_ata\x2dSAMSUNG_HD204UI_XXX\x2dpart1.service
          1.639s network.service
          1.265s plymouth-start.service
          1.055s network@enp3s0.service
           311ms postfix.service
...

BTW: Aus mir unbekannten Gründen musste ich in der Firewall meines NFS-Servers noch Port 111 freigeben, sonst funktionierte das Mounten nicht. Diese Notwendigkeit gab es bei der Lösung via /etc/fstab nicht.

Fazit: Prozessbeschleunigung von 22 auf 4 Sekunden - ich bin zufrieden.
Vielen Dank an alle Beteiligten!

cu, gehrke

[Gelöst] Boot-Prozess trödelt bei DHCP

gehrke

Administrator

Sauerland

Ultimate Guru

gehrke

Administrator

gehrke

Administrator

spezi

Advanced Hacker

gehrke

Administrator

spezi

Advanced Hacker

gehrke

Administrator