ModemManager[15695]: spawning new mbim-proxy (try 1)...
ModemManager[15695]: <debug> [1465836139.238397] [mm-port-serial-at.c:459] debug_log(): (ttyS0): --> 'AT<CR>'
ModemManager[15695]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 88
<<<<<<   data   = 03:00:00:00:58:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:01:00:00:00:28:00:00:00:0C:00:00:00:1A:00:00:00:1E:00:00:00:2F:00:64:00:65:00:76:00:2F:00:63:00:64:00:63:00:2D:00:77:00:64:00:6D:00:30:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 88
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 1
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
<<<<<<   cid     = 'configuration' (0x00000001)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[15695]: <debug> [1465836140.122541] [mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 0: min probing time elapsed
ModemManager[15695]: <debug> [1465836140.122574] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 1 running probes (1 active): ttyS0
ModemManager[15695]: <debug> [1465836140.122586] [mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 1: min probing time elapsed
ModemManager[15695]: <debug> [1465836140.122594] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 1: still 2 running probes (1 active): cdc-wdm0, wwan0
ModemManager[15695]: <debug> [1465836140.122607] [mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 2: min probing time elapsed
ModemManager[15695]: <debug> [1465836140.122623] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 2: still 1 running probes (0 active): wlan0
ModemManager[15695]: <debug> [1465836140.122655] [mm-plugin-manager.c:1009] device_context_continue(): [plugin manager] task 2: no active tasks to probe
ModemManager[15695]: <debug> [1465836140.122671] [mm-plugin-manager.c:337] port_context_set_suggestion(): [plugin manager] task 2,wlan0: deferred task completed, no suggested plugin
ModemManager[15695]: <debug> [1465836140.122686] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 2,wlan0: finished in '2.500597' seconds
ModemManager[15695]: <debug> [1465836140.122749] [mm-plugin-manager.c:892] device_context_set_best_plugin(): [plugin manager] task 2,wlan0: not supported by any plugin
ModemManager[15695]: <debug> [1465836140.122768] [mm-device.c:373] mm_device_ignore_port(): Fully ignoring port 'net/wlan0' from now on
ModemManager[15695]: <debug> [1465836140.122783] [mm-plugin-manager.c:979] device_context_continue(): [plugin manager] task 2: no more ports to probe
ModemManager[15695]: <debug> [1465836140.122792] [mm-plugin-manager.c:813] device_context_complete(): [plugin manager] task 2: finished in '2.500745' seconds
ModemManager[15695]: <info>  [1465836140.122941] [mm-base-manager.c:155] device_support_check_ready(): Couldn't check support for device at '/sys/devices/pci0000:00/0000:00:1c.2/0000:04:00.0': not supported by any plugin
ModemManager[15695]: <debug> [1465836140.123143] [mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 3: min probing time elapsed
ModemManager[15695]: <debug> [1465836140.123314] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 3: still 1 running probes (0 active): eth0
ModemManager[15695]: <debug> [1465836140.123485] [mm-plugin-manager.c:1009] device_context_continue(): [plugin manager] task 3: no active tasks to probe
ModemManager[15695]: <debug> [1465836140.123603] [mm-plugin-manager.c:337] port_context_set_suggestion(): [plugin manager] task 3,eth0: deferred task completed, no suggested plugin
ModemManager[15695]: <debug> [1465836140.123760] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 3,eth0: finished in '2.501520' seconds
ModemManager[15695]: <debug> [1465836140.123994] [mm-plugin-manager.c:892] device_context_set_best_plugin(): [plugin manager] task 3,eth0: not supported by any plugin
ModemManager[15695]: <debug> [1465836140.124173] [mm-device.c:373] mm_device_ignore_port(): Fully ignoring port 'net/eth0' from now on
ModemManager[15695]: <debug> [1465836140.124283] [mm-plugin-manager.c:979] device_context_continue(): [plugin manager] task 3: no more ports to probe
ModemManager[15695]: <debug> [1465836140.124392] [mm-plugin-manager.c:813] device_context_complete(): [plugin manager] task 3: finished in '2.502200' seconds
ModemManager[15695]: <info>  [1465836140.124509] [mm-base-manager.c:155] device_support_check_ready(): Couldn't check support for device at '/sys/devices/pci0000:00/0000:00:1f.6': not supported by any plugin
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 48
>>>>>>   data   = 03:00:00:80:30:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 48
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 1
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>>>>>>   cid          = 'configuration' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 16
<<<<<<   data   = 01:00:00:00:10:00:00:00:02:00:00:00:00:10:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 16
<<<<<<   type        = open (0x00000001)
<<<<<<   transaction = 2
<<<<<< Contents:
<<<<<<   max_control_transfer = 4096
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 01:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
ModemManager[15695]: <debug> [1465836142.310162] [mm-port-probe.c:304] mm_port_probe_set_result_mbim(): (usbmisc/cdc-wdm0) port is MBIM-capable
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 12
<<<<<<   data   = 02:00:00:00:0C:00:00:00:03:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 12
<<<<<<   type        = close (0x00000002)
<<<<<<   transaction = 3
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 02:00:00:80:10:00:00:00:03:00:00:00:00:00:00:00
ModemManager[15695]: <debug> [1465836142.310392] [mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 1,cdc-wdm0: found best plugin for port (Sierra)
ModemManager[15695]: <debug> [1465836142.310403] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 1,cdc-wdm0: finished in '4.687581' seconds
ModemManager[15695]: <debug> [1465836142.310418] [mm-plugin-manager.c:913] device_context_set_best_plugin(): [plugin manager] task 1,cdc-wdm0: found best plugin: Sierra
ModemManager[15695]: <debug> [1465836142.310426] [mm-plugin-manager.c:326] port_context_set_suggestion(): [plugin manager] task 1,wwan0: deferred task completed, got suggested plugin (Sierra)
ModemManager[15695]: <debug> [1465836142.310434] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 1: still 1 running probes (1 active): wwan0
ModemManager[15695]: <debug> [1465836142.310454] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,wwan0: checking with plugin 'Sierra'
ModemManager[15695]: <debug> [1465836142.310539] [mm-plugin.c:730] mm_plugin_supports_port(): (Sierra) [wwan0] probing deferred until result suggested
ModemManager[15695]: <debug> [1465836142.310662] [mm-plugin-manager.c:434] port_context_defer_until_suggested(): [plugin manager] task 1,wwan0: completed, got suggested plugin (Sierra)
ModemManager[15695]: <debug> [1465836142.310781] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 1,wwan0: finished in '4.688840' seconds
ModemManager[15695]: <debug> [1465836142.310904] [mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 1,wwan0: best plugin matches device reported one: Sierra
ModemManager[15695]: <debug> [1465836142.311061] [mm-plugin-manager.c:979] device_context_continue(): [plugin manager] task 1: no more ports to probe
ModemManager[15695]: <debug> [1465836142.311172] [mm-plugin-manager.c:813] device_context_complete(): [plugin manager] task 1: finished in '4.689290' seconds
ModemManager[15695]: <info>  [1465836142.311273] [mm-device.c:525] mm_device_create_modem(): Creating modem with plugin 'Sierra' and '2' ports
ModemManager[15695]: <debug> [1465836142.311387] [sierra/mm-plugin-sierra.c:66] create_modem(): MBIM-powered Sierra modem found...
ModemManager[15695]: <debug> [1465836142.312107] [mm-base-modem.c:280] mm_base_modem_grab_port(): (cdc-wdm0) type 'mbim' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb1/1-2
ModemManager[15695]: <debug> [1465836142.312131] [mm-base-modem.c:280] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb1/1-2
ModemManager[15695]: <debug> [1465836142.312147] [mm-base-modem.c:864] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2) net/wwan0 data (primary)
ModemManager[15695]: <debug> [1465836142.312157] [mm-base-modem.c:864] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2) usb/cdc-wdm0 mbim (primary)
ModemManager[15695]: <info>  [1465836142.312285] [mm-base-manager.c:175] device_support_check_ready(): Modem for device at '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2' successfully created
ModemManager[15695]: opening device...
ModemManager[15695]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 88
<<<<<<   data   = 03:00:00:00:58:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:01:00:00:00:28:00:00:00:0C:00:00:00:1A:00:00:00:1E:00:00:00:2F:00:64:00:65:00:76:00:2F:00:63:00:64:00:63:00:2D:00:77:00:64:00:6D:00:30:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 88
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 1
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
<<<<<<   cid     = 'configuration' (0x00000001)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 48
>>>>>>   data   = 03:00:00:80:30:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 48
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 1
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>>>>>>   cid          = 'configuration' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 16
<<<<<<   data   = 01:00:00:00:10:00:00:00:02:00:00:00:00:10:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 16
<<<<<<   type        = open (0x00000001)
<<<<<<   transaction = 2
<<<<<< Contents:
<<<<<<   max_control_transfer = 4096
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 01:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
ModemManager[15695]: <debug> [1465836142.372720] [mm-broadband-modem-mbim.c:1578] parent_initialization_started_ready(): Couldn't start parent initialization: Couldn't open ports during modem initialization: Couldn't get primary port
ModemManager[15695]: <debug> [1465836142.373155] [mm-broadband-modem-mbim.c:218] modem_load_current_capabilities(): loading current capabilities...
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 3
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-caps' (0x00000001)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 196
>>>>>>   data   = 03:00:00:80:C4:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:94:00:00:00:03:00:00:00:01:00:00:00:01:00:00:00:02:00:00:00:3C:00:00:00:03:00:00:00:01:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:40:00:00:00:1E:00:00:00:60:00:00:00:28:00:00:00:88:00:00:00:0C:00:00:00:30:00:31:00:34:00:35:00:38:00:32:00:30:00:30:00:30:00:35:00:32:00:36:00:34:00:37:00:36:00:00:00:53:00:57:00:49:00:39:00:58:00:33:00:30:00:43:00:5F:00:30:00:32:00:2E:00:30:00:38:00:2E:00:30:00:32:00:2E:00:30:00:30:00:45:00:4D:00:37:00:34:00:35:00:35:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 196
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 3
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-caps' (0x00000001)
ModemManager[15695]: <debug> [1465836142.436612] [mm-broadband-modem-mbim.c:144] modem_load_current_capabilities_finish(): loaded modem capabilities: gsm-umts, lte
ModemManager[15695]: <debug> [1465836142.436672] [mm-iface-modem.c:4345] interface_initialization_step(): Modem allows up to 1 bearers
ModemManager[15695]: <debug> [1465836142.436683] [mm-bearer-list.c:270] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
ModemManager[15695]: <debug> [1465836142.436777] [mm-modem-helpers.c:211] mm_create_device_identifier(): Device ID source '0000119900009079014582000526476SWI9X30C_02.08.02.00MBIM[1199:9079]Sierra'
ModemManager[15695]: <debug> [1465836142.436788] [mm-modem-helpers.c:212] mm_create_device_identifier(): Device ID '9e169eacf81d32d78cb812e12eccffd3dc58b9a8'
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 4
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'radio-state' (0x00000003)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 4
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'radio-state' (0x00000003)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 5
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 180
>>>>>>   data   = 03:00:00:80:B4:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:84:00:00:00:01:00:00:00:3C:00:00:00:1E:00:00:00:5C:00:00:00:26:00:00:00:00:00:00:00:01:00:00:00:24:00:00:00:16:00:00:00:31:00:36:00:35:00:30:00:33:00:30:00:37:00:30:00:37:00:37:00:34:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:39:00:37:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:00:00:38:00:39:00:30:00:31:00:32:00:36:00:30:00:39:00:37:00:31:00:31:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:30:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 180
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 5
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 6
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin' (0x00000004)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:03:00:00:00:01:00:00:00:0A:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 6
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'pin' (0x00000004)
ModemManager[15695]: <debug> [1465836142.628702] [mm-iface-modem.c:3110] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:07:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 7
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 180
>>>>>>   data   = 03:00:00:80:B4:00:00:00:07:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:84:00:00:00:01:00:00:00:3C:00:00:00:1E:00:00:00:5C:00:00:00:26:00:00:00:00:00:00:00:01:00:00:00:24:00:00:00:16:00:00:00:31:00:36:00:35:00:30:00:33:00:30:00:37:00:30:00:37:00:37:00:34:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:39:00:37:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:00:00:38:00:39:00:30:00:31:00:32:00:36:00:30:00:39:00:37:00:31:00:31:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:30:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 180
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 7
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 8
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 180
>>>>>>   data   = 03:00:00:80:B4:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:84:00:00:00:01:00:00:00:3C:00:00:00:1E:00:00:00:5C:00:00:00:26:00:00:00:00:00:00:00:01:00:00:00:24:00:00:00:16:00:00:00:31:00:36:00:35:00:30:00:33:00:30:00:37:00:30:00:37:00:37:00:34:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:39:00:37:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:00:00:38:00:39:00:30:00:31:00:32:00:36:00:30:00:39:00:37:00:31:00:31:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:30:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 180
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 8
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:09:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 9
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'home-provider' (0x00000006)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 112
>>>>>>   data   = 03:00:00:80:70:00:00:00:09:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:40:00:00:00:20:00:00:00:0C:00:00:00:01:00:00:00:2C:00:00:00:14:00:00:00:01:00:00:00:63:00:00:00:63:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:50:00:72:00:6F:00:6A:00:65:00:63:00:74:00:20:00:46:00:69:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 112
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 9
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'home-provider' (0x00000006)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 10
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'home-provider' (0x00000006)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 112
>>>>>>   data   = 03:00:00:80:70:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:40:00:00:00:20:00:00:00:0C:00:00:00:01:00:00:00:2C:00:00:00:14:00:00:00:01:00:00:00:63:00:00:00:63:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:50:00:72:00:6F:00:6A:00:65:00:63:00:74:00:20:00:46:00:69:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 112
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 10
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'home-provider' (0x00000006)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 11
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 180
>>>>>>   data   = 03:00:00:80:B4:00:00:00:0B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:84:00:00:00:01:00:00:00:3C:00:00:00:1E:00:00:00:5C:00:00:00:26:00:00:00:00:00:00:00:01:00:00:00:24:00:00:00:16:00:00:00:31:00:36:00:35:00:30:00:33:00:30:00:37:00:30:00:37:00:37:00:34:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:39:00:37:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:00:00:38:00:39:00:30:00:31:00:32:00:36:00:30:00:39:00:37:00:31:00:31:00:30:00:36:00:34:00:33:00:36:00:38:00:39:00:30:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 180
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 11
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 12
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin-list' (0x00000005)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 208
>>>>>>   data   = 03:00:00:80:D0:00:00:00:0C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:00:00:00:00:A0:00:00:00:02:00:00:00:01:00:00:00:04:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00:04:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 208
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 12
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'pin-list' (0x00000005)
ModemManager[15695]: <debug> [1465836143.012756] [mm-iface-modem-3gpp-ussd.c:786] check_support_ready(): USSD support check failed: 'No AT port available to run command'
ModemManager[15695]: <debug> [1465836143.012777] [mm-broadband-modem.c:9627] iface_modem_3gpp_ussd_initialize_ready(): Couldn't initialize interface: 'USSD not supported'
ModemManager[15695]: <debug> [1465836143.013014] [mm-broadband-modem-mbim.c:2881] messaging_check_support(): Messaging capabilities supported
ModemManager[15695]: <debug> [1465836143.013040] [mm-iface-modem-messaging.c:1149] load_supported_storages_ready(): Supported storages loaded:
ModemManager[15695]: <debug> [1465836143.013047] [mm-iface-modem-messaging.c:1150] load_supported_storages_ready():   mem1 (list/read/delete) storages: 'mt'
ModemManager[15695]: <debug> [1465836143.013052] [mm-iface-modem-messaging.c:1151] load_supported_storages_ready():   mem2 (write/send) storages:       'mt'
ModemManager[15695]: <debug> [1465836143.013056] [mm-iface-modem-messaging.c:1152] load_supported_storages_ready():   mem3 (reception) storages:        'mt'
ModemManager[15695]: <debug> [1465836143.013077] [mm-iface-modem-messaging.c:1229] init_current_storages_ready(): Couldn't initialize current storages: 'No AT port available to run command'
ModemManager[15695]: <debug> [1465836143.013143] [mm-iface-modem-voice.c:916] check_support_ready(): Voice support check failed: 'No AT port available to run command'
ModemManager[15695]: <debug> [1465836143.013160] [mm-broadband-modem.c:9631] iface_modem_voice_initialize_ready(): Couldn't initialize interface: 'Voice not supported'
ModemManager[15695]: <debug> [1465836143.013204] [mm-iface-modem-time.c:831] check_support_ready(): Time support check failed: 'No AT port available to run command'
ModemManager[15695]: <debug> [1465836143.013218] [mm-broadband-modem.c:9632] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
ModemManager[15695]: <debug> [1465836143.013267] [mm-broadband-modem.c:9633] iface_modem_signal_initialize_ready(): Couldn't initialize interface: 'Extended Signal information not supported'
ModemManager[15695]: <debug> [1465836143.014998] [mm-broadband-modem.c:9634] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
ModemManager[15695]: <debug> [1465836143.015056] [mm-broadband-modem.c:9635] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
ModemManager[15695]: <info>  [1465836143.015154] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem: state changed (unknown -> disabled)
ModemManager[15695]: <debug> [1465836143.015265] [mm-base-modem.c:833] initialize_ready(): modem properly initialized
ModemManager[15695]: <debug> [1465836143.015814] [mm-device.c:452] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2' at path '/org/freedesktop/ModemManager1/Modem/0'
ModemManager[15695]: <debug> [1465836143.015840] [mm-device.c:462] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Sierra' modem, VID 0x1199 PID 0x9079 (usb)
ModemManager[15695]: <info>  [1465836143.023994] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
ModemManager[15695]: <debug> [1465836143.024763] [mm-broadband-modem.c:8539] enabling_started(): Skipping modem initialization: not required
ModemManager[15695]: <debug> [1465836143.026572] [mm-broadband-modem-mbim.c:1505] parent_enabling_started_ready(): Couldn't start parent enabling: Couldn't open ports during modem enabling: Couldn't get primary port
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 13
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'radio-state' (0x00000003)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38:00:00:00:0D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 13
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'radio-state' (0x00000003)
ModemManager[15695]: <debug> [1465836143.076600] [mm-iface-modem.c:3293] set_power_state(): No need to change power state: already in 'on' power state
ModemManager[15695]: <debug> [1465836143.076626] [mm-broadband-modem.c:9197] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
ModemManager[15695]: <debug> [1465836143.076645] [mm-broadband-modem-mbim.c:2265] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[15695]: <debug> [1465836143.076677] [mm-broadband-modem-mbim.c:2404] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 96
<<<<<<   data   = 03:00:00:00:60:00:00:00:0E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:30:00:00:00:01:00:00:00:0C:00:00:00:24:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:0B:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 96
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 14
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-service-subscribe-list' (0x00000013)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60:00:00:00:0E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:30:00:00:00:01:00:00:00:0C:00:00:00:24:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:0B:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 14
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-service-subscribe-list' (0x00000013)
ModemManager[15695]: <debug> [1465836143.076924] [mm-broadband-modem-mbim.c:2265] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[15695]: <debug> [1465836143.076947] [mm-broadband-modem-mbim.c:2404] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 100
<<<<<<   data   = 03:00:00:00:64:00:00:00:0F:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:34:00:00:00:01:00:00:00:0C:00:00:00:28:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 100
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 15
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-service-subscribe-list' (0x00000013)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 100
>>>>>>   data   = 03:00:00:80:64:00:00:00:0F:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:34:00:00:00:01:00:00:00:0C:00:00:00:28:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 100
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 15
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-service-subscribe-list' (0x00000013)
ModemManager[15695]: <debug> [1465836143.077340] [mm-broadband-modem.c:9238] enabling_step(): Modem has location capabilities, enabling the Location interface...
ModemManager[15695]: <debug> [1465836143.077464] [mm-iface-modem-location.c:762] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
ModemManager[15695]: <debug> [1465836143.077602] [mm-iface-modem-3gpp.c:761] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:10:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 16
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'register-state' (0x00000009)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: <debug> [1465836143.078021] [mm-broadband-modem.c:9251] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
ModemManager[15695]: <debug> [1465836143.078115] [mm-broadband-modem-mbim.c:3036] load_initial_sms_parts(): loading SMS parts...
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 60
<<<<<<   data   = 03:00:00:00:3C:00:00:00:11:00:00:00:01:00:00:00:00:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:00:00:00:00:0C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 60
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 17
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
<<<<<<   cid     = 'read' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: <debug> [1465836143.115484] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[15695]: <debug> [1465836143.115650] [mm-port-serial-at.c:459] debug_log(): (ttyS0): --> 'AT<CR>'
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38:00:00:00:11:00:00:00:01:00:00:00:00:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:00:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 17
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
>>>>>>   cid          = 'read' (0x00000002)
ModemManager[15695]: <debug> [1465836143.140592] [mm-broadband-modem-mbim.c:2265] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
ModemManager[15695]: <debug> [1465836143.140611] [mm-broadband-modem-mbim.c:2404] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 136
<<<<<<   data   = 03:00:00:00:88:00:00:00:12:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:58:00:00:00:02:00:00:00:14:00:00:00:28:00:00:00:3C:00:00:00:1C:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:02:00:00:00:05:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 136
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 18
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-service-subscribe-list' (0x00000013)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 136
>>>>>>   data   = 03:00:00:80:88:00:00:00:12:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:58:00:00:00:02:00:00:00:14:00:00:00:28:00:00:00:3C:00:00:00:1C:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:02:00:00:00:05:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 136
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 18
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-service-subscribe-list' (0x00000013)
ModemManager[15695]: <info>  [1465836143.141784] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> enabled)
ModemManager[15695]: <debug> [1465836143.141966] [mm-iface-modem-3gpp.c:761] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:13:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 19
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'register-state' (0x00000009)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 128
>>>>>>   data   = 03:00:00:80:80:00:00:00:10:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:50:00:00:00:00:00:00:00:03:00:00:00:01:00:00:00:20:00:00:00:01:00:00:00:30:00:00:00:0C:00:00:00:3C:00:00:00:14:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:50:00:72:00:6F:00:6A:00:65:00:63:00:74:00:20:00:46:00:69:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 128
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 16
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'register-state' (0x00000009)
ModemManager[15695]: <info>  [1465836143.204634] [mm-iface-modem-3gpp.c:1171] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
ModemManager[15695]: <debug> [1465836143.204667] [mm-iface-modem.c:933] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> lte)
ModemManager[15695]: <debug> [1465836143.204697] [mm-iface-modem-location.c:297] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '310', MNC: '260', Location area code: '0', Cell ID: '0')
ModemManager[15695]: <info>  [1465836143.204842] [mm-iface-modem-3gpp.c:1096] update_registration_reload_current_registration_info_ready(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
ModemManager[15695]: <debug> [1465836143.204867] [mm-iface-modem.c:1600] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
ModemManager[15695]: <info>  [1465836143.204877] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabled -> registered)
ModemManager[15695]: <debug> [1465836143.204963] [mm-iface-modem.c:1075] periodic_access_technologies_check_enable(): Periodic access technology checks enabled
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 128
>>>>>>   data   = 03:00:00:80:80:00:00:00:13:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:50:00:00:00:00:00:00:00:03:00:00:00:01:00:00:00:20:00:00:00:01:00:00:00:30:00:00:00:0C:00:00:00:3C:00:00:00:14:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00:33:00:31:00:30:00:32:00:36:00:30:00:50:00:72:00:6F:00:6A:00:65:00:63:00:74:00:20:00:46:00:69:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 128
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 19
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'register-state' (0x00000009)
ModemManager[15695]: <debug> [1465836143.268610] [mm-broadband-modem.c:8574] modem_3gpp_run_registration_checks_ready(): Initial 3GPP registration checks finished
ModemManager[15695]: <debug> [1465836146.114813] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[15695]: <debug> [1465836146.114935] [mm-port-serial-at.c:459] debug_log(): (ttyS0): --> 'AT<CR>'
ModemManager[15695]: <debug> [1465836149.115782] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[15695]: <debug> [1465836149.115857] [mm-port-probe.c:165] mm_port_probe_set_result_at(): (tty/ttyS0) port is not AT-capable
ModemManager[15695]: <debug> [1465836149.115904] [mm-plugin.c:504] apply_post_probing_filters(): (Iridium) [ttyS0] filtered as no vendor/product strings given
ModemManager[15695]: <debug> [1465836149.115947] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyS0: checking with plugin 'Cinterion'
ModemManager[15695]: <debug> [1465836149.116033] [mm-plugin.c:804] mm_plugin_supports_port(): (Cinterion) [ttyS0] probe required: 'at, at-vendor'
ModemManager[15695]: <debug> [1465836149.116105] [mm-port-probe.c:1367] mm_port_probe_run(): (tty/ttyS0) port probing finished: no more probings needed
ModemManager[15695]: <debug> [1465836149.116191] [mm-port-serial.c:1345] _close_internal(): (ttyS0) device open count is 0 (close)
ModemManager[15695]: <debug> [1465836149.116229] [mm-port-serial.c:1361] _close_internal(): (ttyS0) closing serial port...
ModemManager[15695]: <debug> [1465836149.116386] [mm-port-serial.c:1409] _close_internal(): (ttyS0) serial port closed
ModemManager[15695]: <debug> [1465836149.116460] [mm-port-serial.c:1471] port_serial_close_force(): (ttyS0) forced to close port
ModemManager[15695]: <debug> [1465836149.116532] [mm-plugin.c:479] apply_post_probing_filters(): (Cinterion) [ttyS0] filtered by vendor strings
ModemManager[15695]: <debug> [1465836149.116570] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyS0: checking with plugin 'Nokia'
ModemManager[15695]: <debug> [1465836149.116632] [mm-plugin.c:804] mm_plugin_supports_port(): (Nokia) [ttyS0] probe required: 'at, at-vendor, at-icera'
ModemManager[15695]: <debug> [1465836149.116765] [mm-port-probe.c:1367] mm_port_probe_run(): (tty/ttyS0) port probing finished: no more probings needed
ModemManager[15695]: <debug> [1465836149.117307] [mm-plugin.c:479] apply_post_probing_filters(): (Nokia) [ttyS0] filtered by vendor strings
ModemManager[15695]: <debug> [1465836149.117699] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyS0: checking with plugin 'Via CBP7'
ModemManager[15695]: <debug> [1465836149.118124] [mm-plugin.c:804] mm_plugin_supports_port(): (Via CBP7) [ttyS0] probe required: 'at, at-vendor, at-product'
ModemManager[15695]: <debug> [1465836149.118530] [mm-port-probe.c:1367] mm_port_probe_run(): (tty/ttyS0) port probing finished: no more probings needed
ModemManager[15695]: <debug> [1465836149.118963] [mm-plugin.c:504] apply_post_probing_filters(): (Via CBP7) [ttyS0] filtered as no vendor/product strings given
ModemManager[15695]: <debug> [1465836149.119359] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyS0: checking with plugin 'Generic'
ModemManager[15695]: <debug> [1465836149.119813] [mm-plugin.c:804] mm_plugin_supports_port(): (Generic) [ttyS0] probe required: 'at, qcdm'
ModemManager[15695]: <debug> [1465836149.120212] [mm-port-probe.c:1377] mm_port_probe_run(): (tty/ttyS0) launching port probing: 'qcdm'
ModemManager[15695]: <debug> [1465836149.120632] [mm-port-probe.c:691] serial_probe_qcdm(): (tty/ttyS0) probing QCDM...
ModemManager[15695]: <debug> [1465836149.121078] [mm-port-serial.c:1158] mm_port_serial_open(): (ttyS0) opening serial port...
ModemManager[15695]: <debug> [1465836149.121623] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyS0) device open count is 1 (open)
ModemManager[15695]: <debug> [1465836149.121898] [mm-port-serial-qcdm.c:199] debug_log(): (ttyS0): --> 7e 00 78 f0 7e
ModemManager[15695]: <debug> [1465836152.115926] [mm-port-serial-qcdm.c:199] debug_log(): (ttyS0): --> 7e 00 78 f0 7e
ModemManager[15695]: <debug> [1465836155.115466] [mm-port-probe.c:261] mm_port_probe_set_result_qcdm(): (tty/ttyS0) port is not QCDM-capable
ModemManager[15695]: <debug> [1465836155.115517] [mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyS0: found best plugin for port (Generic)
ModemManager[15695]: <debug> [1465836155.115539] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyS0: finished in '17.494387' seconds
ModemManager[15695]: <debug> [1465836155.115571] [mm-plugin-manager.c:979] device_context_continue(): [plugin manager] task 0: no more ports to probe
ModemManager[15695]: <debug> [1465836155.115587] [mm-plugin-manager.c:813] device_context_complete(): [plugin manager] task 0: finished in '17.494539' seconds
ModemManager[15695]: <info>  [1465836155.115630] [mm-device.c:525] mm_device_create_modem(): Creating modem with plugin 'Generic' and '1' ports
ModemManager[15695]: <warn>  [1465836155.116004] [mm-plugin.c:957] mm_plugin_create_modem(): Could not grab port (tty/ttyS0): 'Cannot add port 'tty/ttyS0', unhandled serial type'
ModemManager[15695]: <debug> [1465836155.116068] [mm-base-modem.c:1379] finalize(): Modem (Generic) '/sys/devices/pci0000:00/0000:00:16.3' completely disposed
ModemManager[15695]: <warn>  [1465836155.116091] [mm-base-manager.c:167] device_support_check_ready(): Couldn't create modem for device at '/sys/devices/pci0000:00/0000:00:16.3': Failed to find primary AT port
ModemManager[15695]: <debug> [1465836155.116136] [mm-port-serial.c:1345] _close_internal(): (ttyS0) device open count is 0 (close)
ModemManager[15695]: <debug> [1465836155.116162] [mm-port-serial.c:1361] _close_internal(): (ttyS0) closing serial port...
ModemManager[15695]: <debug> [1465836155.116265] [mm-port-serial.c:1409] _close_internal(): (ttyS0) serial port closed
ModemManager[15695]: <debug> [1465836155.116302] [mm-port-serial.c:1471] port_serial_close_force(): (ttyS0) forced to close port


ModemManager[15695]: <info>  [1465836169.423340] [mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
ModemManager[15695]: <debug> [1465836169.423367] [mm-iface-modem-simple.c:651] connect_auth_ready():    PIN: unspecified
ModemManager[15695]: <debug> [1465836169.423376] [mm-iface-modem-simple.c:653] connect_auth_ready():    Operator ID: unspecified
ModemManager[15695]: <debug> [1465836169.423384] [mm-iface-modem-simple.c:655] connect_auth_ready():    Allowed roaming: yes
ModemManager[15695]: <debug> [1465836169.423391] [mm-iface-modem-simple.c:657] connect_auth_ready():    APN: h2g2
ModemManager[15695]: <debug> [1465836169.423398] [mm-iface-modem-simple.c:665] connect_auth_ready():    IP family: unspecified
ModemManager[15695]: <debug> [1465836169.423409] [mm-iface-modem-simple.c:670] connect_auth_ready():    Allowed authentication: none, pap, chap, mschap, mschapv2, eap
ModemManager[15695]: <debug> [1465836169.423417] [mm-iface-modem-simple.c:675] connect_auth_ready():    User: unspecified
ModemManager[15695]: <debug> [1465836169.423424] [mm-iface-modem-simple.c:677] connect_auth_ready():    Password: unspecified
ModemManager[15695]: <debug> [1465836169.423431] [mm-iface-modem-simple.c:679] connect_auth_ready():    Number: *99#
ModemManager[15695]: <info>  [1465836169.423437] [mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
ModemManager[15695]: <info>  [1465836169.423452] [mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
ModemManager[15695]: <debug> [1465836169.423552] [mm-iface-modem-3gpp.c:400] mm_iface_modem_3gpp_register_in_network(): Already registered in network '310260', automatic registration not launched...
ModemManager[15695]: <info>  [1465836169.423904] [mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
ModemManager[15695]: <debug> [1465836169.423922] [mm-iface-modem-simple.c:521] connection_step(): Creating new bearer...
ModemManager[15695]: <debug> [1465836169.424017] [mm-broadband-modem-mbim.c:1448] modem_create_bearer(): Creating MBIM bearer in MBIM modem
ModemManager[15695]: <debug> [1465836169.424356] [mm-broadband-modem-mbim.c:1362] modem_create_bearer_finish(): New bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[15695]: <info>  [1465836169.424474] [mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
ModemManager[15695]: <debug> [1465836169.424489] [mm-base-bearer.c:703] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[15695]: <info>  [1465836169.424750] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
ModemManager[15695]: <debug> [1465836169.424929] [mm-bearer-mbim.c:1024] _connect(): Launching connection with data port (net/wwan0)
ModemManager[15695]: <debug> [1465836169.424943] [mm-bearer-mbim.c:782] connect_context_step(): Activating packet service...
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 52
<<<<<<   data   = 03:00:00:00:34:00:00:00:14:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:01:00:00:00:04:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 52
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 20
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'packet-service' (0x0000000a)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 76
>>>>>>   data   = 03:00:00:80:4C:00:00:00:14:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:00:00:00:00:1C:00:00:00:00:00:00:00:02:00:00:00:20:00:00:00:80:F0:FA:02:00:00:00:00:00:A3:E1:11:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 76
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 20
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'packet-service' (0x0000000a)
ModemManager[15695]: <debug> [1465836169.444253] [mm-bearer-mbim.c:721] packet_service_set_ready(): Packet service update:
ModemManager[15695]: <debug> [1465836169.444263] [mm-bearer-mbim.c:722] packet_service_set_ready():          state: 'attached'
ModemManager[15695]: <debug> [1465836169.444269] [mm-bearer-mbim.c:723] packet_service_set_ready():     data class: 'lte'
ModemManager[15695]: <debug> [1465836169.444276] [mm-bearer-mbim.c:724] packet_service_set_ready():         uplink: '50000000' bps
ModemManager[15695]: <debug> [1465836169.444282] [mm-bearer-mbim.c:725] packet_service_set_ready():       downlink: '300000000' bps
ModemManager[15695]: <debug> [1465836169.444289] [mm-bearer-mbim.c:803] connect_context_step(): Listing provisioned contexts...
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:15:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 21
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'provisioned-contexts' (0x0000000d)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 120
>>>>>>   data   = 03:00:00:80:78:00:00:00:15:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:48:00:00:00:01:00:00:00:0C:00:00:00:3C:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:34:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:68:00:32:00:67:00:32:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 120
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 21
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'provisioned-contexts' (0x0000000d)
ModemManager[15695]: <debug> [1465836169.508375] [mm-bearer-mbim.c:656] provisioned_contexts_query_ready(): Provisioned contexts found (1):
ModemManager[15695]: <debug> [1465836169.508392] [mm-bearer-mbim.c:662] provisioned_contexts_query_ready(): [1] context type: internet
ModemManager[15695]: <debug> [1465836169.508401] [mm-bearer-mbim.c:663] provisioned_contexts_query_ready():              uuid: 7e5e2a7e-4e6f-7272-736b-656e7e5e2a7e
ModemManager[15695]: <debug> [1465836169.508409] [mm-bearer-mbim.c:664] provisioned_contexts_query_ready():     access string: h2g2
ModemManager[15695]: <debug> [1465836169.508417] [mm-bearer-mbim.c:665] provisioned_contexts_query_ready():          username: 
ModemManager[15695]: <debug> [1465836169.508425] [mm-bearer-mbim.c:666] provisioned_contexts_query_ready():          password: 
ModemManager[15695]: <debug> [1465836169.508435] [mm-bearer-mbim.c:667] provisioned_contexts_query_ready():       compression: none
ModemManager[15695]: <debug> [1465836169.508443] [mm-bearer-mbim.c:668] provisioned_contexts_query_ready():              auth: none
ModemManager[15695]: <debug> [1465836169.508470] [mm-bearer-mbim.c:868] connect_context_step(): No specific IP family requested, defaulting to ipv4
ModemManager[15695]: <debug> [1465836169.508483] [mm-bearer-mbim.c:899] connect_context_step(): Launching connection with APN 'h2g2'...
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 116
<<<<<<   data   = 03:00:00:00:74:00:00:00:16:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:01:00:00:00:44:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:68:00:32:00:67:00:32:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 116
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 22
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'connect' (0x0000000c)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 80
>>>>>>   data   = 07:00:00:80:50:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:24:00:00:00:00:00:00:00:02:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 80
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'connect' (0x0000000c)
ModemManager[15695]: <debug> [1465836169.572370] [mm-broadband-modem-mbim.c:2219] device_notification_cb(): Received notification (service 'basic-connect', command 'connect')
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 84
>>>>>>   data   = 03:00:00:80:54:00:00:00:16:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:00:00:00:00:24:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 84
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 22
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'connect' (0x0000000c)
ModemManager[15695]: <debug> [1465836169.925088] [mm-bearer-mbim.c:611] connect_set_ready(): Session ID '0': activated (IP type: ipv4)
ModemManager[15695]: <debug> [1465836169.925103] [mm-bearer-mbim.c:930] connect_context_step(): Querying IP configuration...
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 108
<<<<<<   data   = 03:00:00:00:6C:00:00:00:17:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 108
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 23
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'ip-configuration' (0x0000000f)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 128
>>>>>>   data   = 03:00:00:80:80:00:00:00:17:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:50:00:00:00:00:00:00:00:0F:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:44:00:00:00:00:00:00:00:02:00:00:00:48:00:00:00:00:00:00:00:00:00:00:00:DC:05:00:00:00:00:00:00:1C:00:00:00:1A:C3:D7:27:1A:C3:D7:28:0A:B1:00:22:0A:B1:00:D2
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 128
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 23
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'ip-configuration' (0x0000000f)
ModemManager[15695]: <debug> [1465836169.988458] [mm-bearer-mbim.c:319] ip_configuration_query_ready(): IPv4 configuration available: 'address, gateway, dns, mtu'
ModemManager[15695]: <debug> [1465836169.988468] [mm-bearer-mbim.c:325] ip_configuration_query_ready():   IP addresses (1)
ModemManager[15695]: <debug> [1465836169.988539] [mm-bearer-mbim.c:329] ip_configuration_query_ready():     IP [0]: '26.195.215.39/28'
ModemManager[15695]: <debug> [1465836169.988552] [mm-bearer-mbim.c:338] ip_configuration_query_ready():   Gateway: '26.195.215.40'
ModemManager[15695]: <debug> [1465836169.988560] [mm-bearer-mbim.c:346] ip_configuration_query_ready():   DNS addresses (2)
ModemManager[15695]: <debug> [1465836169.988571] [mm-bearer-mbim.c:351] ip_configuration_query_ready():     DNS [0]: '10.177.0.34'
ModemManager[15695]: <debug> [1465836169.988581] [mm-bearer-mbim.c:351] ip_configuration_query_ready():     DNS [1]: '10.177.0.210'
ModemManager[15695]: <debug> [1465836169.988588] [mm-bearer-mbim.c:359] ip_configuration_query_ready():   MTU: '1500'
ModemManager[15695]: <debug> [1465836169.988594] [mm-bearer-mbim.c:365] ip_configuration_query_ready(): IPv6 configuration available: 'none'
ModemManager[15695]: <debug> [1465836169.988633] [mm-port.c:95] mm_port_set_connected(): (wwan0): port now connected
ModemManager[15695]: <debug> [1465836169.988649] [mm-base-bearer.c:601] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:18:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:14:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 24
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'packet-statistics' (0x00000014)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: <info>  [1465836169.988935] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
ModemManager[15695]: <info>  [1465836169.989161] [mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60:00:00:00:18:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:14:00:00:00:00:00:00:00:30:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 24
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'packet-statistics' (0x00000014)
ModemManager[15695]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:19:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:14:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 25
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'packet-statistics' (0x00000014)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[15695]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60:00:00:00:19:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:14:00:00:00:00:00:00:00:30:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15695]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 25
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'packet-statistics' (0x00000014)