E1750 Reloaded - QMI - STATIC - DHCP - IPv4

poma pomidorabelisima at gmail.com
Wed Aug 6 15:07:20 PDT 2014


 
 /etc/NetworkManager/system-connections/MBB
 [connection]
 id=MBB
 uuid=12345678-1234-1234-1234-123456789abc
 type=gsm
 autoconnect=false
 timestamp=1407274428
 zone=block
 
 [ipv6]
 method=ignore
 
 [gsm]
 username=username
 password=password
 apn=access.point.name
 home-only=true
 
 [ppp]
 refuse-eap=true
 refuse-chap=true
 refuse-mschap=true
 refuse-mschapv2=true
 nobsdcomp=true
 nodeflate=true
 no-vj-comp=true
 
 [serial]
 baud=115200
 
 [ipv4]
 method=auto
 
 ~~~~~~~~~~~
 
 Starting Modem Manager...
 <info>  [000.000071] [main.c:140] main(): ModemManager (version 1.3.0-1.git20140804.fc21) starting in system bus...
 <debug> [001.754017] [main.c:65] bus_acquired_cb(): Bus acquired, creating manager...
 <debug> [002.136766] [mm-plugin-manager.c:852] load_plugins(): Looking for plugins in '/usr/lib64/ModemManager'
 <debug> [002.137372] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Huawei'
 <warn>  [002.137400] [mm-plugin-manager.c:889] load_plugins(): Generic plugin not loaded
 <debug> [002.137409] [mm-plugin-manager.c:902] load_plugins(): Successfully loaded 1 plugins
 <debug> [002.138496] [main.c:87] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
 <debug> [002.138527] [mm-base-manager.c:479] mm_base_manager_start(): Starting automatic device scan...
 Started Modem Manager.
 <debug> [002.140207] [mm-base-manager.c:518] mm_base_manager_start(): Finished device scan...
 <debug> [002.140394] [mm-base-manager.c:297] device_added(): (tty/ttyS0): port's parent device is blacklisted
 <debug> [002.140507] [mm-base-manager.c:297] device_added(): (tty/ttyS1): port's parent device is blacklisted
 <debug> [002.140602] [mm-base-manager.c:314] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
 <debug> [002.140687] [mm-base-manager.c:314] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
 <debug> [002.198625] [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> [002.198871] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wwan0] Found '1' plugins to try...
 <debug> [002.198900] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wwan0]   Will try with plugin 'Huawei'
 <debug> [002.198930] [mm-plugin.c:689] mm_plugin_supports_port(): (Huawei) [wwan0] probing deferred until result suggested
 <debug> [002.199718] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '1' plugins to try...
 <debug> [002.199751] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [cdc-wdm0]   Will try with plugin 'Huawei'
 <debug> [002.199794] [mm-plugin.c:767] mm_plugin_supports_port(): (Huawei) [cdc-wdm0] probe required: 'qmi'
 <debug> [002.199823] [mm-port-probe.c:1353] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'qmi'
 <debug> [002.199871] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support check until result suggested
 <debug> [002.199908] [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> [002.315177] [mm-port-probe.c:271] mm_port_probe_set_result_qmi(): (usbmisc/cdc-wdm0) port is QMI-capable
 <debug> [002.315362] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [cdc-wdm0] found best plugin for port
 <debug> [002.315393] [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> [002.315432] [mm-plugin-manager.c:361] suggest_single_port_probe_result(): (Plugin Manager) (Huawei) [wwan0] deferred task completed, got suggested plugin
 <debug> [002.315459] [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> [002.315541] [mm-plugin.c:689] mm_plugin_supports_port(): (Huawei) [wwan0] probing deferred until result suggested
 <debug> [002.319356] [mm-plugin-manager.c:549] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [wwan0] task completed, got suggested plugin
 <debug> [002.319489] [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.120755' seconds elapsed)
 <debug> [004.898294] [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> [004.898377] [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.699644' seconds
 <info>  [004.898425] [mm-device.c:509] mm_device_create_modem(): Creating modem with plugin 'Huawei' and '2' ports
 <debug> [004.898488] [huawei/mm-plugin-huawei.c:491] create_modem(): QMI-powered Huawei modem found...
 <debug> [004.900983] [huawei/mm-plugin-huawei.c:554] grab_port(): (usbmisc/cdc-wdm0) Port will have AT flags 'none'
 <debug> [004.901097] [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> [004.901142] [huawei/mm-plugin-huawei.c:554] grab_port(): (net/wwan0) Port will have AT flags 'none'
 <debug> [004.901183] [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> [004.901236] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3) net/wwan0 data (primary)
 <debug> [004.901259] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:04.1/usb2/2-3) usb/cdc-wdm0 qmi (primary)
 <info>  [004.901754] [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:17
 [/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:17
 >>>>>>   translated = [ service = 'dms' cid = '23' ]
 [/dev/cdc-wdm0] Registered 'dms' (version 1.2) client with ID '23'
 [/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:13
 [/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:13
 >>>>>>   translated = [ service = 'nas' cid = '19' ]
 [/dev/cdc-wdm0] Registered 'nas' (version 1.0) client with ID '19'
 <debug> [004.925259] [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> [004.925315] [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> [004.925367] [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> [004.925454] [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> [004.926855] [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:13:00:01:00:2B:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< 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:13: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  = 19
 >>>>>> 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> [004.928840] [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:17:00:01:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.930919] [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> [004.931030] [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:17:00:02:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.934774] [mm-iface-modem.c:4327] interface_initialization_step(): Modem allows up to 1 bearers
 <debug> [004.934786] [mm-bearer-list.c:276] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
 <debug> [004.934838] [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:17:00:03:00:21:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.936731] [mm-broadband-modem-qmi.c:942] modem_load_manufacturer_finish(): loaded manufacturer: QUALCOMM INCORPORATED
 <debug> [004.936766] [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:17:00:04:00:22:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.940858] [mm-broadband-modem-qmi.c:1018] modem_load_model_finish(): loaded model: 29
 <debug> [004.940929] [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:17:00:05:00:23:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.944923] [mm-broadband-modem-qmi.c:1094] modem_load_revision_finish(): loaded revision: M6290A-KPRBL-...
 <debug> [004.944995] [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:17:00:06:00:25:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.948882] [mm-broadband-modem-qmi.c:1186] modem_load_equipment_identifier_finish(): loaded equipment identifier: 353...
 <debug> [004.948947] [mm-broadband-modem-qmi.c:1324] modem_load_device_identifier(): loading device identifier...
 <debug> [004.949006] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '000012d10000140c353...M6290A-KPRBL-...29QUALCOMMINCORPORATED'
 <debug> [004.949028] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID 'eb8d2760525a500bcbf18a9e9b89cd55098848e4'
 <debug> [004.949128] [mm-broadband-modem-qmi.c:1312] modem_load_device_identifier_finish(): loaded device identifier: eb8d2760525a500bcbf18a9e9b89cd55098848e4
 <debug> [004.949301] [mm-broadband-modem-qmi.c:1727] modem_load_supported_bands(): loading band capabilities...
 <warn>  [004.949381] [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> [004.949453] [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:17:00:08:00:2D:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.952892] [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:17:00:09:00:2B:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.956944] [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:17:00:0A:00:2B:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [004.961125] [mm-iface-modem.c:3076] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
 <debug> [004.961565] [mm-sim-qmi.c:148] load_sim_identifier(): loading SIM identifier...
 <debug> [004.961665] [mm-sim-qmi.c:148] load_sim_identifier(): loading SIM identifier...
 <warn>  [004.961730] [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> [004.961776] [mm-sim-qmi.c:224] load_imsi(): loading IMSI...
 <warn>  [004.961848] [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> [004.961985] [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:17:00:0E:00:24:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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>  [004.964827] [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:13:00:02:00:2B:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< 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:13: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  = 19
 >>>>>> 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> [004.966996] [mm-broadband-modem-qmi.c:2853] get_technology_preference_ready(): Couldn't get technology preference: QMI protocol error (71): 'InvalidQmiCommand'
 <warn>  [004.967083] [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> [004.967134] [mm-broadband-modem-qmi.c:1875] modem_load_current_bands(): loading current bands...
 <warn>  [004.967217] [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> [004.967916] [mm-broadband-modem-qmi.c:3281] modem_3gpp_load_imei_finish(): loaded IMEI: 353...
 <debug> [004.968034] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'ph-sim' status, assuming disabled
 <debug> [004.968108] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'net-pers' status, assuming disabled
 <debug> [004.968162] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'net-sub-pers' status, assuming disabled
 <debug> [004.968215] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'provider-pers' status, assuming disabled
 <debug> [004.968268] [mm-broadband-modem-qmi.c:3360] dms_uim_get_ck_status_ready(): Couldn't query facility 'corp-pers' status, assuming disabled
 <debug> [004.968706] [mm-broadband-modem.c:8997] iface_modem_3gpp_ussd_initialize_ready(): Couldn't initialize interface: 'USSD not supported'
 <debug> [004.969361] [mm-broadband-modem.c:9000] iface_modem_messaging_initialize_ready(): Couldn't initialize interface: 'Messaging not supported'
 <debug> [004.969576] [mm-broadband-modem.c:9001] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
 <debug> [004.969668] [mm-broadband-modem-qmi.c:9424] signal_check_support(): Extended signal capabilities supported
 <debug> [004.969789] [mm-broadband-modem-qmi.c:8138] oma_check_support(): OMA capabilities not supported
 <debug> [004.969846] [mm-broadband-modem.c:9003] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
 <debug> [004.969900] [mm-broadband-modem-qmi.c:9090] firmware_check_support(): loading firmware images...
 <debug> [004.969938] [mm-broadband-modem.c:9004] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
 <info>  [004.970021] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem: state changed (unknown -> disabled)
 <debug> [004.970120] [mm-base-modem.c:939] initialize_ready(): modem properly initialized
 <debug> [004.970655] [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> [004.970677] [mm-device.c:446] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Huawei' modem, VID 0x12D1 PID 0x140C (usb)
 <info>  [005.373629] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
 <debug> [005.374179] [mm-broadband-modem.c:8002] enabling_started(): Skipping modem initialization: not required
 <debug> [005.374250] [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> [005.374301] [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:17:00:15:00:2D:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "dms"
 <<<<<<   client  = 23
 <<<<<< 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:17: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  = 23
 >>>>>> 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> [005.376905] [mm-iface-modem.c:3259] set_power_state(): No need to change power state: already in 'on' power state
 <debug> [005.376980] [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:13: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  = 19
 <<<<<< 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:13: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  = 19
 >>>>>> 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> [005.380829] [mm-broadband-modem-qmi.c:4769] modem_3gpp_enable_unsolicited_registration_events(): Assuming serving system indications are always enabled
 <debug> [005.380879] [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:13:00:05:00:24:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< 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:13: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:4F:70:65:72:61:74:6F:72:11:02:00:01:05
 [/dev/cdc-wdm0] Received message (translated)...
 >>>>>> QMUX:
 >>>>>>   length  = 53
 >>>>>>   flags   = 0x80
 >>>>>>   service = "nas"
 >>>>>>   client  = 19
 >>>>>> 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:4F:70:65:72:61:74:6F:72
 >>>>>>   translated = [ mcc = '000' mnc = '0' description = 'Operator' ]
 >>>>>> TLV:
 >>>>>>   type       = "Data Service Capability" (0x11)
 >>>>>>   length     = 2
 >>>>>>   value      = 01:05
 >>>>>>   translated = { [0] = 'wcdma '}
 <debug> [005.384906] [mm-broadband-modem-qmi.c:3907] common_process_serving_system_3gpp(): Processing 3GPP info...
 <info>  [005.384959] [mm-iface-modem-3gpp.c:1154] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
 <debug> [005.385166] [mm-broadband-modem.c:8632] enabling_step(): Modem has location capabilities, enabling the Location interface...
 <debug> [005.385207] [mm-iface-modem-location.c:759] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
 <debug> [005.385300] [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:13:00:06:00:24:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 6
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Serving System" (0x0024)
 <info>  [005.386088] [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> [005.386186] [mm-iface-modem.c:1561] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
 <debug> [005.386224] [mm-broadband-modem.c:8671] enabling_step(): Modem has extended signal reporting capabilities, enabling the Signal interface...
 <debug> [005.386277] [mm-iface-modem-signal.c:206] setup_refresh_context(): Extended signal information reporting disabled (rate: 0 seconds)
 <info>  [005.386530] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
 <debug> [005.386889] [mm-iface-modem.c:1316] periodic_signal_quality_check_enable(): Periodic signal quality checks enabled (interval = 3s)
 <debug> [005.386925] [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:13:00:07:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< 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:13: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:4F:70:65:72:61:74:6F:72:11:02:00:01:05
 [/dev/cdc-wdm0] Received message (translated)...
 >>>>>> QMUX:
 >>>>>>   length  = 53
 >>>>>>   flags   = 0x80
 >>>>>>   service = "nas"
 >>>>>>   client  = 19
 >>>>>> 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:4F:70:65:72:61:74:6F:72
 >>>>>>   translated = [ mcc = '000' mnc = '0' description = 'Operator' ]
 >>>>>> TLV:
 >>>>>>   type       = "Data Service Capability" (0x11)
 >>>>>>   length     = 2
 >>>>>>   value      = 01:05
 >>>>>>   translated = { [0] = 'wcdma '}
 <debug> [005.388620] [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:13: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  = 19
 >>>>>> 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> [005.390582] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [005.390591] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <info>  [005.390625] [mm-iface-modem.c:894] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> umts)
 <debug> [005.390660] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [005.390671] [mm-iface-modem.c:1235] signal_quality_check_ready(): Periodic signal quality checks rescheduled (interval = 30s)
 <debug> [035.926131] [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:13:00:08:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< 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:13: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  = 19
 >>>>>> 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> [035.929085] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [035.929117] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [035.929252] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [065.914455] [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:13:00:09:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< 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:13: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  = 19
 >>>>>> 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> [065.917316] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [065.917346] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [065.917473] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [095.922543] [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:13:00:0A:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< 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:13: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  = 19
 >>>>>> 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> [095.925589] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [095.925618] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [095.925748] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [125.904889] [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:13:00:0B:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 11
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:0B: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  = 19
 >>>>>> 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      = AB:05
 >>>>>>   translated = [ strength = '-85' radio_interface = 'umts' ]
 <debug> [125.907518] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [125.907548] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [125.907676] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [155.925855] [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:13:00:0C:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 12
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:0C: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  = 19
 >>>>>> 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      = AB:05
 >>>>>>   translated = [ strength = '-85' radio_interface = 'umts' ]
 <debug> [155.929687] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [155.929717] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [155.929847] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 
 
 $ nmcli connection up MBB
 
 
 <debug> [185.926004] [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:13:00:0D:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 13
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:0D: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  = 19
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 13
 >>>>>>   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> [185.930010] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [185.930059] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [185.930191] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [215.925346] [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:13:00:0E:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 14
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:0E: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  = 19
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 14
 >>>>>>   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> [215.928001] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [215.928029] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [215.928185] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [245.903890] [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:13:00:0F:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 15
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:0F: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  = 19
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 15
 >>>>>>   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> [245.908254] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [245.908283] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [245.908413] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [275.916398] [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:13:00:10:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 16
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:10: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  = 19
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 16
 >>>>>>   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> [275.920440] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [275.920468] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [275.920591] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <info>  [293.146515] [mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
 <debug> [293.146572] [mm-iface-modem-simple.c:651] connect_auth_ready():    PIN: unspecified
 <debug> [293.146595] [mm-iface-modem-simple.c:653] connect_auth_ready():    Operator ID: unspecified
 <debug> [293.285711] [mm-iface-modem-simple.c:655] connect_auth_ready():    Allowed roaming: no
 <debug> [293.286050] [mm-iface-modem-simple.c:657] connect_auth_ready():    APN: access.point.name
 <debug> [293.286323] [mm-iface-modem-simple.c:662] connect_auth_ready():    IP family: ipv4
 <debug> [293.286581] [mm-iface-modem-simple.c:670] connect_auth_ready():    Allowed authentication: none, pap
 <debug> [293.286816] [mm-iface-modem-simple.c:675] connect_auth_ready():    User: username
 <debug> [293.287069] [mm-iface-modem-simple.c:677] connect_auth_ready():    Password: password
 <debug> [293.287311] [mm-iface-modem-simple.c:679] connect_auth_ready():    Number: unspecified
 <info>  [293.287568] [mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
 <info>  [293.287932] [mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
 <debug> [293.288131] [mm-iface-modem-3gpp.c:390] mm_iface_modem_3gpp_register_in_network(): Already registered in network '00000', automatic registration not launched...
 <info>  [293.288419] [mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
 <debug> [293.288650] [mm-iface-modem-simple.c:521] connection_step(): Creating new bearer...
 <debug> [293.288901] [mm-broadband-modem-qmi.c:320] modem_create_bearer(): Creating QMI bearer in QMI modem
 <debug> [293.289774] [mm-broadband-modem-qmi.c:299] modem_create_bearer_finish(): New bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0'
 <info>  [293.290089] [mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
 <debug> [293.290131] [mm-base-bearer.c:590] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
 <info>  [293.290184] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
 <debug> [293.290570] [mm-bearer-qmi.c:952] _connect(): Launching connection with QMI port (usb/cdc-wdm0) and data port (net/wwan0)
 <debug> [293.290610] [mm-bearer-qmi.c:655] connect_context_step(): Running IPv4 connection setup
 <debug> [293.290632] [mm-bearer-qmi.c:668] connect_context_step(): Allocating IPv4-specific WDS client
 [/dev/cdc-wdm0] Allocating new client ID...
 [/dev/cdc-wdm0] Sent message...
 <<<<<< RAW:
 <<<<<<   length = 16
 <<<<<<   data   = 01:0F:00:00:00:00:00:05:22:00:04:00:01:01:00:01
 [/dev/cdc-wdm0] 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
 [/dev/cdc-wdm0] 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:18
 [/dev/cdc-wdm0] 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:18
 >>>>>>   translated = [ service = 'wds' cid = '24' ]
 [/dev/cdc-wdm0] Registered 'wds' (version 1.3) client with ID '24'
 <debug> [293.295378] [mm-bearer-qmi.c:710] connect_context_step(): Starting IPv4 connection...
 [/dev/cdc-wdm0] Sent message...
 <<<<<< RAW:
 <<<<<<   length = 70
 <<<<<<   data   = 01:45:00:00:01:18:00:01:00:20:00:39:00:19:01:00:04:18:09:00:70:61:73:73:77:6F:72:64:17:10:00:75:73:65:72:6E:61:6D:65:16:01:00:01:14:0F:00:61:63:63:65:73:73:2E:70:6F:69:6E:74:2E:6E:61:6D:65
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 69
 <<<<<<   flags   = 0x00
 <<<<<<   service = "wds"
 <<<<<<   client  = 24
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 1
 <<<<<<   tlv_length  = 57
 <<<<<<   message     = "Start Network" (0x0020)
 <<<<<< TLV:
 <<<<<<   type       = "IP Family Preference" (0x19)
 <<<<<<   length     = 1
 <<<<<<   value      = 04
 <<<<<<   translated = ipv4
 <<<<<< TLV:
 <<<<<<   type       = "Password" (0x18)
 <<<<<<   length     = 9
 <<<<<<   value      = 70:61:73:73:77:6F:72:64
 <<<<<<   translated = password
 <<<<<< TLV:
 <<<<<<   type       = "Username" (0x17)
 <<<<<<   length     = 16
 <<<<<<   value      = 75:73:65:72:6E:61:6D:65
 <<<<<<   translated = username
 <<<<<< TLV:
 <<<<<<   type       = "Authentication Preference" (0x16)
 <<<<<<   length     = 1
 <<<<<<   value      = 01
 <<<<<<   translated = pap
 <<<<<< TLV:
 <<<<<<   type       = "APN" (0x14)
 <<<<<<   length     = 15
 <<<<<<   value      = 61:63:63:65:73:73:2E:70:6F:69:6E:74:2E:6E:61:6D:65
 <<<<<<   translated = access.point.name
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 27
 >>>>>>   data   = 01:1A:00:80:01:18:02:01:00:20:00:0E:00:02:04:00:00:00:00:00:01:04:00:34:91:CF:01
 [/dev/cdc-wdm0] Received message (translated)...
 >>>>>> QMUX:
 >>>>>>   length  = 26
 >>>>>>   flags   = 0x80
 >>>>>>   service = "wds"
 >>>>>>   client  = 24
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 1
 >>>>>>   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      = 34:91:CF:01
 >>>>>>   translated = 30380340
 <debug> [296.467180] [mm-bearer-qmi.c:725] connect_context_step(): Getting IPv4 configuration...
 [/dev/cdc-wdm0] Sent message...
 <<<<<< RAW:
 <<<<<<   length = 20
 <<<<<<   data   = 01:13:00:00:01:18:00:02:00:2D:00:07:00:10:04:00:30:E3:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 19
 <<<<<<   flags   = 0x00
 <<<<<<   service = "wds"
 <<<<<<   client  = 24
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 2
 <<<<<<   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
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 18
 >>>>>>   data   = 01:11:00:80:01:FF:04:00:00:22:00:05:00:01:02:00:02:00
 [/dev/cdc-wdm0] Received message (translated)...
 >>>>>> QMUX:
 >>>>>>   length  = 17
 >>>>>>   flags   = 0x80
 >>>>>>   service = "wds"
 >>>>>>   client  = 255
 >>>>>> QMI:
 >>>>>>   flags       = "indication"
 >>>>>>   transaction = 0
 >>>>>>   tlv_length  = 5
 >>>>>>   message     = (0x0022)
 >>>>>> TLV:
 >>>>>>   type   = 0x01
 >>>>>>   length = 2
 >>>>>>   value  = 02:00
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 91
 >>>>>>   data   = 01:5A:00:80:01:18:02:02:00:2D:00:4E:00:02:04:00:00:00:00:00:1E:04:00:4A:3E:93:1F:15:04:00:82:B8:C6:C1:16:04:00:8C:B8:C6:C1:20:04:00:49:3E:93:1F:21:04:00:FC:FF:FF:FF:17:21:00:04:F5:02:00:00:3E:03:00:00:10:00:00:00:80:00:00:00:02:DC:05:00:00:04:07:03:00:00:00:00:03:00:00:00
 [/dev/cdc-wdm0] Received message (translated)...
 >>>>>> QMUX:
 >>>>>>   length  = 90
 >>>>>>   flags   = 0x80
 >>>>>>   service = "wds"
 >>>>>>   client  = 24
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 2
 >>>>>>   tlv_length  = 78
 >>>>>>   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      = 4E:38:EA:01
 >>>>>>   translated = 32127054
 >>>>>> TLV:
 >>>>>>   type       = "Primary IPv4 DNS Address" (0x15)
 >>>>>>   length     = 4
 >>>>>>   value      = 08:08:08:08
 >>>>>>   translated = 134744072
 >>>>>> TLV:
 >>>>>>   type       = "Secondary IPv4 DNS Address" (0x16)
 >>>>>>   length     = 4
 >>>>>>   value      = 04:04:08:08
 >>>>>>   translated = 134743044
 >>>>>> TLV:
 >>>>>>   type       = "IPv4 Gateway Address" (0x20)
 >>>>>>   length     = 4
 >>>>>>   value      = 4D:38:EA:01
 >>>>>>   translated = 32127053
 >>>>>> TLV:
 >>>>>>   type       = "IPv4 Gateway Subnet Mask" (0x21)
 >>>>>>   length     = 4
 >>>>>>   value      = FC:FF:FF:FF
 >>>>>>   translated = 4294967292
 >>>>>> TLV:
 >>>>>>   type   = 0x17
 >>>>>>   length = 33
 >>>>>>   value  = 04:F5:02:00:00:3E:03:00:00:10:00:00:00:80:00:00:00:02:DC:05:00:00:04:07:03:00:00:00:00:03:00:00:00
 <debug> [296.471217] [mm-bearer-qmi.c:461] get_current_settings_ready():  IP Family: failed (Field 'IP Family' was not found in the message); assuming IPv4
 <debug> [296.471244] [mm-bearer-qmi.c:467] get_current_settings_ready():  IP Family: IPv4
 <debug> [296.471265] [mm-bearer-qmi.c:470] get_current_settings_ready():        MTU: failed (Field 'MTU' was not found in the message)
 <debug> [296.471307] [mm-bearer-qmi.c:291] get_ipv4_config(): QMI IPv4 Settings:
 <debug> [296.471369] [mm-bearer-qmi.c:300] get_ipv4_config():     Address: 01.234.56.78/30
 <debug> [296.471394] [mm-bearer-qmi.c:306] get_ipv4_config():     Gateway: 01.234.56.77
 <debug> [296.471413] [mm-bearer-qmi.c:316] get_ipv4_config():     DNS #1: 8.8.8.8
 <debug> [296.471708] [mm-bearer-qmi.c:326] get_ipv4_config():     DNS #2: 8.8.4.4
 <debug> [296.473506] [mm-bearer-qmi.c:492] get_current_settings_ready():    Domains: failed (Field 'Domain Name List' was not found in the message)
 <debug> [296.474389] [mm-port.c:95] mm_port_set_connected(): (wwan0): port now connected
 <debug> [296.475147] [mm-base-bearer.c:488] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
 <info>  [296.475941] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
 <info>  [296.478308] [mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
 <debug> [305.905471] [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:13:00:11:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 17
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:11: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  = 19
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 17
 >>>>>>   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> [305.910694] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [305.910723] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [305.910852] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 
 
 $ nmcli connection down MBB
 
 
 <debug> [335.906464] [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:13:00:12:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 18
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:12: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  = 19
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 18
 >>>>>>   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> [335.910839] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [335.910868] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [335.910997] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)
 <debug> [350.667701] [mm-base-bearer.c:760] mm_base_bearer_disconnect(): Disconnecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
 <info>  [350.668805] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting)
 [/dev/cdc-wdm0] Sent message...
 <<<<<< RAW:
 <<<<<<   length = 20
 <<<<<<   data   = 01:13:00:00:01:18:00:03:00:21:00:07:00:01:04:00:34:91:CF:01
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 19
 <<<<<<   flags   = 0x00
 <<<<<<   service = "wds"
 <<<<<<   client  = 24
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 3
 <<<<<<   tlv_length  = 7
 <<<<<<   message     = "Stop Network" (0x0021)
 <<<<<< TLV:
 <<<<<<   type       = "Packet Data Handle" (0x01)
 <<<<<<   length     = 4
 <<<<<<   value      = 34:91:CF:01
 <<<<<<   translated = 30380340
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 20
 >>>>>>   data   = 01:13:00:80:01:18:02:03:00:21:00:07:00:02:04:00:00:00:00:00
 [/dev/cdc-wdm0] Received message (translated)...
 >>>>>> QMUX:
 >>>>>>   length  = 19
 >>>>>>   flags   = 0x80
 >>>>>>   service = "wds"
 >>>>>>   client  = 24
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 3
 >>>>>>   tlv_length  = 7
 >>>>>>   message     = "Stop Network" (0x0021)
 >>>>>> TLV:
 >>>>>>   type       = "Result" (0x02)
 >>>>>>   length     = 4
 >>>>>>   value      = 00:00:00:00
 >>>>>>   translated = SUCCESS
 <debug> [350.677467] [mm-port.c:95] mm_port_set_connected(): (wwan0): port now disconnected
 <debug> [350.677486] [mm-base-bearer.c:693] disconnect_ready(): Disconnected bearer '/org/freedesktop/ModemManager1/Bearer/0'
 <info>  [350.677516] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 23
 >>>>>>   data   = 01:16:00:80:01:FF:04:00:00:22:00:0A:00:01:02:00:01:00:10:02:00:01:00
 [/dev/cdc-wdm0] Received message (translated)...
 >>>>>> QMUX:
 >>>>>>   length  = 22
 >>>>>>   flags   = 0x80
 >>>>>>   service = "wds"
 >>>>>>   client  = 255
 >>>>>> QMI:
 >>>>>>   flags       = "indication"
 >>>>>>   transaction = 0
 >>>>>>   tlv_length  = 10
 >>>>>>   message     = (0x0022)
 >>>>>> TLV:
 >>>>>>   type   = 0x01
 >>>>>>   length = 2
 >>>>>>   value  = 01:00
 >>>>>> TLV:
 >>>>>>   type   = 0x10
 >>>>>>   length = 2
 >>>>>>   value  = 01:00
 <debug> [365.910100] [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:13:00:13:00:20:00:00:00
 [/dev/cdc-wdm0] Sent message (translated)...
 <<<<<< QMUX:
 <<<<<<   length  = 12
 <<<<<<   flags   = 0x00
 <<<<<<   service = "nas"
 <<<<<<   client  = 19
 <<<<<< QMI:
 <<<<<<   flags       = "none"
 <<<<<<   transaction = 19
 <<<<<<   tlv_length  = 0
 <<<<<<   message     = "Get Signal Strength" (0x0020)
 [/dev/cdc-wdm0] Received message...
 >>>>>> RAW:
 >>>>>>   length = 25
 >>>>>>   data   = 01:18:00:80:03:13:02:13: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  = 19
 >>>>>> QMI:
 >>>>>>   flags       = "response"
 >>>>>>   transaction = 19
 >>>>>>   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> [365.912861] [mm-broadband-modem-qmi.c:2346] signal_strength_get_quality_and_access_tech(): Signal strength (umts): -85 dBm
 <debug> [365.912890] [mm-broadband-modem-qmi.c:2379] signal_strength_get_quality_and_access_tech(): Signal strength: -85 dBm --> 46%
 <debug> [365.913019] [mm-iface-modem.c:1165] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (46)


poma





More information about the ModemManager-devel mailing list