ModemManager[5554]: <debug> [1402913752.120893] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1] Checking device support...
ModemManager[5554]: <debug> [1402913752.121200] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121256] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121294] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.121338] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121375] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [cdc-wdm1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.121419] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121457] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121500] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [cdc-wdm1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.121535] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121577] [mm-plugin.c:212] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121621] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121656] [mm-plugin.c:212] apply_pre_probing_filters(): (Samsung) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121698] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121733] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121766] [mm-plugin.c:212] apply_pre_probing_filters(): (Novatel LTE) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121808] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121844] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [cdc-wdm1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.121886] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [cdc-wdm1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.121921] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.121963] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [cdc-wdm1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.122006] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [cdc-wdm1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.122049] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [cdc-wdm1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.122093] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [cdc-wdm1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.122136] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.122183] [mm-plugin.c:212] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.122228] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm1] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.122263] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [cdc-wdm1] Found '1' plugins to try...
ModemManager[5554]: <debug> [1402913752.122297] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [cdc-wdm1]   Will try with plugin 'Generic'
ModemManager[5554]: <debug> [1402913752.122337] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [cdc-wdm1] probe required: 'mbim'
ModemManager[5554]: <debug> [1402913752.122391] [mm-port-probe.c:1352] mm_port_probe_run(): (usbmisc/cdc-wdm1) launching port probing: 'mbim'
ModemManager[5554]: <debug> [1402913752.122555] [mm-port-probe.c:522] wdm_probe_mbim(): (usbmisc/cdc-wdm1) probing MBIM...
ModemManager[5554]: [/dev/cdc-wdm1] Queried max control message size: 512
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 16
<<<<<<   data   = 01:00:00:00:10:00:00:00:01:00:00:00:00:02:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 16
<<<<<<   type        = open (0x00000001)
<<<<<<   transaction = 1
<<<<<< Contents:
<<<<<<   max_control_transfer = 512
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 01:00:00:80:10:00:00:00:01:00:00:00:00:00:00:00
ModemManager[5554]: <debug> [1402913752.130713] [mm-port-probe.c:300] mm_port_probe_set_result_mbim(): (usbmisc/cdc-wdm1) port is MBIM-capable
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 12
<<<<<<   data   = 02:00:00:00:0C:00:00:00:02:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 12
<<<<<<   type        = close (0x00000002)
<<<<<<   transaction = 2
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 02:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
ModemManager[5554]: <debug> [1402913752.135309] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [cdc-wdm1] found best plugin for port
ModemManager[5554]: <debug> [1402913752.135398] [mm-plugin-manager.c:313] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm1' port probe finished, last one in device, but minimum probing time not consumed yet ('0.014397' seconds elapsed)
ModemManager[5554]: <debug> [1402913752.151853] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.151933] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.151973] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152010] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152052] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wwan1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.152140] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152176] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152215] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152249] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152286] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152320] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152354] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152388] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152421] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152454] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152487] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152522] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152565] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152608] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152651] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152694] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152736] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wwan1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.152779] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wwan1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.152823] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wwan1] filtered by subsystem
ModemManager[5554]: <debug> [1402913752.152865] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wwan1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.152910] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wwan1] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.152953] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wwan1] Found '1' plugins to try...
ModemManager[5554]: <debug> [1402913752.152995] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wwan1]   Will try with plugin 'Generic'
ModemManager[5554]: <debug> [1402913752.153037] [mm-plugin.c:704] mm_plugin_supports_port(): (Generic) [wwan1] probing deferred until result suggested
ModemManager[5554]: <debug> [1402913752.153125] [mm-plugin-manager.c:537] plugin_supports_port_ready(): (Plugin Manager) (Generic) [wwan1] task deferred until result suggested and got suggested plugin
ModemManager[5554]: <debug> [1402913752.153170] [mm-plugin-manager.c:361] suggest_single_port_probe_result(): (Plugin Manager) (Generic) [wwan1] deferred task completed, got suggested plugin
ModemManager[5554]: <debug> [1402913752.153205] [mm-plugin-manager.c:549] plugin_supports_port_ready(): (Plugin Manager) (Generic) [wwan1] task completed, got suggested plugin
ModemManager[5554]: <debug> [1402913752.153247] [mm-plugin-manager.c:313] port_probe_context_finished(): (Plugin Manager) 'wwan1' port probe finished, last one in device, but minimum probing time not consumed yet ('0.032246' seconds elapsed)
ModemManager[5554]: <debug> [1402913752.223137] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223232] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223273] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223310] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB2] filtered by drivers
ModemManager[5554]: <debug> [1402913752.223356] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223392] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223427] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223463] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223499] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223534] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223568] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223602] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223635] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223669] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223703] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223739] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB2] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.223773] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223820] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223856] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB2] filtered by drivers
ModemManager[5554]: <debug> [1402913752.223892] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB2] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.223928] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB2] filtered by drivers
ModemManager[5554]: <debug> [1402913752.223973] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB2] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.224016] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB2] Found '5' plugins to try...
ModemManager[5554]: <debug> [1402913752.224059] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Iridium'
ModemManager[5554]: <debug> [1402913752.224163] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Via CBP7'
ModemManager[5554]: <debug> [1402913752.224198] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Nokia'
ModemManager[5554]: <debug> [1402913752.224239] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Cinterion'
ModemManager[5554]: <debug> [1402913752.224274] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Generic'
ModemManager[5554]: <debug> [1402913752.224325] [mm-plugin.c:782] mm_plugin_supports_port(): (Iridium) [ttyUSB2] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.224370] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.224566] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB2) opening serial port...
ModemManager[5554]: <warn>  [1402913752.228495] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
ModemManager[5554]: <debug> [1402913752.228622] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913752.252953] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253043] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253083] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253120] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB0] filtered by drivers
ModemManager[5554]: <debug> [1402913752.253162] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253197] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253232] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253268] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253304] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253338] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253371] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253405] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253439] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253472] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253505] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253540] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB0] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.253576] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253620] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253655] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB0] filtered by drivers
ModemManager[5554]: <debug> [1402913752.253691] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB0] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.253725] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB0] filtered by drivers
ModemManager[5554]: <debug> [1402913752.253759] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB0] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.253802] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB0] Found '5' plugins to try...
ModemManager[5554]: <debug> [1402913752.253845] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Iridium'
ModemManager[5554]: <debug> [1402913752.253886] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Via CBP7'
ModemManager[5554]: <debug> [1402913752.253928] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Nokia'
ModemManager[5554]: <debug> [1402913752.253972] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Cinterion'
ModemManager[5554]: <debug> [1402913752.254013] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Generic'
ModemManager[5554]: <debug> [1402913752.254070] [mm-plugin.c:782] mm_plugin_supports_port(): (Iridium) [ttyUSB0] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.254122] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.254324] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
ModemManager[5554]: <warn>  [1402913752.257860] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
ModemManager[5554]: <debug> [1402913752.257978] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913752.264941] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265033] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265073] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265110] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.265151] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265186] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265221] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265256] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265292] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265327] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265362] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265396] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265430] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265463] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265496] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265531] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB1] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.265601] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265636] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265670] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.265710] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB1] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.265752] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB1] filtered by drivers
ModemManager[5554]: <debug> [1402913752.265796] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB1] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.265839] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB1] Found '5' plugins to try...
ModemManager[5554]: <debug> [1402913752.265873] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Iridium'
ModemManager[5554]: <debug> [1402913752.265914] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Via CBP7'
ModemManager[5554]: <debug> [1402913752.265947] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Nokia'
ModemManager[5554]: <debug> [1402913752.265980] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Cinterion'
ModemManager[5554]: <debug> [1402913752.266012] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Generic'
ModemManager[5554]: <debug> [1402913752.266059] [mm-plugin.c:782] mm_plugin_supports_port(): (Iridium) [ttyUSB1] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.266111] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.274030] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274119] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274159] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274204] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB3] filtered by drivers
ModemManager[5554]: <debug> [1402913752.274239] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274273] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274306] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274343] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274379] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274413] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274446] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274480] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274523] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274558] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274592] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274628] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB3] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.274670] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274713] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274755] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB3] filtered by drivers
ModemManager[5554]: <debug> [1402913752.274800] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB3] filtered by vendor/product IDs
ModemManager[5554]: <debug> [1402913752.274843] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB3] filtered by drivers
ModemManager[5554]: <debug> [1402913752.274881] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB3] filtered by udev tags
ModemManager[5554]: <debug> [1402913752.274923] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB3] Found '5' plugins to try...
ModemManager[5554]: <debug> [1402913752.274959] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3]   Will try with plugin 'Iridium'
ModemManager[5554]: <debug> [1402913752.274992] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3]   Will try with plugin 'Via CBP7'
ModemManager[5554]: <debug> [1402913752.275024] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3]   Will try with plugin 'Nokia'
ModemManager[5554]: <debug> [1402913752.275056] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3]   Will try with plugin 'Cinterion'
ModemManager[5554]: <debug> [1402913752.275088] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3]   Will try with plugin 'Generic'
ModemManager[5554]: <debug> [1402913752.275134] [mm-plugin.c:782] mm_plugin_supports_port(): (Iridium) [ttyUSB3] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.275186] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB3) launching port probing: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913752.275400] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB1) opening serial port...
ModemManager[5554]: <warn>  [1402913752.276887] [mm-port-serial.c:515] real_config_fd(): (ttyUSB1): port attributes not fully set
ModemManager[5554]: <debug> [1402913752.276977] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913752.277161] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB3) opening serial port...
ModemManager[5554]: <warn>  [1402913752.278316] [mm-port-serial.c:515] real_config_fd(): (ttyUSB3): port attributes not fully set
ModemManager[5554]: <debug> [1402913752.278391] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB3) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913752.330086] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913752.358838] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913752.559776] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'AT'
ModemManager[5554]: <debug> [1402913752.560112] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR>'
ModemManager[5554]: <debug> [1402913752.560323] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913752.560502] [mm-port-probe.c:151] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is AT-capable
ModemManager[5554]: <debug> [1402913752.560704] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913752.560839] [mm-port-serial-at.c:440] debug_log(): (ttyUSB3): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913752.560964] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CGMI<CR>'
ModemManager[5554]: <debug> [1402913752.761070] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- 'AT'
ModemManager[5554]: <debug> [1402913752.761369] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR>'
ModemManager[5554]: <debug> [1402913752.761645] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913752.761831] [mm-port-probe.c:151] mm_port_probe_set_result_at(): (tty/ttyUSB1) port is AT-capable
ModemManager[5554]: <debug> [1402913753.262095] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'AT+CGMI'
ModemManager[5554]: <debug> [1402913753.262343] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR>'
ModemManager[5554]: <debug> [1402913753.262555] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>+CGMI: MTK1<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913753.262705] [mm-port-probe.c:178] mm_port_probe_set_result_at_vendor(): (tty/ttyUSB0) vendor probing finished
ModemManager[5554]: <debug> [1402913753.262932] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT+CGMI<CR>'
ModemManager[5554]: <debug> [1402913753.263061] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CGMM<CR>'
ModemManager[5554]: <debug> [1402913753.963723] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- 'AT+CGMI'
ModemManager[5554]: <debug> [1402913753.963981] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR>'
ModemManager[5554]: <debug> [1402913753.964310] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'AT+CGMM'
ModemManager[5554]: <debug> [1402913753.964441] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>+CGMI: MTK1<CR><LF>'
ModemManager[5554]: <debug> [1402913753.965187] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><CR><LF>+CGMM: MTK2<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913753.965346] [mm-port-probe.c:198] mm_port_probe_set_result_at_product(): (tty/ttyUSB0) product probing finished
ModemManager[5554]: <debug> [1402913753.965489] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913753.965607] [mm-port-probe.c:178] mm_port_probe_set_result_at_vendor(): (tty/ttyUSB1) vendor probing finished
ModemManager[5554]: <debug> [1402913753.965744] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913753.965843] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB0) closing serial port...
ModemManager[5554]: <debug> [1402913753.969604] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB0) serial port closed
ModemManager[5554]: <debug> [1402913753.969720] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB0) forced to close port
ModemManager[5554]: <debug> [1402913753.970198] [mm-plugin.c:477] apply_post_probing_filters(): (Iridium) [ttyUSB0] filtered by vendor/product strings
ModemManager[5554]: <debug> [1402913753.970507] [mm-plugin.c:782] mm_plugin_supports_port(): (Via CBP7) [ttyUSB0] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913753.970652] [mm-plugin.c:477] apply_post_probing_filters(): (Via CBP7) [ttyUSB0] filtered by vendor/product strings
ModemManager[5554]: <debug> [1402913753.970788] [mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB0] probe required: 'at, at-vendor, at-icera'
ModemManager[5554]: <debug> [1402913753.970913] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at-icera'
ModemManager[5554]: <debug> [1402913753.971170] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
ModemManager[5554]: <warn>  [1402913753.971829] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
ModemManager[5554]: <debug> [1402913753.972151] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913753.972534] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT+CGMM<CR>'
ModemManager[5554]: <debug> [1402913754.571335] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1] Minimum probing time consumed
ModemManager[5554]: <debug> [1402913754.673443] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- 'AT+CGMM'
ModemManager[5554]: <debug> [1402913754.674044] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT%IPSYS?<CR>'
ModemManager[5554]: <debug> [1402913754.674499] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><CR><LF>+CGMM: MTK2<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913754.674867] [mm-port-probe.c:198] mm_port_probe_set_result_at_product(): (tty/ttyUSB1) product probing finished
ModemManager[5554]: <debug> [1402913754.675128] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB1) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913754.675319] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB1) closing serial port...
ModemManager[5554]: <debug> [1402913754.677038] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB1) serial port closed
ModemManager[5554]: <debug> [1402913754.677100] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB1) forced to close port
ModemManager[5554]: <debug> [1402913754.677166] [mm-plugin.c:477] apply_post_probing_filters(): (Iridium) [ttyUSB1] filtered by vendor/product strings
ModemManager[5554]: <debug> [1402913754.677274] [mm-plugin.c:782] mm_plugin_supports_port(): (Via CBP7) [ttyUSB1] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913754.677365] [mm-plugin.c:477] apply_post_probing_filters(): (Via CBP7) [ttyUSB1] filtered by vendor/product strings
ModemManager[5554]: <debug> [1402913754.677454] [mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB1] probe required: 'at, at-vendor, at-icera'
ModemManager[5554]: <debug> [1402913754.677494] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at-icera'
ModemManager[5554]: <debug> [1402913755.571349] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[5554]: <debug> [1402913755.571475] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[5554]: <debug> [1402913755.575123] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'AT%IPSYS?'
ModemManager[5554]: <debug> [1402913755.575334] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR>'
ModemManager[5554]: <debug> [1402913755.575547] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB1) opening serial port...
ModemManager[5554]: <warn>  [1402913755.576149] [mm-port-serial.c:515] real_config_fd(): (ttyUSB1): port attributes not fully set
ModemManager[5554]: <debug> [1402913755.576247] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913755.576395] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
ModemManager[5554]: <debug> [1402913755.576574] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[5554]: <debug> [1402913755.576654] [mm-port-probe.c:223] mm_port_probe_set_result_at_icera(): (tty/ttyUSB0) Modem is probably not Icera-based
ModemManager[5554]: <debug> [1402913755.576744] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913755.576792] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB0) closing serial port...
ModemManager[5554]: <debug> [1402913755.580986] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB0) serial port closed
ModemManager[5554]: <debug> [1402913755.581046] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB0) forced to close port
ModemManager[5554]: <debug> [1402913755.581111] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyUSB0] filtered by vendor strings
ModemManager[5554]: <debug> [1402913755.581211] [mm-plugin.c:782] mm_plugin_supports_port(): (Cinterion) [ttyUSB0] probe required: 'at, at-vendor'
ModemManager[5554]: <debug> [1402913755.581291] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyUSB0] filtered by vendor strings
ModemManager[5554]: <debug> [1402913755.581367] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [ttyUSB0] probe required: 'at, qcdm'
ModemManager[5554]: <debug> [1402913755.581462] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyUSB0] found best plugin for port
ModemManager[5554]: <debug> [1402913755.581508] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB0' port probe finished, still 3 running probes in this device (ttyUSB3, ttyUSB1, ttyUSB2)
ModemManager[5554]: <debug> [1402913755.581574] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913755.581646] [mm-port-serial-at.c:440] debug_log(): (ttyUSB3): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913755.677258] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT%IPSYS?<CR>'
ModemManager[5554]: <debug> [1402913756.579008] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- 'AT%IPSYS?'
ModemManager[5554]: <debug> [1402913756.579666] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><CR><LF>ERROR<CR><LF>'
ModemManager[5554]: <debug> [1402913756.579741] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[5554]: <debug> [1402913756.579804] [mm-port-probe.c:223] mm_port_probe_set_result_at_icera(): (tty/ttyUSB1) Modem is probably not Icera-based
ModemManager[5554]: <debug> [1402913756.579893] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB1) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913756.579935] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB1) closing serial port...
ModemManager[5554]: <debug> [1402913756.581561] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB1) serial port closed
ModemManager[5554]: <debug> [1402913756.581623] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB1) forced to close port
ModemManager[5554]: <debug> [1402913756.581686] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyUSB1] filtered by vendor strings
ModemManager[5554]: <debug> [1402913756.581790] [mm-plugin.c:782] mm_plugin_supports_port(): (Cinterion) [ttyUSB1] probe required: 'at, at-vendor'
ModemManager[5554]: <debug> [1402913756.581875] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyUSB1] filtered by vendor strings
ModemManager[5554]: <debug> [1402913756.581955] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [ttyUSB1] probe required: 'at, qcdm'
ModemManager[5554]: <debug> [1402913756.582053] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyUSB1] found best plugin for port
ModemManager[5554]: <debug> [1402913756.582103] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB1' port probe finished, still 2 running probes in this device (ttyUSB3, ttyUSB2)
ModemManager[5554]: <debug> [1402913758.574363] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[5554]: <debug> [1402913758.574561] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[5554]: <debug> [1402913758.574749] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913758.574908] [mm-port-serial-at.c:440] debug_log(): (ttyUSB3): --> 'AT<CR>'
ModemManager[5554]: <debug> [1402913761.574921] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[5554]: <debug> [1402913761.575073] [mm-port-probe.c:161] mm_port_probe_set_result_at(): (tty/ttyUSB2) port is not AT-capable
ModemManager[5554]: <debug> [1402913761.575193] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[5554]: <debug> [1402913761.575363] [mm-port-probe.c:161] mm_port_probe_set_result_at(): (tty/ttyUSB3) port is not AT-capable
ModemManager[5554]: <debug> [1402913761.575592] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB2) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913761.575754] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB2) closing serial port...
ModemManager[5554]: <debug> [1402913761.578924] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB2) serial port closed
ModemManager[5554]: <debug> [1402913761.579138] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB2) forced to close port
ModemManager[5554]: <debug> [1402913761.579335] [mm-plugin.c:454] apply_post_probing_filters(): (Iridium) [ttyUSB2] filtered as no vendor/product strings given
ModemManager[5554]: <debug> [1402913761.579523] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB3) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913761.579683] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB3) closing serial port...
ModemManager[5554]: <debug> [1402913761.582297] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB3) serial port closed
ModemManager[5554]: <debug> [1402913761.584059] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB3) forced to close port
ModemManager[5554]: <debug> [1402913761.584817] [mm-plugin.c:454] apply_post_probing_filters(): (Iridium) [ttyUSB3] filtered as no vendor/product strings given
ModemManager[5554]: <debug> [1402913761.585886] [mm-plugin.c:782] mm_plugin_supports_port(): (Via CBP7) [ttyUSB2] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913761.586459] [mm-plugin.c:782] mm_plugin_supports_port(): (Via CBP7) [ttyUSB3] probe required: 'at, at-vendor, at-product'
ModemManager[5554]: <debug> [1402913761.586917] [mm-plugin.c:454] apply_post_probing_filters(): (Via CBP7) [ttyUSB2] filtered as no vendor/product strings given
ModemManager[5554]: <debug> [1402913761.587331] [mm-plugin.c:454] apply_post_probing_filters(): (Via CBP7) [ttyUSB3] filtered as no vendor/product strings given
ModemManager[5554]: <debug> [1402913761.587768] [mm-plugin.c:763] mm_plugin_supports_port(): (Nokia) [ttyUSB2] not setting up AT probing tasks: modem already has the expected single AT port
ModemManager[5554]: <debug> [1402913761.588284] [mm-port-probe.c:161] mm_port_probe_set_result_at(): (tty/ttyUSB2) port is not AT-capable
ModemManager[5554]: <debug> [1402913761.588579] [mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB2] probe required: 'at, at-vendor, at-icera'
ModemManager[5554]: <debug> [1402913761.588846] [mm-plugin.c:763] mm_plugin_supports_port(): (Nokia) [ttyUSB3] not setting up AT probing tasks: modem already has the expected single AT port
ModemManager[5554]: <debug> [1402913761.589072] [mm-port-probe.c:161] mm_port_probe_set_result_at(): (tty/ttyUSB3) port is not AT-capable
ModemManager[5554]: <debug> [1402913761.589297] [mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB3] probe required: 'at, at-vendor, at-icera'
ModemManager[5554]: <debug> [1402913761.589546] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyUSB2] filtered by vendor strings
ModemManager[5554]: <debug> [1402913761.589836] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyUSB3] filtered by vendor strings
ModemManager[5554]: <debug> [1402913761.590095] [mm-plugin.c:782] mm_plugin_supports_port(): (Cinterion) [ttyUSB2] probe required: 'at, at-vendor'
ModemManager[5554]: <debug> [1402913761.590365] [mm-plugin.c:782] mm_plugin_supports_port(): (Cinterion) [ttyUSB3] probe required: 'at, at-vendor'
ModemManager[5554]: <debug> [1402913761.590611] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyUSB2] filtered by vendor strings
ModemManager[5554]: <debug> [1402913761.590847] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyUSB3] filtered by vendor strings
ModemManager[5554]: <debug> [1402913761.591099] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [ttyUSB2] probe required: 'at, qcdm'
ModemManager[5554]: <debug> [1402913761.591379] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'qcdm'
ModemManager[5554]: <debug> [1402913761.591654] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [ttyUSB3] probe required: 'at, qcdm'
ModemManager[5554]: <debug> [1402913761.591885] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB3) launching port probing: 'qcdm'
ModemManager[5554]: <debug> [1402913761.592163] [mm-port-probe.c:657] serial_probe_qcdm(): (tty/ttyUSB2) probing QCDM...
ModemManager[5554]: <debug> [1402913761.592484] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB2) opening serial port...
ModemManager[5554]: <debug> [1402913761.593715] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913761.593981] [mm-port-probe.c:657] serial_probe_qcdm(): (tty/ttyUSB3) probing QCDM...
ModemManager[5554]: <debug> [1402913761.594503] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB3) opening serial port...
ModemManager[5554]: <debug> [1402913761.595533] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB3) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913761.595813] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB2): --> 7e 00 78 f0 7e
ModemManager[5554]: <debug> [1402913761.596120] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB3): --> 7e 00 78 f0 7e
ModemManager[5554]: <debug> [1402913764.574781] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB2): --> 7e 00 78 f0 7e
ModemManager[5554]: <debug> [1402913764.575000] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB3): --> 7e 00 78 f0 7e
ModemManager[5554]: <debug> [1402913767.575352] [mm-port-probe.c:257] mm_port_probe_set_result_qcdm(): (tty/ttyUSB2) port is not QCDM-capable
ModemManager[5554]: <debug> [1402913767.575548] [mm-port-probe.c:257] mm_port_probe_set_result_qcdm(): (tty/ttyUSB3) port is not QCDM-capable
ModemManager[5554]: <debug> [1402913767.575678] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB2) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913767.575866] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB2) closing serial port...
ModemManager[5554]: <debug> [1402913767.578320] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB2) serial port closed
ModemManager[5554]: <debug> [1402913767.578594] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB2) forced to close port
ModemManager[5554]: <debug> [1402913767.578835] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB3) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913767.579009] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB3) closing serial port...
ModemManager[5554]: <debug> [1402913767.584323] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB3) serial port closed
ModemManager[5554]: <debug> [1402913767.584890] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB3) forced to close port
ModemManager[5554]: <debug> [1402913767.585308] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyUSB2] found best plugin for port
ModemManager[5554]: <debug> [1402913767.585644] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB2' port probe finished, still 1 running probes in this device (ttyUSB3)
ModemManager[5554]: <debug> [1402913767.586242] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyUSB3] found best plugin for port
ModemManager[5554]: <debug> [1402913767.586921] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'ttyUSB3' port probe finished, last one in device
ModemManager[5554]: <debug> [1402913767.587180] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1] device support check finished in '15.466178' seconds
ModemManager[5554]: <info>  [1402913767.587768] [mm-device.c:509] mm_device_create_modem(): Creating modem with plugin 'Generic' and '6' ports
ModemManager[5554]: <debug> [1402913767.588464] [generic/mm-plugin-generic.c:73] create_modem(): MBIM-powered generic modem found...
ModemManager[5554]: <warn>  [1402913767.589089] [mm-plugin.c:919] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB3): 'Cannot add port 'tty/ttyUSB3', unhandled serial type'
ModemManager[5554]: <debug> [1402913767.589448] [mm-base-modem.c:303] mm_base_modem_grab_port(): (ttyUSB1) type 'at' claimed by /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1
ModemManager[5554]: <debug> [1402913767.589718] [mm-base-modem.c:303] mm_base_modem_grab_port(): (ttyUSB0) type 'at' claimed by /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1
ModemManager[5554]: <warn>  [1402913767.589920] [mm-plugin.c:919] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB2): 'Cannot add port 'tty/ttyUSB2', unhandled serial type'
ModemManager[5554]: <debug> [1402913767.590118] [mm-base-modem.c:303] mm_base_modem_grab_port(): (wwan1) type 'net' claimed by /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1
ModemManager[5554]: <debug> [1402913767.590321] [mm-base-modem.c:303] mm_base_modem_grab_port(): (cdc-wdm1) type 'mbim' claimed by /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1
ModemManager[5554]: <debug> [1402913767.590514] [mm-base-modem.c:1118] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1) tty/ttyUSB0 at (primary)
ModemManager[5554]: <debug> [1402913767.590732] [mm-base-modem.c:1118] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1) tty/ttyUSB1 at (secondary)
ModemManager[5554]: <debug> [1402913767.590909] [mm-base-modem.c:1118] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1) net/wwan1 data (primary)
ModemManager[5554]: <debug> [1402913767.591102] [mm-base-modem.c:1118] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1) usb/cdc-wdm1 mbim (primary)
ModemManager[5554]: <info>  [1402913767.591781] [mm-manager.c:162] find_device_support_ready(): Modem for device at '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1' successfully created
ModemManager[5554]: [/dev/cdc-wdm1] Queried max control message size: 512
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 16
<<<<<<   data   = 01:00:00:00:10:00:00:00:01:00:00:00:00:02:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 16
<<<<<<   type        = open (0x00000001)
<<<<<<   transaction = 1
<<<<<< Contents:
<<<<<<   max_control_transfer = 512
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 01:00:00:80:10:00:00:00:01:00:00:00:00:00:00:00
ModemManager[5554]: <debug> [1402913767.594377] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
ModemManager[5554]: <warn>  [1402913767.595268] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
ModemManager[5554]: <debug> [1402913767.595497] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913767.595680] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB0): running init sequence...
ModemManager[5554]: <debug> [1402913767.595913] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 2 (open)
ModemManager[5554]: <debug> [1402913767.597063] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 3 (open)
ModemManager[5554]: <debug> [1402913767.598572] [mm-broadband-modem-mbim.c:210] modem_load_current_capabilities(): loading current capabilities...
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:02: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[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 2
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-caps' (0x00000001)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: <debug> [1402913767.599899] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
ModemManager[5554]: <debug> [1402913767.604403] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'A'
ModemManager[5554]: <debug> [1402913767.619633] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'TE0'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 204
>>>>>>   data   = 03:00:00:80:CC:00:00:00:02: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:9C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00:02:00:00:00:1F:00:00:00:03:00:00:00:01:00:00:00:02:00:00:00:00:00:00:00:00:00:00:00:40:00:00:00:1E:00:00:00:60:00:00:00:34:00:00:00:94:00:00:00:08:00:00:00:33:00:35:00:35:00:36:00:31:00:39:00:30:00:35:00:30:00:31:00:35:00:31:00:32:00:39:00:37:00:00:00:4D:00:4F:00:4C:00:59:00:2E:00:57:00:52:00:38:00:2E:00:57:00:31:00:32:00:33:00:31:00:2E:00:44:00:43:00:2E:00:57:00:47:00:2E:00:4D:00:50:00:2E:00:56:00:33:00:4D:00:54:00:4B:00:32:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 204
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 2
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-caps' (0x00000001)
ModemManager[5554]: <debug> [1402913767.620490] [mm-broadband-modem-mbim.c:140] modem_load_current_capabilities_finish(): loaded modem capabilities: gsm-umts
ModemManager[5554]: <debug> [1402913767.620658] [mm-iface-modem.c:4327] interface_initialization_step(): Modem allows up to 1 bearers
ModemManager[5554]: <debug> [1402913767.620716] [mm-bearer-list.c:276] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
ModemManager[5554]: <debug> [1402913767.621093] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '0000200100007d01355619050151297MOLY.WR8.W1231.DC.WG.MP.V3MBIM[2001:7D01]Generic'
ModemManager[5554]: <debug> [1402913767.621147] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID 'bb19fbb402766b1c3f1a3663a4200c7bcd8187ef'
ModemManager[5554]: [/dev/cdc-wdm1] 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:03:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'radio-state' (0x00000003)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: <debug> [1402913767.621852] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913767.621987] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATV1<CR>'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38: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:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   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          = 'radio-state' (0x00000003)
ModemManager[5554]: [/dev/cdc-wdm1] 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:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4: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:02:00:00:00:00:00:00:00:B4:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:28: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:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   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          = 'subscriber-ready-status' (0x00000002)
ModemManager[5554]: [/dev/cdc-wdm1] 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:04:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'pin' (0x00000004)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C: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:04:00:00:00:00:00:00:00:0C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   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          = 'pin' (0x00000004)
ModemManager[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] 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:02:00:00:00:01:00:00:00:03:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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[5554]: <info>  [1402913767.634219] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem: state changed (unknown -> locked)
ModemManager[5554]: <debug> [1402913767.634777] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] 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[5554]: <debug> [1402913767.637213] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4: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:B4:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:28: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:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4: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:B4:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:28: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:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 144
>>>>>>   data   = 03:00:00:80:90: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:60:00:00:00:20:00:00:00:0A:00:00:00:01:00:00:00:2C:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:00:00:00:00:30:00:30:00:30:00:30:00:30:00:00:00:30:00:30:00:30:00:30: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
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 144
>>>>>>   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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 144
>>>>>>   data   = 03:00:00:80:90: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:60:00:00:00:20:00:00:00:0A:00:00:00:01:00:00:00:2C:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:00:00:00:00:30:00:30:00:30:00:30:00:30:00:00:00:30:00:30:00:30:00:30: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
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 144
>>>>>>   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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] 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[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4: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:B4:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:28: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:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   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[5554]: <debug> [1402913767.653913] [mm-broadband-modem.c:9004] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
ModemManager[5554]: <debug> [1402913767.654166] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 2 (close)
ModemManager[5554]: <debug> [1402913767.655077] [mm-base-modem.c:1098] initialize_ready(): Couldn't finish initialization in the current state: 'Modem is currently locked, cannot fully initialize'
ModemManager[5554]: <debug> [1402913767.655875] [mm-device.c:436] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1' at path '/org/freedesktop/ModemManager1/Modem/0'
ModemManager[5554]: <debug> [1402913767.656002] [mm-device.c:446] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Generic' modem, VID 0x2001 PID 0x7D01 (usb)
ModemManager[5554]: <debug> [1402913767.657338] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913767.657625] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATX4<CR>'
ModemManager[5554]: <debug> [1402913767.662990] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913767.663128] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT&C1<CR>'
ModemManager[5554]: <debug> [1402913767.670397] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913767.673027] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
ModemManager[5554]: <debug> [1402913767.678385] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913767.679069] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 1 (close)
ModemManager[5554]: <debug> [1402913767.679447] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
ModemManager[5554]: <debug> [1402913767.690540] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913767.691319] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913767.691596] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB0) closing serial port...
ModemManager[5554]: <debug> [1402913767.695659] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB0) serial port closed
ModemManager[5554]: <debug> [1402913775.769677] [mm-sim-mbim.c:404] send_pin(): Sending PIN...
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 80
<<<<<<   data   = 03:00:00:00:50: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:04:00:00:00:01:00:00:00:20:00:00:00:02:00:00:00:00:00:00:00:18:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:31:00:35:00:32:00:35:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 80
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 12
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin' (0x00000004)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C: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:04:00:00:00:00:00:00:00:0C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   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' (0x00000004)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 224
>>>>>>   data   = 07:00:00:80:E0: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:02:00:00:00:B4:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:28: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:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 224
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'subscriber-ready-status' (0x00000002)
ModemManager[5554]: [/dev/cdc-wdm1] 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:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4: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:02:00:00:00:00:00:00:00:B4:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:28: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:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   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          = 'subscriber-ready-status' (0x00000002)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 224
>>>>>>   data   = 07:00:00:80:E0: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:02:00:00:00:B4:00:00:00:01:00:00:00:2C:00:00:00:1E:00:00:00:4C:00:00:00:28: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:32:00:34:00:32:00:30:00:31:00:33:00:30:00:35:00:30:00:30:00:30:00:30:00:37:00:36:00:31:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 224
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'subscriber-ready-status' (0x00000002)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 224
>>>>>>   data   = 07:00:00:80:E0: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:02:00:00:00:B4:00:00:00:01:00:00:00:2C:00:00:00:1E:00:00:00:4C:00:00:00:28: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:32:00:34:00:32:00:30:00:31:00:33:00:30:00:35:00:30:00:30:00:30:00:30:00:37:00:36:00:31:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 224
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'subscriber-ready-status' (0x00000002)
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30: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:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 14
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4: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:02:00:00:00:00:00:00:00:B4:00:00:00:01:00:00:00:2C:00:00:00:1E:00:00:00:4C:00:00:00:28: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:32:00:34:00:32:00:30:00:31:00:33:00:30:00:35:00:30:00:30:00:30:00:30:00:37:00:36:00:31:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   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          = 'subscriber-ready-status' (0x00000002)
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30: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:04:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 15
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin' (0x00000004)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C: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:04:00:00:00:00:00:00:00:0C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   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          = 'pin' (0x00000004)
ModemManager[5554]: <debug> [1402913777.577037] [mm-iface-modem.c:3076] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
ModemManager[5554]: <info>  [1402913777.578126] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (locked -> initializing)
ModemManager[5554]: <debug> [1402913777.582191] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
ModemManager[5554]: <warn>  [1402913777.583246] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
ModemManager[5554]: <debug> [1402913777.583696] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913777.583777] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB0): running init sequence...
ModemManager[5554]: <debug> [1402913777.583906] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 2 (open)
ModemManager[5554]: <debug> [1402913777.584003] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 3 (open)
ModemManager[5554]: [/dev/cdc-wdm1] 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:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: <debug> [1402913777.586485] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4: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:02:00:00:00:00:00:00:00:B4:00:00:00:01:00:00:00:2C:00:00:00:1E:00:00:00:4C:00:00:00:28: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:32:00:34:00:32:00:30:00:31:00:33:00:30:00:35:00:30:00:30:00:30:00:30:00:37:00:36:00:31:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   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          = 'subscriber-ready-status' (0x00000002)
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:11: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[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 17
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 228
>>>>>>   data   = 03:00:00:80:E4:00:00:00:11: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:B4:00:00:00:01:00:00:00:2C:00:00:00:1E:00:00:00:4C:00:00:00:28: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:32:00:34:00:32:00:30:00:31:00:33:00:30:00:35:00:30:00:30:00:30:00:30:00:37:00:36:00:31:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:31:00:31:00:31:00:31:00:38:00:30:00:30:00:31:00:32:00:31:00:39: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 228
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 17
>>>>>> 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[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30: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:05:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 18
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin-list' (0x00000005)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: <debug> [1402913777.598905] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 208
>>>>>>   data   = 03:00:00:80:D0: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:05:00:00:00:00:00:00:00:A0:00:00:00:01:00:00:00:01:00:00:00:04:00:00:00:08:00:00:00:02:00:00:00:01:00:00:00:04:00:00:00:08:00:00:00:00:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00:00:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00:01:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00:01:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00:01:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00:01:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00:01:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00:00:00:00:00:01:00:00:00:08:00:00:00:10:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 208
>>>>>>   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          = 'pin-list' (0x00000005)
ModemManager[5554]: <debug> [1402913777.601884] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 4 (open)
ModemManager[5554]: <debug> [1402913777.602340] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATV1<CR>'
ModemManager[5554]: <debug> [1402913777.607770] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913777.607951] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
ModemManager[5554]: <debug> [1402913777.619802] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913777.619946] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATX4<CR>'
ModemManager[5554]: <debug> [1402913777.625442] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913777.625640] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT&C1<CR>'
ModemManager[5554]: <debug> [1402913777.632284] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913777.632480] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
ModemManager[5554]: <debug> [1402913777.638112] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913777.638256] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 3 (close)
ModemManager[5554]: <debug> [1402913777.638400] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
ModemManager[5554]: <debug> [1402913777.650237] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913777.650798] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 2 (close)
ModemManager[5554]: <debug> [1402913777.651258] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CUSD=?<CR>'
ModemManager[5554]: <debug> [1402913777.663534] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>+CUSD: (0-2)<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913777.664596] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 1 (close)
ModemManager[5554]: <debug> [1402913777.666158] [mm-broadband-modem-mbim.c:2584] messaging_check_support(): Messaging capabilities supported
ModemManager[5554]: <debug> [1402913777.666700] [mm-iface-modem-messaging.c:1146] load_supported_storages_ready(): Supported storages loaded:
ModemManager[5554]: <debug> [1402913777.666942] [mm-iface-modem-messaging.c:1147] load_supported_storages_ready():   mem1 (list/read/delete) storages: 'mt'
ModemManager[5554]: <debug> [1402913777.667174] [mm-iface-modem-messaging.c:1148] load_supported_storages_ready():   mem2 (write/send) storages:       'mt'
ModemManager[5554]: <debug> [1402913777.667404] [mm-iface-modem-messaging.c:1149] load_supported_storages_ready():   mem3 (reception) storages:        'mt'
ModemManager[5554]: <debug> [1402913777.668403] [mm-broadband-modem.c:9001] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
ModemManager[5554]: <debug> [1402913777.668723] [mm-broadband-modem.c:9002] iface_modem_signal_initialize_ready(): Couldn't initialize interface: 'Extended Signal information not supported'
ModemManager[5554]: <debug> [1402913777.669321] [mm-broadband-modem.c:9003] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
ModemManager[5554]: <debug> [1402913777.669586] [mm-broadband-modem.c:9004] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
ModemManager[5554]: <info>  [1402913777.669767] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (initializing -> disabled)
ModemManager[5554]: <debug> [1402913777.670187] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 0 (close)
ModemManager[5554]: <debug> [1402913777.670334] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB0) closing serial port...
ModemManager[5554]: <debug> [1402913777.674476] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB0) serial port closed
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 108
>>>>>>   data   = 07:00:00:80:6C:00:00:00:00: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:01:00:00:00:40:00:00:00:01:00:00:00:00:00:00:00:46:00:00:00:00:00:00:00:18:00:00:00:16:00:00:00:2B:00:34:00:37:00:39:00:30:00:30:00:30:00:32:00:31:00:30:00:30:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 108
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
>>>>>>   cid     = 'configuration' (0x00000001)
ModemManager[5554]: <info>  [1402913796.354277] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
ModemManager[5554]: <debug> [1402913796.354726] [mm-broadband-modem.c:7999] enabling_started(): Skipping modem initialization: device hotplugged
ModemManager[5554]: <debug> [1402913796.354795] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
ModemManager[5554]: <warn>  [1402913796.355798] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
ModemManager[5554]: <debug> [1402913796.355901] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913796.355948] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB0): running init sequence...
ModemManager[5554]: <debug> [1402913796.356017] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB1) opening serial port...
ModemManager[5554]: <warn>  [1402913796.357165] [mm-port-serial.c:515] real_config_fd(): (ttyUSB1): port attributes not fully set
ModemManager[5554]: <debug> [1402913796.357263] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
ModemManager[5554]: <debug> [1402913796.357309] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB1): running init sequence...
ModemManager[5554]: <debug> [1402913796.357360] [mm-broadband-modem.c:8015] enabling_started(): Flashing primary AT port before enabling...
ModemManager[5554]: <debug> [1402913796.357481] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
ModemManager[5554]: <debug> [1402913796.357574] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'ATE0<CR>'
ModemManager[5554]: <debug> [1402913796.362086] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- 'ATE0'
ModemManager[5554]: <debug> [1402913796.362637] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913796.362943] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913796.363475] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATV1<CR>'
ModemManager[5554]: <debug> [1402913796.369213] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913796.369354] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
ModemManager[5554]: <debug> [1402913796.380717] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913796.380846] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'ATX4<CR>'
ModemManager[5554]: <debug> [1402913796.386209] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913796.386336] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT&C1<CR>'
ModemManager[5554]: <debug> [1402913796.392795] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: [/dev/cdc-wdm1] 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:03:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'radio-state' (0x00000003)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38: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:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   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          = 'radio-state' (0x00000003)
ModemManager[5554]: [/dev/cdc-wdm1] 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:03:00:00:00:01:00:00:00:04:00:00:00:01:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'radio-state' (0x00000003)
<<<<<<   type    = 'set' (0x00000001)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38: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:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   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          = 'radio-state' (0x00000003)
ModemManager[5554]: <debug> [1402913796.506530] [mm-iface-modem.c:3191] modem_power_up_ready(): Modem set in full-power mode...
ModemManager[5554]: <debug> [1402913796.506900] [mm-broadband-modem.c:8591] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
ModemManager[5554]: <debug> [1402913796.507226] [mm-broadband-modem-mbim.c:1968] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[5554]: <debug> [1402913796.507507] [mm-broadband-modem-mbim.c:2107] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 96
<<<<<<   data   = 03:00:00:00:60: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: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[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 96
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 21
<<<<<< 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[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 52
>>>>>>   data   = 07:00:00:80:34: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:03:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 52
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'radio-state' (0x00000003)
ModemManager[5554]: <debug> [1402913796.511531] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>+PSBEARER: 0, 0<CR><LF>'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 92
>>>>>>   data   = 07:00:00:80:5C: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:09:00:00:00:30:00:00:00:00:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:01: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:02:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 92
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'register-state' (0x00000009)
ModemManager[5554]: <debug> [1402913796.513237] [mm-broadband-modem-mbim.c:1922] device_notification_cb(): Received notification (service 'basic-connect', command 'radio-state')
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 72
>>>>>>   data   = 07:00:00:80:48: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:0A:00:00:00:1C:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 72
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'packet-service' (0x0000000a)
ModemManager[5554]: <debug> [1402913796.515073] [mm-broadband-modem-mbim.c:1922] device_notification_cb(): Received notification (service 'basic-connect', command 'register-state')
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60: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: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   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          = 'device-service-subscribe-list' (0x00000013)
ModemManager[5554]: <debug> [1402913796.516966] [mm-broadband-modem-mbim.c:1922] device_notification_cb(): Received notification (service 'basic-connect', command 'packet-service')
ModemManager[5554]: <debug> [1402913796.517209] [mm-broadband-modem-mbim.c:1737] basic_connect_notification_packet_service(): Packet service state: 'detached', data class: '(null)'
ModemManager[5554]: <debug> [1402913796.517542] [mm-broadband-modem-mbim.c:1968] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[5554]: <debug> [1402913796.517855] [mm-broadband-modem-mbim.c:2107] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 100
<<<<<<   data   = 03:00:00:00:64: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: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[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 100
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 22
<<<<<< 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[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 100
>>>>>>   data   = 03:00:00:80:64: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: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 100
>>>>>>   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          = 'device-service-subscribe-list' (0x00000013)
ModemManager[5554]: <debug> [1402913796.523996] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30: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:09:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 23
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'register-state' (0x00000009)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60: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:09:00:00:00:00:00:00:00:30:00:00:00:00:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:01: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:02:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   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          = 'register-state' (0x00000009)
ModemManager[5554]: <info>  [1402913796.529092] [mm-iface-modem-3gpp.c:1169] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> searching)
ModemManager[5554]: <debug> [1402913796.529533] [mm-iface-modem.c:1561] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
ModemManager[5554]: <debug> [1402913796.530632] [mm-broadband-modem.c:8604] enabling_step(): Modem has 3GPP/USSD capabilities, enabling the Modem 3GPP/USSD interface...
ModemManager[5554]: <debug> [1402913796.531030] [mm-broadband-modem.c:4908] set_unsolicited_result_code_handlers(): (ttyUSB0) Setting unsolicited result code handlers
ModemManager[5554]: <debug> [1402913796.531411] [mm-broadband-modem.c:4908] set_unsolicited_result_code_handlers(): (ttyUSB1) Setting unsolicited result code handlers
ModemManager[5554]: <debug> [1402913796.531784] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 2 (open)
ModemManager[5554]: <debug> [1402913796.532218] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT+CUSD=1<CR>'
ModemManager[5554]: <debug> [1402913796.543891] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[5554]: <debug> [1402913796.544040] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 1 (close)
ModemManager[5554]: <debug> [1402913796.544302] [mm-broadband-modem.c:8632] enabling_step(): Modem has location capabilities, enabling the Location interface...
ModemManager[5554]: <debug> [1402913796.544368] [mm-iface-modem-location.c:739] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
ModemManager[5554]: <debug> [1402913796.544471] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[5554]: [/dev/cdc-wdm1] 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:09:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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     = 'register-state' (0x00000009)
<<<<<<   type    = 'query' (0x00000000)
ModemManager[5554]: <debug> [1402913796.544896] [mm-broadband-modem.c:8645] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
ModemManager[5554]: <debug> [1402913796.545096] [mm-broadband-modem-mbim.c:1968] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
ModemManager[5554]: <debug> [1402913796.545195] [mm-broadband-modem-mbim.c:2107] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
ModemManager[5554]: [/dev/cdc-wdm1] Sent message...
<<<<<< RAW:
<<<<<<   length = 136
<<<<<<   data   = 03:00:00:00:88: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: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[5554]: [/dev/cdc-wdm1] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 136
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 25
<<<<<< 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[5554]: [/dev/cdc-wdm1] 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:09:00:00:00:00:00:00:00:30:00:00:00:00:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:01: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:02:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] 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          = 'register-state' (0x00000009)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 136
>>>>>>   data   = 03:00:00:80:88: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: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[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 136
>>>>>>   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          = 'device-service-subscribe-list' (0x00000013)
ModemManager[5554]: <info>  [1402913796.548461] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> searching)
ModemManager[5554]: <debug> [1402913798.658046] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>+PSBEARER: 24, 0<CR><LF>'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 92
>>>>>>   data   = 07:00:00:80:5C: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:09:00:00:00:30:00:00:00:02:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:01: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:02:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 92
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'register-state' (0x00000009)
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 72
>>>>>>   data   = 07:00:00:80:48: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:0A:00:00:00:1C:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 72
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'packet-service' (0x0000000a)
ModemManager[5554]: <debug> [1402913798.659117] [mm-broadband-modem-mbim.c:1922] device_notification_cb(): Received notification (service 'basic-connect', command 'register-state')
ModemManager[5554]: <info>  [1402913798.659230] [mm-iface-modem-3gpp.c:1169] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (searching -> unknown)
ModemManager[5554]: <debug> [1402913798.659590] [mm-broadband-modem-mbim.c:1922] device_notification_cb(): Received notification (service 'basic-connect', command 'packet-service')
ModemManager[5554]: <debug> [1402913798.659664] [mm-broadband-modem-mbim.c:1737] basic_connect_notification_packet_service(): Packet service state: 'detached', data class: '(null)'
ModemManager[5554]: <debug> [1402913798.662028] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>+EIND: 16,"24201",1,0,2<CR><LF><CR><LF>+PSBEARER: 24, 0<CR><LF><CR><LF>+PSBEARER: 24, 0<CR><LF><CR><LF>+EIND: 16,"24201",1,0,0<CR><LF>'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 72
>>>>>>   data   = 07:00:00:80:48: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:0A:00:00:00:1C:00:00:00:07:00:00:00:04:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 72
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'packet-service' (0x0000000a)
ModemManager[5554]: <debug> [1402913802.503593] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>+PSBEARER: 24, 0<CR><LF><CR><LF>+EIND: 16,"24201",1,1,7<CR><LF>'
ModemManager[5554]: <debug> [1402913802.503947] [mm-broadband-modem-mbim.c:1922] device_notification_cb(): Received notification (service 'basic-connect', command 'packet-service')
ModemManager[5554]: <debug> [1402913802.504057] [mm-broadband-modem-mbim.c:1737] basic_connect_notification_packet_service(): Packet service state: 'detached', data class: '(null)'
ModemManager[5554]: [/dev/cdc-wdm1] Received message...
>>>>>> RAW:
>>>>>>   length = 92
>>>>>>   data   = 07:00:00:80:5C: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:09:00:00:00:30:00:00:00:00:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:01: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:02:00:00:00
ModemManager[5554]: [/dev/cdc-wdm1] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 92
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'register-state' (0x00000009)
ModemManager[5554]: <debug> [1402913802.953503] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>+PSBEARER: 0, 0<CR><LF><CR><LF>+EIND: 16,"24201",1,1,0<CR><LF>'
ModemManager[5554]: <debug> [1402913802.953856] [mm-broadband-modem-mbim.c:1922] device_notification_cb(): Received notification (service 'basic-connect', command 'register-state')
ModemManager[5554]: <info>  [1402913802.953968] [mm-iface-modem-3gpp.c:1169] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> searching)
ModemManager[5554]: <debug> [1402913804.448582] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): <-- '<CR><LF>+PSBEARER: 0, 0<CR><LF><CR><LF>+EIND: 16,"24201",1,1,0<CR><LF>'
