Re: IPv6 Prefix Delegation through Network Manager



Started having issues again after a recent reboot. The closest error I can see from the debug logs states "device doesn't use DHCPv6, can't request prefixes"? Which is super weird because I *just* had it working. Here's a debug log for reference(output scrubbed):

Sep 26 22:32:34 router systemd[1]: Starting Network Manager...
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.4966] NetworkManager (version 1.10.12-1.fc28) is starting... (after a restart)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.4967] Read config: /etc/NetworkManager/NetworkManager.conf
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.5015] manager[0x561734dd80b0]: monitoring kernel firmware directory '/lib/firmware'.
Sep 26 22:32:34 router dbus-daemon[801]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.110' (uid=0 pid=6367 comm="/usr/sbin/NetworkManager --no-daemon " label="system_u:system_r:NetworkManager_t:s0")
Sep 26 22:32:34 router systemd[1]: Starting Hostname Service...
Sep 26 22:32:34 router dbus-daemon[801]: [system] Successfully activated service 'org.freedesktop.hostname1'
Sep 26 22:32:34 router systemd[1]: Started Hostname Service.
Sep 26 22:32:34 router audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.5885] hostname: hostname: using hostnamed
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.5886] hostname: hostname changed from (none) to "router"
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.5888] dns-mgr[0x561734df3140]: init: dns=default, rc-manager=symlink
Sep 26 22:32:34 router systemd[1]: Started Network Manager.
Sep 26 22:32:34 router audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 26 22:32:34 router dbus-daemon[801]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.110' (uid=0 pid=6367 comm="/usr/sbin/NetworkManager --no-daemon " label="system_u:system_r:NetworkManager_t:s0")
Sep 26 22:32:34 router systemd[1]: Starting Network Manager Script Dispatcher Service...
Sep 26 22:32:34 router systemd[1]: Starting Network Manager Wait Online...
Sep 26 22:32:34 router dbus-daemon[801]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Sep 26 22:32:34 router systemd[1]: Started Network Manager Script Dispatcher Service.
Sep 26 22:32:34 router audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6015] settings: loaded plugin ifcfg-rh: (c) 2007 - 2015 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list. (/usr/lib64/NetworkManager/libnm-settings-plugin-ifcfg-rh.so)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6019] settings: loaded plugin iBFT: (c) 2014 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list. (/usr/lib64/NetworkManager/libnm-settings-plugin-ibft.so)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6020] settings: loaded plugin keyfile: (c) 2007 - 2016 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6033] ifcfg-rh: new connection /etc/sysconfig/network-scripts/ifcfg-enp5s0 (07b0a380-363a-39da-bfd5-55d0c44277d9,"enp5s0")
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6039] ifcfg-rh: new connection /etc/sysconfig/network-scripts/ifcfg-enp2s0 (33d1e6fd-998c-3060-baaf-239650746574,"enp2s0")
Sep 26 22:32:34 router audit[6372]: USER_ACCT pid=6372 uid=0 auid=0 ses=8 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:accounting grantors=pam_unix,pam_localuser acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/0 res=success'
Sep 26 22:32:34 router sudo[6372]:     root : TTY=pts/0 ; PWD=/root ; USER=root ; COMMAND=/usr/bin/dbus-send --system --print-reply --dest=org.freedesktop.NetworkManager /org/freedesktop/NetworkManager org.freedesktop.NetworkManager.SetLogging string:debug string:
Sep 26 22:32:34 router audit[6372]: USER_CMD pid=6372 uid=0 auid=0 ses=8 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='cwd="/root" cmd=646275732D73656E64202D2D73797374656D202D2D7072696E742D7265706C79202D2D646573743D6F72672E667265656465736B746F702E4E6574776F726B4D616E61676572202F6F72672F667265656465736B746F702F4E6574776F726B4D616E61676572206F72672E667265656465736B746F702E4E6574776F726B4D616E616765722E5365744C6F6767696E6720737472696E673A646562756720737472696E673A terminal=pts/0 res=success'
Sep 26 22:32:34 router audit[6372]: CRED_REFR pid=6372 uid=0 auid=0 ses=8 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:setcred grantors=pam_env,pam_fprintd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/0 res=success'
Sep 26 22:32:34 router sudo[6372]: pam_systemd(sudo:session): Cannot create session: Already running in a session
Sep 26 22:32:34 router sudo[6372]: pam_unix(sudo:session): session opened for user root by root(uid=0)
Sep 26 22:32:34 router audit[6372]: USER_START pid=6372 uid=0 auid=0 ses=8 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:session_open grantors=pam_keyinit,pam_limits,pam_keyinit,pam_limits,pam_systemd,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/0 res=success'
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6141] keyfile: new connection /etc/NetworkManager/system-connections/tun0 (f0b330a4-f68f-4b9d-b2ff-5452873c2e89,"tun0")
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6144] manager: rfkill: WiFi enabled by radio killswitch; enabled by state file
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6145] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6145] manager: Networking is enabled by state file
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6146] dhcp-init: Using DHCP client 'dhclient'
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6147] Loaded device plugin: NMBondDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6147] Loaded device plugin: NMBridgeDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6147] Loaded device plugin: NMDummyDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6147] Loaded device plugin: NMEthernetDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMInfinibandDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMIPTunnelDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMMacsecDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMMacvlanDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMPppDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMTunDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMVethDeviceFactory (internal)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:1 'hostname': new request (5 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6148] Loaded device plugin: NMVlanDeviceFactory (internal)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:1 'hostname': start running ordered scripts...
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6149] Loaded device plugin: NMVxlanDeviceFactory (internal)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6151] Loaded device plugin: NMWifiFactory (/usr/lib64/NetworkManager/libnm-device-plugin-wifi.so)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6159] Loaded device plugin: NMTeamFactory (/usr/lib64/NetworkManager/libnm-device-plugin-team.so)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6169] Loaded device plugin: NMBluezManager (/usr/lib64/NetworkManager/libnm-device-plugin-bluetooth.so)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6171] Loaded device plugin: NMWwanFactory (/usr/lib64/NetworkManager/libnm-device-plugin-wwan.so)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6178] device (lo): carrier: link connected
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6182] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6186] device (enp2s0): carrier: link connected
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6198] manager: (enp2s0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6210] manager: (enp2s0): assume: will attempt to assume matching connection 'enp2s0' (33d1e6fd-998c-3060-baaf-239650746574) (indicated)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6210] device (enp2s0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6212] device (enp2s0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6219] device (enp2s0): Activation: starting connection 'enp2s0' (33d1e6fd-998c-3060-baaf-239650746574)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6226] manager: (enp4s0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/3)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6234] ifcfg-rh: add connection in-memory (107b064b-19d7-3ab8-a29b-8db0c9d78c90,"Wired connection 1")
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6237] settings: (enp4s0): created default wired connection 'Wired connection 1'
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6241] device (enp4s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6257] device (enp5s0): carrier: link connected
Sep 26 22:32:34 router kernel: IPv6: ADDRCONF(NETDEV_UP): enp4s0: link is not ready
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6270] manager: (enp5s0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/4)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6279] manager: (enp5s0): assume: will attempt to assume matching connection 'enp5s0' (07b0a380-363a-39da-bfd5-55d0c44277d9) (indicated)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6280] device (enp5s0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6282] device (enp5s0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6288] device (enp5s0): Activation: starting connection 'enp5s0' (07b0a380-363a-39da-bfd5-55d0c44277d9)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6296] manager: (tun0): new Tun device (/org/freedesktop/NetworkManager/Devices/5)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6316] keyfile: add connection in-memory (1e3a2a19-e436-4ed2-808a-a11f3586b6dc,"tun0")
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6320] device (tun0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6322] device (tun0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6328] device (tun0): Activation: starting connection 'tun0' (1e3a2a19-e436-4ed2-808a-a11f3586b6dc)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6352] manager: logging: level 'DEBUG' domains 'PLATFORM,RFKILL,ETHER,WIFI,BT,MB,DHCP4,DHCP6,PPP,IP4,IP6,AUTOIP4,DNS,VPN,SHARING,SUPPLICANT,AGENTS,SETTINGS,SUSPEND,CORE,DEVICE,OLPC,INFINIBAND,FIREWALL,ADSL,BOND,VLAN,BRIDGE,TEAM,CONCHECK,DCB,DISPATCH,AUDIT,SYSTEMD,PROXY'
Sep 26 22:32:34 router sudo[6372]: pam_unix(sudo:session): session closed for user root
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6359] dispatcher: (1) 00-netreport succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6359] dispatcher: (1) 04-iscsi succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6359] dispatcher: (1) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6359] dispatcher: (1) 11-dhclient succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6360] dispatcher: (1) 20-chrony succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6360] sleep-monitor-sd: inhibit: taking sleep inhibitor...
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6361] ifcfg-rh: dbus: aquired D-Bus service com.redhat.ifcfgrh1 and exported /com/redhat/ifcfgrh1 object
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6362] bluez: detecting BlueZ version failed: introspect failed with Cannot invoke method; proxy is for a well-known name without an owner and proxy was constructed with the G_DBUS_PROXY_FLAGS_DO_NOT_AUTO_START flag
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6365] device[0x561734e5bd50] (lo): ip4-config: update (commit=0, new-config=0x561734e7eaa0)
Sep 26 22:32:34 router audit[6372]: USER_END pid=6372 uid=0 auid=0 ses=8 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:session_close grantors=pam_keyinit,pam_limits,pam_keyinit,pam_limits,pam_systemd,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/0 res=success'
Sep 26 22:32:34 router audit[6372]: CRED_DISP pid=6372 uid=0 auid=0 ses=8 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:setcred grantors=pam_env,pam_fprintd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/0 res=success'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6368] device[0x561734e5bd50] (lo): ip4-config: set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/5)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6369] dns-mgr: (device_ip4_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6369] dns-mgr: (device_ip4_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6369] dns-mgr: (device_ip4_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6369] device[0x561734e5bd50] (lo): ip6-config: update (commit=0, new-config=0x561734ed7040)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6372] device[0x561734e5bd50] (lo): ip6-config: set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/5)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6373] dns-mgr: (device_ip6_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6373] dns-mgr: (device_ip6_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6373] dns-mgr: (device_ip6_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6375] device[0x561734e714e0] (enp2s0): ip4-config: update (commit=0, new-config=0x561734e7e0a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6375] device[0x561734e714e0] (enp2s0): ip4-config: update IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6375] dns-mgr: (device_ip4_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6375] dns-mgr: (device_ip4_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6375] dns-mgr: (device_ip4_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6376] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=0, new-config=0x561734ed7160)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6377] device[0x561734e714e0] (enp2s0): ip6-config: update IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6377] dns-mgr: (device_ip6_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6377] dns-mgr: (device_ip6_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6377] dns-mgr: (device_ip6_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6378] device[0x561734e714e0] (enp2s0): remove_pending_action (2): 'recheck-available'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6379] device[0x561734e714e0] (enp2s0): remove_pending_action (1): 'autoactivate'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6379] device[0x561734e714e0] (enp2s0): activation-stage: invoke activate_stage1_device_prepare,v4 (id 42)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6379] device (enp2s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6380] active-connection[0x561734e85420]: set state activating (was unknown)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6381] active-connection[0x561734e85420]: check-master-ready: not signalling (state activating, no master)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6381] device[0x561734e714e0] (enp2s0): activation-stage: schedule activate_stage2_device_config,v4 (id 106)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6381] device[0x561734e714e0] (enp2s0): activation-stage: complete activate_stage1_device_prepare,v4 (id 42)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6382] device[0x561734e9a0c0] (enp4s0): ip4-config: update (commit=0, new-config=0x561734e7ed20)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6384] device[0x561734e9a0c0] (enp4s0): ip4-config: set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/6)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6384] dns-mgr: (device_ip4_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6384] dns-mgr: (device_ip4_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6384] dns-mgr: (device_ip4_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6384] device[0x561734e9a0c0] (enp4s0): ip6-config: update (commit=0, new-config=0x561734ed74c0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6386] device[0x561734e9a0c0] (enp4s0): ip6-config: set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/6)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6386] dns-mgr: (device_ip6_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6386] dns-mgr: (device_ip6_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6386] dns-mgr: (device_ip6_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6386] manager: (enp4s0): assume: cannot generate connection: device has no existing configuration
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6386] device[0x561734eb4f50] (enp5s0): ip4-config: update (commit=0, new-config=0x561734e9e090)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6387] device[0x561734eb4f50] (enp5s0): ip6-config: update (commit=0, new-config=0x561734e85940)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6388] device[0x561734eb4f50] (enp5s0): remove_pending_action (2): 'recheck-available'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6388] device[0x561734eb4f50] (enp5s0): remove_pending_action (1): 'autoactivate'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6388] device[0x561734eb4f50] (enp5s0): activation-stage: invoke activate_stage1_device_prepare,v4 (id 58)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6388] device (enp5s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6389] active-connection[0x561734e85540]: set state activating (was unknown)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6389] active-connection[0x561734e85540]: check-master-ready: not signalling (state activating, no master)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6389] device[0x561734eb4f50] (enp5s0): activation-stage: schedule activate_stage2_device_config,v4 (id 112)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6389] device[0x561734eb4f50] (enp5s0): activation-stage: complete activate_stage1_device_prepare,v4 (id 58)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6390] device[0x561734ec8c50] (tun0): ip4-config: update (commit=0, new-config=0x561734e9e310)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6390] device[0x561734ec8c50] (tun0): ip6-config: update (commit=0, new-config=0x561734e85700)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6391] device[0x561734ec8c50] (tun0): remove_pending_action (2): 'recheck-available'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6391] device[0x561734ec8c50] (tun0): remove_pending_action (1): 'autoactivate'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6391] device[0x561734ec8c50] (tun0): activation-stage: invoke activate_stage1_device_prepare,v4 (id 68)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6392] device (tun0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6392] active-connection[0x561734e85d20]: set state activating (was unknown)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6392] active-connection[0x561734e85d20]: check-master-ready: not signalling (state activating, no master)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6393] device[0x561734ec8c50] (tun0): activation-stage: schedule activate_stage2_device_config,v4 (id 116)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6393] device[0x561734ec8c50] (tun0): activation-stage: complete activate_stage1_device_prepare,v4 (id 68)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6393] auth: dbus name owner: ':1.2'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6393] auth: emit changed signal
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6393] firewall: firewall started
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6394] modem-manager: ModemManager available
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6395] sleep-monitor-sd: inhibit: inhibitor fd is 18
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6436] manager: (lo): assume: don't assume because not managed
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6437] device[0x561734e714e0] (enp2s0): activation-stage: invoke activate_stage2_device_config,v4 (id 106)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6437] device (enp2s0): state change: prepare -> config (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6438] firewall: [0x561734db2630,change:"enp2s0"]: firewall zone change enp2s0:"external"
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6438] device[0x561734e714e0] (enp2s0): activation-stage: complete activate_stage2_device_config,v4 (id 106)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6438] device[0x561734e9a0c0] (enp4s0): ip4-config: update (commit=0, new-config=0x561734e9e310)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6439] device[0x561734e9a0c0] (enp4s0): ip6-config: update (commit=0, new-config=0x561734ed73a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6439] manager: (enp4s0): assume: cannot generate connection: device has no existing configuration
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6440] device[0x561734eb4f50] (enp5s0): activation-stage: invoke activate_stage2_device_config,v4 (id 112)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6440] device (enp5s0): state change: prepare -> config (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6441] firewall: [0x561734ee86d0,change:"enp5s0"]: firewall zone change enp5s0:"internal"
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6441] device[0x561734eb4f50] (enp5s0): activation-stage: complete activate_stage2_device_config,v4 (id 112)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6442] device[0x561734ec8c50] (tun0): activation-stage: invoke activate_stage2_device_config,v4 (id 116)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6442] device (tun0): state change: prepare -> config (reason 'none', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6443] device[0x561734ec8c50] (tun0): activation-stage: schedule activate_stage3_ip_config_start,v4 (id 164)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6443] device[0x561734ec8c50] (tun0): activation-stage: complete activate_stage2_device_config,v4 (id 116)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6445] device[0x561734ec8c50] (tun0): activation-stage: invoke activate_stage3_ip_config_start,v4 (id 164)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6445] active-connection[0x561734e85d20]: set state-flags layer2-ready (was none)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6445] device (tun0): state change: config -> ip-config (reason 'none', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6446] active-connection[0x561734e85d20]: set state-flags layer2-ready,ip4-ready (was layer2-ready)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6446] device (tun0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6447] dispatcher: (2) (tun0) dispatching action 'pre-up' (with callback)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6449] active-connection[0x561734e85d20]: set state-flags layer2-ready,ip4-ready,ip6-ready (was layer2-ready,ip4-ready)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6449] device[0x561734ec8c50] (tun0): activation-stage: complete activate_stage3_ip_config_start,v4 (id 164)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6451] manager: check_if_startup_complete returns FALSE because of enp2s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: new request (1 scripts)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: environment: DEVICE_IP_IFACE=tun0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: environment: DEVICE_IFACE=tun0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: environment: CONNECTION_ID=tun0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: environment: CONNECTION_UUID=1e3a2a19-e436-4ed2-808a-a11f3586b6dc
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: environment: CONNECTION_EXTERNAL=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/5
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0], "/etc/NetworkManager/dispatcher.d/pre-up.d/10-ifcfg-rh-routes.sh": run script (no-wait)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6461] firewall: [0x561734db2630,change:"enp2s0"]: complete: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6461] device[0x561734e714e0] (enp2s0): activation-stage: schedule activate_stage3_ip_config_start,v4 (id 173)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6461] device[0x561734e714e0] (enp2s0): activation-stage: invoke activate_stage3_ip_config_start,v4 (id 173)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6461] active-connection[0x561734e85420]: set state-flags layer2-ready (was none)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6461] device (enp2s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6465] bus-manager: (dhcp) creating private socket unix:path=/var/run/NetworkManager/private-dhcp
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6467] create NMDhcpListener singleton (0x561734e9f500)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6467] dhcp4 (enp2s0): activation: beginning transaction (timeout in 45 seconds)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6467] dhcp4 (enp2s0): creating composite dhclient config /var/lib/NetworkManager/dhclient-enp2s0.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6468] dhcp4 (enp2s0): looking for existing config /etc/NetworkManager/dhclient-33d1e6fd-998c-3060-baaf-239650746574.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6468] dhcp4 (enp2s0): looking for existing config /etc/NetworkManager/dhclient-enp2s0.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6468] dhcp4 (enp2s0): looking for existing config /etc/NetworkManager/dhclient.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6468] dhcp4 (enp2s0): looking for existing config /etc/dhcp/dhclient-enp2s0.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6468] dhcp4 (enp2s0): looking for existing config /etc/dhclient-enp2s0.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6468] dhcp4 (enp2s0): looking for existing config /etc/dhcp/dhclient.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6469] dhcp4 (enp2s0): looking for existing config /etc/dhclient.conf
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6469] dhcp4 (enp2s0): no existing dhclient configuration to merge
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0], "/etc/NetworkManager/dispatcher.d/pre-up.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:2 'pre-up' [tun0]: completed (1 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6520] kill process 'dhcp-client' (6197): waiting up to 2000 milliseconds for process to disappear after sending SIGTERM (15)...
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6600] kill process 'dhcp-client' (6197): process is gone after sending signal SIGTERM (15) (8019 usec elapsed)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6601] dhcp4 (enp2s0): running: /sbin/dhclient -d -q -sf /usr/libexec/nm-dhcp-helper -pf /var/run/dhclient-enp2s0.pid -lf /var/lib/NetworkManager/dhclient-33d1e6fd-998c-3060-baaf-239650746574-enp2s0.lease -cf /var/lib/NetworkManager/dhclient-enp2s0.conf enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6611] dhcp4 (enp2s0): dhclient started with pid 6400
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6611] device[0x561734e714e0] (enp2s0): add_pending_action (2): 'dhcp4'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6613] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/default/use_tempaddr': '0'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6613] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/enp2s0/router_solicitation_interval': '4'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6614] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/enp2s0/router_solicitations': '-1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6614] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/enp2s0/max_addresses': '16'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6616] device[0x561734e714e0] (enp2s0): addrconf6: using the device EUI-64 identifier
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6617] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=1, new-config=0x561734ed73a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6617] platform-linux: kernel-support: extended-ifa-flags: unable to detect kernel support for handling IPv6 temporary addresses. Assume support
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6618] platform: address: adding or updating IPv6 address: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 lft 604672sec pref 604672sec lifetime 1-0[604672,604672] dev 2 flags noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6618] platform-linux: do-add-ip6-address[2: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6619] platform: address: adding or updating IPv6 address: fe80::ffff:ffff:ffff:ffff/64 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 2 flags permanent,noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6619] platform-linux: do-add-ip6-address[2: fe80::ffff:ffff:ffff:ffff]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6620] device[0x561734e714e0] (enp2s0): ip6-config: update IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6620] dns-mgr: (device_ip6_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6621] dns-mgr: (device_ip6_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6621] dns-mgr: (device_ip6_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6621] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp2s0/accept_ra' to '1' (current value is '2')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6621] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp2s0/accept_ra_defrtr' to '0' (current value is identical)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6622] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp2s0/accept_ra_pinfo' to '0' (current value is identical)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6622] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp2s0/accept_ra_rtr_pref' to '0' (current value is identical)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6622] ndisc[0x561734e850e0,"enp2s0"]: starting neighbor discovery: 2
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6622] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6623] ndisc[0x561734e850e0,"enp2s0"]: scheduling RA timeout in 30 seconds
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6623] ndisc[0x561734e850e0,"enp2s0"]: scheduling explicit router solicitation request in 0 seconds.
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6623] device[0x561734e714e0] (enp2s0): activation-stage: complete activate_stage3_ip_config_start,v4 (id 173)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6625] firewall: [0x561734ee86d0,change:"enp5s0"]: complete: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6625] device[0x561734eb4f50] (enp5s0): activation-stage: schedule activate_stage3_ip_config_start,v4 (id 190)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6625] dispatcher: (2) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6625] device[0x561734ec8c50] (tun0): add_pending_action (2): 'queued-state-change-secondaries'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6625] device[0x561734ec8c50] (tun0): queue-state[secondaries, reason:none, id:191]: queue state change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6628] device[0x561734eb4f50] (enp5s0): activation-stage: invoke activate_stage3_ip_config_start,v4 (id 190)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6628] active-connection[0x561734e85540]: set state-flags layer2-ready (was none)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6628] device (enp5s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6630] device[0x561734eb4f50] (enp5s0): activation-stage: schedule activate_stage5_ip4_config_result,v4 (id 196)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6631] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/enp5s0/router_solicitation_interval': '4'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6631] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/enp5s0/router_solicitations': '-1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6631] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/enp5s0/max_addresses': '16'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6632] device[0x561734eb4f50] (enp5s0): addrconf6: using the device EUI-64 identifier
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6632] device[0x561734eb4f50] (enp5s0): ip6-config: update (commit=1, new-config=0x561734ed7a60)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6632] platform: address: adding or updating IPv6 address: fe80::0000:0000:0000:0000/64 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 3 flags permanent,noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6635] platform-linux: do-add-ip6-address[3: fe80::0000:0000:0000:0000]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6635] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp5s0/forwarding' to '1' (current value is identical)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6638] device[0x561734eb4f50] (enp5s0): activation-stage: schedule activate_stage5_ip6_config_commit,v6 (id 197)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6638] policy: ipv6-pd: enp5s0 needs a subnet
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6638] policy: ipv6-pd: no device to obtain a subnet to share on enp5s0 from
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6638] ndisc[0x561734ed79e0,"enp5s0"]: starting neighbor discovery: 3
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6639] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6639] ndisc[0x561734ed79e0,"enp5s0"]: will send an initial router advertisement
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6639] device[0x561734eb4f50] (enp5s0): activation-stage: complete activate_stage3_ip_config_start,v4 (id 190)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6639] device[0x561734ec8c50] (tun0): queue-state[secondaries, reason:none, id:191]: change state
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6639] device (tun0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6640] device[0x561734ec8c50] (tun0): add_pending_action (3): 'queued-state-change-activated'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6640] device[0x561734ec8c50] (tun0): queue-state[activated, reason:none, id:202]: queue state change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6640] device[0x561734ec8c50] (tun0): device entered SECONDARIES state
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6641] device[0x561734ec8c50] (tun0): remove_pending_action (2): 'queued-state-change-secondaries'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6643] device[0x561734eb4f50] (enp5s0): activation-stage: invoke activate_stage5_ip4_config_result,v4 (id 196)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6644] device[0x561734eb4f50] (enp5s0): ip4-config: update (commit=1, new-config=0x561734e7e5a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6644] platform: address: adding or updating IPv4 address: 192.168.1.1/24 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 3 flags noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6645] platform-linux: do-add-ip4-address[3: 192.168.1.1/24]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6645] arping[0x561734ee4300,3]: run /usr/sbin/arping -A -q -I enp5s0 -c 1 192.168.1.1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6657] active-connection[0x561734e85540]: set state-flags layer2-ready,ip4-ready (was layer2-ready)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6657] device (enp5s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6659] dispatcher: (3) (enp5s0) dispatching action 'pre-up' (with callback)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6664] device[0x561734eb4f50] (enp5s0): activation-stage: complete activate_stage5_ip4_config_result,v4 (id 196)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6664] device[0x561734eb4f50] (enp5s0): activation-stage: invoke activate_stage5_ip6_config_commit,v6 (id 197)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6665] device[0x561734eb4f50] (enp5s0): ip6-config: update (commit=1, new-config=0x561734ed7a60)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6665] platform: address: adding or updating IPv6 address: fe80::0000:0000:0000:0000/64 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 3 flags permanent,noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6668] platform-linux: do-add-ip6-address[3: fe80::0000:0000:0000:0000]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6669] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/all/forwarding' to '1' (current value is identical)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: new request (1 scripts)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6670] active-connection[0x561734e85540]: set state-flags layer2-ready,ip4-ready,ip6-ready (was layer2-ready,ip4-ready)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: environment: DEVICE_IP_IFACE=enp5s0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6670] device[0x561734eb4f50] (enp5s0): activation-stage: complete activate_stage5_ip6_config_commit,v6 (id 197)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: environment: DEVICE_IFACE=enp5s0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6671] device[0x561734ec8c50] (tun0): queue-state[activated, reason:none, id:202]: change state
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: environment: CONNECTION_ID=enp5s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6671] device (tun0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external')
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: environment: CONNECTION_UUID=07b0a380-363a-39da-bfd5-55d0c44277d9
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6672] active-connection[0x561734e85d20]: set state activated (was activating)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: environment: CONNECTION_FILENAME=/etc/sysconfig/network-scripts/ifcfg-enp5s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6673] manager: NetworkManager state is now CONNECTED_LOCAL
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/2
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6674] active-connection[0x561734e85d20]: check-master-ready: not signalling (state activated, no master)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0], "/etc/NetworkManager/dispatcher.d/pre-up.d/10-ifcfg-rh-routes.sh": run script (no-wait)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0], "/etc/NetworkManager/dispatcher.d/pre-up.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:3 'pre-up' [enp5s0]: completed (1 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6716] device[0x561734ec8c50] (tun0): remove_pending_action (1): 'activation-0x561734e85d20'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6718] dns-mgr: (device_state_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6718] dns-mgr: (update_routing_and_dns): queueing DNS updates (2)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6719] policy: set 'enp2s0' (enp2s0) as default for IPv4 routing and DNS
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6719] manager: PrimaryConnection now enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6719] policy: ipv6-pd: none of 0 prefixes of enp2s0 can be shared on enp5s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6719] device (enp2s0): ipv6-pd: device doesn't use DHCPv6, can't request prefixes
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6719] policy: set 'enp2s0' (enp2s0) as default for IPv6 routing and DNS
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6719] dns-mgr: (update_routing_and_dns): DNS configuration changed
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6720] dns-mgr: (update_routing_and_dns): no DNS changes to commit (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6720] dns-mgr: (device_state_changed): DNS configuration changed
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6720] dns-mgr: (device_state_changed): committing DNS changes (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6720] dns-mgr: update-dns: updating resolv.conf
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6744] device (tun0): Activation: successful, device activated.
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6744] device[0x561734ec8c50] (tun0): set metered value 4
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6744] dispatcher: (4) (tun0) dispatching action 'up'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6747] create NMPacrunnerManager singleton (0x561734ecc600)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6747] pacrunner: call[0x561734f0cf00]: send: new config ({'Interface': <'tun0'>, 'Method': <'direct'>, 'BrowserOnly': <false>},)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6747] device[0x561734ec8c50] (tun0): remove_pending_action (0): 'queued-state-change-activated'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6747] manager: check_if_startup_complete returns FALSE because of enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6750] dispatcher: (3) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6750] device[0x561734eb4f50] (enp5s0): add_pending_action (2): 'queued-state-change-secondaries'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6750] device[0x561734eb4f50] (enp5s0): queue-state[secondaries, reason:none, id:226]: queue state change
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: new request (5 scripts)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP6_NUM_ROUTES=2
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP6_ROUTE_1=ff00::/8 :: 256
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP6_ROUTE_0=fe80::/64 :: 256
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6753] bus-manager: (dhcp) accepted connection 0x561734dcd650 on private socket
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP6_GATEWAY=::
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP6_NUM_ADDRESSES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP6_ADDRESS_0=fe80::eeee:eeee:eeee:eeee/64 ::
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP4_NUM_ROUTES=2
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP4_ROUTE_1=192.168.11.0/24 0.0.0.0 0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP4_ROUTE_0=192.168.9.0/24 192.168.11.2 0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6757] device[0x561734eb4f50] (enp5s0): queue-state[secondaries, reason:none, id:226]: change state
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP4_GATEWAY=0.0.0.0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6757] device (enp5s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP4_NUM_ADDRESSES=1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6758] device[0x561734eb4f50] (enp5s0): add_pending_action (3): 'queued-state-change-activated'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: IP4_ADDRESS_0=192.168.2.1/24 0.0.0.0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6758] device[0x561734eb4f50] (enp5s0): queue-state[activated, reason:none, id:232]: queue state change
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: DEVICE_IP_IFACE=tun0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6758] device[0x561734eb4f50] (enp5s0): device entered SECONDARIES state
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: DEVICE_IFACE=tun0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6758] device[0x561734eb4f50] (enp5s0): remove_pending_action (2): 'queued-state-change-secondaries'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: CONNECTION_ID=tun0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6759] dhcp4 (enp2s0): unmapped DHCP state 'PREINIT'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: CONNECTION_UUID=1e3a2a19-e436-4ed2-808a-a11f3586b6dc
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6759] dhcp4 (enp2s0): DHCP reason 'PREINIT' -> state 'unknown'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: CONNECTION_EXTERNAL=1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6760] device[0x561734eb4f50] (enp5s0): queue-state[activated, reason:none, id:232]: change state
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/5
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6760] device (enp5s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: start running ordered scripts...
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6761] active-connection[0x561734e85540]: set state activated (was activating)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/00-netreport": run script
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6761] active-connection[0x561734e85540]: update activation type from assume to managed
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6762] active-connection[0x561734e85540]: check-master-ready: not signalling (state activated, no master)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6785] device[0x561734eb4f50] (enp5s0): remove_pending_action (1): 'activation-0x561734e85540'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6787] dns-mgr: (device_state_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6787] dns-mgr: (update_routing_and_dns): queueing DNS updates (2)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6787] device[0x561734eb4f50] (enp5s0): ip6-config: update (commit=1, new-config=0x561734ed73a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6788] platform: address: adding or updating IPv6 address: fe80::0000:0000:0000:0000/64 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 3 flags permanent,noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6788] platform-linux: do-add-ip6-address[3: fe80::0000:0000:0000:0000]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6789] dns-mgr: (update_routing_and_dns): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6789] dns-mgr: (update_routing_and_dns): no DNS changes to commit (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6789] dns-mgr: (device_state_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6789] dns-mgr: (device_state_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.6789] device (enp5s0): Activation: successful, device activated.
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6789] device[0x561734eb4f50] (enp5s0): set metered value 4
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6789] dispatcher: (5) (enp5s0) dispatching action 'up'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6792] pacrunner: call[0x561734f0c890]: send: new config ({'Interface': <'enp5s0'>, 'Method': <'direct'>, 'BrowserOnly': <false>},)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6792] device[0x561734eb4f50] (enp5s0): remove_pending_action (0): 'queued-state-change-activated'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6793] manager: check_if_startup_complete returns FALSE because of enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6794] bus-manager: (dhcp) closed connection 0x561734dcd650 on private socket
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.6797] pacrunner: name owner disappeared
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: new request (5 scripts)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP6_NUM_ROUTES=3
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP6_ROUTE_2=ff00::/8 :: 256
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP6_ROUTE_1=fe80::/64 :: 256
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP6_ROUTE_0=fe80::/64 :: 101
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP6_GATEWAY=::
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP6_NUM_ADDRESSES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP6_ADDRESS_0=fe80::0000:0000:0000:0000/64 ::
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP4_NUM_ROUTES=2
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP4_ROUTE_1=239.0.0.0/8 0.0.0.0 101
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP4_ROUTE_0=192.168.1.0/24 0.0.0.0 101
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP4_GATEWAY=0.0.0.0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP4_NUM_ADDRESSES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: IP4_ADDRESS_0=192.168.1.1/24 0.0.0.0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: DEVICE_IP_IFACE=enp5s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: DEVICE_IFACE=enp5s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: CONNECTION_ID=enp5s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: CONNECTION_UUID=07b0a380-363a-39da-bfd5-55d0c44277d9
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: CONNECTION_FILENAME=/etc/sysconfig/network-scripts/ifcfg-enp5s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/2
Sep 26 22:32:34 router dhclient[6400]: DHCPREQUEST on enp2s0 to 255.255.255.255 port 67 (xid=0x39f7fd15)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/00-netreport": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/04-iscsi": run script
Sep 26 22:32:34 router systemd[1]: iscsi.service: Unit cannot be reloaded because it is inactive.
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/04-iscsi": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/11-dhclient": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/11-dhclient": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/20-chrony": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0], "/etc/NetworkManager/dispatcher.d/20-chrony": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:4 'up' [tun0]: completed (5 scripts)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: start running ordered scripts...
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/00-netreport": run script
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7114] dispatcher: (4) 00-netreport succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7114] dispatcher: (4) 04-iscsi succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7114] dispatcher: (4) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7114] dispatcher: (4) 11-dhclient succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7114] dispatcher: (4) 20-chrony succeeded
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/00-netreport": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/04-iscsi": run script
Sep 26 22:32:34 router systemd[1]: iscsi.service: Unit cannot be reloaded because it is inactive.
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/04-iscsi": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/11-dhclient": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/11-dhclient": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/20-chrony": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0], "/etc/NetworkManager/dispatcher.d/20-chrony": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:5 'up' [enp5s0]: completed (5 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7440] dispatcher: (5) 00-netreport succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7440] dispatcher: (5) 04-iscsi succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7440] dispatcher: (5) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7440] dispatcher: (5) 11-dhclient succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.7440] dispatcher: (5) 20-chrony succeeded
Sep 26 22:32:34 router dhclient[6400]: DHCPACK from 69.134.151.28 (xid=0x39f7fd15)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8676] bus-manager: (dhcp) accepted connection 0x561734dcd750 on private socket
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8683] dhcp4 (enp2s0): DHCP reason 'REBOOT' -> state 'bound'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'requested_host_name'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'requested_routers'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'network_number'=>'198.51.100.0'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'requested_subnet_mask'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'requested_domain_search'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'requested_wpad'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'dad_wait_time'=>'0'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'dhcp_lease_time'=>'86077'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'domain_name'=>'myregion.myinternetprovider.com'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'broadcast_address'=>'255.255.255.255'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'requested_static_routes'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8685] dhcp4 (enp2s0): option 'dhcp_message_type'=>'5'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'requested_nis_servers'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'dhcp_server_identifier'=>'203.0.113.105'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'domain_name_servers'=>'203.0.113.106 203.0.113.107'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'requested_ms_classless_static_routes'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'requested_rfc3442_classless_static_routes'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'requested_classless_static_routes'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'requested_ntp_servers'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'requested_time_offset'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'subnet_mask'=>'255.255.248.0'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'ip_address'=>'198.51.100.130'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'expiry'=>'1538105231'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8686] dhcp4 (enp2s0): option 'requested_domain_name'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'routers'=>'198.51.100.1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'requested_interface_mtu'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'requested_domain_name_servers'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'host_name'=>'router'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'requested_nis_domain'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'next_server'=>'0.0.0.0'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'requested_broadcast_address'=>'1'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8687] dhcp4 (enp2s0): option 'interface_mtu'=>'1500'
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8687] dhcp4 (enp2s0):   address 198.51.100.130
Sep 26 22:32:34 router miniupnpd[2690]: PCPSendUnsolicitedAnnounce() IPv6 sendto(): Bad file descriptor
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8687] dhcp4 (enp2s0):   plen 21 (255.255.248.0)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8688] dhcp4 (enp2s0):   gateway 198.51.100.1
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8688] dhcp4 (enp2s0):   lease time 86077
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: new request (1 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8688] dhcp4 (enp2s0):   hostname 'router'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8688] dhcp4 (enp2s0):   nameserver '203.0.113.106'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: environment: DEVICE_IP_IFACE=enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8688] dhcp4 (enp2s0):   nameserver '203.0.113.107'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: environment: DEVICE_IFACE=enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8688] dhcp4 (enp2s0):   domain name 'myregion.myinternetprovider.com'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: environment: CONNECTION_ID=enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8689] dhcp4 (enp2s0): state changed unknown -> bound
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: environment: CONNECTION_UUID=33d1e6fd-998c-3060-baaf-239650746574
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8689] device[0x561734e714e0] (enp2s0): new DHCPv4 client state 1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: environment: CONNECTION_FILENAME=/etc/sysconfig/network-scripts/ifcfg-enp2s0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8691] device[0x561734e714e0] (enp2s0): activation-stage: schedule activate_stage5_ip4_config_result,v4 (id 253)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8695] device[0x561734e714e0] (enp2s0): activation-stage: invoke activate_stage5_ip4_config_result,v4 (id 253)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0], "/etc/NetworkManager/dispatcher.d/pre-up.d/10-ifcfg-rh-routes.sh": run script (no-wait)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8696] device[0x561734e714e0] (enp2s0): ip4-config: update (commit=1, new-config=0x561734e7e5a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8696] platform: address: adding or updating IPv4 address: 198.51.100.130/21 lft 86077sec pref 86077sec lifetime 1-0[86077,86077] dev 2 flags noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8698] platform: signal: address 4 changed: 198.51.100.130/21 lft 86077sec pref 86077sec lifetime 1-1[86077,86077] dev 2 flags noprefixroute src kernel
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8699] device[0x561734e714e0] (enp2s0): queued IP4 config change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8699] platform-linux: do-add-ip4-address[2: 198.51.100.130/21]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8700] device[0x561734e714e0] (enp2s0): ip4-config: update IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8701] dns-mgr: (device_ip4_config_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8701] dns-mgr: (device_ip4_config_changed): DNS configuration did not change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8701] dns-mgr: (device_ip4_config_changed): no DNS changes to commit (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8701] device[0x561734e714e0] (enp2s0): remove_pending_action (1): 'dhcp4'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8701] active-connection[0x561734e85420]: set state-flags layer2-ready,ip4-ready (was layer2-ready)
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8702] device (enp2s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8703] dispatcher: (6) (enp2s0) dispatching action 'pre-up' (with callback)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8711] device[0x561734e714e0] (enp2s0): activation-stage: complete activate_stage5_ip4_config_result,v4 (id 253)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8713] bus-manager: (dhcp) closed connection 0x561734dcd750 on private socket
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8715] device[0x561734e714e0] (enp2s0): ip4-config: update (commit=0, new-config=0x561734e7e5a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8743] ndisc[0x561734e850e0,"enp2s0"]: router solicitation sent
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8743] ndisc[0x561734e850e0,"enp2s0"]: scheduling router solicitation retry in 4 seconds.
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8744] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8744] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:34 router dhclient[6400]: bound to 198.51.100.130 -- renewal in 38540 seconds.
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0], "/etc/NetworkManager/dispatcher.d/pre-up.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:6 'pre-up' [enp2s0]: completed (1 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8786] dispatcher: (6) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8786] device[0x561734e714e0] (enp2s0): add_pending_action (2): 'queued-state-change-secondaries'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8786] device[0x561734e714e0] (enp2s0): queue-state[secondaries, reason:none, id:269]: queue state change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8786] device[0x561734e714e0] (enp2s0): queue-state[secondaries, reason:none, id:269]: change state
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8786] device (enp2s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8787] device[0x561734e714e0] (enp2s0): add_pending_action (3): 'queued-state-change-activated'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8787] device[0x561734e714e0] (enp2s0): queue-state[activated, reason:none, id:272]: queue state change
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8787] device[0x561734e714e0] (enp2s0): device entered SECONDARIES state
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8787] device[0x561734e714e0] (enp2s0): remove_pending_action (2): 'queued-state-change-secondaries'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8789] device[0x561734e714e0] (enp2s0): queue-state[activated, reason:none, id:272]: change state
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8789] device (enp2s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'assume')
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8790] active-connection[0x561734e85420]: set state activated (was activating)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8790] active-connection[0x561734e85420]: update activation type from assume to managed
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8790] manager: NetworkManager state is now CONNECTED_SITE
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8791] active-connection[0x561734e85420]: check-master-ready: not signalling (state activated, no master)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8813] device[0x561734e714e0] (enp2s0): remove_pending_action (1): 'activation-0x561734e85420'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8815] dns-mgr: (device_state_changed): queueing DNS updates (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8816] dns-mgr: (update_routing_and_dns): queueing DNS updates (2)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8816] device[0x561734eb4f50] (enp5s0): ip6-config: update (commit=1, new-config=0x561734ed73a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8816] platform: address: adding or updating IPv6 address: fe80::0000:0000:0000:0000/64 lft forever pref forever lifetime 2-0[4294967295,4294967295] dev 3 flags permanent,noprefixroute src unknown
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8817] platform-linux: do-add-ip6-address[3: fe80::0000:0000:0000:0000]: success
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8817] dns-mgr: (update_routing_and_dns): DNS configuration changed
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8817] dns-mgr: (update_routing_and_dns): no DNS changes to commit (1)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8817] dns-mgr: (device_state_changed): DNS configuration changed
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8817] dns-mgr: (device_state_changed): committing DNS changes (0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8817] dns-mgr: update-dns: updating resolv.conf
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8841] device (enp2s0): Activation: successful, device activated.
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8841] device[0x561734e714e0] (enp2s0): set metered value 4
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8842] manager: new metered value: 4
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8842] dispatcher: (7) (enp2s0) dispatching action 'up'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8846] pacrunner: call[0x561734f05860]: send: new config ({'Interface': <'enp2s0'>, 'Method': <'direct'>, 'BrowserOnly': <false>},)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8846] connectivity: (enp2s0) faking request. Connectivity check disabled
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8847] device[0x561734e714e0] (enp2s0): remove_pending_action (0): 'queued-state-change-activated'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8847] manager: check_if_startup_complete returns FALSE because of enp4s0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8849] device[0x561734e714e0] (enp2s0): state changed from UNKNOWN to FULL
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8849] manager: connectivity checking indicates FULL
Sep 26 22:32:34 router NetworkManager[6367]: <info>  [1538019154.8849] manager: NetworkManager state is now CONNECTED_GLOBAL
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8850] dispatcher: (8) dispatching action 'connectivity-change'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8851] device[0x561734e714e0] (enp2s0): ip4-config: update (commit=1, new-config=0x561734e7e5a0)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8852] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/enp2s0/mtu': '1500'
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8852] platform: address: adding or updating IPv4 address: 198.51.100.130/21 lft 86076sec pref 86076sec lifetime 2-0[86076,86076] dev 2 flags noprefixroute src unknown
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: new request (5 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8853] platform: signal: address 4 changed: 198.51.100.130/21 lft 86076sec pref 86076sec lifetime 2-2[86076,86076] dev 2 flags noprefixroute src kernel
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8854] device[0x561734e714e0] (enp2s0): queued IP4 config change
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_INTERFACE_MTU=1500
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8854] platform-linux: do-add-ip4-address[2: 198.51.100.130/21]: success
Sep 26 22:32:34 router miniupnpd[2690]: PCPSendUnsolicitedAnnounce() IPv6 sendto(): Bad file descriptor
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8854] platform-linux: sysctl: reading '/proc/sys/net/ipv4/conf/enp2s0/rp_filter': '2'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_BROADCAST_ADDRESS=1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8855] platform-linux: sysctl: reading '/proc/sys/net/ipv4/conf/all/rp_filter': '1'
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_NEXT_SERVER=0.0.0.0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8855] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=1, new-config=0x561734ed7a60)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_NIS_DOMAIN=1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8856] platform: address: adding or updating IPv6 address: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 lft 604671sec pref 604671sec lifetime 2-0[604671,604671] dev 2 flags noprefixroute src unknown
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_HOST_NAME=router
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8857] platform: signal: address 6 changed: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 lft 604671sec pref 604671sec lifetime 2-2[604671,604671] dev 2 flags noprefixroute src kernel
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_DOMAIN_NAME_SERVERS=1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8858] device[0x561734e714e0] (enp2s0): queued IP6 config change
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_INTERFACE_MTU=1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8858] platform-linux: do-add-ip6-address[2: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff]: success
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_ROUTERS=198.51.100.1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8858] platform: address: adding or updating IPv6 address: fe80::ffff:ffff:ffff:ffff/64 lft forever pref forever lifetime 2-0[4294967295,4294967295] dev 2 flags permanent,noprefixroute src unknown
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_DOMAIN_NAME=1
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8859] platform-linux: do-add-ip6-address[2: fe80::ffff:ffff:ffff:ffff]: success
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_EXPIRY=1538105231
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8859] pacrunner: call[0x561734f05860]: sending failed: GDBus.Error:org.freedesktop.DBus.Error.NameHasNoOwner: Name "org.pacrunner" does not exist
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_IP_ADDRESS=198.51.100.130
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8863] device[0x561734e714e0] (enp2s0): ip4-config: update (commit=0, new-config=0x561734e7e5a0)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_SUBNET_MASK=255.255.248.0
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.8865] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=0, new-config=0x561734ed7a60)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_TIME_OFFSET=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_NTP_SERVERS=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_CLASSLESS_STATIC_ROUTES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_RFC3442_CLASSLESS_STATIC_ROUTES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_MS_CLASSLESS_STATIC_ROUTES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_DOMAIN_NAME_SERVERS=203.0.113.106 203.0.113.107
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_DHCP_SERVER_IDENTIFIER=203.0.113.105
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_NIS_SERVERS=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_DHCP_MESSAGE_TYPE=5
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_STATIC_ROUTES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_BROADCAST_ADDRESS=255.255.255.255
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_DOMAIN_NAME=myregion.myinternetprovider.com
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_DHCP_LEASE_TIME=86077
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_DAD_WAIT_TIME=0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_WPAD=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_DOMAIN_SEARCH=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_SUBNET_MASK=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_NETWORK_NUMBER=198.51.100.0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_ROUTERS=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DHCP4_REQUESTED_HOST_NAME=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_NUM_ROUTES=8
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_7=ff00::/8 :: 256
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_6=fe80::/64 :: 256
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_5=fe80::/64 :: 100
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_4=2001:db8:6fc0:37::/64 :: 100
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_3=2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 :: 100
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_2=2001:db8:c09:37::/64 :: 100
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_1=2001:db8:709:37::/64 :: 100
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ROUTE_0=2001:db8:409:37::/64 :: 100
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_NAMESERVERS=::1 2001:4860:4860::8888 2001:4860:4860::8844
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_GATEWAY=fe80::1111:1111:1111:1111
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_NUM_ADDRESSES=2
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ADDRESS_1=fe80::ffff:ffff:ffff:ffff/64 fe80::1111:1111:1111:1111
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP6_ADDRESS_0=2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 fe80::1111:1111:1111:1111
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP4_NUM_ROUTES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP4_ROUTE_0=198.51.100.0/21 0.0.0.0 100
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP4_NAMESERVERS=192.168.1.1 8.8.8.8 8.8.4.4
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP4_GATEWAY=198.51.100.1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP4_NUM_ADDRESSES=1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: IP4_ADDRESS_0=198.51.100.130/21 198.51.100.1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DEVICE_IP_IFACE=enp2s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: DEVICE_IFACE=enp2s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: CONNECTION_ID=enp2s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: CONNECTION_UUID=33d1e6fd-998c-3060-baaf-239650746574
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: CONNECTION_FILENAME=/etc/sysconfig/network-scripts/ifcfg-enp2s0
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/1
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: start running ordered scripts...
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/00-netreport": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change': new request (5 scripts)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change': environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change': environment: CONNECTIVITY_STATE=FULL
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/00-netreport": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/04-iscsi": run script
Sep 26 22:32:34 router systemd[1]: iscsi.service: Unit cannot be reloaded because it is inactive.
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/04-iscsi": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/11-dhclient": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/11-dhclient": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/20-chrony": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0], "/etc/NetworkManager/dispatcher.d/20-chrony": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:7 'up' [enp2s0]: completed (5 scripts)
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change': start running ordered scripts...
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/00-netreport": run script
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9158] dispatcher: (7) 00-netreport succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9159] dispatcher: (7) 04-iscsi succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9159] dispatcher: (7) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9159] dispatcher: (7) 11-dhclient succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9159] dispatcher: (7) 20-chrony succeeded
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/00-netreport": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/04-iscsi": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/04-iscsi": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/11-dhclient": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/11-dhclient": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/20-chrony": run script
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change', "/etc/NetworkManager/dispatcher.d/20-chrony": complete
Sep 26 22:32:34 router nm-dispatcher[6373]: req:8 'connectivity-change': completed (5 scripts)
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9365] dispatcher: (8) 00-netreport succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9365] dispatcher: (8) 04-iscsi succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9365] dispatcher: (8) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9365] dispatcher: (8) 11-dhclient succeeded
Sep 26 22:32:34 router NetworkManager[6367]: <debug> [1538019154.9365] dispatcher: (8) 20-chrony succeeded
Sep 26 22:32:36 router NetworkManager[6367]: <debug> [1538019156.8768] ndisc[0x561734ed79e0,"enp5s0"]: router advertisement sent
Sep 26 22:32:36 router NetworkManager[6367]: <debug> [1538019156.8769] ndisc[0x561734ed79e0,"enp5s0"]: will resend an initial router advertisement
Sep 26 22:32:36 router NetworkManager[6367]: <debug> [1538019156.8771] arping[0x561734ee4300,3]: run /usr/sbin/arping -U -q -I enp5s0 -c 1 192.168.1.1
Sep 26 22:32:36 router NetworkManager[6367]: <debug> [1538019156.8810] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:36 router NetworkManager[6367]: <debug> [1538019156.8811] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:38 router dnsmasq-dhcp[5594]: no address range available for DHCPv6 request via enp5s0
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.8765] ndisc[0x561734e850e0,"enp2s0"]: router solicitation sent
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.8765] ndisc[0x561734e850e0,"enp2s0"]: scheduling router solicitation retry in 4 seconds.
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.8766] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.8767] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9086] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9087] ndisc-lndp[0x561734e850e0,"enp2s0"]: received router advertisement at 6
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9088] ndisc[0x561734e850e0,"enp2s0"]: neighbor discovery configuration changed [dGR]:
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9088] ndisc[0x561734e850e0,"enp2s0"]:   dhcp-level managed
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9089] ndisc[0x561734e850e0,"enp2s0"]:   gateway fe80::1111:1111:1111:1111 pref medium exp 1806
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9089] ndisc[0x561734e850e0,"enp2s0"]:   route 2001:db8:709:37::/64 via :: pref medium exp 2147483647
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9089] ndisc[0x561734e850e0,"enp2s0"]:   route 2001:db8:409:37::/64 via :: pref medium exp 2147483647
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9089] ndisc[0x561734e850e0,"enp2s0"]:   route 2001:db8:6fc0:37::/64 via :: pref medium exp 2147483647
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9090] ndisc[0x561734e850e0,"enp2s0"]:   route 2001:db8:c09:37::/64 via :: pref medium exp 2147483647
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9092] device[0x561734e714e0] (enp2s0): Activation: Stage 3 of 5 (IP Configure Start) starting DHCPv6 as requested by IPv6 router...
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9102] dhcp6 (enp2s0): looking for DUID in '/var/lib/NetworkManager/dhclient6-33d1e6fd-998c-3060-baaf-239650746574-enp2s0.lease'
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9104] dhcp6 (enp2s0): DUID is '00:04:24:90:2c:64:f9:3c:a8:9a:95:a4:eb:87:2f:d5:9d:b3'
Sep 26 22:32:38 router NetworkManager[6367]: <info>  [1538019158.9104] dhcp6 (enp2s0): activation: beginning transaction (timeout in 45 seconds)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9104] dhcp6 (enp2s0): creating composite dhclient config /var/lib/NetworkManager/dhclient6-enp2s0.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9104] dhcp6 (enp2s0): looking for existing config /etc/NetworkManager/dhclient6-33d1e6fd-998c-3060-baaf-239650746574.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9105] dhcp6 (enp2s0): looking for existing config /etc/NetworkManager/dhclient6-enp2s0.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9105] dhcp6 (enp2s0): looking for existing config /etc/NetworkManager/dhclient6.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9105] dhcp6 (enp2s0): looking for existing config /etc/dhcp/dhclient6-enp2s0.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9105] dhcp6 (enp2s0): looking for existing config /etc/dhclient6-enp2s0.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9106] dhcp6 (enp2s0): looking for existing config /etc/dhcp/dhclient6.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9106] dhcp6 (enp2s0): looking for existing config /etc/dhclient6.conf
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9106] dhcp6 (enp2s0): no existing dhclient configuration to merge
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9171] kill process 'dhcp-client' (6311): waiting up to 2000 milliseconds for process to disappear after sending SIGTERM (15)...
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9335] kill process 'dhcp-client' (6311): process is gone after sending signal SIGTERM (15) (16469 usec elapsed)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9337] dhcp6 (enp2s0): running: /sbin/dhclient -d -q -6 -N -P -sf /usr/libexec/nm-dhcp-helper -pf /var/run/dhclient6-enp2s0.pid -lf /var/lib/NetworkManager/dhclient6-33d1e6fd-998c-3060-baaf-239650746574-enp2s0.lease -cf /var/lib/NetworkManager/dhclient6-enp2s0.conf enp2s0
Sep 26 22:32:38 router NetworkManager[6367]: <info>  [1538019158.9359] dhcp6 (enp2s0): dhclient started with pid 6501
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9360] device[0x561734e714e0] (enp2s0): mtu: set IPv6 MTU to 1500
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9360] device[0x561734e714e0] (enp2s0): activation-stage: schedule activate_stage5_ip6_config_commit,v6 (id 297)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9361] ndisc[0x561734e850e0,"enp2s0"]: scheduling next now/lifetime check: 1800 seconds
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9361] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9363] device[0x561734e714e0] (enp2s0): activation-stage: invoke activate_stage5_ip6_config_commit,v6 (id 297)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9365] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=1, new-config=0x561734ed7a60)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9366] platform: address: adding or updating IPv6 address: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 lft 604667sec pref 604667sec lifetime 6-0[604667,604667] dev 2 flags noprefixroute src unknown
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9367] platform: signal: address 6 changed: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 lft 604667sec pref 604667sec lifetime 6-6[604667,604667] dev 2 flags noprefixroute src kernel
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9368] device[0x561734e714e0] (enp2s0): queued IP6 config change
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9369] platform-linux: do-add-ip6-address[2: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff]: success
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9369] platform: address: adding or updating IPv6 address: fe80::ffff:ffff:ffff:ffff/64 lft forever pref forever lifetime 6-0[4294967295,4294967295] dev 2 flags permanent,noprefixroute src unknown
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9370] platform-linux: do-add-ip6-address[2: fe80::ffff:ffff:ffff:ffff]: success
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9381] device[0x561734e714e0] (enp2s0): ip6-config: update IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/1)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9382] dns-mgr: (device_ip6_config_changed): queueing DNS updates (1)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9382] device[0x561734eb4f50] (enp5s0): ip6-config: update (commit=1, new-config=0x561734ed7ca0)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9383] platform: address: adding or updating IPv6 address: fe80::0000:0000:0000:0000/64 lft forever pref forever lifetime 6-0[4294967295,4294967295] dev 3 flags permanent,noprefixroute src unknown
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9384] platform-linux: do-add-ip6-address[3: fe80::0000:0000:0000:0000]: success
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9385] dns-mgr: (device_ip6_config_changed): DNS configuration did not change
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9385] dns-mgr: (device_ip6_config_changed): no DNS changes to commit (0)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9385] device[0x561734e714e0] (enp2s0): activation-stage: complete activate_stage5_ip6_config_commit,v6 (id 297)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9396] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=0, new-config=0x561734f25040)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9407] device[0x561734e714e0] (enp2s0): ip6-config: update IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/1)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9408] dns-mgr: (device_ip6_config_changed): queueing DNS updates (1)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9409] device[0x561734eb4f50] (enp5s0): ip6-config: update (commit=1, new-config=0x561734f25160)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9409] platform: address: adding or updating IPv6 address: fe80::0000:0000:0000:0000/64 lft forever pref forever lifetime 6-0[4294967295,4294967295] dev 3 flags permanent,noprefixroute src unknown
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9410] platform-linux: do-add-ip6-address[3: fe80::0000:0000:0000:0000]: success
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9411] dns-mgr: (device_ip6_config_changed): DNS configuration did not change
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9411] dns-mgr: (device_ip6_config_changed): no DNS changes to commit (0)
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9487] bus-manager: (dhcp) accepted connection 0x561734dcd850 on private socket
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9489] dhcp6 (enp2s0): unmapped DHCP state 'PREINIT6'
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9490] dhcp6 (enp2s0): DHCP reason 'PREINIT6' -> state 'unknown'
Sep 26 22:32:38 router NetworkManager[6367]: <debug> [1538019158.9493] bus-manager: (dhcp) closed connection 0x561734dcd850 on private socket
Sep 26 22:32:39 router dhclient[6501]: XMT: Rebind on enp2s0, interval 980ms.
Sep 26 22:32:39 router dhclient[6501]: RCV: Reply message on enp2s0 from fe80::1111:1111:1111:1111.
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8162] bus-manager: (dhcp) accepted connection 0x561734dcd950 on private socket
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8174] dhcp6 (enp2s0): DHCP reason 'REBIND6' -> state 'bound'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8176] dhcp6 (enp2s0): option 'dad_wait_time'=>'0'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8176] dhcp6 (enp2s0): option 'requested_dhcp6_client_id'=>'1'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8176] dhcp6 (enp2s0): option 'requested_dhcp6_name_servers'=>'1'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8176] dhcp6 (enp2s0): option 'renew'=>'302333'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8177] dhcp6 (enp2s0): option 'max_life'=>'604666'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8177] dhcp6 (enp2s0): option 'preferred_life'=>'604666'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8177] dhcp6 (enp2s0): option 'ip6_address'=>'2001:db8:ffff:ffff:ffff:ffff:ffff:ffff'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8177] dhcp6 (enp2s0): option 'dhcp6_server_id'=>'0:1:0:1:1d:7c:50:b0:0:50:56:9d:a8:78'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8177] dhcp6 (enp2s0): option 'ip6_prefixlen'=>'128'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8177] dhcp6 (enp2s0): option 'iaid'=>'6d:03:27:c4'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8178] dhcp6 (enp2s0): option 'requested_dhcp6_domain_search'=>'1'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8178] dhcp6 (enp2s0): option 'rebind'=>'483732'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8178] dhcp6 (enp2s0): option 'starts'=>'1538019159'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8178] dhcp6 (enp2s0): option 'life_starts'=>'1538019159'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8179] dhcp6 (enp2s0): option 'dhcp6_client_id'=>'0:4:24:90:2c:64:f9:3c:a8:9a:95:a4:eb:87:2f:d5:9d:b3'
Sep 26 22:32:39 router NetworkManager[6367]: <info>  [1538019159.8179] dhcp6 (enp2s0):   valid_lft 604666
Sep 26 22:32:39 router NetworkManager[6367]: <info>  [1538019159.8179] dhcp6 (enp2s0):   preferred_lft 604666
Sep 26 22:32:39 router NetworkManager[6367]: <info>  [1538019159.8180] dhcp6 (enp2s0):   address 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff
Sep 26 22:32:39 router NetworkManager[6367]: <info>  [1538019159.8180] dhcp6 (enp2s0): state changed unknown -> bound, event ID="6d:03:27:c4|1538019159"
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8181] device[0x561734e714e0] (enp2s0): new DHCPv6 client state 1
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8183] device[0x561734e714e0] (enp2s0): activation-stage: schedule activate_stage5_ip6_config_commit,v6 (id 321)
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8194] device[0x561734e714e0] (enp2s0): activation-stage: invoke activate_stage5_ip6_config_commit,v6 (id 321)
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8196] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=1, new-config=0x561734e85700)
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8198] platform: address: adding or updating IPv6 address: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 lft 604666sec pref 604666sec lifetime 6-0[604666,604666] dev 2 flags noprefixroute src unknown
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8200] platform: signal: address 6 changed: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 lft 604666sec pref 604666sec lifetime 6-6[604666,604666] dev 2 flags noprefixroute src kernel
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8200] device[0x561734e714e0] (enp2s0): queued IP6 config change
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8200] platform-linux: do-add-ip6-address[2: 2001:db8:ffff:ffff:ffff:ffff:ffff:ffff]: success
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8201] platform: address: adding or updating IPv6 address: fe80::ffff:ffff:ffff:ffff/64 lft forever pref forever lifetime 6-0[4294967295,4294967295] dev 2 flags permanent,noprefixroute src unknown
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8201] platform-linux: do-add-ip6-address[2: fe80::ffff:ffff:ffff:ffff]: success
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8202] dispatcher: (9) (enp2s0) dispatching action 'dhcp6-change'
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8205] active-connection[0x561734e85420]: set state-flags layer2-ready,ip4-ready,ip6-ready (was layer2-ready,ip4-ready)
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8205] device[0x561734e714e0] (enp2s0): activation-stage: complete activate_stage5_ip6_config_commit,v6 (id 321)
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8206] bus-manager: (dhcp) closed connection 0x561734dcd950 on private socket
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8207] device[0x561734e714e0] (enp2s0): ip6-config: update (commit=0, new-config=0x561734ed7ca0)
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: new request (5 scripts)
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_DHCP6_CLIENT_ID=0:4:24:90:2c:64:f9:3c:a8:9a:95:a4:eb:87:2f:d5:9d:b3
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_LIFE_STARTS=1538019159
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_STARTS=1538019159
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_REBIND=483732
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_REQUESTED_DHCP6_DOMAIN_SEARCH=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_IAID=6d:03:27:c4
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_IP6_PREFIXLEN=128
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_DHCP6_SERVER_ID=0:1:0:1:1d:7c:50:b0:0:50:56:9d:a8:78
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_IP6_ADDRESS=2001:db8:ffff:ffff:ffff:ffff:ffff:ffff
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_PREFERRED_LIFE=604666
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_MAX_LIFE=604666
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_RENEW=302333
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_REQUESTED_DHCP6_NAME_SERVERS=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_REQUESTED_DHCP6_CLIENT_ID=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP6_DAD_WAIT_TIME=0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_INTERFACE_MTU=1500
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_BROADCAST_ADDRESS=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_NEXT_SERVER=0.0.0.0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_NIS_DOMAIN=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_HOST_NAME=router
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_DOMAIN_NAME_SERVERS=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_INTERFACE_MTU=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_ROUTERS=198.51.100.1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_DOMAIN_NAME=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_EXPIRY=1538105231
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_IP_ADDRESS=198.51.100.130
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_SUBNET_MASK=255.255.248.0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_TIME_OFFSET=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_NTP_SERVERS=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_CLASSLESS_STATIC_ROUTES=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_RFC3442_CLASSLESS_STATIC_ROUTES=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_MS_CLASSLESS_STATIC_ROUTES=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_DOMAIN_NAME_SERVERS=203.0.113.106 203.0.113.107
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_DHCP_SERVER_IDENTIFIER=203.0.113.105
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_NIS_SERVERS=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_DHCP_MESSAGE_TYPE=5
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_STATIC_ROUTES=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_BROADCAST_ADDRESS=255.255.255.255
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_DOMAIN_NAME=myregion.myinternetprovider.com
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_DHCP_LEASE_TIME=86077
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_DAD_WAIT_TIME=0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_WPAD=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_DOMAIN_SEARCH=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_SUBNET_MASK=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_NETWORK_NUMBER=198.51.100.0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_ROUTERS=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DHCP4_REQUESTED_HOST_NAME=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_NUM_ROUTES=8
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_7=ff00::/8 :: 256
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_6=fe80::/64 :: 256
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_5=fe80::/64 :: 100
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_4=2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 :: 100
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_3=2001:db8:c09:37::/64 :: 100
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_2=2001:db8:6fc0:37::/64 :: 100
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_1=2001:db8:409:37::/64 :: 100
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ROUTE_0=2001:db8:709:37::/64 :: 100
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_NAMESERVERS=::1 2001:4860:4860::8888 2001:4860:4860::8844
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_GATEWAY=fe80::1111:1111:1111:1111
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_NUM_ADDRESSES=2
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ADDRESS_1=fe80::ffff:ffff:ffff:ffff/64 fe80::1111:1111:1111:1111
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP6_ADDRESS_0=2001:db8:ffff:ffff:ffff:ffff:ffff:ffff/128 fe80::1111:1111:1111:1111
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP4_NUM_ROUTES=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP4_ROUTE_0=198.51.100.0/21 0.0.0.0 100
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP4_NAMESERVERS=192.168.1.1 8.8.8.8 8.8.4.4
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP4_GATEWAY=198.51.100.1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP4_NUM_ADDRESSES=1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: IP4_ADDRESS_0=198.51.100.130/21 198.51.100.1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DEVICE_IP_IFACE=enp2s0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: DEVICE_IFACE=enp2s0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: CONNECTION_ID=enp2s0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: CONNECTION_UUID=33d1e6fd-998c-3060-baaf-239650746574
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: CONNECTION_FILENAME=/etc/sysconfig/network-scripts/ifcfg-enp2s0
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/1
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: start running ordered scripts...
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/00-netreport": run script
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/00-netreport": complete
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/04-iscsi": run script
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/04-iscsi": complete
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": run script
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/10-ifcfg-rh-routes.sh": complete
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/11-dhclient": run script
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/11-dhclient": complete
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/20-chrony": run script
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0], "/etc/NetworkManager/dispatcher.d/20-chrony": complete
Sep 26 22:32:39 router nm-dispatcher[6373]: req:9 'dhcp6-change' [enp2s0]: completed (5 scripts)
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8375] dispatcher: (9) 00-netreport succeeded
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8375] dispatcher: (9) 04-iscsi succeeded
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8375] dispatcher: (9) 10-ifcfg-rh-routes.sh succeeded
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8375] dispatcher: (9) 11-dhclient succeeded
Sep 26 22:32:39 router NetworkManager[6367]: <debug> [1538019159.8375] dispatcher: (9) 20-chrony succeeded
Sep 26 22:32:40 router NetworkManager[6367]: <debug> [1538019160.6265] device[0x561734e9a0c0] (enp4s0): remove_pending_action (0): 'carrier-wait'
Sep 26 22:32:40 router NetworkManager[6367]: <info>  [1538019160.6266] manager: startup complete
Sep 26 22:32:40 router systemd[1]: Started Network Manager Wait Online.
Sep 26 22:32:40 router audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 26 22:32:42 router NetworkManager[6367]: <debug> [1538019162.7871] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:42 router NetworkManager[6367]: <debug> [1538019162.7873] ndisc-lndp[0x561734e850e0,"enp2s0"]: received router advertisement at 9
Sep 26 22:32:42 router NetworkManager[6367]: <debug> [1538019162.7874] ndisc[0x561734e850e0,"enp2s0"]: scheduling next now/lifetime check: 1800 seconds
Sep 26 22:32:42 router NetworkManager[6367]: <debug> [1538019162.7874] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:46 router NetworkManager[6367]: <debug> [1538019166.8788] ndisc[0x561734ed79e0,"enp5s0"]: router advertisement sent
Sep 26 22:32:46 router NetworkManager[6367]: <debug> [1538019166.8789] ndisc[0x561734ed79e0,"enp5s0"]: will resend an initial router advertisement
Sep 26 22:32:46 router NetworkManager[6367]: <debug> [1538019166.8790] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:46 router NetworkManager[6367]: <debug> [1538019166.8791] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:49 router NetworkManager[6367]: <debug> [1538019169.8774] ndisc[0x561734ed79e0,"enp5s0"]: router advertisement sent
Sep 26 22:32:49 router NetworkManager[6367]: <debug> [1538019169.8775] ndisc[0x561734ed79e0,"enp5s0"]: will send an unsolicited router advertisement
Sep 26 22:32:49 router NetworkManager[6367]: <debug> [1538019169.8775] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:49 router NetworkManager[6367]: <debug> [1538019169.8776] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:32:49 router audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 26 22:32:57 router NetworkManager[6367]: <debug> [1538019177.9241] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:32:57 router NetworkManager[6367]: <debug> [1538019177.9242] ndisc-lndp[0x561734e850e0,"enp2s0"]: received router advertisement at 25
Sep 26 22:32:57 router NetworkManager[6367]: <debug> [1538019177.9243] ndisc[0x561734e850e0,"enp2s0"]: scheduling next now/lifetime check: 1800 seconds
Sep 26 22:32:57 router NetworkManager[6367]: <debug> [1538019177.9243] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:33:03 router NetworkManager[6367]: <debug> [1538019183.5735] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:33:03 router NetworkManager[6367]: <debug> [1538019183.5735] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:33:04 router audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 26 22:33:05 router NetworkManager[6367]: <debug> [1538019185.6752] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:33:05 router NetworkManager[6367]: <debug> [1538019185.6753] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:33:10 router NetworkManager[6367]: <debug> [1538019190.7783] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:33:10 router NetworkManager[6367]: <debug> [1538019190.7784] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:33:13 router NetworkManager[6367]: <debug> [1538019193.2328] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:33:13 router NetworkManager[6367]: <debug> [1538019193.2330] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:33:13 router NetworkManager[6367]: <debug> [1538019193.7202] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:33:13 router NetworkManager[6367]: <debug> [1538019193.7203] ndisc-lndp[0x561734e850e0,"enp2s0"]: received router advertisement at 40
Sep 26 22:33:13 router NetworkManager[6367]: <debug> [1538019193.7204] ndisc[0x561734e850e0,"enp2s0"]: scheduling next now/lifetime check: 1800 seconds
Sep 26 22:33:13 router NetworkManager[6367]: <debug> [1538019193.7204] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events
Sep 26 22:33:18 router NetworkManager[6367]: <debug> [1538019198.4584] ndisc-lndp[0x561734e850e0,"enp2s0"]: processing libndp events
Sep 26 22:33:18 router NetworkManager[6367]: <debug> [1538019198.4585] ndisc-lndp[0x561734ed79e0,"enp5s0"]: processing libndp events


