-- Logs begin at ti. 2014-05-13 08:55:43 CEST, end at lø. 2014-06-28 11:21:02 CEST. --
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.254882] [devices/nm-device.c:6436] nm_device_add_pending_action(): (ttyACM14): add_pending_action (1): 'activation::0x7f32f63c7e20'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <info> Activation (ttyACM14) starting connection 'Default (telenor)'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <info> Activation (ttyACM14) Stage 1 of 5 (Device Prepare) scheduled...
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <info> Activation (ttyACM14) Stage 1 of 5 (Device Prepare) started...
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <info> (ttyACM14): device state change: disconnected -> prepare (reason 'none') [30 40 0]
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <info> NetworkManager state is now CONNECTING
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.280830] [nm-active-connection.c:446] check_master_ready(): (0x7f32f63c7e20): not signalling master-ready (no master)
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.280910] [devices/nm-device.c:6436] nm_device_add_pending_action(): (lo): add_pending_action (1): 'autoactivate'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.280936] [devices/nm-device.c:6436] nm_device_add_pending_action(): (enp0s25): add_pending_action (1): 'autoactivate'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.280959] [devices/nm-device.c:6436] nm_device_add_pending_action(): (wlo1): add_pending_action (1): 'autoactivate'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.281002] [nm-manager.c:4379] policy_activating_device_changed(): ActivatingConnection now Default (telenor)
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <info> Activation (ttyACM14) Stage 1 of 5 (Device Prepare) complete.
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.281885] [devices/nm-device.c:6470] nm_device_remove_pending_action(): (lo): remove_pending_action (0): 'autoactivate'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.282052] [devices/nm-device.c:6470] nm_device_remove_pending_action(): (enp0s25): remove_pending_action (0): 'autoactivate'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <debug> [1403947230.282282] [devices/nm-device.c:6470] nm_device_remove_pending_action(): (wlo1): remove_pending_action (0): 'autoactivate'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <info>  Simple connect started...
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    PIN: unspecified
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    Operator ID: unspecified
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    Allowed roaming: yes
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    APN: telenor
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    IP family: ipv4v6
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    Allowed authentication: unspecified
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    User: unspecified
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    Password: unspecified
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug>    Number: *99#
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <info>  Simple connect state (4/8): Wait to get fully enabled
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <info>  Simple connect state (5/8): Register
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Already registered in network '24201', automatic registration not launched...
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <info>  Simple connect state (6/8): Bearer
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Creating new bearer...
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (open)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 1 (close)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <info>  Simple connect state (7/8): Connect
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Connecting bearer '/org/freedesktop/ModemManager1/Bearer/1'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <info>  Modem /org/freedesktop/ModemManager1/Modem/6: state changed (registered -> connecting)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Launching 3GPP connection attempt with APN 'telenor'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Looking for best CID...
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (open)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT+CGDCONT?<CR>'
juni 28 11:20:30 envy.fud.no NetworkManager[738]: <info> (ttyACM14): modem state changed, 'registered' --> 'connecting' (reason: user-requested)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF><CR><LF>OK<CR><LF>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> No PDP contexts found
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Using CID 1
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 3 (open)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (close)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT+CGDCONT=1,"IPV4V6","telenor"<CR>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Not using authentication
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 3 (open)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (close)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT%IPDPCFG=1,0,0,"",""<CR>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 3 (open)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (close)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT%IPDPACT=1,0<CR>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>+CME ERROR: 767<CR><LF>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: Invalid mobile equipment error code: 767
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> Got failure code 100: Unknown error
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 3 (open)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (close)
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT%IPDPACT=1,1<CR>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>%IPDPACT: 1, 2, 0<CR><LF>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juni 28 11:20:30 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 1 (close)
juni 28 11:20:31 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>%NWSTATE: 4,24201,3G-HSDPA-HSUPA,-,0<CR><LF>'
juni 28 11:20:31 envy.fud.no ModemManager[2329]: <debug> Modem /org/freedesktop/ModemManager1/Modem/6: signal quality updated (80)
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (open)
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> loading signal quality...
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 3 (open)
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT%NWSTATE<CR>'
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>%NWSTATE: 4,24201,3G-HSDPA-HSUPA,-,0<CR><LF><CR><LF>OK<CR><LF>'
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> Modem /org/freedesktop/ModemManager1/Modem/6: signal quality updated (80)
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (close)
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT+CSQ<CR>'
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>+CSQ: 13,0<CR><LF><CR><LF>OK<CR><LF>'
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 1 (close)
juni 28 11:20:32 envy.fud.no ModemManager[2329]: <debug> Modem /org/freedesktop/ModemManager1/Modem/6: signal quality updated (41)
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>%NWSTATE: 4,24201,3G-HSDPA-HSUPA,HSDPA-HSUPA-HSPA+,0<CR><LF>'
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> Modem /org/freedesktop/ModemManager1/Modem/6: signal quality updated (80)
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <info>  Modem /org/freedesktop/ModemManager1/Modem/6: access technology changed (hspa -> hspa-plus)
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>%IPDPACT: 1, 1, 0<CR><LF>'
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 2 (open)
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): --> 'AT%IPDPADDR=1<CR>'
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> (ttyACM14): <-- '<CR><LF>%IPDPADDR: 1, 109.179.2.225, 109.179.2.226, 193.213.112.4, 130.67.15.198, 0.0.0.0, 0.0.0.0, 255.255.255.0, 109.179.2.226, ::, ::, ::, ::, ::, ::, ::, ::<CR><LF>OK<CR><LF>'
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> (ttyACM14) device open count is 1 (close)
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> Couldn't connect bearer '/org/freedesktop/ModemManager1/Bearer/1': 'Couldn't parse IPv6 address '::''
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <info>  Modem /org/freedesktop/ModemManager1/Modem/6: state changed (connecting -> registered)
juni 28 11:20:33 envy.fud.no ModemManager[2329]: <debug> Couldn't connect bearer: 'Couldn't parse IPv6 address '::''
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <info> (ttyACM14): modem state changed, 'connecting' --> 'registered' (reason: user-requested)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <warn> (ttyACM14) failed to connect modem: Couldn't parse IPv6 address '::'
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.606094] [nm-modem-broadband.c:97] translate_mm_error(): unmapped error detected: 'Couldn't parse IPv6 address '::''
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <info> (ttyACM14): device state change: prepare -> failed (reason '(null)') [40 120 1]
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <info> NetworkManager state is now DISCONNECTED
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.606759] [nm-active-connection.c:442] check_master_ready(): (0x7f32f63c7e20): not signalling master-ready (not activating)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.606806] [devices/nm-device.c:6470] nm_device_remove_pending_action(): (ttyACM14): remove_pending_action (0): 'activation::0x7f32f63c7e20'
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.607353] [nm-policy.c:1453] device_state_changed(): Connection 'Default (telenor)' failed to autoconnect; 3 tries left
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.608013] [nm-manager.c:4379] policy_activating_device_changed(): ActivatingConnection now (none)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <warn> Activation (ttyACM14) failed for connection 'Default (telenor)'
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.609322] [devices/nm-device.c:6436] nm_device_add_pending_action(): (ttyACM14): add_pending_action (1): 'queued state change to disconnected'
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.611415] [devices/nm-device.c:6982] nm_device_queue_state(): (ttyACM14): queued state change to disconnected due to none (id 15744)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.614213] [devices/nm-device.c:6930] queued_set_state(): (ttyACM14): running queued state change to disconnected (id 15744)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <info> (ttyACM14): device state change: failed -> disconnected (reason 'none') [120 30 0]
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <info> (ttyACM14): deactivating device (reason 'none') [0]
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.616748] [firewall-manager/nm-firewall-manager.c:204] nm_firewall_manager_remove_from_zone(): (ttyACM14) firewall zone remove -> * [8]
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.617963] [devices/nm-device.c:6490] nm_device_remove_pending_action(): (ttyACM14): remove_pending_action (1): 'autoconf6' not pending (expected)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.619019] [platform/nm-linux-platform.c:2017] sysctl_set(): sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM14/disable_ipv6': (2) Ingen slik fil eller filkatalog
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.619608] [platform/nm-linux-platform.c:2017] sysctl_set(): sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM14/accept_ra': (2) Ingen slik fil eller filkatalog
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.620675] [platform/nm-linux-platform.c:2017] sysctl_set(): sysctl: failed to open '/proc/sys/net/ipv6/conf/ttyACM14/use_tempaddr': (2) Ingen slik fil eller filkatalog
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.621819] [dns-manager/nm-dns-manager.c:1017] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (1)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.622454] [dns-manager/nm-dns-manager.c:1035] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.623208] [dns-manager/nm-dns-manager.c:1039] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (0)
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.623891] [devices/nm-device.c:6436] nm_device_add_pending_action(): (ttyACM14): add_pending_action (2): 'autoactivate'
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.624343] [devices/nm-device.c:6470] nm_device_remove_pending_action(): (ttyACM14): remove_pending_action (1): 'queued state change to disconnected'
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.636516] [firewall-manager/nm-firewall-manager.c:176] remove_cb(): (ttyACM14) firewall zone remove failed [8]: (32) UNKNOWN_INTERFACE: ttyACM14
juni 28 11:20:33 envy.fud.no NetworkManager[738]: <debug> [1403947233.637924] [devices/nm-device.c:6470] nm_device_remove_pending_action(): (ttyACM14): remove_pending_action (0): 'autoactivate'
