GPS support using Quectel EC21
José
Joseddg92 at gmail.com
Mon Sep 11 11:31:59 UTC 2017
Hi,
I am trying to use ModemManager with the Quectel EC21 modem to get GPS data.
By default this modem uses QMI, but I see the following message when
starting ModemManager:
[1504793139.991929] [../../git/src/mm-broadband-modem-qmi.c:11204]
qmi_port_allocate_client_ready(): Couldn't allocate client for service
'pds': Couldn't create client for service 'pds': Service 'pds' not
supported by the device
>From that, I interpret that the modem firmware (I am using
EC21EFAR02A05M4G) is not implementing the PDS QMI service, which is
used for GPS support. I have asked Quectel about new firmware versions
for this modem, just in case there is support for PDS service, but I
am still waiting for their answer.
In the meanwhile, I decided to test without QMI, using the option
driver to probe the USB serial devices. I removed the QMI driver and I
manually probed the USB serial ports with the option driver:
echo "2c7c 0121" > /sys/bus/usb-serial/drivers/option1/new_id
option 1-1.3:1.0: GSM modem (1-port) converter detected
usb 1-1.3: GSM modem (1-port) converter now attached to ttyUSB0
option 1-1.3:1.1: GSM modem (1-port) converter detected
usb 1-1.3: GSM modem (1-port) converter now attached to ttyUSB1
option 1-1.3:1.2: GSM modem (1-port) converter detected
usb 1-1.3: GSM modem (1-port) converter now attached to ttyUSB2
option 1-1.3:1.3: GSM modem (1-port) converter detected
usb 1-1.3: GSM modem (1-port) converter now attached to ttyUSB3
In this mode, I have verified that the GPS seems to work. I use the
'AT+QGPS=1' at command to enable GPS and then I can see NMEA traces in
the ttyUSB1 port:
root at ccimx6ulsbc:~# mmcli -m 0 --command="AT+QGPS=1"
response: ''
root at ccimx6ulsbc:~# cat /dev/ttyUSB1
$GPVTG,,T,,M,,N,,K,N*2C
$GPGSA,A,1,,,,,,,,,,,,,,,*1E
$GPGGA,,,,,,0,,,,,,,,*66
$GPRMC,,V,,,,,,,,,,N*53
$GPVTG,,T,,M,,N,,K,N*2C
$GPGSA,A,1,,,,,,,,,,,,,,,*1E
$GPGGA,,,,,,0,,,,,,,,*66
$GPRMC,,V,,,,,,,,,,N*53
$GPVTG,,T,,M,,N,,K,N*2C
$GPGSA,A,1,,,,,,,,,,,,,,,*1E
$GPGGA,,,,,,0,,,,,,,,*66
$GPRMC,,V,,,,,,,,,,N*53
$GPVTG,,T,,M,,N,,K,N*2C
$GPGSA,A,1,,,,,,,,,,,,,,,*1E
$GPGGA,,,,,,0,,,,,,,,*66
The problem is trying to make this work with ModemManager. For some
reason (I don't quite understand why) seems like ModemManager doesn't
recognize the ttyUSB1 port as the GPS port. I am not sure if AT+QGPS
is a standard AT command or is something specific from Quectell
modems/Qualcomm chipsets.
Is this expected to work, am I missing something?
I attach the ModemManager debug log when probing the modem (after
removing QMI and enabling the serial driver) and trying the following:
root at ccimx6ulsbc:~# mmcli -m 0 -e
successfully enabled the modem
root at ccimx6ulsbc:~# mmcli -m 0 --location-status
/org/freedesktop/ModemManager1/Modem/0
----------------------------
Location | capabilities: '3gpp-lac-ci'
| enabled: '3gpp-lac-ci'
| signals: 'no'
root at ccimx6ulsbc:~# mmcli -m 0 --location-enable-gps-nmea
error: couldn't setup location gathering:
'GDBus.Error:org.freedesktop.ModemManage
r1.Error.Core.Unsupported: Cannot enable unsupported location sources:
'gps-nmea''
root at ccimx6ulsbc:~# mmcli -m 0 --location-enable-gps-raw
error: couldn't setup location gathering:
'GDBus.Error:org.freedesktop.ModemManage
r1.Error.Core.Unsupported: Cannot enable unsupported location sources:
'gps-raw''
-------------- next part --------------
<info> [1505128640.680356] [../../git/src/main.c:157] main(): ModemManager (version 1.7.0) starting in system bus...
<debug> [1505128640.716743] [../../git/src/main.c:83] bus_acquired_cb(): Bus acquired, creating manager...
<debug> [1505128640.723523] [../../git/src/mm-plugin-manager.c:1559] load_plugins(): [plugin manager] looking for plugins in '/usr/lib/ModemManager'
<debug> [1505128640.731767] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Haier'
<debug> [1505128640.735467] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Option'
<debug> [1505128640.740988] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'X22X'
<debug> [1505128640.744649] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Ericsson MBM'
<debug> [1505128640.748105] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Sierra'
<debug> [1505128640.751208] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Linktop'
<debug> [1505128640.753965] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'MTK'
<debug> [1505128640.757069] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Novatel LTE'
<debug> [1505128640.764108] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'AnyDATA'
<debug> [1505128640.767804] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'u-blox'
<debug> [1505128640.770669] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Longcheer'
<debug> [1505128640.773944] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Cinterion'
<debug> [1505128640.777301] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Sierra (legacy)'
<debug> [1505128640.780204] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Wavecom'
<debug> [1505128640.783531] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Dell'
<debug> [1505128640.789886] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Thuraya'
<debug> [1505128640.793215] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Novatel'
<debug> [1505128640.796221] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Iridium'
<debug> [1505128640.799231] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'SimTech'
<debug> [1505128640.802134] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Generic'
<debug> [1505128640.805381] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Option High-Speed'
<debug> [1505128640.813022] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Altair LTE'
<debug> [1505128640.816577] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Telit'
<debug> [1505128640.819579] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Nokia'
<debug> [1505128640.822645] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Via CBP7'
<debug> [1505128640.825970] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Samsung'
<debug> [1505128640.829095] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Motorola'
<debug> [1505128640.832538] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Huawei'
<debug> [1505128640.835597] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Pantech'
<debug> [1505128640.839128] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'ZTE'
<debug> [1505128640.843689] [../../git/src/mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Nokia (Icera)'
<debug> [1505128640.845229] [../../git/src/mm-plugin-manager.c:1609] load_plugins(): [plugin manager] successfully loaded 31 plugins
<debug> [1505128640.853651] [../../git/src/main.c:106] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
<debug> [1505128640.855103] [../../git/src/mm-base-manager.c:573] mm_base_manager_start(): Starting automatic device scan...
<debug> [1505128640.876760] [../../git/src/mm-base-manager.c:575] mm_base_manager_start(): Finished device scan...
<debug> [1505128640.879609] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttymxc0): adding device at sysfs path: /sys/devices/platform/soc/2000000.aips-bus/2000000.spba-bus/2020000.serial/tty/ttymxc0
<debug> [1505128640.882706] [../../git/src/kerneldevice/mm-kernel-device-udev.c:474] kernel_device_is_candidate(): (tty/ttymxc0): port's parent platform driver is not whitelisted
<debug> [1505128640.884233] [../../git/src/mm-base-manager.c:283] device_added(): (tty/ttymxc0): port not candidate
<debug> [1505128640.886114] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttyUSB0): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3/1-1.3:1.0/ttyUSB0/tty/ttyUSB0
<debug> [1505128640.890412] [../../git/src/mm-base-manager.c:308] device_added(): (tty/ttyUSB0): first port in device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128640.892869] [../../git/src/mm-plugin-manager.c:1442] mm_plugin_manager_device_support_check(): [plugin manager] task 0: new support task for device: /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128640.897095] [../../git/src/mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: ttyUSB0
<debug> [1505128640.898672] [../../git/src/mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,ttyUSB0: new support task for port
<debug> [1505128640.900068] [../../git/src/mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,ttyUSB0: deferred until min wait time elapsed
<debug> [1505128640.901811] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttyUSB1): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3/1-1.3:1.1/ttyUSB1/tty/ttyUSB1
<debug> [1505128640.905754] [../../git/src/mm-base-manager.c:329] device_added(): (tty/ttyUSB1): additional port in device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128640.908002] [../../git/src/mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: ttyUSB1
<debug> [1505128640.909576] [../../git/src/mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,ttyUSB1: new support task for port
<debug> [1505128640.910987] [../../git/src/mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,ttyUSB1: deferred until min wait time elapsed
<debug> [1505128640.912794] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttyUSB2): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3/1-1.3:1.2/ttyUSB2/tty/ttyUSB2
<debug> [1505128640.917062] [../../git/src/mm-base-manager.c:329] device_added(): (tty/ttyUSB2): additional port in device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128640.919174] [../../git/src/mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: ttyUSB2
<debug> [1505128640.920770] [../../git/src/mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,ttyUSB2: new support task for port
<debug> [1505128640.922186] [../../git/src/mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,ttyUSB2: deferred until min wait time elapsed
<debug> [1505128640.924094] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttyUSB3): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3/1-1.3:1.3/ttyUSB3/tty/ttyUSB3
<debug> [1505128640.928509] [../../git/src/mm-base-manager.c:329] device_added(): (tty/ttyUSB3): additional port in device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128640.930510] [../../git/src/mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: ttyUSB3
<debug> [1505128640.932002] [../../git/src/mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,ttyUSB3: new support task for port
<debug> [1505128640.933306] [../../git/src/mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,ttyUSB3: deferred until min wait time elapsed
<debug> [1505128640.934998] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttyUSB4): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3/1-1.3:1.4/ttyUSB4/tty/ttyUSB4
<debug> [1505128640.938995] [../../git/src/mm-base-manager.c:329] device_added(): (tty/ttyUSB4): additional port in device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128640.941011] [../../git/src/mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: ttyUSB4
<debug> [1505128640.942523] [../../git/src/mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,ttyUSB4: new support task for port
<debug> [1505128640.943838] [../../git/src/mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,ttyUSB4: deferred until min wait time elapsed
<debug> [1505128640.945454] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttymxc1): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/21e8000.serial/tty/ttymxc1
<debug> [1505128640.948224] [../../git/src/mm-base-manager.c:308] device_added(): (tty/ttymxc1): first port in device Digi XBee Cellular
<debug> [1505128640.949945] [../../git/src/mm-plugin-manager.c:1442] mm_plugin_manager_device_support_check(): [plugin manager] task 1: new support task for device: Digi XBee Cellular
<debug> [1505128640.951934] [../../git/src/mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 1: port grabbed: ttymxc1
<debug> [1505128640.953452] [../../git/src/mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 1,ttymxc1: new support task for port
<debug> [1505128640.954792] [../../git/src/mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 1,ttymxc1: deferred until min wait time elapsed
<debug> [1505128640.956689] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttymxc2): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/21ec000.serial/tty/ttymxc2
<debug> [1505128640.959405] [../../git/src/kerneldevice/mm-kernel-device-udev.c:474] kernel_device_is_candidate(): (tty/ttymxc2): port's parent platform driver is not whitelisted
<debug> [1505128640.960992] [../../git/src/mm-base-manager.c:283] device_added(): (tty/ttymxc2): port not candidate
<debug> [1505128640.962793] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ttymxc4): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/21f4000.serial/tty/ttymxc4
<debug> [1505128640.965456] [../../git/src/kerneldevice/mm-kernel-device-udev.c:474] kernel_device_is_candidate(): (tty/ttymxc4): port's parent platform driver is not whitelisted
<debug> [1505128640.967123] [../../git/src/mm-base-manager.c:283] device_added(): (tty/ttymxc4): port not candidate
<debug> [1505128640.968940] [../../git/src/mm-base-manager.c:274] device_added(): (tty/console): adding device at sysfs path: /sys/devices/virtual/tty/console
<debug> [1505128640.972127] [../../git/src/mm-base-manager.c:283] device_added(): (tty/console): port not candidate
<debug> [1505128640.974095] [../../git/src/mm-base-manager.c:274] device_added(): (tty/ptmx): adding device at sysfs path: /sys/devices/virtual/tty/ptmx
<debug> [1505128640.976254] [../../git/src/mm-base-manager.c:283] device_added(): (tty/ptmx): port not candidate
<debug> [1505128640.978239] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty): adding device at sysfs path: /sys/devices/virtual/tty/tty
<debug> [1505128640.980355] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty): port not candidate
<debug> [1505128640.982110] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty0): adding device at sysfs path: /sys/devices/virtual/tty/tty0
<debug> [1505128640.984067] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty0): port not candidate
<debug> [1505128640.985790] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty1): adding device at sysfs path: /sys/devices/virtual/tty/tty1
<debug> [1505128640.988018] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty1): port not candidate
<debug> [1505128640.989778] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty10): adding device at sysfs path: /sys/devices/virtual/tty/tty10
<debug> [1505128640.991736] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty10): port not candidate
<debug> [1505128640.993481] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty11): adding device at sysfs path: /sys/devices/virtual/tty/tty11
<debug> [1505128640.995459] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty11): port not candidate
<debug> [1505128640.997298] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty12): adding device at sysfs path: /sys/devices/virtual/tty/tty12
<debug> [1505128640.999303] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty12): port not candidate
<debug> [1505128641.001942] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty13): adding device at sysfs path: /sys/devices/virtual/tty/tty13
<debug> [1505128641.003941] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty13): port not candidate
<debug> [1505128641.005726] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty14): adding device at sysfs path: /sys/devices/virtual/tty/tty14
<debug> [1505128641.007931] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty14): port not candidate
<debug> [1505128641.009687] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty15): adding device at sysfs path: /sys/devices/virtual/tty/tty15
<debug> [1505128641.011703] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty15): port not candidate
<debug> [1505128641.013467] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty16): adding device at sysfs path: /sys/devices/virtual/tty/tty16
<debug> [1505128641.015468] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty16): port not candidate
<debug> [1505128641.017616] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty17): adding device at sysfs path: /sys/devices/virtual/tty/tty17
<debug> [1505128641.019695] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty17): port not candidate
<debug> [1505128641.021479] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty18): adding device at sysfs path: /sys/devices/virtual/tty/tty18
<debug> [1505128641.023502] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty18): port not candidate
<debug> [1505128641.025263] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty19): adding device at sysfs path: /sys/devices/virtual/tty/tty19
<debug> [1505128641.027540] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty19): port not candidate
<debug> [1505128641.029351] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty2): adding device at sysfs path: /sys/devices/virtual/tty/tty2
<debug> [1505128641.031385] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty2): port not candidate
<debug> [1505128641.033312] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty20): adding device at sysfs path: /sys/devices/virtual/tty/tty20
<debug> [1505128641.035278] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty20): port not candidate
<debug> [1505128641.037190] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty21): adding device at sysfs path: /sys/devices/virtual/tty/tty21
<debug> [1505128641.039171] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty21): port not candidate
<debug> [1505128641.040905] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty22): adding device at sysfs path: /sys/devices/virtual/tty/tty22
<debug> [1505128641.042873] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty22): port not candidate
<debug> [1505128641.044616] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty23): adding device at sysfs path: /sys/devices/virtual/tty/tty23
<debug> [1505128641.046985] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty23): port not candidate
<debug> [1505128641.048732] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty24): adding device at sysfs path: /sys/devices/virtual/tty/tty24
<debug> [1505128641.050714] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty24): port not candidate
<debug> [1505128641.052488] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty25): adding device at sysfs path: /sys/devices/virtual/tty/tty25
<debug> [1505128641.054471] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty25): port not candidate
<debug> [1505128641.056196] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty26): adding device at sysfs path: /sys/devices/virtual/tty/tty26
<debug> [1505128641.058387] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty26): port not candidate
<debug> [1505128641.060134] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty27): adding device at sysfs path: /sys/devices/virtual/tty/tty27
<debug> [1505128641.062153] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty27): port not candidate
<debug> [1505128641.063932] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty28): adding device at sysfs path: /sys/devices/virtual/tty/tty28
<debug> [1505128641.065916] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty28): port not candidate
<debug> [1505128641.067886] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty29): adding device at sysfs path: /sys/devices/virtual/tty/tty29
<debug> [1505128641.069898] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty29): port not candidate
<debug> [1505128641.071645] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty3): adding device at sysfs path: /sys/devices/virtual/tty/tty3
<debug> [1505128641.073639] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty3): port not candidate
<debug> [1505128641.075407] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty30): adding device at sysfs path: /sys/devices/virtual/tty/tty30
<debug> [1505128641.077608] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty30): port not candidate
<debug> [1505128641.079426] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty31): adding device at sysfs path: /sys/devices/virtual/tty/tty31
<debug> [1505128641.081441] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty31): port not candidate
<debug> [1505128641.083220] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty32): adding device at sysfs path: /sys/devices/virtual/tty/tty32
<debug> [1505128641.085244] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty32): port not candidate
<debug> [1505128641.087239] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty33): adding device at sysfs path: /sys/devices/virtual/tty/tty33
<debug> [1505128641.089278] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty33): port not candidate
<debug> [1505128641.091062] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty34): adding device at sysfs path: /sys/devices/virtual/tty/tty34
<debug> [1505128641.094169] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty34): port not candidate
<debug> [1505128641.095902] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty35): adding device at sysfs path: /sys/devices/virtual/tty/tty35
<debug> [1505128641.098158] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty35): port not candidate
<debug> [1505128641.099883] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty36): adding device at sysfs path: /sys/devices/virtual/tty/tty36
<debug> [1505128641.101861] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty36): port not candidate
<debug> [1505128641.103588] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty37): adding device at sysfs path: /sys/devices/virtual/tty/tty37
<debug> [1505128641.105596] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty37): port not candidate
<debug> [1505128641.107564] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty38): adding device at sysfs path: /sys/devices/virtual/tty/tty38
<debug> [1505128641.109555] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty38): port not candidate
<debug> [1505128641.111304] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty39): adding device at sysfs path: /sys/devices/virtual/tty/tty39
<debug> [1505128641.113362] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty39): port not candidate
<debug> [1505128641.115106] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty4): adding device at sysfs path: /sys/devices/virtual/tty/tty4
<debug> [1505128641.117297] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty4): port not candidate
<debug> [1505128641.119050] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty40): adding device at sysfs path: /sys/devices/virtual/tty/tty40
<debug> [1505128641.121131] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty40): port not candidate
<debug> [1505128641.123823] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty41): adding device at sysfs path: /sys/devices/virtual/tty/tty41
<debug> [1505128641.125847] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty41): port not candidate
<debug> [1505128641.127827] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty42): adding device at sysfs path: /sys/devices/virtual/tty/tty42
<debug> [1505128641.129841] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty42): port not candidate
<debug> [1505128641.131632] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty43): adding device at sysfs path: /sys/devices/virtual/tty/tty43
<debug> [1505128641.133662] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty43): port not candidate
<debug> [1505128641.135407] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty44): adding device at sysfs path: /sys/devices/virtual/tty/tty44
<debug> [1505128641.137556] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty44): port not candidate
<debug> [1505128641.139346] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty45): adding device at sysfs path: /sys/devices/virtual/tty/tty45
<debug> [1505128641.141362] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty45): port not candidate
<debug> [1505128641.143146] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty46): adding device at sysfs path: /sys/devices/virtual/tty/tty46
<debug> [1505128641.145184] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty46): port not candidate
<debug> [1505128641.147189] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty47): adding device at sysfs path: /sys/devices/virtual/tty/tty47
<debug> [1505128641.149255] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty47): port not candidate
<debug> [1505128641.151041] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty48): adding device at sysfs path: /sys/devices/virtual/tty/tty48
<debug> [1505128641.153234] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty48): port not candidate
<debug> [1505128641.154945] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty49): adding device at sysfs path: /sys/devices/virtual/tty/tty49
<debug> [1505128641.157119] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty49): port not candidate
<debug> [1505128641.158885] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty5): adding device at sysfs path: /sys/devices/virtual/tty/tty5
<debug> [1505128641.160857] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty5): port not candidate
<debug> [1505128641.162609] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty50): adding device at sysfs path: /sys/devices/virtual/tty/tty50
<debug> [1505128641.164749] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty50): port not candidate
<debug> [1505128641.166753] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty51): adding device at sysfs path: /sys/devices/virtual/tty/tty51
<debug> [1505128641.168797] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty51): port not candidate
<debug> [1505128641.170530] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty52): adding device at sysfs path: /sys/devices/virtual/tty/tty52
<debug> [1505128641.172579] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty52): port not candidate
<debug> [1505128641.174322] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty53): adding device at sysfs path: /sys/devices/virtual/tty/tty53
<debug> [1505128641.176564] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty53): port not candidate
<debug> [1505128641.178347] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty54): adding device at sysfs path: /sys/devices/virtual/tty/tty54
<debug> [1505128641.180398] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty54): port not candidate
<debug> [1505128641.182144] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty55): adding device at sysfs path: /sys/devices/virtual/tty/tty55
<debug> [1505128641.184146] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty55): port not candidate
<debug> [1505128641.185890] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty56): adding device at sysfs path: /sys/devices/virtual/tty/tty56
<debug> [1505128641.188111] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty56): port not candidate
<debug> [1505128641.189863] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty57): adding device at sysfs path: /sys/devices/virtual/tty/tty57
<debug> [1505128641.191896] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty57): port not candidate
<debug> [1505128641.193651] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty58): adding device at sysfs path: /sys/devices/virtual/tty/tty58
<debug> [1505128641.195689] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty58): port not candidate
<debug> [1505128641.197633] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty59): adding device at sysfs path: /sys/devices/virtual/tty/tty59
<debug> [1505128641.199651] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty59): port not candidate
<debug> [1505128641.201407] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty6): adding device at sysfs path: /sys/devices/virtual/tty/tty6
<debug> [1505128641.203435] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty6): port not candidate
<debug> [1505128641.205232] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty60): adding device at sysfs path: /sys/devices/virtual/tty/tty60
<debug> [1505128641.207485] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty60): port not candidate
<debug> [1505128641.209290] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty61): adding device at sysfs path: /sys/devices/virtual/tty/tty61
<debug> [1505128641.211340] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty61): port not candidate
<debug> [1505128641.213271] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty62): adding device at sysfs path: /sys/devices/virtual/tty/tty62
<debug> [1505128641.216203] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty62): port not candidate
<debug> [1505128641.218299] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty63): adding device at sysfs path: /sys/devices/virtual/tty/tty63
<debug> [1505128641.220303] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty63): port not candidate
<debug> [1505128641.222105] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty7): adding device at sysfs path: /sys/devices/virtual/tty/tty7
<debug> [1505128641.224083] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty7): port not candidate
<debug> [1505128641.225815] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty8): adding device at sysfs path: /sys/devices/virtual/tty/tty8
<debug> [1505128641.227987] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty8): port not candidate
<debug> [1505128641.229721] [../../git/src/mm-base-manager.c:274] device_added(): (tty/tty9): adding device at sysfs path: /sys/devices/virtual/tty/tty9
<debug> [1505128641.231719] [../../git/src/mm-base-manager.c:283] device_added(): (tty/tty9): port not candidate
<debug> [1505128641.233484] [../../git/src/mm-base-manager.c:274] device_added(): (net/can0): adding device at sysfs path: /sys/devices/platform/soc/2000000.aips-bus/2090000.can/net/can0
<debug> [1505128641.236610] [../../git/src/kerneldevice/mm-kernel-device-udev.c:474] kernel_device_is_candidate(): (net/can0): port's parent platform driver is not whitelisted
<debug> [1505128641.238153] [../../git/src/mm-base-manager.c:283] device_added(): (net/can0): port not candidate
<debug> [1505128641.239935] [../../git/src/mm-base-manager.c:274] device_added(): (net/eth0): adding device at sysfs path: /sys/devices/platform/soc/2000000.aips-bus/20b4000.ethernet/net/eth0
<debug> [1505128641.242546] [../../git/src/kerneldevice/mm-kernel-device-udev.c:474] kernel_device_is_candidate(): (net/eth0): port's parent platform driver is not whitelisted
<debug> [1505128641.244068] [../../git/src/mm-base-manager.c:283] device_added(): (net/eth0): port not candidate
<debug> [1505128641.246926] [../../git/src/mm-base-manager.c:274] device_added(): (net/eth1): adding device at sysfs path: /sys/devices/platform/soc/2100000.aips-bus/2188000.ethernet/net/eth1
<debug> [1505128641.249594] [../../git/src/kerneldevice/mm-kernel-device-udev.c:474] kernel_device_is_candidate(): (net/eth1): port's parent platform driver is not whitelisted
<debug> [1505128641.251127] [../../git/src/mm-base-manager.c:283] device_added(): (net/eth1): port not candidate
<debug> [1505128641.252894] [../../git/src/mm-base-manager.c:274] device_added(): (net/lo): adding device at sysfs path: /sys/devices/virtual/net/lo
<debug> [1505128641.255047] [../../git/src/mm-base-manager.c:283] device_added(): (net/lo): port not candidate
<debug> [1505128641.256896] [../../git/src/mm-base-manager.c:274] device_added(): (net/sit0): adding device at sysfs path: /sys/devices/virtual/net/sit0
<debug> [1505128641.259008] [../../git/src/kerneldevice/mm-kernel-device-udev.c:453] kernel_device_is_candidate(): (net/sit0): could not get port's parent device
<debug> [1505128641.260556] [../../git/src/mm-base-manager.c:283] device_added(): (net/sit0): port not candidate
<debug> [1505128642.396475] [../../git/src/mm-plugin-manager.c:1110] device_context_min_wait_time_elapsed(): [plugin manager] task 0: min wait time elapsed
<debug> [1505128642.399116] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Haier) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.401578] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Option) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.403970] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (X22X) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.406804] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB4] filtered by udev tags
<debug> [1505128642.409022] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra) [ttyUSB4] filtered by drivers
<debug> [1505128642.411179] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Linktop) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.413349] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (MTK) [ttyUSB4] filtered by udev tags
<debug> [1505128642.415545] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.417915] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (AnyDATA) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.420138] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Longcheer) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.422350] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttyUSB4] filtered by drivers
<debug> [1505128642.424554] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Wavecom) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.426799] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.428983] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Thuraya) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.431159] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.433461] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (SimTech) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.435707] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB4] filtered by drivers
<debug> [1505128642.438097] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Altair LTE) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.440349] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Samsung) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.442587] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Motorola) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.444778] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.447177] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Pantech) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.449436] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (ZTE) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.451716] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB4] filtered by vendor/product IDs
<debug> [1505128642.454040] [../../git/src/mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,ttyUSB4: found '7' plugins to try
<debug> [1505128642.456842] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB4: will try with plugin 'u-blox'
<debug> [1505128642.458271] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB4: will try with plugin 'Cinterion'
<debug> [1505128642.459638] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB4: will try with plugin 'Iridium'
<debug> [1505128642.461006] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB4: will try with plugin 'Telit'
<debug> [1505128642.462355] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB4: will try with plugin 'Nokia'
<debug> [1505128642.463692] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB4: will try with plugin 'Via CBP7'
<debug> [1505128642.465039] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB4: will try with plugin 'Generic'
<debug> [1505128642.466662] [../../git/src/mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,ttyUSB4: started
<debug> [1505128642.468044] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB4: checking with plugin 'u-blox'
<debug> [1505128642.469690] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (u-blox) [ttyUSB4] probe required: 'at, at-vendor'
<debug> [1505128642.471165] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB4) launching port probing: 'at, at-vendor'
<debug> [1505128642.472674] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Haier) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.474102] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Option) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.476435] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (X22X) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.477814] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB3] filtered by udev tags
<debug> [1505128642.479204] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra) [ttyUSB3] filtered by drivers
<debug> [1505128642.480536] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Linktop) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.481900] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (MTK) [ttyUSB3] filtered by udev tags
<debug> [1505128642.483239] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.484577] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (AnyDATA) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.485927] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Longcheer) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.487466] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttyUSB3] filtered by drivers
<debug> [1505128642.488884] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Wavecom) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.490254] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.491641] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Thuraya) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.493019] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.494418] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (SimTech) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.495788] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB3] filtered by drivers
<debug> [1505128642.498220] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Altair LTE) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.499708] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Samsung) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.501117] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Motorola) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.502532] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.503922] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Pantech) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.505327] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (ZTE) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.506852] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB3] filtered by vendor/product IDs
<debug> [1505128642.508249] [../../git/src/mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,ttyUSB3: found '7' plugins to try
<debug> [1505128642.509654] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB3: will try with plugin 'u-blox'
<debug> [1505128642.511174] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB3: will try with plugin 'Cinterion'
<debug> [1505128642.512446] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB3: will try with plugin 'Iridium'
<debug> [1505128642.513757] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB3: will try with plugin 'Telit'
<debug> [1505128642.515028] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB3: will try with plugin 'Nokia'
<debug> [1505128642.516466] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB3: will try with plugin 'Via CBP7'
<debug> [1505128642.517768] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB3: will try with plugin 'Generic'
<debug> [1505128642.519094] [../../git/src/mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,ttyUSB3: started
<debug> [1505128642.520398] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB3: checking with plugin 'u-blox'
<debug> [1505128642.521858] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (u-blox) [ttyUSB3] probe required: 'at, at-vendor'
<debug> [1505128642.523307] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB3) launching port probing: 'at, at-vendor'
<debug> [1505128642.524807] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Haier) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.526201] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Option) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.527790] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (X22X) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.529172] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB2] filtered by udev tags
<debug> [1505128642.530549] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra) [ttyUSB2] filtered by drivers
<debug> [1505128642.531930] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Linktop) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.533316] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (MTK) [ttyUSB2] filtered by udev tags
<debug> [1505128642.534742] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.536140] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (AnyDATA) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.537639] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Longcheer) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.539054] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttyUSB2] filtered by drivers
<debug> [1505128642.540463] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Wavecom) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.541866] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.543250] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Thuraya) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.544680] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.546100] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (SimTech) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.547655] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB2] filtered by drivers
<debug> [1505128642.549051] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Altair LTE) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.550479] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Samsung) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.552057] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Motorola) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.553385] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.554677] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Pantech) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.555957] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (ZTE) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.557306] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB2] filtered by vendor/product IDs
<debug> [1505128642.558655] [../../git/src/mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,ttyUSB2: found '7' plugins to try
<debug> [1505128642.559940] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB2: will try with plugin 'u-blox'
<debug> [1505128642.561224] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB2: will try with plugin 'Cinterion'
<debug> [1505128642.562491] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB2: will try with plugin 'Iridium'
<debug> [1505128642.564719] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB2: will try with plugin 'Telit'
<debug> [1505128642.566041] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB2: will try with plugin 'Nokia'
<debug> [1505128642.567452] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB2: will try with plugin 'Via CBP7'
<debug> [1505128642.568821] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB2: will try with plugin 'Generic'
<debug> [1505128642.570191] [../../git/src/mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,ttyUSB2: started
<debug> [1505128642.571535] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB2: checking with plugin 'u-blox'
<debug> [1505128642.573079] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (u-blox) [ttyUSB2] probe required: 'at, at-vendor'
<debug> [1505128642.574600] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at, at-vendor'
<debug> [1505128642.576100] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Haier) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.577632] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Option) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.579066] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (X22X) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.580512] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB1] filtered by udev tags
<debug> [1505128642.581935] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra) [ttyUSB1] filtered by drivers
<debug> [1505128642.583331] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Linktop) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.584727] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (MTK) [ttyUSB1] filtered by udev tags
<debug> [1505128642.587247] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.588707] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (AnyDATA) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.590141] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Longcheer) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.591597] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttyUSB1] filtered by drivers
<debug> [1505128642.593129] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Wavecom) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.594439] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.595751] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Thuraya) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.597082] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.598403] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (SimTech) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.599683] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB1] filtered by drivers
<debug> [1505128642.600969] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Altair LTE) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.602282] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Samsung) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.603614] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Motorola) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.604898] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.606174] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Pantech) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.607730] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (ZTE) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.609075] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB1] filtered by vendor/product IDs
<debug> [1505128642.610420] [../../git/src/mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,ttyUSB1: found '7' plugins to try
<debug> [1505128642.611735] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'u-blox'
<debug> [1505128642.613086] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Cinterion'
<debug> [1505128642.614420] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Iridium'
<debug> [1505128642.615753] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Telit'
<debug> [1505128642.617225] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Nokia'
<debug> [1505128642.618614] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Via CBP7'
<debug> [1505128642.619934] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Generic'
<debug> [1505128642.621317] [../../git/src/mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,ttyUSB1: started
<debug> [1505128642.622665] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'u-blox'
<debug> [1505128642.624202] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (u-blox) [ttyUSB1] probe required: 'at, at-vendor'
<debug> [1505128642.625691] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at, at-vendor'
<debug> [1505128642.627253] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Haier) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.628701] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Option) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.630101] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (X22X) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.631484] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB0] filtered by udev tags
<debug> [1505128642.632990] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra) [ttyUSB0] filtered by drivers
<debug> [1505128642.634285] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Linktop) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.635602] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (MTK) [ttyUSB0] filtered by udev tags
<debug> [1505128642.636918] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.638257] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (AnyDATA) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.639592] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Longcheer) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.640945] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttyUSB0] filtered by drivers
<debug> [1505128642.642284] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Wavecom) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.643579] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.644871] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Thuraya) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.646209] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.647661] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (SimTech) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.649054] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB0] filtered by drivers
<debug> [1505128642.650393] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Altair LTE) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.652722] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Samsung) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.654085] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Motorola) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.655423] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.656896] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Pantech) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.658262] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (ZTE) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.659658] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB0] filtered by vendor/product IDs
<debug> [1505128642.661055] [../../git/src/mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,ttyUSB0: found '7' plugins to try
<debug> [1505128642.662401] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'u-blox'
<debug> [1505128642.663761] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Cinterion'
<debug> [1505128642.665097] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Iridium'
<debug> [1505128642.666499] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Telit'
<debug> [1505128642.667891] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Nokia'
<debug> [1505128642.669249] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Via CBP7'
<debug> [1505128642.670655] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Generic'
<debug> [1505128642.672251] [../../git/src/mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,ttyUSB0: started
<debug> [1505128642.674775] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'u-blox'
<debug> [1505128642.676502] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (u-blox) [ttyUSB0] probe required: 'at, at-vendor'
<debug> [1505128642.677964] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at, at-vendor'
<debug> [1505128642.679487] [../../git/src/mm-plugin-manager.c:1110] device_context_min_wait_time_elapsed(): [plugin manager] task 1: min wait time elapsed
<debug> [1505128642.680901] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Haier) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.682273] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Option) [ttymxc1] filtered by drivers
<debug> [1505128642.683599] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (X22X) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.684937] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttymxc1] filtered by udev tags
<debug> [1505128642.686261] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra) [ttymxc1] filtered by drivers
<debug> [1505128642.687761] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Linktop) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.689155] [../../git/src/mm-plugin.c:429] apply_pre_probing_filters(): (MTK) [ttymxc1] filtered by udev tags
<debug> [1505128642.690538] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel LTE) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.691921] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (AnyDATA) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.693302] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Longcheer) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.694687] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttymxc1] filtered by drivers
<debug> [1505128642.696062] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Wavecom) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.697538] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.698922] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Thuraya) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.700355] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Novatel) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.701737] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (SimTech) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.703102] [../../git/src/mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttymxc1] filtered by drivers
<debug> [1505128642.704504] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Altair LTE) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.705909] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Samsung) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.707427] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Motorola) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.708826] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.710210] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Pantech) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.711619] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (ZTE) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.713003] [../../git/src/mm-plugin.c:376] apply_pre_probing_filters(): (Nokia (Icera)) [ttymxc1] filtered by vendor/product IDs
<debug> [1505128642.714439] [../../git/src/mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 1,ttymxc1: found '7' plugins to try
<debug> [1505128642.715949] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 1,ttymxc1: will try with plugin 'u-blox'
<debug> [1505128642.717342] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 1,ttymxc1: will try with plugin 'Cinterion'
<debug> [1505128642.718668] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 1,ttymxc1: will try with plugin 'Iridium'
<debug> [1505128642.719923] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 1,ttymxc1: will try with plugin 'Telit'
<debug> [1505128642.721201] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 1,ttymxc1: will try with plugin 'Nokia'
<debug> [1505128642.722469] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 1,ttymxc1: will try with plugin 'Via CBP7'
<debug> [1505128642.723747] [../../git/src/mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 1,ttymxc1: will try with plugin 'Generic'
<debug> [1505128642.725077] [../../git/src/mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 1,ttymxc1: started
<debug> [1505128642.726418] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,ttymxc1: checking with plugin 'u-blox'
<debug> [1505128642.727932] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (u-blox) [ttymxc1] probe required: 'at, at-vendor'
<debug> [1505128642.729391] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttymxc1) launching port probing: 'at, at-vendor'
<debug> [1505128642.732961] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB4) opening serial port...
<debug> [1505128642.735829] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB4): setting up baudrate: 57600
<debug> [1505128642.737504] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128642.739125] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB4) device open count is 1 (open)
<debug> [1505128642.740854] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128642.743197] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB3) opening serial port...
<debug> [1505128642.745905] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB3): setting up baudrate: 57600
<debug> [1505128642.748547] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB3): port attributes not fully set
<debug> [1505128642.750101] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 1 (open)
<debug> [1505128642.751717] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB3): port attributes not fully set
<debug> [1505128642.754046] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB2) opening serial port...
<debug> [1505128642.756359] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB2): setting up baudrate: 57600
<debug> [1505128642.757891] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128642.759471] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1505128642.761012] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128642.763373] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB1) opening serial port...
<debug> [1505128642.765672] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB1): setting up baudrate: 57600
<debug> [1505128642.767339] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB1): port attributes not fully set
<debug> [1505128642.768892] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
<debug> [1505128642.770468] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB1): port attributes not fully set
<debug> [1505128642.773013] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB0) opening serial port...
<debug> [1505128642.776676] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB0): setting up baudrate: 57600
<debug> [1505128642.779506] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB0): port attributes not fully set
<debug> [1505128642.781156] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
<debug> [1505128642.782674] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB0): port attributes not fully set
<debug> [1505128642.784857] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttymxc1) opening serial port...
<debug> [1505128642.787295] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttymxc1): setting up baudrate: 57600
<debug> [1505128642.788960] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttymxc1) device open count is 1 (open)
<debug> [1505128642.790515] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttymxc1): port attributes not fully set
<debug> [1505128642.844066] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT<CR>'
<debug> [1505128642.854670] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT<CR>'
<debug> [1505128643.061422] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- 'AT'
<debug> [1505128643.064882] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><CR><LF>OK<CR><LF>'
<debug> [1505128643.073200] [../../git/src/mm-port-probe.c:154] mm_port_probe_set_result_at(): (tty/ttyUSB3) port is AT-capable
<debug> [1505128643.075360] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT<CR>'
<debug> [1505128643.077271] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT<CR>'
<debug> [1505128643.079138] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB0): --> 'AT<CR>'
<debug> [1505128643.080869] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttymxc1): --> 'AT<CR>'
<debug> [1505128643.082561] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT+CGMI<CR>'
<debug> [1505128643.277775] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'AT'
<debug> [1505128643.279890] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><CR><LF>OK<CR><LF>'
<debug> [1505128643.281575] [../../git/src/mm-port-probe.c:154] mm_port_probe_set_result_at(): (tty/ttyUSB2) port is AT-capable
<debug> [1505128643.283677] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- 'AT'
<debug> [1505128643.286455] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>'
<debug> [1505128643.394555] [../../git/src/mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 0: min probing time elapsed
<debug> [1505128643.396270] [../../git/src/mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 5 running probes (5 active): ttyUSB4, ttyUSB3, ttyUSB2, ttyUSB1, ttyUSB0
<debug> [1505128643.451490] [../../git/src/mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 1: min probing time elapsed
<debug> [1505128643.453057] [../../git/src/mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 1: still 1 running probes (1 active): ttymxc1
<debug> [1505128643.789192] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- 'AT+CGMI'
<debug> [1505128643.791484] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><CR><LF>Quectel<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128643.793303] [../../git/src/mm-port-probe.c:181] mm_port_probe_set_result_at_vendor(): (tty/ttyUSB3) vendor probing finished
<debug> [1505128643.795021] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (u-blox) [ttyUSB3] filtered by vendor strings
<debug> [1505128643.796755] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB3: checking with plugin 'Cinterion'
<debug> [1505128643.798562] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Cinterion) [ttyUSB3] probe required: 'at, at-vendor'
<debug> [1505128643.799982] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB3) port probing finished: no more probings needed
<debug> [1505128643.801559] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 0 (close)
<debug> [1505128643.802992] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB3) closing serial port...
<debug> [1505128643.807872] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB3) serial port closed
<debug> [1505128643.809492] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB3) forced to close port
<debug> [1505128643.811225] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Cinterion) [ttyUSB3] filtered by vendor strings
<debug> [1505128643.812774] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB3: checking with plugin 'Iridium'
<debug> [1505128643.814318] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Iridium) [ttyUSB3] probe required: 'at, at-vendor, at-product'
<debug> [1505128643.815779] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB3) launching port probing: 'at-product'
<debug> [1505128643.818587] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB3) opening serial port...
<debug> [1505128643.820933] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB3): setting up baudrate: 57600
<debug> [1505128643.822455] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB3): port attributes not fully set
<debug> [1505128643.824015] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 1 (open)
<debug> [1505128643.825559] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB3): port attributes not fully set
<debug> [1505128643.827326] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGMI<CR>'
<debug> [1505128644.531980] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'AT+CGMI'
<debug> [1505128644.534762] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><CR><LF>Quectel<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128644.537156] [../../git/src/mm-port-probe.c:181] mm_port_probe_set_result_at_vendor(): (tty/ttyUSB2) vendor probing finished
<debug> [1505128644.539797] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (u-blox) [ttyUSB2] filtered by vendor strings
<debug> [1505128644.541826] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB2: checking with plugin 'Cinterion'
<debug> [1505128644.544418] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Cinterion) [ttyUSB2] probe required: 'at, at-vendor'
<debug> [1505128644.546581] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB2) port probing finished: no more probings needed
<debug> [1505128644.549200] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
<debug> [1505128644.551355] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
<debug> [1505128644.557096] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB2) serial port closed
<debug> [1505128644.559657] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB2) forced to close port
<debug> [1505128644.561872] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Cinterion) [ttyUSB2] filtered by vendor strings
<debug> [1505128644.564000] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB2: checking with plugin 'Iridium'
<debug> [1505128644.566705] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Iridium) [ttyUSB2] probe required: 'at, at-vendor, at-product'
<debug> [1505128644.569347] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at-product'
<debug> [1505128644.572935] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB2) opening serial port...
<debug> [1505128644.577056] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB2): setting up baudrate: 57600
<debug> [1505128644.579579] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128644.583220] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1505128644.586265] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128644.589169] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT+CGMM<CR>'
<debug> [1505128645.293379] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- 'AT+CGMM'
<debug> [1505128645.296627] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><CR><LF>EC21<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128645.299793] [../../git/src/mm-port-probe.c:201] mm_port_probe_set_result_at_product(): (tty/ttyUSB3) product probing finished
<debug> [1505128645.302673] [../../git/src/mm-plugin.c:526] apply_post_probing_filters(): (Iridium) [ttyUSB3] filtered by vendor/product strings
<debug> [1505128645.306472] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB3: checking with plugin 'Telit'
<debug> [1505128645.309571] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Telit) [ttyUSB3] probe required: 'at, at-vendor'
<debug> [1505128645.313019] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB3) port probing finished: no more probings needed
<debug> [1505128645.315770] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 0 (close)
<debug> [1505128645.318849] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB3) closing serial port...
<debug> [1505128645.325585] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB3) serial port closed
<debug> [1505128645.328462] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB3) forced to close port
<debug> [1505128645.331582] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Telit) [ttyUSB3] filtered by vendor strings
<debug> [1505128645.334044] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB3: checking with plugin 'Nokia'
<debug> [1505128645.336704] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Nokia) [ttyUSB3] probe required: 'at, at-vendor, at-icera'
<debug> [1505128645.339157] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB3) launching port probing: 'at-icera'
<debug> [1505128645.342841] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB3) opening serial port...
<debug> [1505128645.346941] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB3): setting up baudrate: 57600
<debug> [1505128645.349949] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB3): port attributes not fully set
<debug> [1505128645.353108] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 1 (open)
<debug> [1505128645.356234] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB3): port attributes not fully set
<debug> [1505128645.359219] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGMM<CR>'
<debug> [1505128646.063560] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'AT+CGMM'
<debug> [1505128646.067243] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><CR><LF>EC21<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128646.070038] [../../git/src/mm-port-probe.c:201] mm_port_probe_set_result_at_product(): (tty/ttyUSB2) product probing finished
<debug> [1505128646.073294] [../../git/src/mm-plugin.c:526] apply_post_probing_filters(): (Iridium) [ttyUSB2] filtered by vendor/product strings
<debug> [1505128646.076549] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB2: checking with plugin 'Telit'
<debug> [1505128646.079835] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Telit) [ttyUSB2] probe required: 'at, at-vendor'
<debug> [1505128646.082400] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB2) port probing finished: no more probings needed
<debug> [1505128646.085104] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
<debug> [1505128646.087663] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
<debug> [1505128646.094467] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB2) serial port closed
<debug> [1505128646.097069] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB2) forced to close port
<debug> [1505128646.099999] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Telit) [ttyUSB2] filtered by vendor strings
<debug> [1505128646.102497] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB2: checking with plugin 'Nokia'
<debug> [1505128646.105292] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Nokia) [ttyUSB2] probe required: 'at, at-vendor, at-icera'
<debug> [1505128646.108790] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at-icera'
<debug> [1505128646.112490] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB2) opening serial port...
<debug> [1505128646.116699] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB2): setting up baudrate: 57600
<debug> [1505128646.119734] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128646.122786] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1505128646.125562] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128646.128496] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT%IPSYS?<CR>'
<debug> [1505128647.032789] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- 'AT%IPSYS?'
<debug> [1505128647.036045] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><CR><LF>ERROR<CR><LF>'
<debug> [1505128647.040115] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1505128647.045874] [../../git/src/mm-port-probe.c:951] serial_probe_at_parse_response(): (tty/ttyUSB3) re-scheduling next command in probing group in 2 seconds...
<debug> [1505128647.049631] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT%IPSYS?<CR>'
<debug> [1505128647.952737] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'AT%IPSYS?'
<debug> [1505128647.954846] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><CR><LF>ERROR<CR><LF>'
<debug> [1505128647.956645] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1505128647.962577] [../../git/src/mm-port-probe.c:951] serial_probe_at_parse_response(): (tty/ttyUSB2) re-scheduling next command in probing group in 2 seconds...
<debug> [1505128649.008188] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT%IPSYS?<CR>'
<debug> [1505128649.913115] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- 'AT%IPSYS?'
<debug> [1505128649.915210] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><CR><LF>ERROR<CR><LF>'
<debug> [1505128649.917100] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1505128649.918721] [../../git/src/mm-port-probe.c:951] serial_probe_at_parse_response(): (tty/ttyUSB3) re-scheduling next command in probing group in 2 seconds...
<debug> [1505128650.007101] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128650.009041] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT%IPSYS?<CR>'
<debug> [1505128650.010987] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT<CR>'
<debug> [1505128650.912778] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'AT%IPSYS?'
<debug> [1505128650.914761] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><CR><LF>ERROR<CR><LF>'
<debug> [1505128650.916422] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1505128650.917934] [../../git/src/mm-port-probe.c:951] serial_probe_at_parse_response(): (tty/ttyUSB2) re-scheduling next command in probing group in 2 seconds...
<debug> [1505128651.007080] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128651.008794] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128651.010400] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128651.012248] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT<CR>'
<debug> [1505128651.013819] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB0): --> 'AT<CR>'
<debug> [1505128651.015670] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttymxc1): --> 'AT<CR>'
<debug> [1505128651.214431] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- 'AT<CR><LF>'
<debug> [1505128652.007342] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT%IPSYS?<CR>'
<debug> [1505128652.912397] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- 'AT%IPSYS?'
<debug> [1505128652.914457] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><CR><LF>ERROR<CR><LF>'
<debug> [1505128652.916102] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1505128652.917840] [../../git/src/mm-port-probe.c:226] mm_port_probe_set_result_at_icera(): (tty/ttyUSB3) Modem is probably not Icera-based
<debug> [1505128652.919356] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Nokia) [ttyUSB3] filtered by vendor strings
<debug> [1505128652.920763] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB3: checking with plugin 'Via CBP7'
<debug> [1505128652.922339] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Via CBP7) [ttyUSB3] probe required: 'at, at-vendor, at-product'
<debug> [1505128652.923882] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB3) port probing finished: no more probings needed
<debug> [1505128652.925453] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 0 (close)
<debug> [1505128652.927167] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB3) closing serial port...
<debug> [1505128652.932443] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB3) serial port closed
<debug> [1505128652.934118] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB3) forced to close port
<debug> [1505128652.936061] [../../git/src/mm-plugin.c:526] apply_post_probing_filters(): (Via CBP7) [ttyUSB3] filtered by vendor/product strings
<debug> [1505128652.937809] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB3: checking with plugin 'Generic'
<debug> [1505128652.939437] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Generic) [ttyUSB3] probe required: 'at, qcdm'
<debug> [1505128652.940937] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB3) port probing finished: no more probings needed
<debug> [1505128652.942808] [../../git/src/mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyUSB3: found best plugin for port (Generic)
<debug> [1505128652.944268] [../../git/src/mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyUSB3: finished in '12.012299' seconds
<debug> [1505128652.945807] [../../git/src/mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 4 running probes (4 active): ttyUSB4, ttyUSB2, ttyUSB1, ttyUSB0
<debug> [1505128653.007340] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT%IPSYS?<CR>'
<debug> [1505128653.136531] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Sending command failed: 'Resource temporarily unavailable''
<debug> [1505128653.138723] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB4: checking with plugin 'Cinterion'
<debug> [1505128653.140380] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Cinterion) [ttyUSB4] probe required: 'at, at-vendor'
<debug> [1505128653.141909] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB4) launching port probing: 'at, at-vendor'
<debug> [1505128653.143505] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB4) device open count is 0 (close)
<debug> [1505128653.144971] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB4) closing serial port...
<debug> [1505128653.150157] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB4) serial port closed
<debug> [1505128653.151782] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB4) forced to close port
<debug> [1505128653.911420] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'AT%IPSYS?'
<debug> [1505128653.913460] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><CR><LF>ERROR<CR><LF>'
<debug> [1505128653.915097] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1505128653.916895] [../../git/src/mm-port-probe.c:226] mm_port_probe_set_result_at_icera(): (tty/ttyUSB2) Modem is probably not Icera-based
<debug> [1505128653.918451] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Nokia) [ttyUSB2] filtered by vendor strings
<debug> [1505128653.919917] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB2: checking with plugin 'Via CBP7'
<debug> [1505128653.921528] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Via CBP7) [ttyUSB2] probe required: 'at, at-vendor, at-product'
<debug> [1505128653.923028] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB2) port probing finished: no more probings needed
<debug> [1505128653.925550] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
<debug> [1505128653.928143] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
<debug> [1505128653.933186] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB2) serial port closed
<debug> [1505128653.934839] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB2) forced to close port
<debug> [1505128653.938820] [../../git/src/mm-plugin.c:526] apply_post_probing_filters(): (Via CBP7) [ttyUSB2] filtered by vendor/product strings
<debug> [1505128653.940345] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB2: checking with plugin 'Generic'
<debug> [1505128653.941971] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Generic) [ttyUSB2] probe required: 'at, qcdm'
<debug> [1505128653.943486] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB2) port probing finished: no more probings needed
<debug> [1505128653.945198] [../../git/src/mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyUSB2: found best plugin for port (Generic)
<debug> [1505128653.946885] [../../git/src/mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyUSB2: finished in '13.026145' seconds
<debug> [1505128653.948559] [../../git/src/mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 0,ttyUSB2: best plugin matches device reported one: Generic
<debug> [1505128653.949982] [../../git/src/mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 3 running probes (3 active): ttyUSB4, ttyUSB1, ttyUSB0
<debug> [1505128653.952379] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB4) opening serial port...
<debug> [1505128653.955076] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB4): setting up baudrate: 57600
<debug> [1505128653.956654] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128653.962434] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB4) device open count is 1 (open)
<debug> [1505128653.964001] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128654.066952] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT^SQPORT?<CR>'
<debug> [1505128657.387460] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT<CR>'
<debug> [1505128658.007675] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128658.010534] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128658.013191] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128658.016874] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT<CR>'
<debug> [1505128658.019833] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB0): --> 'AT<CR>'
<debug> [1505128658.022975] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttymxc1): --> 'AT<CR>'
<debug> [1505128658.220002] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- 'AT'
<debug> [1505128658.222135] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>'
<debug> [1505128660.303681] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Sending command failed: 'Resource temporarily unavailable''
<debug> [1505128660.306787] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB4: checking with plugin 'Iridium'
<debug> [1505128660.309526] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Iridium) [ttyUSB4] probe required: 'at, at-vendor, at-product'
<debug> [1505128660.312162] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB4) launching port probing: 'at, at-vendor, at-product'
<debug> [1505128660.314901] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB4) device open count is 0 (close)
<debug> [1505128660.317592] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB4) closing serial port...
<debug> [1505128660.325248] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB4) serial port closed
<debug> [1505128660.328426] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB4) forced to close port
<debug> [1505128660.332880] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB4) opening serial port...
<debug> [1505128660.336949] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB4): setting up baudrate: 57600
<debug> [1505128660.339539] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128660.342203] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB4) device open count is 1 (open)
<debug> [1505128660.344903] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128660.448716] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT<CR>'
<debug> [1505128664.009683] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128664.012735] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT<CR>'
<debug> [1505128665.007273] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128665.009769] [../../git/src/mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB1) port is not AT-capable
<debug> [1505128665.012062] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (u-blox) [ttyUSB1] filtered by vendor strings
<debug> [1505128665.014301] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'Cinterion'
<debug> [1505128665.017012] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Cinterion) [ttyUSB1] probe required: 'at, at-vendor'
<debug> [1505128665.019457] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB1) port probing finished: no more probings needed
<debug> [1505128665.022052] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
<debug> [1505128665.024427] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
<debug> [1505128665.031203] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB1) serial port closed
<debug> [1505128665.033857] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB1) forced to close port
<debug> [1505128665.036804] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128665.039221] [../../git/src/mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is not AT-capable
<debug> [1505128665.041653] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (u-blox) [ttyUSB0] filtered by vendor strings
<debug> [1505128665.044039] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'Cinterion'
<debug> [1505128665.047238] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Cinterion) [ttyUSB0] probe required: 'at, at-vendor'
<debug> [1505128665.049704] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB0) port probing finished: no more probings needed
<debug> [1505128665.052365] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 0 (close)
<debug> [1505128665.054801] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB0) closing serial port...
<debug> [1505128665.059402] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB0) serial port closed
<debug> [1505128665.063542] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB0) forced to close port
<debug> [1505128665.067914] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128665.069602] [../../git/src/mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttymxc1) port is not AT-capable
<debug> [1505128665.071292] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (u-blox) [ttymxc1] filtered by vendor strings
<debug> [1505128665.072913] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,ttymxc1: checking with plugin 'Cinterion'
<debug> [1505128665.074675] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Cinterion) [ttymxc1] probe required: 'at, at-vendor'
<debug> [1505128665.076586] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttymxc1) port probing finished: no more probings needed
<debug> [1505128665.078446] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttymxc1) device open count is 0 (close)
<debug> [1505128665.080102] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttymxc1) closing serial port...
<debug> [1505128665.086770] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttymxc1) serial port closed
<debug> [1505128665.088505] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttymxc1) forced to close port
<debug> [1505128665.090295] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Cinterion) [ttyUSB1] filtered by vendor strings
<debug> [1505128665.091875] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'Iridium'
<debug> [1505128665.093622] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Iridium) [ttyUSB1] probe required: 'at, at-vendor, at-product'
<debug> [1505128665.095230] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB1) port probing finished: no more probings needed
<debug> [1505128665.097154] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Cinterion) [ttyUSB0] filtered by vendor strings
<debug> [1505128665.098785] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'Iridium'
<debug> [1505128665.100562] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Iridium) [ttyUSB0] probe required: 'at, at-vendor, at-product'
<debug> [1505128665.102181] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB0) port probing finished: no more probings needed
<debug> [1505128665.103920] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Cinterion) [ttymxc1] filtered by vendor strings
<debug> [1505128665.105509] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,ttymxc1: checking with plugin 'Iridium'
<debug> [1505128665.107461] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Iridium) [ttymxc1] probe required: 'at, at-vendor, at-product'
<debug> [1505128665.109109] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttymxc1) port probing finished: no more probings needed
<debug> [1505128665.110960] [../../git/src/mm-plugin.c:503] apply_post_probing_filters(): (Iridium) [ttyUSB1] filtered as no vendor/product strings given
<debug> [1505128665.112614] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'Telit'
<debug> [1505128665.114388] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Telit) [ttyUSB1] probe required: 'at, at-vendor'
<debug> [1505128665.116028] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB1) port probing finished: no more probings needed
<debug> [1505128665.118073] [../../git/src/mm-plugin.c:503] apply_post_probing_filters(): (Iridium) [ttyUSB0] filtered as no vendor/product strings given
<debug> [1505128665.119763] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'Telit'
<debug> [1505128665.121590] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Telit) [ttyUSB0] probe required: 'at, at-vendor'
<debug> [1505128665.123282] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB0) port probing finished: no more probings needed
<debug> [1505128665.125123] [../../git/src/mm-plugin.c:503] apply_post_probing_filters(): (Iridium) [ttymxc1] filtered as no vendor/product strings given
<debug> [1505128665.126880] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,ttymxc1: checking with plugin 'Telit'
<debug> [1505128665.128645] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Telit) [ttymxc1] probe required: 'at, at-vendor'
<debug> [1505128665.130285] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttymxc1) port probing finished: no more probings needed
<debug> [1505128665.132161] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Telit) [ttyUSB1] filtered by vendor strings
<debug> [1505128665.133824] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'Nokia'
<debug> [1505128665.135572] [../../git/src/mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB1] not setting up AT probing tasks: modem already has the expected single AT port
<debug> [1505128665.137781] [../../git/src/mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB1) port is not AT-capable
<debug> [1505128665.139218] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Nokia) [ttyUSB1] probe required: 'at, at-vendor, at-icera'
<debug> [1505128665.140594] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB1) port probing finished: no more probings needed
<debug> [1505128665.142195] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Telit) [ttyUSB0] filtered by vendor strings
<debug> [1505128665.143635] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'Nokia'
<debug> [1505128665.145175] [../../git/src/mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB0] not setting up AT probing tasks: modem already has the expected single AT port
<debug> [1505128665.146592] [../../git/src/mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is not AT-capable
<debug> [1505128665.148013] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Nokia) [ttyUSB0] probe required: 'at, at-vendor, at-icera'
<debug> [1505128665.149417] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB0) port probing finished: no more probings needed
<debug> [1505128665.150964] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Telit) [ttymxc1] filtered by vendor strings
<debug> [1505128665.152411] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,ttymxc1: checking with plugin 'Nokia'
<debug> [1505128665.153966] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Nokia) [ttymxc1] probe required: 'at, at-vendor, at-icera'
<debug> [1505128665.155391] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttymxc1) port probing finished: no more probings needed
<debug> [1505128665.157143] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Nokia) [ttyUSB1] filtered by vendor strings
<debug> [1505128665.158672] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'Via CBP7'
<debug> [1505128665.160264] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Via CBP7) [ttyUSB1] probe required: 'at, at-vendor, at-product'
<debug> [1505128665.161731] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB1) port probing finished: no more probings needed
<debug> [1505128665.163320] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Nokia) [ttyUSB0] filtered by vendor strings
<debug> [1505128665.164841] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'Via CBP7'
<debug> [1505128665.166534] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Via CBP7) [ttyUSB0] probe required: 'at, at-vendor, at-product'
<debug> [1505128665.168079] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB0) port probing finished: no more probings needed
<debug> [1505128665.169691] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Nokia) [ttymxc1] filtered by vendor strings
<debug> [1505128665.171150] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,ttymxc1: checking with plugin 'Via CBP7'
<debug> [1505128665.172733] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Via CBP7) [ttymxc1] probe required: 'at, at-vendor, at-product'
<debug> [1505128665.175164] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttymxc1) port probing finished: no more probings needed
<debug> [1505128665.177913] [../../git/src/mm-plugin.c:503] apply_post_probing_filters(): (Via CBP7) [ttyUSB1] filtered as no vendor/product strings given
<debug> [1505128665.179440] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'Generic'
<debug> [1505128665.181180] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Generic) [ttyUSB1] probe required: 'at, qcdm'
<debug> [1505128665.182654] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'qcdm'
<debug> [1505128665.184219] [../../git/src/mm-plugin.c:503] apply_post_probing_filters(): (Via CBP7) [ttyUSB0] filtered as no vendor/product strings given
<debug> [1505128665.185631] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'Generic'
<debug> [1505128665.187217] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Generic) [ttyUSB0] probe required: 'at, qcdm'
<debug> [1505128665.188661] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'qcdm'
<debug> [1505128665.190246] [../../git/src/mm-plugin.c:503] apply_post_probing_filters(): (Via CBP7) [ttymxc1] filtered as no vendor/product strings given
<debug> [1505128665.191667] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 1,ttymxc1: checking with plugin 'Generic'
<debug> [1505128665.193213] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Generic) [ttymxc1] probe required: 'at, qcdm'
<debug> [1505128665.194693] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttymxc1) launching port probing: 'qcdm'
<debug> [1505128665.196519] [../../git/src/mm-port-probe.c:690] serial_probe_qcdm(): (tty/ttyUSB1) probing QCDM...
<debug> [1505128665.198439] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB1) opening serial port...
<debug> [1505128665.201264] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
<debug> [1505128665.202896] [../../git/src/mm-port-probe.c:690] serial_probe_qcdm(): (tty/ttyUSB0) probing QCDM...
<debug> [1505128665.204554] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB0) opening serial port...
<debug> [1505128665.207276] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
<debug> [1505128665.208958] [../../git/src/mm-port-probe.c:690] serial_probe_qcdm(): (tty/ttymxc1) probing QCDM...
<debug> [1505128665.210631] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttymxc1) opening serial port...
<debug> [1505128665.213306] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttymxc1) device open count is 1 (open)
<debug> [1505128665.215469] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB1): --> 7e 00 78 f0 7e
<debug> [1505128665.217296] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 7e 00 78 f0 7e
<debug> [1505128665.219261] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttymxc1): --> 7e 00 78 f0 7e
<debug> [1505128665.221301] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB1): <-- 7e 5e 40 78 f0 7e
<debug> [1505128665.222914] [../../git/src/mm-port-probe.c:637] serial_probe_qcdm_parse_response(): QCDM parsing error: Failed to unescape QCDM packet
<debug> [1505128665.224438] [../../git/src/mm-port-probe.c:260] mm_port_probe_set_result_qcdm(): (tty/ttyUSB1) port is not QCDM-capable
<debug> [1505128665.225923] [../../git/src/mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyUSB1: found best plugin for port (Generic)
<debug> [1505128665.227566] [../../git/src/mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyUSB1: finished in '24.318019' seconds
<debug> [1505128665.229064] [../../git/src/mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 0,ttyUSB1: best plugin matches device reported one: Generic
<debug> [1505128665.230570] [../../git/src/mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 2 running probes (2 active): ttyUSB4, ttyUSB0
<debug> [1505128665.232249] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
<debug> [1505128665.233902] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
<debug> [1505128665.238826] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB1) serial port closed
<debug> [1505128665.240333] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB1) forced to close port
<debug> [1505128665.241958] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 13 60 0d 0a 5e 40 5e 41 54 0d 41 54 0d 41 54 0d 00 78 f0 7d 5e d7 5d 7e
<warn> [1505128665.244429] [../../git/src/mm-port-probe.c:627] serial_probe_qcdm_parse_response(): (tty/ttyUSB0) failed to parse QCDM version info command result: -7
<debug> [1505128665.246207] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 7e 00 78 f0 7e
<debug> [1505128665.249830] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 00 4a 61 6e 20 20 35 20 32 30 31 37 31 39 3a 31 39 3a 35 35 4e 6f 76 20 33 30 20 32 30 31 36 30 34 3a 30 30 3a 30 30 39 36 30 37 2e 67 65 6e 3a 09 ff 64 00 02 00 48 23 32 7e
<debug> [1505128665.252108] [../../git/src/mm-port-probe.c:242] mm_port_probe_set_result_qcdm(): (tty/ttyUSB0) port is QCDM-capable
<debug> [1505128665.253615] [../../git/src/mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyUSB0: found best plugin for port (Generic)
<debug> [1505128665.255056] [../../git/src/mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyUSB0: finished in '24.356421' seconds
<debug> [1505128665.256523] [../../git/src/mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 0,ttyUSB0: best plugin matches device reported one: Generic
<debug> [1505128665.257933] [../../git/src/mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 1 running probes (1 active): ttyUSB4
<debug> [1505128665.259475] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 0 (close)
<debug> [1505128665.260954] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB0) closing serial port...
<debug> [1505128665.263366] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB0) serial port closed
<debug> [1505128665.264949] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB0) forced to close port
<debug> [1505128667.105980] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Sending command failed: 'Resource temporarily unavailable''
<debug> [1505128667.113464] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB4: checking with plugin 'Telit'
<debug> [1505128667.116193] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Telit) [ttyUSB4] probe required: 'at, at-vendor'
<debug> [1505128667.119167] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB4) launching port probing: 'at, at-vendor'
<debug> [1505128667.121984] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB4) device open count is 0 (close)
<debug> [1505128667.124533] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB4) closing serial port...
<debug> [1505128667.131809] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB4) serial port closed
<debug> [1505128667.134675] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB4) forced to close port
<debug> [1505128667.141672] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB4) opening serial port...
<debug> [1505128667.146040] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB4): setting up baudrate: 57600
<debug> [1505128667.149021] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128667.151783] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB4) device open count is 1 (open)
<debug> [1505128667.154644] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB4): port attributes not fully set
<debug> [1505128667.267675] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT<CR>'
<debug> [1505128668.007934] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttymxc1): --> 7e 00 78 f0 7e
<debug> [1505128671.010133] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1505128671.012891] [../../git/src/mm-port-probe.c:260] mm_port_probe_set_result_qcdm(): (tty/ttymxc1) port is not QCDM-capable
<debug> [1505128671.015250] [../../git/src/mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 1,ttymxc1: found best plugin for port (Generic)
<debug> [1505128671.017897] [../../git/src/mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 1,ttymxc1: finished in '30.064473' seconds
<debug> [1505128671.020331] [../../git/src/mm-plugin-manager.c:979] device_context_continue(): [plugin manager] task 1: no more ports to probe
<debug> [1505128671.022624] [../../git/src/mm-plugin-manager.c:813] device_context_complete(): [plugin manager] task 1: finished in '30.072697' seconds
<info> [1505128671.025226] [../../git/src/mm-device.c:385] mm_device_create_modem(): [device Digi XBee Cellular] creating modem with plugin 'Generic' and '1' ports
<warn> [1505128671.048993] [../../git/src/mm-plugin.c:948] mm_plugin_create_modem(): Could not grab port (tty/ttymxc1): 'Cannot add port 'tty/ttymxc1', unhandled serial type'
<debug> [1505128671.051864] [../../git/src/mm-base-modem.c:1409] finalize(): Modem (Generic) 'Digi XBee Cellular' completely disposed
<warn> [1505128671.054297] [../../git/src/mm-base-manager.c:185] device_support_check_ready(): Couldn't create modem for device 'Digi XBee Cellular': Failed to find primary AT port
<debug> [1505128671.057345] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttymxc1) device open count is 0 (close)
<debug> [1505128671.059842] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttymxc1) closing serial port...
<debug> [1505128671.066903] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttymxc1) serial port closed
<debug> [1505128671.069545] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttymxc1) forced to close port
<debug> [1505128671.072380] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB4): --> 'AT<CR>'
<debug> [1505128674.088653] [../../git/src/mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Sending command failed: 'Resource temporarily unavailable''
<debug> [1505128674.091565] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB4: checking with plugin 'Nokia'
<debug> [1505128674.094230] [../../git/src/mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB4] not setting up AT probing tasks: modem already has the expected single AT port
<debug> [1505128674.096828] [../../git/src/mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB4) port is not AT-capable
<debug> [1505128674.099392] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Nokia) [ttyUSB4] probe required: 'at, at-vendor, at-icera'
<debug> [1505128674.101926] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB4) port probing finished: no more probings needed
<debug> [1505128674.104672] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB4) device open count is 0 (close)
<debug> [1505128674.107487] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB4) closing serial port...
<debug> [1505128674.114860] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB4) serial port closed
<debug> [1505128674.118138] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB4) forced to close port
<debug> [1505128674.120957] [../../git/src/mm-plugin.c:478] apply_post_probing_filters(): (Nokia) [ttyUSB4] filtered by vendor strings
<debug> [1505128674.123558] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB4: checking with plugin 'Via CBP7'
<debug> [1505128674.126703] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Via CBP7) [ttyUSB4] probe required: 'at, at-vendor, at-product'
<debug> [1505128674.129743] [../../git/src/mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB4) port probing finished: no more probings needed
<debug> [1505128674.132422] [../../git/src/mm-plugin.c:503] apply_post_probing_filters(): (Via CBP7) [ttyUSB4] filtered as no vendor/product strings given
<debug> [1505128674.134784] [../../git/src/mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB4: checking with plugin 'Generic'
<debug> [1505128674.137615] [../../git/src/mm-plugin.c:803] mm_plugin_supports_port(): (Generic) [ttyUSB4] probe required: 'at, qcdm'
<debug> [1505128674.140017] [../../git/src/mm-port-probe.c:1395] mm_port_probe_run(): (tty/ttyUSB4) launching port probing: 'qcdm'
<debug> [1505128674.142654] [../../git/src/mm-port-probe.c:690] serial_probe_qcdm(): (tty/ttyUSB4) probing QCDM...
<debug> [1505128674.145499] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB4) opening serial port...
<debug> [1505128674.149899] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB4) device open count is 1 (open)
<debug> [1505128674.152724] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB4): --> 7e 00 78 f0 7e
<debug> [1505128677.007637] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB4): --> 7e 00 78 f0 7e
<debug> [1505128680.009770] [../../git/src/mm-port-probe.c:260] mm_port_probe_set_result_qcdm(): (tty/ttyUSB4) port is not QCDM-capable
<debug> [1505128680.012375] [../../git/src/mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyUSB4: found best plugin for port (Generic)
<debug> [1505128680.014719] [../../git/src/mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyUSB4: finished in '39.072218' seconds
<debug> [1505128680.017499] [../../git/src/mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 0,ttyUSB4: best plugin matches device reported one: Generic
<debug> [1505128680.019915] [../../git/src/mm-plugin-manager.c:979] device_context_continue(): [plugin manager] task 0: no more ports to probe
<debug> [1505128680.022251] [../../git/src/mm-plugin-manager.c:813] device_context_complete(): [plugin manager] task 0: finished in '39.129411' seconds
<info> [1505128680.024944] [../../git/src/mm-device.c:385] mm_device_create_modem(): [device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3] creating modem with plugin 'Generic' and '5' ports
<warn> [1505128680.031915] [../../git/src/mm-plugin.c:948] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB4): 'Cannot add port 'tty/ttyUSB4', unhandled serial type'
<debug> [1505128680.036173] [../../git/src/mm-base-modem.c:292] mm_base_modem_grab_port(): (ttyUSB3) type 'at' claimed by /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128680.040726] [../../git/src/mm-base-modem.c:292] mm_base_modem_grab_port(): (ttyUSB2) type 'at' claimed by /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<warn> [1505128680.043635] [../../git/src/mm-plugin.c:948] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type'
<debug> [1505128680.046997] [../../git/src/mm-base-modem.c:292] mm_base_modem_grab_port(): (ttyUSB0) type 'qcdm' claimed by /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3
<debug> [1505128680.049792] [../../git/src/mm-base-modem.c:893] log_port(): (/sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3) tty/ttyUSB2 at (primary)
<debug> [1505128680.052254] [../../git/src/mm-base-modem.c:893] log_port(): (/sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3) tty/ttyUSB3 at (secondary)
<debug> [1505128680.054662] [../../git/src/mm-base-modem.c:893] log_port(): (/sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3) tty/ttyUSB2 data (primary)
<debug> [1505128680.057577] [../../git/src/mm-base-modem.c:893] log_port(): (/sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3) tty/ttyUSB0 qcdm
<debug> [1505128680.069255] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB2) opening serial port...
<debug> [1505128680.073495] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB2): setting up baudrate: 57600
<debug> [1505128680.075833] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128680.078660] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1505128680.081027] [../../git/src/mm-port-serial-at.c:495] mm_port_serial_at_run_init_sequence(): (ttyUSB2): running init sequence...
<debug> [1505128680.083774] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128680.088027] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<info> [1505128680.091286] [../../git/src/mm-base-manager.c:194] device_support_check_ready(): Modem for device '/sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3' successfully created
<debug> [1505128680.092922] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB4) device open count is 0 (close)
<debug> [1505128680.094362] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB4) closing serial port...
<debug> [1505128680.099325] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB4) serial port closed
<debug> [1505128680.100901] [../../git/src/mm-port-serial.c:1433] port_serial_close_force(): (ttyUSB4) forced to close port
<debug> [1505128680.117187] [../../git/src/mm-broadband-modem.c:747] modem_load_current_capabilities(): loading current capabilities...
<debug> [1505128680.119425] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB0) opening serial port...
<debug> [1505128680.122132] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
<debug> [1505128680.124439] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
<debug> [1505128680.127175] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 26 0a 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 b2 37 7e
<debug> [1505128680.131561] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 26 0a 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 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4f 52 7e
<debug> [1505128680.133343] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
<debug> [1505128680.137068] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'ATE0'
<debug> [1505128680.139106] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR>'
<debug> [1505128680.141203] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.143091] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATV1<CR>'
<debug> [1505128680.151467] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.153384] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
<debug> [1505128680.167732] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.169561] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATX4<CR>'
<debug> [1505128680.177625] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.179468] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT&C1<CR>'
<debug> [1505128680.188858] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.190683] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
<debug> [1505128680.198875] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.200640] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
<debug> [1505128680.202224] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
<debug> [1505128680.218630] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.220445] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.222059] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
<debug> [1505128680.234673] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+GCAP: +CGSM<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.239925] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.241817] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.243752] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+WS46=?<CR>'
<debug> [1505128680.262571] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+WS46: (12,22,25,28,29)<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.270175] [../../git/src/mm-broadband-modem.c:375] modem_load_current_capabilities_finish(): loaded current capabilities: gsm-umts, lte
<debug> [1505128680.271974] [../../git/src/mm-iface-modem.c:3912] load_current_capabilities_ready(): Setting EPS network as supported
<debug> [1505128680.274204] [../../git/src/mm-iface-modem.c:4393] interface_initialization_step(): Modem allows up to 1 bearers
<debug> [1505128680.275904] [../../git/src/mm-bearer-list.c:272] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
<debug> [1505128680.278444] [../../git/src/mm-broadband-modem.c:807] modem_load_manufacturer(): loading manufacturer...
<debug> [1505128680.280242] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.282052] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 0 (close)
<debug> [1505128680.283678] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB0) closing serial port...
<debug> [1505128680.288932] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB0) serial port closed
<debug> [1505128680.290663] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.292482] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGMI<CR>'
<debug> [1505128680.304909] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>Quectel<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.313024] [../../git/src/mm-broadband-modem.c:791] modem_load_manufacturer_finish(): loaded manufacturer: Quectel
<debug> [1505128680.314946] [../../git/src/mm-broadband-modem.c:847] modem_load_model(): loading model...
<debug> [1505128680.317078] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.318963] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.320805] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGMM<CR>'
<debug> [1505128680.334037] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>EC21<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.336008] [../../git/src/mm-broadband-modem.c:831] modem_load_model_finish(): loaded model: EC21
<debug> [1505128680.340078] [../../git/src/mm-broadband-modem.c:887] modem_load_revision(): loading revision...
<debug> [1505128680.341784] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.343735] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.345556] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGMR<CR>'
<debug> [1505128680.361571] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>EC21EFAR02A05M4G<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.363693] [../../git/src/mm-broadband-modem.c:871] modem_load_revision_finish(): loaded revision: EC21EFAR02A05M4G
<debug> [1505128680.366210] [../../git/src/mm-broadband-modem.c:948] modem_load_equipment_identifier(): loading equipment identifier...
<debug> [1505128680.369391] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.372298] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.374248] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGSN<CR>'
<debug> [1505128680.388728] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>861108030008592<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.392006] [../../git/src/mm-broadband-modem.c:930] modem_load_equipment_identifier_finish(): loaded equipment identifier: 861108030008592
<debug> [1505128680.394622] [../../git/src/mm-broadband-modem.c:1036] modem_load_device_identifier(): loading device identifier...
<debug> [1505128680.396542] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.398376] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.400167] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATI<CR>'
<debug> [1505128680.407702] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>Quectel<CR><LF>EC21<CR><LF>Revision: EC21EFAR02A05M4G<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.416937] [../../git/src/mm-modem-helpers.c:310] mm_create_device_identifier(): Device ID source '00002c7c00000121QuectelEC21Revision:EC21EFAR02A05M4G861108030008592EC21EFAR02A05M4GEC21Quectel'
<debug> [1505128680.418624] [../../git/src/mm-modem-helpers.c:311] mm_create_device_identifier(): Device ID '555919a2efdf0cbce7b05045dfaafea2683f4d1c'
<debug> [1505128680.420315] [../../git/src/mm-broadband-modem.c:999] modem_load_device_identifier_finish(): loaded device identifier: 555919a2efdf0cbce7b05045dfaafea2683f4d1c
<debug> [1505128680.422937] [../../git/src/mm-broadband-modem.c:1612] modem_load_supported_modes(): loading supported modes...
<debug> [1505128680.424830] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.426753] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.428652] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT*CNTI=2<CR>'
<debug> [1505128680.444913] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>*CNTI: 2, GSM, GPRS, EDGE, UMTS, HSDPA, HSUPA<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.447289] [../../git/src/mm-broadband-modem.c:1521] supported_modes_cnti_ready(): Device allows (3GPP) 2G networks
<debug> [1505128680.449014] [../../git/src/mm-broadband-modem.c:1529] supported_modes_cnti_ready(): Device allows (3GPP) 3G networks
<debug> [1505128680.450762] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.452877] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.455040] [../../git/src/mm-broadband-modem.c:1491] supported_modes_ws46_test_ready(): Device allows (3GPP) mode combination: 2g
<debug> [1505128680.456821] [../../git/src/mm-broadband-modem.c:1491] supported_modes_ws46_test_ready(): Device allows (3GPP) mode combination: 3g
<debug> [1505128680.458437] [../../git/src/mm-broadband-modem.c:1491] supported_modes_ws46_test_ready(): Device allows (3GPP) mode combination: 2g, 3g, 4g
<debug> [1505128680.459909] [../../git/src/mm-broadband-modem.c:1491] supported_modes_ws46_test_ready(): Device allows (3GPP) mode combination: 4g
<debug> [1505128680.461456] [../../git/src/mm-broadband-modem.c:1491] supported_modes_ws46_test_ready(): Device allows (3GPP) mode combination: 2g, 3g
<debug> [1505128680.464380] [../../git/src/mm-broadband-modem.c:1686] modem_load_supported_ip_families(): loading supported IP families...
<debug> [1505128680.466217] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.468199] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.470141] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGDCONT=?<CR>'
<debug> [1505128680.491204] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CGDCONT: (1-24,100-179),"IP",,,(0-2),(0-4),(0-1),(0-1)<CR><LF>+CGDCONT: (1-24,100-179),"PPP",,,(0-2),(0-4),(0-1),(0-1)<CR><LF>+CGDCONT: (1-24,100-179),"IPV6",,,(0-2),(0-4),(0-1),(0-1)<CR><LF>+CGDCONT: (1-24,100-179),"IPV4V6",,,(0-2),(0-4),(0-1),(0-1)<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.495410] [../../git/src/mm-modem-helpers.c:1377] mm_3gpp_parse_cgdcont_test_response(): Unhandled PDP type in CGDCONT=? reply: 'PPP'
<debug> [1505128680.498399] [../../git/src/mm-broadband-modem.c:3259] load_power_state(): loading power state...
<debug> [1505128680.500334] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.502320] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.504189] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CFUN?<CR>'
<debug> [1505128680.524087] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CFUN: 1<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.533849] [../../git/src/mm-broadband-modem.c:1339] modem_load_unlock_required(): checking if unlock required...
<debug> [1505128680.535821] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.537833] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.539680] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CPIN?<CR>'
<debug> [1505128680.554166] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.556484] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128680.558463] [../../git/src/mm-iface-modem.c:3101] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
<debug> [1505128680.564033] [../../git/src/mm-base-sim.c:1004] load_sim_identifier(): loading SIM identifier...
<debug> [1505128680.565950] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128680.568206] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CRSM=176,12258,0,0,10<CR>'
<debug> [1505128680.604432] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CRSM: 144,0,"984370720000707630F8"<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.607144] [../../git/src/mm-base-sim.c:993] load_sim_identifier_finish(): loaded SIM identifier: 8934072700000767038
<debug> [1505128680.609288] [../../git/src/mm-base-sim.c:1074] load_imsi(): loading IMSI...
<debug> [1505128680.610987] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.612826] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.614558] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CIMI<CR>'
<debug> [1505128680.626508] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>214075537771200<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.628532] [../../git/src/mm-base-sim.c:1063] load_imsi_finish(): loaded IMSI: 214075537771200
<debug> [1505128680.630447] [../../git/src/mm-base-sim.c:1194] load_operator_identifier(): loading Operator ID...
<debug> [1505128680.632180] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.633967] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.635751] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CRSM=176,28589,0,0,4<CR>'
<debug> [1505128680.669561] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CRSM: 144,0,"00000002"<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.672216] [../../git/src/mm-base-sim.c:1289] load_operator_name(): loading Operator Name...
<debug> [1505128680.675166] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.678180] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.679983] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CRSM=176,28486,0,0,17<CR>'
<debug> [1505128680.716065] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
<debug> [1505128680.718222] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<warn> [1505128680.720133] [../../git/src/mm-base-sim.c:1425] load_operator_name_ready(): couldn't load Operator name: 'Unknown error'
<debug> [1505128680.721908] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128680.725179] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB0) opening serial port...
<debug> [1505128680.728580] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
<debug> [1505128680.730275] [../../git/src/mm-broadband-modem.c:1217] modem_load_own_numbers(): loading own numbers...
<debug> [1505128680.732012] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128680.734038] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CNUM<CR>'
<debug> [1505128680.747321] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128680.750692] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 0 (close)
<debug> [1505128680.752465] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB0) closing serial port...
<debug> [1505128680.755459] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB0) serial port closed
<debug> [1505128680.757364] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128680.762829] [../../git/src/mm-broadband-modem.c:3362] modem_3gpp_load_imei(): loading IMEI...
<debug> [1505128680.764744] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128680.766881] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGSN<CR>'
<debug> [1505128680.780949] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>861108030008592<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.783350] [../../git/src/mm-broadband-modem.c:3353] modem_3gpp_load_imei_finish(): loaded IMEI: 861108030008592
<debug> [1505128680.785181] [../../git/src/mm-broadband-modem.c:3521] modem_3gpp_load_enabled_facility_locks(): loading enabled facility locks...
<debug> [1505128680.787011] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.788804] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.790790] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK=?<CR>'
<debug> [1505128680.806241] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: ("AB","AC","AG","AI","AO","IR","OI","OX","SC","FD","PN","PU","PP","PC","PF")<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.811458] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.813370] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.815146] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK="SC",2<CR>'
<debug> [1505128680.837849] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.840277] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.842238] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.844092] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK="FD",2<CR>'
<debug> [1505128680.865937] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.868497] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.870422] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.872235] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK="PF",2<CR>'
<debug> [1505128680.900452] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.902860] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.904762] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.906640] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK="PN",2<CR>'
<debug> [1505128680.935454] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.937895] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.939837] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.941713] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK="PU",2<CR>'
<debug> [1505128680.974953] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128680.977357] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128680.979249] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128680.981071] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK="PP",2<CR>'
<debug> [1505128681.009232] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128681.011675] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128681.013719] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128681.015605] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLCK="PC",2<CR>'
<debug> [1505128681.047337] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128681.050148] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128681.054099] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128681.056169] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CUSD=?<CR>'
<debug> [1505128681.071069] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CUSD: (0-2)<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128681.073684] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128681.079756] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128681.081850] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CNMI=?<CR>'
<debug> [1505128681.099576] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CNMI: (0-2),(0-3),(0,2),(0-2),(0,1)<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128681.102836] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128681.104698] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128681.106682] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CPMS=?<CR>'
<debug> [1505128681.123376] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: ("ME","MT","SM","SR"),("ME","MT","SM","SR"),("ME","MT","SM","SR")<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128681.127079] [../../git/src/mm-iface-modem-messaging.c:1149] load_supported_storages_ready(): Supported storages loaded:
<debug> [1505128681.128687] [../../git/src/mm-iface-modem-messaging.c:1150] load_supported_storages_ready(): mem1 (list/read/delete) storages: 'me, mt, sm, sr'
<debug> [1505128681.130276] [../../git/src/mm-iface-modem-messaging.c:1151] load_supported_storages_ready(): mem2 (write/send) storages: 'me, mt, sm, sr'
<debug> [1505128681.131820] [../../git/src/mm-iface-modem-messaging.c:1152] load_supported_storages_ready(): mem3 (reception) storages: 'me, mt, sm, sr'
<debug> [1505128681.133765] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128681.135619] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128681.137562] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CPMS?<CR>'
<debug> [1505128681.153592] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: "SR",0,0,"MT",1,255,"MT",1,255<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128681.156395] [../../git/src/mm-broadband-modem.c:5412] cpms_query_ready(): Current storages initialized:
<debug> [1505128681.158145] [../../git/src/mm-broadband-modem.c:5414] cpms_query_ready(): mem1 (list/read/delete) storages: 'sr'
<debug> [1505128681.159748] [../../git/src/mm-broadband-modem.c:5416] cpms_query_ready(): mem2 (write/send) storages: 'mt'
<debug> [1505128681.161360] [../../git/src/mm-iface-modem-messaging.c:1232] init_current_storages_ready(): Current storages initialized
<debug> [1505128681.163475] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128681.166217] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128681.168456] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATH<CR>'
<debug> [1505128681.176508] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128681.178966] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128681.181608] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128681.183603] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CTZU=1<CR>'
<debug> [1505128681.200702] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128681.202938] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CCLK?<CR>'
<debug> [1505128681.224327] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CCLK: "80/01/06,02:06:47+08"<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128681.227102] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128681.230060] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128681.232070] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CESQ=?<CR>'
<debug> [1505128681.246482] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>ERROR<CR><LF>'
<debug> [1505128681.248427] [../../git/src/mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1505128681.250157] [../../git/src/mm-iface-modem-signal.c:398] check_support_ready(): Extended signal support check failed: 'Unknown error'
<debug> [1505128681.251916] [../../git/src/mm-broadband-modem.c:10010] iface_modem_signal_initialize_ready(): Couldn't initialize interface: 'Extended Signal information not supported'
<debug> [1505128681.255284] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128681.257336] [../../git/src/mm-broadband-modem.c:10011] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
<debug> [1505128681.260021] [../../git/src/mm-broadband-modem.c:10012] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware interface not available'
<info> [1505128681.262920] [../../git/src/mm-iface-modem.c:1433] __iface_modem_update_state_internal(): Modem: state changed (unknown -> disabled)
<debug> [1505128681.265421] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
<debug> [1505128681.267239] [../../git/src/mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
<debug> [1505128681.272672] [../../git/src/mm-port-serial.c:1371] _close_internal(): (ttyUSB2) serial port closed
<debug> [1505128681.274529] [../../git/src/mm-base-modem.c:862] initialize_ready(): modem properly initialized
<debug> [1505128681.287369] [../../git/src/mm-device.c:283] export_modem(): [device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3] exported modem at path '/org/freedesktop/ModemManager1/Modem/0'
<debug> [1505128681.289158] [../../git/src/mm-device.c:284] export_modem(): [device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3] plugin: Generic
<debug> [1505128681.290788] [../../git/src/mm-device.c:288] export_modem(): [device /sys/devices/platform/soc/2100000.aips-bus/2184200.usb/ci_hdrc.1/usb1/1-1/1-1.3] vid:pid: 0x2C7C:0x0121
<info> [1505128726.309488] [../../git/src/mm-iface-modem.c:1433] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
<debug> [1505128726.318592] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB2) opening serial port...
<debug> [1505128726.321348] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB2): setting up baudrate: 57600
<debug> [1505128726.322917] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128726.324647] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1505128726.326142] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB3) opening serial port...
<debug> [1505128726.329591] [../../git/src/mm-port-serial.c:421] real_config_fd(): (ttyUSB3): setting up baudrate: 57600
<debug> [1505128726.331030] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB3): port attributes not fully set
<debug> [1505128726.332524] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 1 (open)
<debug> [1505128726.333919] [../../git/src/mm-port-serial.c:1120] mm_port_serial_open(): (ttyUSB0) opening serial port...
<debug> [1505128726.336147] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
<debug> [1505128726.337649] [../../git/src/mm-broadband-modem.c:8928] enabling_started(): Flashing primary AT port before enabling...
<debug> [1505128726.339110] [../../git/src/mm-port-serial.c:399] internal_tcsetattr(): (ttyUSB2): port attributes not fully set
<debug> [1505128726.441200] [../../git/src/mm-broadband-modem.c:8817] enabling_flash_done(): Running modem initialization sequence...
<debug> [1505128726.443915] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128726.445921] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATZ<CR>'
<debug> [1505128726.460965] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128726.464028] [../../git/src/mm-broadband-modem.c:8798] enabling_modem_init_ready(): Giving some time to settle the modem...
<debug> [1505128726.467496] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128726.969214] [../../git/src/mm-port-serial-at.c:495] mm_port_serial_at_run_init_sequence(): (ttyUSB2): running init sequence...
<debug> [1505128726.972262] [../../git/src/mm-port-serial-at.c:495] mm_port_serial_at_run_init_sequence(): (ttyUSB3): running init sequence...
<debug> [1505128726.975167] [../../git/src/mm-broadband-modem.c:3259] load_power_state(): loading power state...
<debug> [1505128726.978130] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128726.981026] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
<debug> [1505128726.983973] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'ATE0<CR>'
<debug> [1505128726.992131] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- 'ATE'
<debug> [1505128726.996005] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '0<CR><CR><LF>OK<CR><LF>'
<debug> [1505128727.000048] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- 'ATE'
<debug> [1505128727.003516] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.008178] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATV1<CR>'
<debug> [1505128727.019554] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.022998] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
<debug> [1505128727.043352] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.047228] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'ATX4<CR>'
<debug> [1505128727.054887] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.061123] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT&C1<CR>'
<debug> [1505128727.070419] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.072402] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CFUN?<CR>'
<debug> [1505128727.085525] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CFUN: 1<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.089647] [../../git/src/mm-iface-modem.c:3298] set_power_state(): No need to change power state: already in 'on' power state
<debug> [1505128727.091273] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.092974] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.094736] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+IFC=?<CR>'
<debug> [1505128727.111321] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+IFC: (0,2),(0,2)<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.113392] [../../git/src/mm-modem-helpers.c:541] flow_control_array_to_mask(): TE supports no flow control
<debug> [1505128727.114838] [../../git/src/mm-modem-helpers.c:549] flow_control_array_to_mask(): TE supports RTS/CTS flow control
<debug> [1505128727.116735] [../../git/src/mm-modem-helpers.c:541] flow_control_array_to_mask(): TA supports no flow control
<debug> [1505128727.118371] [../../git/src/mm-modem-helpers.c:549] flow_control_array_to_mask(): TA supports RTS/CTS flow control
<debug> [1505128727.120074] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128727.121988] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
<debug> [1505128727.123851] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
<debug> [1505128727.125676] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+IFC=2,2<CR>'
<debug> [1505128727.143838] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.145896] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128727.147861] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CSCS=?<CR>'
<debug> [1505128727.167060] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CSCS: ("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.169675] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128727.171593] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128727.173485] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CSCS="UCS2"<CR>'
<debug> [1505128727.196217] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.198493] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128727.200384] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128727.202202] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CSCS?<CR>'
<debug> [1505128727.219965] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.222220] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.224199] [../../git/src/mm-broadband-modem.c:9573] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
<debug> [1505128727.226805] [../../git/src/mm-broadband-modem.c:2703] modem_3gpp_setup_unsolicited_events(): Checking indicator support...
<debug> [1505128727.228628] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.230654] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CIND=?<CR>'
<debug> [1505128727.245221] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: ("battchg",(0-5)),("signal",(0-5)),("service",(0-1)),("call",(0-1)),("roam",(0-1)),("smsfull",(0-1)),("GPRS coverage",(0-1)),("callsetup",(0-3))<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.248216] [../../git/src/mm-broadband-modem.c:2656] cind_format_check_ready(): Modem supports signal quality indications via CIND at index '2'(min: 0, max: 5)
<debug> [1505128727.249831] [../../git/src/mm-broadband-modem.c:2665] cind_format_check_ready(): Modem supports roaming indications via CIND at index '5'
<debug> [1505128727.251322] [../../git/src/mm-broadband-modem.c:2674] cind_format_check_ready(): Modem supports service indications via CIND at index '3'
<debug> [1505128727.252986] [../../git/src/mm-broadband-modem.c:2607] set_unsolicited_events_handlers(): (ttyUSB2) Setting 3GPP unsolicited events handlers
<debug> [1505128727.254514] [../../git/src/mm-broadband-modem.c:2607] set_unsolicited_events_handlers(): (ttyUSB3) Setting 3GPP unsolicited events handlers
<debug> [1505128727.256627] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128727.258584] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128727.260423] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMER=3,0,0,1<CR>'
<debug> [1505128727.283587] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.286868] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 2 (open)
<debug> [1505128727.289794] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.291590] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT+CMER=3,0,0,1<CR>'
<debug> [1505128727.314469] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.318720] [../../git/src/mm-broadband-modem.c:3735] modem_3gpp_setup_unsolicited_registration_events(): (ttyUSB2) setting up 3GPP unsolicited registration messages handlers
<debug> [1505128727.320549] [../../git/src/mm-broadband-modem.c:3735] modem_3gpp_setup_unsolicited_registration_events(): (ttyUSB3) setting up 3GPP unsolicited registration messages handlers
<debug> [1505128727.322412] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 1 (close)
<debug> [1505128727.324432] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.326752] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CREG=2<CR>'
<debug> [1505128727.341971] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.344175] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 2 (open)
<debug> [1505128727.346185] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.348181] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT+CREG=2<CR>'
<debug> [1505128727.363450] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.365681] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.367663] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 1 (close)
<debug> [1505128727.369508] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGREG=2<CR>'
<debug> [1505128727.385193] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.387471] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 2 (open)
<debug> [1505128727.389428] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.391303] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT+CGREG=2<CR>'
<debug> [1505128727.407958] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.410042] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.411849] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 1 (close)
<debug> [1505128727.413597] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CEREG=2<CR>'
<debug> [1505128727.430086] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.432208] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 2 (open)
<debug> [1505128727.434088] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.435963] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT+CEREG=2<CR>'
<debug> [1505128727.452450] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.454501] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 1 (close)
<debug> [1505128727.456582] [../../git/src/mm-broadband-modem.c:9586] enabling_step(): Modem has 3GPP/USSD capabilities, enabling the Modem 3GPP/USSD interface...
<debug> [1505128727.458435] [../../git/src/mm-broadband-modem.c:5049] set_unsolicited_result_code_handlers(): (ttyUSB2) Setting unsolicited result code handlers
<debug> [1505128727.460081] [../../git/src/mm-broadband-modem.c:5049] set_unsolicited_result_code_handlers(): (ttyUSB3) Setting unsolicited result code handlers
<debug> [1505128727.462110] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.464104] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CUSD=1<CR>'
<debug> [1505128727.479643] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.482098] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.488397] [../../git/src/mm-broadband-modem.c:9614] enabling_step(): Modem has location capabilities, enabling the Location interface...
<debug> [1505128727.490283] [../../git/src/mm-iface-modem-location.c:762] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
<debug> [1505128727.493761] [../../git/src/mm-iface-modem-3gpp.c:798] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'yes')
<debug> [1505128727.495582] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.502056] [../../git/src/mm-broadband-modem.c:9627] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
<debug> [1505128727.504456] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128727.506601] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CREG?<CR>'
<debug> [1505128727.521348] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CREG: 2,1,"67E8","3F7B21E",7<CR><LF><CR><LF>OK<CR><LF>'
<info> [1505128727.523643] [../../git/src/mm-iface-modem-3gpp.c:1197] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
<debug> [1505128727.525482] [../../git/src/mm-broadband-modem.c:3564] modem_3gpp_load_operator_code(): loading Operator Code...
<debug> [1505128727.527337] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
<debug> [1505128727.529582] [../../git/src/mm-iface-modem.c:935] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> lte)
<debug> [1505128727.531517] [../../git/src/mm-iface-modem-location.c:297] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '67E8', Cell ID: '3F7B21E')
<debug> [1505128727.533960] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
<debug> [1505128727.535796] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
<debug> [1505128727.541884] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMGF=?<CR>'
<debug> [1505128727.565981] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CMGF: (0,1)<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.569502] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
<debug> [1505128727.571342] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
<debug> [1505128727.573252] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+COPS=3,2;+COPS?<CR>'
<debug> [1505128727.601227] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+COPS: 0,2,"21407",7<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.631498] [../../git/src/mm-broadband-modem.c:3555] modem_3gpp_load_operator_code_finish(): loaded Operator Code: 21407
<debug> [1505128727.633625] [../../git/src/mm-iface-modem-location.c:297] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '214', MNC: '7', Location area code: '67E8', Cell ID: '3F7B21E')
<debug> [1505128727.635304] [../../git/src/mm-broadband-modem.c:3607] modem_3gpp_load_operator_name(): loading Operator Name...
<debug> [1505128727.638328] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
<debug> [1505128727.641135] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
<debug> [1505128727.647447] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGREG?<CR>'
<debug> [1505128727.663631] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CGREG: 2,1,"67E8","3F7B21E",7<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.666251] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
<debug> [1505128727.668305] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
<debug> [1505128727.670202] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMGF=0<CR>'
<debug> [1505128727.685584] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128727.687845] [../../git/src/mm-broadband-modem.c:5729] cmgf_set_ready(): Successfully set preferred SMS mode: 'PDU'
<debug> [1505128727.690082] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
<debug> [1505128727.691997] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
<debug> [1505128727.698251] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+COPS=3,0;+COPS?<CR>'
<debug> [1505128727.727385] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+COPS: 0,0,"Movistar",7<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.729921] [../../git/src/mm-broadband-modem.c:3598] modem_3gpp_load_operator_name_finish(): loaded Operator Name: Movistar
<debug> [1505128727.732103] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
<info> [1505128727.738859] [../../git/src/mm-iface-modem-3gpp.c:1114] update_registration_reload_current_registration_info_ready(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
<debug> [1505128727.741057] [../../git/src/mm-iface-modem.c:1602] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
<debug> [1505128727.747536] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CEREG?<CR>'
<debug> [1505128727.763522] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CEREG: 2,1,"67E8","3F7B21E",7<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.766041] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128727.768132] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CPMS="SR","MT","MT"<CR>'
<debug> [1505128727.801981] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 0,0,1,255,1,255<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.804123] [../../git/src/mm-broadband-modem.c:6501] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'me'
<debug> [1505128727.805818] [../../git/src/mm-broadband-modem.c:5611] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (ME), mem2 (none)...
<debug> [1505128727.807683] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128727.809479] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128727.811255] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CPMS="ME"<CR>'
<debug> [1505128727.833722] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 1,255,1,255,1,255<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.835894] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.838043] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.840075] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMGL=4<CR>'
<debug> [1505128727.861161] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CMGL: 0,1,,157<CR><LF>07914326926912F12409D0D967F2F8040000713072612144809EC4F27C1C969FC3F432E82C0FD3D37350330DCABED3E73728088582F2A0F1DB3DAFB3E96190393CA6D7E5E1390B347EBBE7F5F61BF406B5DFE4B4393D0E83E665B93D3D4EBFE72073789C6683F22079189E26BF5DA0A09B2C7FA7C93AD0FD7E77E5DFE9F3DB357EB75F6138FC356FCF656150F239D581EEF7BB2BFF4E9FDFAEF1BBFD0AC3E1AF797B2E4B03<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128727.866269] [../../git/src/mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (0)...
<debug> [1505128727.868049] [../../git/src/mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+34622996211'
<debug> [1505128727.869700] [../../git/src/mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
<debug> [1505128727.871367] [../../git/src/mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: 'YOIGO'
<debug> [1505128727.873001] [../../git/src/mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
<debug> [1505128727.874583] [../../git/src/mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is GSM7
<debug> [1505128727.876171] [../../git/src/mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 158 elements
<debug> [1505128727.877853] [../../git/src/mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 139 bytes
<debug> [1505128727.879433] [../../git/src/mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '158' elements
<debug> [1505128727.881023] [../../git/src/mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
<debug> [1505128727.882730] [../../git/src/mm-sms-part-3gpp.c:247] sms_decode_text(): Got UTF-8 text: 'Descargate gratis Mi Yoigo APP y consulta facturas, consumo o modifica servicios facil y rapido. Android: www.yoigo.com/app/sms2a IOS: www.yoigo.com/app/sms2i'
<debug> [1505128727.884419] [../../git/src/mm-broadband-modem.c:6434] sms_pdu_part_list_ready(): Correctly parsed PDU (0)
<debug> [1505128727.886257] [../../git/src/mm-sms-list.c:368] mm_sms_list_take_part(): SMS part at 'me/0' is from a singlepart SMS
<debug> [1505128727.897504] [../../git/src/mm-iface-modem-messaging.c:511] sms_added(): Added received SMS at '/org/freedesktop/ModemManager1/SMS/0'
<debug> [1505128727.903600] [../../git/src/mm-broadband-modem.c:6501] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'sm'
<debug> [1505128727.905330] [../../git/src/mm-broadband-modem.c:5611] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SM), mem2 (none)...
<debug> [1505128727.907072] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128727.908850] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128727.914830] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CPMS="SM"<CR>'
<debug> [1505128727.938311] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 6,30,1,255,1,255<CR><LF><CR><LF>OK<CR><LF><CR><LF>+CIEV: 5,0<CR><LF>'
<debug> [1505128727.940307] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128727.942057] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128727.943895] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMGL=4<CR>'
<debug> [1505128728.060114] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CMGL: 0,1,,108<CR><LF>07914306090909F944038147F80004712042016445405D0605040B840000000607BEAF848DCCB4818C8298303131385879366958564B008D9389078032323630300086808A808E03010C8A8805810303F48083687474703A2F2F763A31303032312F6D6D73632F3F303131385879366958564B00<CR><LF>+CMGL: 1,1,,156<CR><LF>07914306090909F9400681120555000071204211228340A0050003B5020188655DF36D4FCFE9613928E936BF41231708349296C769719A1C06C5EB6575183485069B2072794E2E83E675D0F8ED2EE3D36F3728E9A697E5EE32DD056A86E7A0B4DBFC96B7C3E3F4DB0D2ACFC7F2B4380C0A831A0A77B95D9EE7E7007A995D36BFDDE971D8559E8382F3BA9BFED681CAAD7638CD1E3963B7160C96B3C970B6960D86B3C962<CR><LF>+CMGL: 2,1,,30<CR><LF>07914306090909F94406811205550000712042112293400F050003B5020270341CA8A1682800<CR><LF>+CMGL: 3,1,,108<CR><LF>07914306090909F944038128F20004717020617353805D0605040B840000000607BEAF848DCCB4818C8298303267514C69505A324F69008D9389078032323630300086808A808E03010C8A8805810303F47F83687474703A2F2F703A31303032312F6D6D73632F3F303267514C69505A324F6900<CR><LF>+CMGL: 4,1,,108<CR><LF>07914306090909F944038147F80004717082819384805D0605040B840000000607BEAF848DCCB4818C829830316A657A395535434D6D008D9389078032323630300086808A808E03010C8A8805810303F47F83687474703A2F2F763A31303032312F6D6D73632F3F30316A657A395535434D6D00<CR><LF>+CMGL: 5,2,,22<CR><LF>07914306090909F90100099126376878F100000BC8329BFD06DDDF723619<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128728.065998] [../../git/src/mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (0)...
<debug> [1505128728.068947] [../../git/src/mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+34609090909'
<debug> [1505128728.071369] [../../git/src/mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
<debug> [1505128728.073737] [../../git/src/mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: '748'
<debug> [1505128728.076108] [../../git/src/mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
<debug> [1505128728.078874] [../../git/src/mm-sms-part-3gpp.c:592] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is 8bit
<debug> [1505128728.082768] [../../git/src/mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 93 elements
<debug> [1505128728.086735] [../../git/src/mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 93 bytes
<debug> [1505128728.089379] [../../git/src/mm-sms-part-3gpp.c:708] mm_sms_part_3gpp_new_from_binary_pdu(): Skipping SMS text: Unknown encoding (0x02)
<debug> [1505128728.092851] [../../git/src/mm-broadband-modem.c:6434] sms_pdu_part_list_ready(): Correctly parsed PDU (0)
<debug> [1505128728.095226] [../../git/src/mm-sms-list.c:368] mm_sms_list_take_part(): SMS part at 'sm/0' is from a singlepart SMS
<debug> [1505128728.100522] [../../git/src/mm-iface-modem-messaging.c:511] sms_added(): Added received SMS at '/org/freedesktop/ModemManager1/SMS/1'
<debug> [1505128728.110173] [../../git/src/mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (1)...
<debug> [1505128728.112664] [../../git/src/mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+34609090909'
<debug> [1505128728.114936] [../../git/src/mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
<debug> [1505128728.117246] [../../git/src/mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: '215055'
<debug> [1505128728.119497] [../../git/src/mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
<debug> [1505128728.121896] [../../git/src/mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is GSM7
<debug> [1505128728.124115] [../../git/src/mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 160 elements
<debug> [1505128728.126528] [../../git/src/mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 140 bytes
<debug> [1505128728.128755] [../../git/src/mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '153' elements
<debug> [1505128728.130956] [../../git/src/mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
<debug> [1505128728.133387] [../../git/src/mm-sms-part-3gpp.c:247] sms_decode_text(): Got UTF-8 text: 'De:Movistar Info #. #Recibida queja SPAM desde su conexion Internet. Mas informacion escriba a
nemesys at telefonica.es Asunto: e-mail#N17-0096286-608621'
<debug> [1505128728.135752] [../../git/src/mm-broadband-modem.c:6434] sms_pdu_part_list_ready(): Correctly parsed PDU (1)
<debug> [1505128728.138144] [../../git/src/mm-sms-list.c:355] mm_sms_list_take_part(): SMS part at 'sm/1' is from a multipart SMS (reference: '181', sequence: '1')
<debug> [1505128728.140644] [../../git/src/mm-iface-modem-messaging.c:511] sms_added(): Added received SMS at '/org/freedesktop/ModemManager1/SMS/2'
<debug> [1505128728.145584] [../../git/src/mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (2)...
<debug> [1505128728.147248] [../../git/src/mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+34609090909'
<debug> [1505128728.148742] [../../git/src/mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
<debug> [1505128728.150150] [../../git/src/mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: '215055'
<debug> [1505128728.151577] [../../git/src/mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
<debug> [1505128728.152984] [../../git/src/mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is GSM7
<debug> [1505128728.154345] [../../git/src/mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 15 elements
<debug> [1505128728.155728] [../../git/src/mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 14 bytes
<debug> [1505128728.157256] [../../git/src/mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '8' elements
<debug> [1505128728.158655] [../../git/src/mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
<debug> [1505128728.160087] [../../git/src/mm-sms-part-3gpp.c:247] sms_decode_text(): Got UTF-8 text: '848
'
<debug> [1505128728.161502] [../../git/src/mm-broadband-modem.c:6434] sms_pdu_part_list_ready(): Correctly parsed PDU (2)
<debug> [1505128728.163096] [../../git/src/mm-sms-list.c:355] mm_sms_list_take_part(): SMS part at 'sm/2' is from a multipart SMS (reference: '181', sequence: '2')
<debug> [1505128728.165387] [../../git/src/mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (3)...
<debug> [1505128728.166871] [../../git/src/mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+34609090909'
<debug> [1505128728.168240] [../../git/src/mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
<debug> [1505128728.169592] [../../git/src/mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: '822'
<debug> [1505128728.170911] [../../git/src/mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
<debug> [1505128728.172193] [../../git/src/mm-sms-part-3gpp.c:592] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is 8bit
<debug> [1505128728.173541] [../../git/src/mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 93 elements
<debug> [1505128728.174842] [../../git/src/mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 93 bytes
<debug> [1505128728.176143] [../../git/src/mm-sms-part-3gpp.c:708] mm_sms_part_3gpp_new_from_binary_pdu(): Skipping SMS text: Unknown encoding (0x02)
<debug> [1505128728.177615] [../../git/src/mm-broadband-modem.c:6434] sms_pdu_part_list_ready(): Correctly parsed PDU (3)
<debug> [1505128728.179059] [../../git/src/mm-sms-list.c:368] mm_sms_list_take_part(): SMS part at 'sm/3' is from a singlepart SMS
<debug> [1505128728.181868] [../../git/src/mm-iface-modem-messaging.c:511] sms_added(): Added received SMS at '/org/freedesktop/ModemManager1/SMS/3'
<debug> [1505128728.186998] [../../git/src/mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (4)...
<debug> [1505128728.188524] [../../git/src/mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+34609090909'
<debug> [1505128728.189924] [../../git/src/mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu(): Deliver type PDU detected
<debug> [1505128728.191298] [../../git/src/mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: '748'
<debug> [1505128728.192651] [../../git/src/mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
<debug> [1505128728.193970] [../../git/src/mm-sms-part-3gpp.c:592] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is 8bit
<debug> [1505128728.195322] [../../git/src/mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 93 elements
<debug> [1505128728.196756] [../../git/src/mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 93 bytes
<debug> [1505128728.198112] [../../git/src/mm-sms-part-3gpp.c:708] mm_sms_part_3gpp_new_from_binary_pdu(): Skipping SMS text: Unknown encoding (0x02)
<debug> [1505128728.199512] [../../git/src/mm-broadband-modem.c:6434] sms_pdu_part_list_ready(): Correctly parsed PDU (4)
<debug> [1505128728.201085] [../../git/src/mm-sms-list.c:368] mm_sms_list_take_part(): SMS part at 'sm/4' is from a singlepart SMS
<debug> [1505128728.203839] [../../git/src/mm-iface-modem-messaging.c:511] sms_added(): Added received SMS at '/org/freedesktop/ModemManager1/SMS/4'
<debug> [1505128728.210221] [../../git/src/mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (5)...
<debug> [1505128728.211774] [../../git/src/mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu(): SMSC address parsed: '+34609090909'
<debug> [1505128728.214216] [../../git/src/mm-sms-part-3gpp.c:414] mm_sms_part_3gpp_new_from_binary_pdu(): Submit type PDU detected
<debug> [1505128728.215627] [../../git/src/mm-sms-part-3gpp.c:451] mm_sms_part_3gpp_new_from_binary_pdu(): message reference: 0
<debug> [1505128728.218607] [../../git/src/mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu(): Number parsed: '+627386871'
<debug> [1505128728.229677] [../../git/src/mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu(): PID: 0
<debug> [1505128728.234541] [../../git/src/mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu(): user data encoding is GSM7
<debug> [1505128728.240830] [../../git/src/mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 11 elements
<debug> [1505128728.242197] [../../git/src/mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu(): user data length: 10 bytes
<debug> [1505128728.246425] [../../git/src/mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '11' elements
<debug> [1505128728.247792] [../../git/src/mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
<debug> [1505128728.251941] [../../git/src/mm-sms-part-3gpp.c:247] sms_decode_text(): Got UTF-8 text: 'Hello world'
<debug> [1505128728.253329] [../../git/src/mm-broadband-modem.c:6434] sms_pdu_part_list_ready(): Correctly parsed PDU (5)
<debug> [1505128728.261899] [../../git/src/mm-sms-list.c:368] mm_sms_list_take_part(): SMS part at 'sm/5' is from a singlepart SMS
<debug> [1505128728.264685] [../../git/src/mm-iface-modem-messaging.c:511] sms_added(): Added local SMS at '/org/freedesktop/ModemManager1/SMS/5'
<debug> [1505128728.272677] [../../git/src/mm-broadband-modem.c:6501] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'sr'
<debug> [1505128728.276445] [../../git/src/mm-broadband-modem.c:5611] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SR), mem2 (none)...
<debug> [1505128728.278114] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128728.283382] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128728.297999] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CPMS="SR"<CR>'
<debug> [1505128728.325450] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 0,0,1,255,1,255<CR><LF><CR><LF>OK<CR><LF><CR><LF>+CIEV: 5,1<CR><LF>'
<debug> [1505128728.327530] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128728.329351] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128728.331147] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CMGL=4<CR>'
<debug> [1505128728.347767] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128728.350362] [../../git/src/mm-broadband-modem.c:6032] set_messaging_unsolicited_events_handlers(): (ttyUSB2) Setting messaging unsolicited events handlers
<debug> [1505128728.352107] [../../git/src/mm-broadband-modem.c:6032] set_messaging_unsolicited_events_handlers(): (ttyUSB3) Setting messaging unsolicited events handlers
<debug> [1505128728.353889] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128728.355753] [../../git/src/mm-broadband-modem.c:6205] modem_messaging_enable_unsolicited_events(): (ttyUSB2) Enabling messaging unsolicited events on primary port
<debug> [1505128728.362020] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128728.364108] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CNMI=2,1,2,1,0<CR>'
<debug> [1505128728.394869] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128728.397188] [../../git/src/mm-broadband-modem.c:6166] modem_messaging_enable_unsolicited_events_primary_ready(): (ttyUSB2) Messaging unsolicited events enabled on primary
<debug> [1505128728.398907] [../../git/src/mm-broadband-modem.c:6171] modem_messaging_enable_unsolicited_events_primary_ready(): (ttyUSB3) Enabling messaging unsolicited events on secondary port
<debug> [1505128728.400675] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB3) device open count is 2 (open)
<debug> [1505128728.402796] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128728.404555] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): --> 'AT+CNMI=2,1,2,1,0<CR>'
<debug> [1505128728.435240] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128728.437288] [../../git/src/mm-broadband-modem.c:6139] modem_messaging_enable_unsolicited_events_secondary_ready(): (ttyUSB3) Messaging unsolicited events enabled on secondary
<debug> [1505128728.439191] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB3) device open count is 1 (close)
<debug> [1505128728.441072] [../../git/src/mm-broadband-modem.c:9640] enabling_step(): Modem has voice capabilities, enabling the Voice interface...
<debug> [1505128728.443486] [../../git/src/mm-broadband-modem.c:6669] set_voice_unsolicited_events_handlers(): (ttyUSB2) Setting voice unsolicited events handlers
<debug> [1505128728.445230] [../../git/src/mm-broadband-modem.c:6669] set_voice_unsolicited_events_handlers(): (ttyUSB3) Setting voice unsolicited events handlers
<debug> [1505128728.447367] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128728.449343] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CLIP=1<CR>'
<debug> [1505128728.464616] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128728.467076] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CRC=1<CR>'
<debug> [1505128728.480855] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128728.483006] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128728.484897] [../../git/src/mm-broadband-modem.c:9653] enabling_step(): Modem has time capabilities, enabling the Time interface...
<info> [1505128728.487131] [../../git/src/mm-iface-modem.c:1433] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
<debug> [1505128728.497483] [../../git/src/mm-iface-modem.c:1357] periodic_signal_quality_check_enable(): Periodic signal quality checks enabled (interval = 3s)
<debug> [1505128728.499362] [../../git/src/mm-broadband-modem.c:2074] modem_load_signal_quality(): loading signal quality...
<debug> [1505128728.501158] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128728.503131] [../../git/src/mm-iface-modem.c:1077] periodic_access_technologies_check_enable(): Periodic access technology checks enabled
<debug> [1505128728.505050] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 2 (open)
<debug> [1505128728.506793] [../../git/src/mm-broadband-modem.c:2479] modem_load_access_technologies(): loading access technologies via QCDM...
<debug> [1505128728.516896] [../../git/src/mm-iface-modem-3gpp.c:798] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'yes')
<debug> [1505128728.520537] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128728.525887] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
<debug> [1505128728.537344] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 f5 7e
<debug> [1505128728.545246] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 8a 16 01 08 03 00 58 29 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 05 05 09 0c 3b 7e
<debug> [1505128728.557795] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
<debug> [1505128728.564641] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 8a 16 01 08 03 00 58 29 08 29 41 70 55 73 77 21 00 0a 66 3a 7e
<debug> [1505128728.570079] [../../git/src/mm-broadband-modem.c:2179] access_tech_context_complete_and_free(): QCDM operating mode: 5
<debug> [1505128728.571521] [../../git/src/mm-broadband-modem.c:2180] access_tech_context_complete_and_free(): QCDM system mode: 9
<debug> [1505128728.573725] [../../git/src/mm-broadband-modem.c:2181] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
<debug> [1505128728.575003] [../../git/src/mm-broadband-modem.c:2182] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
<debug> [1505128728.577341] [../../git/src/mm-broadband-modem.c:2183] access_tech_context_complete_and_free(): QCDM EVDO open: 0
<debug> [1505128728.578856] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 1 (close)
<debug> [1505128728.587972] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 0,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128728.590117] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128728.592267] [../../git/src/mm-iface-modem.c:1206] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
<debug> [1505128728.593807] [../../git/src/mm-iface-modem.c:1276] signal_quality_check_ready(): Periodic signal quality checks rescheduled (interval = 30s)
<debug> [1505128728.597580] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CREG?<CR>'
<debug> [1505128728.611329] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CREG: 2,1,"67E8","3F7B21E",7<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128728.613629] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128728.615375] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128728.617132] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CGREG?<CR>'
<debug> [1505128728.632482] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CGREG: 2,1,"67E8","3F7B21E",7<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128728.635076] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1505128728.637101] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1505128728.639066] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CEREG?<CR>'
<debug> [1505128728.654758] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CEREG: 2,1,"67E8","3F7B21E",7<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128728.657394] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128728.659332] [../../git/src/mm-broadband-modem.c:8950] modem_3gpp_run_registration_checks_ready(): Initial 3GPP registration checks finished
<debug> [1505128734.012974] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128734.016829] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CCLK?<CR>'
<debug> [1505128734.034418] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CCLK: "80/01/06,02:07:40+08"<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128734.039676] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128759.012009] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 2 (open)
<debug> [1505128759.014622] [../../git/src/mm-broadband-modem.c:2479] modem_load_access_technologies(): loading access technologies via QCDM...
<debug> [1505128759.017790] [../../git/src/mm-broadband-modem.c:2074] modem_load_signal_quality(): loading signal quality...
<debug> [1505128759.020573] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128759.023962] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 f5 7e
<debug> [1505128759.026796] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
<debug> [1505128759.030493] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 8a 16 01 08 03 00 58 29 00 00 00 00 00 00 00 00 00 0a de ad 00 00 00 00 05 05 09 51 cb 7e
<debug> [1505128759.034324] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
<debug> [1505128759.039150] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 8a 16 01 08 03 00 58 29 08 29 41 70 55 73 77 21 00 0a 66 3a 7e
<debug> [1505128759.041641] [../../git/src/mm-broadband-modem.c:2179] access_tech_context_complete_and_free(): QCDM operating mode: 5
<debug> [1505128759.044097] [../../git/src/mm-broadband-modem.c:2180] access_tech_context_complete_and_free(): QCDM system mode: 9
<debug> [1505128759.046656] [../../git/src/mm-broadband-modem.c:2181] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
<debug> [1505128759.048971] [../../git/src/mm-broadband-modem.c:2182] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
<debug> [1505128759.051156] [../../git/src/mm-broadband-modem.c:2183] access_tech_context_complete_and_free(): QCDM EVDO open: 0
<debug> [1505128759.053527] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 1 (close)
<debug> [1505128759.068509] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 0,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128759.072213] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128759.075624] [../../git/src/mm-iface-modem.c:1206] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
<debug> [1505128781.819734] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128781.821614] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+QGPS=1<CR>'
<debug> [1505128781.838895] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1505128781.848627] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128789.014060] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 2 (open)
<debug> [1505128789.016913] [../../git/src/mm-broadband-modem.c:2479] modem_load_access_technologies(): loading access technologies via QCDM...
<debug> [1505128789.019597] [../../git/src/mm-broadband-modem.c:2074] modem_load_signal_quality(): loading signal quality...
<debug> [1505128789.022277] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128789.025488] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 f5 7e
<debug> [1505128789.028597] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
<debug> [1505128789.032534] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 8a 16 01 08 03 00 58 29 00 00 00 00 00 00 00 00 00 0a de ad 00 00 00 00 05 05 09 51 cb 7e
<debug> [1505128789.036674] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
<debug> [1505128789.041652] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 8a 16 01 08 03 00 58 29 08 29 41 70 55 73 77 21 00 0a 66 3a 7e
<debug> [1505128789.044433] [../../git/src/mm-broadband-modem.c:2179] access_tech_context_complete_and_free(): QCDM operating mode: 5
<debug> [1505128789.046982] [../../git/src/mm-broadband-modem.c:2180] access_tech_context_complete_and_free(): QCDM system mode: 9
<debug> [1505128789.049325] [../../git/src/mm-broadband-modem.c:2181] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
<debug> [1505128789.052081] [../../git/src/mm-broadband-modem.c:2182] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
<debug> [1505128789.054159] [../../git/src/mm-broadband-modem.c:2183] access_tech_context_complete_and_free(): QCDM EVDO open: 0
<debug> [1505128789.056716] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 1 (close)
<debug> [1505128789.071813] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 0,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128789.077275] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128789.079576] [../../git/src/mm-iface-modem.c:1206] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
<debug> [1505128819.037074] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 2 (open)
<debug> [1505128819.039637] [../../git/src/mm-broadband-modem.c:2479] modem_load_access_technologies(): loading access technologies via QCDM...
<debug> [1505128819.042220] [../../git/src/mm-broadband-modem.c:2074] modem_load_signal_quality(): loading signal quality...
<debug> [1505128819.044787] [../../git/src/mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1505128819.047874] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 f5 7e
<debug> [1505128819.050748] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
<debug> [1505128819.054589] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 8a 16 01 08 03 00 58 29 00 00 00 00 00 00 00 00 00 0a de ad 00 00 00 00 05 05 09 51 cb 7e
<debug> [1505128819.058667] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
<debug> [1505128819.063961] [../../git/src/mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 8a 16 01 08 03 00 58 29 08 29 41 70 55 73 77 21 00 0a 66 3a 7e
<debug> [1505128819.066796] [../../git/src/mm-broadband-modem.c:2179] access_tech_context_complete_and_free(): QCDM operating mode: 5
<debug> [1505128819.069116] [../../git/src/mm-broadband-modem.c:2180] access_tech_context_complete_and_free(): QCDM system mode: 9
<debug> [1505128819.071362] [../../git/src/mm-broadband-modem.c:2181] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
<debug> [1505128819.073748] [../../git/src/mm-broadband-modem.c:2182] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
<debug> [1505128819.075981] [../../git/src/mm-broadband-modem.c:2183] access_tech_context_complete_and_free(): QCDM EVDO open: 0
<debug> [1505128819.078479] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 1 (close)
<debug> [1505128819.091501] [../../git/src/mm-port-serial-at.c:459] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 0,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
<debug> [1505128819.093992] [../../git/src/mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
<debug> [1505128819.096547] [../../git/src/mm-iface-modem.c:1206] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
More information about the ModemManager-devel
mailing list