On boot up NetworkManager runs nm_dispatcher for only 1 of 2 tun interfaces

Bug #1777125 reported by Nick Tait
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
ifupdown (Ubuntu)
New
Undecided
Unassigned

Bug Description

I have two tun interfaces used with OpenVPN, called tun0 (UDP peer-to-peer VPN) and tun1 (TCP server VPN), and I have a script in /etc/network/if-up.d which I use to add routing table entries when the interface comes up. (FYI The reason for adding routes in an if-up.d script is so I can administer all the policy-based routes in one place.)

When I start up OpenVPN for the tun0 interface, the if-up.d scripts run successfully for that interface. And when I start up OpenVPN for the tun1 interface, the if-up.d scripts run successfully for that interface. So I know that everything is configured correctly.

BTW The two OpenVPN instances are configured as systemd services called <email address hidden> and <email address hidden>, and neither tun0 and tun1 are configured in /etc/network/interfaces.

However around 50% of the time when I reboot, the if-up.d scripts are run for only one of the two interfaces (even though both interfaces had started successfully), and it seems random which one. (The other 50% of the time it works properly and runs the if-up.d scripts for both interfaces.)

As far as I can tell, it is NetworkManager which is supposed to start nm-dispatcher to run the if-up.d scripts when each tun interface comes up, and it seems that if both interfaces come up at the same time, then it only runs nm-dispatcher for one of them?

I've pasted below an extract from my syslog after a reboot, where nm-dispatcher was only run for tun1, not tun0:

