Lots of NetworkManager warnings and errors in host logs

Open Source Projects DockerEngine
#1

We are seeing a ton of errors and warnings from NetworkManager in /var/log/messages, about every minute or so. Everything seems to be operating nicely other than these messages. This is a CentOS 7 host running Docker 1.11.0.

What is causing these?

Jun  6 09:10:58 dockerhost NetworkManager[919]: <warn>  (vethd9692e3): failed to disable userspace IPv6LL address handling
Jun  6 09:10:58 dockerhost NetworkManager[919]: <info>  (docker0): bridge port veth711172c was detached
Jun  6 09:10:58 dockerhost NetworkManager[919]: <info>  (veth711172c): released from master docker0
Jun  6 09:10:58 dockerhost NetworkManager[919]: <warn>  (veth711172c): failed to disable userspace IPv6LL address handling
Jun  6 09:11:28 dockerhost kernel: [1556517.993974] XFS (dm-18): Mounting V4 Filesystem
Jun  6 09:11:28 dockerhost kernel: [1556518.247653] XFS (dm-18): Ending clean mount
Jun  6 09:11:28 dockerhost NetworkManager[919]: <warn>  (veth3773231): failed to find device 48794 'veth3773231' with udev
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth3773231): new Veth device (carrier: OFF, driver: 'veth', ifindex: 48794)
Jun  6 09:11:28 dockerhost NetworkManager[919]: <warn>  (veth5149103): failed to find device 48795 'veth5149103' with udev
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): new Veth device (carrier: OFF, driver: 'veth', ifindex: 48795)
Jun  6 09:11:28 dockerhost kernel: [1556518.270063] device veth5149103 entered promiscuous mode
Jun  6 09:11:28 dockerhost kernel: [1556518.278810] IPv6: ADDRCONF(NETDEV_UP): veth5149103: link is not ready
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (docker0): bridge port veth5149103 was attached
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): enslaved to docker0
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  ifcfg-rh: add connection in-memory (a26fd6c5-558d-4a5a-8474-683faed6854d,"veth5149103")
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: unmanaged -> unavailable (reason 'connection-assumed') [10 20 41]
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: unavailable -> disconnected (reason 'connection-assumed') [20 30 41]
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): Activation: starting connection 'veth5149103' (a26fd6c5-558d-4a5a-8474-683faed6854d)
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: prepare -> config (reason 'none') [40 50 0]
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: config -> ip-config (reason 'none') [50 70 0]
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: ip-config -> secondaries (reason 'none') [70 90 0]
Jun  6 09:11:28 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: secondaries -> activated (reason 'none') [90 100 0]
Jun  6 09:11:29 dockerhost kernel: [1556518.567888] IPv6: ADDRCONF(NETDEV_CHANGE): veth5149103: link becomes ready
Jun  6 09:11:29 dockerhost kernel: [1556518.568006] docker0: port 14(veth5149103) entered forwarding state
Jun  6 09:11:29 dockerhost kernel: [1556518.568016] docker0: port 14(veth5149103) entered forwarding state
Jun  6 09:11:29 dockerhost NetworkManager[919]: <info>  (veth5149103): Activation: successful, device activated.
Jun  6 09:11:29 dockerhost NetworkManager[919]: <warn>  (veth3773231): failed to disable userspace IPv6LL address handling
Jun  6 09:11:29 dockerhost NetworkManager[919]: <info>  (veth5149103): link connected
Jun  6 09:11:29 dockerhost dbus[893]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Jun  6 09:11:29 dockerhost dbus[893]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jun  6 09:11:29 dockerhost nm-dispatcher: Dispatching action 'up' for veth5149103
Jun  6 09:11:29 dockerhost kernel: [1556518.968662] docker0: port 14(veth5149103) entered disabled state
Jun  6 09:11:29 dockerhost NetworkManager[919]: <warn>  (veth3773231): failed to find device 48794 'veth3773231' with udev
Jun  6 09:11:29 dockerhost NetworkManager[919]: <info>  (veth3773231): new Veth device (carrier: OFF, driver: 'veth', ifindex: 48794)
Jun  6 09:11:29 dockerhost kernel: [1556519.085382] docker0: port 14(veth5149103) entered disabled state
Jun  6 09:11:29 dockerhost kernel: [1556519.093163] device veth5149103 left promiscuous mode
Jun  6 09:11:29 dockerhost kernel: [1556519.093185] docker0: port 14(veth5149103) entered disabled state
Jun  6 09:11:29 dockerhost NetworkManager[919]: <info>  (veth5149103): link disconnected (deferring action for 4 seconds)
Jun  6 09:11:29 dockerhost NetworkManager[919]: <warn>  (veth3773231): failed to disable userspace IPv6LL address handling
Jun  6 09:11:29 dockerhost NetworkManager[919]: <info>  (veth5149103): device state change: activated -> unmanaged (reason 'removed') [100 10 36]
#2

