-- Logs begin at to. 2014-07-03 00:02:09 CEST, end at ti. 2014-12-16 12:44:34 CET. --
des. 16 12:43:06 envy.fud.no clatd[22771]: Configuration successfully read, dumping it:
des. 16 12:43:06 envy.fud.no clatd[22771]: clat-dev=clat
des. 16 12:43:06 envy.fud.no clatd[22771]: clat-v4-addr=192.0.0.1
des. 16 12:43:06 envy.fud.no clatd[22771]: clat-v6-addr=<undefined>
des. 16 12:43:06 envy.fud.no clatd[22771]: cmd-ip=ip
des. 16 12:43:06 envy.fud.no clatd[22771]: cmd-ip6tables=ip6tables
des. 16 12:43:06 envy.fud.no clatd[22771]: cmd-tayga=tayga
des. 16 12:43:06 envy.fud.no clatd[22771]: debug=2
des. 16 12:43:06 envy.fud.no clatd[22771]: dns64-servers=<undefined>
des. 16 12:43:06 envy.fud.no clatd[22771]: forwarding-enable=1
des. 16 12:43:06 envy.fud.no clatd[22771]: ip6tables-enable=<undefined>
des. 16 12:43:06 envy.fud.no clatd[22771]: plat-dev=<undefined>
des. 16 12:43:06 envy.fud.no clatd[22771]: plat-prefix=<undefined>
des. 16 12:43:06 envy.fud.no clatd[22771]: proxynd-enable=1
des. 16 12:43:06 envy.fud.no clatd[22771]: quiet=0
des. 16 12:43:06 envy.fud.no clatd[22771]: tayga-conffile=<undefined>
des. 16 12:43:06 envy.fud.no clatd[22771]: tayga-v4-addr=192.0.0.2
des. 16 12:43:06 envy.fud.no clatd[22771]: v4-conncheck-delay=1
des. 16 12:43:06 envy.fud.no clatd[22771]: v4-conncheck-enable=1
des. 16 12:43:06 envy.fud.no clatd[22771]: v4-defaultroute-enable=1
des. 16 12:43:06 envy.fud.no clatd[22771]: v4-defaultroute-metric=2048
des. 16 12:43:06 envy.fud.no clatd[22771]: v4-defaultroute-mtu=1260
des. 16 12:43:06 envy.fud.no clatd[22771]: Starting clatd v1.2 by Tore Anderson <tore@fud.no>
des. 16 12:43:06 envy.fud.no clatd[22771]: Performing DNS64-based PLAT prefix discovery (cf. RFC 7050)
des. 16 12:43:06 envy.fud.no clatd[22771]: cfgstr(dns64-servers)
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking up 'ipv4only.arpa' using system resolver
des. 16 12:43:06 envy.fud.no NetworkManager[18536]: <debug> [1418730186.328439] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 24)
des. 16 12:43:06 envy.fud.no NetworkManager[18536]: <debug> [1418730186.328576] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 5 returned 0x7fe080be63e0
des. 16 12:43:06 envy.fud.no NetworkManager[18536]: <debug> [1418730186.328607] [platform/nm-linux-platform.c:1684] announce_object(): skip announce unmatching IP6 route 2001:4600:4:fff::54/128 via fe80::215:e0ff:feec:101 dev wwp0s26u1u5i6 metric 0 mss 0 src unknown
des. 16 12:43:06 envy.fud.no clatd[22771]: check_wka(): Testing to see if 64:ff9b:0:0:0:0:c000:ab was DNS64-synthesised
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /48
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:0:aa00:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:0:ab00:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /64
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:aa00:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:ab00:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /56
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:aa:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:ab:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /32
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c000:aa::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c000:ab::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /40
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c0:0:aa::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c0:0:ab::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /96
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:aa
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:ab
des. 16 12:43:06 envy.fud.no clatd[22771]: Found it!
des. 16 12:43:06 envy.fud.no clatd[22771]: Inferred PLAT prefix 64:ff9b::/96 from AAAA record 64:ff9b:0:0:0:0:c000:ab
des. 16 12:43:06 envy.fud.no clatd[22771]: check_wka(): Testing to see if 64:ff9b:0:0:0:0:c000:aa was DNS64-synthesised
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /40
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c0:0:aa::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c0:0:ab::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /96
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:aa
des. 16 12:43:06 envy.fud.no clatd[22771]: Found it!
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:ab
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /64
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:aa00:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:ab00:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /56
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:aa:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c0:0:ab:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /32
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c000:aa::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA 0:0:c000:ab::
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for Well-Known Addresses at prefix length /48
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:0:aa00:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Looking for WKA ::c000:0:ab00:0:0
des. 16 12:43:06 envy.fud.no clatd[22771]: Didn't find it
des. 16 12:43:06 envy.fud.no clatd[22771]: Inferred PLAT prefix 64:ff9b::/96 from AAAA record 64:ff9b:0:0:0:0:c000:aa
des. 16 12:43:06 envy.fud.no clatd[22771]: Using PLAT (NAT64) prefix: 64:ff9b::/96
des. 16 12:43:06 envy.fud.no clatd[22771]: get_plat_dev(): finding which network dev faces the PLAT
des. 16 12:43:06 envy.fud.no NetworkManager[18536]: <debug> [1418730186.999244] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 24)
des. 16 12:43:06 envy.fud.no NetworkManager[18536]: <debug> [1418730186.999389] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 5 returned 0x7fe080bfbc70
des. 16 12:43:06 envy.fud.no NetworkManager[18536]: <debug> [1418730186.999422] [platform/nm-linux-platform.c:1684] announce_object(): skip announce unmatching IP6 route 64:ff9b::/128 via fe80::215:e0ff:feec:101 dev wwp0s26u1u5i6 metric 0 mss 0 src unknown
des. 16 12:43:07 envy.fud.no clatd[22771]: cfgstr(plat-prefix)
des. 16 12:43:07 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:07 envy.fud.no clatd[22771]: get_plat_dev(): Found PLAT-facing device: wwp0s26u1u5i6
des. 16 12:43:07 envy.fud.no clatd[22771]: Device facing the PLAT: wwp0s26u1u5i6
des. 16 12:43:07 envy.fud.no clatd[22771]: cfgstr(plat-dev)
des. 16 12:43:07 envy.fud.no clatd[22771]: cfgstr(plat-prefix)
des. 16 12:43:07 envy.fud.no clatd[22771]: Attempting to derive a CLAT IPv6 address from an IPv6 address on 'wwp0s26u1u5i6'
des. 16 12:43:07 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:07 envy.fud.no clatd[22771]: Saw a candidate address on 'wwp0s26u1u5i6': 2a02:2121:8f:3709:0:25:fd6f:e801/64
des. 16 12:43:07 envy.fud.no clatd[22771]: Preferring 2a02:2121:8f:3709:0:25:fd6f:e801/64; best match so far
des. 16 12:43:07 envy.fud.no clatd[22771]: Using random interface ID: ddefc9e863780000
des. 16 12:43:07 envy.fud.no clatd[22771]: Using CLAT IPv4 address: 192.0.0.1
des. 16 12:43:07 envy.fud.no clatd[22771]: Using CLAT IPv6 address: 2a02:2121:8f:3709:ddef:c9e8:6378:0
des. 16 12:43:07 envy.fud.no clatd[22771]: cfgbool(v4-conncheck-enable)
des. 16 12:43:07 envy.fud.no clatd[22771]: cfgstr(v4-conncheck-delay)
des. 16 12:43:07 envy.fud.no clatd[22771]: Checking if this system already has IPv4 connectivity in 1 sec(s)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(tayga-conffile)
des. 16 12:43:08 envy.fud.no clatd[22771]: Using temporary conffile for TAYGA: /tmp/hlbXywhWQ_
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(plat-prefix)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(tayga-v4-addr)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-v4-addr)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-v6-addr)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgbool(forwarding-enable)
des. 16 12:43:08 envy.fud.no clatd[22771]: Reading sysctl /proc/sys/net/ipv6/conf/all/forwarding
des. 16 12:43:08 envy.fud.no clatd[22771]: /proc/sys/net/ipv6/conf/all/forwarding is set to '0'
des. 16 12:43:08 envy.fud.no clatd[22771]: Enabling IPv6 forwarding
des. 16 12:43:08 envy.fud.no clatd[22771]: Reading sysctl /proc/sys/net/ipv6/conf/default/accept_ra
des. 16 12:43:08 envy.fud.no clatd[22771]: /proc/sys/net/ipv6/conf/default/accept_ra is set to '1'
des. 16 12:43:08 envy.fud.no clatd[22771]: Changing /proc/sys/net/ipv6/conf/default/accept_ra from 1 to 2 to prevent connectivity loss after enabling IPv6 forwarding
des. 16 12:43:08 envy.fud.no clatd[22771]: Setting sysctl /proc/sys/net/ipv6/conf/default/accept_ra=2
des. 16 12:43:08 envy.fud.no clatd[22771]: Reading sysctl /proc/sys/net/ipv6/conf/enp0s25/accept_ra
des. 16 12:43:08 envy.fud.no clatd[22771]: /proc/sys/net/ipv6/conf/enp0s25/accept_ra is set to '1'
des. 16 12:43:08 envy.fud.no clatd[22771]: Changing /proc/sys/net/ipv6/conf/enp0s25/accept_ra from 1 to 2 to prevent connectivity loss after enabling IPv6 forwarding
des. 16 12:43:08 envy.fud.no clatd[22771]: Setting sysctl /proc/sys/net/ipv6/conf/enp0s25/accept_ra=2
des. 16 12:43:08 envy.fud.no clatd[22771]: Reading sysctl /proc/sys/net/ipv6/conf/lo/accept_ra
des. 16 12:43:08 envy.fud.no clatd[22771]: /proc/sys/net/ipv6/conf/lo/accept_ra is set to '1'
des. 16 12:43:08 envy.fud.no clatd[22771]: Changing /proc/sys/net/ipv6/conf/lo/accept_ra from 1 to 2 to prevent connectivity loss after enabling IPv6 forwarding
des. 16 12:43:08 envy.fud.no clatd[22771]: Setting sysctl /proc/sys/net/ipv6/conf/lo/accept_ra=2
des. 16 12:43:08 envy.fud.no clatd[22771]: Reading sysctl /proc/sys/net/ipv6/conf/wlo1/accept_ra
des. 16 12:43:08 envy.fud.no clatd[22771]: /proc/sys/net/ipv6/conf/wlo1/accept_ra is set to '0'
des. 16 12:43:08 envy.fud.no clatd[22771]: Reading sysctl /proc/sys/net/ipv6/conf/wwp0s26u1u5i6/accept_ra
des. 16 12:43:08 envy.fud.no clatd[22771]: /proc/sys/net/ipv6/conf/wwp0s26u1u5i6/accept_ra is set to '1'
des. 16 12:43:08 envy.fud.no clatd[22771]: Changing /proc/sys/net/ipv6/conf/wwp0s26u1u5i6/accept_ra from 1 to 2 to prevent connectivity loss after enabling IPv6 forwarding
des. 16 12:43:08 envy.fud.no clatd[22771]: Setting sysctl /proc/sys/net/ipv6/conf/wwp0s26u1u5i6/accept_ra=2
des. 16 12:43:08 envy.fud.no clatd[22771]: Setting sysctl /proc/sys/net/ipv6/conf/all/forwarding=1
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.122203] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 24)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.122375] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 5 returned 0x7fe080bff1f0
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.122408] [platform/nm-linux-platform.c:1684] announce_object(): skip announce unmatching IP6 route 2a02:2121:8f:3709::/128 via :: dev lo metric 0 mss 0 src unknown
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.122454] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 24)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.122570] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 5 returned 0x7fe080bff1f0
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.122593] [platform/nm-linux-platform.c:1684] announce_object(): skip announce unmatching IP6 route fe80::/128 via :: dev lo metric 0 mss 0 src unknown
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgbool(ip6tables-enable)
des. 16 12:43:08 envy.fud.no clatd[22771]: Adding ip6tables rules allowing traffic between the CLAT and PLAT devices
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip6tables)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(plat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(ip6tables -I FORWARD -i clat -o wwp0s26u1u5i6 -j ACCEPT)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip6tables)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(plat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(ip6tables -I FORWARD -i wwp0s26u1u5i6 -o clat -j ACCEPT)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgbool(proxynd-enable)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(plat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-v6-addr)
des. 16 12:43:08 envy.fud.no clatd[22771]: Enabling Proxy-ND for 2a02:2121:8f:3709:ddef:c9e8:6378:0 on wwp0s26u1u5i6
des. 16 12:43:08 envy.fud.no clatd[22771]: Reading sysctl /proc/sys/net/ipv6/conf/wwp0s26u1u5i6/proxy_ndp
des. 16 12:43:08 envy.fud.no clatd[22771]: /proc/sys/net/ipv6/conf/wwp0s26u1u5i6/proxy_ndp is set to '0'
des. 16 12:43:08 envy.fud.no clatd[22771]: Setting sysctl /proc/sys/net/ipv6/conf/wwp0s26u1u5i6/proxy_ndp=1
des. 16 12:43:08 envy.fud.no clatd[22771]: Enabled Proxy-ND sysctl for wwp0s26u1u5i6
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-v6-addr)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(plat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(ip -6 neighbour add proxy 2a02:2121:8f:3709:ddef:c9e8:6378:0 dev wwp0s26u1u5i6)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.155169] [platform/nm-linux-platform.c:1950] event_notification(): netlink event (type 16) for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.155279] [platform/nm-linux-platform.c:426] get_kernel_object(): get_kernel_object for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.155512] [platform/nm-linux-platform.c:2144] _log_dbg_sysctl_get_impl(): sysctl: reading '/sys/class/net/clat/owner': '-1' (changed from '0' on last read)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.155557] [platform/nm-linux-platform.c:2144] _log_dbg_sysctl_get_impl(): sysctl: reading '/sys/class/net/clat/group': '-1' (changed from '0' on last read)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.155605] [platform/nm-linux-platform.c:2144] _log_dbg_sysctl_get_impl(): sysctl: reading '/sys/class/net/clat/tun_flags': '0x1' (changed from '0x801' on last read)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.155645] [platform/nm-platform.c:2712] log_link(): signal: link   added: 11225: clat <NOARP,DOWN> mtu 1500 tun
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.155718] [devices/nm-device.c:7951] constructor(): [0x7fe080c3a3c0] (clat): constructor(): NMDeviceTun, kernel ifindex 11225
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): carrier is OFF
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.156190] [platform/nm-linux-platform.c:2184] sysctl_get(): error reading /sys/class/net/clat/phys_port_id: Feil under lesing fra fil «/sys/class/net/clat/phys_port_id»: Operasjonen er ikke støttet
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): new Tun device (driver: 'unknown' ifindex: 11225)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): exported as /org/freedesktop/NetworkManager/Devices/43
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.156578] [devices/nm-device.c:5728] nm_device_set_ip4_config(): [0x7fe080c3a3c0] (clat): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/43)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.166069] [devices/nm-device.c:5853] nm_device_set_ip6_config(): [0x7fe080c3a3c0] (clat): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/43)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.166511] [devices/nm-device.c:1996] nm_device_generate_connection(): [0x7fe080c3a3c0] (clat): ignoring generated connection (no IP and not in master-slave relationship)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.166692] [nm-manager.c:1666] recheck_assume_connection(): (clat): can't assume; no connection
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.166861] [nm-manager.c:1102] system_create_virtual_devices(): creating virtual devices...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.170745] [platform/nm-linux-platform.c:1950] event_notification(): netlink event (type 16) for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: Creating and configuring up CLAT device 'clat'
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-tayga)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(tayga-conffile)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(debug)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(tayga --config /tmp/hlbXywhWQ_ --mktun -d)
des. 16 12:43:08 envy.fud.no clatd[22771]: Created persistent tun device clat
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(ip link set up dev clat)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-v4-addr)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(ip -4 address add 192.0.0.1 dev clat)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-v6-addr)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(ip -6 route add 2a02:2121:8f:3709:ddef:c9e8:6378:0 dev clat)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.181703] [platform/nm-linux-platform.c:426] get_kernel_object(): get_kernel_object for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.181861] [platform/nm-linux-platform.c:2144] _log_dbg_sysctl_get_impl(): sysctl: reading '/sys/class/net/clat/owner': '0' (changed from '-1' on last read)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.181903] [platform/nm-linux-platform.c:2144] _log_dbg_sysctl_get_impl(): sysctl: reading '/sys/class/net/clat/group': '0' (changed from '-1' on last read)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.181940] [platform/nm-linux-platform.c:2144] _log_dbg_sysctl_get_impl(): sysctl: reading '/sys/class/net/clat/tun_flags': '0x801' (changed from '0x1' on last read)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182017] [platform/nm-platform.c:2712] log_link(): signal: link changed: 11225: clat <NOARP,UP> mtu 1500 tun
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182186] [platform/nm-linux-platform.c:4297] handle_udev_event(): UDEV event: action 'add' subsys 'net' device 'clat' (11225); seqnum=72090
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182343] [platform/nm-platform.c:2712] log_link(): signal: link changed: 11225: clat <NOARP,UP> mtu 1500 tun driver 'tun' udi '/sys/devices/virtual/net/clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182486] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 20)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182555] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 2 returned 0x7fe080bf1550
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182583] [platform/nm-platform.c:2718] log_ip4_address(): signal: address 4   added: 192.0.0.1/32 lft forever pref forever lifetime 608-0[4294967295,4294967295] dev clat src kernel
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182598] [nm-default-route-manager.c:1235] _resync_idle_reschedule(): default-route-: resync: schedule on idle
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.182615] [devices/nm-device.c:6557] device_ip_changed(): [0x7fe080c3a3c0] (clat): queued IP config change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.188297] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 24)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.188685] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 4 returned 0x7fe080bff0d0
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.188872] [platform/nm-linux-platform.c:1672] announce_object(): skip announce unmatching IP4 route 192.0.0.1/32 via 0.0.0.0 dev clat metric 0 mss 0 src kernel
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.191199] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 24)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.191700] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 5 returned 0x7fe080c2abd0
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.191902] [platform/nm-platform.c:2736] log_ip6_route(): signal: route   6   added: 2a02:2121:8f:3709:ddef:c9e8:6378:0/128 via :: dev clat metric 1024 mss 0 src user
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.192174] [devices/nm-device.c:6557] device_ip_changed(): [0x7fe080c3a3c0] (clat): queued IP config change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.192486] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 24)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.192844] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 4 returned 0x7fe080c0f510
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.193031] [platform/nm-platform.c:2730] log_ip4_route(): signal: route   4   added: 0.0.0.0/0 via 0.0.0.0 dev clat metric 2048 mss 0 src user
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.193313] [devices/nm-device.c:6557] device_ip_changed(): [0x7fe080c3a3c0] (clat): queued IP config change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.193643] [platform/nm-linux-platform.c:1950] event_notification(): netlink event (type 16) for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.197358] [platform/nm-linux-platform.c:426] get_kernel_object(): get_kernel_object for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.197741] [platform/nm-platform.c:2712] log_link(): signal: link changed: 11225: clat <NOARP,UP,LOWER_UP> mtu 1500 tun driver 'tun' udi '/sys/devices/virtual/net/clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): link connected
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.198541] [devices/nm-device.c:2157] nm_device_emit_recheck_assume(): [0x7fe080c3a3c0] (clat): emit RECHECK_ASSUME signal
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.199639] [devices/nm-device.c:5716] nm_device_set_ip4_config(): [0x7fe080c3a3c0] (clat): update IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/43)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.199833] [dns-manager/nm-dns-manager.c:1005] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.199932] [dns-manager/nm-dns-manager.c:1023] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.200214] [dns-manager/nm-dns-manager.c:1027] nm_dns_manager_end_updates(): (device_ip4_config_changed): no DNS changes to commit (0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.203091] [devices/nm-device.c:5841] nm_device_set_ip6_config(): [0x7fe080c3a3c0] (clat): update IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/43)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.203122] [dns-manager/nm-dns-manager.c:1005] nm_dns_manager_begin_updates(): (device_ip6_config_changed): queueing DNS updates (1)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.203221] [dns-manager/nm-dns-manager.c:1023] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.203494] [dns-manager/nm-dns-manager.c:1027] nm_dns_manager_end_updates(): (device_ip6_config_changed): no DNS changes to commit (0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.204018] [nm-manager.c:1579] get_existing_connection(): (clat): generated connection 'clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.204083] [settings/nm-settings.c:979] nm_settings_add_connection(): Failed to add 1112cd8c-545a-4a7b-97c1-fe55e2622870/'clat': The ifcfg-rh plugin cannot write the connection 'clat' (type 'generic' pppoe 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.205513] [settings/nm-settings.c:979] nm_settings_add_connection(): Failed to add 1112cd8c-545a-4a7b-97c1-fe55e2622870/'clat': (unknown)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.206130] [NetworkManagerUtils.c:2130] nm_utils_log_connection_diff(): ++ connection 'update connection' (0x7fe080b952c0 < 0x7fe080bb3dc0):
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.206159] [NetworkManagerUtils.c:2149] nm_utils_log_connection_diff(): ++ connection                [ 0x7fe080bb3fa0 < *missing* ]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.220419] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.autoconnect    = FALSE
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.220839] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.id             = 'clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.221118] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.interface-name = 'clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.221412] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.permissions    = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.221691] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.secondaries    = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.221969] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.timestamp      = 1418730188
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.222238] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.type           = 'generic'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.222522] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.uuid           = '1112cd8c-545a-4a7b-97c1-fe55e2622870'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.222839] [NetworkManagerUtils.c:2149] nm_utils_log_connection_diff(): ++ ipv4                      [ 0x7fe080bb3f00 < *missing* ]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.223123] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.addresses            = ((GPtrArray*) 0x7fe080c23aa0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.223415] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.dns                  = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.223702] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.dns-search           = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.223975] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.method               = 'manual'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.224249] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.routes               = ((GPtrArray*) 0x7fe0640012e0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.224534] [NetworkManagerUtils.c:2149] nm_utils_log_connection_diff(): ++ ipv6                      [ 0x7fe080bb21f0 < *missing* ]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.224805] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.addresses            = ((GPtrArray*) 0x7fe080b98880)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.225100] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.dns                  = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.225386] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.dns-search           = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.225676] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.method               = 'ignore'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.225974] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.routes               = ((GPtrArray*) 0x7fe080b98780)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.227524] [settings/nm-settings-connection.c:1896] nm_settings_connection_read_and_fill_timestamp(): failed to read connection timestamp for '1112cd8c-545a-4a7b-97c1-fe55e2622870': (3) Nøkkelfil har ikke nøkkelen «1112cd8c-545a-4a7b-97c1-fe55e2622870»
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.227888] [NetworkManagerUtils.c:2132] nm_utils_log_connection_diff(): ++ connection 'new connection' (0x7fe080bb3dc0):
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.238724] [NetworkManagerUtils.c:2151] nm_utils_log_connection_diff(): ++ connection                [ 0x7fe080bb2790 ]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.239083] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.autoconnect    = FALSE
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.239405] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.id             = 'clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.239698] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.interface-name = 'clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.240002] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.permissions    = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.240284] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.secondaries    = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.240579] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.timestamp      = 1418730188
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.240863] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.type           = 'generic'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.241157] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ connection.uuid           = '1112cd8c-545a-4a7b-97c1-fe55e2622870'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.241460] [NetworkManagerUtils.c:2151] nm_utils_log_connection_diff(): ++ ipv4                      [ 0x7fe080bb38c0 ]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.241721] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.addresses            = ((GPtrArray*) 0x7fe080b94f40)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.242017] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.dns                  = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.242296] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.dns-search           = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.242581] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.method               = 'manual'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.242873] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv4.routes               = ((GPtrArray*) 0x7fe080b6a5a0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.243185] [NetworkManagerUtils.c:2151] nm_utils_log_connection_diff(): ++ ipv6                      [ 0x7fe080bb2510 ]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.243464] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.addresses            = ((GPtrArray*) 0x7fe080b6f520)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.243754] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.dns                  = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.244032] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.dns-search           = []
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.244305] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.method               = 'ignore'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.244604] [NetworkManagerUtils.c:2160] nm_utils_log_connection_diff(): ++ ipv6.routes               = ((GPtrArray*) 0x7fe080c25ae0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: unmanaged -> unavailable (reason 'connection-assumed') [10 20 41]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.259343] [devices/nm-device.c:6198] nm_device_bring_up(): [0x7fe080c3a3c0] (clat): bringing up device.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.259363] [platform/nm-platform.c:870] nm_platform_link_set_up(): link: setting up 'clat' (11225)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.260286] [platform/nm-linux-platform.c:2441] link_change_flags(): link: change 11225: flags set 'up' (1)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.260392] [platform/nm-linux-platform.c:426] get_kernel_object(): get_kernel_object for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.260522] [platform/nm-platform.c:2712] log_link(): signal: link changed: 11225: clat <NOARP,UP,LOWER_UP> mtu 1500 tun driver 'tun' udi '/sys/devices/virtual/net/clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.260634] [devices/nm-device.c:6953] nm_device_add_pending_action(): [0x7fe080c3a3c0] (clat): add_pending_action (1): 'carrier wait'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.260816] [devices/nm-device.c:7498] _set_state_full(): [0x7fe080c3a3c0] (clat): device is available, will transition to DISCONNECTED
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.260884] [devices/nm-device.c:6953] nm_device_add_pending_action(): [0x7fe080c3a3c0] (clat): add_pending_action (2): 'queued state change to disconnected'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.261163] [devices/nm-device.c:7687] nm_device_queue_state(): [0x7fe080c3a3c0] (clat): queued state change to disconnected due to none (id 5415)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.261480] [nm-manager.c:1609] assume_connection(): (clat): will attempt to assume connection
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: unavailable -> disconnected (reason 'connection-assumed') [20 30 41]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.262017] [devices/nm-device.c:7709] nm_device_queued_state_clear(): [0x7fe080c3a3c0] (clat): clearing queued state transition (id 5415)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.262303] [devices/nm-device.c:6986] nm_device_remove_pending_action(): [0x7fe080c3a3c0] (clat): remove_pending_action (1): 'queued state change to disconnected'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.262815] [devices/nm-device.c:6953] nm_device_add_pending_action(): [0x7fe080c3a3c0] (clat): add_pending_action (2): 'activation::0x7fe080bbfa30'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.262933] [devices/nm-device.c:6986] nm_device_remove_pending_action(): [0x7fe080c3a3c0] (clat): remove_pending_action (1): 'activation::0x7fe080bbfa30'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: starting connection 'clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 1 of 5 (Device Prepare) scheduled...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.263935] [nm-default-route-manager.c:604] _entry_at_idx_update(): default-route4: entry[0/dev:0x7fe080c3a3c0:clat:ns]: add 0.0.0.0/0 via 0.0.0.0 dev clat metric 2048 mss 0 src user
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.264901] [nm-default-route-manager.c:1211] _resync_idle_cancel(): default-route-: resync: cancelled (5403)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 1 of 5 (Device Prepare) started...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: disconnected -> prepare (reason 'none') [30 40 0]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.273201] [nm-active-connection.c:480] check_master_ready(): (0x7fe080bbfa30): not signalling master-ready (no master)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.273368] [nm-manager.c:4322] policy_activating_device_changed(): ActivatingConnection now clat
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 2 of 5 (Device Configure) scheduled...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 1 of 5 (Device Prepare) complete.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 2 of 5 (Device Configure) starting...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: prepare -> config (reason 'none') [40 50 0]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 2 of 5 (Device Configure) successful.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.276835] [devices/nm-device.c:4722] nm_device_activate_schedule_stage3_ip_config_start(): [0x7fe080c3a3c0] (clat): Activation: skip setting firewall zone 'default' for assumed device
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 2 of 5 (Device Configure) complete.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 3 of 5 (IP Configure Start) started...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: config -> ip-config (reason 'none') [50 70 0]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 5 of 5 (IPv4 Configure Commit) scheduled...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.291608] [devices/nm-device.c:4277] set_nm_ipv6ll(): [0x7fe080c3a3c0] (clat): will disable userland IPv6LL
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.291626] [platform/nm-linux-platform.c:2504] link_set_user_ipv6ll_enabled(): link: change 11225: set IPv6 address generation mode to eui64
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.291740] [platform/nm-linux-platform.c:426] get_kernel_object(): get_kernel_object for link: clat (11225, family 0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.291895] [platform/nm-platform.c:2712] log_link(): signal: link changed: 11225: clat <NOARP,UP,LOWER_UP> mtu 1500 tun driver 'tun' udi '/sys/devices/virtual/net/clat'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.292041] [platform/nm-linux-platform.c:2052] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/disable_ipv6' to '1' (current value is '0')
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.293408] [platform/nm-linux-platform.c:2052] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/disable_ipv6' to '0' (current value is '1')
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.293474] [platform/nm-linux-platform.c:2050] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/use_tempaddr' to '-1' (current value is identical)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.302100] [platform/nm-linux-platform.c:2050] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/hop_limit' to '64' (current value is identical)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.302197] [platform/nm-linux-platform.c:2050] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/accept_ra_pinfo' to '1' (current value is identical)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.302555] [platform/nm-linux-platform.c:2050] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/accept_ra_rtr_pref' to '1' (current value is identical)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.302911] [platform/nm-linux-platform.c:2050] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/accept_ra' to '2' (current value is identical)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.303303] [platform/nm-linux-platform.c:2050] _log_dbg_sysctl_set_impl(): sysctl: setting '/proc/sys/net/ipv6/conf/clat/accept_ra_defrtr' to '1' (current value is identical)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 3 of 5 (IP Configure Start) complete.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.304008] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 25)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.304472] [platform/nm-linux-platform.c:472] get_kernel_object(): get_kernel_object for type 5 had no result
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.304839] [platform/nm-platform.c:2736] log_ip6_route(): signal: route   6 removed: 2a02:2121:8f:3709:ddef:c9e8:6378:0/128 via :: dev clat metric 1024 mss 0 src user
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.307120] [devices/nm-device.c:6557] device_ip_changed(): [0x7fe080c3a3c0] (clat): queued IP config change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 5 of 5 (IPv4 Commit) started...
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.313205] [platform/nm-platform.c:1533] nm_platform_ip4_address_add(): address: adding or updating IPv4 address: 192.0.0.1/32 lft forever pref forever lifetime 608-0[4294967295,4294967295] dev clat src unknown
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.315851] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 2 returned 0x7fe080bf8390
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.316354] [platform/nm-platform.c:2718] log_ip4_address(): signal: address 4 changed: 192.0.0.1/32 lft forever pref forever lifetime 608-0[4294967295,4294967295] dev clat src kernel
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.317455] [nm-default-route-manager.c:1235] _resync_idle_reschedule(): default-route-: resync: schedule on idle
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.318865] [devices/nm-device.c:6557] device_ip_changed(): [0x7fe080c3a3c0] (clat): queued IP config change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.322741] [devices/nm-device.c:5046] send_arps(): [0x7fe080c3a3c0] (clat): arping: run /usr/sbin/arping -A -q -I clat -c 1 192.0.0.1
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.326781] [devices/nm-device.c:7000] nm_device_remove_pending_action(): [0x7fe080c3a3c0] (clat): remove_pending_action (1): 'dhcp4' not pending (expected)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.327109] [nm-dispatcher.c:443] _dispatcher_call(): (126) (clat) dispatching action 'pre-up' (with callback)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.327130] [nm-dispatcher.c:458] _dispatcher_call(): (126) simulate request; no scripts in /etc/NetworkManager/dispatcher.d/pre-up.d
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: Stage 5 of 5 (IPv4 Commit) complete.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.329672] [devices/nm-device.c:5841] nm_device_set_ip6_config(): [0x7fe080c3a3c0] (clat): update IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/43)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.329708] [dns-manager/nm-dns-manager.c:1005] nm_dns_manager_begin_updates(): (device_ip6_config_changed): queueing DNS updates (1)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.333152] [dns-manager/nm-dns-manager.c:1023] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.333175] [dns-manager/nm-dns-manager.c:1027] nm_dns_manager_end_updates(): (device_ip6_config_changed): no DNS changes to commit (0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.333349] [platform/nm-linux-platform.c:1952] event_notification(): netlink event (type 20)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.334859] [platform/nm-linux-platform.c:470] get_kernel_object(): get_kernel_object for type 2 returned 0x7fe080c10d80
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgbool(v4-defaultroute-enable)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(clat-dev)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(v4-defaultroute-metric)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(v4-defaultroute-metric)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(v4-defaultroute-mtu)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(v4-defaultroute-mtu)
des. 16 12:43:08 envy.fud.no clatd[22771]: Adding IPv4 default route via the CLAT
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-ip)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(ip -4 route add default dev clat metric 2048 mtu 1260)
des. 16 12:43:08 envy.fud.no clatd[22771]: Starting up TAYGA, using config file '/tmp/hlbXywhWQ_'
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(cmd-tayga)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(tayga-conffile)
des. 16 12:43:08 envy.fud.no clatd[22771]: cfgstr(debug)
des. 16 12:43:08 envy.fud.no clatd[22771]: cmd(tayga --config /tmp/hlbXywhWQ_ --nodetach -d)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.350092] [nm-default-route-manager.c:1181] _resync_idle_now(): default-route-: resync: sync now (5442) (IPv4 changes: yes, IPv6 changes: no)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.354109] [devices/nm-device.c:6953] nm_device_add_pending_action(): [0x7fe080c3a3c0] (clat): add_pending_action (2): 'queued state change to secondaries'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.354551] [devices/nm-device.c:7687] nm_device_queue_state(): [0x7fe080c3a3c0] (clat): queued state change to secondaries due to none (id 5456)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.383703] [devices/nm-device.c:7636] queued_set_state(): [0x7fe080c3a3c0] (clat): running queued state change to secondaries (id 5456)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.384569] [devices/nm-device.c:6953] nm_device_add_pending_action(): [0x7fe080c3a3c0] (clat): add_pending_action (3): 'queued state change to activated'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.384594] [devices/nm-device.c:7687] nm_device_queue_state(): [0x7fe080c3a3c0] (clat): queued state change to activated due to none (id 5466)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.384634] [nm-manager.c:4322] policy_activating_device_changed(): ActivatingConnection now (none)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.384664] [devices/nm-device.c:7587] _set_state_full(): [0x7fe080c3a3c0] (clat): device entered SECONDARIES state
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.384687] [devices/nm-device.c:6986] nm_device_remove_pending_action(): [0x7fe080c3a3c0] (clat): remove_pending_action (2): 'queued state change to secondaries'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.394068] [devices/nm-device.c:7636] queued_set_state(): [0x7fe080c3a3c0] (clat): running queued state change to activated (id 5466)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): device state change: secondaries -> activated (reason 'none') [90 100 0]
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.394811] [nm-active-connection.c:476] check_master_ready(): (0x7fe080bbfa30): not signalling master-ready (not activating)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396225] [dns-manager/nm-dns-manager.c:1005] nm_dns_manager_begin_updates(): (device_state_changed): queueing DNS updates (1)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396283] [dns-manager/nm-dns-manager.c:1005] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (2)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  Policy set 'clat' (clat) as default for IPv4 routing and DNS.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396332] [nm-manager.c:4288] policy_default_device_changed(): PrimaryConnection now clat
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396373] [dns-manager/nm-dns-manager.c:1023] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396386] [dns-manager/nm-dns-manager.c:1027] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (1)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396397] [dns-manager/nm-dns-manager.c:1023] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396406] [dns-manager/nm-dns-manager.c:1027] nm_dns_manager_end_updates(): (device_state_changed): no DNS changes to commit (0)
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <info>  (clat): Activation: successful, device activated.
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.396439] [nm-dispatcher.c:443] _dispatcher_call(): (127) (clat) dispatching action 'up'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.400883] [devices/nm-device.c:6986] nm_device_remove_pending_action(): [0x7fe080c3a3c0] (clat): remove_pending_action (1): 'queued state change to activated'
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.552885] [nm-dispatcher.c:303] dispatcher_results_process(): (127) 00-netreport succeeded
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.552944] [nm-dispatcher.c:303] dispatcher_results_process(): (127) 04-iscsi succeeded
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.552954] [nm-dispatcher.c:303] dispatcher_results_process(): (127) 11-dhclient succeeded
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.552962] [nm-dispatcher.c:303] dispatcher_results_process(): (127) 20-chrony succeeded
des. 16 12:43:08 envy.fud.no NetworkManager[18536]: <debug> [1418730188.552970] [nm-dispatcher.c:303] dispatcher_results_process(): (127) 50-clatd succeeded
des. 16 12:43:10 envy.fud.no NetworkManager[18536]: <debug> [1418730190.736394] [devices/nm-device.c:5046] send_arps(): [0x7fe080c3a3c0] (clat): arping: run /usr/sbin/arping -U -q -I clat -c 1 192.0.0.1
des. 16 12:43:13 envy.fud.no NetworkManager[18536]: <debug> [1418730193.737367] [devices/nm-device.c:6986] nm_device_remove_pending_action(): [0x7fe080c3a3c0] (clat): remove_pending_action (0): 'carrier wait'
