AW: MC7455 not working
Thomas Lang
thomas.lang at tactilo.eu
Fri Jun 17 15:27:34 UTC 2016
Hmm, so itried dieffrent things out and what I have observed is that if I don’t use NM and MM as sudo systemctl enable NetworkManager ModemManager. The SIM card fails. You could see this in the last mail. When I start the PC after power down. And stop MM with :
sudo service ModemManager stop
go at ubuntu:~$ mmcli -L
No modems were found
go at ubuntu:~$ mmcli -m 0
/org/freedesktop/ModemManager1/Modem/0 (device id '7b4cfd7e877aff3cade0b53c88a7b33e7a95c7df')
-------------------------
Hardware | manufacturer: 'Sierra Wireless, Incorporated'
| model: 'MC7455'
| revision: 'SWI9X30C_02.08.02.00 r5428 CARMD-EV-FRMWR2 2016/01/06 20:38:53'
| supported: 'gsm-umts
| lte
| gsm-umts, lte'
| current: 'gsm-umts, lte'
| equipment id: '359072060132616'
-------------------------
System | device: '/sys/devices/pci0000:00/0000:00:13.0/usb1/1-1/1-1.3'
| drivers: 'qcserial, qmi_wwan'
| plugin: 'Sierra'
| primary port: 'cdc-wdm0'
| ports: 'ttyUSB2 (at), ttyUSB0 (qcdm), wwp0s19u1u3i10 (net), cdc-wdm0 (qmi), cdc-wdm1 (qmi), wwan0 (net)'
-------------------------
Numbers | own : 'unknown'
-------------------------
Status | lock: 'sim-pin2'
| unlock retries: 'sim-pin (3), sim-pin2 (3), sim-puk (10), sim-puk2 (10)'
| state: 'registered'
| power state: 'on'
| access tech: 'lte'
| signal quality: '54' (recent)
-------------------------
Modes | supported: 'allowed: 2g, 3g, 4g; preferred: none'
| current: 'allowed: 2g, 3g, 4g; preferred: none'
-------------------------
Bands | supported: 'u2100, u1800, u1900, u17iv, u850, u900, eutran-i, eutran-ii, eutran-iii, eutran-iv, eutran-v, eutran-vii, eutran-viii, eutran-xii, eutran-xiii, eutran-xx, eutran-xxv, eutran-xli'
| current: 'u2100, u1800, u1900, u17iv, u850, u900, eutran-i, eutran-ii, eutran-iii, eutran-iv, eutran-v, eutran-vii, eutran-viii, eutran-xii, eutran-xiii, eutran-xx, eutran-xxv, eutran-xli'
-------------------------
IP | supported: 'ipv4, ipv6, ipv4v6'
-------------------------
3GPP | imei: '359072060132616'
| enabled locks: 'none'
| operator id: '26202'
| operator name: 'Vodafone'
| subscription: 'unknown'
| registration: 'home'
-------------------------
SIM | path: '/org/freedesktop/ModemManager1/SIM/0'
-------------------------
Bearers | paths: 'none'
go at ubuntu:~$ sudo nmcli d
DEVICE TYPE STATE CONNECTION
cdc-wdm0 gsm disconnected --
wlp4s0 wifi disconnected --
enp1s0 ethernet unavailable --
enp3s0 ethernet unavailable --
enp2s0 ethernet unmanaged --
lo loopback unmanaged --
go at ubuntu:~$ sudo nmcli d c cdc-wdm0
Device 'cdc-wdm0' successfully activated with '9264dfab-d648-4497-b851-97bd6a3ad1ce'.
It works. Below find the debug trace. But still if NM and MM are enable as service. PC start after powerdown I still need to restart MM once to get it running. My idea would be to restart MM somewhere with a script. Do you see another solution for now?
>>>>>> tlv_length = 7
>>>>>> message = "Set Event Report" (0x0002)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:03:07:00:07:00:03:00:04:00:13:01:00:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 7
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 7
<<<<<< tlv_length = 4
<<<<<< message = "Register Indications" (0x0003)
<<<<<< TLV:
<<<<<< type = "Serving System Events" (0x13)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = yes
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:07:02:07:00:03:00:07:00:02:04:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 7
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 7
>>>>>> tlv_length = 7
>>>>>> message = "Register Indications" (0x0003)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
ModemManager[1157]: <debug> [1466176578.472516] [mm-broadband-modem.c:9238] enabling_step(): Modem has location capabilities, enabling the Location interface...
ModemManager[1157]: <debug> [1466176578.472670] [mm-iface-modem-location.c:762] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
ModemManager[1157]: <debug> [1466176578.472987] [mm-iface-modem-3gpp.c:761] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:07:00:08:00:24:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 7
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 0
<<<<<< message = "Get Serving System" (0x0024)
ModemManager[1157]: <debug> [1466176578.473697] [mm-broadband-modem.c:9251] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
ModemManager[1157]: <debug> [1466176578.474168] [mm-broadband-modem-qmi.c:7456] messaging_set_default_storage(): setting default messaging routes...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 26
<<<<<< data = 01:19:00:00:05:06:00:01:00:32:00:0D:00:01:0A:00:02:00:00:00:01:01:00:01:01:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 25
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 13
<<<<<< message = "Set Routes" (0x0032)
<<<<<< TLV:
<<<<<< type = "Route List" (0x01)
<<<<<< length = 10
<<<<<< value = 02:00:00:00:01:01:00:01:01:01
<<<<<< translated = { [0] = '[ message_type = 'point' message_class = '0' storage = 'nv' receipt_action = 'store-and-notify' ] ' [1] = '[ message_type = 'point' message_class = '1' storage = 'nv' receipt_action = 'store-and-notify' ] '}
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 93
>>>>>> data = 01:5C:00:80:03:07:02:08:00:24:00:50:00:02:04:00:00:00:00:00:01:06:00:01:01:01:02:01:08:10:01:00:01:11:02:00:01:0B:12:0D:00:06:01:02:00:08:56:6F:64:61:66:6F:6E:65:15:03:00:01:08:01:1C:02:00:FE:FF:1D:04:00:03:D6:44:01:21:05:00:02:03:00:00:00:24:02:00:9E:BB:27:05:00:06:01:02:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 92
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 7
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 8
>>>>>> tlv_length = 80
>>>>>> message = "Get Serving System" (0x0024)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Serving System" (0x01)
>>>>>> length = 6
>>>>>> value = 01:01:01:02:01:08
>>>>>> translated = [ registration_state = 'registered' cs_attach_state = 'attached' ps_attach_state = 'attached' selected_network = '3gpp' radio_interfaces = '{ [0] = 'lte '}' ]
>>>>>> TLV:
>>>>>> type = "Roaming Indicator" (0x10)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = off
>>>>>> TLV:
>>>>>> type = "Data Service Capability" (0x11)
>>>>>> length = 2
>>>>>> value = 01:0B
>>>>>> translated = { [0] = 'lte '}
>>>>>> TLV:
>>>>>> type = "Current PLMN" (0x12)
>>>>>> length = 13
>>>>>> value = 06:01:02:00:08:56:6F:64:61:66:6F:6E:65
>>>>>> translated = [ mcc = '262' mnc = '2' description = 'Vodafone' ]
>>>>>> TLV:
>>>>>> type = "Roaming Indicator List" (0x15)
>>>>>> length = 3
>>>>>> value = 01:08:01
>>>>>> translated = { [0] = '[ radio_interface = 'lte' roaming_indicator = 'off' ] '}
>>>>>> TLV:
>>>>>> type = "LAC 3GPP" (0x1c)
>>>>>> length = 2
>>>>>> value = FE:FF
>>>>>> translated = 65534
>>>>>> TLV:
>>>>>> type = "CID 3GPP" (0x1d)
>>>>>> length = 4
>>>>>> value = 03:D6:44:01
>>>>>> translated = 21288451
>>>>>> TLV:
>>>>>> type = "Detailed Service Status" (0x21)
>>>>>> length = 5
>>>>>> value = 02:03:00:00:00
>>>>>> translated = [ status = 'available' capability = 'cs-ps' hdr_status = 'none' hdr_hybrid = 'no' forbidden = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE TAC" (0x24)
>>>>>> length = 2
>>>>>> value = 9E:BB
>>>>>> translated = 48030
>>>>>> TLV:
>>>>>> type = "MNC PCS Digit Include Status" (0x27)
>>>>>> length = 5
>>>>>> value = 06:01:02:00:00
>>>>>> translated = [ mcc = '262' mnc = '2' includes_pcs_digit = 'no' ]
ModemManager[1157]: <debug> [1466176578.542943] [mm-broadband-modem-qmi.c:4607] common_process_serving_system_3gpp(): Processing 3GPP info...
ModemManager[1157]: <info> [1466176578.543124] [mm-iface-modem-3gpp.c:1171] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
ModemManager[1157]: <debug> [1466176578.543324] [mm-iface-modem-location.c:297] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: 'FFFE', Cell ID: '144D603')
ModemManager[1157]: <debug> [1466176578.543733] [mm-iface-modem-location.c:297] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '262', MNC: '2', Location area code: 'FFFE', Cell ID: '144D603')
ModemManager[1157]: <info> [1466176578.544951] [mm-iface-modem-3gpp.c:1096] update_registration_reload_current_registration_info_ready(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
ModemManager[1157]: <debug> [1466176578.545406] [mm-iface-modem.c:1600] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:01:00:32:00:07:00:02:04:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Set Routes" (0x0032)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
ModemManager[1157]: <debug> [1466176578.600667] [mm-broadband-modem-qmi.c:7750] load_initial_sms_parts_step(): loading all 3GPP messages from storage 'sm'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 21
<<<<<< data = 01:14:00:00:05:06:00:02:00:31:00:08:00:12:01:00:01:01:01:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 20
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 8
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:02:00:31:00:07:00:02:04:00:01:00:11:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:11:00
>>>>>> translated = FAILURE: MissingArgument
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (17): 'MissingArgument'
ModemManager[1157]: <debug> [1466176578.665229] [mm-broadband-modem-qmi.c:7755] load_initial_sms_parts_step(): loading 3GPP MT-read messages from storage 'sm'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:03:00:31:00:0C:00:12:01:00:01:11:01:00:00:01:01:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = mt-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:03:00:31:00:07:00:02:04:00:01:00:34:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:34:00
>>>>>> translated = FAILURE: DeviceNotReady
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (52): 'DeviceNotReady'
ModemManager[1157]: <debug> [1466176578.729029] [mm-broadband-modem-qmi.c:7761] load_initial_sms_parts_step(): loading 3GPP MT-not-read messages from storage 'sm'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:04:00:31:00:0C:00:12:01:00:01:11:01:00:01:01:01:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = mt-not-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 27
>>>>>> data = 01:1A:00:80:05:06:02:04:00:31:00:0E:00:02:04:00:00:00:00:00:01:04:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 26
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 14
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Message List" (0x01)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = {}
ModemManager[1157]: <debug> [1466176578.792964] [mm-broadband-modem-qmi.c:7767] load_initial_sms_parts_step(): loading 3GPP MO-sent messages from storage 'sm'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:05:00:31:00:0C:00:12:01:00:01:11:01:00:02:01:01:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 02
<<<<<< translated = mo-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:05:00:31:00:07:00:02:04:00:01:00:30:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'
ModemManager[1157]: <debug> [1466176578.856904] [mm-broadband-modem-qmi.c:7773] load_initial_sms_parts_step(): loading 3GPP MO-not-sent messages from storage 'sm'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:06:00:31:00:0C:00:12:01:00:01:11:01:00:03:01:01:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = mo-not-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:06:00:31:00:07:00:02:04:00:01:00:30:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'
ModemManager[1157]: <debug> [1466176578.921127] [mm-broadband-modem-qmi.c:7750] load_initial_sms_parts_step(): loading all 3GPP messages from storage 'me'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 21
<<<<<< data = 01:14:00:00:05:06:00:07:00:31:00:08:00:12:01:00:01:01:01:00:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 20
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 7
<<<<<< tlv_length = 8
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:07:00:31:00:07:00:02:04:00:01:00:11:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 7
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:11:00
>>>>>> translated = FAILURE: MissingArgument
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (17): 'MissingArgument'
ModemManager[1157]: <debug> [1466176578.984907] [mm-broadband-modem-qmi.c:7755] load_initial_sms_parts_step(): loading 3GPP MT-read messages from storage 'me'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:08:00:31:00:0C:00:12:01:00:01:11:01:00:00:01:01:00:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = mt-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:08:00:31:00:07:00:02:04:00:01:00:34:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 8
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:34:00
>>>>>> translated = FAILURE: DeviceNotReady
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (52): 'DeviceNotReady'
ModemManager[1157]: <debug> [1466176579.049070] [mm-broadband-modem-qmi.c:7761] load_initial_sms_parts_step(): loading 3GPP MT-not-read messages from storage 'me'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:09:00:31:00:0C:00:12:01:00:01:11:01:00:01:01:01:00:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = mt-not-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 42
>>>>>> data = 01:29:00:80:05:06:02:09:00:31:00:1D:00:02:04:00:00:00:00:00:01:13:00:03:00:00:00:00:00:00:00:00:01:00:00:00:00:02:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 41
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 9
>>>>>> tlv_length = 29
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Message List" (0x01)
>>>>>> length = 19
>>>>>> value = 03:00:00:00:00:00:00:00:00:01:00:00:00:00:02:00:00:00:00
>>>>>> translated = { [0] = '[ memory_index = '0' message_tag = 'mt-read' ] ' [1] = '[ memory_index = '1' message_tag = 'mt-read' ] ' [2] = '[ memory_index = '2' message_tag = 'mt-read' ] '}
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:0A:00:22:00:0C:00:10:01:00:01:01:05:00:01:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 12
<<<<<< message = "Raw Read" (0x0022)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x10)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Memory Storage ID" (0x01)
<<<<<< length = 5
<<<<<< value = 01:00:00:00:00
<<<<<< translated = [ storage_type = 'nv' memory_index = '0' ]
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 198
>>>>>> data = 01:C5:00:80:05:06:02:0A:00:22:00:B9:00:02:04:00:00:00:00:00:01:AF:00:00:06:AB:00:07:91:94:71:22:72:30:33:60:14:D0:D6:37:39:6C:7E:BB:CB:2E:72:19:00:00:61:50:13:71:34:72:80:A0:05:00:03:BA:03:01:98:E9:B2:B8:2C:07:59:DF:E4:B0:F9:ED:2E:B7:96:75:37:B9:CC:02:B5:D3:74:50:12:2D:2F:B7:41:D4:B0:3C:6D:06:CD:C7:E8:B2:7B:5D:76:83:EE:69:39:28:89:76:97:DD:A0:19:A8:F9:76:87:E9:65:50:39:ED:06:15:DD:F4:B2:9C:1E:4E:BB:DB:65:37:BD:05:0D:AF:CB:74:17:E8:BA:47:B3:CB:6E:D0:34:5D:06:95:D3:6E:73:78:8C:D6:81:9A:69:36:3B:FD:76:97:DD:A0:E9:DB:7D:9E:83:EA:6E:32:08:C9:97:8B:FD:63:74:59:0E:12:97:D3:20:62:B9:AC:2F:CB:41
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 197
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 10
>>>>>> tlv_length = 185
>>>>>> message = "Raw Read" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Raw Message Data" (0x01)
>>>>>> length = 175
>>>>>> value = 00:06:AB:00:07:91:94:71:22:72:30:33:60:14:D0:D6:37:39:6C:7E:BB:CB:2E:72:19:00:00:61:50:13:71:34:72:80:A0:05:00:03:BA:03:01:98:E9:B2:B8:2C:07:59:DF:E4:B0:F9:ED:2E:B7:96:75:37:B9:CC:02:B5:D3:74:50:12:2D:2F:B7:41:D4:B0:3C:6D:06:CD:C7:E8:B2:7B:5D:76:83:EE:69:39:28:89:76:97:DD:A0:19:A8:F9:76:87:E9:65:50:39:ED:06:15:DD:F4:B2:9C:1E:4E:BB:DB:65:37:BD:05:0D:AF:CB:74:17:E8:BA:47:B3:CB:6E:D0:34:5D:06:95:D3:6E:73:78:8C:D6:81:9A:69:36:3B:FD:76:97:DD:A0:E9:DB:7D:9E:83:EA:6E:32:08:C9:97:8B:FD:63:74:59:0E:12:97:D3:20:62:B9:AC:2F:CB:41
>>>>>> translated = [ message_tag = 'mt-read' format = 'gsm-wcdma-point-to-point' raw_data = '{ [0] = '7 ' [1] = '145 ' [2] = '148 ' [3] = '113 ' [4] = '34 ' [5] = '114 ' [6] = '48 ' [7] = '51 ' [8] = '96 ' [9] = '20 ' [10] = '208 ' [11] = '214 ' [12] = '55 ' [13] = '57 ' [14] = '108 ' [15] = '126 ' [16] = '187 ' [17] = '203 ' [18] = '46 ' [19] = '114 ' [20] = '25 ' [21] = '0 ' [22] = '0 ' [23] = '97 ' [24] = '80 ' [25] = '19 ' [26] = '113 ' [27] = '52 ' [28] = '114 ' [29] = '128 ' [30] = '160 ' [31] = '5 ' [32] = '0 ' [33] = '3 ' [34] = '186 ' [35] = '3 ' [36] = '1 ' [37] = '152 ' [38] = '233 ' [39] = '178 ' [40] = '184 ' [41] = '44 ' [42] = '7 ' [43] = '89 ' [44] = '223 ' [45] = '228 ' [46] = '176 ' [47] = '249 ' [48] = '237 ' [49] = '46 ' [50] = '183 ' [51] = '150 ' [52] = '117 ' [53] = '55 ' [54] = '185 ' [55] = '204 ' [56] = '2 ' [57] = '181 ' [58] = '211 ' [59] = '116 ' [60] = '80 ' [61] = '18 ' [62] = '45 ' [63] = '47 ' [64] = '183 ' [65] = '65 ' [66] = '212 ' [67] = '176 ' [68] = '60 ' [69] = '109 ' [70] = '6 ' [71] = '205 ' [72] = '199 ' [73] = '232 ' [74] = '178 ' [75] = '123 ' [76] = '93 ' [77] = '118 ' [78] = '131 ' [79] = '238 ' [80] = '105 ' [81] = '57 ' [82] = '40 ' [83] = '137 ' [84] = '118 ' [85] = '151 ' [86] = '221 ' [87] = '160 ' [88] = '25 ' [89] = '168 ' [90] = '249 ' [91] = '118 ' [92] = '135 ' [93] = '233 ' [94] = '101 ' [95] = '80 ' [96] = '57 ' [97] = '237 ' [98] = '6 ' [99] = '21 ' [100] = '221 ' [101] = '244 ' [102] = '178 ' [103] = '156 ' [104] = '30 ' [105] = '78 ' [106] = '187 ' [107] = '219 ' [108] = '101 ' [109] = '55 ' [110] = '189 ' [111] = '5 ' [112] = '13 ' [113] = '175 ' [114] = '203 ' [115] = '116 ' [116] = '23 ' [117] = '232 ' [118] = '186 ' [119] = '71 ' [120] = '179 ' [121] = '203 ' [122] = '110 ' [123] = '208 ' [124] = '52 ' [125] = '93 ' [126] = '6 ' [127] = '149 ' [128] = '211 ' [129] = '110 ' [130] = '115 ' [131] = '120 ' [132] = '140 ' [133] = '214 ' [134] = '129 ' [135] = '154 ' [136] = '105 ' [137] = '54 ' [138] = '59 ' [139] = '253 ' [140] = '118 ' [141] = '151 ' [142] = '221 ' [143] = '160 ' [144] = '233 ' [145] = '219 ' [146] = '125 ' [147] = '158 ' [148] = '131 ' [149] = '234 ' [150] = '110 ' [151] = '50 ' [152] = '8 ' [153] = '201 ' [154] = '151 ' [155] = '139 ' [156] = '253 ' [157] = '99 ' [158] = '116 ' [159] = '89 ' [160] = '14 ' [161] = '18 ' [162] = '151 ' [163] = '211 ' [164] = '32 ' [165] = '98 ' [166] = '185 ' [167] = '172 ' [168] = '47 ' [169] = '203 ' [170] = '65 '}' ]
ModemManager[1157]: <debug> [1466176579.178047] [mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (0)...
ModemManager[1157]: <debug> [1466176579.178109] [mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+491722270333'
ModemManager[1157]: <debug> [1466176579.178150] [mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
ModemManager[1157]: <debug> [1466176579.178267] [mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: 'Vodafone.de'
ModemManager[1157]: <debug> [1466176579.178313] [mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
ModemManager[1157]: <debug> [1466176579.178353] [mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is GSM7
ModemManager[1157]: <debug> [1466176579.178422] [mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 160 elements
ModemManager[1157]: <debug> [1466176579.178462] [mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 140 bytes
ModemManager[1157]: <debug> [1466176579.178532] [mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '153' elements
ModemManager[1157]: <debug> [1466176579.178571] [mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
ModemManager[1157]: <debug> [1466176579.178642] [mm-sms-part-3gpp.c:247] sms_decode_text(): Got UTF-8 text: 'Lieber Vodafone-Kunde, mit Ihrem Tarif schenken wir Ihnen 3 Monate ein Entertainment-Paket. Wählen Sie einfach: Millionen Songs und Hörbücher bei Deezer '
ModemManager[1157]: <debug> [1466176579.178726] [mm-broadband-modem-qmi.c:7568] add_new_read_sms_part(): Correctly parsed PDU (0)
ModemManager[1157]: <debug> [1466176579.178829] [mm-sms-list.c:371] mm_sms_list_take_part(): SMS part at 'me/0' is from a multipart SMS (reference: '186', sequence: '1')
ModemManager[1157]: <debug> [1466176579.180362] [mm-iface-modem-messaging.c:511] sms_added(): Added received SMS at '/org/freedesktop/ModemManager1/SMS/0'
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:0B:00:22:00:0C:00:10:01:00:01:01:05:00:01:01:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 11
<<<<<< tlv_length = 12
<<<<<< message = "Raw Read" (0x0022)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x10)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Memory Storage ID" (0x01)
<<<<<< length = 5
<<<<<< value = 01:01:00:00:00
<<<<<< translated = [ storage_type = 'nv' memory_index = '1' ]
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 198
>>>>>> data = 01:C5:00:80:05:06:02:0B:00:22:00:B9:00:02:04:00:00:00:00:00:01:AF:00:00:06:AB:00:07:91:94:71:22:72:30:33:60:14:D0:D6:37:39:6C:7E:BB:CB:2E:72:19:00:00:61:50:13:71:34:72:80:A0:05:00:03:BA:03:02:DE:E4:B2:1C:44:4E:97:41:C2:BA:9B:5C:9E:B3:D3:E7:30:88:9D:B6:97:41:ED:34:1D:34:5D:E7:41:E2:72:1A:D4:7C:8B:D3:EC:32:D5:EA:02:05:D7:F4:B4:3D:5D:96:97:DD:A0:69:BA:0C:4A:A2:E5:20:68:78:5D:A6:83:D4:65:BA:9E:0E:0A:D7:CD:A0:FB:FD:EE:B2:BF:C9:61:F3:DB:5D:76:91:CB:AF:B2:9B:5E:96:D3:C3:69:77:BB:EC:A6:BF:64:20:17:68:9A:2E:83:C4:E5:F5:BB:DD:2E:BB:41:F6:B7:1C:14:14:B3:C3:75:33:88:5C:96:83:66:A0:E6:DB:1D:A6:97:41
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 197
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 11
>>>>>> tlv_length = 185
>>>>>> message = "Raw Read" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Raw Message Data" (0x01)
>>>>>> length = 175
>>>>>> value = 00:06:AB:00:07:91:94:71:22:72:30:33:60:14:D0:D6:37:39:6C:7E:BB:CB:2E:72:19:00:00:61:50:13:71:34:72:80:A0:05:00:03:BA:03:02:DE:E4:B2:1C:44:4E:97:41:C2:BA:9B:5C:9E:B3:D3:E7:30:88:9D:B6:97:41:ED:34:1D:34:5D:E7:41:E2:72:1A:D4:7C:8B:D3:EC:32:D5:EA:02:05:D7:F4:B4:3D:5D:96:97:DD:A0:69:BA:0C:4A:A2:E5:20:68:78:5D:A6:83:D4:65:BA:9E:0E:0A:D7:CD:A0:FB:FD:EE:B2:BF:C9:61:F3:DB:5D:76:91:CB:AF:B2:9B:5E:96:D3:C3:69:77:BB:EC:A6:BF:64:20:17:68:9A:2E:83:C4:E5:F5:BB:DD:2E:BB:41:F6:B7:1C:14:14:B3:C3:75:33:88:5C:96:83:66:A0:E6:DB:1D:A6:97:41
>>>>>> translated = [ message_tag = 'mt-read' format = 'gsm-wcdma-point-to-point' raw_data = '{ [0] = '7 ' [1] = '145 ' [2] = '148 ' [3] = '113 ' [4] = '34 ' [5] = '114 ' [6] = '48 ' [7] = '51 ' [8] = '96 ' [9] = '20 ' [10] = '208 ' [11] = '214 ' [12] = '55 ' [13] = '57 ' [14] = '108 ' [15] = '126 ' [16] = '187 ' [17] = '203 ' [18] = '46 ' [19] = '114 ' [20] = '25 ' [21] = '0 ' [22] = '0 ' [23] = '97 ' [24] = '80 ' [25] = '19 ' [26] = '113 ' [27] = '52 ' [28] = '114 ' [29] = '128 ' [30] = '160 ' [31] = '5 ' [32] = '0 ' [33] = '3 ' [34] = '186 ' [35] = '3 ' [36] = '2 ' [37] = '222 ' [38] = '228 ' [39] = '178 ' [40] = '28 ' [41] = '68 ' [42] = '78 ' [43] = '151 ' [44] = '65 ' [45] = '194 ' [46] = '186 ' [47] = '155 ' [48] = '92 ' [49] = '158 ' [50] = '179 ' [51] = '211 ' [52] = '231 ' [53] = '48 ' [54] = '136 ' [55] = '157 ' [56] = '182 ' [57] = '151 ' [58] = '65 ' [59] = '237 ' [60] = '52 ' [61] = '29 ' [62] = '52 ' [63] = '93 ' [64] = '231 ' [65] = '65 ' [66] = '226 ' [67] = '114 ' [68] = '26 ' [69] = '212 ' [70] = '124 ' [71] = '139 ' [72] = '211 ' [73] = '236 ' [74] = '50 ' [75] = '213 ' [76] = '234 ' [77] = '2 ' [78] = '5 ' [79] = '215 ' [80] = '244 ' [81] = '180 ' [82] = '61 ' [83] = '93 ' [84] = '150 ' [85] = '151 ' [86] = '221 ' [87] = '160 ' [88] = '105 ' [89] = '186 ' [90] = '12 ' [91] = '74 ' [92] = '162 ' [93] = '229 ' [94] = '32 ' [95] = '104 ' [96] = '120 ' [97] = '93 ' [98] = '166 ' [99] = '131 ' [100] = '212 ' [101] = '101 ' [102] = '186 ' [103] = '158 ' [104] = '14 ' [105] = '10 ' [106] = '215 ' [107] = '205 ' [108] = '160 ' [109] = '251 ' [110] = '253 ' [111] = '238 ' [112] = '178 ' [113] = '191 ' [114] = '201 ' [115] = '97 ' [116] = '243 ' [117] = '219 ' [118] = '93 ' [119] = '118 ' [120] = '145 ' [121] = '203 ' [122] = '175 ' [123] = '178 ' [124] = '155 ' [125] = '94 ' [126] = '150 ' [127] = '211 ' [128] = '195 ' [129] = '105 ' [130] = '119 ' [131] = '187 ' [132] = '236 ' [133] = '166 ' [134] = '191 ' [135] = '100 ' [136] = '32 ' [137] = '23 ' [138] = '104 ' [139] = '154 ' [140] = '46 ' [141] = '131 ' [142] = '196 ' [143] = '229 ' [144] = '245 ' [145] = '187 ' [146] = '221 ' [147] = '46 ' [148] = '187 ' [149] = '65 ' [150] = '246 ' [151] = '183 ' [152] = '28 ' [153] = '20 ' [154] = '20 ' [155] = '179 ' [156] = '195 ' [157] = '117 ' [158] = '51 ' [159] = '136 ' [160] = '92 ' [161] = '150 ' [162] = '131 ' [163] = '102 ' [164] = '160 ' [165] = '230 ' [166] = '219 ' [167] = '29 ' [168] = '166 ' [169] = '151 ' [170] = '65 '}' ]
ModemManager[1157]: <debug> [1466176579.242071] [mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (1)...
ModemManager[1157]: <debug> [1466176579.242194] [mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+491722270333'
ModemManager[1157]: <debug> [1466176579.242266] [mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
ModemManager[1157]: <debug> [1466176579.242383] [mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: 'Vodafone.de'
ModemManager[1157]: <debug> [1466176579.242457] [mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
ModemManager[1157]: <debug> [1466176579.242497] [mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is GSM7
ModemManager[1157]: <debug> [1466176579.242599] [mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 160 elements
ModemManager[1157]: <debug> [1466176579.242669] [mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 140 bytes
ModemManager[1157]: <debug> [1466176579.242740] [mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '153' elements
ModemManager[1157]: <debug> [1466176579.242782] [mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
ModemManager[1157]: <debug> [1466176579.242852] [mm-sms-part-3gpp.c:247] sms_decode_text(): Got UTF-8 text: 'oder die Bundesliga live mit Sky bei MobileTV. Aktivieren Sie Ihr Paket jetzt auf www.vodafone.de/entertainment/2 . Sie bekommen vor Ablauf der 3 Monate '
ModemManager[1157]: <debug> [1466176579.242937] [mm-broadband-modem-qmi.c:7568] add_new_read_sms_part(): Correctly parsed PDU (1)
ModemManager[1157]: <debug> [1466176579.243126] [mm-sms-list.c:371] mm_sms_list_take_part(): SMS part at 'me/1' is from a multipart SMS (reference: '186', sequence: '2')
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:0C:00:22:00:0C:00:10:01:00:01:01:05:00:01:02:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 12
<<<<<< tlv_length = 12
<<<<<< message = "Raw Read" (0x0022)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x10)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Memory Storage ID" (0x01)
<<<<<< length = 5
<<<<<< value = 01:02:00:00:00
<<<<<< translated = [ storage_type = 'nv' memory_index = '2' ]
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 184
>>>>>> data = 01:B7:00:80:05:06:02:0C:00:22:00:AB:00:02:04:00:00:00:00:00:01:A1:00:00:06:9D:00:07:91:94:71:22:72:30:33:64:14:D0:D6:37:39:6C:7E:BB:CB:2E:72:19:00:00:61:50:13:71:34:72:80:8F:05:00:03:BA:03:03:CA:69:77:19:34:6D:4E:5D:A0:A5:DF:4D:4E:9F:CB:6E:D0:34:5D:06:B9:D3:63:34:9D:05:D2:87:D1:EC:B2:1B:34:4D:97:41:69:37:88:5C:76:83:9A:6F:77:98:5E:76:83:C8:61:77:78:8C:06:89:CB:F1:7A:B9:0D:F2:8B:CB:72:50:12:2D:2F:83:9A:6F:71:9A:6D:AE:BB:D7:2D:69:79:8C:76:D7:DD:67:17:C8:28:2F:D7:DD:64:76:7A:8C:2E:83:8E:72:BF:A7:CC:02:25:D1:72:90:F5:4D:0E:9B:DF:EE:72:8B:5A:0E:B7:01
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 183
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 12
>>>>>> tlv_length = 171
>>>>>> message = "Raw Read" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Raw Message Data" (0x01)
>>>>>> length = 161
>>>>>> value = 00:06:9D:00:07:91:94:71:22:72:30:33:64:14:D0:D6:37:39:6C:7E:BB:CB:2E:72:19:00:00:61:50:13:71:34:72:80:8F:05:00:03:BA:03:03:CA:69:77:19:34:6D:4E:5D:A0:A5:DF:4D:4E:9F:CB:6E:D0:34:5D:06:B9:D3:63:34:9D:05:D2:87:D1:EC:B2:1B:34:4D:97:41:69:37:88:5C:76:83:9A:6F:77:98:5E:76:83:C8:61:77:78:8C:06:89:CB:F1:7A:B9:0D:F2:8B:CB:72:50:12:2D:2F:83:9A:6F:71:9A:6D:AE:BB:D7:2D:69:79:8C:76:D7:DD:67:17:C8:28:2F:D7:DD:64:76:7A:8C:2E:83:8E:72:BF:A7:CC:02:25:D1:72:90:F5:4D:0E:9B:DF:EE:72:8B:5A:0E:B7:01
>>>>>> translated = [ message_tag = 'mt-read' format = 'gsm-wcdma-point-to-point' raw_data = '{ [0] = '7 ' [1] = '145 ' [2] = '148 ' [3] = '113 ' [4] = '34 ' [5] = '114 ' [6] = '48 ' [7] = '51 ' [8] = '100 ' [9] = '20 ' [10] = '208 ' [11] = '214 ' [12] = '55 ' [13] = '57 ' [14] = '108 ' [15] = '126 ' [16] = '187 ' [17] = '203 ' [18] = '46 ' [19] = '114 ' [20] = '25 ' [21] = '0 ' [22] = '0 ' [23] = '97 ' [24] = '80 ' [25] = '19 ' [26] = '113 ' [27] = '52 ' [28] = '114 ' [29] = '128 ' [30] = '143 ' [31] = '5 ' [32] = '0 ' [33] = '3 ' [34] = '186 ' [35] = '3 ' [36] = '3 ' [37] = '202 ' [38] = '105 ' [39] = '119 ' [40] = '25 ' [41] = '52 ' [42] = '109 ' [43] = '78 ' [44] = '93 ' [45] = '160 ' [46] = '165 ' [47] = '223 ' [48] = '77 ' [49] = '78 ' [50] = '159 ' [51] = '203 ' [52] = '110 ' [53] = '208 ' [54] = '52 ' [55] = '93 ' [56] = '6 ' [57] = '185 ' [58] = '211 ' [59] = '99 ' [60] = '52 ' [61] = '157 ' [62] = '5 ' [63] = '210 ' [64] = '135 ' [65] = '209 ' [66] = '236 ' [67] = '178 ' [68] = '27 ' [69] = '52 ' [70] = '77 ' [71] = '151 ' [72] = '65 ' [73] = '105 ' [74] = '55 ' [75] = '136 ' [76] = '92 ' [77] = '118 ' [78] = '131 ' [79] = '154 ' [80] = '111 ' [81] = '119 ' [82] = '152 ' [83] = '94 ' [84] = '118 ' [85] = '131 ' [86] = '200 ' [87] = '97 ' [88] = '119 ' [89] = '120 ' [90] = '140 ' [91] = '6 ' [92] = '137 ' [93] = '203 ' [94] = '241 ' [95] = '122 ' [96] = '185 ' [97] = '13 ' [98] = '242 ' [99] = '139 ' [100] = '203 ' [101] = '114 ' [102] = '80 ' [103] = '18 ' [104] = '45 ' [105] = '47 ' [106] = '131 ' [107] = '154 ' [108] = '111 ' [109] = '113 ' [110] = '154 ' [111] = '109 ' [112] = '174 ' [113] = '187 ' [114] = '215 ' [115] = '45 ' [116] = '105 ' [117] = '121 ' [118] = '140 ' [119] = '118 ' [120] = '215 ' [121] = '221 ' [122] = '103 ' [123] = '23 ' [124] = '200 ' [125] = '40 ' [126] = '47 ' [127] = '215 ' [128] = '221 ' [129] = '100 ' [130] = '118 ' [131] = '122 ' [132] = '140 ' [133] = '46 ' [134] = '131 ' [135] = '142 ' [136] = '114 ' [137] = '191 ' [138] = '167 ' [139] = '204 ' [140] = '2 ' [141] = '37 ' [142] = '209 ' [143] = '114 ' [144] = '144 ' [145] = '245 ' [146] = '77 ' [147] = '14 ' [148] = '155 ' [149] = '223 ' [150] = '238 ' [151] = '114 ' [152] = '139 ' [153] = '90 ' [154] = '14 ' [155] = '183 ' [156] = '1 '}' ]
ModemManager[1157]: <debug> [1466176579.306058] [mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (2)...
ModemManager[1157]: <debug> [1466176579.306119] [mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+491722270333'
ModemManager[1157]: <debug> [1466176579.306162] [mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
ModemManager[1157]: <debug> [1466176579.306253] [mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: 'Vodafone.de'
ModemManager[1157]: <debug> [1466176579.306299] [mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
ModemManager[1157]: <debug> [1466176579.306369] [mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is GSM7
ModemManager[1157]: <debug> [1466176579.306410] [mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 143 elements
ModemManager[1157]: <debug> [1466176579.306450] [mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 126 bytes
ModemManager[1157]: <debug> [1466176579.306499] [mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '136' elements
ModemManager[1157]: <debug> [1466176579.306541] [mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
ModemManager[1157]: <debug> [1466176579.306697] [mm-sms-part-3gpp.c:247] sms_decode_text(): Got UTF-8 text: 'eine SMS. Kündigen Sie nicht, zahlen Sie in den Monaten danach bequem über Ihre Mobilfunk-Rechnung. Freundliche Grüße, Ihr Vodafone-Team'
ModemManager[1157]: <debug> [1466176579.306778] [mm-broadband-modem-qmi.c:7568] add_new_read_sms_part(): Correctly parsed PDU (2)
ModemManager[1157]: <debug> [1466176579.306929] [mm-sms-list.c:371] mm_sms_list_take_part(): SMS part at 'me/2' is from a multipart SMS (reference: '186', sequence: '3')
ModemManager[1157]: <debug> [1466176579.307659] [mm-broadband-modem-qmi.c:7767] load_initial_sms_parts_step(): loading 3GPP MO-sent messages from storage 'me'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:0D:00:31:00:0C:00:12:01:00:01:11:01:00:02:01:01:00:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 13
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 02
<<<<<< translated = mo-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:0D:00:31:00:07:00:02:04:00:01:00:30:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 13
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'
ModemManager[1157]: <debug> [1466176579.368885] [mm-broadband-modem-qmi.c:7773] load_initial_sms_parts_step(): loading 3GPP MO-not-sent messages from storage 'me'...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:06:00:0E:00:31:00:0C:00:12:01:00:01:11:01:00:03:01:01:00:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 14
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = mo-not-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:0E:00:31:00:07:00:02:04:00:01:00:30:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 14
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
ModemManager[1157]: Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:05:06:00:0F:00:01:00:04:00:10:01:00:01
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 6
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 15
<<<<<< tlv_length = 4
<<<<<< message = "Set Event Report" (0x0001)
<<<<<< TLV:
<<<<<< type = "New MT Message Indicator" (0x10)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = [ report = 'yes' ]
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:06:02:0F:00:01:00:07:00:02:04:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 6
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 15
>>>>>> tlv_length = 7
>>>>>> message = "Set Event Report" (0x0001)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
ModemManager[1157]: <debug> [1466176579.496217] [mm-broadband-modem.c:9264] enabling_step(): Modem has voice capabilities, enabling the Voice interface...
ModemManager[1157]: <debug> [1466176579.496666] [mm-broadband-modem.c:6525] set_voice_unsolicited_events_handlers(): (ttyUSB2) Setting voice unsolicited events handlers
ModemManager[1157]: <debug> [1466176579.496792] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
ModemManager[1157]: <debug> [1466176579.496985] [mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLIP=1<CR>'
ModemManager[1157]: <debug> [1466176579.513561] [mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager[1157]: <debug> [1466176579.513796] [mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CRC=1<CR>'
ModemManager[1157]: <debug> [1466176579.527703] [mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager[1157]: <debug> [1466176579.527858] [mm-port-serial.c:1345] _close_internal(): (ttyUSB2) device open count is 1 (close)
ModemManager[1157]: <debug> [1466176579.527997] [mm-broadband-modem.c:9277] enabling_step(): Modem has time capabilities, enabling the Time interface...
ModemManager[1157]: <debug> [1466176579.528208] [mm-broadband-modem.c:9290] enabling_step(): Modem has extended signal reporting capabilities, enabling the Signal interface...
ModemManager[1157]: <debug> [1466176579.528282] [mm-iface-modem-signal.c:206] setup_refresh_context(): Extended signal information reporting disabled (rate: 0 seconds)
ModemManager[1157]: <info> [1466176579.528549] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
ModemManager[1157]: <debug> [1466176579.529419] [mm-iface-modem.c:1355] periodic_signal_quality_check_enable(): Periodic signal quality checks enabled (interval = 3s)
ModemManager[1157]: <debug> [1466176579.529578] [mm-broadband-modem-qmi.c:2951] load_signal_quality(): loading signal quality...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:07:00:09:00:20:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 7
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
ModemManager[1157]: <debug> [1466176579.530439] [mm-iface-modem-3gpp.c:761] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:07:00:0A:00:24:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 7
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 0
<<<<<< message = "Get Serving System" (0x0024)
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:03:07:02:09:00:20:00:0C:00:02:04:00:00:00:00:00:01:02:00:B0:08
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 7
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 9
>>>>>> tlv_length = 12
>>>>>> message = "Get Signal Strength" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Signal Strength" (0x01)
>>>>>> length = 2
>>>>>> value = B0:08
>>>>>> translated = [ strength = '-80' radio_interface = 'lte' ]
ModemManager[1157]: <debug> [1466176579.560563] [mm-broadband-modem-qmi.c:2841] signal_strength_get_quality_and_access_tech(): Signal strength (lte): -80 dBm
ModemManager[1157]: <debug> [1466176579.560633] [mm-broadband-modem-qmi.c:2874] signal_strength_get_quality_and_access_tech(): Signal strength: -80 dBm --> 54%
ModemManager[1157]: <debug> [1466176579.560875] [mm-iface-modem.c:933] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> lte)
ModemManager[1157]: <debug> [1466176579.561180] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (54)
ModemManager[1157]: <debug> [1466176579.561291] [mm-iface-modem.c:1274] signal_quality_check_ready(): Periodic signal quality checks rescheduled (interval = 30s)
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 93
>>>>>> data = 01:5C:00:80:03:07:02:0A:00:24:00:50:00:02:04:00:00:00:00:00:01:06:00:01:01:01:02:01:08:10:01:00:01:11:02:00:01:0B:12:0D:00:06:01:02:00:08:56:6F:64:61:66:6F:6E:65:15:03:00:01:08:01:1C:02:00:FE:FF:1D:04:00:03:D6:44:01:21:05:00:02:03:00:00:00:24:02:00:9E:BB:27:05:00:06:01:02:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 92
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 7
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 10
>>>>>> tlv_length = 80
>>>>>> message = "Get Serving System" (0x0024)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Serving System" (0x01)
>>>>>> length = 6
>>>>>> value = 01:01:01:02:01:08
>>>>>> translated = [ registration_state = 'registered' cs_attach_state = 'attached' ps_attach_state = 'attached' selected_network = '3gpp' radio_interfaces = '{ [0] = 'lte '}' ]
>>>>>> TLV:
>>>>>> type = "Roaming Indicator" (0x10)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = off
>>>>>> TLV:
>>>>>> type = "Data Service Capability" (0x11)
>>>>>> length = 2
>>>>>> value = 01:0B
>>>>>> translated = { [0] = 'lte '}
>>>>>> TLV:
>>>>>> type = "Current PLMN" (0x12)
>>>>>> length = 13
>>>>>> value = 06:01:02:00:08:56:6F:64:61:66:6F:6E:65
>>>>>> translated = [ mcc = '262' mnc = '2' description = 'Vodafone' ]
>>>>>> TLV:
>>>>>> type = "Roaming Indicator List" (0x15)
>>>>>> length = 3
>>>>>> value = 01:08:01
>>>>>> translated = { [0] = '[ radio_interface = 'lte' roaming_indicator = 'off' ] '}
>>>>>> TLV:
>>>>>> type = "LAC 3GPP" (0x1c)
>>>>>> length = 2
>>>>>> value = FE:FF
>>>>>> translated = 65534
>>>>>> TLV:
>>>>>> type = "CID 3GPP" (0x1d)
>>>>>> length = 4
>>>>>> value = 03:D6:44:01
>>>>>> translated = 21288451
>>>>>> TLV:
>>>>>> type = "Detailed Service Status" (0x21)
>>>>>> length = 5
>>>>>> value = 02:03:00:00:00
>>>>>> translated = [ status = 'available' capability = 'cs-ps' hdr_status = 'none' hdr_hybrid = 'no' forbidden = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE TAC" (0x24)
>>>>>> length = 2
>>>>>> value = 9E:BB
>>>>>> translated = 48030
>>>>>> TLV:
>>>>>> type = "MNC PCS Digit Include Status" (0x27)
>>>>>> length = 5
>>>>>> value = 06:01:02:00:00
>>>>>> translated = [ mcc = '262' mnc = '2' includes_pcs_digit = 'no' ]
ModemManager[1157]: <debug> [1466176579.625332] [mm-broadband-modem-qmi.c:4607] common_process_serving_system_3gpp(): Processing 3GPP info...
ModemManager[1157]: <debug> [1466176579.625576] [mm-broadband-modem.c:8574] modem_3gpp_run_registration_checks_ready(): Initial 3GPP registration checks finished
ModemManager[1157]: <debug> [1466176584.950205] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
ModemManager[1157]: <debug> [1466176584.950457] [mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CCLK?<CR>'
ModemManager[1157]: <debug> [1466176584.961000] [mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CCLK: "80/01/06,00:16:00"<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[1157]: <debug> [1466176584.961555] [mm-iface-modem-time.c:622] update_network_timezone_ready(): Couldn't update network timezone: 'Couldn't match +CCLK reply'
ModemManager[1157]: <debug> [1466176584.961628] [mm-port-serial.c:1345] _close_internal(): (ttyUSB2) device open count is 1 (close)
ModemManager[1157]: <debug> [1466176609.970046] [mm-broadband-modem-qmi.c:2951] load_signal_quality(): loading signal quality...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:07:00:0B:00:20:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 7
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 11
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:03:07:02:0B:00:20:00:0C:00:02:04:00:00:00:00:00:01:02:00:B0:08
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 7
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 11
>>>>>> tlv_length = 12
>>>>>> message = "Get Signal Strength" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Signal Strength" (0x01)
>>>>>> length = 2
>>>>>> value = B0:08
>>>>>> translated = [ strength = '-80' radio_interface = 'lte' ]
ModemManager[1157]: <debug> [1466176609.990036] [mm-broadband-modem-qmi.c:2841] signal_strength_get_quality_and_access_tech(): Signal strength (lte): -80 dBm
ModemManager[1157]: <debug> [1466176609.990100] [mm-broadband-modem-qmi.c:2874] signal_strength_get_quality_and_access_tech(): Signal strength: -80 dBm --> 54%
ModemManager[1157]: <debug> [1466176609.990387] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (54)
ModemManager[1157]: <info> [1466176629.591001] [mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
ModemManager[1157]: <debug> [1466176629.591196] [mm-iface-modem-simple.c:651] connect_auth_ready(): PIN: unspecified
ModemManager[1157]: <debug> [1466176629.591263] [mm-iface-modem-simple.c:653] connect_auth_ready(): Operator ID: unspecified
ModemManager[1157]: <debug> [1466176629.591344] [mm-iface-modem-simple.c:655] connect_auth_ready(): Allowed roaming: yes
ModemManager[1157]: <debug> [1466176629.591412] [mm-iface-modem-simple.c:657] connect_auth_ready(): APN: web.vodafone.de
ModemManager[1157]: <debug> [1466176629.591457] [mm-iface-modem-simple.c:662] connect_auth_ready(): IP family: ipv4v6
ModemManager[1157]: <debug> [1466176629.591524] [mm-iface-modem-simple.c:673] connect_auth_ready(): Allowed authentication: unspecified
ModemManager[1157]: <debug> [1466176629.591564] [mm-iface-modem-simple.c:675] connect_auth_ready(): User: unspecified
ModemManager[1157]: <debug> [1466176629.591628] [mm-iface-modem-simple.c:677] connect_auth_ready(): Password: unspecified
ModemManager[1157]: <debug> [1466176629.591668] [mm-iface-modem-simple.c:679] connect_auth_ready(): Number: *99#
ModemManager[1157]: <info> [1466176629.591730] [mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
ModemManager[1157]: <info> [1466176629.591865] [mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
ModemManager[1157]: <debug> [1466176629.592006] [mm-iface-modem-3gpp.c:400] mm_iface_modem_3gpp_register_in_network(): Already registered in network '26202', automatic registration not launched...
ModemManager[1157]: <info> [1466176629.592130] [mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
ModemManager[1157]: <debug> [1466176629.592183] [mm-iface-modem-simple.c:521] connection_step(): Creating new bearer...
ModemManager[1157]: <debug> [1466176629.592288] [mm-broadband-modem-qmi.c:332] modem_create_bearer(): Creating QMI bearer in QMI modem
ModemManager[1157]: <debug> [1466176629.593847] [mm-broadband-modem-qmi.c:304] modem_create_bearer_finish(): New bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[1157]: <info> [1466176629.594706] [mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
ModemManager[1157]: <debug> [1466176629.595214] [mm-base-bearer.c:703] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[1157]: <info> [1466176629.595400] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
ModemManager[1157]: <debug> [1466176629.596696] [mm-bearer-qmi.c:1251] _connect(): Launching connection with QMI port (usb/cdc-wdm1) and data port (net/wwp0s19u1u3i10)
ModemManager[1157]: <debug> [1466176629.596941] [mm-port-qmi.c:328] port_open_context_step(): Opening QMI device...
ModemManager[1157]: <debug> [1466176629.597007] [mm-port-qmi.c:333] port_open_context_step(): Checking if QMI device already opening...
ModemManager[1157]: <debug> [1466176629.597071] [mm-port-qmi.c:346] port_open_context_step(): Checking if QMI device already open...
ModemManager[1157]: <debug> [1466176629.597235] [mm-port-qmi.c:367] port_open_context_step(): Creating QMI device...
ModemManager[1157]: <debug> [1466176629.600353] [mm-port-qmi.c:380] port_open_context_step(): Opening device without data format update...
ModemManager[1157]: [/dev/cdc-wdm1] Opening device with flags 'version-info, proxy'...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 28
<<<<<< data = 01:1B:00:00:00:00:00:01:00:FF:10:00:01:0D:00:2F:64:65:76:2F:63:64:63:2D:77:64:6D:31
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 27
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 16
<<<<<< message = "Internal Proxy Open" (0xFF00)
<<<<<< TLV:
<<<<<< type = "Device Path" (0x01)
<<<<<< length = 13
<<<<<< value = 2F:64:65:76:2F:63:64:63:2D:77:64:6D:31
<<<<<< translated = /dev/cdc-wdm1
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 19
>>>>>> data = 01:12:00:00:00:00:01:01:00:FF:07:00:02:04:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 18
>>>>>> flags = 0x00
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Internal Proxy Open" (0xFF00)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
ModemManager[1157]: [/dev/cdc-wdm1] Checking version info (10 retries)...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:02:21:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 11
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Version Info" (0x0021)
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 183
>>>>>> data = 01:B6:00:80:00:00:01:02:21:00:AB:00:02:04:00:00:00:00:00:01:A1:00:20:00:01:00:05:00:01:01:00:43:00:02:01:00:0E:00:03:01:00:19:00:04:01:00:06:00:05:01:00:0A:00:07:01:00:03:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:18:00:0B:01:00:2D:00:0C:01:00:04:00:0F:01:00:00:00:10:02:00:00:00:11:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:10:00:1D:01:00:01:00:22:01:00:00:00:24:01:00:00:00:29:01:00:00:00:2A:01:00:00:00:2B:01:00:00:00:2E:01:00:00:00:30:01:00:00:00:31:01:00:00:00:36:01:00:00:00:E1:01:00:00:00:F0:01:00:00:00:F5:01:00:00:00:F6:01:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 182
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 171
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 161
>>>>>> value = 20:00:01:00:05:00:01:01:00:43:00:02:01:00:0E:00:03:01:00:19:00:04:01:00:06:00:05:01:00:0A:00:07:01:00:03:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:18:00:0B:01:00:2D:00:0C:01:00:04:00:0F:01:00:00:00:10:02:00:00:00:11:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:10:00:1D:01:00:01:00:22:01:00:00:00:24:01:00:00:00:29:01:00:00:00:2A:01:00:00:00:2B:01:00:00:00:2E:01:00:00:00:30:01:00:00:00:31:01:00:00:00:36:01:00:00:00:E1:01:00:00:00:F0:01:00:00:00:F5:01:00:00:00:F6:01:00:00:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '5' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '67' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '14' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '25' ] ' [4] = '[ service = 'qos' major_version = '1' minor_version = '6' ] ' [5] = '[ service = 'wms' major_version = '1' minor_version = '10' ] ' [6] = '[ service = 'auth' major_version = '1' minor_version = '3' ] ' [7] = '[ service = 'at' major_version = '1' minor_version = '2' ] ' [8] = '[ service = 'voice' major_version = '2' minor_version = '1' ] ' [9] = '[ service = 'cat2' major_version = '2' minor_version = '24' ] ' [10] = '[ service = 'uim' major_version = '1' minor_version = '45' ] ' [11] = '[ service = 'pbm' major_version = '1' minor_version = '4' ] ' [12] = '[ service = 'test' major_version = '1' minor_version = '0' ] ' [13] = '[ service = 'loc' major_version = '2' minor_version = '0' ] ' [14] = '[ service = 'sar' major_version = '1' minor_version = '0' ] ' [15] = '[ service = 'ts' major_version = '1' minor_version = '0' ] ' [16] = '[ service = 'tmd' major_version = '1' minor_version = '0' ] ' [17] = '[ service = 'wda' major_version = '1' minor_version = '16' ] ' [18] = '[ service = 'csvt' major_version = '1' minor_version = '1' ] ' [19] = '[ service = 'coex' major_version = '1' minor_version = '0' ] ' [20] = '[ service = 'pdc' major_version = '1' minor_version = '0' ] ' [21] = '[ service = 'rfrpe' major_version = '1' minor_version = '0' ] ' [22] = '[ service = 'dsd' major_version = '1' minor_version = '0' ] ' [23] = '[ service = 'ssctl' major_version = '1' minor_version = '0' ] ' [24] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [25] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [26] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [27] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [28] = '[ service = 'rms' major_version = '1' minor_version = '0' ] ' [29] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [30] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [31] = '[ service = '(null)' major_version = '1' minor_version = '0' ] '}
ModemManager[1157]: [/dev/cdc-wdm1] QMI Device supports 32 services:
ModemManager[1157]: [/dev/cdc-wdm1] ctl (1.5)
ModemManager[1157]: [/dev/cdc-wdm1] wds (1.67)
ModemManager[1157]: [/dev/cdc-wdm1] dms (1.14)
ModemManager[1157]: [/dev/cdc-wdm1] nas (1.25)
ModemManager[1157]: [/dev/cdc-wdm1] qos (1.6)
ModemManager[1157]: [/dev/cdc-wdm1] wms (1.10)
ModemManager[1157]: [/dev/cdc-wdm1] auth (1.3)
ModemManager[1157]: [/dev/cdc-wdm1] at (1.2)
ModemManager[1157]: [/dev/cdc-wdm1] voice (2.1)
ModemManager[1157]: [/dev/cdc-wdm1] cat2 (2.24)
ModemManager[1157]: [/dev/cdc-wdm1] uim (1.45)
ModemManager[1157]: [/dev/cdc-wdm1] pbm (1.4)
ModemManager[1157]: [/dev/cdc-wdm1] test (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] loc (2.0)
ModemManager[1157]: [/dev/cdc-wdm1] sar (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] ts (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] tmd (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] wda (1.16)
ModemManager[1157]: [/dev/cdc-wdm1] csvt (1.1)
ModemManager[1157]: [/dev/cdc-wdm1] coex (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] pdc (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] rfrpe (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] dsd (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] ssctl (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] unknown [0x2e] (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] unknown [0x30] (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] unknown [0x31] (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] unknown [0x36] (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] rms (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] unknown [0xf0] (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] unknown [0xf5] (1.0)
ModemManager[1157]: [/dev/cdc-wdm1] unknown [0xf6] (1.0)
ModemManager[1157]: <debug> [1466176629.672354] [mm-port-qmi.c:391] port_open_context_step(): Querying kernel data format...
ModemManager[1157]: [/dev/cdc-wdm1] Reading expected data format from: /sys/class/net/wwp0s19u1u3i10/qmi/raw_ip
ModemManager[1157]: <debug> [1466176629.672939] [mm-port-qmi.c:405] port_open_context_step(): Allocating WDA client...
ModemManager[1157]: [/dev/cdc-wdm1] Allocating new client ID...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:03:22:00:04:00:01:01:00:1A
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 1A
<<<<<< translated = wda
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:03:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:1A:01
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 12
>>>>>> message = "Allocate CID" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Allocation Info" (0x01)
>>>>>> length = 2
>>>>>> value = 1A:01
>>>>>> translated = [ service = 'wda' cid = '1' ]
ModemManager[1157]: [/dev/cdc-wdm1] Registered 'wda' (version 1.16) client with ID '1'
ModemManager[1157]: <debug> [1466176629.733680] [mm-port-qmi.c:418] port_open_context_step(): Querying device data format...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:1A:01:00:01:00:21:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "wda"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Data Format" (0x0021)
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 91
>>>>>> data = 01:5A:00:80:1A:01:02:01:00:21:00:4E:00:02:04:00:00:00:00:00:10:01:00:00:11:04:00:02:00:00:00:12:04:00:00:00:00:00:13:04:00:00:00:00:00:14:04:00:00:00:00:00:15:04:00:00:00:00:00:16:04:00:00:00:00:00:17:04:00:01:00:00:00:18:04:00:FF:FF:FF:FF:1A:04:00:00:00:00:00:1B:01:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 90
>>>>>> flags = 0x80
>>>>>> service = "wda"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 78
>>>>>> message = "Get Data Format" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "QoS Format" (0x10)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = no
>>>>>> TLV:
>>>>>> type = "Link Layer Protocol" (0x11)
>>>>>> length = 4
>>>>>> value = 02:00:00:00
>>>>>> translated = raw-ip
>>>>>> TLV:
>>>>>> type = "Uplink Data Aggregation Protocol" (0x12)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = disabled
>>>>>> TLV:
>>>>>> type = "Downlink Data Aggregation Protocol" (0x13)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = disabled
>>>>>> TLV:
>>>>>> type = "NDP Signature" (0x14)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = 0
>>>>>> TLV:
>>>>>> type = "Uplink Data Aggregation Max Size" (0x15)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = 0
>>>>>> TLV:
>>>>>> type = "Downlink Data Aggregation Max Size" (0x16)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = 0
>>>>>> TLV:
>>>>>> type = 0x17
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> TLV:
>>>>>> type = 0x18
>>>>>> length = 4
>>>>>> value = FF:FF:FF:FF
>>>>>> TLV:
>>>>>> type = 0x1a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> TLV:
>>>>>> type = 0x1b
>>>>>> length = 1
>>>>>> value = 00
ModemManager[1157]: <debug> [1466176629.797954] [mm-port-qmi.c:432] port_open_context_step(): Checking data format: kernel raw-ip, device raw-ip
ModemManager[1157]: <debug> [1466176629.798056] [mm-port-qmi.c:494] port_open_context_step(): QMI port open operation finished
ModemManager[1157]: [/dev/cdc-wdm1] Releasing 'wda' client with flags 'release-cid'...
ModemManager[1157]: [/dev/cdc-wdm1] Unregistered 'wda' client with ID '1'
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:00:00:00:04:23:00:05:00:01:02:00:1A:01
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 5
<<<<<< message = "Release CID" (0x0023)
<<<<<< TLV:
<<<<<< type = "Release Info" (0x01)
<<<<<< length = 2
<<<<<< value = 1A:01
<<<<<< translated = [ service = 'wda' cid = '1' ]
ModemManager[1157]: <debug> [1466176629.798593] [mm-bearer-qmi.c:934] connect_context_step(): Running IPv4 connection setup
ModemManager[1157]: <debug> [1466176629.798690] [mm-bearer-qmi.c:947] connect_context_step(): Allocating IPv4-specific WDS client
ModemManager[1157]: [/dev/cdc-wdm1] Allocating new client ID...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:05:22:00:04:00:01:01:00:01
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = wds
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:04:23:00:0C:00:02:04:00:00:00:00:00:01:02:00:1A:01
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 12
>>>>>> message = "Release CID" (0x0023)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Release Info" (0x01)
>>>>>> length = 2
>>>>>> value = 1A:01
>>>>>> translated = [ service = 'wda' cid = '1' ]
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:05:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:01:25
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 12
>>>>>> message = "Allocate CID" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Allocation Info" (0x01)
>>>>>> length = 2
>>>>>> value = 01:25
>>>>>> translated = [ service = 'wds' cid = '37' ]
ModemManager[1157]: [/dev/cdc-wdm1] Registered 'wds' (version 1.67) client with ID '37'
ModemManager[1157]: <debug> [1466176629.926367] [mm-bearer-qmi.c:968] connect_context_step(): Setting default IP family to: IPv4
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:01:25:00:01:00:4D:00:04:00:01:01:00:04
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "wds"
<<<<<< client = 37
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 4
<<<<<< message = "Set IP Family" (0x004D)
<<<<<< TLV:
<<<<<< type = "Preference" (0x01)
<<<<<< length = 1
<<<<<< value = 04
<<<<<< translated = ipv4
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:01:25:02:01:00:4D:00:07:00:02:04:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wds"
>>>>>> client = 37
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Set IP Family" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
ModemManager[1157]: <debug> [1466176629.989671] [mm-bearer-qmi.c:997] connect_context_step(): Starting IPv4 connection...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 31
<<<<<< data = 01:1E:00:00:01:25:00:02:00:20:00:12:00:14:0F:00:77:65:62:2E:76:6F:64:61:66:6F:6E:65:2E:64:65
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 30
<<<<<< flags = 0x00
<<<<<< service = "wds"
<<<<<< client = 37
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 18
<<<<<< message = "Start Network" (0x0020)
<<<<<< TLV:
<<<<<< type = "APN" (0x14)
<<<<<< length = 15
<<<<<< value = 77:65:62:2E:76:6F:64:61:66:6F:6E:65:2E:64:65
<<<<<< translated = web.vodafone.de
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 27
>>>>>> data = 01:1A:00:80:01:25:02:02:00:20:00:0E:00:02:04:00:00:00:00:00:01:04:00:00:B6:C0:03
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 26
>>>>>> flags = 0x80
>>>>>> service = "wds"
>>>>>> client = 37
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 14
>>>>>> message = "Start Network" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Packet Data Handle" (0x01)
>>>>>> length = 4
>>>>>> value = 00:B6:C0:03
>>>>>> translated = 62961152
ModemManager[1157]: <debug> [1466176630.053154] [mm-bearer-qmi.c:1012] connect_context_step(): Getting IPv4 configuration...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 20
<<<<<< data = 01:13:00:00:01:25:00:03:00:2D:00:07:00:10:04:00:30:E3:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 19
<<<<<< flags = 0x00
<<<<<< service = "wds"
<<<<<< client = 37
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 7
<<<<<< message = "Get Current Settings" (0x002D)
<<<<<< TLV:
<<<<<< type = "Requested Settings" (0x10)
<<<<<< length = 4
<<<<<< value = 30:E3:00:00
<<<<<< translated = dns-address, granted-qos, ip-address, gateway-info, mtu, domain-name-list, ip-family
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 31
>>>>>> data = 01:1E:00:80:01:25:04:01:00:22:00:12:00:01:02:00:02:00:12:01:00:04:13:02:00:80:88:14:01:00:05
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 30
>>>>>> flags = 0x80
>>>>>> service = "wds"
>>>>>> client = 37
>>>>>> QMI:
>>>>>> flags = "indication"
>>>>>> transaction = 1
>>>>>> tlv_length = 18
>>>>>> message = "Packet Service Status" (0x0022)
>>>>>> TLV:
>>>>>> type = "Connection Status" (0x01)
>>>>>> length = 2
>>>>>> value = 02:00
>>>>>> translated = [ status = 'connected' reconfiguration_required = 'no' ]
>>>>>> TLV:
>>>>>> type = "IP Family" (0x12)
>>>>>> length = 1
>>>>>> value = 04
>>>>>> translated = ipv4
>>>>>> TLV:
>>>>>> type = 0x13
>>>>>> length = 2
>>>>>> value = 80:88
>>>>>> TLV:
>>>>>> type = 0x14
>>>>>> length = 1
>>>>>> value = 05
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 70
>>>>>> data = 01:45:00:80:01:25:02:03:00:2D:00:39:00:02:04:00:00:00:00:00:1E:04:00:E1:DD:4D:64:15:04:00:7E:1E:07:8B:16:04:00:7D:1E:07:8B:20:04:00:E2:DD:4D:64:21:04:00:FC:FF:FF:FF:29:04:00:DC:05:00:00:2A:01:00:00:2B:01:00:04
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 69
>>>>>> flags = 0x80
>>>>>> service = "wds"
>>>>>> client = 37
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 57
>>>>>> message = "Get Current Settings" (0x002D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "IPv4 Address" (0x1e)
>>>>>> length = 4
>>>>>> value = E1:DD:4D:64
>>>>>> translated = 1682824673
>>>>>> TLV:
>>>>>> type = "Primary IPv4 DNS Address" (0x15)
>>>>>> length = 4
>>>>>> value = 7E:1E:07:8B
>>>>>> translated = 2332499582
>>>>>> TLV:
>>>>>> type = "Secondary IPv4 DNS Address" (0x16)
>>>>>> length = 4
>>>>>> value = 7D:1E:07:8B
>>>>>> translated = 2332499581
>>>>>> TLV:
>>>>>> type = "IPv4 Gateway Address" (0x20)
>>>>>> length = 4
>>>>>> value = E2:DD:4D:64
>>>>>> translated = 1682824674
>>>>>> TLV:
>>>>>> type = "IPv4 Gateway Subnet Mask" (0x21)
>>>>>> length = 4
>>>>>> value = FC:FF:FF:FF
>>>>>> translated = 4294967292
>>>>>> TLV:
>>>>>> type = "MTU" (0x29)
>>>>>> length = 4
>>>>>> value = DC:05:00:00
>>>>>> translated = 1500
>>>>>> TLV:
>>>>>> type = "Domain Name List" (0x2a)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = {}
>>>>>> TLV:
>>>>>> type = "IP Family" (0x2b)
>>>>>> length = 1
>>>>>> value = 04
>>>>>> translated = ipv4
ModemManager[1157]: <debug> [1466176630.245754] [mm-bearer-qmi.c:677] get_current_settings_ready(): IP Family: IPv4
ModemManager[1157]: <info> [1466176630.246015] [mm-bearer-qmi.c:495] get_ipv4_config(): QMI IPv4 Settings:
ModemManager[1157]: <info> [1466176630.246232] [mm-bearer-qmi.c:508] get_ipv4_config(): Address: 100.77.221.225/30
ModemManager[1157]: <info> [1466176630.246317] [mm-bearer-qmi.c:514] get_ipv4_config(): Gateway: 100.77.221.226
ModemManager[1157]: <info> [1466176630.246422] [mm-bearer-qmi.c:524] get_ipv4_config(): DNS #1: 139.7.30.126
ModemManager[1157]: <info> [1466176630.246468] [mm-bearer-qmi.c:534] get_ipv4_config(): DNS #2: 139.7.30.125
ModemManager[1157]: <info> [1466176630.246550] [mm-bearer-qmi.c:545] get_ipv4_config(): MTU: 1500
ModemManager[1157]: <debug> [1466176630.246596] [mm-bearer-qmi.c:699] get_current_settings_ready(): Domains:
ModemManager[1157]: <debug> [1466176630.246671] [mm-bearer-qmi.c:1029] connect_context_step(): Running IPv6 connection setup
ModemManager[1157]: <debug> [1466176630.246744] [mm-bearer-qmi.c:1042] connect_context_step(): Allocating IPv6-specific WDS client
ModemManager[1157]: [/dev/cdc-wdm1] Allocating new client ID...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:06:22:00:04:00:01:01:00:01
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = wds
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:06:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:01:26
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 12
>>>>>> message = "Allocate CID" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Allocation Info" (0x01)
>>>>>> length = 2
>>>>>> value = 01:26
>>>>>> translated = [ service = 'wds' cid = '38' ]
ModemManager[1157]: [/dev/cdc-wdm1] Registered 'wds' (version 1.67) client with ID '38'
ModemManager[1157]: <debug> [1466176630.309925] [mm-bearer-qmi.c:1065] connect_context_step(): Setting default IP family to: IPv6
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:01:26:00:01:00:4D:00:04:00:01:01:00:06
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "wds"
<<<<<< client = 38
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 4
<<<<<< message = "Set IP Family" (0x004D)
<<<<<< TLV:
<<<<<< type = "Preference" (0x01)
<<<<<< length = 1
<<<<<< value = 06
<<<<<< translated = ipv6
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:01:26:02:01:00:4D:00:07:00:02:04:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wds"
>>>>>> client = 38
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Set IP Family" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
ModemManager[1157]: <debug> [1466176630.373545] [mm-bearer-qmi.c:1094] connect_context_step(): Starting IPv6 connection...
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 31
<<<<<< data = 01:1E:00:00:01:26:00:02:00:20:00:12:00:14:0F:00:77:65:62:2E:76:6F:64:61:66:6F:6E:65:2E:64:65
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 30
<<<<<< flags = 0x00
<<<<<< service = "wds"
<<<<<< client = 38
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 18
<<<<<< message = "Start Network" (0x0020)
<<<<<< TLV:
<<<<<< type = "APN" (0x14)
<<<<<< length = 15
<<<<<< value = 77:65:62:2E:76:6F:64:61:66:6F:6E:65:2E:64:65
<<<<<< translated = web.vodafone.de
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 32
>>>>>> data = 01:1F:00:80:01:26:02:02:00:20:00:13:00:02:04:00:01:00:0E:00:10:02:00:01:00:11:04:00:02:00:D2:00
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 31
>>>>>> flags = 0x80
>>>>>> service = "wds"
>>>>>> client = 38
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 19
>>>>>> message = "Start Network" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:0E:00
>>>>>> translated = FAILURE: CallFailed
>>>>>> TLV:
>>>>>> type = "Call End Reason" (0x10)
>>>>>> length = 2
>>>>>> value = 01:00
>>>>>> translated = generic-unspecified
>>>>>> TLV:
>>>>>> type = "Verbose Call End Reason" (0x11)
>>>>>> length = 4
>>>>>> value = 02:00:D2:00
>>>>>> translated = [ type = 'internal' reason = '210' ]
ModemManager[1157]: <info> [1466176630.437626] [mm-bearer-qmi.c:354] start_network_ready(): error: couldn't start network: QMI protocol error (14): 'CallFailed'
ModemManager[1157]: <info> [1466176630.437730] [mm-bearer-qmi.c:368] start_network_ready(): call end reason (1): 'generic-unspecified'
ModemManager[1157]: <info> [1466176630.437904] [mm-bearer-qmi.c:379] start_network_ready(): verbose call end reason (2,210): [internal] pdn-ipv6-call-disallowed
ModemManager[1157]: <debug> [1466176630.437975] [mm-port.c:95] mm_port_set_connected(): (wwp0s19u1u3i10): port now connected
ModemManager[1157]: <debug> [1466176630.438144] [mm-base-bearer.c:601] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[1157]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<< length = 20
<<<<<< data = 01:13:00:00:01:25:00:04:00:24:00:07:00:01:04:00:C0:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 19
<<<<<< flags = 0x00
<<<<<< service = "wds"
<<<<<< client = 37
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 7
<<<<<< message = "Get Packet Statistics" (0x0024)
<<<<<< TLV:
<<<<<< type = "Mask" (0x01)
<<<<<< length = 4
<<<<<< value = C0:00:00:00
<<<<<< translated = tx-bytes-ok, rx-bytes-ok
ModemManager[1157]: <info> [1466176630.439305] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
ModemManager[1157]: <info> [1466176630.441643] [mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
ModemManager[1157]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>> length = 42
>>>>>> data = 01:29:00:80:01:25:02:04:00:24:00:1D:00:02:04:00:00:00:00:00:1A:08:00:00:00:00:00:00:00:00:00:19:08:00:00:00:00:00:00:00:00:00
ModemManager[1157]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 41
>>>>>> flags = 0x80
>>>>>> service = "wds"
>>>>>> client = 37
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 29
>>>>>> message = "Get Packet Statistics" (0x0024)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Rx Bytes Ok" (0x1a)
>>>>>> length = 8
>>>>>> value = 00:00:00:00:00:00:00:00
>>>>>> translated = 0
>>>>>> TLV:
>>>>>> type = "Tx Bytes Ok" (0x19)
>>>>>> length = 8
>>>>>> value = 00:00:00:00:00:00:00:00
>>>>>> translated = 0
ModemManager[1157]: <debug> [1466176639.955496] [mm-broadband-modem-qmi.c:2951] load_signal_quality(): loading signal quality...
ModemManager[1157]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:07:00:0C:00:20:00:00:00
ModemManager[1157]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 7
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 12
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
ModemManager[1157]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:03:07:02:0C:00:20:00:0C:00:02:04:00:00:00:00:00:01:02:00:B0:08
ModemManager[1157]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 7
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 12
>>>>>> tlv_length = 12
>>>>>> message = "Get Signal Strength" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Signal Strength" (0x01)
>>>>>> length = 2
>>>>>> value = B0:08
>>>>>> translated = [ strength = '-80' radio_interface = 'lte' ]
ModemManager[1157]: <debug> [1466176639.971632] [mm-broadband-modem-qmi.c:2841] signal_strength_get_quality_and_access_tech(): Signal strength (lte): -80 dBm
ModemManager[1157]: <debug> [1466176639.971710] [mm-broadband-modem-qmi.c:2874] signal_strength_get_quality_and_access_tech(): Signal strength: -80 dBm --> 54%
ModemManager[1157]: <debug> [1466176639.972086] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (54)
More information about the ModemManager-devel
mailing list