I get a lot of similar messages on Kali Linux 2017 rolling release host.

# uname -a
Linux bumper 4.12.0-kali1-amd64 #1 SMP Debian 4.12.6-1kali5 (2017-08-25) x86_64 GNU/Linux

# docker version
Client:
 Version:      17.05.0-ce
 API version:  1.29
 Go version:   go1.7.5
 Git commit:   89658be
 Built:        Thu May  4 22:09:06 2017
 OS/Arch:      linux/amd64

Server:
 Version:      17.05.0-ce
 API version:  1.29 (minimum version 1.12)
 Go version:   go1.7.5
 Git commit:   89658be
 Built:        Thu May  4 22:09:06 2017
 OS/Arch:      linux/amd64
 Experimental: false

Sep 14 11:04:37 bumper kernel: [63981.932630] docker0: port 1(veth6a8c64b) entered disabled state
Sep 14 11:04:37 bumper kernel: [63981.932698] vetheda91ec: renamed from eth0
Sep 14 11:04:37 bumper NetworkManager[25985]: <info>  [1505412277.7799] manager: (vetheda91ec): new Veth device (/org/freedesktop/NetworkManager/Devices/9)
Sep 14 11:04:37 bumper NetworkManager[25985]: <info>  [1505412277.7901] devices added (path: /sys/devices/virtual/net/vetheda91ec, iface: vetheda91ec)
Sep 14 11:04:37 bumper NetworkManager[25985]: <info>  [1505412277.7901] device added (path: /sys/devices/virtual/net/vetheda91ec, iface: vetheda91ec): no ifupdown configuration found.
Sep 14 11:04:37 bumper kernel: [63982.086808] docker0: port 1(veth6a8c64b) entered disabled state
Sep 14 11:04:37 bumper kernel: [63982.089272] device veth6a8c64b left promiscuous mode
Sep 14 11:04:37 bumper kernel: [63982.089274] docker0: port 1(veth6a8c64b) entered disabled state
Sep 14 11:04:37 bumper NetworkManager[25985]: <info>  [1505412277.9170] devices removed (path: /sys/devices/virtual/net/vetheda91ec, iface: vetheda91ec)
Sep 14 11:04:37 bumper NetworkManager[25985]: <info>  [1505412277.9206] devices removed (path: /sys/devices/virtual/net/veth6a8c64b, iface: veth6a8c64b)
Sep 14 11:04:37 bumper NetworkManager[25985]: <info>  [1505412277.9231] device (veth6a8c64b): released from master device docker0
Sep 14 11:04:38 bumper kernel: [63982.440250] docker0: port 1(veth780ef34) entered blocking state
Sep 14 11:04:38 bumper kernel: [63982.440253] docker0: port 1(veth780ef34) entered disabled state
Sep 14 11:04:38 bumper kernel: [63982.440310] device veth780ef34 entered promiscuous mode
Sep 14 11:04:38 bumper kernel: [63982.440450] IPv6: ADDRCONF(NETDEV_UP): veth780ef34: link is not ready
Sep 14 11:04:38 bumper kernel: [63982.440453] docker0: port 1(veth780ef34) entered blocking state
Sep 14 11:04:38 bumper kernel: [63982.440456] docker0: port 1(veth780ef34) entered forwarding state
Sep 14 11:04:38 bumper NetworkManager[25985]: <info>  [1505412278.2573] manager: (veth5455a63): new Veth device (/org/freedesktop/NetworkManager/Devices/10)
Sep 14 11:04:38 bumper NetworkManager[25985]: <info>  [1505412278.2598] manager: (veth780ef34): new Veth device (/org/freedesktop/NetworkManager/Devices/11)
Sep 14 11:04:38 bumper NetworkManager[25985]: <info>  [1505412278.2640] devices added (path: /sys/devices/virtual/net/veth5455a63, iface: veth5455a63)
Sep 14 11:04:38 bumper NetworkManager[25985]: <info>  [1505412278.2641] device added (path: /sys/devices/virtual/net/veth5455a63, iface: veth5455a63): no ifupdown configuration found.
Sep 14 11:04:38 bumper NetworkManager[25985]: <info>  [1505412278.2669] devices added (path: /sys/devices/virtual/net/veth780ef34, iface: veth780ef34)
Sep 14 11:04:38 bumper NetworkManager[25985]: <info>  [1505412278.2669] device added (path: /sys/devices/virtual/net/veth780ef34, iface: veth780ef34): no ifupdown configuration found.
Sep 14 11:04:38 bumper kernel: [63982.941962] docker0: port 1(veth780ef34) entered disabled state
Sep 14 11:04:38 bumper kernel: [63982.998715] eth0: renamed from veth5455a63