Attachment 121682 Details for Bug 94093 – Network Manager Debug Log

Network Manager Debug Log

nm.log (text/plain), 149.51 KB, created by Aaron on 2016-02-11 17:18:41 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Aaron

Created: 2016-02-11 17:18:41 UTC

Size: 149.51 KB

patch

obsolete

>NetworkManager[824]: <info>  NetworkManager (version 1.0.10) is starting...
>NetworkManager[824]: <info>  Read config: /etc/NetworkManager/NetworkManager.conf
>NetworkManager[824]: <debug> [1455210469.737621] [nm-config-data.c:338] nm_config_data_log(): CONFIG: config-data[0x80cb00]: 2 groups
>NetworkManager[824]: <debug> [1455210469.737659] [nm-config-data.c:344] nm_config_data_log(): CONFIG:
>NetworkManager[824]: <debug> [1455210469.737687] [nm-config-data.c:345] nm_config_data_log(): CONFIG: [main]
>NetworkManager[824]: <debug> [1455210469.737719] [nm-config-data.c:353] nm_config_data_log(): CONFIG:   plugins=ifupdown
>NetworkManager[824]: <debug> [1455210469.737750] [nm-config-data.c:353] nm_config_data_log(): CONFIG:   dhcp=internal
>NetworkManager[824]: <debug> [1455210469.737779] [nm-config-data.c:344] nm_config_data_log(): CONFIG:
>NetworkManager[824]: <debug> [1455210469.737808] [nm-config-data.c:345] nm_config_data_log(): CONFIG: [ifupdown]
>NetworkManager[824]: <debug> [1455210469.737839] [nm-config-data.c:353] nm_config_data_log(): CONFIG:   managed=false
>NetworkManager[824]: <debug> [1455210469.737867] [main.c:456] main(): WEXT support is enabled
>NetworkManager[824]: <debug> [1455210469.737994] [nm-dbus-manager.c:208] private_server_new(): (private) creating private socket unix:path=/var/run/NetworkManager/private.
>NetworkManager[824]: <debug> [1455210469.738285] [nm-dbus-manager.c:108] nm_dbus_manager_setup(): create NMDBusManager singleton (0x813d00)
>NetworkManager[824]: <debug> [1455210469.743660] [platform/nm-linux-platform.c:4857] constructed(): platform-linux[0x819080]: create
>NetworkManager[824]: <debug> [1455210469.743794] [platform/nm-linux-platform.c:4862] constructed(): platform-linux: Netlink socket for requests established: port=985662264, fd=8
>NetworkManager[824]: <debug> [1455210469.743865] [platform/nm-linux-platform.c:4879] constructed(): platform-linux: Netlink socket for events established: port=1568670520, fd=9
>NetworkManager[824]: <debug> [1455210469.744170] [platform/nm-platform.c:142] nm_platform_setup(): setup NMPlatform singleton (0x819080, NMLinuxPlatform)
>NetworkManager[824]: <debug> [1455210469.744210] [platform/nm-linux-platform.c:4900] constructed(): platform-linux: populate platform cache
>NetworkManager[824]: <debug> [1455210469.744758] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.744906] [platform/nm-platform.c:2896] log_link(): platform: signal: link   added: 1: lo <UP,LOWER_UP;loopback,up,running,lowerup> mtu 65536 arp 772 loopback not-init addr 00:00:00:00:00:00 driver unknown
>NetworkManager[824]: <debug> [1455210469.745051] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.745250] [platform/nm-platform.c:2896] log_link(): platform: signal: link   added: 2: sit0 <NOARP,DOWN;noarp> mtu 1480 arp 776 unknown/sit not-init addr 00:00:00:00 driver sit
>NetworkManager[824]: <debug> [1455210469.745505] [platform/nm-platform.c:2896] log_link(): platform: signal: link   added: 3: eth0 <UP,LOWER_UP;broadcast,multicast,up,running,lowerup> mtu 1500 arp 1 ethernet not-init addr 00:13:95:19:6B:3C driver igb
>NetworkManager[824]: <debug> [1455210469.745810] [platform/nm-platform.c:2896] log_link(): platform: signal: link   added: 4: wlan0 <DOWN;broadcast,multicast> mtu 1500 arp 1 wifi not-init addr 44:C3:06:20:22:18 driver ath9k
>NetworkManager[824]: <debug> [1455210469.746007] [NetworkManagerUtils.c:2320] monotonic_timestamp_get(): monotonic timestamp started counting 1.475471102 seconds ago with an offset of 1667.0 seconds to CLOCK_BOOTTIME (local time is 2016-02-11 17:07:49)
>NetworkManager[824]: <debug> [1455210469.746069] [platform/nm-platform.c:2902] log_ip4_address(): platform: signal: address 4   added: 127.0.0.1/8 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 1 src kernel
>NetworkManager[824]: <debug> [1455210469.746150] [platform/nm-platform.c:2902] log_ip4_address(): platform: signal: address 4   added: 172.23.1.20/22 lft 689722sec pref 689722sec lifetime 1-1[689722,689722] dev 3 src kernel
>NetworkManager[824]: <debug> [1455210469.746282] [platform/nm-platform.c:2908] log_ip6_address(): platform: signal: address 6   added: ::1/128 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 1 flags permanent src kernel
>NetworkManager[824]: <debug> [1455210469.746596] [platform/nm-platform.c:2908] log_ip6_address(): platform: signal: address 6   added: fe80::213:95ff:fe19:6b3c/64 lft forever pref forever lifetime 1-0[4294967295,4294967295] dev 3 flags permanent src kernel
>NetworkManager[824]: <debug> [1455210469.747162] [platform/nm-platform.c:2914] log_ip4_route(): platform: signal: route   4   added: 0.0.0.0/0 via 172.23.0.1 dev 3 metric 100 mss 0 src user scope global
>NetworkManager[824]: <debug> [1455210469.747449] [platform/nm-platform.c:2914] log_ip4_route(): platform: signal: route   4   added: 172.23.0.0/22 via 0.0.0.0 dev 3 metric 100 mss 0 src rtprot-kernel scope link pref-src 172.23.1.20
>NetworkManager[824]: <debug> [1455210469.747995] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6   added: fe80::/64 via :: dev 3 metric 256 mss 0 src rtprot-kernel
>NetworkManager[824]: <debug> [1455210469.748276] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6   added: ff00::/8 via :: dev 3 metric 256 mss 0 src user
>NetworkManager[824]: <debug> [1455210469.750417] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 4: wlan0 <DOWN;broadcast,multicast> mtu 1500 arp 1 wifi init addr 44:C3:06:20:22:18 driver ath9k
>NetworkManager[824]: <debug> [1455210469.750806] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 3: eth0 <UP,LOWER_UP;broadcast,multicast,up,running,lowerup> mtu 1500 arp 1 ethernet init addr 00:13:95:19:6B:3C driver igb
>NetworkManager[824]: <debug> [1455210469.751084] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.751159] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 1: lo <UP,LOWER_UP;loopback,up,running,lowerup> mtu 65536 arp 772 loopback init addr 00:00:00:00:00:00 driver unknown
>NetworkManager[824]: <debug> [1455210469.751423] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 2: sit0 <NOARP,DOWN;noarp> mtu 1480 arp 776 unknown/sit init addr 00:00:00:00 driver sit
>NetworkManager[824]: <debug> [1455210469.751580] [nm-auth-manager.c:549] constructed(): auth[0x8098e0]: create auth-manager: polkit enabled
>NetworkManager[824]: <debug> [1455210469.752315] [nm-auth-manager.c:497] nm_auth_manager_setup(): auth[0x8098e0]: set instance
>NetworkManager[824]: <debug> [1455210469.752836] [nm-dispatcher.c:746] dispatcher_dir_changed(): dispatcher: default script directory '/etc/NetworkManager/dispatcher.d' has scripts
>NetworkManager[824]: <debug> [1455210469.752965] [nm-dispatcher.c:748] dispatcher_dir_changed(): dispatcher: pre-up script directory '/etc/NetworkManager/dispatcher.d/pre-up.d' has no scripts
>NetworkManager[824]: <debug> [1455210469.753060] [nm-dispatcher.c:748] dispatcher_dir_changed(): dispatcher: pre-down script directory '/etc/NetworkManager/dispatcher.d/pre-down.d' has no scripts
>NetworkManager[824]: <debug> [1455210469.753722] [settings/nm-agent-manager.c:1561] nm_agent_manager_get(): create NMAgentManager singleton (0x80db00)
>NetworkManager[824]: <info>  init!
>NetworkManager[824]: <debug> [1455210469.755277] [settings/nm-inotify-helper.c:153] nm_inotify_helper_get(): create NMInotifyHelper singleton (0x830960)
>NetworkManager[824]: <info>  update_system_hostname
>NetworkManager[824]: <warn>  interfaces file /etc/network/interfaces doesn't exist
>NetworkManager[824]: <info>  management mode: unmanaged
>NetworkManager[824]: <info>  devices added (path: /sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0/net/wlan0, iface: wlan0)
>NetworkManager[824]: <info>  device added (path: /sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0/net/wlan0, iface: wlan0): no ifupdown configuration found.
>NetworkManager[824]: <info>  devices added (path: /sys/devices/pci0000:00/0000:00:1c.3/0000:08:00.0/net/eth0, iface: eth0)
>NetworkManager[824]: <info>  device added (path: /sys/devices/pci0000:00/0000:00:1c.3/0000:08:00.0/net/eth0, iface: eth0): no ifupdown configuration found.
>NetworkManager[824]: <info>  devices added (path: /sys/devices/virtual/net/lo, iface: lo)
>NetworkManager[824]: <info>  device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
>NetworkManager[824]: <info>  devices added (path: /sys/devices/virtual/net/sit0, iface: sit0)
>NetworkManager[824]: <info>  device added (path: /sys/devices/virtual/net/sit0, iface: sit0): no ifupdown configuration found.
>NetworkManager[824]: <info>  end _init.
>NetworkManager[824]: <info>  Loaded settings plugin ifupdown: (C) 2008 Canonical Ltd.  To report bugs please use the NetworkManager mailing list. (/usr/lib/NetworkManager/libnm-settings-plugin-ifupdown.so)
>NetworkManager[824]: <info>  Loaded settings plugin keyfile: (c) 2007 - 2015 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>NetworkManager[824]: <info>  (8585024) ... get_connections.
>NetworkManager[824]: <info>  (8585024) ... get_connections (managed=false): return empty list.
>NetworkManager[824]: <debug> [1455210469.761110] [settings/plugins/keyfile/plugin.c:171] update_connection(): keyfile: loading from file "/etc/NetworkManager/system-connections/Wired connection 1"...
>NetworkManager[824]: <debug> [1455210469.787458] [settings/nm-settings-connection.c:2301] constructed(): settings-connection[0x8193a0]: constructed (NMKeyfileConnection)
>NetworkManager[824]: <debug> [1455210469.788021] [settings/nm-settings-connection.c:517] nm_settings_connection_replace_settings(): settings-connection[0x8193a0,177b570e-07b6-495a-98bc-c17c3a676eb2]: replace settings from connection 0x81aa80 (Wired connection 1)
>NetworkManager[824]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/Wired connection 1 (177b570e-07b6-495a-98bc-c17c3a676eb2,"Wired connection 1")
>NetworkManager[824]: <debug> [1455210469.788764] [settings/plugins/keyfile/plugin.c:171] update_connection(): keyfile: loading from file "/etc/NetworkManager/system-connections/mobilecon"...
>NetworkManager[824]: <debug> [1455210469.814007] [settings/nm-settings-connection.c:2301] constructed(): settings-connection[0x83f2a0]: constructed (NMKeyfileConnection)
>NetworkManager[824]: <debug> [1455210469.814587] [settings/nm-settings-connection.c:517] nm_settings_connection_replace_settings(): settings-connection[0x83f2a0,41ece17e-cc54-11e5-ad21-001395196b3c]: replace settings from connection 0x81ab00 (mobilecon)
>NetworkManager[824]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/mobilecon (41ece17e-cc54-11e5-ad21-001395196b3c,"mobilecon")
>NetworkManager[824]: <debug> [1455210469.815921] [NetworkManagerUtils.c:2630] nm_utils_log_connection_diff(): ++ connection 'new connection' (0x83f2a0/NMKeyfileConnection): [/org/freedesktop/NetworkManager/Settings/0]
>NetworkManager[824]: <debug> [1455210469.815991] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ connection                [ 0x83f340 ]
>NetworkManager[824]: <debug> [1455210469.816027] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.id             = 'mobilecon'
>NetworkManager[824]: <debug> [1455210469.816083] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.permissions    = []
>NetworkManager[824]: <debug> [1455210469.816125] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.secondaries    = []
>NetworkManager[824]: <debug> [1455210469.816166] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.type           = 'gsm'
>NetworkManager[824]: <debug> [1455210469.816207] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.uuid           = '41ece17e-cc54-11e5-ad21-001395196b3c'
>NetworkManager[824]: <debug> [1455210469.816249] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ gsm                       [ 0x83caf0 ]
>NetworkManager[824]: <debug> [1455210469.816280] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ gsm.apn                   = 'broadband'
>NetworkManager[824]: <debug> [1455210469.816327] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ gsm.home-only             = TRUE
>NetworkManager[824]: <debug> [1455210469.816366] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ gsm.number                = '*99#'
>NetworkManager[824]: <debug> [1455210469.816444] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ serial                    [ 0x80dba0 ]
>NetworkManager[824]: <debug> [1455210469.816476] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ serial.baud               = 115200
>NetworkManager[824]: <debug> [1455210469.816575] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ ipv4                      [ 0x819260 ]
>NetworkManager[824]: <debug> [1455210469.816815] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.addresses            = ((GPtrArray*) 0x7f727c001960)
>NetworkManager[824]: <debug> [1455210469.817202] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.dns                  = []
>NetworkManager[824]: <debug> [1455210469.817592] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.dns-search           = []
>NetworkManager[824]: <debug> [1455210469.817960] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.method               = 'auto'
>NetworkManager[824]: <debug> [1455210469.818326] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.route-metric         = 700
>NetworkManager[824]: <debug> [1455210469.818711] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.routes               = ((GPtrArray*) 0x83d860)
>NetworkManager[824]: <debug> [1455210469.819135] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ ipv6                      [ 0x83f3e0 ]
>NetworkManager[824]: <debug> [1455210469.819451] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.addresses            = ((GPtrArray*) 0x81aac0)
>NetworkManager[824]: <debug> [1455210469.819850] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.dns                  = []
>NetworkManager[824]: <debug> [1455210469.820219] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.dns-search           = []
>NetworkManager[824]: <debug> [1455210469.820607] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.method               = 'ignore'
>NetworkManager[824]: <debug> [1455210469.820986] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.routes               = ((GPtrArray*) 0x80a2e0)
>NetworkManager[824]: <debug> [1455210469.821808] [NetworkManagerUtils.c:2630] nm_utils_log_connection_diff(): ++ connection 'new connection' (0x8193a0/NMKeyfileConnection): [/org/freedesktop/NetworkManager/Settings/1]
>NetworkManager[824]: <debug> [1455210469.821870] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ connection                [ 0x8194e0 ]
>NetworkManager[824]: <debug> [1455210469.822160] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.autoconnect-priority = -999
>NetworkManager[824]: <debug> [1455210469.822560] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.id             = 'Wired connection 1'
>NetworkManager[824]: <debug> [1455210469.822925] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.interface-name = 'eth0'
>NetworkManager[824]: <debug> [1455210469.823303] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.permissions    = []
>NetworkManager[824]: <debug> [1455210469.823685] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.secondaries    = []
>NetworkManager[824]: <debug> [1455210469.824052] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.timestamp      = 1454709791
>NetworkManager[824]: <debug> [1455210469.824410] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.type           = '802-3-ethernet'
>NetworkManager[824]: <debug> [1455210469.824808] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.uuid           = '177b570e-07b6-495a-98bc-c17c3a676eb2'
>NetworkManager[824]: <debug> [1455210469.825238] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ 802-3-ethernet            [ 0x819440 ]
>NetworkManager[824]: <debug> [1455210469.825623] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ 802-3-ethernet.mac-address = '00:13:95:19:6B:3C'
>NetworkManager[824]: <debug> [1455210469.826031] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ 802-3-ethernet.mac-address-blacklist = []
>NetworkManager[824]: <debug> [1455210469.826430] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ 802-3-ethernet.s390-options = ((GHashTable*) 0x7f727c004e40)
>NetworkManager[824]: <debug> [1455210469.826834] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ ipv4                      [ 0x819620 ]
>NetworkManager[824]: <debug> [1455210469.827193] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.addresses            = ((GPtrArray*) 0x81a8c0)
>NetworkManager[824]: <debug> [1455210469.827597] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.dns                  = []
>NetworkManager[824]: <debug> [1455210469.827965] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.dns-search           = []
>NetworkManager[824]: <debug> [1455210469.828330] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.method               = 'auto'
>NetworkManager[824]: <debug> [1455210469.828738] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.routes               = ((GPtrArray*) 0x83db20)
>NetworkManager[824]: <debug> [1455210469.829107] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ ipv6                      [ 0x819580 ]
>NetworkManager[824]: <debug> [1455210469.829467] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.addresses            = ((GPtrArray*) 0x83dc60)
>NetworkManager[824]: <debug> [1455210469.829877] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.dns                  = []
>NetworkManager[824]: <debug> [1455210469.830263] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.dns-search           = []
>NetworkManager[824]: <debug> [1455210469.830673] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.ip6-privacy          = ((NMSettingIP6ConfigPrivacy) NM_SETTING_IP6_CONFIG_PRIVACY_DISABLED)
>NetworkManager[824]: <debug> [1455210469.831034] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.method               = 'link-local'
>NetworkManager[824]: <debug> [1455210469.831403] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.routes               = ((GPtrArray*) 0x81a680)
>NetworkManager[824]: <info>  get unmanaged devices count: 0
>NetworkManager[824]: <debug> [1455210469.832713] [vpn-manager/nm-vpn-manager.c:203] nm_vpn_manager_get(): create NMVpnManager singleton (0x8098a0)
>NetworkManager[824]: <debug> [1455210469.833598] [nm-sleep-monitor-systemd.c:246] nm_sleep_monitor_get(): create NMSleepMonitor singleton (0x843920)
>NetworkManager[824]: <info>  monitoring kernel firmware directory '/lib/firmware'.
>NetworkManager[824]: <debug> [1455210469.834262] [nm-firewall-manager.c:354] nm_firewall_manager_init(): firewall is not running
>NetworkManager[824]: <debug> [1455210469.834982] [nm-firewall-manager.c:340] nm_firewall_manager_get(): create NMFirewallManager singleton (0x80dc80)
>NetworkManager[824]: <debug> [1455210469.835120] [dns-manager/nm-dns-manager.c:1077] nm_dns_manager_get(): create NMDnsManager singleton (0x83f160)
>NetworkManager[824]: <info>  rfkill0: found WiFi radio killswitch (at /sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0/ieee80211/phy0/rfkill0) (driver ath9k)
>NetworkManager[824]: <debug> [1455210469.836913] [nm-rfkill-manager.c:210] recheck_killswitches(): WiFi rfkill switch rfkill0 state now 1/0
>NetworkManager[824]: <info>  WiFi hardware radio set enabled
>NetworkManager[824]: <info>  WWAN hardware radio set enabled
>NetworkManager[824]: <info>  Loaded device plugin: NMBondFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMBridgeFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMEthernetFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMGreFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMInfinibandFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMMacvlanFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMTunFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMVethFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMVlanFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMVxlanFactory (internal)
>NetworkManager[824]: <info>  Loaded device plugin: NMBluezManager (/usr/lib/NetworkManager/libnm-device-plugin-bluetooth.so)
>NetworkManager[824]: <info>  Loaded device plugin: NMWwanFactory (/usr/lib/NetworkManager/libnm-device-plugin-wwan.so)
>NetworkManager[824]: <info>  Loaded device plugin: NMWifiFactory (/usr/lib/NetworkManager/libnm-device-plugin-wifi.so)
>NetworkManager[824]: <info>  Loaded device plugin: NMAtmManager (/usr/lib/NetworkManager/libnm-device-plugin-adsl.so)
>NetworkManager[824]: <info>  WiFi enabled by radio killswitch; enabled by state file
>NetworkManager[824]: <info>  WWAN enabled by radio killswitch; enabled by state file
>NetworkManager[824]: <info>  WiMAX enabled by radio killswitch; enabled by state file
>NetworkManager[824]: <info>  Networking is enabled by state file
>NetworkManager[824]: <debug> [1455210469.845180] [dhcp-manager/nm-dhcp-manager.c:391] nm_dhcp_manager_init(): Registered DHCP client 'dhclient' (NMDhcpDhclient)
>NetworkManager[824]: <debug> [1455210469.845213] [dhcp-manager/nm-dhcp-manager.c:391] nm_dhcp_manager_init(): Registered DHCP client 'dhcpcd' (NMDhcpDhcpcd)
>NetworkManager[824]: <debug> [1455210469.845242] [dhcp-manager/nm-dhcp-manager.c:391] nm_dhcp_manager_init(): Registered DHCP client 'internal' (NMDhcpSystemd)
>NetworkManager[824]: <debug> [1455210469.845271] [dhcp-manager/nm-dhcp-manager.c:407] nm_dhcp_manager_init(): Using DHCP client 'internal'
>NetworkManager[824]: <debug> [1455210469.845542] [dhcp-manager/nm-dhcp-manager.c:376] nm_dhcp_manager_get(): create NMDhcpManager singleton (0x7d9ae0)
>NetworkManager[824]: <debug> [1455210469.846581] [devices/nm-device.c:9069] constructor(): [0x85e5c0] (lo): constructor(): NMDeviceGeneric, kernel ifindex 1
>NetworkManager[824]: <debug> [1455210469.846778] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /sys/class/net/lo/phys_port_id: Failed to read from file '/sys/class/net/lo/phys_port_id': Operation not supported
>NetworkManager[824]: <debug> [1455210469.846870] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/sys/class/net/lo/dev_id': '0x0'
>NetworkManager[824]: <debug> [1455210469.847271] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.847718] [devices/nm-device.c:8885] nm_device_update_hw_address(): [0x85e5c0] (lo): hardware address now 00:00:00:00:00:00
>NetworkManager[824]: <debug> [1455210469.848037] [devices/nm-device.c:9138] constructed(): [0x85e5c0] (lo): read initial MAC address 00:00:00:00:00:00
>NetworkManager[824]: <debug> [1455210469.848438] [devices/nm-device.c:9151] constructed(): [0x85e5c0] (lo): unable to read permanent MAC address
>NetworkManager[824]: <info>  (lo): link connected
>NetworkManager[824]: <debug> [1455210469.849174] [devices/nm-device.c:9171] constructed(): [0x85e5c0] (lo): carrier is ON
>NetworkManager[824]: <info>  (lo): new Generic device (carrier: ON, driver: 'unknown', ifindex: 1)
>NetworkManager[824]: <debug> [1455210469.849940] [devices/nm-device.c:536] nm_device_dbus_export(): [0x85e5c0] (lo): exported as /org/freedesktop/NetworkManager/Devices/0
>NetworkManager[824]: <debug> [1455210469.850601] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210469.850843] [devices/nm-device.c:9069] constructor(): [0x861160] (eth0): constructor(): NMDeviceEthernet, kernel ifindex 3
>NetworkManager[824]: <debug> [1455210469.851256] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /sys/class/net/eth0/phys_port_id: Failed to read from file '/sys/class/net/eth0/phys_port_id': Operation not supported
>NetworkManager[824]: <debug> [1455210469.851577] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/sys/class/net/eth0/dev_id': '0x0'
>NetworkManager[824]: <debug> [1455210469.852175] [devices/nm-device.c:8885] nm_device_update_hw_address(): [0x861160] (eth0): hardware address now 00:13:95:19:6B:3C
>NetworkManager[824]: <debug> [1455210469.852352] [devices/nm-device.c:9138] constructed(): [0x861160] (eth0): read initial MAC address 00:13:95:19:6B:3C
>NetworkManager[824]: <debug> [1455210469.852806] [devices/nm-device.c:9148] constructed(): [0x861160] (eth0): read permanent MAC address 00:13:95:19:6B:3C
>NetworkManager[824]: <info>  (eth0): link connected
>NetworkManager[824]: <debug> [1455210469.853589] [devices/nm-device-ethernet.c:1584] get_link_speed(): [0x861160] (eth0): speed is now 1000 Mb/s
>NetworkManager[824]: <debug> [1455210469.853893] [devices/nm-device.c:9171] constructed(): [0x861160] (eth0): carrier is ON
>NetworkManager[824]: <info>  (eth0): new Ethernet device (carrier: ON, driver: 'igb', ifindex: 3)
>NetworkManager[824]: <debug> [1455210469.854681] [devices/nm-device.c:536] nm_device_dbus_export(): [0x861160] (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
>NetworkManager[824]: <debug> [1455210469.855928] [devices/nm-device.c:6563] nm_device_set_ip4_config(): [0x861160] (eth0): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/0)
>NetworkManager[824]: <debug> [1455210469.856014] [nm-default-route-manager.c:62] nm_default_route_manager_get(): create NMDefaultRouteManager singleton (0x80dd20)
>NetworkManager[824]: <debug> [1455210469.856068] [nm-default-route-manager.c:663] _entry_at_idx_update(): default-route: entry[0/dev:0x861160:eth0:1:-sync]: record:add    0.0.0.0/0 via 172.23.0.1 dev 3 metric 100 mss 0 src user scope global (100)
>NetworkManager[824]: <debug> [1455210469.856737] [devices/nm-device.c:6690] nm_device_set_ip6_config(): [0x861160] (eth0): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/0)
>NetworkManager[824]: <debug> [1455210469.857942] [NetworkManagerUtils.c:2216] nm_utils_match_connection(): Connection 'eth0' differs from candidate 'Wired connection 1' in ipv6.routes
>NetworkManager[824]: <debug> [1455210469.858006] [nm-manager.c:1605] get_existing_connection(): (eth0): generated connection 'eth0'
>NetworkManager[824]: <debug> [1455210469.858047] [settings/nm-settings.c:1061] nm_settings_add_connection(): Failed to add c7361bb2-01ec-46d5-91c9-755189a3daea/'eth0': (unknown)
>NetworkManager[824]: <debug> [1455210469.858108] [settings/nm-settings-connection.c:2301] constructed(): settings-connection[0x83f7a0]: constructed (NMKeyfileConnection)
>NetworkManager[824]: <debug> [1455210469.858873] [settings/nm-settings-connection.c:517] nm_settings_connection_replace_settings(): settings-connection[0x83f7a0,c7361bb2-01ec-46d5-91c9-755189a3daea]: replace settings from connection 0x86cc20 (eth0)
>NetworkManager[824]: <info>  keyfile: add connection in-memory (c7361bb2-01ec-46d5-91c9-755189a3daea,"eth0")
>NetworkManager[824]: <debug> [1455210469.859661] [settings/nm-settings-connection.c:1938] nm_settings_connection_read_and_fill_timestamp(): settings-connection[0x83f7a0,c7361bb2-01ec-46d5-91c9-755189a3daea]: failed to read connection timestamp: (3) Key file does not have key 'c7361bb2-01ec-46d5-91c9-755189a3daea' in group 'timestamps'
>NetworkManager[824]: <debug> [1455210469.860090] [NetworkManagerUtils.c:2630] nm_utils_log_connection_diff(): ++ connection 'new connection' (0x83f7a0/NMKeyfileConnection): [/org/freedesktop/NetworkManager/Settings/2]
>NetworkManager[824]: <debug> [1455210469.860180] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ connection                [ 0x869130 ]
>NetworkManager[824]: <debug> [1455210469.860370] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.autoconnect    = FALSE
>NetworkManager[824]: <debug> [1455210469.860792] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.id             = 'eth0'
>NetworkManager[824]: <debug> [1455210469.861156] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.interface-name = 'eth0'
>NetworkManager[824]: <debug> [1455210469.861541] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.permissions    = []
>NetworkManager[824]: <debug> [1455210469.861917] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.secondaries    = []
>NetworkManager[824]: <debug> [1455210469.862394] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.timestamp      = 1455210469
>NetworkManager[824]: <debug> [1455210469.862799] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.type           = '802-3-ethernet'
>NetworkManager[824]: <debug> [1455210469.863173] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ connection.uuid           = 'c7361bb2-01ec-46d5-91c9-755189a3daea'
>NetworkManager[824]: <debug> [1455210469.863574] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ 802-3-ethernet            [ 0x869090 ]
>NetworkManager[824]: <debug> [1455210469.863930] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ 802-3-ethernet.mac-address = '00:13:95:19:6B:3C'
>NetworkManager[824]: <debug> [1455210469.864325] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ 802-3-ethernet.mac-address-blacklist = []
>NetworkManager[824]: <debug> [1455210469.864710] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ 802-3-ethernet.s390-options = ((GHashTable*) 0x86dd20)
>NetworkManager[824]: <debug> [1455210469.865083] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ ipv4                      [ 0x869270 ]
>NetworkManager[824]: <debug> [1455210469.865439] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.addresses            = ((GPtrArray*) 0x86cda0)
>NetworkManager[824]: <debug> [1455210469.865847] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.dns                  = [\"172.23.0.10\", \"172.23.0.11\"]
>NetworkManager[824]: <debug> [1455210469.866218] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.dns-search           = []
>NetworkManager[824]: <debug> [1455210469.866620] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.method               = 'auto'
>NetworkManager[824]: <debug> [1455210469.866999] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.route-metric         = 100
>NetworkManager[824]: <debug> [1455210469.867375] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv4.routes               = ((GPtrArray*) 0x86d120)
>NetworkManager[824]: <debug> [1455210469.867764] [NetworkManagerUtils.c:2650] nm_utils_log_connection_diff(): ++ ipv6                      [ 0x8691d0 ]
>NetworkManager[824]: <debug> [1455210469.868126] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.addresses            = ((GPtrArray*) 0x86cd80)
>NetworkManager[824]: <debug> [1455210469.868505] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.dns                  = []
>NetworkManager[824]: <debug> [1455210469.868902] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.dns-search           = []
>NetworkManager[824]: <debug> [1455210469.869270] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.method               = 'link-local'
>NetworkManager[824]: <debug> [1455210469.869690] [NetworkManagerUtils.c:2659] nm_utils_log_connection_diff(): ++ ipv6.routes               = ((GPtrArray*) 0x86d0e0)
>NetworkManager[824]: <info>  (eth0): device state change: unmanaged -> unavailable (reason 'connection-assumed') [10 20 41]
>NetworkManager[824]: <debug> [1455210469.870824] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/eth0/accept_ra': '0'
>NetworkManager[824]: <debug> [1455210469.870921] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/eth0/accept_ra_defrtr': '0'
>NetworkManager[824]: <debug> [1455210469.871313] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/eth0/accept_ra_pinfo': '0'
>NetworkManager[824]: <debug> [1455210469.871719] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/eth0/accept_ra_rtr_pref': '0'
>NetworkManager[824]: <debug> [1455210469.872109] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/eth0/disable_ipv6': '0'
>NetworkManager[824]: <debug> [1455210469.872478] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/eth0/hop_limit': '64'
>NetworkManager[824]: <debug> [1455210469.872882] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/eth0/use_tempaddr': '0'
>NetworkManager[824]: <debug> [1455210469.873555] [nm-manager.c:1635] assume_connection(): (eth0): will attempt to assume connection
>NetworkManager[824]: <info>  (eth0): device state change: unavailable -> disconnected (reason 'connection-assumed') [20 30 41]
>NetworkManager[824]: <debug> [1455210469.874616] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x861160] (eth0): add_pending_action (1): 'activation::0x809180'
>NetworkManager[824]: <debug> [1455210469.874735] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x861160] (eth0): remove_pending_action (0): 'activation::0x809180'
>NetworkManager[824]: <info>  (eth0): Activation: starting connection 'eth0' (c7361bb2-01ec-46d5-91c9-755189a3daea)
>NetworkManager[824]: <debug> [1455210469.875261] [devices/nm-device.c:2779] nm_device_activate_schedule_stage1_device_prepare(): [0x861160] (eth0): Activation: Stage 1 of 5 (Device Prepare) scheduled...
>NetworkManager[824]: <debug> [1455210469.875880] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210469.876132] [devices/nm-device.c:9069] constructor(): [0x85e960] (sit0): constructor(): NMDeviceGeneric, kernel ifindex 2
>NetworkManager[824]: <debug> [1455210469.876503] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.876904] [platform/nm-platform-utils.c:345] nmp_utils_mii_supports_carrier_detect(): mii: SIOCGMIIPHY failed: Invalid argument (22) (sit0)
>NetworkManager[824]: <debug> [1455210469.877251] [platform/nm-platform-utils.c:363] nmp_utils_mii_supports_carrier_detect(): mii: MII not supported (sit0)
>NetworkManager[824]: <debug> [1455210469.877696] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /sys/class/net/sit0/phys_port_id: Failed to read from file '/sys/class/net/sit0/phys_port_id': Operation not supported
>NetworkManager[824]: <debug> [1455210469.878050] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/sys/class/net/sit0/dev_id': '0x0'
>NetworkManager[824]: <debug> [1455210469.878434] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.878847] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.879225] [platform/nm-platform-utils.c:345] nmp_utils_mii_supports_carrier_detect(): mii: SIOCGMIIPHY failed: Invalid argument (22) (sit0)
>NetworkManager[824]: <debug> [1455210469.879588] [platform/nm-platform-utils.c:363] nmp_utils_mii_supports_carrier_detect(): mii: MII not supported (sit0)
>NetworkManager[824]: <debug> [1455210469.880000] [devices/nm-device.c:8885] nm_device_update_hw_address(): [0x85e960] (sit0): hardware address now 00:00:00:00
>NetworkManager[824]: <debug> [1455210469.880349] [devices/nm-device.c:9138] constructed(): [0x85e960] (sit0): read initial MAC address 00:00:00:00
>NetworkManager[824]: <debug> [1455210469.880763] [devices/nm-device.c:9151] constructed(): [0x85e960] (sit0): unable to read permanent MAC address
>NetworkManager[824]: <info>  (sit0): new Generic device (carrier: UNKNOWN, driver: 'sit', ifindex: 2)
>NetworkManager[824]: <debug> [1455210469.881489] [devices/nm-device.c:536] nm_device_dbus_export(): [0x85e960] (sit0): exported as /org/freedesktop/NetworkManager/Devices/2
>NetworkManager[824]: <debug> [1455210469.882078] [devices/nm-device.c:6563] nm_device_set_ip4_config(): [0x85e960] (sit0): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/1)
>NetworkManager[824]: <debug> [1455210469.882397] [devices/nm-device.c:6690] nm_device_set_ip6_config(): [0x85e960] (sit0): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/1)
>NetworkManager[824]: <debug> [1455210469.882718] [devices/nm-device.c:2279] nm_device_generate_connection(): [0x85e960] (sit0): device has no existing configuration
>NetworkManager[824]: <debug> [1455210469.883074] [nm-manager.c:1692] recheck_assume_connection(): (sit0): can't assume; no connection
>NetworkManager[824]: <debug> [1455210469.883667] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210469.884039] [devices/nm-device.c:9069] constructor(): [0x8777f0] (wlan0): constructor(): NMDeviceWifi, kernel ifindex 4
>NetworkManager[824]: <debug> [1455210469.884339] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /sys/class/net/wlan0/phys_port_id: Failed to read from file '/sys/class/net/wlan0/phys_port_id': Operation not supported
>NetworkManager[824]: <debug> [1455210469.884713] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/sys/class/net/wlan0/dev_id': '0x0'
>NetworkManager[824]: <debug> [1455210469.885468] [platform/wifi/wifi-utils-nl80211.c:820] nl80211_wiphy_info_handler(): Don't know the meaning of NL80211_ATTR_CIPHER_SUITE 0x000fac0a.
>NetworkManager[824]: <debug> [1455210469.885536] [platform/wifi/wifi-utils-nl80211.c:820] nl80211_wiphy_info_handler(): Don't know the meaning of NL80211_ATTR_CIPHER_SUITE 0x000fac09.
>NetworkManager[824]: <debug> [1455210469.885868] [platform/wifi/wifi-utils-nl80211.c:820] nl80211_wiphy_info_handler(): Don't know the meaning of NL80211_ATTR_CIPHER_SUITE 0x000fac0d.
>NetworkManager[824]: <debug> [1455210469.886246] [platform/wifi/wifi-utils-nl80211.c:820] nl80211_wiphy_info_handler(): Don't know the meaning of NL80211_ATTR_CIPHER_SUITE 0x000fac0b.
>NetworkManager[824]: <debug> [1455210469.886623] [platform/wifi/wifi-utils-nl80211.c:820] nl80211_wiphy_info_handler(): Don't know the meaning of NL80211_ATTR_CIPHER_SUITE 0x000fac0c.
>NetworkManager[824]: <info>  (wlan0): using nl80211 for WiFi device control
>NetworkManager[824]: <info>  (wlan0): driver supports Access Point (AP) mode
>NetworkManager[824]: <debug> [1455210469.887892] [supplicant-manager/nm-supplicant-manager.c:321] nm_supplicant_manager_get(): create NMSupplicantManager singleton (0x80de10)
>NetworkManager[824]: <debug> [1455210469.888177] [devices/nm-device.c:8885] nm_device_update_hw_address(): [0x8777f0] (wlan0): hardware address now 44:C3:06:20:22:18
>NetworkManager[824]: <debug> [1455210469.888561] [devices/nm-device.c:9138] constructed(): [0x8777f0] (wlan0): read initial MAC address 44:C3:06:20:22:18
>NetworkManager[824]: <debug> [1455210469.888982] [devices/nm-device.c:9148] constructed(): [0x8777f0] (wlan0): read permanent MAC address 44:C3:06:20:22:18
>NetworkManager[824]: <debug> [1455210469.889441] [nm-manager.c:1363] manager_rfkill_update_one_type(): WiFi hw-enabled 1 sw-enabled 1
>NetworkManager[824]: <debug> [1455210469.889712] [devices/wifi/nm-device-wifi.c:3154] set_enabled(): [0x8777f0] (wlan0): device now enabled
>NetworkManager[824]: <debug> [1455210469.890085] [devices/wifi/nm-device-wifi.c:3159] set_enabled(): [0x8777f0] (wlan0): (enable): device blocked by UNMANAGED state
>NetworkManager[824]: <info>  (wlan0): new 802.11 WiFi device (carrier: UNKNOWN, driver: 'ath9k', ifindex: 4)
>NetworkManager[824]: <debug> [1455210469.890845] [devices/nm-device.c:536] nm_device_dbus_export(): [0x8777f0] (wlan0): exported as /org/freedesktop/NetworkManager/Devices/3
>NetworkManager[824]: <debug> [1455210469.891400] [devices/nm-device.c:6563] nm_device_set_ip4_config(): [0x8777f0] (wlan0): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/2)
>NetworkManager[824]: <debug> [1455210469.891742] [devices/nm-device.c:6690] nm_device_set_ip6_config(): [0x8777f0] (wlan0): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/2)
>NetworkManager[824]: <debug> [1455210469.892039] [nm-manager.c:1692] recheck_assume_connection(): (wlan0): can't assume; no connection
>NetworkManager[824]: <info>  (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
>NetworkManager[824]: <debug> [1455210469.892862] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/wlan0/accept_ra': '1'
>NetworkManager[824]: <debug> [1455210469.893207] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/wlan0/accept_ra_defrtr': '1'
>NetworkManager[824]: <debug> [1455210469.893617] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/wlan0/accept_ra_pinfo': '1'
>NetworkManager[824]: <debug> [1455210469.893991] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/wlan0/accept_ra_rtr_pref': '1'
>NetworkManager[824]: <debug> [1455210469.894357] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6': '0'
>NetworkManager[824]: <debug> [1455210469.894755] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/wlan0/hop_limit': '64'
>NetworkManager[824]: <debug> [1455210469.895126] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr': '0'
>NetworkManager[824]: <debug> [1455210469.895549] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '1' (current value is '0')
>NetworkManager[824]: <debug> [1455210469.895927] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_defrtr' to '0' (current value is '1')
>NetworkManager[824]: <debug> [1455210469.896283] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_pinfo' to '0' (current value is '1')
>NetworkManager[824]: <debug> [1455210469.896680] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_rtr_pref' to '0' (current value is '1')
>NetworkManager[824]: <debug> [1455210469.897051] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210469.897383] [devices/nm-device.c:7078] nm_device_bring_up(): [0x8777f0] (wlan0): bringing up device.
>NetworkManager[824]: <debug> [1455210469.897758] [platform/nm-platform.c:1118] nm_platform_link_set_up(): platform: link: setting up 'wlan0' (4)
>NetworkManager[824]: <debug> [1455210469.898152] [platform/nm-linux-platform.c:2960] link_change_flags(): platform-linux: link: change 4: flags set 'up' (1)
>NetworkManager[824]: <debug> [1455210469.910616] [platform/nm-linux-platform.c:2820] do_change_link(): platform-linux: do-change-link: success changing link 4
>NetworkManager[824]: <debug> [1455210469.910908] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 4: wlan0 <UP;broadcast,multicast,up> mtu 1500 arp 1 wifi init addr 44:C3:06:20:22:18 driver ath9k
>NetworkManager[824]: <debug> [1455210469.910972] [devices/nm-device.c:1576] link_changed_cb(): [0x8777f0] (wlan0): queued link change for ifindex 4
>NetworkManager[824]: <debug> [1455210469.911210] [devices/nm-device.c:8156] nm_device_cleanup(): [0x8777f0] (wlan0): preparing device
>NetworkManager[824]: <debug> [1455210469.911267] [devices/nm-device.c:5914] nm_device_queued_ip_config_change_clear(): [0x8777f0] (wlan0): clearing queued IP4 config change
>NetworkManager[824]: <debug> [1455210469.911301] [devices/nm-device.c:5919] nm_device_queued_ip_config_change_clear(): [0x8777f0] (wlan0): clearing queued IP6 config change
>NetworkManager[824]: <debug> [1455210469.911335] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210469.911365] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210469.911459] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '1' (current value is identical)
>NetworkManager[824]: <debug> [1455210469.911569] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra' to '0' (current value is '1')
>NetworkManager[824]: <debug> [1455210469.911660] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210469.911710] [devices/nm-device.c:8913] nm_device_set_hw_addr(): [0x8777f0] (wlan0): no MAC address change needed
>NetworkManager[824]: <debug> [1455210469.911835] [nm-route-manager.c:78] nm_route_manager_get(): create NMRouteManager singleton (0x86b580)
>NetworkManager[824]: <debug> [1455210469.911878] [nm-route-manager.c:467] _vx_route_sync(): route-mgr4:   4: sync 0 IPv4 routes
>NetworkManager[824]: <debug> [1455210469.911917] [nm-route-manager.c:467] _vx_route_sync(): route-mgr6:   4: sync 0 IPv6 routes
>NetworkManager[824]: <debug> [1455210469.912046] [nm-default-route-manager.c:663] _entry_at_idx_update(): default-route: entry[1/dev:0x8777f0:wlan0:0:+sync]: record:add    0.0.0.0/0 via 0.0.0.0 dev 4 metric 4294967295 mss 0 src unknown (4294967295)
>NetworkManager[824]: <debug> [1455210469.912439] [nm-default-route-manager.c:663] _entry_at_idx_update(): default-route: entry[0/dev:0x8777f0:wlan0:0:+sync]: record:add    ::/0 via :: dev 4 metric 4294967295 mss 0 src unknown (4294967295)
>NetworkManager[824]: <debug> [1455210469.912853] [nm-default-route-manager.c:684] _entry_at_idx_remove(): default-route: entry[1/dev:0x8777f0:wlan0:0:+sync]: record:remove 0.0.0.0/0 via 0.0.0.0 dev 4 metric 4294967295 mss 0 src unknown (4294967295)
>NetworkManager[824]: <debug> [1455210469.913229] [nm-default-route-manager.c:684] _entry_at_idx_remove(): default-route: entry[0/dev:0x8777f0:wlan0:0:+sync]: record:remove ::/0 via :: dev 4 metric 4294967295 mss 0 src unknown (4294967295)
>NetworkManager[824]: <debug> [1455210469.913595] [devices/nm-device.c:6569] nm_device_set_ip4_config(): [0x8777f0] (wlan0): clear IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/2)
>NetworkManager[824]: <debug> [1455210469.914015] [devices/nm-device.c:6696] nm_device_set_ip6_config(): [0x8777f0] (wlan0): clear IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/2)
>NetworkManager[824]: <debug> [1455210469.914665] [supplicant-manager/nm-supplicant-manager.c:84] nm_supplicant_manager_iface_get(): (wlan0): creating new supplicant interface
>NetworkManager[824]: <debug> [1455210469.914865] [supplicant-manager/nm-supplicant-interface.c:832] interface_add(): (wlan0): adding interface to supplicant
>NetworkManager[824]: <debug> [1455210469.915256] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'waiting for supplicant'
>NetworkManager[824]: <debug> [1455210469.915615] [devices/nm-device.c:8608] _set_state_full(): [0x8777f0] (wlan0): device not yet available for transition to DISCONNECTED
>NetworkManager[824]: <debug> [1455210469.916211] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210469.916377] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210469.916772] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of wlan0
>NetworkManager[824]: <debug> [1455210469.917128] [main.c:512] main(): setting up local loopback
>NetworkManager[824]: <debug> [1455210469.917510] [platform/nm-platform.c:1118] nm_platform_link_set_up(): platform: link: setting up 'lo' (1)
>NetworkManager[824]: <debug> [1455210469.917910] [platform/nm-linux-platform.c:2960] link_change_flags(): platform-linux: link: change 1: flags set 'up' (1)
>NetworkManager[824]: <debug> [1455210469.918323] [platform/nm-linux-platform.c:2820] do_change_link(): platform-linux: do-change-link: success changing link 1
>NetworkManager[824]: <debug> [1455210469.918810] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210469.926492] [nm-sleep-monitor-systemd.c:109] take_inhibitor(): Taking systemd sleep inhibitor
>NetworkManager[824]: <debug> [1455210469.927396] [devices/bluetooth/nm-bluez-manager.c:240] check_bluez_and_try_setup_final_step(): 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
>NetworkManager[824]: <debug> [1455210469.927755] [nm-auth-manager.c:357] _log_name_owner(): auth: dbus name owner: ':1.7'
>NetworkManager[824]: <debug> [1455210469.927801] [nm-auth-manager.c:345] _emit_changed_signal(): auth: emit changed signal
>NetworkManager[824]: <debug> [1455210469.928943] [devices/nm-device.c:6563] nm_device_set_ip4_config(): [0x85e5c0] (lo): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/3)
>NetworkManager[824]: <debug> [1455210469.929041] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210469.929088] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210469.929118] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip4_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210469.929312] [devices/nm-device.c:6690] nm_device_set_ip6_config(): [0x85e5c0] (lo): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/3)
>NetworkManager[824]: <debug> [1455210469.929372] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip6_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210469.929413] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210469.929442] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip6_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210469.931124] [devices/nm-device.c:2550] recheck_available(): [0x861160] (eth0): device is available, will transition to unknown
>NetworkManager[824]: <debug> [1455210469.931313] [devices/nm-device.c:2738] nm_device_activate_stage1_device_prepare(): [0x861160] (eth0): Activation: Stage 1 of 5 (Device Prepare) started...
>NetworkManager[824]: <info>  (eth0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>NetworkManager[824]: <debug> [1455210469.931544] [nm-active-connection.c:518] check_master_ready(): active-connection[0x809180]: not signalling master-ready (no master)
>NetworkManager[824]: <debug> [1455210469.931635] [nm-manager.c:4398] policy_activating_device_changed(): ActivatingConnection now eth0
>NetworkManager[824]: <debug> [1455210469.931686] [devices/nm-device.c:2898] nm_device_activate_schedule_stage2_device_config(): [0x861160] (eth0): Activation: Stage 2 of 5 (Device Configure) scheduled...
>NetworkManager[824]: <debug> [1455210469.931717] [devices/nm-device.c:2756] nm_device_activate_stage1_device_prepare(): [0x861160] (eth0): Activation: Stage 1 of 5 (Device Prepare) complete.
>NetworkManager[824]: <debug> [1455210469.932112] [devices/nm-device.c:2514] nm_device_emit_recheck_assume(): [0x85e960] (sit0): emit RECHECK_ASSUME signal
>NetworkManager[824]: <debug> [1455210469.932325] [devices/nm-device.c:2279] nm_device_generate_connection(): [0x85e960] (sit0): device has no existing configuration
>NetworkManager[824]: <debug> [1455210469.932361] [nm-manager.c:1692] recheck_assume_connection(): (sit0): can't assume; no connection
>NetworkManager[824]: <debug> [1455210469.932954] [nm-sleep-monitor-systemd.c:98] inhibit_done(): Inhibitor fd is 21
>NetworkManager[824]: <info>  wpa_supplicant running
>NetworkManager[824]: <debug> [1455210469.933757] [supplicant-manager/nm-supplicant-manager.c:174] update_capabilities(): AP mode is supported
>NetworkManager[824]: <debug> [1455210469.933811] [supplicant-manager/nm-supplicant-manager.c:189] update_capabilities(): EAP-FAST is not supported
>NetworkManager[824]: <debug> [1455210469.934078] [devices/nm-device.c:2514] nm_device_emit_recheck_assume(): [0x85e5c0] (lo): emit RECHECK_ASSUME signal
>NetworkManager[824]: <debug> [1455210469.934582] [devices/nm-device.c:2810] nm_device_activate_stage2_device_config(): [0x861160] (eth0): Activation: Stage 2 of 5 (Device Configure) starting...
>NetworkManager[824]: <info>  (eth0): device state change: prepare -> config (reason 'none') [40 50 0]
>NetworkManager[824]: <debug> [1455210469.934837] [devices/nm-device.c:2845] nm_device_activate_stage2_device_config(): [0x861160] (eth0): Activation: Stage 2 of 5 (Device Configure) successful.
>NetworkManager[824]: <debug> [1455210469.934980] [devices/nm-device.c:5470] nm_device_activate_schedule_stage3_ip_config_start(): [0x861160] (eth0): Activation: skip setting firewall zone 'default' for assumed device
>NetworkManager[824]: <debug> [1455210469.935361] [devices/nm-device.c:5472] nm_device_activate_schedule_stage3_ip_config_start(): [0x861160] (eth0): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
>NetworkManager[824]: <debug> [1455210469.936915] [devices/nm-device.c:2850] nm_device_activate_stage2_device_config(): [0x861160] (eth0): Activation: Stage 2 of 5 (Device Configure) complete.
>NetworkManager[824]: <debug> [1455210469.937146] [devices/nm-device.c:5375] nm_device_activate_stage3_ip_config_start(): [0x861160] (eth0): Activation: Stage 3 of 5 (IP Configure Start) started...
>NetworkManager[824]: <info>  (eth0): device state change: config -> ip-config (reason 'none') [50 70 0]
>NetworkManager[824]: <info>  Activation (eth0) Beginning DHCPv4 transaction (timeout in 45 seconds)
>NetworkManager[824]: <debug> [1455210469.937826] [sd-dhcp-client.c:1620] sd_dhcp_client_start(): DHCP CLIENT (0x198b2a56): STARTED on ifindex 3
>NetworkManager[824]: <debug> [1455210469.938103] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x861160] (eth0): add_pending_action (1): 'dhcp4'
>NetworkManager[824]: <debug> [1455210469.938487] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of eth0
>NetworkManager[824]: <debug> [1455210469.938969] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/eth0/disable_ipv6' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210469.939371] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/default/use_tempaddr': '0'
>NetworkManager[824]: <debug> [1455210469.939769] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/eth0/use_tempaddr' to '0' (current value is identical)
>NetworkManager[824]: <info>  (eth0): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
>NetworkManager[824]: <debug> [1455210469.940680] [nm-dispatcher.c:444] _dispatcher_call(): (1) (eth0) dispatching action 'pre-up' (with callback)
>NetworkManager[824]: <debug> [1455210469.940903] [nm-dispatcher.c:455] _dispatcher_call(): (1) simulate request; no scripts in /etc/NetworkManager/dispatcher.d/pre-up.d
>NetworkManager[824]: <debug> [1455210469.941342] [devices/nm-device.c:5415] nm_device_activate_stage3_ip_config_start(): [0x861160] (eth0): Activation: Stage 3 of 5 (IP Configure Start) complete.
>NetworkManager[824]: <debug> [1455210469.941769] [sd-dhcp-client.c:610] client_send_discover(): DHCP CLIENT (0x198b2a56): DISCOVER
>NetworkManager[824]: <debug> [1455210469.942178] [supplicant-manager/nm-supplicant-interface.c:676] interface_add_done(): (wlan0): interface added to supplicant
>NetworkManager[824]: <info>  ModemManager available in the bus
>NetworkManager[824]: <debug> [1455210469.943918] [devices/nm-device.c:9069] constructor(): [0x88e5a0] (ttyACM3): constructor(): NMDeviceModem, kernel ifindex 0
>NetworkManager[824]: <debug> [1455210469.944192] [nm-manager.c:1363] manager_rfkill_update_one_type(): WWAN hw-enabled 1 sw-enabled 1
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'disabled' --> 'enabling' (reason: user preference)
>NetworkManager[824]: <info>  (ttyACM3): new Broadband device (carrier: UNKNOWN, driver: 'cdc_acm', ifindex: 0)
>NetworkManager[824]: <debug> [1455210469.945276] [devices/nm-device.c:536] nm_device_dbus_export(): [0x88e5a0] (ttyACM3): exported as /org/freedesktop/NetworkManager/Devices/4
>NetworkManager[824]: <debug> [1455210469.945405] [nm-manager.c:1692] recheck_assume_connection(): (ttyACM3): can't assume; no connection
>NetworkManager[824]: <info>  (ttyACM3): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
>NetworkManager[824]: <debug> [1455210469.945989] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /proc/sys/net/ipv6/conf/ttyACM3/accept_ra: Failed to open file '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra': No such file or directory
>NetworkManager[824]: <debug> [1455210469.946320] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /proc/sys/net/ipv6/conf/ttyACM3/accept_ra_defrtr: Failed to open file '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_defrtr': No such file or directory
>NetworkManager[824]: <debug> [1455210469.946710] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /proc/sys/net/ipv6/conf/ttyACM3/accept_ra_pinfo: Failed to open file '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_pinfo': No such file or directory
>NetworkManager[824]: <debug> [1455210469.947079] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /proc/sys/net/ipv6/conf/ttyACM3/accept_ra_rtr_pref: Failed to open file '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_rtr_pref': No such file or directory
>NetworkManager[824]: <debug> [1455210469.947464] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /proc/sys/net/ipv6/conf/ttyACM3/disable_ipv6: Failed to open file '/proc/sys/net/ipv6/conf/ttyACM3/disable_ipv6': No such file or directory
>NetworkManager[824]: <debug> [1455210469.947849] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /proc/sys/net/ipv6/conf/ttyACM3/hop_limit: Failed to open file '/proc/sys/net/ipv6/conf/ttyACM3/hop_limit': No such file or directory
>NetworkManager[824]: <debug> [1455210469.948627] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /proc/sys/net/ipv6/conf/ttyACM3/use_tempaddr: Failed to open file '/proc/sys/net/ipv6/conf/ttyACM3/use_tempaddr': No such file or directory
>NetworkManager[824]: <debug> [1455210469.949100] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/disable_ipv6': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.949945] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_defrtr': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.950289] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_pinfo': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.950650] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_rtr_pref': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.951016] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/use_tempaddr': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.951761] [devices/nm-device.c:7078] nm_device_bring_up(): [0x88e5a0] (ttyACM3): bringing up device.
>NetworkManager[824]: <debug> [1455210469.952494] [devices/nm-device.c:8156] nm_device_cleanup(): [0x88e5a0] (ttyACM3): preparing device
>NetworkManager[824]: <debug> [1455210469.952850] [devices/nm-device.c:5914] nm_device_queued_ip_config_change_clear(): [0x88e5a0] (ttyACM3): clearing queued IP4 config change
>NetworkManager[824]: <debug> [1455210469.953229] [devices/nm-device.c:5919] nm_device_queued_ip_config_change_clear(): [0x88e5a0] (ttyACM3): clearing queued IP6 config change
>NetworkManager[824]: <debug> [1455210469.953590] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210469.953931] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210469.954299] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/disable_ipv6': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.954679] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.955025] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/use_tempaddr': (2) No such file or directory
>NetworkManager[824]: <info>  (ttyACM3): modem state 'enabling'
>NetworkManager[824]: <debug> [1455210469.955873] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210469.956150] [sd-dhcp-client.c:1078] client_handle_offer(): DHCP CLIENT (0x198b2a56): OFFER
>NetworkManager[824]: <debug> [1455210469.956771] [sd-dhcp-client.c:1120] client_handle_ack(): DHCP CLIENT (0x198b2a56): received message was not an ACK, ignoring
>NetworkManager[824]: <debug> [1455210469.956885] [sd-dhcp-client.c:715] client_send_request(): DHCP CLIENT (0x198b2a56): REQUEST (requesting)
>NetworkManager[824]: <debug> [1455210469.957671] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x861160] (eth0): add_pending_action (2): 'queued state change to secondaries'
>NetworkManager[824]: <debug> [1455210469.957744] [devices/nm-device.c:8816] nm_device_queue_state(): [0x861160] (eth0): queued state change to secondaries due to none (id 145)
>NetworkManager[824]: <debug> [1455210469.958092] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (1): 'queued state change to disconnected'
>NetworkManager[824]: <debug> [1455210469.958237] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of eth0
>NetworkManager[824]: <debug> [1455210469.958589] [devices/nm-device.c:8816] nm_device_queue_state(): [0x88e5a0] (ttyACM3): queued state change to disconnected due to none (id 146)
>NetworkManager[824]: <debug> [1455210469.958927] [devices/nm-device.c:2550] recheck_available(): [0x88e5a0] (ttyACM3): device is available, will transition to disconnected
>NetworkManager[824]: <debug> [1455210469.959434] [sd-dhcp-client.c:1161] client_handle_ack(): DHCP CLIENT (0x198b2a56): ACK
>NetworkManager[824]: <debug> [1455210469.966646] [sd-dhcp-client.c:1265] client_set_lease_timeouts(): DHCP CLIENT (0x198b2a56): lease expires in 1w 23h 59min 59.036354s
>NetworkManager[824]: <debug> [1455210469.966717] [sd-dhcp-client.c:1292] client_set_lease_timeouts(): DHCP CLIENT (0x198b2a56): T2 expires in 6d 23h 59min 58.007460s
>NetworkManager[824]: <debug> [1455210469.966757] [sd-dhcp-client.c:1318] client_set_lease_timeouts(): DHCP CLIENT (0x198b2a56): T1 expires in 3d 23h 59min 57.970280s
>NetworkManager[824]: <debug> [1455210469.966824] [dhcp-manager/nm-dhcp-systemd.c:492] dhcp_event_cb(): (eth0): DHCPv4 client event 1
>NetworkManager[824]: <debug> [1455210469.966853] [dhcp-manager/nm-dhcp-systemd.c:441] bound4_handle(): (eth0): lease available
>NetworkManager[824]: <info>    address 172.23.1.20
>NetworkManager[824]: <info>    plen 22
>NetworkManager[824]: <info>    expires in 691200 seconds
>NetworkManager[824]: <info>    gateway 172.23.0.1
>NetworkManager[824]: <info>    nameserver '172.23.0.10'
>NetworkManager[824]: <info>    nameserver '172.23.0.11'
>NetworkManager[824]: <info>    domain name 'sm.local'
>NetworkManager[824]: <info>  (eth0): DHCPv4 state changed unknown -> bound
>NetworkManager[824]: <debug> [1455210469.967535] [devices/nm-device.c:3549] dhcp4_state_changed(): [0x861160] (eth0): new DHCPv4 client state 1
>NetworkManager[824]: <debug> [1455210469.968456] [devices/nm-device.c:5940] nm_device_activate_schedule_ip4_config_result(): [0x861160] (eth0): Activation: Stage 5 of 5 (IPv4 Configure Commit) scheduled...
>NetworkManager[824]: <debug> [1455210469.969062] [devices/nm-device.c:8765] queued_set_state(): [0x861160] (eth0): running queued state change to secondaries (id 145)
>NetworkManager[824]: <info>  (eth0): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
>NetworkManager[824]: <debug> [1455210469.969305] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x861160] (eth0): add_pending_action (3): 'queued state change to activated'
>NetworkManager[824]: <debug> [1455210469.969346] [devices/nm-device.c:8816] nm_device_queue_state(): [0x861160] (eth0): queued state change to activated due to none (id 162)
>NetworkManager[824]: <debug> [1455210469.969402] [nm-manager.c:4398] policy_activating_device_changed(): ActivatingConnection now (none)
>NetworkManager[824]: <debug> [1455210469.969600] [devices/nm-device.c:8716] _set_state_full(): [0x861160] (eth0): device entered SECONDARIES state
>NetworkManager[824]: <debug> [1455210469.969925] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x861160] (eth0): remove_pending_action (2): 'queued state change to secondaries'
>NetworkManager[824]: <debug> [1455210469.970268] [devices/nm-device.c:8765] queued_set_state(): [0x88e5a0] (ttyACM3): running queued state change to disconnected (id 146)
>NetworkManager[824]: <info>  (ttyACM3): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
>NetworkManager[824]: <debug> [1455210469.971070] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/disable_ipv6': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.971345] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_defrtr': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.971706] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_pinfo': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.972061] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra_rtr_pref': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.972407] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/use_tempaddr': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210469.972917] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (2): 'autoactivate'
>NetworkManager[824]: <debug> [1455210469.973139] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'queued state change to disconnected'
>NetworkManager[824]: <debug> [1455210469.973859] [devices/nm-device.c:5844] nm_device_activate_ip4_config_commit(): [0x861160] (eth0): Activation: Stage 5 of 5 (IPv4 Commit) started...
>NetworkManager[824]: <debug> [1455210469.974054] [platform/nm-platform.c:1875] nm_platform_ip4_address_add(): platform: address: adding or updating IPv4 address: 172.23.1.20/22 lft 691205sec pref 691205sec lifetime 1-0[691205,691205] dev 3 src unknown
>NetworkManager[824]: <debug> [1455210469.974343] [platform/nm-linux-platform.c:2744] do_add_addrroute(): platform-linux: do-add-ip4-address: success adding object 3: 172.23.1.20/22
>NetworkManager[824]: <debug> [1455210469.974579] [platform/nm-platform.c:2902] log_ip4_address(): platform: signal: address 4 changed: 172.23.1.20/22 lft 691205sec pref 691205sec lifetime 1-1[691205,691205] dev 3 src kernel
>NetworkManager[824]: <debug> [1455210469.974890] [devices/nm-device.c:7507] device_ipx_changed(): [0x861160] (eth0): queued IP4 config change
>NetworkManager[824]: <debug> [1455210469.975230] [nm-default-route-manager.c:1318] _resync_idle_reschedule(): default-route: resync: schedule on idle
>NetworkManager[824]: <debug> [1455210469.975654] [platform/nm-platform.c:2914] log_ip4_route(): platform: signal: route   4   added: 172.23.0.0/22 via 0.0.0.0 dev 3 metric 0 mss 0 src rtprot-kernel scope link pref-src 172.23.1.20
>NetworkManager[824]: <debug> [1455210469.975976] [nm-route-manager.c:467] _vx_route_sync(): route-mgr4:   3: sync 0 IPv4 routes
>NetworkManager[824]: <debug> [1455210469.976385] [nm-dispatcher.c:444] _dispatcher_call(): (2) (eth0) dispatching action 'dhcp4-change'
>NetworkManager[824]: <debug> [1455210469.979300] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x861160] (eth0): remove_pending_action (1): 'dhcp4'
>NetworkManager[824]: <debug> [1455210469.979371] [devices/nm-device.c:5903] nm_device_activate_ip4_config_commit(): [0x861160] (eth0): Activation: Stage 5 of 5 (IPv4 Commit) complete.
>NetworkManager[824]: <debug> [1455210469.979740] [devices/nm-device.c:8765] queued_set_state(): [0x861160] (eth0): running queued state change to activated (id 162)
>NetworkManager[824]: <info>  (eth0): device state change: secondaries -> activated (reason 'none') [90 100 0]
>NetworkManager[824]: <debug> [1455210469.979989] [nm-connectivity.c:271] nm_connectivity_set_online(): connectivity: set online
>NetworkManager[824]: <debug> [1455210469.980027] [nm-connectivity.c:108] update_state(): connectivity: state changed from NONE to FULL
>NetworkManager[824]: <debug> [1455210469.980064] [nm-manager.c:4287] connectivity_changed(): connectivity checking indicates FULL
>NetworkManager[824]: <info>  NetworkManager state is now CONNECTED_LOCAL
>NetworkManager[824]: <debug> [1455210469.980262] [nm-active-connection.c:514] check_master_ready(): active-connection[0x809180]: not signalling master-ready (not activating)
>NetworkManager[824]: <debug> [1455210470.004787] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_state_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210470.004859] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (2)
>NetworkManager[824]: <info>  NetworkManager state is now CONNECTED_GLOBAL
>NetworkManager[824]: <info>  Policy set 'eth0' (eth0) as default for IPv4 routing and DNS.
>NetworkManager[824]: <debug> [1455210470.005071] [nm-manager.c:4363] policy_default_device_changed(): PrimaryConnection now eth0
>NetworkManager[824]: <debug> [1455210470.005147] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed
>NetworkManager[824]: <debug> [1455210470.005200] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (1)
>NetworkManager[824]: <debug> [1455210470.005237] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed
>NetworkManager[824]: <debug> [1455210470.005267] [dns-manager/nm-dns-manager.c:1066] nm_dns_manager_end_updates(): (device_state_changed): committing DNS changes (0)
>NetworkManager[824]: <debug> [1455210470.005294] [dns-manager/nm-dns-manager.c:634] update_dns(): updating resolv.conf
>NetworkManager[824]: <info>  (eth0): Activation: successful, device activated.
>NetworkManager[824]: <debug> [1455210470.005760] [devices/nm-device.c:7720] nm_device_update_metered(): [0x861160] (eth0): set metered value 4
>NetworkManager[824]: <debug> [1455210470.005812] [nm-manager.c:681] nm_manager_update_metered(): New manager metered value: 4
>NetworkManager[824]: <debug> [1455210470.005858] [nm-dispatcher.c:444] _dispatcher_call(): (3) (eth0) dispatching action 'up'
>NetworkManager[824]: <debug> [1455210470.008331] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x861160] (eth0): remove_pending_action (0): 'queued state change to activated'
>NetworkManager[824]: <debug> [1455210470.008415] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of wlan0
>NetworkManager[824]: <info>  Auto-activating connection 'mobilecon'.
>NetworkManager[824]: <debug> [1455210470.009279] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (2): 'activation::0x809240'
>NetworkManager[824]: <debug> [1455210470.009395] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'autoactivate'
>NetworkManager[824]: <debug> [1455210470.010124] [nm-dispatcher.c:347] dispatcher_done_cb(): (2) failed to call dispatcher scripts: (org.freedesktop.systemd1.LoadFailed) Unit dbus-org.freedesktop.nm-dispatcher.service failed to load: No such file or directory.
>NetworkManager[824]: <info>  (wlan0) supports 4 scan SSIDs
>NetworkManager[824]: <debug> [1455210470.013772] [nm-dispatcher.c:347] dispatcher_done_cb(): (3) failed to call dispatcher scripts: (org.freedesktop.systemd1.LoadFailed) Unit dbus-org.freedesktop.nm-dispatcher.service failed to load: No such file or directory.
>NetworkManager[824]: <info>  (ttyACM3): Activation: starting connection 'mobilecon' (41ece17e-cc54-11e5-ad21-001395196b3c)
>NetworkManager[824]: <debug> [1455210470.014363] [devices/nm-device.c:2779] nm_device_activate_schedule_stage1_device_prepare(): [0x88e5a0] (ttyACM3): Activation: Stage 1 of 5 (Device Prepare) scheduled...
>NetworkManager[824]: <debug> [1455210470.014575] [devices/nm-device.c:2738] nm_device_activate_stage1_device_prepare(): [0x88e5a0] (ttyACM3): Activation: Stage 1 of 5 (Device Prepare) started...
>NetworkManager[824]: <info>  (ttyACM3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>NetworkManager[824]: <debug> [1455210470.014806] [nm-active-connection.c:518] check_master_ready(): active-connection[0x809240]: not signalling master-ready (no master)
>NetworkManager[824]: <debug> [1455210470.014976] [devices/wwan/nm-modem-broadband.c:367] act_stage_context_step(): (ttyACM3): launching connection with ip type 'ipv4'
>NetworkManager[824]: <debug> [1455210470.015207] [devices/nm-device.c:2756] nm_device_activate_stage1_device_prepare(): [0x88e5a0] (ttyACM3): Activation: Stage 1 of 5 (Device Prepare) complete.
>NetworkManager[824]: <debug> [1455210470.015318] [supplicant-manager/nm-supplicant-interface.c:459] iface_check_netreply_cb(): Supplicant supports network credentials requests
>NetworkManager[824]: <info>  (wlan0): supplicant interface state: starting -> ready
>NetworkManager[824]: <debug> [1455210470.015396] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'waiting for supplicant'
>NetworkManager[824]: <debug> [1455210470.015445] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of ttyACM3
>NetworkManager[824]: <debug> [1455210470.015808] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'queued state change to disconnected'
>NetworkManager[824]: <debug> [1455210470.015867] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of wlan0
>NetworkManager[824]: <debug> [1455210470.015906] [devices/nm-device.c:8816] nm_device_queue_state(): [0x8777f0] (wlan0): queued state change to disconnected due to supplicant-available (id 194)
>NetworkManager[824]: <debug> [1455210470.015937] [devices/nm-device.c:2550] recheck_available(): [0x8777f0] (wlan0): device is available, will transition to disconnected
>NetworkManager[824]: <debug> [1455210470.015988] [devices/nm-device.c:8765] queued_set_state(): [0x8777f0] (wlan0): running queued state change to disconnected (id 194)
>NetworkManager[824]: <info>  (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
>NetworkManager[824]: <debug> [1455210470.016379] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '1' (current value is identical)
>NetworkManager[824]: <debug> [1455210470.017124] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_defrtr' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210470.017249] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_pinfo' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210470.017390] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_rtr_pref' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210470.017938] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210470.018499] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (2): 'scan'
>NetworkManager[824]: <debug> [1455210470.018599] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (3): 'autoactivate'
>NetworkManager[824]: <debug> [1455210470.019011] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (2): 'queued state change to disconnected'
>NetworkManager[824]: <debug> [1455210470.019430] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (1): 'autoactivate'
>NetworkManager[824]: <debug> [1455210470.019504] [nm-default-route-manager.c:1264] _resync_idle_now(): default-route: resync: sync now (169) (IPv4 changes: yes, IPv6 changes: no)
>NetworkManager[824]: <debug> [1455210470.024613] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'scan'
>NetworkManager[824]: <debug> [1455210470.024707] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of ttyACM3
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'enabling' --> 'registered' (reason: user-requested)
>NetworkManager[824]: <debug> [1455210471.142602] [devices/nm-device.c:2550] recheck_available(): [0x88e5a0] (ttyACM3): device is available, will transition to unknown
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'registered' --> 'connecting' (reason: user-requested)
>NetworkManager[824]: <debug> [1455210471.147636] [devices/nm-device.c:2550] recheck_available(): [0x88e5a0] (ttyACM3): device is available, will transition to unknown
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'connecting' --> 'connected' (reason: user-requested)
>NetworkManager[824]: <debug> [1455210471.240335] [devices/nm-device.c:2550] recheck_available(): [0x88e5a0] (ttyACM3): device is available, will transition to unknown
>NetworkManager[824]: <warn>  (ttyACM3): failed to look up interface index
>NetworkManager[824]: <debug> [1455210471.244304] [devices/nm-device.c:2898] nm_device_activate_schedule_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) scheduled...
>NetworkManager[824]: <debug> [1455210471.244624] [devices/nm-device.c:2810] nm_device_activate_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) starting...
>NetworkManager[824]: <info>  (ttyACM3): device state change: prepare -> config (reason 'none') [40 50 0]
>NetworkManager[824]: <debug> [1455210471.245027] [devices/nm-device.c:7078] nm_device_bring_up(): [0x88e5a0] (ttyACM3): bringing up device.
>NetworkManager[824]: <debug> [1455210471.245094] [devices/nm-device.c:2845] nm_device_activate_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) successful.
>NetworkManager[824]: <debug> [1455210471.245157] [devices/nm-device.c:5476] nm_device_activate_schedule_stage3_ip_config_start(): [0x88e5a0] (ttyACM3): Activation: setting firewall zone 'default'
>NetworkManager[824]: <debug> [1455210471.245224] [nm-firewall-manager.c:194] nm_firewall_manager_add_or_change_zone(): (ttyACM3) firewall zone change -> default [1] (not running, simulate success)
>NetworkManager[824]: <debug> [1455210471.245280] [devices/nm-device.c:2850] nm_device_activate_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) complete.
>NetworkManager[824]: <debug> [1455210471.245551] [nm-firewall-manager.c:136] add_or_change_idle_cb(): (ttyACM3) firewall zone call pretends success [1]
>NetworkManager[824]: <debug> [1455210471.245626] [devices/nm-device.c:5439] fw_change_zone_cb(): [0x88e5a0] (ttyACM3): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
>NetworkManager[824]: <debug> [1455210471.245710] [devices/nm-device.c:5375] nm_device_activate_stage3_ip_config_start(): [0x88e5a0] (ttyACM3): Activation: Stage 3 of 5 (IP Configure Start) started...
>NetworkManager[824]: <info>  (ttyACM3): device state change: config -> ip-config (reason 'none') [50 70 0]
>NetworkManager[824]: <warn>  (ttyACM3): interface ttyACM3 not up for IP configuration
>NetworkManager[824]: <info>  (ttyACM3): using modem-specified IP timeout: 20 seconds
>NetworkManager[824]: <info>  starting PPP connection
>NetworkManager[824]: <debug> [1455210471.246757] [ppp-manager/nm-ppp-manager.c:1124] nm_ppp_manager_start(): command line: /usr/sbin/pppd nodetach lock nodefaultroute ipv6 , debug ttyACM3 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 idle 0 ipparam /org/freedesktop/NetworkManager/PPP/0 plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so
>NetworkManager[824]: <info>  pppd started with pid 828
>NetworkManager[824]: <debug> [1455210471.249792] [devices/nm-device.c:5415] nm_device_activate_stage3_ip_config_start(): [0x88e5a0] (ttyACM3): Activation: Stage 3 of 5 (IP Configure Start) complete.
>Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded.
>nm-pppd-plugin-Message: nm-ppp-plugin: (plugin_init): initializing
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection'
>using channel 2
>Using interface ppp0
>Connect: ppp0 <--> /dev/ttyACM3
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
>sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x2d7241b5> <pcomp> <accomp>]
>NetworkManager[824]: <debug> [1455210471.268143] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210471.268345] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210471.268443] [platform/nm-platform.c:2896] log_link(): platform: signal: link   added: 6: ppp0 <NOARP,DOWN;pointopoint,multicast,noarp> mtu 1500 arp 512 unknown not-init driver unknown
>NetworkManager[824]: <debug> [1455210471.268786] [devices/nm-device.c:9069] constructor(): [0x85ed00] (ppp0): constructor(): NMDeviceGeneric, kernel ifindex 6
>NetworkManager[824]: <debug> [1455210471.268884] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210471.268951] [platform/nm-platform-utils.c:345] nmp_utils_mii_supports_carrier_detect(): mii: SIOCGMIIPHY failed: Invalid argument (22) (ppp0)
>NetworkManager[824]: <debug> [1455210471.268988] [platform/nm-platform-utils.c:363] nmp_utils_mii_supports_carrier_detect(): mii: MII not supported (ppp0)
>NetworkManager[824]: <debug> [1455210471.269124] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /sys/class/net/ppp0/phys_port_id: Failed to read from file '/sys/class/net/ppp0/phys_port_id': Operation not supported
>NetworkManager[824]: <debug> [1455210471.269216] [platform/nm-linux-platform.c:2525] _log_dbg_sysctl_get_impl(): platform-linux: sysctl: reading '/sys/class/net/ppp0/dev_id': '0x0'
>NetworkManager[824]: <debug> [1455210471.269328] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210471.269391] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210471.269451] [platform/nm-platform-utils.c:345] nmp_utils_mii_supports_carrier_detect(): mii: SIOCGMIIPHY failed: Invalid argument (22) (ppp0)
>NetworkManager[824]: <debug> [1455210471.269701] [platform/nm-platform-utils.c:363] nmp_utils_mii_supports_carrier_detect(): mii: MII not supported (ppp0)
>NetworkManager[824]: <info>  (ppp0): new Generic device (carrier: UNKNOWN, driver: 'unknown', ifindex: 6)
>NetworkManager[824]: <debug> [1455210471.270510] [devices/nm-device.c:536] nm_device_dbus_export(): [0x85ed00] (ppp0): exported as /org/freedesktop/NetworkManager/Devices/5
>NetworkManager[824]: <debug> [1455210471.271088] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210471.271478] [devices/nm-device.c:6563] nm_device_set_ip4_config(): [0x85ed00] (ppp0): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/4)
>NetworkManager[824]: <debug> [1455210471.271787] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210471.272274] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210471.272690] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip4_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210471.273240] [devices/nm-device.c:6690] nm_device_set_ip6_config(): [0x85ed00] (ppp0): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/4)
>NetworkManager[824]: <debug> [1455210471.273526] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip6_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210471.273919] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210471.274320] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip6_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210471.275082] [devices/nm-device.c:2514] nm_device_emit_recheck_assume(): [0x85ed00] (ppp0): emit RECHECK_ASSUME signal
>NetworkManager[824]: <debug> [1455210471.276150] [platform/nm-linux-platform.c:4822] handle_udev_event(): platform-linux: UDEV event: action 'add' subsys 'net' device 'ppp0' (6); seqnum=4032
>NetworkManager[824]: <debug> [1455210471.276342] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210471.276431] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 6: ppp0 <NOARP,DOWN;pointopoint,multicast,noarp> mtu 1500 arp 512 unknown init driver unknown
>NetworkManager[824]: <debug> [1455210471.277226] [devices/nm-device.c:1576] link_changed_cb(): [0x85ed00] (ppp0): queued link change for ifindex 6
>NetworkManager[824]: <info>  devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
>NetworkManager[824]: <info>  device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
>rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth pap> <magic 0xc7aa48ba> <pcomp> <accomp>]
>sent [LCP ConfAck id=0x1 <asyncmap 0x0> <auth pap> <magic 0xc7aa48ba> <pcomp> <accomp>]
>rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x2d7241b5> <pcomp> <accomp>]
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate'
>nm-pppd-plugin-Message: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials...
>nm-pppd-plugin-Message: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager
>sent [PAP AuthReq id=0x1 user="" password=<hidden>]
>rcvd [PAP AuthAck id=0x1 ""]
>PAP authentication succeeded
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
>sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::3804:6ece:30e0:856c>]
>rcvd [LCP ProtRej id=0x2 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15]
>Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
>NetworkManager[824]: <debug> [1455210473.512937] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 4: wlan0 <UP;broadcast,multicast,up> mtu 0 arp 1 wifi init driver ath9k
>NetworkManager[824]: <debug> [1455210473.513038] [devices/nm-device.c:1576] link_changed_cb(): [0x8777f0] (wlan0): queued link change for ifindex 4
>NetworkManager[824]: <info>  (wlan0): supplicant interface state: ready -> inactive
>NetworkManager[824]: <debug> [1455210473.531537] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'scan'
>NetworkManager[824]: <debug> [1455210473.531672] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of wlan0
>NetworkManager[824]: <debug> [1455210473.532925] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (2): 'autoactivate'
>NetworkManager[824]: <debug> [1455210473.536492] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (1): 'scan'
>NetworkManager[824]: <debug> [1455210473.541298] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'autoactivate'
>NetworkManager[824]: <debug> [1455210473.541391] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of ttyACM3
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::3804:6ece:30e0:856c>]
>NetworkManager[824]: <debug> [1455210477.039873] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'autoactivate'
>NetworkManager[824]: <debug> [1455210477.039979] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of wlan0
>NetworkManager[824]: <debug> [1455210477.040436] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'autoactivate'
>NetworkManager[824]: <debug> [1455210477.040529] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of ttyACM3
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::3804:6ece:30e0:856c>]
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::3804:6ece:30e0:856c>]
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::3804:6ece:30e0:856c>]
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::3804:6ece:30e0:856c>]
>rcvd [LCP TermReq id=0x3 "User request"]
>LCP terminated by peer (User request)
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
>sent [LCP TermAck id=0x3]
>Modem hangup
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect'
>Connection terminated.
>NetworkManager[824]: <debug> [1455210488.135319] [platform/nm-platform.c:2896] log_link(): platform: signal: link removed: 6: ppp0 <NOARP,DOWN;pointopoint,multicast,noarp> mtu 1500 arp 512 unknown not-init
>NetworkManager[824]: <debug> [1455210488.136233] [devices/nm-device.c:5552] nm_device_activate_schedule_ip4_config_timeout(): [0x88e5a0] (ttyACM3): Activation: Stage 4 of 5 (IPv4 Configure Timeout) scheduled...
>NetworkManager[824]: <debug> [1455210488.136365] [nm-manager.c:806] remove_device(): (ppp0): removing device (allow_unmanage 1, managed 0)
>NetworkManager[824]: <debug> [1455210488.136599] [devices/nm-device.c:9218] dispose(): [0x85ed00] (ppp0): dispose(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210488.136650] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85ed00] (ppp0): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210488.136681] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85ed00] (ppp0): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210488.136717] [devices/nm-device.c:6569] nm_device_set_ip4_config(): [0x85ed00] (ppp0): clear IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/4)
>NetworkManager[824]: <debug> [1455210488.136775] [devices/nm-device.c:6696] nm_device_set_ip6_config(): [0x85ed00] (ppp0): clear IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/4)
>NetworkManager[824]: <debug> [1455210488.136865] [devices/nm-device.c:9277] finalize(): [0x85ed00] (ppp0): finalize(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210488.136909] [nm-manager.c:760] check_if_startup_complete(): check_if_startup_complete returns FALSE because of ttyACM3
>NetworkManager[824]: <debug> [1455210488.136949] [devices/nm-device.c:5513] nm_device_activate_ip4_config_timeout(): [0x88e5a0] (ttyACM3): Activation: Stage 4 of 5 (IPv4 Configure Timeout) started...
>NetworkManager[824]: <info>  (ttyACM3): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
>NetworkManager[824]: <debug> [1455210488.138912] [nm-active-connection.c:514] check_master_ready(): active-connection[0x809240]: not signalling master-ready (not activating)
>NetworkManager[824]: <debug> [1455210488.139445] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'activation::0x809240'
>NetworkManager[824]: <info>  startup complete
>NetworkManager[824]: <debug> [1455210488.140696] [NetworkManagerUtils.c:667] nm_utils_kill_child_async(): kill child process 'pppd' (828): wait for process to terminate after sending SIGTERM (15) (send SIGKILL in 2000 milliseconds)...
>NetworkManager[824]: <debug> [1455210488.140795] [devices/wwan/nm-modem-broadband.c:984] disconnect(): (ttyACM3): notifying ModemManager about the modem disconnection
>NetworkManager[824]: <debug> [1455210488.141318] [nm-policy.c:1129] device_state_changed(): Connection 'mobilecon' failed to autoconnect; 4 tries left
>NetworkManager[824]: <warn>  (ttyACM3): Activation: failed for connection 'mobilecon'
>NetworkManager[824]: <debug> [1455210488.142002] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (1): 'queued state change to disconnected'
>NetworkManager[824]: <debug> [1455210488.142407] [devices/nm-device.c:8816] nm_device_queue_state(): [0x88e5a0] (ttyACM3): queued state change to disconnected due to none (id 505)
>NetworkManager[824]: <debug> [1455210488.142777] [devices/nm-device.c:5529] nm_device_activate_ip4_config_timeout(): [0x88e5a0] (ttyACM3): Activation: Stage 4 of 5 (IPv4 Configure Timeout) complete.
>NetworkManager[824]: <debug> [1455210488.143293] [platform/nm-linux-platform.c:4822] handle_udev_event(): platform-linux: UDEV event: action 'remove' subsys 'net' device 'ppp0' (6); seqnum=4037
>NetworkManager[824]: <debug> [1455210488.143578] [platform/nm-linux-platform.c:4794] udev_device_removed(): platform-linux: udev-remove: IFINDEX=6
>NetworkManager[824]: <info>  devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
>NetworkManager[824]: <debug> [1455210488.144835] [devices/nm-device.c:8765] queued_set_state(): [0x88e5a0] (ttyACM3): running queued state change to disconnected (id 505)
>NetworkManager[824]: <info>  (ttyACM3): device state change: failed -> disconnected (reason 'none') [120 30 0]
>NetworkManager[824]: <debug> [1455210488.145210] [devices/nm-device.c:8158] nm_device_cleanup(): [0x88e5a0] (ttyACM3): deactivating device (reason 'none') [0]
>NetworkManager[824]: <debug> [1455210488.145611] [nm-firewall-manager.c:256] nm_firewall_manager_remove_from_zone(): (ttyACM3) firewall zone remove skipped (not running)
>NetworkManager[824]: <debug> [1455210488.146090] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210488.146492] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210488.146961] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/disable_ipv6': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210488.147329] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/accept_ra': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210488.148094] [platform/nm-linux-platform.c:2458] sysctl_set(): platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM3/use_tempaddr': (2) No such file or directory
>NetworkManager[824]: <debug> [1455210488.148864] [devices/wwan/nm-modem-broadband.c:984] disconnect(): (ttyACM3): notifying ModemManager about the modem disconnection
>NetworkManager[824]: <debug> [1455210488.149642] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210488.149730] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210488.150128] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210488.150900] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (2): 'autoactivate'
>NetworkManager[824]: <debug> [1455210488.151691] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'queued state change to disconnected'
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'connected' --> 'disconnecting' (reason: user-requested)
>NetworkManager[824]: <info>  Auto-activating connection 'mobilecon'.
>NetworkManager[824]: <debug> [1455210488.154552] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (2): 'activation::0x809300'
>NetworkManager[824]: <debug> [1455210488.155328] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'autoactivate'
>NetworkManager[824]: <debug> [1455210488.155661] [devices/nm-device.c:2550] recheck_available(): [0x88e5a0] (ttyACM3): device is available, will transition to unknown
>NetworkManager[824]: <info>  (ttyACM3): Activation: starting connection 'mobilecon' (41ece17e-cc54-11e5-ad21-001395196b3c)
>NetworkManager[824]: <debug> [1455210488.156466] [devices/nm-device.c:2779] nm_device_activate_schedule_stage1_device_prepare(): [0x88e5a0] (ttyACM3): Activation: Stage 1 of 5 (Device Prepare) scheduled...
>NetworkManager[824]: <debug> [1455210488.157078] [devices/nm-device.c:2738] nm_device_activate_stage1_device_prepare(): [0x88e5a0] (ttyACM3): Activation: Stage 1 of 5 (Device Prepare) started...
>NetworkManager[824]: <info>  (ttyACM3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>NetworkManager[824]: <debug> [1455210488.157856] [nm-active-connection.c:518] check_master_ready(): active-connection[0x809300]: not signalling master-ready (no master)
>NetworkManager[824]: <debug> [1455210488.158124] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'autoactivate'
>NetworkManager[824]: <debug> [1455210488.158599] [devices/wwan/nm-modem-broadband.c:367] act_stage_context_step(): (ttyACM3): launching connection with ip type 'ipv4'
>NetworkManager[824]: <debug> [1455210488.159133] [devices/nm-device.c:2756] nm_device_activate_stage1_device_prepare(): [0x88e5a0] (ttyACM3): Activation: Stage 1 of 5 (Device Prepare) complete.
>NetworkManager[824]: <debug> [1455210488.159776] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'autoactivate'
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead'
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_exit_notify): cleaning up
>NetworkManager[824]: <debug> [1455210489.149076] [NetworkManagerUtils.c:522] _kc_cb_watch_child(): kill child process 'pppd' (828): terminated normally with status 16 (1008379 usec elapsed)
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'disconnecting' --> 'registered' (reason: user-requested)
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'registered' --> 'connecting' (reason: user-requested)
>NetworkManager[824]: <debug> [1455210490.244933] [devices/nm-device.c:2550] recheck_available(): [0x88e5a0] (ttyACM3): device is available, will transition to unknown
>NetworkManager[824]: <info>  (ttyACM3): modem state changed, 'connecting' --> 'connected' (reason: user-requested)
>NetworkManager[824]: <debug> [1455210490.298882] [devices/nm-device.c:2550] recheck_available(): [0x88e5a0] (ttyACM3): device is available, will transition to unknown
>NetworkManager[824]: <warn>  (ttyACM3): failed to look up interface index
>NetworkManager[824]: <debug> [1455210490.305548] [devices/nm-device.c:2898] nm_device_activate_schedule_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) scheduled...
>NetworkManager[824]: <debug> [1455210490.306115] [devices/nm-device.c:2810] nm_device_activate_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) starting...
>NetworkManager[824]: <info>  (ttyACM3): device state change: prepare -> config (reason 'none') [40 50 0]
>NetworkManager[824]: <debug> [1455210490.306784] [devices/nm-device.c:7078] nm_device_bring_up(): [0x88e5a0] (ttyACM3): bringing up device.
>NetworkManager[824]: <debug> [1455210490.306858] [devices/nm-device.c:2845] nm_device_activate_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) successful.
>NetworkManager[824]: <debug> [1455210490.306957] [devices/nm-device.c:5476] nm_device_activate_schedule_stage3_ip_config_start(): [0x88e5a0] (ttyACM3): Activation: setting firewall zone 'default'
>NetworkManager[824]: <debug> [1455210490.307025] [nm-firewall-manager.c:194] nm_firewall_manager_add_or_change_zone(): (ttyACM3) firewall zone change -> default [2] (not running, simulate success)
>NetworkManager[824]: <debug> [1455210490.307080] [devices/nm-device.c:2850] nm_device_activate_stage2_device_config(): [0x88e5a0] (ttyACM3): Activation: Stage 2 of 5 (Device Configure) complete.
>NetworkManager[824]: <debug> [1455210490.307336] [nm-firewall-manager.c:136] add_or_change_idle_cb(): (ttyACM3) firewall zone call pretends success [2]
>NetworkManager[824]: <debug> [1455210490.307402] [devices/nm-device.c:5439] fw_change_zone_cb(): [0x88e5a0] (ttyACM3): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
>NetworkManager[824]: <debug> [1455210490.307486] [devices/nm-device.c:5375] nm_device_activate_stage3_ip_config_start(): [0x88e5a0] (ttyACM3): Activation: Stage 3 of 5 (IP Configure Start) started...
>NetworkManager[824]: <info>  (ttyACM3): device state change: config -> ip-config (reason 'none') [50 70 0]
>NetworkManager[824]: <warn>  (ttyACM3): interface ttyACM3 not up for IP configuration
>NetworkManager[824]: <info>  (ttyACM3): using modem-specified IP timeout: 20 seconds
>NetworkManager[824]: <info>  starting PPP connection
>NetworkManager[824]: <debug> [1455210490.308236] [ppp-manager/nm-ppp-manager.c:1124] nm_ppp_manager_start(): command line: /usr/sbin/pppd nodetach lock nodefaultroute ipv6 , debug ttyACM3 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 idle 0 ipparam /org/freedesktop/NetworkManager/PPP/1 plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so
>NetworkManager[824]: <info>  pppd started with pid 842
>NetworkManager[824]: <debug> [1455210490.311769] [devices/nm-device.c:5415] nm_device_activate_stage3_ip_config_start(): [0x88e5a0] (ttyACM3): Activation: Stage 3 of 5 (IP Configure Start) complete.
>Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded.
>nm-pppd-plugin-Message: nm-ppp-plugin: (plugin_init): initializing
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection'
>using channel 4
>Using interface ppp0
>Connect: ppp0 <--> /dev/ttyACM3
>NetworkManager[824]: <debug> [1455210490.329920] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
>NetworkManager[824]: <debug> [1455210490.330148] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xf698f3ee> <pcomp> <accomp>]
>NetworkManager[824]: <debug> [1455210490.330286] [platform/nm-platform.c:2896] log_link(): platform: signal: link   added: 7: ppp0 <NOARP,DOWN;pointopoint,multicast,noarp> mtu 1500 arp 512 unknown not-init driver unknown
>NetworkManager[824]: <debug> [1455210490.330497] [devices/nm-device.c:9069] constructor(): [0x85f0a0] (ppp0): constructor(): NMDeviceGeneric, kernel ifindex 7
>NetworkManager[824]: <debug> [1455210490.330614] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210490.330697] [platform/nm-platform-utils.c:345] nmp_utils_mii_supports_carrier_detect(): mii: SIOCGMIIPHY failed: Invalid argument (22) (ppp0)
>NetworkManager[824]: <debug> [1455210490.330744] [platform/nm-platform-utils.c:363] nmp_utils_mii_supports_carrier_detect(): mii: MII not supported (ppp0)
>NetworkManager[824]: <debug> [1455210490.330886] [platform/nm-linux-platform.c:2557] sysctl_get(): platform-linux: error reading /sys/class/net/ppp0/phys_port_id: Failed to read from file '/sys/class/net/ppp0/phys_port_id': Operation not supported
>NetworkManager[824]: <debug> [1455210490.331016] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210490.331092] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210490.331171] [platform/nm-platform-utils.c:345] nmp_utils_mii_supports_carrier_detect(): mii: SIOCGMIIPHY failed: Invalid argument (22) (ppp0)
>NetworkManager[824]: <debug> [1455210490.331217] [platform/nm-platform-utils.c:363] nmp_utils_mii_supports_carrier_detect(): mii: MII not supported (ppp0)
>NetworkManager[824]: <info>  (ppp0): new Generic device (carrier: UNKNOWN, driver: 'unknown', ifindex: 7)
>NetworkManager[824]: <debug> [1455210490.331700] [devices/nm-device.c:536] nm_device_dbus_export(): [0x85f0a0] (ppp0): exported as /org/freedesktop/NetworkManager/Devices/6
>NetworkManager[824]: <debug> [1455210490.332437] [nm-manager.c:1117] system_create_virtual_devices(): creating virtual devices...
>NetworkManager[824]: <debug> [1455210490.333167] [devices/nm-device.c:6563] nm_device_set_ip4_config(): [0x85f0a0] (ppp0): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/5)
>NetworkManager[824]: <debug> [1455210490.333413] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210490.333893] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210490.334370] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip4_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210490.334991] [devices/nm-device.c:6690] nm_device_set_ip6_config(): [0x85f0a0] (ppp0): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/5)
>NetworkManager[824]: <debug> [1455210490.335300] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip6_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210490.335807] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210490.336250] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip6_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210490.337091] [devices/nm-device.c:2514] nm_device_emit_recheck_assume(): [0x85f0a0] (ppp0): emit RECHECK_ASSUME signal
>NetworkManager[824]: <debug> [1455210490.338872] [platform/nm-linux-platform.c:4822] handle_udev_event(): platform-linux: UDEV event: action 'add' subsys 'net' device 'ppp0' (7); seqnum=4038
>NetworkManager[824]: <debug> [1455210490.339057] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210490.339141] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 7: ppp0 <NOARP,DOWN;pointopoint,multicast,noarp> mtu 1500 arp 512 unknown init driver unknown
>NetworkManager[824]: <debug> [1455210490.339193] [devices/nm-device.c:1576] link_changed_cb(): [0x85f0a0] (ppp0): queued link change for ifindex 7
>NetworkManager[824]: <info>  devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
>NetworkManager[824]: <info>  device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
>rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth pap> <magic 0x239af903> <pcomp> <accomp>]
>sent [LCP ConfAck id=0x1 <asyncmap 0x0> <auth pap> <magic 0x239af903> <pcomp> <accomp>]
>rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xf698f3ee> <pcomp> <accomp>]
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate'
>nm-pppd-plugin-Message: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials...
>nm-pppd-plugin-Message: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager
>sent [PAP AuthReq id=0x1 user="" password=<hidden>]
>rcvd [PAP AuthAck id=0x1 ""]
>PAP authentication succeeded
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
>sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::7d1c:93f2:9133:bb59>]
>rcvd [LCP ProtRej id=0x2 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15]
>Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::7d1c:93f2:9133:bb59>]
>sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>sent [IPV6CP ConfReq id=0x1 <addr fe80::7d1c:93f2:9133:bb59>]
>rcvd [IPCP ConfReq id=0x1]
>sent [IPCP ConfNak id=0x1 <addr 0.0.0.0>]
>rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
>sent [IPCP ConfReq id=0x2 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
>rcvd [IPV6CP ConfReq id=0x1 <addr fe80::ecd1:d2aa:9b0d:0277>]
>sent [IPV6CP ConfAck id=0x1 <addr fe80::ecd1:d2aa:9b0d:0277>]
>rcvd [IPV6CP ConfAck id=0x1 <addr fe80::7d1c:93f2:9133:bb59>]
>local  LL address fe80::7d1c:93f2:9133:bb59
>remote LL address fe80::ecd1:d2aa:9b0d:0277
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running'
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_ip6_up): ip6-up event
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_ip6_up): sending IPv6 config to NetworkManager...
>NetworkManager[824]: <debug> [1455210496.367731] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210496.367922] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210496.368006] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 7: ppp0 <NOARP,UP,LOWER_UP;pointopoint,multicast,noarp,up,running,lowerup> mtu 1500 arp 512 unknown init driver unknown
>NetworkManager[824]: <debug> [1455210496.368062] [devices/nm-device.c:1576] link_changed_cb(): [0x85f0a0] (ppp0): queued link change for ifindex 7
>NetworkManager[824]: <debug> [1455210496.368159] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6   added: ff00::/8 via :: dev 7 metric 256 mss 0 src user
>NetworkManager[824]: <debug> [1455210496.368207] [devices/nm-device.c:7514] device_ipx_changed(): [0x85f0a0] (ppp0): queued IP6 config change
>NetworkManager[824]: <debug> [1455210496.368271] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6   added: fe80::/10 via :: dev 7 metric 256 mss 0 src rtprot-kernel
>NetworkManager[824]: <debug> [1455210496.368636] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6   added: fe80::/10 via :: dev 7 metric 1 mss 0 src user
>NetworkManager[824]: <debug> [1455210496.369070] [platform/nm-platform.c:2908] log_ip6_address(): platform: signal: address 6   added: fe80::7d1c:93f2:9133:bb59/10 lft forever pref forever lifetime 28-0[4294967295,4294967295] dev 7 flags permanent src kernel
>NetworkManager[824]: <debug> [1455210496.369418] [nm-default-route-manager.c:1318] _resync_idle_reschedule(): default-route: resync: schedule on idle
>NetworkManager[824]: <info>  PPP manager (IPv6 Config Get) reply received.
>NetworkManager[824]: <debug> [1455210496.370365] [nm-manager.c:806] remove_device(): (ppp0): removing device (allow_unmanage 0, managed 0)
>NetworkManager[824]: <debug> [1455210496.370539] [devices/nm-device.c:9218] dispose(): [0x85f0a0] (ppp0): dispose(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210496.370583] [devices/nm-device.c:5919] nm_device_queued_ip_config_change_clear(): [0x85f0a0] (ppp0): clearing queued IP6 config change
>NetworkManager[824]: <debug> [1455210496.370619] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85f0a0] (ppp0): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210496.370650] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85f0a0] (ppp0): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210496.370688] [devices/nm-device.c:6569] nm_device_set_ip4_config(): [0x85f0a0] (ppp0): clear IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/5)
>NetworkManager[824]: <debug> [1455210496.370747] [devices/nm-device.c:6696] nm_device_set_ip6_config(): [0x85f0a0] (ppp0): clear IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/5)
>NetworkManager[824]: <debug> [1455210496.370832] [devices/nm-device.c:9277] finalize(): [0x85f0a0] (ppp0): finalize(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210496.370960] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/ppp0/disable_ipv6' to '1' (current value is '0')
>
>(NetworkManager:824): NetworkManager-wwan-CRITICAL **: modem_ip6_config_result: assertion 'nm_device_activate_ip6_state_in_conf (device) == TRUE' failed
>NetworkManager[824]: <debug> [1455210496.372541] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6 removed: fe80::/10 via :: dev 7 metric 1 mss 0 src user
>NetworkManager[824]: <debug> [1455210496.372610] [devices/nm-device.c:7514] device_ipx_changed(): [0x88e5a0] (ttyACM3): queued IP6 config change
>NetworkManager[824]: <debug> [1455210496.372679] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6 removed: fe80::/10 via :: dev 7 metric 256 mss 0 src rtprot-kernel
>NetworkManager[824]: <debug> [1455210496.372778] [platform/nm-platform.c:2920] log_ip6_route(): platform: signal: route   6 removed: ff00::/8 via :: dev 7 metric 256 mss 0 src user
>NetworkManager[824]: <debug> [1455210496.372865] [platform/nm-platform.c:2908] log_ip6_address(): platform: signal: address 6 removed: fe80::7d1c:93f2:9133:bb59/10 lft forever pref forever lifetime 28-0[4294967295,4294967295] dev 7 flags permanent src kernel
>NetworkManager[824]: <debug> [1455210496.373339] [devices/nm-device.c:6690] nm_device_set_ip6_config(): [0x88e5a0] (ttyACM3): set IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/6)
>NetworkManager[824]: <debug> [1455210496.373411] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip6_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210496.373461] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210496.373491] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip6_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210496.373680] [nm-default-route-manager.c:1264] _resync_idle_now(): default-route: resync: sync now (573) (IPv4 changes: no, IPv6 changes: yes)
>rcvd [IPCP ConfReq id=0x2 <addr 10.168.171.255>]
>sent [IPCP ConfAck id=0x2 <addr 10.168.171.255>]
>rcvd [IPCP ConfNak id=0x2 <addr 10.168.171.255> <ms-dns1 172.26.38.1> <ms-dns2 172.26.38.2>]
>sent [IPCP ConfReq id=0x3 <addr 10.168.171.255> <ms-dns1 172.26.38.1> <ms-dns2 172.26.38.2>]
>rcvd [IPCP ConfAck id=0x3 <addr 10.168.171.255> <ms-dns1 172.26.38.1> <ms-dns2 172.26.38.2>]
>local  IP address 10.168.171.255
>remote IP address 10.168.171.255
>primary   DNS address 172.26.38.1
>secondary DNS address 172.26.38.2
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_ip_up): ip-up event
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager...
>Script /etc/ppp/ip-up started (pid 852)
>NetworkManager[824]: <debug> [1455210496.388995] [platform/nm-platform.c:2902] log_ip4_address(): platform: signal: address 4   added: 10.168.171.255/32 lft forever pref forever lifetime 28-0[4294967295,4294967295] dev 7 src kernel
>NetworkManager[824]: <debug> [1455210496.389104] [nm-default-route-manager.c:1318] _resync_idle_reschedule(): default-route: resync: schedule on idle
>NetworkManager[824]: <debug> [1455210496.389170] [devices/nm-device.c:7507] device_ipx_changed(): [0x88e5a0] (ttyACM3): queued IP4 config change
>NetworkManager[824]: <info>  PPP manager (IPv4 Config Get) reply received.
>NetworkManager[824]: <debug> [1455210496.389896] [platform/nm-platform.c:1875] nm_platform_ip4_address_add(): platform: address: adding or updating IPv4 address: 10.168.171.255/32 lft forever pref forever lifetime 28-0[4294967295,4294967295] ptp 10.168.171.255 dev 7 src unknown
>NetworkManager[824]: <debug> [1455210496.390129] [platform/nm-linux-platform.c:2744] do_add_addrroute(): platform-linux: do-add-ip4-address: success adding object 7: 10.168.171.255/32
>NetworkManager[824]: <debug> [1455210496.390262] [nm-route-manager.c:467] _vx_route_sync(): route-mgr4:   7: sync 1 IPv4 routes
>NetworkManager[824]: <debug> [1455210496.390326] [platform/nm-platform.c:2191] nm_platform_ip4_route_add(): platform: route: adding or updating IPv4 route: 10.168.171.255/32 via 0.0.0.0 dev 7 metric 700 mss 0 src kernel pref-src 10.168.171.255
>NetworkManager[824]: <debug> [1455210496.390510] [platform/nm-linux-platform.c:2744] do_add_addrroute(): platform-linux: do-add-ip4-route: success adding object 7: 10.168.171.255/32 700
>NetworkManager[824]: <debug> [1455210496.390669] [platform/nm-platform.c:2914] log_ip4_route(): platform: signal: route   4   added: 10.168.171.255/32 via 0.0.0.0 dev 7 metric 700 mss 0 src rtprot-kernel scope link pref-src 10.168.171.255
>NetworkManager[824]: <debug> [1455210496.390843] [devices/nm-device.c:6563] nm_device_set_ip4_config(): [0x88e5a0] (ttyACM3): set IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/6)
>NetworkManager[824]: <debug> [1455210496.390917] [nm-default-route-manager.c:663] _entry_at_idx_update(): default-route: entry[1/dev:0x88e5a0:ttyACM3:1:+sync]: record:add    0.0.0.0/0 via 10.168.171.255 dev 7 metric 700 mss 0 src user (700)
>NetworkManager[824]: <debug> [1455210496.390962] [nm-default-route-manager.c:1294] _resync_idle_cancel(): default-route: resync: cancelled (576)
>NetworkManager[824]: <debug> [1455210496.391030] [nm-default-route-manager.c:584] _resync_all(): default-route: entry[1/dev:0x88e5a0:ttyACM3:1:+sync]: sync:add    0.0.0.0/0 via 10.168.171.255 dev 7 metric 700 mss 0 src user (700)
>NetworkManager[824]: <debug> [1455210496.391083] [platform/nm-platform.c:2191] nm_platform_ip4_route_add(): platform: route: adding or updating IPv4 route: 0.0.0.0/0 via 10.168.171.255 dev 7 metric 700 mss 0 src user
>NetworkManager[824]: <debug> [1455210496.391219] [platform/nm-linux-platform.c:2744] do_add_addrroute(): platform-linux: do-add-ip4-route: success adding object 7: 0.0.0.0/0 700
>NetworkManager[824]: <debug> [1455210496.391330] [platform/nm-platform.c:2914] log_ip4_route(): platform: signal: route   4   added: 0.0.0.0/0 via 10.168.171.255 dev 7 metric 700 mss 0 src user scope global
>NetworkManager[824]: <debug> [1455210496.391488] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210496.391581] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210496.391626] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip4_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210496.391674] [devices/nm-device.c:5914] nm_device_queued_ip_config_change_clear(): [0x88e5a0] (ttyACM3): clearing queued IP4 config change
>NetworkManager[824]: <debug> [1455210496.391723] [devices/nm-device.c:5940] nm_device_activate_schedule_ip4_config_result(): [0x88e5a0] (ttyACM3): Activation: Stage 5 of 5 (IPv4 Configure Commit) scheduled...
>NetworkManager[824]: <debug> [1455210496.392192] [devices/nm-device.c:5844] nm_device_activate_ip4_config_commit(): [0x88e5a0] (ttyACM3): Activation: Stage 5 of 5 (IPv4 Commit) started...
>NetworkManager[824]: <debug> [1455210496.392406] [platform/nm-platform.c:1875] nm_platform_ip4_address_add(): platform: address: adding or updating IPv4 address: 10.168.171.255/32 lft forever pref forever lifetime 28-0[4294967295,4294967295] ptp 10.168.171.255 dev 7 src unknown
>NetworkManager[824]: <debug> [1455210496.392593] [platform/nm-linux-platform.c:2744] do_add_addrroute(): platform-linux: do-add-ip4-address: success adding object 7: 10.168.171.255/32
>NetworkManager[824]: <debug> [1455210496.392703] [nm-route-manager.c:467] _vx_route_sync(): route-mgr4:   7: sync 1 IPv4 routes
>NetworkManager[824]: <debug> [1455210496.392757] [platform/nm-platform.c:2191] nm_platform_ip4_route_add(): platform: route: adding or updating IPv4 route: 10.168.171.255/32 via 0.0.0.0 dev 7 metric 700 mss 0 src kernel pref-src 10.168.171.255
>NetworkManager[824]: <debug> [1455210496.392852] [platform/nm-linux-platform.c:2744] do_add_addrroute(): platform-linux: do-add-ip4-route: success adding object 7: 10.168.171.255/32 700
>NetworkManager[824]: <debug> [1455210496.392968] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'dhcp4' not pending (expected)
>NetworkManager[824]: <info>  (ttyACM3): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
>NetworkManager[824]: <debug> [1455210496.393275] [nm-dispatcher.c:444] _dispatcher_call(): (4) (ttyACM3) dispatching action 'pre-up' (with callback)
>NetworkManager[824]: <debug> [1455210496.393355] [nm-dispatcher.c:455] _dispatcher_call(): (4) simulate request; no scripts in /etc/NetworkManager/dispatcher.d/pre-up.d
>NetworkManager[824]: <debug> [1455210496.393479] [devices/nm-device.c:5903] nm_device_activate_ip4_config_commit(): [0x88e5a0] (ttyACM3): Activation: Stage 5 of 5 (IPv4 Commit) complete.
>NetworkManager[824]: <debug> [1455210496.393803] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (2): 'queued state change to secondaries'
>NetworkManager[824]: <debug> [1455210496.393868] [devices/nm-device.c:8816] nm_device_queue_state(): [0x88e5a0] (ttyACM3): queued state change to secondaries due to none (id 586)
>NetworkManager[824]: <debug> [1455210496.393934] [devices/nm-device.c:8765] queued_set_state(): [0x88e5a0] (ttyACM3): running queued state change to secondaries (id 586)
>NetworkManager[824]: <info>  (ttyACM3): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
>NetworkManager[824]: <debug> [1455210496.394210] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x88e5a0] (ttyACM3): add_pending_action (3): 'queued state change to activated'
>NetworkManager[824]: <debug> [1455210496.394267] [devices/nm-device.c:8816] nm_device_queue_state(): [0x88e5a0] (ttyACM3): queued state change to activated due to none (id 588)
>NetworkManager[824]: <debug> [1455210496.394339] [devices/nm-device.c:8716] _set_state_full(): [0x88e5a0] (ttyACM3): device entered SECONDARIES state
>NetworkManager[824]: <debug> [1455210496.394384] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (2): 'queued state change to secondaries'
>NetworkManager[824]: <debug> [1455210496.394618] [devices/nm-device.c:8765] queued_set_state(): [0x88e5a0] (ttyACM3): running queued state change to activated (id 588)
>NetworkManager[824]: <info>  (ttyACM3): device state change: secondaries -> activated (reason 'none') [90 100 0]
>NetworkManager[824]: <debug> [1455210496.394924] [nm-active-connection.c:514] check_master_ready(): active-connection[0x809300]: not signalling master-ready (not activating)
>Script /etc/ppp/ip-up finished (pid 852), status = 0x0
>NetworkManager[824]: <debug> [1455210496.418014] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (1): 'activation::0x809300'
>NetworkManager[824]: <debug> [1455210496.418413] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_state_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210496.418479] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (2)
>NetworkManager[824]: <debug> [1455210496.418562] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed
>NetworkManager[824]: <debug> [1455210496.418596] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (1)
>NetworkManager[824]: <debug> [1455210496.418634] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed
>NetworkManager[824]: <debug> [1455210496.418664] [dns-manager/nm-dns-manager.c:1066] nm_dns_manager_end_updates(): (device_state_changed): committing DNS changes (0)
>NetworkManager[824]: <debug> [1455210496.418691] [dns-manager/nm-dns-manager.c:634] update_dns(): updating resolv.conf
>NetworkManager[824]: <info>  (ttyACM3): Activation: successful, device activated.
>NetworkManager[824]: <debug> [1455210496.419114] [devices/nm-device.c:7720] nm_device_update_metered(): [0x88e5a0] (ttyACM3): set metered value 3
>NetworkManager[824]: <debug> [1455210496.419167] [nm-dispatcher.c:444] _dispatcher_call(): (5) (ttyACM3) dispatching action 'up'
>NetworkManager[824]: <debug> [1455210496.421240] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'queued state change to activated'
>NetworkManager[824]: <debug> [1455210496.422305] [nm-dispatcher.c:347] dispatcher_done_cb(): (5) failed to call dispatcher scripts: (org.freedesktop.systemd1.LoadFailed) Unit dbus-org.freedesktop.nm-dispatcher.service failed to load: No such file or directory.
>NetworkManager[824]: <debug> [1455210496.531806] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'scan'
>NetworkManager[824]: <debug> [1455210496.532490] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'scan'
>NetworkManager[824]: <debug> [1455210529.535155] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'scan'
>NetworkManager[824]: <debug> [1455210529.535978] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'scan'
>NetworkManager[824]: <debug> [1455210572.532943] [devices/nm-device.c:7958] nm_device_add_pending_action(): [0x8777f0] (wlan0): add_pending_action (1): 'scan'
>NetworkManager[824]: <debug> [1455210572.535004] [devices/nm-device.c:7991] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'scan'
>NetworkManager[824]: <info>  caught SIGTERM, shutting down normally.
>NetworkManager[824]: <debug> [1455210610.507151] [nm-manager.c:806] remove_device(): (lo): removing device (allow_unmanage 1, managed 0)
>NetworkManager[824]: <debug> [1455210610.507728] [devices/nm-device.c:9218] dispose(): [0x85e5c0] (lo): dispose(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210610.507891] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85e5c0] (lo): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.508009] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85e5c0] (lo): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.508135] [devices/nm-device.c:6569] nm_device_set_ip4_config(): [0x85e5c0] (lo): clear IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/3)
>NetworkManager[824]: <debug> [1455210610.508327] [devices/nm-device.c:6696] nm_device_set_ip6_config(): [0x85e5c0] (lo): clear IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/3)
>NetworkManager[824]: <debug> [1455210610.508704] [devices/nm-device.c:9277] finalize(): [0x85e5c0] (lo): finalize(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210610.508875] [nm-manager.c:806] remove_device(): (eth0): removing device (allow_unmanage 1, managed 1)
>NetworkManager[824]: <debug> [1455210610.509349] [nm-manager.c:806] remove_device(): (sit0): removing device (allow_unmanage 1, managed 0)
>NetworkManager[824]: <debug> [1455210610.509781] [devices/nm-device.c:9218] dispose(): [0x85e960] (sit0): dispose(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210610.509930] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85e960] (sit0): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.510046] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x85e960] (sit0): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.510167] [devices/nm-device.c:6569] nm_device_set_ip4_config(): [0x85e960] (sit0): clear IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/1)
>NetworkManager[824]: <debug> [1455210610.510454] [devices/nm-device.c:6696] nm_device_set_ip6_config(): [0x85e960] (sit0): clear IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/1)
>NetworkManager[824]: <debug> [1455210610.511855] [devices/nm-device.c:9277] finalize(): [0x85e960] (sit0): finalize(): NMDeviceGeneric
>NetworkManager[824]: <debug> [1455210610.512535] [nm-manager.c:806] remove_device(): (wlan0): removing device (allow_unmanage 1, managed 1)
>NetworkManager[824]: <debug> [1455210610.513230] [devices/nm-device.c:7596] nm_device_set_unmanaged(): [0x8777f0] (wlan0): now unmanaged
>NetworkManager[824]: <info>  (wlan0): device state change: disconnected -> unmanaged (reason 'unmanaged') [30 10 3]
>NetworkManager[824]: <debug> [1455210610.514775] [devices/nm-device.c:7152] nm_device_take_down(): [0x8777f0] (wlan0): taking down device.
>NetworkManager[824]: <debug> [1455210610.515472] [platform/nm-platform.c:1137] nm_platform_link_set_down(): platform: link: setting down 'wlan0' (4)
>NetworkManager[824]: <debug> [1455210610.516261] [platform/nm-linux-platform.c:2960] link_change_flags(): platform-linux: link: change 4: flags unset 'up' (1)
>NetworkManager[824]: <debug> [1455210610.524592] [platform/nm-linux-platform.c:2820] do_change_link(): platform-linux: do-change-link: success changing link 4
>NetworkManager[824]: <debug> [1455210610.524905] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 4: wlan0 <DOWN;broadcast,multicast> mtu 1500 arp 1 wifi init addr 44:C3:06:20:22:18 driver ath9k
>NetworkManager[824]: <debug> [1455210610.524972] [devices/nm-device.c:1576] link_changed_cb(): [0x8777f0] (wlan0): queued link change for ifindex 4
>NetworkManager[824]: <debug> [1455210610.525320] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '0' (current value is '1')
>NetworkManager[824]: <debug> [1455210610.525447] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210610.525574] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/hop_limit' to '64' (current value is identical)
>NetworkManager[824]: <debug> [1455210610.525705] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_pinfo' to '1' (current value is '0')
>NetworkManager[824]: <debug> [1455210610.525895] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_rtr_pref' to '1' (current value is '0')
>NetworkManager[824]: <debug> [1455210610.526302] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra' to '1' (current value is '0')
>NetworkManager[824]: <debug> [1455210610.526824] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_defrtr' to '1' (current value is '0')
>NetworkManager[824]: <debug> [1455210610.535744] [devices/nm-device.c:9218] dispose(): [0x8777f0] (wlan0): dispose(): NMDeviceWifi
>NetworkManager[824]: <debug> [1455210610.535857] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.535890] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x8777f0] (wlan0): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.535956] [devices/nm-device.c:9277] finalize(): [0x8777f0] (wlan0): finalize(): NMDeviceWifi
>NetworkManager[824]: <debug> [1455210610.536006] [nm-manager.c:806] remove_device(): (ttyACM3): removing device (allow_unmanage 1, managed 1)
>NetworkManager[824]: <info>  (ttyACM3): device state change: activated -> deactivating (reason 'unmanaged') [100 110 3]
>NetworkManager[824]: <debug> [1455210610.536223] [nm-active-connection.c:514] check_master_ready(): active-connection[0x809300]: not signalling master-ready (not activating)
>NetworkManager[824]: <debug> [1455210610.557613] [nm-dispatcher.c:444] _dispatcher_call(): (6) (ttyACM3) dispatching action 'pre-down' (blocking)
>NetworkManager[824]: <debug> [1455210610.557675] [nm-dispatcher.c:457] _dispatcher_call(): (6) ignoring request; no scripts in /etc/NetworkManager/dispatcher.d/pre-down.d
>NetworkManager[824]: <debug> [1455210610.557709] [devices/nm-device.c:7596] nm_device_set_unmanaged(): [0x88e5a0] (ttyACM3): now unmanaged
>NetworkManager[824]: <info>  (ttyACM3): device state change: deactivating -> unmanaged (reason 'unmanaged') [110 10 3]
>NetworkManager[824]: <debug> [1455210610.557821] [devices/nm-device.c:8158] nm_device_cleanup(): [0x88e5a0] (ttyACM3): deactivating device (reason 'unmanaged') [3]
>NetworkManager[824]: <debug> [1455210610.557853] [nm-firewall-manager.c:256] nm_firewall_manager_remove_from_zone(): (ppp0) firewall zone remove skipped (not running)
>NetworkManager[824]: <debug> [1455210610.557885] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.557915] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.558032] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/ppp0/disable_ipv6' to '1' (current value is identical)
>NetworkManager[824]: <debug> [1455210610.558130] [platform/nm-linux-platform.c:2425] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/ppp0/accept_ra' to '0' (current value is '1')
>NetworkManager[824]: <debug> [1455210610.558224] [platform/nm-linux-platform.c:2423] _log_dbg_sysctl_set_impl(): platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/ppp0/use_tempaddr' to '0' (current value is identical)
>NetworkManager[824]: <debug> [1455210610.558612] [NetworkManagerUtils.c:667] nm_utils_kill_child_async(): kill child process 'pppd' (842): wait for process to terminate after sending SIGTERM (15) (send SIGKILL in 2000 milliseconds)...
>Terminating on signal 15
>NetworkManager[824]: <debug> [1455210610.558699] [devices/wwan/nm-modem-broadband.c:984] disconnect(): (ttyACM3): notifying ModemManager about the modem disconnection
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate'
>NetworkManager[824]: <debug> [1455210610.558890] [nm-route-manager.c:467] _vx_route_sync(): route-mgr4:   7: sync 0 IPv4 routes
>NetworkManager[824]: <debug> [1455210610.558947] [platform/nm-platform.c:2234] nm_platform_ip4_route_delete(): platform: route: deleting IPv4 route 10.168.171.255/32, metric=700, ifindex 7 dev ppp0
>NetworkManager[824]: <debug> [1455210610.559569] [platform/nm-linux-platform.c:2778] do_delete_object(): platform-linux: do-delete-ip4-route: success deleting '7: 10.168.171.255/32 700'
>Connect time 1.9 minutes.
>NetworkManager[824]: <debug> [1455210610.560286] [platform/nm-platform.c:2914] log_ip4_route(): platform: signal: route   4 removed: 10.168.171.255/32 via 0.0.0.0 dev 7 metric 700 mss 0 src rtprot-kernel scope link pref-src 10.168.171.255
>Sent 0 bytes, received 0 bytes.
>NetworkManager[824]: <debug> [1455210610.561108] [devices/nm-device.c:7507] device_ipx_changed(): [0x88e5a0] (ttyACM3): queued IP4 config change
>Script /etc/ppp/ip-down started (pid 870)
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
>cif6addr: ioctl(SIOCDIFADDR): No such address
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
>sent [LCP TermReq id=0x2 "User request"]
>NetworkManager[824]: <debug> [1455210610.564471] [platform/nm-platform.c:2902] log_ip4_address(): platform: signal: address 4 removed: 10.168.171.255/32 lft forever pref forever lifetime 142-0[4294967295,4294967295] dev 7 src kernel
>NetworkManager[824]: <debug> [1455210610.564556] [nm-default-route-manager.c:1318] _resync_idle_reschedule(): default-route: resync: schedule on idle
>NetworkManager[824]: <debug> [1455210610.564698] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210610.565498] [platform/nm-platform-utils.c:69] ethtool_get(): ethtool: Request failed: Operation not supported
>NetworkManager[824]: <debug> [1455210610.565623] [platform/nm-platform.c:2896] log_link(): platform: signal: link changed: 7: ppp0 <NOARP,DOWN;pointopoint,multicast,noarp> mtu 1500 arp 512 unknown init driver unknown
>NetworkManager[824]: <debug> [1455210610.566655] [devices/nm-device.c:1581] link_changed_cb(): [0x88e5a0] (ttyACM3): queued link change for ip-ifindex 7
>NetworkManager[824]: <debug> [1455210610.566979] [platform/nm-platform.c:2914] log_ip4_route(): platform: signal: route   4 removed: 0.0.0.0/0 via 10.168.171.255 dev 7 metric 700 mss 0 src user scope global
>NetworkManager[824]: <debug> [1455210610.567058] [nm-route-manager.c:467] _vx_route_sync(): route-mgr6:   7: sync 0 IPv6 routes
>NetworkManager[824]: <debug> [1455210610.567638] [devices/nm-device.c:7720] nm_device_update_metered(): [0x88e5a0] (ttyACM3): set metered value 0
>NetworkManager[824]: <debug> [1455210610.567748] [nm-default-route-manager.c:663] _entry_at_idx_update(): default-route: entry[1/dev:0x88e5a0:ttyACM3:0:+sync]: record:update 0.0.0.0/0 via 0.0.0.0 dev 7 metric 4294967295 mss 0 src unknown (700)
>NetworkManager[824]: <debug> [1455210610.568235] [nm-default-route-manager.c:1294] _resync_idle_cancel(): default-route: resync: cancelled (888)
>NetworkManager[824]: <debug> [1455210610.568706] [nm-default-route-manager.c:663] _entry_at_idx_update(): default-route: entry[0/dev:0x88e5a0:ttyACM3:0:+sync]: record:add    ::/0 via :: dev 7 metric 4294967295 mss 0 src unknown (4294967295)
>NetworkManager[824]: <debug> [1455210610.569093] [nm-default-route-manager.c:684] _entry_at_idx_remove(): default-route: entry[1/dev:0x88e5a0:ttyACM3:0:+sync]: record:remove 0.0.0.0/0 via 0.0.0.0 dev 7 metric 4294967295 mss 0 src unknown (700)
>NetworkManager[824]: <debug> [1455210610.569489] [nm-default-route-manager.c:684] _entry_at_idx_remove(): default-route: entry[0/dev:0x88e5a0:ttyACM3:0:+sync]: record:remove ::/0 via :: dev 7 metric 4294967295 mss 0 src unknown (4294967295)
>NetworkManager[824]: <debug> [1455210610.569909] [devices/nm-device.c:6569] nm_device_set_ip4_config(): [0x88e5a0] (ttyACM3): clear IP4Config instance (/org/freedesktop/NetworkManager/IP4Config/6)
>NetworkManager[824]: <debug> [1455210610.570331] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210610.570705] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed
>NetworkManager[824]: <debug> [1455210610.571055] [dns-manager/nm-dns-manager.c:1066] nm_dns_manager_end_updates(): (device_ip4_config_changed): committing DNS changes (0)
>NetworkManager[824]: <debug> [1455210610.571445] [dns-manager/nm-dns-manager.c:634] update_dns(): updating resolv.conf
>NetworkManager[824]: <debug> [1455210610.572220] [devices/nm-device.c:6696] nm_device_set_ip6_config(): [0x88e5a0] (ttyACM3): clear IP6Config instance (/org/freedesktop/NetworkManager/IP6Config/6)
>Script /etc/ppp/ip-down finished (pid 870), status = 0x0
>NetworkManager[824]: <debug> [1455210610.572767] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (device_ip6_config_changed): queueing DNS updates (1)
>NetworkManager[824]: <debug> [1455210610.573173] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>NetworkManager[824]: <debug> [1455210610.573590] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (device_ip6_config_changed): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210610.574110] [devices/nm-device.c:7152] nm_device_take_down(): [0x88e5a0] (ttyACM3): taking down device.
>NetworkManager[824]: <debug> [1455210610.574460] [devices/nm-device.c:7189] take_down(): [0x88e5a0] (ttyACM3): cannot take down device without ifindex
>NetworkManager[824]: <debug> [1455210610.575128] [nm-active-connection.c:514] check_master_ready(): active-connection[0x809300]: not signalling master-ready (not activating)
>rcvd [LCP TermAck id=0x2]
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect'
>NetworkManager[824]: <debug> [1455210610.575877] [devices/wwan/nm-modem-broadband.c:984] disconnect(): (ttyACM3): notifying ModemManager about the modem disconnection
>Connection terminated.
>NetworkManager[824]: <debug> [1455210610.576779] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (1)
>Connect time 1.9 minutes.
>NetworkManager[824]: <debug> [1455210610.577441] [dns-manager/nm-dns-manager.c:1057] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
>Sent 0 bytes, received 0 bytes.
>NetworkManager[824]: <debug> [1455210610.579261] [dns-manager/nm-dns-manager.c:1061] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (0)
>NetworkManager[824]: <debug> [1455210610.579342] [nm-dispatcher.c:444] _dispatcher_call(): (7) (ttyACM3) dispatching action 'down'
>NetworkManager[824]: <debug> [1455210610.581248] [devices/nm-device.c:9218] dispose(): [0x88e5a0] (ttyACM3): dispose(): NMDeviceModem
>NetworkManager[824]: <debug> [1455210610.581329] [devices/nm-device.c:5914] nm_device_queued_ip_config_change_clear(): [0x88e5a0] (ttyACM3): clearing queued IP4 config change
>NetworkManager[824]: <debug> [1455210610.581367] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'dhcp6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.581397] [devices/nm-device.c:8005] nm_device_remove_pending_action(): [0x88e5a0] (ttyACM3): remove_pending_action (0): 'autoconf6' not pending (expected)
>NetworkManager[824]: <debug> [1455210610.582085] [devices/nm-device.c:9277] finalize(): [0x88e5a0] (ttyACM3): finalize(): NMDeviceModem
>NetworkManager[824]: <debug> [1455210610.583450] [nm-manager.c:286] active_connection_remove(): Assumed connection disconnected. Deleting generated connection 'eth0' (c7361bb2-01ec-46d5-91c9-755189a3daea)
>NetworkManager[824]: <debug> [1455210610.584597] [settings/nm-agent-manager.c:1417] nm_agent_manager_delete_secrets(): Deleting secrets for connection /org/freedesktop/NetworkManager/Settings/2 (eth0)
>NetworkManager[824]: <info>  exiting (success)
>NetworkManager[824]: <debug> [1455210610.592596] [dhcp-manager/nm-dhcp-manager.c:376] _singleton_instance_weak_ref_cb(): disposing NMDhcpManager singleton (0x7d9ae0)
>NetworkManager[824]: <debug> [1455210610.592682] [dns-manager/nm-dns-manager.c:634] update_dns(): updating resolv.conf
>NetworkManager[824]: <debug> [1455210610.593158] [dns-manager/nm-dns-manager.c:1077] _singleton_instance_weak_ref_cb(): disposing NMDnsManager singleton (0x83f160)
>NetworkManager[824]: <debug> [1455210610.593621] [supplicant-manager/nm-supplicant-manager.c:321] _singleton_instance_weak_ref_cb(): disposing NMSupplicantManager singleton (0x80de10)
>NetworkManager[824]: <debug> [1455210610.593683] [nm-config.c:1045] _singleton_instance_weak_ref_cb(): disposing NMConfig singleton (0x8090c0)
>NetworkManager[824]: <debug> [1455210610.593749] [nm-dbus-manager.c:82] _singleton_destructor(): disown NMDBusManager singleton (0x813d00)
>NetworkManager[824]: <debug> [1455210610.593796] [nm-route-manager.c:78] _singleton_instance_weak_ref_cb(): disposing NMRouteManager singleton (0x86b580)
>NetworkManager[824]: <debug> [1455210610.593842] [nm-default-route-manager.c:62] _singleton_instance_weak_ref_cb(): disposing NMDefaultRouteManager singleton (0x80dd20)
>NetworkManager[824]: <debug> [1455210610.593981] [nm-firewall-manager.c:340] _singleton_instance_weak_ref_cb(): disposing NMFirewallManager singleton (0x80dc80)
>NetworkManager[824]: <debug> [1455210610.594020] [nm-sleep-monitor-systemd.c:246] _singleton_instance_weak_ref_cb(): disposing NMSleepMonitor singleton (0x843920)
>NetworkManager[824]: <debug> [1455210610.594050] [nm-sleep-monitor-systemd.c:69] drop_inhibitor(): Dropping systemd sleep inhibitor
>NetworkManager[824]: <debug> [1455210610.594459] [settings/nm-agent-manager.c:1561] _singleton_destructor(): disown NMAgentManager singleton (0x80db00)
>NetworkManager[824]: <debug> [1455210610.594539] [settings/nm-inotify-helper.c:153] _singleton_instance_weak_ref_cb(): disposing NMInotifyHelper singleton (0x830960)
>NetworkManager[824]: <debug> [1455210610.594625] [vpn-manager/nm-vpn-manager.c:203] _singleton_instance_weak_ref_cb(): disposing NMVpnManager singleton (0x8098a0)
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead'
>nm-pppd-plugin-Message: nm-ppp-plugin: (nm_exit_notify): cleaning up

Actions: View

Attachments on bug 94093: 121681 | 121682

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.