Any ideas? Thanks.


On Fri, Sep 7, 2018 at 5:59 AM Thomas Haller <thaller redhat com> wrote:
On Wed, 2018-09-05 at 19:50 -0500, dag dg via networkmanager-list
wrote:
> Thanks Thomas. Going into debug was able to point me in the right
> direction. For those stumbling on this like myself, the
> "ipv6.method=shared" refers to your *LAN* interface, not your WAN
> interface. While this might seem intuitive to some, when I think
> "shared" I think of the WAN though that is mostly a holdover from
> IPv4
> conventions.
>
> In an earlier fit of desperation I had tried setting the LAN
> interface
> to "shared", but at the time ipv6 ICMP was unintentionally blocked by
> the firewall which was preventing the negotiation with my ISP from
> happening. I eventually figured it out that it was the firewall when
> I
> switched to wide-dhcpv6 using the known working config I had used
> with
> my old router, but I never went back to try setting the LAN interface
> to shared.
>
> After switching to debug I was able to see that the errors hinted at
> NM trying to find an interface(device) other than my WAN to assign a
> range to. The informational level message "no device to obtain a
> subnet to share on <interface> from" sort of gives this away but by
> itself can appear a bit cryptic, especially if like me you don't
> fully
> understand how ipv6 works.
>
> I think it would really help out if the documentation had a smidgen
> more detail, even if it was just a "for example if you are
> configuring
> a router for prefix delegation you would want to set your
> LAN/local/whatever interface to shared mode". Maybe it's already
> supposed to appear obvious but I definitely missed it, for what it's
> worth.
>
> Thanks again Thomas and thanks Vladimir; your earlier post was what
> made me aware Network Manager began supporting prefix delegation in
> the first place.


