[systemd-devel] networkd failing sporadically failing to bring up network device

Sitsofe Wheeler sitsofe at yahoo.com
Sat Apr 4 04:08:04 PDT 2015


Hi,

I've noticed that networkd occasionally fails to bring up one of two
network interfaces on boot (this happens about once every 70 or so
boots). The machine in question is a VMware ESXi 5.5 guest with two
VMXNET3 network adaptors. When this issue occurs the message

rtnl: received address for a nonexistent link (1), ignoring

is present in the journal.

Does anyone know if this is a known issue in systemd 216 (I'm using
Fedora 21)? I've attached a journal log below:

(systemd-216-20.fc21.x86_64)
Apr 03 11:15:47 h systemd[1]: Starting Login Service...
Apr 03 11:15:47 h systemd[1]: Starting D-Bus System Message Bus...
Apr 03 11:15:47 h systemd[1]: Started D-Bus System Message Bus.
Apr 03 11:15:48 h chronyd[397]: chronyd version 1.31 starting
Apr 03 11:15:48 h kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
Apr 03 11:15:48 h kernel: [drm] Initialized drm 1.1.0 20060810
Apr 03 11:15:48 h kernel: piix4_smbus 0000:00:07.3: SMBus Host Controller not enabled!
Apr 03 11:15:48 h kernel: parport_pc 00:05: reported by Plug and Play ACPI
Apr 03 11:15:48 h kernel: parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
Apr 03 11:15:48 h kernel: vmw_vmci 0000:00:07.7: Found VMCI PCI device at 0x11080, irq 16
Apr 03 11:15:48 h kernel: vmw_vmci 0000:00:07.7: Using capabilities 0xc
Apr 03 11:15:48 h chronyd[397]: Frequency -2.442 +/- 94.425 ppm read from /var/lib/chrony/drift
Apr 03 11:15:48 h kernel: vmw_vmci 0000:00:07.7: irq 57 for MSI/MSI-X
Apr 03 11:15:48 h kernel: vmw_vmci 0000:00:07.7: irq 58 for MSI/MSI-X
Apr 03 11:15:48 h kernel: Guest personality initialized and is active
Apr 03 11:15:48 h kernel: VMCI host device registered (name=vmci, major=10, minor=58)
Apr 03 11:15:48 h kernel: Initialized host personality
Apr 03 11:15:48 h systemd-vconsole-setup[405]: /usr/bin/setfont failed with error code 1.
Apr 03 11:15:48 h systemd-vconsole-setup[405]: /usr/bin/loadkeys failed with error code 1.
Apr 03 11:15:48 h systemd[1]: Starting Network Service...
Apr 03 11:15:48 h systemd[1]: Started NTP client/server.
Apr 03 11:15:48 h systemd[1]: Found device /dev/ttyS0.
Apr 03 11:15:48 h systemd-logind[387]: Watching system buttons on /dev/input/event0 (Power Button)
Apr 03 11:15:48 h systemd-logind[387]: New seat seat0.
Apr 03 11:15:48 h systemd[1]: Started Login Service.
Apr 03 11:15:48 h kernel: alg: No test for crc32 (crc32-pclmul)
Apr 03 11:15:48 h kernel: VMware vmxnet3 virtual NIC driver - version 1.2.1.0-k-NAPI
Apr 03 11:15:48 h kernel: vmxnet3 0000:0b:00.0: # of Tx queues : 1, # of Rx queues : 1
Apr 03 11:15:48 h kernel: vmxnet3 0000:0b:00.0: irq 59 for MSI/MSI-X
Apr 03 11:15:48 h kernel: vmxnet3 0000:0b:00.0: irq 60 for MSI/MSI-X
Apr 03 11:15:48 h kernel: vmxnet3 0000:0b:00.0 eth0: NIC Link is Up 10000 Mbps
Apr 03 11:15:48 h kernel: ppdev: user-space parallel port driver
Apr 03 11:15:48 h kernel: vmxnet3 0000:13:00.0: # of Tx queues : 1, # of Rx queues : 1
Apr 03 11:15:48 h systemd-networkd[422]: timestamp of '/etc/systemd/network' changed
Apr 03 11:15:48 h kernel: vmxnet3 0000:13:00.0: irq 61 for MSI/MSI-X
Apr 03 11:15:48 h kernel: vmxnet3 0000:13:00.0: irq 62 for MSI/MSI-X
Apr 03 11:15:48 h kernel: vmxnet3 0000:13:00.0 eth1: NIC Link is Up 10000 Mbps
Apr 03 11:15:48 h kernel: [drm] DMA map mode: Using physical TTM page addresses.
Apr 03 11:15:48 h kernel: [drm] Capabilities:
Apr 03 11:15:48 h kernel: [drm]   Rect copy.
Apr 03 11:15:48 h kernel: [drm]   Cursor.
Apr 03 11:15:48 h kernel: [drm]   Cursor bypass.
Apr 03 11:15:48 h kernel: [drm]   Cursor bypass 2.
Apr 03 11:15:48 h kernel: [drm]   8bit emulation.
Apr 03 11:15:48 h kernel: [drm]   Alpha cursor.
Apr 03 11:15:48 h kernel: [drm]   Extended Fifo.
Apr 03 11:15:48 h kernel: [drm]   Multimon.
Apr 03 11:15:48 h kernel: [drm]   Pitchlock.
Apr 03 11:15:48 h kernel: [drm]   Irq mask.
Apr 03 11:15:48 h kernel: [drm]   Display Topology.
Apr 03 11:15:48 h kernel: [drm]   GMR.
Apr 03 11:15:48 h kernel: [drm]   Traces.
Apr 03 11:15:48 h kernel: [drm]   GMR2.
Apr 03 11:15:48 h kernel: [drm]   Screen Object 2.
Apr 03 11:15:48 h kernel: [drm]   Command Buffers.
Apr 03 11:15:48 h kernel: [drm] Max GMR ids is 64
Apr 03 11:15:48 h kernel: [drm] Max number of GMR pages is 65536
Apr 03 11:15:48 h kernel: [drm] Max dedicated hypervisor surface memory is 163840 kiB
Apr 03 11:15:48 h kernel: [drm] Maximum display memory size is 8192 kiB
Apr 03 11:15:48 h kernel: [drm] VRAM at 0xec000000 size is 8192 kiB
Apr 03 11:15:48 h kernel: [drm] MMIO at 0xfe000000 size is 256 kiB
Apr 03 11:15:48 h kernel: [drm] global init.
Apr 03 11:15:48 h kernel: [TTM] Zone  kernel: Available graphics memory: 508754 kiB
Apr 03 11:15:48 h kernel: [TTM] Initializing pool allocator
Apr 03 11:15:48 h kernel: [TTM] Initializing DMA pool allocator
Apr 03 11:15:48 h kernel: [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
Apr 03 11:15:48 h kernel: [drm] No driver support for vblank timestamp query.
Apr 03 11:15:48 h kernel: [drm] Screen objects system initialized
Apr 03 11:15:48 h kernel: [drm] width 1280
Apr 03 11:15:48 h kernel: [drm] height 768
Apr 03 11:15:48 h kernel: [drm] bpp 32
Apr 03 11:15:48 h kernel: [drm] Fifo max 0x00040000 min 0x00001000 cap 0x0000077f
Apr 03 11:15:48 h kernel: fbcon: svgadrmfb (fb0) is primary device
Apr 03 11:15:48 h kernel: Console: switching to colour frame buffer device 160x48
Apr 03 11:15:48 h systemd[1]: Time has been changed
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : flags change: +MULTICAST +BROADCAST
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : link 3 added
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : link pending udev initialization...
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : saved original MTU: 1500
Apr 03 11:15:48 h systemd-networkd[422]: Sent message type=method_call sender=n/a destination=org.freedesktop.DBus object=/org/freedesktop/DBus interface=org.freedesktop.DBus member=Hello cookie=1 reply_cookie=0 error=n/a
Apr 03 11:15:48 h systemd-networkd[422]: rtnl: received address for a nonexistent link (1), ignoring
Apr 03 11:15:48 h systemd-networkd[422]: rtnl: received address for a nonexistent link (1), ignoring
Apr 03 11:15:48 h systemd-networkd[422]: Got message type=method_return sender=org.freedesktop.DBus destination=:1.2 object=n/a interface=n/a member=n/a cookie=1 reply_cookie=1 error=n/a
Apr 03 11:15:48 h systemd-networkd[422]: Got message type=signal sender=org.freedesktop.DBus destination=:1.2 object=/org/freedesktop/DBus interface=org.freedesktop.DBus member=NameAcquired cookie=2 reply_cookie=0 error=n/a
Apr 03 11:15:48 h systemd[1]: Started Network Service.
Apr 03 11:15:48 h systemd[1]: Starting Reboot if we find a network...
Apr 03 11:15:48 h kernel: [drm] Initialized vmwgfx 2.6.1 20140704 for 0000:00:0f.0 on minor 0
Apr 03 11:15:48 h growroot.sh[383]: growroot: NOCHANGE: partition 1 is size 6286612. it cannot be grown
Apr 03 11:15:48 h systemd[1]: Started Grow the root partition.
Apr 03 11:15:48 h systemd-sysctl[461]: Overwriting earlier assignment of kernel/sysrq in file '/etc/sysctl.d/60-sysrq.conf'.
Apr 03 11:15:48 h systemd-sysctl[467]: Overwriting earlier assignment of kernel/sysrq in file '/etc/sysctl.d/60-sysrq.conf'.
Apr 03 11:15:48 h kernel: vmxnet3 0000:13:00.0 eth1: intr type 3, mode 0, 2 vectors allocated
Apr 03 11:15:48 h kernel: vmxnet3 0000:13:00.0 eth1: NIC Link is Up 10000 Mbps
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : udev initialized link
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : link state is up-to-date
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : found matching network '/etc/systemd/network/dhcp.network'
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : bringing link up
Apr 03 11:15:48 h systemd-networkd[422]: eth1            : flags change: +UP +LOWER_UP
Apr 03 11:15:48 h systemd-sysctl[470]: Overwriting earlier assignment of kernel/sysrq in file '/etc/sysctl.d/60-sysrq.conf'.
Apr 03 11:15:48 h network[386]: Bringing up loopback interface:  [  OK  ]
Apr 03 11:15:48 h systemd-sysctl[548]: Overwriting earlier assignment of kernel/sysrq in file '/etc/sysctl.d/60-sysrq.conf'.
Apr 03 11:15:48 h systemd[1]: Started LSB: Bring up/down networking.
Apr 03 11:15:48 h systemd[1]: Starting Network.
Apr 03 11:15:48 h systemd[1]: Reached target Network.
Apr 03 11:15:48 h systemd[1]: Started Login and scanning of iSCSI devices.
Apr 03 11:15:48 h systemd[1]: Starting Remote File Systems (Pre).
Apr 03 11:15:48 h systemd[1]: Reached target Remote File Systems (Pre).
Apr 03 11:15:48 h systemd[1]: Starting Remote File Systems.
Apr 03 11:15:48 h systemd[1]: Reached target Remote File Systems.
Apr 03 11:15:48 h systemd[1]: Starting Permit User Sessions...
Apr 03 11:15:48 h systemd[1]: Starting virt-sysprep firstboot service...
Apr 03 11:15:48 h systemd[1]: Starting OpenSSH server daemon...
Apr 03 11:15:48 h firstboot.sh[552]: /usr/lib/virt-sysprep/firstboot.sh start
Apr 03 11:15:48 h firstboot.sh[552]: Scripts dir: /usr/lib/virt-sysprep/scripts
Apr 03 11:15:48 h systemd[1]: Started OpenSSH server daemon.
Apr 03 11:15:48 h systemd[1]: Starting fio server...
Apr 03 11:15:48 h systemd[1]: Started fio server.
Apr 03 11:15:48 h systemd[1]: Starting Network is Online.
Apr 03 11:15:48 h systemd[1]: Reached target Network is Online.
Apr 03 11:15:48 h systemd[1]: Started Permit User Sessions.
Apr 03 11:15:48 h systemd[1]: Started virt-sysprep firstboot service.
Apr 03 11:15:48 h systemd[1]: Starting Command Scheduler...
Apr 03 11:15:48 h systemd[1]: Started Command Scheduler.
Apr 03 11:15:48 h systemd[1]: Starting Getty on tty1...
Apr 03 11:15:48 h systemd[1]: Started Getty on tty1.
Apr 03 11:15:48 h systemd[1]: Starting Serial Getty on ttyS0...
Apr 03 11:15:48 h systemd[1]: Started Serial Getty on ttyS0.
Apr 03 11:15:48 h systemd[1]: Starting Login Prompts.
Apr 03 11:15:48 h systemd[1]: Reached target Login Prompts.
Apr 03 11:15:48 h sshd[558]: Server listening on 0.0.0.0 port 22.
Apr 03 11:15:48 h sshd[558]: Server listening on :: port 22.
Apr 03 11:15:48 h crond[563]: (CRON) INFO (Syslog will be used instead of sendmail.)
Apr 03 11:15:48 h crond[563]: (CRON) INFO (RANDOM_DELAY will be scaled with factor 76% if used.)
Apr 03 11:15:48 h crond[563]: (CRON) INFO (running with inotify support)
Apr 03 11:15:48 h systemd[1]: Started Update getty on network changes.
Apr 03 11:15:48 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:49 h systemd-networkd[422]: eth1            : flags change: +RUNNING
Apr 03 11:15:49 h systemd-networkd[422]: eth1            : gained carrier
Apr 03 11:15:49 h systemd-networkd[422]: eth1            : acquiring DHCPv4 lease
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): STARTED on ifindex 3
Apr 03 11:15:49 h systemd-networkd[422]: eth1            : discovering IPv6 routers
Apr 03 11:15:49 h systemd-networkd[422]: ICMPv6 CLIENT: Start Router Solicitation
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): DISCOVER
Apr 03 11:15:49 h systemd-networkd[422]: ICMPv6 CLIENT: Error sending Router Solicitation
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): OFFER
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): REQUEST (requesting)
Apr 03 11:15:49 h systemd[1]: Starting Update getty on network changes...
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): ACK
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): lease expires in 9min 57.908265s
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): T2 expires in 8min 42.812944s
Apr 03 11:15:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): T1 expires in 5min 496.210ms
Apr 03 11:15:49 h systemd-networkd[422]: eth1            : DHCPv4 address 172.x.x.x/24
Apr 03 11:15:49 h systemd-networkd[422]: eth1            : added address: 172.x.x.x/24 (valid for 10min)
Apr 03 11:15:49 h systemd[1]: Started Update getty on network changes.
Apr 03 11:15:49 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:50 h systemd-networkd[422]: eth1            : added address: fe80::250:56ff:feb3:e398/64 (valid for ever)
Apr 03 11:15:50 h systemd[1]: Starting Update getty on network changes...
Apr 03 11:15:50 h systemd[1]: Started Update getty on network changes.
Apr 03 11:15:50 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:51 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:52 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:53 h systemd-networkd[422]: ICMPv6 CLIENT: Sent Router Solicitation
Apr 03 11:15:53 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:54 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:55 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:56 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:57 h systemd-networkd[422]: ICMPv6 CLIENT: Sent Router Solicitation
Apr 03 11:15:57 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:58 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:15:59 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:00 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:01 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:01 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:16:01 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 1.068791s
Apr 03 11:16:02 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:02 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:16:02 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 2.210163s
Apr 03 11:16:03 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:04 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:05 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:16:05 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 4.504864s
Apr 03 11:16:05 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:06 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:07 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:08 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:09 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:16:09 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 8.732715s
Apr 03 11:16:09 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:10 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:11 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:12 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:13 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:14 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:15 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:16 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:17 h netreboot.sh[566]: connect: Network is unreachable
Apr 03 11:16:18 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:16:18 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 16.623017s
Apr 03 11:16:18 h systemd[1]: Started Reboot if we find a network.
Apr 03 11:16:18 h systemd[1]: Starting Multi-User System.
Apr 03 11:16:18 h systemd[1]: Reached target Multi-User System.
Apr 03 11:16:18 h systemd[1]: Starting Update UTMP about System Runlevel Changes...
Apr 03 11:16:18 h netreboot.sh[566]: No network
Apr 03 11:16:18 h systemd[1]: Started Stop Read-Ahead Data Collection 10s After Completed Startup.
Apr 03 11:16:18 h systemd[1]: Started Update UTMP about System Runlevel Changes.
Apr 03 11:16:18 h systemd[1]: Startup finished in 1.371s (kernel) + 831ms (initrd) + 31.865s (userspace) = 34.069s.
Apr 03 11:16:35 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:16:35 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 33.279164s
Apr 03 11:17:08 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:17:08 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 1min 3.589497s
Apr 03 11:18:11 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:18:11 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 1min 57.667992s
Apr 03 11:20:09 h systemd-networkd[422]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:20:09 h systemd-networkd[422]: DHCPv6 CLIENT: Next retransmission in 2min 3.395916s
Apr 03 11:20:38 h systemd[1]: Starting user-0.slice.
Apr 03 11:20:38 h systemd[1]: Created slice user-0.slice.
Apr 03 11:20:38 h systemd[1]: Starting User Manager for UID 0...
Apr 03 11:20:38 h systemd-logind[387]: New session 1 of user root.
Apr 03 11:20:38 h systemd[1]: Starting Session 1 of user root.
Apr 03 11:20:38 h systemd[1]: Started Session 1 of user root.
Apr 03 11:20:38 h systemd[655]: pam_unix(systemd-user:session): session opened for user root by (uid=0)
Apr 03 11:20:38 h systemd[655]: Starting Paths.
Apr 03 11:20:38 h systemd[655]: Reached target Paths.
Apr 03 11:20:38 h systemd[655]: Starting Timers.
Apr 03 11:20:38 h systemd[655]: Reached target Timers.
Apr 03 11:20:38 h systemd[655]: Starting Sockets.
Apr 03 11:20:38 h systemd[655]: Reached target Sockets.
Apr 03 11:20:38 h systemd[655]: Starting Basic System.
Apr 03 11:20:38 h systemd[655]: Reached target Basic System.
Apr 03 11:20:38 h systemd[655]: Starting Default.
Apr 03 11:20:38 h systemd[655]: Reached target Default.
Apr 03 11:20:38 h systemd[655]: Startup finished in 7ms.
Apr 03 11:20:38 h login[564]: pam_unix(login:session): session opened for user root by LOGIN(uid=0)
Apr 03 11:20:38 h systemd[1]: Started User Manager for UID 0.
Apr 03 11:20:38 h login[564]: ROOT LOGIN ON tty1
Apr 03 11:20:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): REQUEST (renewing)
Apr 03 11:20:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): ACK
Apr 03 11:20:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): lease expires in 9min 57.661711s
Apr 03 11:20:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): T2 expires in 8min 42.793219s
Apr 03 11:20:49 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): T1 expires in 4min 59.851536s
Apr 03 11:20:49 h systemd-networkd[422]: eth1            : updated address: 172.x.x.x/24 (valid for 10min)
Apr 03 11:20:49 h systemd[1]: Starting Update getty on network changes...
Apr 03 11:20:50 h systemd[1]: Started Update getty on network changes.
Apr 03 11:21:57 h systemd[1]: Stopping Network Service...
Apr 03 11:21:57 h systemd-networkd[422]: DHCP CLIENT (0xfeab9961): FREE
Apr 03 11:21:57 h systemd[1]: Stopping Update getty on network changes.
Apr 03 11:21:57 h systemd[1]: Starting Update getty on network changes.
Apr 03 11:21:57 h systemd[1]: Started Update getty on network changes.
Apr 03 11:21:57 h systemd[1]: Starting Network Service...
Apr 03 11:21:57 h systemd-networkd[725]: timestamp of '/etc/systemd/network' changed
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : flags change: +UP +LOWER_UP +RUNNING +MULTICAST +BROADCAST
Apr 03 11:21:57 h systemd[1]: Starting Update getty on network changes...
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : link 3 added
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : udev initialized link
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : saved original MTU: 1500
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : flags change: +MULTICAST +BROADCAST
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : link 2 added
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : udev initialized link
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : saved original MTU: 1500
Apr 03 11:21:57 h systemd-networkd[725]: lo              : flags change: +LOOPBACK +UP +LOWER_UP +RUNNING
Apr 03 11:21:57 h systemd-networkd[725]: lo              : link 1 added
Apr 03 11:21:57 h systemd-networkd[725]: lo              : udev initialized link
Apr 03 11:21:57 h systemd-networkd[725]: lo              : saved original MTU: 0
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : link state is up-to-date
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : found matching network '/etc/systemd/network/dhcp.network'
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : acquiring DHCPv4 lease
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): STARTED on ifindex 3
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : discovering IPv6 routers
Apr 03 11:21:57 h systemd-networkd[725]: ICMPv6 CLIENT: Start Router Solicitation
Apr 03 11:21:57 h systemd-networkd[725]: Sent message type=method_call sender=n/a destination=org.freedesktop.DBus object=/org/freedesktop/DBus interface=org.freedesktop.DBus member=Hello cookie=1 reply_cookie=0 error=n/a
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): DISCOVER
Apr 03 11:21:57 h systemd-networkd[725]: ICMPv6 CLIENT: Sent Router Solicitation
Apr 03 11:21:57 h systemd-networkd[725]: Got message type=method_return sender=org.freedesktop.DBus destination=:1.4 object=n/a interface=n/a member=n/a cookie=1 reply_cookie=1 error=n/a
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : getting address failed: Device or resource busy
Apr 03 11:21:57 h systemd-networkd[725]: Got message type=signal sender=org.freedesktop.DBus destination=:1.4 object=/org/freedesktop/DBus interface=org.freedesktop.DBus member=NameAcquired cookie=2 reply_cookie=0 error=n/a
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : link state is up-to-date
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : found matching network '/etc/systemd/network/dhcp.network'
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : bringing link up
Apr 03 11:21:57 h systemd[1]: Started Network Service.
Apr 03 11:21:57 h systemd-networkd[725]: lo              : getting address failed: Device or resource busy
Apr 03 11:21:57 h systemd-networkd[725]: lo              : link state is up-to-date
Apr 03 11:21:57 h systemd-networkd[725]: lo              : unmanaged
Apr 03 11:21:57 h systemd[1]: Starting Reboot if we find a network...
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : added address: fe80::250:56ff:feb3:e398/64 (valid for ever)
Apr 03 11:21:57 h systemd-networkd[725]: lo              : added address: ::1/128 (valid for ever)
Apr 03 11:21:57 h systemd-networkd[725]: eth1            : added address: 172.x.x.x/24 (valid for 8min 53s)
Apr 03 11:21:57 h systemd-networkd[725]: lo              : added address: 127.0.0.1/8 (valid for ever)
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : flags change: +UP +LOWER_UP +RUNNING
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : gained carrier
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : acquiring DHCPv4 lease
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): STARTED on ifindex 2
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : discovering IPv6 routers
Apr 03 11:21:57 h systemd-networkd[725]: ICMPv6 CLIENT: Start Router Solicitation
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): DISCOVER
Apr 03 11:21:57 h systemd-networkd[725]: ICMPv6 CLIENT: Error sending Router Solicitation
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): OFFER
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): REQUEST (requesting)
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): ACK
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): lease expires in 23h 59min 58.448429s
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): T2 expires in 20h 59min 57.150073s
Apr 03 11:21:57 h systemd-networkd[725]: DHCP CLIENT (0x6d00c46a): T1 expires in 11h 59min 59.005497s
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : DHCPv4 address 10.x.x.x/16 via 10.x.x.x
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : added address: 10.x.x.x/16 (valid for 1d)
Apr 03 11:21:57 h systemd-networkd[725]: eth0            : link configured
Apr 03 11:21:57 h kernel: vmxnet3 0000:0b:00.0 eth0: intr type 3, mode 0, 2 vectors allocated
Apr 03 11:21:57 h kernel: vmxnet3 0000:0b:00.0 eth0: NIC Link is Up 10000 Mbps
Apr 03 11:21:57 h systemd[1]: Started Update getty on network changes.
Apr 03 11:21:57 h systemd[1]: Started Reboot if we find a network.
Apr 03 11:21:58 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): DISCOVER
Apr 03 11:21:58 h systemd-networkd[725]: eth0            : added address: fe80::250:56ff:feb3:9a5/64 (valid for ever)
Apr 03 11:21:58 h systemd[1]: Starting Update getty on network changes...
Apr 03 11:21:59 h systemd[1]: Started Update getty on network changes.
Apr 03 11:21:59 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): DISCOVER
Apr 03 11:22:01 h systemd-networkd[725]: ICMPv6 CLIENT: Sent Router Solicitation
Apr 03 11:22:01 h systemd-networkd[725]: ICMPv6 CLIENT: Sent Router Solicitation
Apr 03 11:22:01 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): OFFER
Apr 03 11:22:01 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): REQUEST (requesting)
Apr 03 11:22:01 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): ACK
Apr 03 11:22:01 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): lease expires in 9min 57.170664s
Apr 03 11:22:01 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): T2 expires in 8min 43.621805s
Apr 03 11:22:01 h systemd-networkd[725]: DHCP CLIENT (0x109220e5): T1 expires in 4min 59.515859s
Apr 03 11:22:01 h systemd-networkd[725]: eth1            : DHCPv4 address 172.x.x.x/24
Apr 03 11:22:01 h systemd-networkd[725]: eth1            : updated address: 172.x.x.x/24 (valid for 10min)
Apr 03 11:22:01 h systemd[1]: Starting Update getty on network changes...
Apr 03 11:22:02 h systemd[1]: Started Update getty on network changes.
Apr 03 11:22:05 h systemd-networkd[725]: ICMPv6 CLIENT: Sent Router Solicitation
Apr 03 11:22:05 h systemd-networkd[725]: ICMPv6 CLIENT: Sent Router Solicitation
Apr 03 11:22:09 h systemd-networkd[725]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:22:09 h systemd-networkd[725]: DHCPv6 CLIENT: Next retransmission in 1.107713s
Apr 03 11:22:10 h systemd-networkd[725]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:22:10 h systemd-networkd[725]: DHCPv6 CLIENT: Next retransmission in 2.208623s
Apr 03 11:22:13 h systemd-networkd[725]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:22:13 h systemd-networkd[725]: DHCPv6 CLIENT: Next retransmission in 4.428601s
Apr 03 11:22:17 h systemd-networkd[725]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:22:17 h systemd-networkd[725]: DHCPv6 CLIENT: Next retransmission in 8.546098s
Apr 03 11:22:26 h systemd-networkd[725]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:22:26 h systemd-networkd[725]: DHCPv6 CLIENT: Next retransmission in 17.439738s
Apr 03 11:22:43 h systemd-networkd[725]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:22:43 h systemd-networkd[725]: DHCPv6 CLIENT: Next retransmission in 35.906321s
Apr 03 11:22:52 h chronyd[397]: Selected source 10.x.x.x
Apr 03 11:23:19 h systemd-networkd[725]: DHCPv6 CLIENT: Sent SOLICIT
Apr 03 11:23:19 h systemd-networkd[725]: DHCPv6 CLIENT: Next retransmission in 1min 14.790780s

-- 
Sitsofe | http://sucs.org/~sits/


More information about the systemd-devel mailing list