Sierra Wireless EM7455
Andreas Fett
andreas.fett at secunet.com
Tue Apr 5 11:34:01 UTC 2016
Hi list,
I'm dealing with a Sierra Wireless EM7455 as used in Lenovos T460s.
For this modem the mbim driver attaches and works well (ie the sim can
be unlocked) until I try to connect. It then fails during a "set
radio-state" command.
I tried mbimcli with --set-radio-state=on with the same result.
Kernel Version is 4.5, I'm somewhat confused however by two recent
commits in this kernel version which place the USB IDs of this device in
the qmi_wwan and qcserial drivers both of which do not attach.
ModemManager is 1.4.14
libmbim is 1.12.4
Any Ideas?
Andreas
-------------- next part --------------
Bus 001 Device 002: ID 1199:9079 Sierra Wireless, Inc.
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.10
bDeviceClass 0 (Defined at Interface level)
bDeviceSubClass 0
bDeviceProtocol 0
bMaxPacketSize0 64
idVendor 0x1199 Sierra Wireless, Inc.
idProduct 0x9079
bcdDevice 0.06
iManufacturer 1 Sierra Wireless, Incorporated
iProduct 2 Sierra Wireless EM7455 Qualcomm Snapdragon X7 LTE-A
iSerial 3 LF60150371031013
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 95
bNumInterfaces 2
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xa0
(Bus Powered)
Remote Wakeup
MaxPower 500mA
Interface Association:
bLength 8
bDescriptorType 11
bFirstInterface 12
bInterfaceCount 2
bFunctionClass 2 Communications
bFunctionSubClass 14
bFunctionProtocol 0
iFunction 0
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 12
bAlternateSetting 0
bNumEndpoints 1
bInterfaceClass 2 Communications
bInterfaceSubClass 14
bInterfaceProtocol 0
iInterface 0
CDC Header:
bcdCDC 1.10
CDC Union:
bMasterInterface 12
bSlaveInterface 13
CDC MBIM:
bcdMBIMVersion 1.00
wMaxControlMessage 4096
bNumberFilters 32
bMaxFilterSize 128
wMaxSegmentSize 2048
bmNetworkCapabilities 0x20
8-byte ntb input size
UNRECOGNIZED CDC: 08 24 1c 00 01 40 dc 05
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x82 EP 2 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0040 1x 64 bytes
bInterval 9
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 13
bAlternateSetting 0
bNumEndpoints 0
bInterfaceClass 10 CDC Data
bInterfaceSubClass 0 Unused
bInterfaceProtocol 2
iInterface 0
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 13
bAlternateSetting 1
bNumEndpoints 2
bInterfaceClass 10 CDC Data
bInterfaceSubClass 0 Unused
bInterfaceProtocol 2
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 0
Binary Object Store Descriptor:
bLength 5
bDescriptorType 15
wTotalLength 22
bNumDeviceCaps 2
USB 2.0 Extension Device Capability:
bLength 7
bDescriptorType 16
bDevCapabilityType 2
bmAttributes 0x00000000
(Missing must-be-set LPM bit!)
SuperSpeed USB Device Capability:
bLength 10
bDescriptorType 16
bDevCapabilityType 3
bmAttributes 0x00
wSpeedsSupported 0x000f
Device can operate at Low Speed (1Mbps)
Device can operate at Full Speed (12Mbps)
Device can operate at High Speed (480Mbps)
Device can operate at SuperSpeed (5Gbps)
bFunctionalitySupport 1
Lowest fully-functional device speed is Full Speed (12Mbps)
bU1DevExitLat 1 micro seconds
bU2DevExitLat 500 micro seconds
Device Status: 0x0000
(Bus Powered)
-------------- next part --------------
/org/freedesktop/ModemManager1/Modem/0 (device id 'f71f3e1a78bd99824c7025f09e416aea4ab70fda')
-------------------------
Hardware | manufacturer: 'Generic'
| model: 'MBIM [1199:9079]'
| revision: 'SWI9X30C_02.05.07.00'
| supported: 'gsm-umts, lte'
| current: 'gsm-umts, lte'
| equipment id: '014582000243312'
-------------------------
System | device: '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2'
| drivers: 'cdc_mbim'
| plugin: 'Generic'
| primary port: 'cdc-wdm0'
| ports: 'cdc-wdm0 (mbim), wwan0 (net)'
-------------------------
Numbers | own : 'unknown'
-------------------------
Status | lock: 'none'
| unlock retries: 'sim-pin2 (3)'
| state: 'disabled'
| power state: 'low'
| access tech: 'unknown'
| signal quality: '0' (cached)
-------------------------
Modes | supported: 'allowed: 3g, 4g; preferred: none'
| current: 'allowed: 3g, 4g; preferred: none'
-------------------------
Bands | supported: 'unknown'
| current: 'unknown'
-------------------------
IP | supported: 'ipv4, ipv6, ipv4v6'
-------------------------
3GPP | imei: '014582000243312'
| enabled locks: 'sim, fixed-dialing'
| operator id: 'unknown'
| operator name: 'unknown'
| subscription: 'unknown'
| registration: 'unknown'
-------------------------
SIM | path: '/org/freedesktop/ModemManager1/SIM/0'
-------------------------
Bearers | paths: 'none'
-------------- next part --------------
******************************************************
*
* Starting log for modem-manager
* Current time: 2016-Apr-05 12:37:54
*
******************************************************
<info> [1459859874.502678] [main.c:136] main(): ModemManager (version 1.4.14) starting in system bus...
<debug> [1459859874.547037] [main.c:61] bus_acquired_cb(): Bus acquired, creating manager...
<debug> [1459859874.557228] [mm-plugin-manager.c:852] load_plugins(): Looking for plugins in '/usr/lib/ModemManager'
<debug> [1459859874.570652] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Altair LTE'
<debug> [1459859874.570809] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'AnyDATA'
<debug> [1459859874.573655] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Cinterion'
<debug> [1459859874.573782] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Generic'
<debug> [1459859874.573903] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Gobi'
<debug> [1459859874.576438] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option High-Speed'
<debug> [1459859874.580539] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Huawei'
<debug> [1459859874.583163] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Iridium'
<debug> [1459859874.583292] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Linktop'
<debug> [1459859874.583424] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Longcheer'
<debug> [1459859874.586993] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Ericsson MBM'
<debug> [1459859874.587124] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Motorola'
<debug> [1459859874.587252] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'MTK'
<debug> [1459859874.590466] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia (Icera)'
<debug> [1459859874.590599] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia'
<debug> [1459859874.594069] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Novatel LTE'
<debug> [1459859874.594206] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Novatel'
<debug> [1459859874.594341] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option'
<debug> [1459859874.597619] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Pantech'
<debug> [1459859874.597767] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Samsung'
<debug> [1459859874.601675] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Sierra'
<debug> [1459859874.604013] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'SimTech'
<debug> [1459859874.604164] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Telit'
<debug> [1459859874.604291] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Via CBP7'
<debug> [1459859874.609181] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Wavecom'
<debug> [1459859874.609320] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'X22X'
<debug> [1459859874.612719] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'ZTE'
<debug> [1459859874.612729] [mm-plugin-manager.c:902] load_plugins(): Successfully loaded 27 plugins
<debug> [1459859874.613117] [main.c:83] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
<debug> [1459859874.613121] [mm-base-manager.c:485] mm_base_manager_start(): Starting automatic device scan...
<debug> [1459859874.614614] [mm-base-manager.c:524] mm_base_manager_start(): Finished device scan...
<debug> [1459859874.619561] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:16.3] Checking device support...
<debug> [1459859874.619635] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619639] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619642] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyS0] filtered by drivers
<debug> [1459859874.619645] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyS0] filtered by drivers
<debug> [1459859874.619647] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619649] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619651] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619653] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyS0] filtered by udev tags
<debug> [1459859874.619655] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619657] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyS0] filtered by udev tags
<debug> [1459859874.619659] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619679] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619681] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619685] [mm-plugin.c:253] apply_pre_probing_filters(): (Option) [ttyS0] filtered by drivers
<debug> [1459859874.619688] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619690] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619692] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyS0] filtered by drivers
<debug> [1459859874.619694] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619696] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619698] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619700] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619702] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyS0] filtered by vendor/product IDs
<debug> [1459859874.619704] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyS0] Found '5' plugins to try...
<debug> [1459859874.619707] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0] Will try with plugin 'Cinterion'
<debug> [1459859874.619709] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0] Will try with plugin 'Iridium'
<debug> [1459859874.619711] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0] Will try with plugin 'Nokia'
<debug> [1459859874.619712] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0] Will try with plugin 'Via CBP7'
<debug> [1459859874.619714] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0] Will try with plugin 'Generic'
<debug> [1459859874.619726] [mm-plugin.c:767] mm_plugin_supports_port(): (Cinterion) [ttyS0] probe required: 'at, at-vendor'
<debug> [1459859874.619734] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyS0) launching port probing: 'at, at-vendor'
<debug> [1459859874.619815] [mm-base-manager.c:320] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
<debug> [1459859874.619886] [mm-base-manager.c:320] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
<debug> [1459859874.619982] [mm-base-manager.c:320] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
<debug> [1459859874.620111] [mm-base-manager.c:296] device_added(): (tty/ptyp0): could not get port's parent device
<debug> [1459859874.620144] [mm-base-manager.c:296] device_added(): (tty/ptyp1): could not get port's parent device
<debug> [1459859874.620175] [mm-base-manager.c:296] device_added(): (tty/ptyp2): could not get port's parent device
<debug> [1459859874.620207] [mm-base-manager.c:296] device_added(): (tty/ptyp3): could not get port's parent device
<debug> [1459859874.620238] [mm-base-manager.c:296] device_added(): (tty/ptyp4): could not get port's parent device
<debug> [1459859874.620270] [mm-base-manager.c:296] device_added(): (tty/ptyp5): could not get port's parent device
<debug> [1459859874.620300] [mm-base-manager.c:296] device_added(): (tty/ptyp6): could not get port's parent device
<debug> [1459859874.620331] [mm-base-manager.c:296] device_added(): (tty/ptyp7): could not get port's parent device
<debug> [1459859874.620637] [mm-base-manager.c:296] device_added(): (tty/ttyp0): could not get port's parent device
<debug> [1459859874.620684] [mm-base-manager.c:296] device_added(): (tty/ttyp1): could not get port's parent device
<debug> [1459859874.620716] [mm-base-manager.c:296] device_added(): (tty/ttyp2): could not get port's parent device
<debug> [1459859874.620760] [mm-base-manager.c:296] device_added(): (tty/ttyp3): could not get port's parent device
<debug> [1459859874.620794] [mm-base-manager.c:296] device_added(): (tty/ttyp4): could not get port's parent device
<debug> [1459859874.620826] [mm-base-manager.c:296] device_added(): (tty/ttyp5): could not get port's parent device
<debug> [1459859874.620856] [mm-base-manager.c:296] device_added(): (tty/ttyp6): could not get port's parent device
<debug> [1459859874.620888] [mm-base-manager.c:296] device_added(): (tty/ttyp7): could not get port's parent device
<debug> [1459859874.621010] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2] Checking device support...
<debug> [1459859874.621039] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621042] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621044] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621046] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wwan0] filtered by drivers
<debug> [1459859874.621049] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wwan0] filtered by drivers
<debug> [1459859874.621051] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621052] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wwan0] filtered by subsystem
<debug> [1459859874.621055] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wwan0] filtered by subsystem
<debug> [1459859874.621057] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wwan0] filtered by subsystem
<debug> [1459859874.621059] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wwan0] filtered by udev tags
<debug> [1459859874.621061] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wwan0] filtered by subsystem
<debug> [1459859874.621063] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wwan0] filtered by subsystem
<debug> [1459859874.621065] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621067] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wwan0] filtered by subsystem
<debug> [1459859874.621069] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621071] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621072] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wwan0] filtered by subsystem
<debug> [1459859874.621074] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621076] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621078] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wwan0] filtered by drivers
<debug> [1459859874.621080] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wwan0] filtered by subsystem
<debug> [1459859874.621082] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wwan0] filtered by subsystem
<debug> [1459859874.621084] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wwan0] filtered by subsystem
<debug> [1459859874.621086] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wwan0] filtered by subsystem
<debug> [1459859874.621088] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621091] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wwan0] filtered by vendor/product IDs
<debug> [1459859874.621106] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wwan0] Found '1' plugins to try...
<debug> [1459859874.621108] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin 'Generic'
<debug> [1459859874.621112] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [wwan0] probing deferred until result suggested
<debug> [1459859874.621183] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.2/0000:04:00.0] Checking device support...
<debug> [1459859874.621204] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621207] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621209] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621211] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wlan0] filtered by drivers
<debug> [1459859874.621213] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wlan0] filtered by drivers
<debug> [1459859874.621215] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621217] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wlan0] filtered by subsystem
<debug> [1459859874.621219] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wlan0] filtered by subsystem
<debug> [1459859874.621220] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wlan0] filtered by subsystem
<debug> [1459859874.621223] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wlan0] filtered by udev tags
<debug> [1459859874.621225] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wlan0] filtered by subsystem
<debug> [1459859874.621227] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wlan0] filtered by subsystem
<debug> [1459859874.621229] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621231] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wlan0] filtered by subsystem
<debug> [1459859874.621233] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621234] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621236] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wlan0] filtered by subsystem
<debug> [1459859874.621239] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621254] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621256] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wlan0] filtered by drivers
<debug> [1459859874.621258] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wlan0] filtered by subsystem
<debug> [1459859874.621259] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wlan0] filtered by subsystem
<debug> [1459859874.621275] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wlan0] filtered by subsystem
<debug> [1459859874.621277] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wlan0] filtered by subsystem
<debug> [1459859874.621279] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621281] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wlan0] filtered by vendor/product IDs
<debug> [1459859874.621283] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wlan0] Found '1' plugins to try...
<debug> [1459859874.621285] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wlan0] Will try with plugin 'Generic'
<debug> [1459859874.621288] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [wlan0] probing deferred until result suggested
<debug> [1459859874.621352] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1f.6] Checking device support...
<debug> [1459859874.621399] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621402] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621405] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621407] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [eth0-link] filtered by drivers
<debug> [1459859874.621409] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [eth0-link] filtered by drivers
<debug> [1459859874.621411] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621413] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [eth0-link] filtered by subsystem
<debug> [1459859874.621415] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [eth0-link] filtered by subsystem
<debug> [1459859874.621417] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [eth0-link] filtered by subsystem
<debug> [1459859874.621419] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [eth0-link] filtered by udev tags
<debug> [1459859874.621421] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [eth0-link] filtered by subsystem
<debug> [1459859874.621423] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [eth0-link] filtered by subsystem
<debug> [1459859874.621425] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621427] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [eth0-link] filtered by subsystem
<debug> [1459859874.621429] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621431] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621433] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [eth0-link] filtered by subsystem
<debug> [1459859874.621435] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621437] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621439] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [eth0-link] filtered by drivers
<debug> [1459859874.621441] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [eth0-link] filtered by subsystem
<debug> [1459859874.621443] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [eth0-link] filtered by subsystem
<debug> [1459859874.621458] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [eth0-link] filtered by subsystem
<debug> [1459859874.621460] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [eth0-link] filtered by subsystem
<debug> [1459859874.621462] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621464] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [eth0-link] filtered by vendor/product IDs
<debug> [1459859874.621466] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [eth0-link] Found '1' plugins to try...
<debug> [1459859874.621468] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [eth0-link] Will try with plugin 'Generic'
<debug> [1459859874.621471] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [eth0-link] probing deferred until result suggested
<debug> [1459859874.621508] [mm-base-manager.c:296] device_added(): (net/eth0): could not get port's parent device
<debug> [1459859874.621542] [mm-base-manager.c:296] device_added(): (net/ipsec0): could not get port's parent device
<debug> [1459859874.621574] [mm-base-manager.c:296] device_added(): (net/ipsec1): could not get port's parent device
<debug> [1459859874.621604] [mm-base-manager.c:296] device_added(): (net/ipsec2): could not get port's parent device
<debug> [1459859874.621655] [mm-base-manager.c:296] device_added(): (net/ipsec3): could not get port's parent device
<debug> [1459859874.621714] [mm-base-manager.c:296] device_added(): (net/tap0): could not get port's parent device
<debug> [1459859874.621745] [mm-base-manager.c:296] device_added(): (net/tap1): could not get port's parent device
<debug> [1459859874.621774] [mm-base-manager.c:296] device_added(): (net/tap2): could not get port's parent device
<debug> [1459859874.621806] [mm-base-manager.c:296] device_added(): (net/tap3): could not get port's parent device
<debug> [1459859874.621836] [mm-base-manager.c:296] device_added(): (net/tap4): could not get port's parent device
<debug> [1459859874.621865] [mm-base-manager.c:296] device_added(): (net/tap5): could not get port's parent device
<debug> [1459859874.621974] [mm-plugin.c:212] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.621978] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1459859874.621980] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1459859874.621982] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [cdc-wdm0] filtered by drivers
<debug> [1459859874.621984] [mm-plugin.c:212] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.621986] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1459859874.621988] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.621990] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.621992] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.621994] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm0] filtered by udev tags
<debug> [1459859874.621996] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.621998] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622006] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622008] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622010] [mm-plugin.c:212] apply_pre_probing_filters(): (Novatel LTE) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622012] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1459859874.622014] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622016] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1459859874.622031] [mm-plugin.c:212] apply_pre_probing_filters(): (Samsung) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622033] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [cdc-wdm0] filtered by drivers
<debug> [1459859874.622035] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622037] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622039] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622041] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [cdc-wdm0] filtered by subsystem
<debug> [1459859874.622043] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1459859874.622045] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1459859874.622047] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '1' plugins to try...
<debug> [1459859874.622049] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin 'Generic'
<debug> [1459859874.622055] [mm-plugin.c:767] mm_plugin_supports_port(): (Generic) [cdc-wdm0] probe required: 'mbim'
<debug> [1459859874.622059] [mm-port-probe.c:1368] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'mbim'
<debug> [1459859874.622073] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support check until result suggested
<debug> [1459859874.622078] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wlan0] deferring support check until result suggested
<debug> [1459859874.622082] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [eth0-link] deferring support check until result suggested
<debug> [1459859874.622204] [mm-port-serial.c:1133] mm_port_serial_open(): (ttyS0) opening serial port...
<debug> [1459859874.622310] [mm-port-serial.c:1271] mm_port_serial_open(): (ttyS0) device open count is 1 (open)
<debug> [1459859874.622330] [mm-port-probe.c:525] wdm_probe_mbim(): (usbmisc/cdc-wdm0) probing MBIM...
opening device...cannot connect to proxy: Could not connect: Connection refusedspawning new mbim-proxy (try 1)...<debug> [1459859874.723194] [mm-port-serial-at.c:440] debug_log(): (ttyS0): --> 'AT^SQPORT?<CR>'
[/dev/cdc-wdm0] Read max control message size from descriptors file: 4096[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 88
<<<<<< data = 03:00:00:00:58:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:01:00:00:00:28:00:00:00:0C:00:00:00:1A:00:00:00:1E:00:00:00:2F:00:64:00:65:00:76:00:2F:00:63:00:64:00:63:00:2D:00:77:00:64:00:6D:00:30:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 88
<<<<<< type = command (0x00000003)
<<<<<< transaction = 1
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
<<<<<< cid = 'configuration' (0x00000001)
<<<<<< type = 'set' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 03:00:00:80:30:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 48
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 1
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>>>>>> cid = 'configuration' (0x00000001)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:00:00:00:10:00:00:00:02:00:00:00:00:10:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 16
<<<<<< type = open (0x00000001)
<<<<<< transaction = 2
<<<<<< Contents:
<<<<<< max_control_transfer = 4096
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 01:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
<debug> [1459859876.919502] [mm-port-probe.c:303] mm_port_probe_set_result_mbim(): (usbmisc/cdc-wdm0) port is MBIM-capable
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 02:00:00:00:0C:00:00:00:03:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 12
<<<<<< type = close (0x00000002)
<<<<<< transaction = 3
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 02:00:00:80:10:00:00:00:03:00:00:00:00:00:00:00
<debug> [1459859876.919623] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [cdc-wdm0] found best plugin for port
<debug> [1459859876.919632] [mm-plugin-manager.c:361] suggest_single_port_probe_result(): (Plugin Manager) (Generic) [wwan0] deferred task completed, got suggested plugin
<debug> [1459859876.919637] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm0' port probe finished, still 1 running probes in this device (wwan0)
<debug> [1459859876.919647] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [wwan0] probing deferred until result suggested
<debug> [1459859876.919651] [mm-plugin-manager.c:549] plugin_supports_port_ready(): (Plugin Manager) (Generic) [wwan0] task completed, got suggested plugin
<debug> [1459859876.919654] [mm-plugin-manager.c:313] port_probe_context_finished(): (Plugin Manager) 'wwan0' port probe finished, last one in device, but minimum probing time not consumed yet ('2.298635' seconds elapsed)
<debug> [1459859877.000753] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:16.3] Minimum probing time consumed
<debug> [1459859877.000762] [mm-plugin-manager.c:703] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2] Minimum probing time consumed and no more ports to probe
<debug> [1459859877.000766] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2] device support check finished in '2.379746' seconds
<info> [1459859877.000778] [mm-device.c:520] mm_device_create_modem(): Creating modem with plugin 'Generic' and '2' ports
<debug> [1459859877.000787] [generic/mm-plugin-generic.c:73] create_modem(): MBIM-powered generic modem found...
<debug> [1459859877.001240] [mm-base-modem.c:304] mm_base_modem_grab_port(): (cdc-wdm0) type 'mbim' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb1/1-2
<debug> [1459859877.001249] [mm-base-modem.c:304] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb1/1-2
<debug> [1459859877.001252] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2) net/wwan0 data (primary)
<debug> [1459859877.001255] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2) usb/cdc-wdm0 mbim (primary)
<info> [1459859877.001347] [mm-base-manager.c:162] find_device_support_ready(): Modem for device at '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2' successfully created
<debug> [1459859877.001357] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.2/0000:04:00.0] Minimum probing time consumed
<debug> [1459859877.001359] [mm-plugin-manager.c:368] suggest_single_port_probe_result(): (Plugin Manager) [wlan0] deferred task cancelled, no suggested plugin
<debug> [1459859877.001363] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1f.6] Minimum probing time consumed
<debug> [1459859877.001365] [mm-plugin-manager.c:368] suggest_single_port_probe_result(): (Plugin Manager) [eth0-link] deferred task cancelled, no suggested plugin
opening device...[/dev/cdc-wdm0] Read max control message size from descriptors file: 4096[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 88
<<<<<< data = 03:00:00:00:58:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:01:00:00:00:28:00:00:00:0C:00:00:00:1A:00:00:00:1E:00:00:00:2F:00:64:00:65:00:76:00:2F:00:63:00:64:00:63:00:2D:00:77:00:64:00:6D:00:30:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 88
<<<<<< type = command (0x00000003)
<<<<<< transaction = 1
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
<<<<<< cid = 'configuration' (0x00000001)
<<<<<< type = 'set' (0x00000001)
<debug> [1459859877.001591] [mm-plugin-manager.c:195] port_probe_context_finished(): (Plugin Manager) [wlan0] not supported by any plugin
<debug> [1459859877.001595] [mm-device.c:368] mm_device_ignore_port(): Fully ignoring port 'net/wlan0' from now on
<debug> [1459859877.001598] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'wlan0' port probe finished, last one in device
<debug> [1459859877.001600] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.2/0000:04:00.0] device support check finished in '2.380411' seconds
<info> [1459859877.001619] [mm-base-manager.c:153] find_device_support_ready(): Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.2/0000:04:00.0': not supported by any plugin
<debug> [1459859877.001627] [mm-plugin-manager.c:195] port_probe_context_finished(): (Plugin Manager) [eth0-link] not supported by any plugin
<debug> [1459859877.001629] [mm-device.c:368] mm_device_ignore_port(): Fully ignoring port 'net/eth0-link' from now on
<debug> [1459859877.001632] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'eth0-link' port probe finished, last one in device
<debug> [1459859877.001634] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1f.6] device support check finished in '2.380250' seconds
<info> [1459859877.001638] [mm-base-manager.c:153] find_device_support_ready(): Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1f.6': not supported by any plugin
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 03:00:00:80:30:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 48
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 1
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>>>>>> cid = 'configuration' (0x00000001)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:00:00:00:10:00:00:00:02:00:00:00:00:10:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 16
<<<<<< type = open (0x00000001)
<<<<<< transaction = 2
<<<<<< Contents:
<<<<<< max_control_transfer = 4096
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 01:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
<debug> [1459859877.001728] [mm-broadband-modem-mbim.c:1293] parent_initialization_started_ready(): Couldn't start parent initialization: Couldn't open ports during modem initialization: Couldn't get primary port
<debug> [1459859877.002011] [mm-broadband-modem-mbim.c:214] modem_load_current_capabilities(): loading current capabilities...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 3
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'device-caps' (0x00000001)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 196
>>>>>> data = 03:00:00:80:C4:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:94:00:00:00:03:00:00:00:01:00:00:00:01:00:00:00:02:00:00:00:3C:00:00:00:03:00:00:00:11:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:40:00:00:00:1E:00:00:00:60:00:00:00:28:00:00:00:88:00:00:00:0C:00:00:00:30:00:31:00:34:00:35:00:38:00:32:00:30:00:30:00:30:00:32:00:34:00:33:00:33:00:31:00:32:00:00:00:53:00:57:00:49:00:39:00:58:00:33:00:30:00:43:00:5F:00:30:00:32:00:2E:00:30:00:35:00:2E:00:30:00:37:00:2E:00:30:00:30:00:45:00:4D:00:37:00:34:00:35:00:35:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 196
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 3
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'device-caps' (0x00000001)
<debug> [1459859877.047642] [mm-broadband-modem-mbim.c:140] modem_load_current_capabilities_finish(): loaded modem capabilities: gsm-umts, lte
<debug> [1459859877.047685] [mm-iface-modem.c:4345] interface_initialization_step(): Modem allows up to 1 bearers
<debug> [1459859877.047689] [mm-bearer-list.c:270] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
<debug> [1459859877.047754] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '0000119900009079014582000243312SWI9X30C_02.05.07.00MBIM[1199:9079]Generic'
<debug> [1459859877.047757] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID 'f71f3e1a78bd99824c7025f09e416aea4ab70fda'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 4
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'radio-state' (0x00000003)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 56
>>>>>> data = 03:00:00:80:38:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 56
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 4
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'radio-state' (0x00000003)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 5
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:44:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 5
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 6
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'pin' (0x00000004)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 60
>>>>>> data = 03:00:00:80:3C:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 60
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 6
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'pin' (0x00000004)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:07:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 7
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'pin' (0x00000004)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 60
>>>>>> data = 03:00:00:80:3C: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:04:00:00:00:00:00:00:00:0C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 60
>>>>>> 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 = 'pin' (0x00000004)
<info> [1459859877.303495] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem: state changed (unknown -> locked)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 8
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74: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:44:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> 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)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:09:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 9
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74: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:02:00:00:00:00:00:00:00:44:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> 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 = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 10
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'home-provider' (0x00000006)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 03:00:00:80: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:05:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 48
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 10
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'PinRequired' (0x00000005)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'home-provider' (0x00000006)
<warn> [1459859877.495374] [mm-base-sim.c:1480] load_operator_identifier_ready(): couldn't load Operator identifier: 'PinRequired'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:0B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 11
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'home-provider' (0x00000006)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 03:00:00:80: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:06:00:00:00:05:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 48
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 11
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'PinRequired' (0x00000005)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'home-provider' (0x00000006)
<warn> [1459859877.559383] [mm-base-sim.c:1481] load_operator_name_ready(): couldn't load Operator name: 'PinRequired'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:0C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 12
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74: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:02:00:00:00:00:00:00:00:44:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> 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 = 'subscriber-ready-status' (0x00000002)
<debug> [1459859877.623605] [mm-broadband-modem.c:9231] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
<debug> [1459859877.623651] [mm-base-modem.c:950] initialize_ready(): Couldn't finish initialization in the current state: 'Modem is currently locked, cannot fully initialize'
<debug> [1459859877.623841] [mm-device.c:447] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-2' at path '/org/freedesktop/ModemManager1/Modem/0'
<debug> [1459859877.623845] [mm-device.c:457] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Generic' modem, VID 0x1199 PID 0x9079 (usb)
<debug> [1459859879.001968] [mm-port-serial-at.c:440] debug_log(): (ttyS0): --> 'AT<CR>'
<debug> [1459859882.003845] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1459859882.003963] [mm-port-serial-at.c:440] debug_log(): (ttyS0): --> 'AT<CR>'
<debug> [1459859885.002555] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1459859885.002676] [mm-port-serial-at.c:440] debug_log(): (ttyS0): --> 'AT<CR>'
<debug> [1459859888.000503] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1459859888.000533] [mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyS0) port is not AT-capable
<debug> [1459859888.000589] [mm-port-serial.c:1328] _close_internal(): (ttyS0) device open count is 0 (close)
<debug> [1459859888.000600] [mm-port-serial.c:1344] _close_internal(): (ttyS0) closing serial port...
<debug> [1459859888.000726] [mm-port-serial.c:1393] _close_internal(): (ttyS0) serial port closed
<debug> [1459859888.000743] [mm-port-serial.c:1455] port_serial_close_force(): (ttyS0) forced to close port
<debug> [1459859888.000785] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyS0] filtered by vendor strings
<debug> [1459859888.000841] [mm-plugin.c:767] mm_plugin_supports_port(): (Iridium) [ttyS0] probe required: 'at, at-vendor, at-product'
<debug> [1459859888.000868] [mm-plugin.c:454] apply_post_probing_filters(): (Iridium) [ttyS0] filtered as no vendor/product strings given
<debug> [1459859888.000913] [mm-plugin.c:767] mm_plugin_supports_port(): (Nokia) [ttyS0] probe required: 'at, at-vendor, at-icera'
<debug> [1459859888.000936] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyS0] filtered by vendor strings
<debug> [1459859888.000962] [mm-plugin.c:767] mm_plugin_supports_port(): (Via CBP7) [ttyS0] probe required: 'at, at-vendor, at-product'
<debug> [1459859888.000980] [mm-plugin.c:454] apply_post_probing_filters(): (Via CBP7) [ttyS0] filtered as no vendor/product strings given
<debug> [1459859888.001042] [mm-plugin.c:767] mm_plugin_supports_port(): (Generic) [ttyS0] probe required: 'at, qcdm'
<debug> [1459859888.001063] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyS0) launching port probing: 'qcdm'
<debug> [1459859888.001089] [mm-port-probe.c:660] serial_probe_qcdm(): (tty/ttyS0) probing QCDM...
<debug> [1459859888.001159] [mm-port-serial.c:1133] mm_port_serial_open(): (ttyS0) opening serial port...
<debug> [1459859888.001348] [mm-port-serial.c:1271] mm_port_serial_open(): (ttyS0) device open count is 1 (open)
<debug> [1459859888.001433] [mm-port-serial-qcdm.c:201] debug_log(): (ttyS0): --> 7e 00 78 f0 7e
<debug> [1459859891.003747] [mm-port-serial-qcdm.c:201] debug_log(): (ttyS0): --> 7e 00 78 f0 7e
<debug> [1459859894.004373] [mm-port-probe.c:260] mm_port_probe_set_result_qcdm(): (tty/ttyS0) port is not QCDM-capable
<debug> [1459859894.004478] [mm-port-serial.c:1328] _close_internal(): (ttyS0) device open count is 0 (close)
<debug> [1459859894.004497] [mm-port-serial.c:1344] _close_internal(): (ttyS0) closing serial port...
<debug> [1459859894.004637] [mm-port-serial.c:1393] _close_internal(): (ttyS0) serial port closed
<debug> [1459859894.004655] [mm-port-serial.c:1455] port_serial_close_force(): (ttyS0) forced to close port
<debug> [1459859894.004726] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyS0] found best plugin for port
<debug> [1459859894.004767] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'ttyS0' port probe finished, last one in device
<debug> [1459859894.004780] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:16.3] device support check finished in '19.385199' seconds
<info> [1459859894.004810] [mm-device.c:520] mm_device_create_modem(): Creating modem with plugin 'Generic' and '1' ports
<warn> [1459859894.005384] [mm-plugin.c:903] mm_plugin_create_modem(): Could not grab port (tty/ttyS0): 'Cannot add port 'tty/ttyS0', unhandled serial type'
<debug> [1459859894.005458] [mm-base-modem.c:1485] finalize(): Modem (Generic) '/sys/devices/pci0000:00/0000:00:16.3' completely disposed
<warn> [1459859894.005473] [mm-base-manager.c:158] find_device_support_ready(): Couldn't create modem for device at '/sys/devices/pci0000:00/0000:00:16.3': Failed to find primary AT port
<debug> [1459860297.146906] [mm-sim-mbim.c:431] send_pin(): Sending PIN...
<debug> [1459860297.147108] [mm-sim-mbim.c:47] inhibit_mbim_traces(): Temporarility disabling MBIM logging
<debug> [1459860297.399793] [mm-sim-mbim.c:55] release_mbim_traces(): Enabling MBIM logging
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] 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)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 03:00:00:80: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:02:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 48
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 14
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'Failure' (0x00000002)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'subscriber-ready-status' (0x00000002)
<debug> [1459860297.464115] [mm-iface-modem.c:266] load_unlock_required_ready(): Couldn't check if unlock required: 'Failure'
<debug> [1459860297.464387] [mm-iface-modem.c:290] load_unlock_required_ready(): Retrying (1) unlock required check
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 144
>>>>>> data = 07:00:00:80:90: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:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:31:00:36:00:34:00:34:00:31:00:30:00:33:00:30:00:35:00:35:00:36:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 144
>>>>>> 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)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 96
>>>>>> data = 07:00:00:80:60: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:34:00:00:00:01:00:00:00:00:00:00:00:13:01:00:00:00:00:00:00:18:00:00:00:1A:00:00:00:2B:00:34:00:39:00:31:00:37:00:31:00:30:00:37:00:36:00:30:00:30:00:30:00:30:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 96
>>>>>> type = indicate-status (0x80000007)
>>>>>> transaction = 0
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
>>>>>> cid = 'configuration' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 96
>>>>>> data = 07:00:00:80:60: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:34:00:00:00:01:00:00:00:00:00:00:00:13:01:00:00:00:00:00:00:18:00:00:00:1A:00:00:00:2B:00:34:00:39:00:31:00:37:00:31:00:30:00:37:00:36:00:30:00:30:00:30:00:30:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 96
>>>>>> type = indicate-status (0x80000007)
>>>>>> transaction = 0
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
>>>>>> cid = 'configuration' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 144
>>>>>> data = 07:00:00:80:90: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:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:31:00:36:00:34:00:34:00:31:00:30:00:33:00:30:00:35:00:35:00:36:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 144
>>>>>> 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)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 64
>>>>>> data = 07:00:00:80:40:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:4B:F3:84:76:1E:6A:41:DB:B1:D8:BE:D2:89:C2:5B:DB:01:00:00:00:14:00:00:00:01:00:00:00:E6:00:00:00:16:00:00:00:28:00:00:00:10:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 64
>>>>>> type = indicate-status (0x80000007)
>>>>>> transaction = 0
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> service = 'phonebook' (4bf38476-1e6a-41db-b1d8-bed289c25bdb)
>>>>>> cid = 'configuration' (0x00000001)
[/dev/cdc-wdm0] 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:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] 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 = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 148
>>>>>> data = 03:00:00:80:94: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:02:00:00:00:00:00:00:00:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:31:00:36:00:34:00:34:00:31:00:30:00:33:00:30:00:35:00:35:00:36:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 148
>>>>>> 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 = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:10:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 16
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'pin' (0x00000004)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 60
>>>>>> data = 03:00:00:80:3C: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:04:00:00:00:00:00:00:00:0C:00:00:00:03:00:00:00:01:00:00:00:03:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 60
>>>>>> 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 = 'pin' (0x00000004)
<debug> [1459860300.120323] [mm-iface-modem.c:3110] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
<info> [1459860300.120942] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (locked -> initializing)
<debug> [1459860300.121943] [mm-broadband-modem-mbim.c:1293] parent_initialization_started_ready(): Couldn't start parent initialization: Couldn't open ports during modem initialization: Couldn't get primary port
[/dev/cdc-wdm0] 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
[/dev/cdc-wdm0] 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)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 148
>>>>>> data = 03:00:00:80:94: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:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:31:00:36:00:34:00:34:00:31:00:30:00:33:00:30:00:35:00:35:00:36:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 148
>>>>>> 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)
[/dev/cdc-wdm0] 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:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] 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 = 'home-provider' (0x00000006)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 112
>>>>>> data = 03:00:00:80:70: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:06:00:00:00:00:00:00:00:40:00:00:00:20:00:00:00:0A:00:00:00:01:00:00:00:2C:00:00:00:14:00:00:00:01:00:00:00:63:00:00:00:63:00:00:00:32:00:36:00:32:00:30:00:31:00:00:00:54:00:65:00:6C:00:65:00:6B:00:6F:00:6D:00:2E:00:64:00:65:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 112
>>>>>> 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 = 'home-provider' (0x00000006)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:13:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 19
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'home-provider' (0x00000006)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 112
>>>>>> data = 03:00:00:80:70: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:06:00:00:00:00:00:00:00:40:00:00:00:20:00:00:00:0A:00:00:00:01:00:00:00:2C:00:00:00:14:00:00:00:01:00:00:00:63:00:00:00:63:00:00:00:32:00:36:00:32:00:30:00:31:00:00:00:54:00:65:00:6C:00:65:00:6B:00:6F:00:6D:00:2E:00:64:00:65:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 112
>>>>>> 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 = 'home-provider' (0x00000006)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30: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:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 20
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 148
>>>>>> data = 03:00:00:80:94: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:02:00:00:00:00:00:00:00:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:31:00:36:00:34:00:34:00:31:00:30:00:33:00:30:00:35:00:35:00:36:00:00:00:38:00:39:00:34:00:39:00:30:00:32:00:30:00:30:00:30:00:30:00:30:00:38:00:31:00:35:00:31:00:35:00:31:00:33:00:33:00:32:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 148
>>>>>> 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 = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:15:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 21
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'pin-list' (0x00000005)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 208
>>>>>> data = 03:00:00:80:D0: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: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:01:00:00:00:01:00:00:00:04:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 208
>>>>>> 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 = 'pin-list' (0x00000005)
<debug> [1459860300.441460] [mm-iface-modem-3gpp-ussd.c:786] check_support_ready(): USSD support check failed: 'No AT port available to run command'
<debug> [1459860300.441518] [mm-broadband-modem.c:9224] iface_modem_3gpp_ussd_initialize_ready(): Couldn't initialize interface: 'USSD not supported'
<debug> [1459860300.442574] [mm-broadband-modem-mbim.c:2596] messaging_check_support(): Messaging capabilities supported
<debug> [1459860300.442680] [mm-iface-modem-messaging.c:1148] load_supported_storages_ready(): Supported storages loaded:
<debug> [1459860300.442698] [mm-iface-modem-messaging.c:1149] load_supported_storages_ready(): mem1 (list/read/delete) storages: 'mt'
<debug> [1459860300.442710] [mm-iface-modem-messaging.c:1150] load_supported_storages_ready(): mem2 (write/send) storages: 'mt'
<debug> [1459860300.442720] [mm-iface-modem-messaging.c:1151] load_supported_storages_ready(): mem3 (reception) storages: 'mt'
<debug> [1459860300.443403] [mm-iface-modem-time.c:831] check_support_ready(): Time support check failed: 'No AT port available to run command'
<debug> [1459860300.443448] [mm-broadband-modem.c:9228] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
<debug> [1459860300.443687] [mm-broadband-modem.c:9229] iface_modem_signal_initialize_ready(): Couldn't initialize interface: 'Extended Signal information not supported'
<debug> [1459860300.444107] [mm-broadband-modem.c:9230] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
<debug> [1459860300.444222] [mm-broadband-modem.c:9231] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
<info> [1459860300.444276] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (initializing -> disabled)
<info> [1459860300.447081] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
<debug> [1459860300.447266] [mm-broadband-modem.c:8166] enabling_started(): Skipping modem initialization: not required
<debug> [1459860300.447287] [mm-broadband-modem-mbim.c:1220] parent_enabling_started_ready(): Couldn't start parent enabling: Couldn't open ports during modem enabling: Couldn't get primary port
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30: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:03:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 22
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'radio-state' (0x00000003)
<<<<<< type = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 56
>>>>>> data = 03:00:00:80:38: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:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 56
>>>>>> 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 = 'radio-state' (0x00000003)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 52
<<<<<< data = 03:00:00:00:34: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:03:00:00:00:01:00:00:00:04:00:00:00:01:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 52
<<<<<< type = command (0x00000003)
<<<<<< transaction = 23
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'radio-state' (0x00000003)
<<<<<< type = 'set' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 56
>>>>>> data = 03:00:00:80:38: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:03:00:00:00:02:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 56
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 23
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'Failure' (0x00000002)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'radio-state' (0x00000003)
<info> [1459860300.568053] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> disabled)
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 198 bytes
Desc: OpenPGP digital signature
URL: <https://lists.freedesktop.org/archives/modemmanager-devel/attachments/20160405/ee52d4be/attachment-0001.sig>
More information about the ModemManager-devel
mailing list