Hi,


I added a comment about that in `man nm-settings` [1], but it's unclear
that this is sufficiently discoverable. But it's also unclear where
else to document it.


Regarding firewall, at least for ipv4.method=shared, NetworkManager adds some
iptables rules to enable NAT [2]. This has room for improvement. Possibly
firewalld should be informed about the sharing and it's up to firewalld to
do the right thing. Todo.

[1] https://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?id=e90e1536c91678dcf34ab496aa750598052e1143
[2] https://cgit.freedesktop.org/NetworkManager/NetworkManager/tree/src/devices/nm-device.c?id=e90e1536c91678dcf34ab496aa750598052e1143#n10068


So, after all you got it working?? Cool!!


best,
Thomas

>
> ~dag
> On Wed, Sep 5, 2018 at 8:11 AM Thomas Haller <thaller redhat com>
> wrote:
> >
> > On Tue, 2018-09-04 at 09:29 -0500, dag dg via networkmanager-list
> > wrote:
> > >
> > > There doesn't seem to be much documentation for Network Manager
> > > on
> > > the
> > > prefix delegation support. Any insight would be appreciated.
> >
> > Hi,
> >
> >
> > it's not much documented, because there isn't much to configure
> > about
> > ipv6.method=shared. It's supposed to just work -- except when it
> > doesn't.
> >
> > Could you provide a full logfile with level=TRACE enabled?
> >
> > See the hints about logging at
> >
https://cgit.freedesktop.org/NetworkManager/NetworkManager/tree/contrib/fedora/rpm/NetworkManager.conf
> >
> >
> > best,
> > Thomas
>
> _______________________________________________
> networkmanager-list mailing list
> networkmanager-list gnome org
> https://mail.gnome.org/mailman/listinfo/networkmanager-list


[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]