$ egrep 'NetworkManager|nm-dispatcher' /var/log/syslog
Jun 15 20:49:55 maimbo NetworkManager[1015]: <info> [1529052595.6455] NetworkManager (version 1.10.6) is starting... (for the first time)
Jun 15 20:49:55 maimbo NetworkManager[1015]: <info> [1529052595.6456] Read config: /etc/NetworkManager/NetworkManager.conf (lib: 10-dns-resolved.conf, no-mac-addr-change.conf) (etc: 10-globally-managed-devices.conf, default-wifi-powersave-on.conf)
Jun 15 20:49:55 maimbo NetworkManager[1015]: <info> [1529052595.8380] manager[0x55bf3e4fe050]: monitoring kernel firmware directory '/lib/firmware'.
Jun 15 20:49:55 maimbo NetworkManager[1015]: <info> [1529052595.8387] monitoring ifupdown state file '/run/network/ifstate'.
Jun 15 20:49:55 maimbo dbus-daemon[860]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.26' (uid=0 pid=1015 comm="/usr/sbin/NetworkManager --no-daemon " label="unconfined")
Jun 15 20:49:58 maimbo NetworkManager[1015]: <info> [1529052598.3561] hostname: hostname: using hostnamed
Jun 15 20:49:58 maimbo dbus-daemon[860]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.26' (uid=0 pid=1015 comm="/usr/sbin/NetworkManager --no-daemon " label="unconfined")
Jun 15 20:49:58 maimbo NetworkManager[1015]: <info> [1529052598.3562] hostname: hostname changed from (none) to "maimbo"
Jun 15 20:49:58 maimbo NetworkManager[1015]: <info> [1529052598.3572] dns-mgr[0x55bf3e51b970]: init: dns=systemd-resolved, rc-manager=symlink, plugin=systemd-resolved
Jun 15 20:49:58 maimbo NetworkManager[1015]: <info> [1529052598.3585] manager[0x55bf3e4fe050]: rfkill: WiFi hardware radio set enabled
Jun 15 20:49:58 maimbo NetworkManager[1015]: <info> [1529052598.3585] manager[0x55bf3e4fe050]: rfkill: WWAN hardware radio set enabled
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7231] init!
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7234] interface-parser: parsing file /etc/network/interfaces
Jun 15 20:49:59 maimbo nm-dispatcher: req:1 'hostname': new request (2 scripts)
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7234] interface-parser: source line includes interfaces file(s) /etc/network/interfaces.d/*
Jun 15 20:49:59 maimbo nm-dispatcher: req:1 'hostname': start running ordered scripts...
Jun 15 20:49:59 maimbo NetworkManager[1015]: <warn> [1529052599.7235] interfaces file /etc/network/interfaces.d/* doesn't exist
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7236] interface-parser: finished parsing file /etc/network/interfaces
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7243] guessed connection type (enp3s3) = 802-3-ethernet
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7244] update_connection_setting_from_if_block: name:enp3s3, type:802-3-ethernet, id:Ifupdown (enp3s3), uuid: 40b6c586-e29c-6c7e-50ee-b622c62bcef9
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7248] adding enp3s3 to connections
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7248] adding iface enp3s3 to eni_ifaces
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7249] deleting enp3s3 from connections
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7250] guessed connection type (enp3s3) = 802-3-ethernet
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7250] update_connection_setting_from_if_block: name:enp3s3, type:802-3-ethernet, id:Ifupdown (enp3s3), uuid: 40b6c586-e29c-6c7e-50ee-b622c62bcef9
Jun 15 20:49:59 maimbo NetworkManager[1015]: <info> [1529052599.7252] addresses count: 1
Jun 15 20:50:00 maimbo NetworkManager[1015]: <info> [1529052599.7252] No dns-nameserver configured in /etc/network/interfaces
Jun 15 20:50:00 maimbo NetworkManager[1015]: <info> [1529052599.7253] adding enp3s3 to connections
Jun 15 20:50:00 maimbo NetworkManager[1015]: <info> [1529052599.7253] adding iface enp3s3 to eni_ifaces
Jun 15 20:50:00 maimbo NetworkManager[1015]: <info> [1529052599.7254] guessed connection type (enp3s3.160) = 802-3-ethernet
Jun 15 20:50:00 maimbo NetworkManager[1015]: <info> [1529052599.7255] update_connection_setting_from_if_block: name:enp3s3.160, type:802-3-ethernet, id:Ifupdown (enp3s3.160), uuid: 49a5a233-a11a-69e4-b350-a5a5e8f425d5
Jun 15 20:50:00 maimbo NetworkManager[1015]: <info> [1529052599.7255] addresses count: 1
Jun 15 20:50:00 maimbo NetworkManager[1015]: <info> [1529052599.7256] No dns-nameserver configured in /etc/network/interfaces
Jun 15 20:50:01 maimbo NetworkManager[1015]: <info> [1529052599.7256] adding enp3s3.160 to connections
Jun 15 20:50:01 maimbo NetworkManager[1015]: <info> [1529052599.7256] adding iface enp3s3.160 to eni_ifaces
Jun 15 20:50:01 maimbo NetworkManager[1015]: <info> [1529052599.7257] deleting enp3s3.160 from connections
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7258] guessed connection type (enp3s3.160) = 802-3-ethernet
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7258] update_connection_setting_from_if_block: name:enp3s3.160, type:802-3-ethernet, id:Ifupdown (enp3s3.160), uuid: 49a5a233-a11a-69e4-b350-a5a5e8f425d5
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7259] adding enp3s3.160 to connections
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7260] adding iface enp3s3.160 to eni_ifaces
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7261] guessed connection type (enp3s3.168) = 802-3-ethernet
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7261] update_connection_setting_from_if_block: name:enp3s3.168, type:802-3-ethernet, id:Ifupdown (enp3s3.168), uuid: 4ab0caee-fc7e-ad1a-0a14-22abb4bd1a23
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7262] addresses count: 1
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7262] No dns-nameserver configured in /etc/network/interfaces
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7265] adding enp3s3.168 to connections
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7266] adding iface enp3s3.168 to eni_ifaces
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7266] deleting enp3s3.168 from connections
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7267] guessed connection type (enp3s3.168) = 802-3-ethernet
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7268] update_connection_setting_from_if_block: name:enp3s3.168, type:802-3-ethernet, id:Ifupdown (enp3s3.168), uuid: 4ab0caee-fc7e-ad1a-0a14-22abb4bd1a23
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7269] adding enp3s3.168 to connections
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7269] adding iface enp3s3.168 to eni_ifaces
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7270] guessed connection type (enp3s3.300) = 802-3-ethernet
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7270] update_connection_setting_from_if_block: name:enp3s3.300, type:802-3-ethernet, id:Ifupdown (enp3s3.300), uuid: e320a74f-4c95-e1c5-eaab-08e124c883f8
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7271] addresses count: 1
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7271] No dns-nameserver configured in /etc/network/interfaces
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7272] adding enp3s3.300 to connections
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7272] adding iface enp3s3.300 to eni_ifaces
Jun 15 20:50:02 maimbo NetworkManager[1015]: <info> [1529052599.7273] guessed connection type (enp3s8) = 802-3-ethernet
Jun 15 20:50:03 maimbo NetworkManager[1015]: <info> [1529052599.7274] update_connection_setting_from_if_block: name:enp3s8, type:802-3-ethernet, id:Ifupdown (enp3s8), uuid: a05bfd79-4089-d95f-db9d-45010a2e0fbd
Jun 15 20:50:03 maimbo NetworkManager[1015]: <info> [1529052599.7275] adding enp3s8 to connections
Jun 15 20:50:03 maimbo NetworkManager[1015]: <info> [1529052599.7275] adding iface enp3s8 to eni_ifaces
Jun 15 20:50:04 maimbo NetworkManager[1015]: <info> [1529052599.7276] deleting enp3s8 from connections
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7276] guessed connection type (enp3s8) = 802-3-ethernet
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7277] update_connection_setting_from_if_block: name:enp3s8, type:802-3-ethernet, id:Ifupdown (enp3s8), uuid: a05bfd79-4089-d95f-db9d-45010a2e0fbd
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7278] adding enp3s8 to connections
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7279] adding iface enp3s8 to eni_ifaces
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7279] autoconnect
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7279] autoconnect
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7280] autoconnect
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7280] autoconnect
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7281] management mode: unmanaged
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7304] devices added (path: /sys/devices/pci0000:00/0000:00:1e.0/0000:03:03.0/net/enp3s3, iface: enp3s3)
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7305] locking wired connection setting
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7306] settings-connection[0x55bf3e4c8c40,40b6c586-e29c-6c7e-50ee-b622c62bcef9]: write: failure to update connection: writing settings not supported
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7307] devices added (path: /sys/devices/virtual/net/enp3s3.160, iface: enp3s3.160)
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7308] locking wired connection setting
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7309] settings-connection[0x55bf3e4c8e00,49a5a233-a11a-69e4-b350-a5a5e8f425d5]: write: failure to update connection: writing settings not supported
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7310] devices added (path: /sys/devices/virtual/net/enp3s3.168, iface: enp3s3.168)
Jun 15 20:50:06 maimbo NetworkManager[1015]: <info> [1529052599.7311] locking wired connection setting
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7311] settings-connection[0x55bf3e54e8e0,4ab0caee-fc7e-ad1a-0a14-22abb4bd1a23]: write: failure to update connection: writing settings not supported
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7313] devices added (path: /sys/devices/virtual/net/enp3s3.300, iface: enp3s3.300)
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7314] locking wired connection setting
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7314] settings-connection[0x55bf3e54e9c0,e320a74f-4c95-e1c5-eaab-08e124c883f8]: write: failure to update connection: writing settings not supported
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7315] devices added (path: /sys/devices/virtual/net/lo, iface: lo)
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7316] device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7316] end _init.
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7316] settings: loaded plugin ifupdown: (C) 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list. (/usr/lib/x86_64-linux-gnu/NetworkManager/libnm-settings-plugin-ifupdown.so)
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7318] settings: loaded plugin keyfile: (c) 2007 - 2016 Red Hat, Inc. To report bugs please use the NetworkManager mailing list.
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7318] (1045667008) ... get_connections.
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.7319] (1045667008) ... get_connections (managed=false): return empty list.
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.8265] get unmanaged devices count: 4
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.8266] manager: rfkill: WiFi enabled by radio killswitch; enabled by state file
Jun 15 20:50:07 maimbo NetworkManager[1015]: <info> [1529052599.8267] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8267] manager: Networking is enabled by state file
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8272] dhcp-init: Using DHCP client 'dhclient'
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8572] Loaded device plugin: NMBondDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8573] Loaded device plugin: NMBridgeDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8573] Loaded device plugin: NMDummyDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8574] Loaded device plugin: NMEthernetDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8574] Loaded device plugin: NMInfinibandDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8575] Loaded device plugin: NMIPTunnelDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8575] Loaded device plugin: NMMacsecDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8576] Loaded device plugin: NMMacvlanDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8576] Loaded device plugin: NMPppDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8577] Loaded device plugin: NMTunDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8577] Loaded device plugin: NMVethDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8578] Loaded device plugin: NMVlanDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052599.8578] Loaded device plugin: NMVxlanDeviceFactory (internal)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.2737] Loaded device plugin: NMBluezManager (/usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-bluetooth.so)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.3169] Loaded device plugin: NMAtmManager (/usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-adsl.so)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.5003] Loaded device plugin: NMTeamFactory (/usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-team.so)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.6081] Loaded device plugin: NMWifiFactory (/usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-wifi.so)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.6866] Loaded device plugin: NMWwanFactory (/usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-wwan.so)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7383] device (lo): carrier: link connected
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7415] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7435] device (enp3s3): carrier: link connected
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7463] manager: (enp3s3): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7477] device (enp3s3.160): carrier: link connected
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7501] manager: (enp3s3.160): new VLAN device (/org/freedesktop/NetworkManager/Devices/3)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7513] device (enp3s3.168): carrier: link connected
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7538] manager: (enp3s3.168): new VLAN device (/org/freedesktop/NetworkManager/Devices/4)
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7555] device (enp3s3.300): carrier: link connected
Jun 15 20:50:08 maimbo NetworkManager[1015]: <info> [1529052601.7577] manager: (enp3s3.300): new VLAN device (/org/freedesktop/NetworkManager/Devices/5)
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052602.1137] manager: NetworkManager state is now CONNECTED_GLOBAL
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052602.1589] modem-manager: ModemManager available
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052602.1652] manager: startup complete
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052607.8477] manager: (tun0): new Tun device (/org/freedesktop/NetworkManager/Devices/6)
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052607.9229] devices added (path: /sys/devices/virtual/net/tun0, iface: tun0)
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052607.9230] device added (path: /sys/devices/virtual/net/tun0, iface: tun0): no ifupdown configuration found.
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052607.9234] device (tun0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052607.9311] keyfile: add connection in-memory (20ce3fb2-4bb9-4cfc-ab0e-c09b03c3c82d,"tun0")
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.1890] device (tun0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external')
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.1916] device (tun0): Activation: starting connection 'tun0' (20ce3fb2-4bb9-4cfc-ab0e-c09b03c3c82d)
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.1934] devices added (path: /sys/devices/virtual/net/tun1, iface: tun1)
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.1934] device added (path: /sys/devices/virtual/net/tun1, iface: tun1): no ifupdown configuration found.
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.1945] device (tun0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.1979] manager: (tun1): new Tun device (/org/freedesktop/NetworkManager/Devices/7)
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.2045] keyfile: add connection in-memory (36a1db01-85ab-4f1e-8181-2ace88956184,"tun1")
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.2061] device (tun1): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.2069] device (tun1): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external')
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.2092] device (tun1): Activation: starting connection 'tun1' (36a1db01-85ab-4f1e-8181-2ace88956184)
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.2107] device (tun0): state change: prepare -> config (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:09 maimbo NetworkManager[1015]: <info> [1529052608.2121] device (tun1): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:10 maimbo NetworkManager[1015]: <info> [1529052608.2130] device (tun0): state change: config -> ip-config (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:10 maimbo NetworkManager[1015]: <info> [1529052608.2132] device (tun0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:10 maimbo NetworkManager[1015]: <info> [1529052608.2139] device (tun1): state change: prepare -> config (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:10 maimbo NetworkManager[1015]: <info> [1529052608.2152] device (tun1): state change: config -> ip-config (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:10 maimbo NetworkManager[1015]: <info> [1529052608.2155] device (tun1): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:10 maimbo NetworkManager[1015]: <info> [1529052608.2161] device (tun0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:10 maimbo NetworkManager[1015]: <info> [1529052608.2169] device (tun0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:17 maimbo NetworkManager[1015]: <info> [1529052617.5681] device (tun0): Activation: successful, device activated.
Jun 15 20:50:17 maimbo NetworkManager[1015]: <info> [1529052617.5707] device (tun1): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:17 maimbo NetworkManager[1015]: <info> [1529052617.5751] device (tun1): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external')
Jun 15 20:50:17 maimbo NetworkManager[1015]: <info> [1529052617.8037] device (tun1): Activation: successful, device activated.
Jun 15 20:50:17 maimbo dbus-daemon[860]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.26' (uid=0 pid=1015 comm="/usr/sbin/NetworkManager --no-daemon " label="unconfined")
Jun 15 20:50:17 maimbo nm-dispatcher: req:1 'up' [tun1]: new request (2 scripts)
Jun 15 20:50:17 maimbo nm-dispatcher: req:1 'up' [tun1]: start running ordered scripts...
Jun 15 20:50:18 maimbo nm-dispatcher[2572]: /etc/network/if-up.d/nick-pbr: About to acquire lock for interface: tun1
Jun 15 20:50:18 maimbo nm-dispatcher[2572]: /etc/network/if-up.d/nick-pbr: Acquired lock for interface: tun1
Jun 15 20:50:18 maimbo nm-dispatcher[2572]: /etc/network/if-up.d/nick-pbr: Interface has started: tun1
Jun 15 20:50:18 maimbo nm-dispatcher[2572]: /etc/network/if-up.d/nick-pbr: Adding routes for interface: tun1
Jun 15 20:50:18 maimbo nm-dispatcher[2572]: /etc/network/if-up.d/nick-pbr: Flushing cache

The key observation in the log is that we see the following line for tun1, but no equivalent line for tun0:

Jun 15 20:50:17 maimbo nm-dispatcher: req:1 'up' [tun1]: start running ordered scripts...

As a result of this issue I need to check my routing tables after every reboot to see if anything is missing (and if so restart the corresponding OpenVPN service).

Other info:

$ lsb_release -rd
Description: Ubuntu 18.04 LTS
Release: 18.04

$ apt-cache policy network-manager
network-manager:
  Installed: 1.10.6-2ubuntu1
  Candidate: 1.10.6-2ubuntu1
  Version table:
 *** 1.10.6-2ubuntu1 500
        500 http://nz.archive.ubuntu.com/ubuntu bionic/main amd64 Packages
        100 /var/lib/dpkg/status

Revision history for this message
Nick Tait (nick.t) wrote :

This bug may have been fixed. In the last couple of months I've rebooted at least half a dozen times and it hasn't occurred.

Revision history for this message
Nick Tait (nick.t) wrote :

I can confirm that this issue hasn't happened in over 1 year. Please close?

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.