-- Logs begin at ti. 2014-05-13 08:55:43 CEST, end at lø. 2014-07-19 13:43:26 CEST. --
juli 19 13:41:52 envy.fud.no ModemManager[3543]: <info>  logging: level 'debug'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Simple connect started...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    PIN: unspecified
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    Operator ID: unspecified
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    Allowed roaming: yes
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    APN: telenor
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    IP family: ipv4v6
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    Allowed authentication: unspecified
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    User: unspecified
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    Password: unspecified
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    Number: unspecified
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Simple connect state (3/8): Enable
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: state changed (disabled -> enabling)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Skipping modem initialization: device hotplugged
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) opening serial port...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): running init sequence...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) opening serial port...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) device open count is 1 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): running init sequence...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Flashing primary AT port before enabling...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'ATE0<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): --> 'ATE0<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): <-- 'ATE0'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'ATV1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): <-- '<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CMEE=1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'ATX4<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT&C1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loading power state...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CFUN?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CFUN: 1<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> No need to change power state: already in 'on' power state
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+IFC=1,1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>ERROR<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Got failure code 100: Unknown error
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CSCS=?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CSCS: ("GSM","HEX","IRA","PCCP","PCDN","UCS2","8859-1")<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CSCS="UCS2"<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CSCS?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Checking indicator support...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CIND=?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CIND: ("service",(0-1)),("call",(0-1)),("callsetup",(0-3))<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem supports service indications via CIND at index '1'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) Setting 3GPP unsolicited events handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) Setting 3GPP unsolicited events handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CMER=3,0,0,1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): --> 'AT+CMER=3,0,0,1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT%NWSTATE=1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>%NWSTATE: 4,24201,3G-HSDPA-HSUPA,-,0<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem /org/freedesktop/ModemManager1/Modem/18: signal quality updated (80)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: access technology changed (unknown -> hspa)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) setting up 3GPP unsolicited registration messages handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) setting up 3GPP unsolicited registration messages handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CREG=2<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): --> 'AT+CREG=2<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CGREG=2<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): --> 'AT+CGREG=2<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CREG?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CREG: 2,1,"52DB","00D4D899",2<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: 3GPP Registration state changed (unknown -> registering)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loading Operator Code...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+COPS=3,2;+COPS?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+COPS: 0,2,"24201",2<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loaded Operator Code: 24201
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loading Operator Name...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CGREG?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CGREG: 2,1,"52DB","00D4D899",2,"01"<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem has 3GPP/USSD capabilities, enabling the Modem 3GPP/USSD interface...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) Setting unsolicited result code handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) Setting unsolicited result code handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+COPS=3,0;+COPS?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+COPS: 0,0,"N Telenor",2<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loaded Operator Name: N Telenor
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: 3GPP Registration state changed (registering -> home)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Will start keeping track of state for subsystem '3gpp'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CUSD=1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem has location capabilities, enabling the Location interface...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Need to enable the following location sources: '3gpp-lac-ci'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loading Operator Code...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem has messaging capabilities, enabling the Messaging interface...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CREG?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CREG: 2,1,"52DB","00D4D899",2<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '52DB', Cell ID: 'D4D899')
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 5 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+COPS=3,2;+COPS?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+COPS: 0,2,"24201",2<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loaded Operator Code: 24201
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: 3GPP location updated (MCC: '242', MNC: '1', Location area code: '52DB', Cell ID: 'D4D899')
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loading Operator Name...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 5 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CMGF=?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CMGF: (0-1)<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 5 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CGREG?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CGREG: 2,1,"52DB","00D4D899",2,"01"<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+COPS=3,0;+COPS?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+COPS: 0,0,"N Telenor",2<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loaded Operator Name: N Telenor
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CMGF=0<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Successfully set preferred SMS mode: 'PDU'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CPMS="","ME","ME"<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CMS ERROR: 518<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: Invalid message error code: 518
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Got failure code 500: Unknown error
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Couldn't set default storage: 'Unknown error'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Listing SMS parts in storage 'sm'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Locking SMS storages to: mem1 (SM), mem2 (none)...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CPMS="SM"<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CPMS: 0,20,2,50,2,50<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CMGL=4<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Listing SMS parts in storage 'me'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Locking SMS storages to: mem1 (ME), mem2 (none)...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CPMS="ME"<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CPMS: 2,50,2,50,2,50<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CMGL=4<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CMGL: 30,1,,158<CR><LF>06917474190900440A917489763164000021404171624480A0050003000201956110B94C07D9C37290FB0D3AB3CBE4323B7D06A541F4B27B4D2F83C8653A081D06D9CB6CD05A5D06D1D364103D4D06D1D36CD09C9D5ED3416950FB0172BF416779985E6797E56550BB4C06D51EF239881C3E97DD20F203042297E9A0B5BAEC7697E5A0B53D2C0FBBC9F23288FC0081C8653AC8BC9783DC6FD05CBD0799EB6776D85D06911F<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '+CMGL: 31,1,,91<CR><LF>06917474190900440A9174897631640000214041716254805305000300020241A076D90D2283CE0F3968FE06CDCB69371DD42E9341E8FA5C9C3F9FD3EE7318543E83CA72D0FC0D9AC3CB6E3A481D069DDF64D09A5D6E83DE6790BDCC5EBFDBEDB21B<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Parsing PDU (30)...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   SMSC address parsed: '+4747919000'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   Deliver type PDU detected
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   Number parsed: '+4798671346'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   PID: 0
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   user data encoding is GSM7
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   user data length: 160 elements
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   user data length: 140 bytes
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Decoding SMS text with '153' elements
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Converting SMS part text from GSM7 to UTF8...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    Got UTF-8 text: 'Ja det var no gledelig i tenkte det ha vel kje tid tid til slikt i må no gratulere med 5års dagen då  det kjenner kvarandre då  det fär no sjä fuglane då'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Correctly parsed PDU (30)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> SMS part at 'me/30' is from a multipart SMS (reference: '0', sequence: '1')
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Added received SMS at '/org/freedesktop/ModemManager1/SMS/6'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Parsing PDU (31)...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   SMSC address parsed: '+4747919000'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   Deliver type PDU detected
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   Number parsed: '+4798671346'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   PID: 0
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   user data encoding is GSM7
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   user data length: 83 elements
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>   user data length: 73 bytes
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Decoding SMS text with '76' elements
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Converting SMS part text from GSM7 to UTF8...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug>    Got UTF-8 text: '  men d går so seint med husbygginga eg er so spent ja god klem og velkommen'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Correctly parsed PDU (31)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> SMS part at 'me/31' is from a multipart SMS (reference: '0', sequence: '2')
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Listing SMS parts in storage 'sr'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Locking SMS storages to: mem1 (SR), mem2 (none)...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CPMS="SR"<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CPMS: 0,50,2,50,2,50<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CMGL=4<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) Setting messaging unsolicited events handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM15) Setting messaging unsolicited events handlers
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CNMI=2,1,2,1,0<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem has time capabilities, enabling the Time interface...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: state changed (enabling -> registered)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Periodic signal quality checks enabled (interval = 3s)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> loading signal quality...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Periodic access technology checks enabled
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Simple connect state (4/8): Wait to get fully enabled
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Simple connect state (5/8): Register
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Already registered in network '24201', automatic registration not launched...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Simple connect state (6/8): Bearer
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Creating new bearer...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Simple connect state (7/8): Connect
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Connecting bearer '/org/freedesktop/ModemManager1/Bearer/12'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: state changed (registered -> connecting)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Launching 3GPP connection attempt with APN 'telenor'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Looking for best CID...
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 4 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CSQ<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CSQ: 21,0<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem /org/freedesktop/ModemManager1/Modem/18: signal quality updated (67)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Periodic signal quality checks rescheduled (interval = 30s)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT%NWSTATE<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>%NWSTATE: 4,24201,3G-HSDPA-HSUPA,-,0<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Modem /org/freedesktop/ModemManager1/Modem/18: signal quality updated (80)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CGDCONT?<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF><CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> No PDP contexts found
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Using CID 1
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT+CGDCONT=1,"IPV4V6","telenor"<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Not using authentication
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT%IPDPCFG=1,0,0,"",""<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT%IPDPACT=1,0<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>+CME ERROR: 767<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: Invalid mobile equipment error code: 767
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> Got failure code 100: Unknown error
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 3 (open)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (close)
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT%IPDPACT=1,1<CR>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>%IPDPACT: 1, 2, 0<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>OK<CR><LF>'
juli 19 13:43:06 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:08 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>%NWSTATE: 4,24201,3G-HSDPA-HSUPA,-,0<CR><LF>'
juli 19 13:43:08 envy.fud.no ModemManager[3543]: <debug> Modem /org/freedesktop/ModemManager1/Modem/18: signal quality updated (80)
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>%NWSTATE: 4,24201,3G-HSDPA-HSUPA,HSDPA-HSUPA-HSPA+,0<CR><LF>'
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> Modem /org/freedesktop/ModemManager1/Modem/18: signal quality updated (80)
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: access technology changed (hspa -> hspa-plus)
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>%IPDPACT: 1, 1, 0<CR><LF>'
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 2 (open)
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): --> 'AT%IPDPADDR=1<CR>'
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> (ttyACM14): <-- '<CR><LF>%IPDPADDR: 1, 46.157.76.179, 46.157.76.180, 193.213.112.4, 130.67.15.198, 0.0.0.0, 0.0.0.0, 255.0.0.0, 46.157.76.180, ::, ::, ::, ::, ::, ::, ::, ::<CR><LF>OK<CR><LF>'
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> (ttyACM14) device open count is 1 (close)
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> Couldn't connect bearer '/org/freedesktop/ModemManager1/Bearer/12': 'Couldn't parse IPv6 address '::''
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <info>  Modem /org/freedesktop/ModemManager1/Modem/18: state changed (connecting -> registered)
juli 19 13:43:09 envy.fud.no ModemManager[3543]: <debug> Couldn't connect bearer: 'Couldn't parse IPv6 address '::''
