E1750 Reloaded - QMI - STATIC - DHCP - IPv4
poma
pomidorabelisima at gmail.com
Wed Aug 6 01:11:36 PDT 2014
According to this[1] document(slide 4/8), using the 'qmicli' the ModemManager is bypassed so no DHCP chit-chat in this log.
<info> [000.000126] [main.c:140] main(): ModemManager (version 1.3.0-1.git20140804.fc21) starting in system bus...
<debug> [000.218245] [main.c:65] bus_acquired_cb(): Bus acquired, creating manager...
<debug> [000.256735] [mm-plugin-manager.c:852] load_plugins(): Looking for plugins in '/usr/lib64/ModemManager'
<debug> [000.257312] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Huawei'
<warn> [000.257342] [mm-plugin-manager.c:889] load_plugins(): Generic plugin not loaded
<debug> [000.257367] [mm-plugin-manager.c:902] load_plugins(): Successfully loaded 1 plugins
<debug> [000.258201] [main.c:87] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
<debug> [000.258236] [mm-base-manager.c:479] mm_base_manager_start(): Starting automatic device scan...
<debug> [000.260098] [mm-base-manager.c:518] mm_base_manager_start(): Finished device scan...
<debug> [000.260330] [mm-base-manager.c:297] device_added(): (tty/ttyS0): port's parent device is blacklisted
<debug> [000.260477] [mm-base-manager.c:297] device_added(): (tty/ttyS1): port's parent device is blacklisted
<debug> [000.260584] [mm-base-manager.c:314] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
<debug> [000.260779] [mm-base-manager.c:314] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
<debug> [000.261719] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3] Checking device support...
<debug> [000.261812] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wwan0] Found '1' plugins to try...
<debug> [000.261824] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin 'Huawei'
<debug> [000.261837] [mm-plugin.c:689] mm_plugin_supports_port(): (Huawei) [wwan0] probing deferred until result suggested
<debug> [000.261981] [mm-base-manager.c:297] device_added(): (net/eth1): port's parent device is blacklisted
<debug> [000.262236] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '1' plugins to try...
<debug> [000.262248] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin 'Huawei'
<debug> [000.262267] [mm-plugin.c:767] mm_plugin_supports_port(): (Huawei) [cdc-wdm0] probe required: 'qmi'
<debug> [000.262278] [mm-port-probe.c:1353] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'qmi'
<debug> [000.262297] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support check until result suggested
<debug> [000.262312] [mm-port-probe.c:456] wdm_probe_qmi(): (usbmisc/cdc-wdm0) probing QMI...
[/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'...
cannot connect to proxy: Could not connect: Connection refused
spawning new qmi-proxy (try 1)...
[/dev/cdc-wdm0] 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:30
[/dev/cdc-wdm0] 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:30
<<<<<< translated = /dev/cdc-wdm0
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] Checking version info (10 retries)...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:02:21:00:00:00
[/dev/cdc-wdm0] 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)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 01:2F:00:80:00:00:01:02:21:00:24:00:02:04:00:00:00:00:00:01:1A:00:05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 47
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 36
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 26
>>>>>> value = 05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '2' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '3' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '2' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '0' ] ' [4] = '[ service = 'cat' major_version = '0' minor_version = '0' ] '}
[/dev/cdc-wdm0] QMI Device supports 5 services:
[/dev/cdc-wdm0] ctl (1.2)
[/dev/cdc-wdm0] wds (1.3)
[/dev/cdc-wdm0] dms (1.2)
[/dev/cdc-wdm0] nas (1.0)
[/dev/cdc-wdm0] cat (0.0)
<debug> [000.375822] [mm-port-probe.c:271] mm_port_probe_set_result_qmi(): (usbmisc/cdc-wdm0) port is QMI-capable
<debug> [000.376017] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [cdc-wdm0] found best plugin for port
<debug> [000.376048] [mm-plugin-manager.c:232] port_probe_context_finished(): (Plugin Manager) (Huawei) [cdc-wdm0]: found best plugin for device (/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3)
<debug> [000.376089] [mm-plugin-manager.c:361] suggest_single_port_probe_result(): (Plugin Manager) (Huawei) [wwan0] deferred task completed, got suggested plugin
<debug> [000.376118] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm0' port probe finished, still 1 running probes in this device (wwan0)
<debug> [000.376164] [mm-plugin.c:689] mm_plugin_supports_port(): (Huawei) [wwan0] probing deferred until result suggested
<debug> [000.378011] [mm-plugin-manager.c:549] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [wwan0] task completed, got suggested plugin
<debug> [000.378187] [mm-plugin-manager.c:313] port_probe_context_finished(): (Plugin Manager) 'wwan0' port probe finished, last one in device, but minimum probing time not consumed yet ('0.116425' seconds elapsed)
<debug> [002.862933] [mm-plugin-manager.c:703] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3] Minimum probing time consumed and no more ports to probe
<debug> [002.863017] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3] device support check finished in '2.601255' seconds
<info> [002.863065] [mm-device.c:509] mm_device_create_modem(): Creating modem with plugin 'Huawei' and '2' ports
<debug> [002.863129] [huawei/mm-plugin-huawei.c:491] create_modem(): QMI-powered Huawei modem found...
<debug> [002.865614] [huawei/mm-plugin-huawei.c:554] grab_port(): (usbmisc/cdc-wdm0) Port will have AT flags 'none'
<debug> [002.865707] [mm-base-modem.c:304] mm_base_modem_grab_port(): (cdc-wdm0) type 'qmi' claimed by /sys/devices/pci0000:00/0000:00:04.1/usb2/2-3
<debug> [002.865752] [huawei/mm-plugin-huawei.c:554] grab_port(): (net/wwan0) Port will have AT flags 'none'
<debug> [002.865794] [mm-base-modem.c:304] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by /sys/devices/pci0000:00/0000:00:04.1/usb2/2-3
<debug> [002.865846] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3) net/wwan0 data (primary)
<debug> [002.865870] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3) usb/cdc-wdm0 qmi (primary)
<info> [002.866376] [mm-base-manager.c:162] find_device_support_ready(): Modem for device at '/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3' successfully created
[/dev/cdc-wdm0] Opening device with flags 'version-info, net-802-3, net-no-qos-header, proxy'...
[/dev/cdc-wdm0] 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:30
[/dev/cdc-wdm0] 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:30
<<<<<< translated = /dev/cdc-wdm0
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] Checking version info (10 retries)...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:02:21:00:00:00
[/dev/cdc-wdm0] 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)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 01:2F:00:80:00:00:01:02:21:00:24:00:02:04:00:00:00:00:00:01:1A:00:05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 47
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 36
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 26
>>>>>> value = 05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '2' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '3' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '2' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '0' ] ' [4] = '[ service = 'cat' major_version = '0' minor_version = '0' ] '}
[/dev/cdc-wdm0] QMI Device supports 5 services:
[/dev/cdc-wdm0] ctl (1.2)
[/dev/cdc-wdm0] wds (1.3)
[/dev/cdc-wdm0] dms (1.2)
[/dev/cdc-wdm0] nas (1.0)
[/dev/cdc-wdm0] cat (0.0)
[/dev/cdc-wdm0] Setting network port data format...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 21
<<<<<< data = 01:14:00:00:00:00:00:03:26:00:09:00:10:02:00:01:00:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 20
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 9
<<<<<< message = "Set Data Format" (0x0026)
<<<<<< TLV:
<<<<<< type = "Protocol" (0x10)
<<<<<< length = 2
<<<<<< value = 01:00
<<<<<< translated = 802-3
<<<<<< TLV:
<<<<<< type = "Format" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = absent
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 19
>>>>>> data = 01:12:00:80:00:00:01:03:26:00:07:00:02:04:00:01:00:2D:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 18
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 7
>>>>>> message = "Set Data Format" (0x0026)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:2D:00
>>>>>> translated = FAILURE: (null)
[/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'...
[/dev/cdc-wdm0] 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:30
[/dev/cdc-wdm0] 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:30
<<<<<< translated = /dev/cdc-wdm0
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] Checking version info (10 retries)...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:02:21:00:00:00
[/dev/cdc-wdm0] 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)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 01:2F:00:80:00:00:01:02:21:00:24:00:02:04:00:00:00:00:00:01:1A:00:05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 47
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 36
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 26
>>>>>> value = 05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '2' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '3' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '2' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '0' ] ' [4] = '[ service = 'cat' major_version = '0' minor_version = '0' ] '}
[/dev/cdc-wdm0] QMI Device supports 5 services:
[/dev/cdc-wdm0] ctl (1.2)
[/dev/cdc-wdm0] wds (1.3)
[/dev/cdc-wdm0] dms (1.2)
[/dev/cdc-wdm0] nas (1.0)
[/dev/cdc-wdm0] cat (0.0)
[/dev/cdc-wdm0] Allocating new client ID...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:03:22:00:04:00:01:01:00:02
[/dev/cdc-wdm0] 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 = 02
<<<<<< translated = dms
[/dev/cdc-wdm0] 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:02:14
[/dev/cdc-wdm0] 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 = 02:14
>>>>>> translated = [ service = 'dms' cid = '20' ]
[/dev/cdc-wdm0] Registered 'dms' (version 1.2) client with ID '20'
[/dev/cdc-wdm0] Allocating new client ID...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:04:22:00:04:00:01:01:00:03
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = nas
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:04:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:03:10
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> 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 = 03:10
>>>>>> translated = [ service = 'nas' cid = '16' ]
[/dev/cdc-wdm0] Registered 'nas' (version 1.0) client with ID '16'
<debug> [002.889709] [mm-broadband-modem-qmi.c:9995] qmi_port_allocate_client_ready(): Couldn't allocate client for service 'wms': Couldn't create client for service 'wms': Service 'wms' not supported by the device
<debug> [002.889766] [mm-broadband-modem-qmi.c:9995] qmi_port_allocate_client_ready(): Couldn't allocate client for service 'pds': Couldn't create client for service 'pds': Service 'pds' not supported by the device
<debug> [002.889819] [mm-broadband-modem-qmi.c:9995] qmi_port_allocate_client_ready(): Couldn't allocate client for service 'oma': Couldn't create client for service 'oma': Service 'oma' not supported by the device
<debug> [002.889908] [mm-broadband-modem-qmi.c:9966] parent_initialization_started_ready(): Couldn't start parent initialization: Couldn't open ports during modem initialization: Couldn't get primary port
<debug> [002.891320] [mm-broadband-modem-qmi.c:531] modem_load_current_capabilities(): loading current capabilities...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:01:00:2B:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Technology Preference" (0x002B)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:10:02:01:00:2B:00:07:00:02:04:00:01:00:47:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Get Technology Preference" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:47:00
>>>>>> translated = FAILURE: InvalidQmiCommand
<debug> [002.893331] [mm-broadband-modem-qmi.c:426] load_current_capabilities_get_technology_preference_ready(): Couldn't get technology preference: QMI protocol error (71): 'InvalidQmiCommand'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:01:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Capabilities" (0x0020)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 36
>>>>>> data = 01:23:00:80:02:14:02:01:00:20:00:17:00:02:04:00:00:00:00:00:01:0D:00:60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 35
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 23
>>>>>> message = "Get Capabilities" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Info" (0x01)
>>>>>> length = 13
>>>>>> value = 60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
>>>>>> translated = [ max_tx_channel_rate = '3100000' max_rx_channel_rate = '3100000' data_service_capability = 'non-simultaneous-cs-ps' sim_capability = 'supported' radio_interface_list = '{ [0] = 'gsm ' [1] = 'umts '}' ]
<debug> [002.895409] [mm-modem-helpers-qmi.c:1268] mm_modem_capability_from_qmi_capabilities_context(): Current capabilities built: 'gsm-umts'
SSP mode preference: 'unknown'
TP: 'auto'
DMS Capabilities: 'gsm-umts'
<debug> [002.895463] [mm-broadband-modem-qmi.c:693] modem_load_supported_capabilities(): loading supported capabilities...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:02:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Capabilities" (0x0020)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 36
>>>>>> data = 01:23:00:80:02:14:02:02:00:20:00:17:00:02:04:00:00:00:00:00:01:0D:00:60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 35
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 23
>>>>>> message = "Get Capabilities" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Info" (0x01)
>>>>>> length = 13
>>>>>> value = 60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
>>>>>> translated = [ max_tx_channel_rate = '3100000' max_rx_channel_rate = '3100000' data_service_capability = 'non-simultaneous-cs-ps' sim_capability = 'supported' radio_interface_list = '{ [0] = 'gsm ' [1] = 'umts '}' ]
<debug> [002.899240] [mm-iface-modem.c:4327] interface_initialization_step(): Modem allows up to 1 bearers
<debug> [002.899252] [mm-bearer-list.c:276] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
<debug> [002.899304] [mm-broadband-modem-qmi.c:995] modem_load_manufacturer(): loading manufacturer...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:03:00:21:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 0
<<<<<< message = "Get Manufacturer" (0x0021)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 44
>>>>>> data = 01:2B:00:80:02:14:02:03:00:21:00:1F:00:02:04:00:00:00:00:00:01:15:00:51:55:41:4C:43:4F:4D:4D:20:49:4E:43:4F:52:50:4F:52:41:54:45:44
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 43
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 31
>>>>>> message = "Get Manufacturer" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Manufacturer" (0x01)
>>>>>> length = 21
>>>>>> value = 51:55:41:4C:43:4F:4D:4D:20:49:4E:43:4F:52:50:4F:52:41:54:45:44
>>>>>> translated = QUALCOMM INCORPORATED
<debug> [002.901176] [mm-broadband-modem-qmi.c:942] modem_load_manufacturer_finish(): loaded manufacturer: QUALCOMM INCORPORATED
<debug> [002.901208] [mm-broadband-modem-qmi.c:1071] modem_load_model(): loading model...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:04:00:22:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 0
<<<<<< message = "Get Model" (0x0022)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:02:14:02:04:00:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:32:39
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 12
>>>>>> message = "Get Model" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Model" (0x01)
>>>>>> length = 2
>>>>>> value = 32:39
>>>>>> translated = 29
<debug> [002.905181] [mm-broadband-modem-qmi.c:1018] modem_load_model_finish(): loaded model: 29
<debug> [002.905214] [mm-broadband-modem-qmi.c:1147] modem_load_revision(): loading revision...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:05:00:23:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 0
<<<<<< message = "Get Revision" (0x0023)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 74
>>>>>> data = 01:49:00:80:02:14:02:05:00:23:00:3D:00:02:04:00:00:00:00:00:01:33:00:4D:36:32:39:30:41:2D:4B:50:52:42:4C:2D:2E:2E:2E
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 73
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 61
>>>>>> message = "Get Revision" (0x0023)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Revision" (0x01)
>>>>>> length = 51
>>>>>> value = 4D:36:32:39:30:41:2D:4B:50:52:42:4C:2D:2E:2E:2E
>>>>>> translated = M6290A-KPRBL-...
<debug> [002.907375] [mm-broadband-modem-qmi.c:1094] modem_load_revision_finish(): loaded revision: M6290A-KPRBL-...
<debug> [002.907446] [mm-broadband-modem-qmi.c:1289] modem_load_equipment_identifier(): loading equipment identifier...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:06:00:25:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 0
<<<<<< message = "Get IDs" (0x0025)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 39
>>>>>> data = 01:26:00:80:02:14:02:06:00:25:00:1A:00:02:04:00:00:00:00:00:11:10:00:33:35:33:2E:2E:2E:01
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 38
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 26
>>>>>> message = "Get IDs" (0x0025)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Imei" (0x11)
>>>>>> length = 16
>>>>>> value = 33:35:33:2E:2E:2E:01
>>>>>> translated = 353...
<debug> [002.911406] [mm-broadband-modem-qmi.c:1186] modem_load_equipment_identifier_finish(): loaded equipment identifier: 353...
<debug> [002.911480] [mm-broadband-modem-qmi.c:1324] modem_load_device_identifier(): loading device identifier...
<debug> [002.911542] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '000012d10000140c353...M6290A-KPRBL-...29QUALCOMMINCORPORATED'
<debug> [002.911567] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID 'eb8d2760525a500bcbf18a9e9b89cd55098848e4'
<debug> [002.911618] [mm-broadband-modem-qmi.c:1312] modem_load_device_identifier_finish(): loaded device identifier: eb8d2760525a500bcbf18a9e9b89cd55098848e4
<debug> [002.911810] [mm-broadband-modem-qmi.c:1727] modem_load_supported_bands(): loading band capabilities...
<warn> [002.911918] [mm-iface-modem.c:3982] load_supported_bands_ready(): couldn't load Supported Bands: 'QMI operation failed: Cannot send message: QMI service 'dms' version '1.3' required, got version '1.2''
<debug> [002.911994] [mm-broadband-modem-qmi.c:2682] load_power_state(): Getting device operating mode...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:08:00:2D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 0
<<<<<< message = "Get Operating Mode" (0x002D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:02:14:02:08:00:2D:00:0B:00:02:04:00:00:00:00:00:01:01:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 8
>>>>>> tlv_length = 11
>>>>>> message = "Get Operating Mode" (0x002D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Mode" (0x01)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = online
<debug> [002.915106] [mm-broadband-modem-qmi.c:1533] modem_load_unlock_required(): loading unlock required...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:09:00:2B:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get PIN Status" (0x002B)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 32
>>>>>> data = 01:1F:00:80:02:14:02:09:00:2B:00:13:00:02:04:00:00:00:00:00:12:03:00:01:03:0A:11:03:00:03:03:0A
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 31
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 9
>>>>>> tlv_length = 19
>>>>>> message = "UIM Get PIN Status" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "PIN2 Status" (0x12)
>>>>>> length = 3
>>>>>> value = 01:03:0A
>>>>>> translated = [ current_status = 'enabled-not-verified' verify_retries_left = '3' unblock_retries_left = '10' ]
>>>>>> TLV:
>>>>>> type = "PIN1 Status" (0x11)
>>>>>> length = 3
>>>>>> value = 03:03:0A
>>>>>> translated = [ current_status = 'disabled' verify_retries_left = '3' unblock_retries_left = '10' ]
<debug> [002.919146] [mm-broadband-modem-qmi.c:1626] modem_load_unlock_retries(): loading unlock retries...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:0A:00:2B:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get PIN Status" (0x002B)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 32
>>>>>> data = 01:1F:00:80:02:14:02:0A:00:2B:00:13:00:02:04:00:00:00:00:00:12:03:00:01:03:0A:11:03:00:03:03:0A
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 31
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 10
>>>>>> tlv_length = 19
>>>>>> message = "UIM Get PIN Status" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "PIN2 Status" (0x12)
>>>>>> length = 3
>>>>>> value = 01:03:0A
>>>>>> translated = [ current_status = 'enabled-not-verified' verify_retries_left = '3' unblock_retries_left = '10' ]
>>>>>> TLV:
>>>>>> type = "PIN1 Status" (0x11)
>>>>>> length = 3
>>>>>> value = 03:03:0A
>>>>>> translated = [ current_status = 'disabled' verify_retries_left = '3' unblock_retries_left = '10' ]
<debug> [002.923217] [mm-iface-modem.c:3076] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
<debug> [002.923418] [mm-sim-qmi.c:148] load_sim_identifier(): loading SIM identifier...
<debug> [002.923453] [mm-sim-qmi.c:148] load_sim_identifier(): loading SIM identifier...
<warn> [002.923476] [mm-base-sim.c:1428] load_sim_identifier_ready(): couldn't load SIM identifier: 'QMI operation failed: Cannot send message: QMI service 'dms' version '1.3' required, got version '1.2''
<debug> [002.923492] [mm-sim-qmi.c:224] load_imsi(): loading IMSI...
<warn> [002.923516] [mm-base-sim.c:1464] load_imsi_ready(): couldn't load IMSI: 'QMI operation failed: Cannot send message: QMI service 'dms' version '1.3' required, got version '1.2''
<debug> [002.923566] [mm-broadband-modem-qmi.c:1408] modem_load_own_numbers(): loading own numbers...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:0E:00:24:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 14
<<<<<< tlv_length = 0
<<<<<< message = "Get MSISDN" (0x0024)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:02:14:02:0E:00:24:00:07:00:02:04:00:01:00:10:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 14
>>>>>> tlv_length = 7
>>>>>> message = "Get MSISDN" (0x0024)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:10:00
>>>>>> translated = FAILURE: NotProvisioned
<warn> [002.927117] [mm-iface-modem.c:4112] load_own_numbers_ready(): couldn't load list of Own Numbers: 'Couldn't get MSISDN: QMI protocol error (16): 'NotProvisioned''
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:02:00:2B:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Technology Preference" (0x002B)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:10:02:02:00:2B:00:07:00:02:04:00:01:00:47:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 7
>>>>>> message = "Get Technology Preference" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:47:00
>>>>>> translated = FAILURE: InvalidQmiCommand
<debug> [002.929104] [mm-broadband-modem-qmi.c:2853] get_technology_preference_ready(): Couldn't get technology preference: QMI protocol error (71): 'InvalidQmiCommand'
<warn> [002.929125] [mm-iface-modem.c:4141] load_current_modes_ready(): couldn't load current allowed/preferred modes: 'Loading current modes is not supported by this device'
<debug> [002.929143] [mm-broadband-modem-qmi.c:1875] modem_load_current_bands(): loading current bands...
<warn> [002.929177] [mm-iface-modem.c:4162] load_current_bands_ready(): couldn't load current Bands: 'QMI operation failed: Cannot send message: QMI service 'nas' version '1.1' required, got version '1.0''
<debug> [002.929482] [mm-broadband-modem-qmi.c:3281] modem_3gpp_load_imei_finish(): loaded IMEI: 353...
<debug> [002.929527] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'ph-sim' status, assuming disabled
<debug> [002.929550] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'net-pers' status, assuming disabled
<debug> [002.929571] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'net-sub-pers' status, assuming disabled
<debug> [002.929592] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'provider-pers' status, assuming disabled
<debug> [002.929612] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'corp-pers' status, assuming disabled
<debug> [002.929786] [mm-broadband-modem.c:8997] iface_modem_3gpp_ussd_initialize_ready(): Couldn't initialize interface: 'USSD not supported'
<debug> [002.930025] [mm-broadband-modem.c:9000] iface_modem_messaging_initialize_ready(): Couldn't initialize interface: 'Messaging not supported'
<debug> [002.930101] [mm-broadband-modem.c:9001] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
<debug> [002.930171] [mm-broadband-modem-qmi.c:9424] signal_check_support(): Extended signal capabilities supported
<debug> [002.930291] [mm-broadband-modem-qmi.c:8138] oma_check_support(): OMA capabilities not supported
<debug> [002.930320] [mm-broadband-modem.c:9003] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
<debug> [002.930379] [mm-broadband-modem-qmi.c:9090] firmware_check_support(): loading firmware images...
<debug> [002.930414] [mm-broadband-modem.c:9004] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
<info> [002.930493] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem: state changed (unknown -> disabled)
<debug> [002.930588] [mm-base-modem.c:939] initialize_ready(): modem properly initialized
<debug> [002.931126] [mm-device.c:436] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3' at path '/org/freedesktop/ModemManager1/Modem/0'
<debug> [002.931145] [mm-device.c:446] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Huawei' modem, VID 0x12D1 PID 0x140C (usb)
<info> [003.862161] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
<debug> [003.862698] [mm-broadband-modem.c:8002] enabling_started(): Skipping modem initialization: not required
<debug> [003.862767] [mm-broadband-modem-qmi.c:9891] parent_enabling_started_ready(): Couldn't start parent enabling: Couldn't open ports during modem enabling: Couldn't get primary port
<debug> [003.862816] [mm-broadband-modem-qmi.c:2682] load_power_state(): Getting device operating mode...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:14:00:15:00:2D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 20
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 21
<<<<<< tlv_length = 0
<<<<<< message = "Get Operating Mode" (0x002D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:02:14:02:15:00:2D:00:0B:00:02:04:00:00:00:00:00:01:01:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 20
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 21
>>>>>> tlv_length = 11
>>>>>> message = "Get Operating Mode" (0x002D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Mode" (0x01)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = online
<debug> [003.865144] [mm-iface-modem.c:3259] set_power_state(): No need to change power state: already in 'on' power state
<debug> [003.865168] [mm-broadband-modem.c:8591] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 23
<<<<<< data = 01:16:00:00:03:10:00:04:00:02:00:0A:00:10:07:00:01:05:B0:D8:00:28:50
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 22
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 10
<<<<<< message = "Set Event Report" (0x0002)
<<<<<< TLV:
<<<<<< type = "Signal Strength Indicator" (0x10)
<<<<<< length = 7
<<<<<< value = 01:05:B0:D8:00:28:50
<<<<<< translated = [ report = 'yes' thresholds = '{ [0] = '-80 ' [1] = '-40 ' [2] = '0 ' [3] = '40 ' [4] = '80 '}' ]
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:10:02:04:00:02:00:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 7
>>>>>> message = "Set Event Report" (0x0002)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
<debug> [003.867138] [mm-broadband-modem-qmi.c:4769] modem_3gpp_enable_unsolicited_registration_events(): Assuming serving system indications are always enabled
<debug> [003.867151] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:05:00:24:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 0
<<<<<< message = "Get Serving System" (0x0024)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 54
>>>>>> data = 01:35:00:80:03:10:02:05:00:24:00:29:00:02:04:00:00:00:00:00:01:06:00:01:01:01:02:01:05:10:01:00:01:12:0D:00:DB:00:02:00:08:54:65:6C:65:32:20:48:52:11:02:00:01:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 53
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 41
>>>>>> 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:05
>>>>>> translated = [ registration_state = 'registered' cs_attach_state = 'attached' ps_attach_state = 'attached' selected_network = '3gpp' radio_interfaces = '{ [0] = 'umts '}' ]
>>>>>> TLV:
>>>>>> type = "Roaming Indicator" (0x10)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = off
>>>>>> TLV:
>>>>>> type = "Current PLMN" (0x12)
>>>>>> length = 13
>>>>>> value = DB:00:02:00:08:54:65:6C:65:32:20:48:52
>>>>>> translated = [ mcc = '000' mnc = '0' description = 'Operator' ]
>>>>>> TLV:
>>>>>> type = "Data Service Capability" (0x11)
>>>>>> length = 2
>>>>>> value = 01:05
>>>>>> translated = { [0] = 'wcdma '}
<debug> [003.869074] [mm-broadband-modem-qmi.c:3907] common_process_serving_system_3gpp(): Processing 3GPP info...
<info> [003.869096] [mm-iface-modem-3gpp.c:1154] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
<debug> [003.869160] [mm-broadband-modem.c:8632] enabling_step(): Modem has location capabilities, enabling the Location interface...
<debug> [003.869172] [mm-iface-modem-location.c:759] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
<debug> [003.869205] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:06:00:24:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 0
<<<<<< message = "Get Serving System" (0x0024)
<info> [003.869428] [mm-iface-modem-3gpp.c:1079] update_registration_reload_current_registration_info_ready(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
<debug> [003.869460] [mm-iface-modem.c:1561] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
<debug> [003.869500] [mm-broadband-modem.c:8671] enabling_step(): Modem has extended signal reporting capabilities, enabling the Signal interface...
<debug> [003.869521] [mm-iface-modem-signal.c:206] setup_refresh_context(): Extended signal information reporting disabled (rate: 0 seconds)
<info> [003.869629] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
<debug> [003.870196] [mm-iface-modem.c:1316] periodic_signal_quality_check_enable(): Periodic signal quality checks enabled (interval = 3s)
<debug> [003.870241] [mm-broadband-modem-qmi.c:2456] load_signal_quality(): loading signal quality...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:07:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 7
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 54
>>>>>> data = 01:35:00:80:03:10:02:06:00:24:00:29:00:02:04:00:00:00:00:00:01:06:00:01:01:01:02:01:05:10:01:00:01:12:0D:00:DB:00:02:00:08:54:65:6C:65:32:20:48:52:11:02:00:01:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 53
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 41
>>>>>> 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:05
>>>>>> translated = [ registration_state = 'registered' cs_attach_state = 'attached' ps_attach_state = 'attached' selected_network = '3gpp' radio_interfaces = '{ [0] = 'umts '}' ]
>>>>>> TLV:
>>>>>> type = "Roaming Indicator" (0x10)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = off
>>>>>> TLV:
>>>>>> type = "Current PLMN" (0x12)
>>>>>> length = 13
>>>>>> value = DB:00:02:00:08:54:65:6C:65:32:20:48:52
>>>>>> translated = [ mcc = '000' mnc = '0' description = 'Operator' ]
>>>>>> TLV:
>>>>>> type = "Data Service Capability" (0x11)
>>>>>> length = 2
>>>>>> value = 01:05
>>>>>> translated = { [0] = 'wcdma '}
<debug> [003.871541] [mm-broadband-modem-qmi.c:3907] common_process_serving_system_3gpp(): Processing 3GPP info...
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:03:10:02:07:00:20:00:0C:00:02:04:00:00:00:00:00:01:02:00:AB:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 7
>>>>>> 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 = AB:05
>>>>>> translated = [ strength = '-85' radio_interface = 'umts' ]
<debug> [003.873202] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
<debug> [003.873229] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
<info> [003.873326] [mm-iface-modem.c:894] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> umts)
<debug> [003.873451] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
<debug> [003.873483] [mm-iface-modem.c:1235] signal_quality_check_ready(): Periodic signal quality checks rescheduled (interval = 30s)
<debug> [033.888502] [mm-broadband-modem-qmi.c:2456] load_signal_quality(): loading signal quality...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:08:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:03:10:02:08:00:20:00:0C:00:02:04:00:00:00:00:00:01:02:00:AB:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 8
>>>>>> 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 = AB:05
>>>>>> translated = [ strength = '-85' radio_interface = 'umts' ]
<debug> [033.891443] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
<debug> [033.891472] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
<debug> [033.891595] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
<debug> [063.873431] [mm-broadband-modem-qmi.c:2456] load_signal_quality(): loading signal quality...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:09:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:03:10:02:09:00:20:00:0C:00:02:04:00:00:00:00:00:01:02:00:AB:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> 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 = AB:05
>>>>>> translated = [ strength = '-85' radio_interface = 'umts' ]
<debug> [063.877540] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
<debug> [063.877568] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
<debug> [063.877697] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
# qmicli -d /dev/cdc-wdm0 --wds-start-network="<APN>,pap,<USER>,<PASSWD>" --client-no-release-cid
<debug> [093.881195] [mm-broadband-modem-qmi.c:2456] load_signal_quality(): loading signal quality...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:0A:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:03:10:02:0A:00:20:00:0C:00:02:04:00:00:00:00:00:01:02:00:AB:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 16
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 10
>>>>>> 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 = AB:05
>>>>>> translated = [ strength = '-85' radio_interface = 'umts' ]
<debug> [093.883710] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
<debug> [093.883738] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
<debug> [093.883865] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
# dhclient wwan0
<debug> [123.891034] [mm-broadband-modem-qmi.c:2456] load_signal_quality(): loading signal quality...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:0B:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 11
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
<debug> [133.871403] [mm-iface-modem.c:1221] signal_quality_check_ready(): Couldn't refresh signal quality: 'Transaction timed out'
# dhclient -r wwan0
<debug> [153.880592] [mm-broadband-modem-qmi.c:2456] load_signal_quality(): loading signal quality...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:0C:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 12
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
<debug> [153.880835] [mm-iface-modem.c:1101] expire_signal_quality(): Signal quality value not updated in 60s, marking as not being recent
<debug> [163.871270] [mm-iface-modem.c:1221] signal_quality_check_ready(): Couldn't refresh signal quality: 'Transaction timed out'
# qmicli -d /dev/cdc-wdm0 --wds-stop-network=<PDH> --client-cid=<CID>
<debug> [183.880478] [mm-broadband-modem-qmi.c:2456] load_signal_quality(): loading signal quality...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:10:00:0D:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 16
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 13
<<<<<< tlv_length = 0
<<<<<< message = "Get Signal Strength" (0x0020)
<debug> [193.870827] [mm-iface-modem.c:1221] signal_quality_check_ready(): Couldn't refresh signal quality: 'Transaction timed out'
poma
[1] https://aleksander.es/data/FOSDEM%202014%20-%20LTE%20in%20your%20Linux%20based%20system.pdf#4
http://ftp.osuosl.org/pub/fosdem//2014/AW1121/Sunday/LTE_in_your_Linuxbased_system.webm#t=572
More information about the ModemManager-devel
mailing list