ptxdist-2013.12.0 + ModemManager + Cinterion PLS8 rel.1
Raul Suarez Moreno
raul.suarez at blue-tc.com
Tue Sep 1 06:16:57 PDT 2015
On Tue, Sep 1, 2015 at 1:05 PM, Aleksander Morgado <aleksander at aleksander.es
> wrote:
> >
> > Sorry, that was my fault. I attach here the full ModemManager debug log
> just
> > from the system booting until the modem enabling process finished. I got
> it
> > after applying Daniels patch, so don't know if anything may be different.
>
> So the modem is indeed being detected as LTE, so that's not the issue.
> I actually checked where the "EPS supported" flag comes from, and we
> don't really set it anywhere during runtime, it's just a plugin
> targeted setting (E.g. Altair LTE sets it to TRUE and resets CS/PS to
> FALSE). So forget about what I previously said :)
>
> > Should I do any checking about Dans patch?
>
> Now, these new logs that Dan added may be indeed useful. But we need a
> longer run from the logs. Can you re-run it with the patch and e.g.
> try to launch a connection as you originally did?
>
> --
> Aleksander
> https://aleksander.es
>
Fine.
I've rerun the --simple-connect method with Dans patch applied. MM log file
attached.
--
Saludos / Best regards
Raúl Suárez
Blue TC
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freedesktop.org/archives/modemmanager-devel/attachments/20150901/5f9370f5/attachment-0001.html>
-------------- next part --------------
<info> [1441116438.359326] [main.c:136] main(): ModemManager (version 1.4.8) starting in system bus...
<warn> [1441116438.522738] [main.c:101] name_lost_cb(): Could not acquire the 'org.freedesktop.ModemManager1' service name
<info> [1441116438.535199] [main.c:187] main(): ModemManager is shut down
<info> [1441116447.978533] [main.c:136] main(): ModemManager (version 1.4.8) starting in system bus...
<debug> [1441116448.168574] [main.c:61] bus_acquired_cb(): Bus acquired, creating manager...
<debug> [1441116448.207344] [mm-plugin-manager.c:852] load_plugins(): Looking for plugins in '/usr/lib/ModemManager'
<debug> [1441116448.289781] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Samsung'
<debug> [1441116448.308360] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Linktop'
<debug> [1441116448.338800] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Via CBP7'
<debug> [1441116448.373347] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'ZTE'
<debug> [1441116448.416894] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Huawei'
<debug> [1441116448.457426] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Longcheer'
<debug> [1441116448.497634] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option'
<debug> [1441116448.561066] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Sierra'
<debug> [1441116448.601786] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Novatel LTE'
<debug> [1441116448.649917] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option High-Speed'
<debug> [1441116448.668603] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Telit'
<debug> [1441116448.707109] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Wavecom'
<debug> [1441116448.746488] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Ericsson MBM'
<debug> [1441116448.802150] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'AnyDATA'
<debug> [1441116448.849532] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Pantech'
<debug> [1441116448.866344] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Generic'
<debug> [1441116448.904984] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'X22X'
<debug> [1441116448.935516] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Gobi'
<debug> [1441116448.977216] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Altair LTE'
<debug> [1441116449.030560] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'MTK'
<debug> [1441116449.055471] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia (Icera)'
<debug> [1441116449.097277] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Novatel'
<debug> [1441116449.186377] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Cinterion'
<debug> [1441116449.285700] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Motorola'
<debug> [1441116449.305940] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia'
<debug> [1441116449.364252] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'SimTech'
<debug> [1441116449.388340] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Iridium'
<debug> [1441116449.418603] [mm-plugin-manager.c:902] load_plugins(): Successfully loaded 27 plugins
<debug> [1441116449.479957] [main.c:83] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
<debug> [1441116449.490222] [mm-base-manager.c:485] mm_base_manager_start(): Starting automatic device scan...
<debug> [1441116450.081410] [mm-base-manager.c:524] mm_base_manager_start(): Finished device scan...
<debug> [1441116450.116718] [mm-base-manager.c:320] device_added(): (tty/ttyAPP0): port's parent platform driver is not whitelisted
<debug> [1441116450.154730] [mm-base-manager.c:320] device_added(): (tty/ttyAPP1): port's parent platform driver is not whitelisted
<debug> [1441116450.195352] [mm-base-manager.c:320] device_added(): (tty/ttyAPP3): port's parent platform driver is not whitelisted
<debug> [1441116450.238445] [mm-base-manager.c:320] device_added(): (tty/ttyAMA0): port's parent platform driver is not whitelisted
<debug> [1441116450.348384] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1] Checking device support...
<debug> [1441116450.382022] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.404839] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.414147] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.426420] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.434797] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.446137] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.454370] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB0] filtered by drivers
<debug> [1441116450.462403] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.471632] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB0] filtered by drivers
<debug> [1441116450.481284] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.489755] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.500121] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB0] filtered by udev tags
<debug> [1441116450.508188] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.516460] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.525868] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.534019] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB0] filtered by drivers
<debug> [1441116450.542130] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.552567] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB0] filtered by udev tags
<debug> [1441116450.561427] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.569740] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.578851] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.587114] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB0] filtered by vendor/product IDs
<debug> [1441116450.595065] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB0] Found '5' plugins to try...
<debug> [1441116450.605626] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Cinterion'
<debug> [1441116450.613590] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Via CBP7'
<debug> [1441116450.622023] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Nokia'
<debug> [1441116450.631063] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Iridium'
<debug> [1441116450.639320] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Generic'
<debug> [1441116450.656348] [mm-plugin.c:767] mm_plugin_supports_port(): (Cinterion) [ttyUSB0] probe required: 'at'
<debug> [1441116450.666724] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at'
<debug> [1441116450.713596] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.725070] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.734148] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.742236] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.750178] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.760439] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.768337] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB1] filtered by drivers
<debug> [1441116450.776738] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.786174] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB1] filtered by drivers
<debug> [1441116450.794660] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.802600] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.813243] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB1] filtered by udev tags
<debug> [1441116450.821709] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.830119] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.839768] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.847631] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB1] filtered by drivers
<debug> [1441116450.856256] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.866386] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB1] filtered by udev tags
<debug> [1441116450.875606] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.883514] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.893141] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.901387] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB1] filtered by vendor/product IDs
<debug> [1441116450.914606] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB1] Found '5' plugins to try...
<debug> [1441116450.928792] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin 'Cinterion'
<debug> [1441116450.937117] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin 'Via CBP7'
<debug> [1441116450.951634] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin 'Nokia'
<debug> [1441116450.960728] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin 'Iridium'
<debug> [1441116450.968657] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin 'Generic'
<debug> [1441116450.977093] [mm-plugin.c:767] mm_plugin_supports_port(): (Cinterion) [ttyUSB1] probe required: 'at'
<debug> [1441116450.988851] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at'
<debug> [1441116451.054090] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.064828] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.074168] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.082102] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.093419] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.103320] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.111038] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB2] filtered by drivers
<debug> [1441116451.118613] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.127473] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB2] filtered by drivers
<debug> [1441116451.134983] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.142564] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.152401] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB2] filtered by udev tags
<debug> [1441116451.159964] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.167357] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.175922] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.844119] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB2] filtered by drivers
<debug> [1441116451.852950] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.861504] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB2] filtered by udev tags
<debug> [1441116451.870008] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.877411] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.884810] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.893616] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB2] filtered by vendor/product IDs
<debug> [1441116451.901326] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB2] Found '5' plugins to try...
<debug> [1441116451.909924] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin 'Cinterion'
<debug> [1441116451.918474] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin 'Via CBP7'
<debug> [1441116451.926042] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin 'Nokia'
<debug> [1441116451.933750] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin 'Iridium'
<debug> [1441116451.942424] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin 'Generic'
<debug> [1441116451.950033] [mm-plugin.c:767] mm_plugin_supports_port(): (Cinterion) [ttyUSB2] probe required: 'at'
<debug> [1441116451.958648] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at'
<debug> [1441116451.985516] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116451.994819] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.002493] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.011421] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.018960] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.027700] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.039874] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB3] filtered by drivers
<debug> [1441116452.047412] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.055026] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB3] filtered by drivers
<debug> [1441116452.063864] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.071366] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.080053] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB3] filtered by udev tags
<debug> [1441116452.088534] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.096161] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.103786] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.112374] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB3] filtered by drivers
<debug> [1441116452.119874] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.128552] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB3] filtered by udev tags
<debug> [1441116452.137351] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.144900] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.152495] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.161280] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB3] filtered by vendor/product IDs
<debug> [1441116452.168901] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB3] Found '5' plugins to try...
<debug> [1441116452.177720] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3] Will try with plugin 'Cinterion'
<debug> [1441116452.186258] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3] Will try with plugin 'Via CBP7'
<debug> [1441116452.193986] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3] Will try with plugin 'Nokia'
<debug> [1441116452.201533] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3] Will try with plugin 'Iridium'
<debug> [1441116452.210077] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB3] Will try with plugin 'Generic'
<debug> [1441116452.217668] [mm-plugin.c:767] mm_plugin_supports_port(): (Cinterion) [ttyUSB3] probe required: 'at'
<debug> [1441116452.226546] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB3) launching port probing: 'at'
<debug> [1441116452.301063] [mm-base-manager.c:320] device_added(): (net/can0): port's parent platform driver is not whitelisted
<debug> [1441116452.323452] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.331597] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wwan0] filtered by subsystem
<debug> [1441116452.340279] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wwan0] filtered by subsystem
<debug> [1441116452.347769] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.356490] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.365270] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wwan0] filtered by subsystem
<debug> [1441116452.479316] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wwan0] filtered by subsystem
<debug> [1441116452.489533] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wwan0] filtered by drivers
<debug> [1441116452.501507] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.508965] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wwan0] filtered by drivers
<debug> [1441116452.516654] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wwan0] filtered by subsystem
<debug> [1441116452.525352] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wwan0] filtered by subsystem
<debug> [1441116452.534044] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wwan0] filtered by udev tags
<debug> [1441116452.541511] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.550232] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.557578] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.565037] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wwan0] filtered by drivers
<debug> [1441116452.573566] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.582182] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wwan0] filtered by subsystem
<debug> [1441116452.589582] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.598128] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wwan0] filtered by vendor/product IDs
<debug> [1441116452.605744] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wwan0] filtered by subsystem
<debug> [1441116452.613245] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wwan0] filtered by subsystem
<debug> [1441116452.621937] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wwan0] filtered by subsystem
<debug> [1441116452.630533] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wwan0] filtered by subsystem
<debug> [1441116452.637964] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wwan0] Found '2' plugins to try...
<debug> [1441116452.646502] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin 'Cinterion'
<debug> [1441116452.654039] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin 'Generic'
<debug> [1441116452.661735] [mm-plugin.c:689] mm_plugin_supports_port(): (Cinterion) [wwan0] probing deferred until result suggested
<debug> [1441116452.677530] [mm-base-manager.c:320] device_added(): (net/eth0): port's parent platform driver is not whitelisted
<debug> [1441116452.694815] [mm-base-manager.c:296] device_added(): (net/sit0): could not get port's parent device
<debug> [1441116452.706360] [mm-base-manager.c:296] device_added(): (net/tunl0): could not get port's parent device
<debug> [1441116452.730032] [mm-plugin.c:212] apply_pre_probing_filters(): (Samsung) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.737619] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.744981] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.753523] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1441116452.762174] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1441116452.769650] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.778359] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.785863] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [cdc-wdm0] filtered by drivers
<debug> [1441116452.793299] [mm-plugin.c:212] apply_pre_probing_filters(): (Novatel LTE) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.802004] [mm-plugin.c:212] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.814222] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.821615] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.830318] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm0] filtered by udev tags
<debug> [1441116452.837706] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1441116452.845190] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1441116452.853802] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1441116452.862427] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [cdc-wdm0] filtered by drivers
<debug> [1441116452.869859] [mm-plugin.c:212] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.878496] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.886524] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.894192] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [cdc-wdm0] filtered by vendor/product IDs
<debug> [1441116452.902782] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.911343] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.918701] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.927419] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [cdc-wdm0] filtered by subsystem
<debug> [1441116452.934853] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '2' plugins to try...
<debug> [1441116452.942353] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin 'Cinterion'
<debug> [1441116452.950824] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin 'Generic'
<debug> [1441116452.959826] [mm-plugin.c:767] mm_plugin_supports_port(): (Cinterion) [cdc-wdm0] probe required: 'qmi'
<debug> [1441116452.967444] [mm-port-probe.c:1368] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'qmi'
<debug> [1441116452.976381] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1] Minimum probing time consumed
<debug> [1441116452.984556] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support check until result suggested
<debug> [1441116453.001056] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
<warn> [1441116453.018132] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
<debug> [1441116453.028060] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
<debug> [1441116453.040887] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB1) opening serial port...
<warn> [1441116453.053338] [mm-port-serial.c:515] real_config_fd(): (ttyUSB1): port attributes not fully set
<debug> [1441116453.061507] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
<debug> [1441116453.072733] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB2) opening serial port...
<warn> [1441116453.084851] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
<debug> [1441116453.094225] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1441116453.105308] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB3) opening serial port...
<warn> [1441116453.117716] [mm-port-serial.c:515] real_config_fd(): (ttyUSB3): port attributes not fully set
<debug> [1441116453.125947] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB3) device open count is 1 (open)
<debug> [1441116453.138256] [mm-port-probe.c:458] wdm_probe_qmi(): (usbmisc/cdc-wdm0) probing QMI...
[/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'...cannot connect to proxy: Could not connect: Connection refusedspawning new qmi-proxy (try 1)...<debug> [1441116453.271952] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT^SQPORT?<CR>'
<debug> [1441116453.283533] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT^SQPORT?<CR>'
<debug> [1441116453.292870] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SQPORT?<CR>'
<debug> [1441116453.303274] [mm-port-serial-at.c:440] debug_log(): (ttyUSB3): --> 'AT^SQPORT?<CR>'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 28
<<<<<< data = 01:1B:00:00:00:00:00:01:00:FF:10:00:01:0D:00:2F:64:65:76:2F:63:64:63:2D:77:64:6D:30
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 27
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 16
<<<<<< message = "Internal Proxy Open" (0xFF00)
<<<<<< TLV:
<<<<<< type = "Device Path" (0x01)
<<<<<< length = 13
<<<<<< value = 2F:64:65:76:2F:63:64:63:2D:77:64:6D:30
<<<<<< translated = /dev/cdc-wdm0
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 19
>>>>>> data = 01:12:00:00:00:00:01:01:00:FF:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 18
>>>>>> flags = 0x00
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Internal Proxy Open" (0xFF00)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
[/dev/cdc-wdm0] Checking version info (10 retries)...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:02:21:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 11
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Version Info" (0x0021)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 133
>>>>>> data = 01:84:00:80:00:00:01:02:21:00:79:00:02:04:00:00:00:00:00:01:6F:00:16:00:01:00:05:00:01:01:00:10:00:02:01:00:0D:00:03:01:00:19:00:04:01:00:03:00:05:01:00:08:00:06:01:00:0D:00:07:01:00:02:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:0B:00:0B:01:00:0C:00:0C:01:00:04:00:0F:01:00:00:00:10:02:00:00:00:11:01:00:00:00:12:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:00:00:1D:01:00:00:00:E0:02:00:0B:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 132
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 121
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 111
>>>>>> value = 16:00:01:00:05:00:01:01:00:10:00:02:01:00:0D:00:03:01:00:19:00:04:01:00:03:00:05:01:00:08:00:06:01:00:0D:00:07:01:00:02:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:0B:00:0B:01:00:0C:00:0C:01:00:04:00:0F:01:00:00:00:10:02:00:00:00:11:01:00:00:00:12:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:00:00:1D:01:00:00:00:E0:02:00:0B:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '5' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '16' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '13' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '25' ] ' [4] = '[ service = 'qos' major_version = '1' minor_version = '3' ] ' [5] = '[ service = 'wms' major_version = '1' minor_version = '8' ] ' [6] = '[ service = 'pds' major_version = '1' minor_version = '13' ] ' [7] = '[ service = 'auth' major_version = '1' minor_version = '2' ] ' [8] = '[ service = 'at' major_version = '1' minor_version = '2' ] ' [9] = '[ service = 'voice' major_version = '2' minor_version = '1' ] ' [10] = '[ service = 'cat2' major_version = '2' minor_version = '11' ] ' [11] = '[ service = 'uim' major_version = '1' minor_version = '12' ] ' [12] = '[ service = 'pbm' major_version = '1' minor_version = '4' ] ' [13] = '[ service = 'test' major_version = '1' minor_version = '0' ] ' [14] = '[ service = 'loc' major_version = '2' minor_version = '0' ] ' [15] = '[ service = 'sar' major_version = '1' minor_version = '0' ] ' [16] = '[ service = 'ims' major_version = '1' minor_version = '0' ] ' [17] = '[ service = 'ts' major_version = '1' minor_version = '0' ] ' [18] = '[ service = 'tmd' major_version = '1' minor_version = '0' ] ' [19] = '[ service = 'wda' major_version = '1' minor_version = '0' ] ' [20] = '[ service = 'csvt' major_version = '1' minor_version = '0' ] ' [21] = '[ service = 'cat' major_version = '2' minor_version = '11' ] '}
[/dev/cdc-wdm0] QMI Device supports 22 services:[/dev/cdc-wdm0] ctl (1.5)[/dev/cdc-wdm0] wds (1.16)[/dev/cdc-wdm0] dms (1.13)[/dev/cdc-wdm0] nas (1.25)[/dev/cdc-wdm0] qos (1.3)[/dev/cdc-wdm0] wms (1.8)[/dev/cdc-wdm0] pds (1.13)[/dev/cdc-wdm0] auth (1.2)[/dev/cdc-wdm0] at (1.2)[/dev/cdc-wdm0] voice (2.1)[/dev/cdc-wdm0] cat2 (2.11)[/dev/cdc-wdm0] uim (1.12)[/dev/cdc-wdm0] pbm (1.4)[/dev/cdc-wdm0] test (1.0)[/dev/cdc-wdm0] loc (2.0)[/dev/cdc-wdm0] sar (1.0)[/dev/cdc-wdm0] ims (1.0)[/dev/cdc-wdm0] ts (1.0)[/dev/cdc-wdm0] tmd (1.0)[/dev/cdc-wdm0] wda (1.0)[/dev/cdc-wdm0] csvt (1.0)[/dev/cdc-wdm0] cat (2.11)<debug> [1441116453.489569] [mm-port-probe.c:273] mm_port_probe_set_result_qmi(): (usbmisc/cdc-wdm0) port is QMI-capable
<debug> [1441116453.523024] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Cinterion) [cdc-wdm0] found best plugin for port
<debug> [1441116453.532525] [mm-plugin-manager.c:232] port_probe_context_finished(): (Plugin Manager) (Cinterion) [cdc-wdm0]: found best plugin for device (/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1)
<debug> [1441116453.542185] [mm-plugin-manager.c:361] suggest_single_port_probe_result(): (Plugin Manager) (Cinterion) [wwan0] deferred task completed, got suggested plugin
<debug> [1441116453.550729] [mm-plugin-manager.c:407] suggest_single_port_probe_result(): (Plugin Manager) (Cinterion) [ttyUSB3] suggested plugin for port
<debug> [1441116453.559988] [mm-plugin-manager.c:407] suggest_single_port_probe_result(): (Plugin Manager) (Cinterion) [ttyUSB2] suggested plugin for port
<debug> [1441116453.568038] [mm-plugin-manager.c:407] suggest_single_port_probe_result(): (Plugin Manager) (Cinterion) [ttyUSB1] suggested plugin for port
<debug> [1441116453.576462] [mm-plugin-manager.c:407] suggest_single_port_probe_result(): (Plugin Manager) (Cinterion) [ttyUSB0] suggested plugin for port
<debug> [1441116453.586329] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm0' port probe finished, still 5 running probes in this device (wwan0, ttyUSB3, ttyUSB2, ttyUSB1, ttyUSB0)
<debug> [1441116453.597290] [mm-plugin.c:689] mm_plugin_supports_port(): (Cinterion) [wwan0] probing deferred until result suggested
<debug> [1441116453.606030] [mm-plugin-manager.c:549] plugin_supports_port_ready(): (Plugin Manager) (Cinterion) [wwan0] task completed, got suggested plugin
<debug> [1441116453.615683] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'wwan0' port probe finished, still 4 running probes in this device (ttyUSB3, ttyUSB2, ttyUSB1, ttyUSB0)
<debug> [1441116454.344570] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>ERROR<CR><LF>'
<debug> [1441116454.355152] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
<debug> [1441116454.370172] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT<CR>'
<debug> [1441116454.587348] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116454.596140] [mm-port-probe.c:154] mm_port_probe_set_result_at(): (tty/ttyUSB2) port is AT-capable
<debug> [1441116454.606007] [mm-port-serial.c:1294] _close_internal(): (ttyUSB2) device open count is 0 (close)
<debug> [1441116454.613899] [mm-port-serial.c:1310] _close_internal(): (ttyUSB2) closing serial port...
<debug> [1441116454.630782] [mm-port-serial.c:1359] _close_internal(): (ttyUSB2) serial port closed
<debug> [1441116454.639839] [mm-port-serial.c:1421] port_serial_close_force(): (ttyUSB2) forced to close port
<debug> [1441116454.650532] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Cinterion) [ttyUSB2] found best plugin for port
<debug> [1441116454.658133] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB2' port probe finished, still 3 running probes in this device (ttyUSB3, ttyUSB1, ttyUSB0)
<debug> [1441116456.670334] [mm-port-serial-at.c:440] debug_log(): (ttyUSB3): --> 'AT<CR>'
<debug> [1441116457.293116] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
<debug> [1441116457.302004] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT<CR>'
<debug> [1441116459.603984] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Sending command failed: 'Resource temporarily unavailable''
<debug> [1441116459.615304] [mm-port-serial.c:1294] _close_internal(): (ttyUSB3) device open count is 0 (close)
<debug> [1441116459.623008] [mm-port-serial.c:1310] _close_internal(): (ttyUSB3) closing serial port...
<debug> [1441116459.639952] [mm-port-serial.c:1359] _close_internal(): (ttyUSB3) serial port closed
<debug> [1441116459.647924] [mm-port-serial.c:1421] port_serial_close_force(): (ttyUSB3) forced to close port
<debug> [1441116459.656830] [mm-plugin-manager.c:480] plugin_supports_port_ready(): (Plugin Manager) [ttyUSB3] ignoring port unsupported by physical modem's plugin
<debug> [1441116459.666330] [mm-plugin-manager.c:189] port_probe_context_finished(): (Plugin Manager) [ttyUSB3] assuming port can be handled by the 'Cinterion' plugin
<debug> [1441116459.675717] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB3' port probe finished, still 2 running probes in this device (ttyUSB1, ttyUSB0)
<debug> [1441116460.290794] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1441116460.301202] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1441116460.329747] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
<debug> [1441116460.338874] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT<CR>'
<debug> [1441116463.993624] [mm-base-manager.c:320] device_added(): (net/wlan0): port's parent platform driver is not whitelisted
<debug> [1441116464.290513] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1441116464.298793] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1441116464.308771] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
<debug> [1441116464.921890] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT<CR>'
<debug> [1441116468.293109] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1441116468.302255] [mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is not AT-capable
<debug> [1441116468.312621] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [1441116468.320084] [mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB1) port is not AT-capable
<debug> [1441116468.331321] [mm-port-serial.c:1294] _close_internal(): (ttyUSB0) device open count is 0 (close)
<debug> [1441116468.848032] [mm-port-serial.c:1310] _close_internal(): (ttyUSB0) closing serial port...
<debug> [1441116468.864885] [mm-port-serial.c:1359] _close_internal(): (ttyUSB0) serial port closed
<debug> [1441116468.882894] [mm-port-serial.c:1421] port_serial_close_force(): (ttyUSB0) forced to close port
<debug> [1441116468.966403] [mm-port-serial.c:1294] _close_internal(): (ttyUSB1) device open count is 0 (close)
<debug> [1441116468.975550] [mm-port-serial.c:1310] _close_internal(): (ttyUSB1) closing serial port...
<debug> [1441116468.991189] [mm-port-serial.c:1359] _close_internal(): (ttyUSB1) serial port closed
<debug> [1441116468.998753] [mm-port-serial.c:1421] port_serial_close_force(): (ttyUSB1) forced to close port
<debug> [1441116469.007211] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Cinterion) [ttyUSB0] found best plugin for port
<debug> [1441116469.015925] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB0' port probe finished, still 1 running probes in this device (ttyUSB1)
<debug> [1441116469.030449] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Cinterion) [ttyUSB1] found best plugin for port
<debug> [1441116469.042267] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'ttyUSB1' port probe finished, last one in device
<debug> [1441116469.051673] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1] device support check finished in '18.674139' seconds
<info> [1441116469.060840] [mm-device.c:520] mm_device_create_modem(): Creating modem with plugin 'Cinterion' and '6' ports
<debug> [1441116469.071157] [cinterion/mm-plugin-cinterion.c:142] create_modem(): QMI-powered Cinterion modem found...
<debug> [1441116469.187789] [mm-base-modem.c:304] mm_base_modem_grab_port(): (cdc-wdm0) type 'qmi' claimed by /sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1
<debug> [1441116469.197666] [mm-base-modem.c:304] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by /sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1
<warn> [1441116469.205821] [mm-plugin.c:903] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB3): 'Cannot add port 'tty/ttyUSB3', unhandled serial type'
<debug> [1441116469.216703] [mm-base-modem.c:304] mm_base_modem_grab_port(): (ttyUSB2) type 'at' claimed by /sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1
<warn> [1441116469.224917] [mm-plugin.c:903] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type'
<warn> [1441116469.232865] [mm-plugin.c:903] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB0): 'Cannot add port 'tty/ttyUSB0', unhandled serial type'
<debug> [1441116469.252260] [mm-base-modem.c:970] log_port(): (/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1) tty/ttyUSB2 at (primary)
<debug> [1441116469.260895] [mm-base-modem.c:970] log_port(): (/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1) net/wwan0 data (primary)
<debug> [1441116469.268384] [mm-base-modem.c:970] log_port(): (/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1) usb/cdc-wdm0 qmi (primary)
<info> [1441116469.284486] [mm-base-manager.c:162] find_device_support_ready(): Modem for device at '/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1' successfully created
[/dev/cdc-wdm0] Opening device with flags 'version-info, net-802-3, net-no-qos-header, proxy'...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 28
<<<<<< data = 01:1B:00:00:00:00:00:01:00:FF:10:00:01:0D:00:2F:64:65:76:2F:63:64:63:2D:77:64:6D:30
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 27
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 16
<<<<<< message = "Internal Proxy Open" (0xFF00)
<<<<<< TLV:
<<<<<< type = "Device Path" (0x01)
<<<<<< length = 13
<<<<<< value = 2F:64:65:76:2F:63:64:63:2D:77:64:6D:30
<<<<<< translated = /dev/cdc-wdm0
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 19
>>>>>> data = 01:12:00:00:00:00:01:01:00:FF:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 18
>>>>>> flags = 0x00
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Internal Proxy Open" (0xFF00)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
[/dev/cdc-wdm0] Checking version info (10 retries)...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:02:21:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 11
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Version Info" (0x0021)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 133
>>>>>> data = 01:84:00:80:00:00:01:02:21:00:79:00:02:04:00:00:00:00:00:01:6F:00:16:00:01:00:05:00:01:01:00:10:00:02:01:00:0D:00:03:01:00:19:00:04:01:00:03:00:05:01:00:08:00:06:01:00:0D:00:07:01:00:02:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:0B:00:0B:01:00:0C:00:0C:01:00:04:00:0F:01:00:00:00:10:02:00:00:00:11:01:00:00:00:12:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:00:00:1D:01:00:00:00:E0:02:00:0B:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 132
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 121
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 111
>>>>>> value = 16:00:01:00:05:00:01:01:00:10:00:02:01:00:0D:00:03:01:00:19:00:04:01:00:03:00:05:01:00:08:00:06:01:00:0D:00:07:01:00:02:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:0B:00:0B:01:00:0C:00:0C:01:00:04:00:0F:01:00:00:00:10:02:00:00:00:11:01:00:00:00:12:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:00:00:1D:01:00:00:00:E0:02:00:0B:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '5' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '16' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '13' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '25' ] ' [4] = '[ service = 'qos' major_version = '1' minor_version = '3' ] ' [5] = '[ service = 'wms' major_version = '1' minor_version = '8' ] ' [6] = '[ service = 'pds' major_version = '1' minor_version = '13' ] ' [7] = '[ service = 'auth' major_version = '1' minor_version = '2' ] ' [8] = '[ service = 'at' major_version = '1' minor_version = '2' ] ' [9] = '[ service = 'voice' major_version = '2' minor_version = '1' ] ' [10] = '[ service = 'cat2' major_version = '2' minor_version = '11' ] ' [11] = '[ service = 'uim' major_version = '1' minor_version = '12' ] ' [12] = '[ service = 'pbm' major_version = '1' minor_version = '4' ] ' [13] = '[ service = 'test' major_version = '1' minor_version = '0' ] ' [14] = '[ service = 'loc' major_version = '2' minor_version = '0' ] ' [15] = '[ service = 'sar' major_version = '1' minor_version = '0' ] ' [16] = '[ service = 'ims' major_version = '1' minor_version = '0' ] ' [17] = '[ service = 'ts' major_version = '1' minor_version = '0' ] ' [18] = '[ service = 'tmd' major_version = '1' minor_version = '0' ] ' [19] = '[ service = 'wda' major_version = '1' minor_version = '0' ] ' [20] = '[ service = 'csvt' major_version = '1' minor_version = '0' ] ' [21] = '[ service = 'cat' major_version = '2' minor_version = '11' ] '}
[/dev/cdc-wdm0] QMI Device supports 22 services:[/dev/cdc-wdm0] ctl (1.5)[/dev/cdc-wdm0] wds (1.16)[/dev/cdc-wdm0] dms (1.13)[/dev/cdc-wdm0] nas (1.25)[/dev/cdc-wdm0] qos (1.3)[/dev/cdc-wdm0] wms (1.8)[/dev/cdc-wdm0] pds (1.13)[/dev/cdc-wdm0] auth (1.2)[/dev/cdc-wdm0] at (1.2)[/dev/cdc-wdm0] voice (2.1)[/dev/cdc-wdm0] cat2 (2.11)[/dev/cdc-wdm0] uim (1.12)[/dev/cdc-wdm0] pbm (1.4)[/dev/cdc-wdm0] test (1.0)[/dev/cdc-wdm0] loc (2.0)[/dev/cdc-wdm0] sar (1.0)[/dev/cdc-wdm0] ims (1.0)[/dev/cdc-wdm0] ts (1.0)[/dev/cdc-wdm0] tmd (1.0)[/dev/cdc-wdm0] wda (1.0)[/dev/cdc-wdm0] csvt (1.0)[/dev/cdc-wdm0] cat (2.11)[/dev/cdc-wdm0] Setting network port data format...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 21
<<<<<< data = 01:14:00:00:00:00:00:03:26:00:09:00:10:02:00:01:00:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 20
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 9
<<<<<< message = "Set Data Format" (0x0026)
<<<<<< TLV:
<<<<<< type = "Protocol" (0x10)
<<<<<< length = 2
<<<<<< value = 01:00
<<<<<< translated = 802-3
<<<<<< TLV:
<<<<<< type = "Format" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = absent
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 28
>>>>>> data = 01:1B:00:80:00:00:01:03:26:00:10:00:02:04:00:00:00:00:00:12:01:00:00:10:02:00:01:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 27
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 16
>>>>>> message = "Set Data Format" (0x0026)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = 0x12
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = "Protocol" (0x10)
>>>>>> length = 2
>>>>>> value = 01:00
>>>>>> translated = 802-3
[/dev/cdc-wdm0] Network port data format operation finished[/dev/cdc-wdm0] Allocating new client ID...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:04:22:00:04:00:01:01:00:02
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 02
<<<<<< translated = dms
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:04:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:02:04
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 12
>>>>>> message = "Allocate CID" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Allocation Info" (0x01)
>>>>>> length = 2
>>>>>> value = 02:04
>>>>>> translated = [ service = 'dms' cid = '4' ]
[/dev/cdc-wdm0] Registered 'dms' (version 1.13) client with ID '4'[/dev/cdc-wdm0] Allocating new client ID...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:05:22:00:04:00:01:01:00:03
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = nas
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:05:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:03:04
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 12
>>>>>> message = "Allocate CID" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Allocation Info" (0x01)
>>>>>> length = 2
>>>>>> value = 03:04
>>>>>> translated = [ service = 'nas' cid = '4' ]
[/dev/cdc-wdm0] Registered 'nas' (version 1.25) client with ID '4'[/dev/cdc-wdm0] Allocating new client ID...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:06:22:00:04:00:01:01:00:05
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 05
<<<<<< translated = wms
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:06:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:05:04
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 12
>>>>>> message = "Allocate CID" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Allocation Info" (0x01)
>>>>>> length = 2
>>>>>> value = 05:04
>>>>>> translated = [ service = 'wms' cid = '4' ]
[/dev/cdc-wdm0] Registered 'wms' (version 1.8) client with ID '4'[/dev/cdc-wdm0] Allocating new client ID...[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:07:22:00:04:00:01:01:00:06
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 7
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 06
<<<<<< translated = pds
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:07:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:06:04
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 7
>>>>>> tlv_length = 12
>>>>>> message = "Allocate CID" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Allocation Info" (0x01)
>>>>>> length = 2
>>>>>> value = 06:04
>>>>>> translated = [ service = 'pds' cid = '4' ]
[/dev/cdc-wdm0] Registered 'pds' (version 1.13) client with ID '4'<debug> [1441116469.536461] [mm-broadband-modem-qmi.c:10206] qmi_port_allocate_client_ready(): Couldn't allocate client for service 'oma': Couldn't create client for service 'oma': Service 'oma' not supported by the device
<debug> [1441116469.553597] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB2) opening serial port...
<warn> [1441116469.565470] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
<debug> [1441116469.574694] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1441116469.582531] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB2): running init sequence...
<debug> [1441116469.591140] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
<debug> [1441116469.600564] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
<debug> [1441116469.652106] [mm-broadband-modem-qmi.c:531] modem_load_current_capabilities(): loading current capabilities...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:01:00:34:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get System Selection Preference" (0x0034)
<debug> [1441116469.665653] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
<debug> [1441116469.684906] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 83
>>>>>> data = 01:52:00:80:03:04:02:01:00:34:00:46:00:02:04:00:00:00:00:00:10:01:00:00:11:02:00:1C:00:12:08:00:80:03:40:01:00:00:02:00:14:02:00:FF:00:15:08:00:C4:00:08:00:00:00:00:00:16:01:00:00:18:04:00:02:00:00:00:19:04:00:00:00:00:00:1C:06:00:05:08:05:04:01:02
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 82
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 70
>>>>>> message = "Get System Selection Preference" (0x0034)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Emergency mode" (0x10)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = no
>>>>>> TLV:
>>>>>> type = "Mode Preference" (0x11)
>>>>>> length = 2
>>>>>> value = 1C:00
>>>>>> translated = gsm, umts, lte
>>>>>> TLV:
>>>>>> type = "Band Preference" (0x12)
>>>>>> length = 8
>>>>>> value = 80:03:40:01:00:00:02:00
>>>>>> translated = gsm-dcs-1800, gsm-900-extended, gsm-900-primary, wcdma-2100, wcdma-dcs-1800, bc-15
>>>>>> TLV:
>>>>>> type = "Roaming Preference" (0x14)
>>>>>> length = 2
>>>>>> value = FF:00
>>>>>> translated = any
>>>>>> TLV:
>>>>>> type = "LTE Band Preference" (0x15)
>>>>>> length = 8
>>>>>> value = C4:00:08:00:00:00:00:00
>>>>>> translated = 3, 7, 8, 20
>>>>>> TLV:
>>>>>> type = "Network Selection Preference" (0x16)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = automatic
>>>>>> TLV:
>>>>>> type = "Service Domain Preference" (0x18)
>>>>>> length = 4
>>>>>> value = 02:00:00:00
>>>>>> translated = cs-ps
>>>>>> TLV:
>>>>>> type = "GSM WCDMA Acquisition Order Preference" (0x19)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = automatic
>>>>>> TLV:
>>>>>> type = 0x1c
>>>>>> length = 6
>>>>>> value = 05:08:05:04:01:02
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:02:00:2B:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Technology Preference" (0x002B)
<debug> [1441116469.713994] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATV1<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 26
>>>>>> data = 01:19:00:80:03:04:02:02:00:2B:00:0D:00:01:03:00:00:00:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 25
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 13
>>>>>> message = "Get Technology Preference" (0x002B)
>>>>>> TLV:
>>>>>> type = "Active" (0x01)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ technology_preference = 'auto' technology_preference_duration = 'permanent' ]
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:01:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Capabilities" (0x0020)
<debug> [1441116469.764637] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116469.773548] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 59
>>>>>> data = 01:3A:00:80:02:04:02:01:00:20:00:2E:00:02:04:00:00:00:00:00:01:0E:00:80:F0:FA:02:00:E1:F5:05:04:02:03:04:05:08:11:08:00:03:00:00:00:00:00:00:00:12:08:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 58
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 46
>>>>>> message = "Get Capabilities" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Info" (0x01)
>>>>>> length = 14
>>>>>> value = 80:F0:FA:02:00:E1:F5:05:04:02:03:04:05:08
>>>>>> translated = [ max_tx_channel_rate = '50000000' max_rx_channel_rate = '100000000' data_service_capability = 'non-simultaneous-cs-ps' sim_capability = 'supported' radio_interface_list = '{ [0] = 'gsm ' [1] = 'umts ' [2] = 'lte '}' ]
>>>>>> TLV:
>>>>>> type = 0x11
>>>>>> length = 8
>>>>>> value = 03:00:00:00:00:00:00:00
>>>>>> TLV:
>>>>>> type = 0x12
>>>>>> length = 8
>>>>>> value = 00:00:00:00:00:00:00:00
<debug> [1441116469.794569] [mm-modem-helpers-qmi.c:1268] mm_modem_capability_from_qmi_capabilities_context(): Current capabilities built: 'gsm-umts, lte'
SSP mode preference: 'gsm, umts, lte'
TP: 'auto'
DMS Capabilities: 'gsm-umts, lte'
<debug> [1441116469.807123] [mm-broadband-modem-qmi.c:693] modem_load_supported_capabilities(): loading supported capabilities...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:02:00:20:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Capabilities" (0x0020)
<debug> [1441116469.835043] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116469.843778] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATX4<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 59
>>>>>> data = 01:3A:00:80:02:04:02:02:00:20:00:2E:00:02:04:00:00:00:00:00:01:0E:00:80:F0:FA:02:00:E1:F5:05:04:02:03:04:05:08:11:08:00:03:00:00:00:00:00:00:00:12:08:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 58
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 46
>>>>>> message = "Get Capabilities" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Info" (0x01)
>>>>>> length = 14
>>>>>> value = 80:F0:FA:02:00:E1:F5:05:04:02:03:04:05:08
>>>>>> translated = [ max_tx_channel_rate = '50000000' max_rx_channel_rate = '100000000' data_service_capability = 'non-simultaneous-cs-ps' sim_capability = 'supported' radio_interface_list = '{ [0] = 'gsm ' [1] = 'umts ' [2] = 'lte '}' ]
>>>>>> TLV:
>>>>>> type = 0x11
>>>>>> length = 8
>>>>>> value = 03:00:00:00:00:00:00:00
>>>>>> TLV:
>>>>>> type = 0x12
>>>>>> length = 8
>>>>>> value = 00:00:00:00:00:00:00:00
<debug> [1441116469.862517] [mm-iface-modem.c:4311] interface_initialization_step(): Modem allows up to 1 bearers
<debug> [1441116469.890154] [mm-bearer-list.c:276] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
<debug> [1441116469.900096] [mm-broadband-modem-qmi.c:995] modem_load_manufacturer(): loading manufacturer...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:03:00:21:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 0
<<<<<< message = "Get Manufacturer" (0x0021)
<debug> [1441116469.922160] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116469.932270] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT&C1<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 44
>>>>>> data = 01:2B:00:80:02:04:02:03:00:21:00:1F:00:02:04:00:00:00:00:00:01:15:00:51:55:41:4C:43:4F:4D:4D:20:49:4E:43:4F:52:50:4F:52:41:54:45:44
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 43
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 31
>>>>>> message = "Get Manufacturer" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Manufacturer" (0x01)
>>>>>> length = 21
>>>>>> value = 51:55:41:4C:43:4F:4D:4D:20:49:4E:43:4F:52:50:4F:52:41:54:45:44
>>>>>> translated = QUALCOMM INCORPORATED
<debug> [1441116469.949721] [mm-broadband-modem-qmi.c:942] modem_load_manufacturer_finish(): loaded manufacturer: QUALCOMM INCORPORATED
<debug> [1441116469.958177] [mm-broadband-modem-qmi.c:1071] modem_load_model(): loading model...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:04:00:22:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 0
<<<<<< message = "Get Model" (0x0022)
<debug> [1441116469.979931] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116469.988608] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:02:04:02:04:00:22:00:0B:00:02:04:00:00:00:00:00:01:01:00:30
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 11
>>>>>> message = "Get Model" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Model" (0x01)
>>>>>> length = 1
>>>>>> value = 30
>>>>>> translated = 0
<debug> [1441116470.014690] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116470.048555] [mm-port-serial.c:1294] _close_internal(): (ttyUSB2) device open count is 2 (close)
<debug> [1441116470.057007] [mm-broadband-modem-qmi.c:1018] modem_load_model_finish(): loaded model: 0
<debug> [1441116470.065404] [mm-broadband-modem-qmi.c:1147] modem_load_revision(): loading revision...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:05:00:23:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 0
<<<<<< message = "Get Revision" (0x0023)
<debug> [1441116470.078470] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 75
>>>>>> data = 01:4A:00:80:02:04:02:05:00:23:00:3E:00:02:04:00:00:00:00:00:01:34:00:4D:39:36:31:35:41:2D:43:45:54:57:4D:41:5A:4D:2D:32:2E:30:2E:31:39:30:33:30:20:20:31:20:20:5B:4A:75:6C:20:30:38:20:32:30:31:33:20:30:32:3A:30:30:3A:30:30:5D
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 74
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 62
>>>>>> message = "Get Revision" (0x0023)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Revision" (0x01)
>>>>>> length = 52
>>>>>> value = 4D:39:36:31:35:41:2D:43:45:54:57:4D:41:5A:4D:2D:32:2E:30:2E:31:39:30:33:30:20:20:31:20:20:5B:4A:75:6C:20:30:38:20:32:30:31:33:20:30:32:3A:30:30:3A:30:30:5D
>>>>>> translated = M9615A-CETWMAZM-2.0.19030 1 [Jul 08 2013 02:00:00]
<debug> [1441116470.110753] [mm-broadband-modem-qmi.c:1094] modem_load_revision_finish(): loaded revision: M9615A-CETWMAZM-2.0.19030 1 [Jul 08 2013 02:00:00]
<debug> [1441116470.120254] [mm-broadband-modem-qmi.c:1289] modem_load_equipment_identifier(): loading equipment identifier...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:06:00:25:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 0
<<<<<< message = "Get IDs" (0x0025)
<debug> [1441116470.137091] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116470.145591] [mm-port-serial.c:1294] _close_internal(): (ttyUSB2) device open count is 1 (close)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 46
>>>>>> data = 01:2D:00:80:02:04:02:06:00:25:00:21:00:02:04:00:00:00:00:00:13:01:00:31:10:01:00:30:11:0F:00:33:35:38:37:30:39:30:35:30:30:31:31:36:33:38
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 45
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 33
>>>>>> message = "Get IDs" (0x0025)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = 0x13
>>>>>> length = 1
>>>>>> value = 31
>>>>>> TLV:
>>>>>> type = "Esn" (0x10)
>>>>>> length = 1
>>>>>> value = 30
>>>>>> translated = 0
>>>>>> TLV:
>>>>>> type = "Imei" (0x11)
>>>>>> length = 15
>>>>>> value = 33:35:38:37:30:39:30:35:30:30:31:31:36:33:38
>>>>>> translated = 358709050011638
<debug> [1441116470.173564] [mm-broadband-modem-qmi.c:1186] modem_load_equipment_identifier_finish(): loaded equipment identifier: 358709050011638
<debug> [1441116470.207847] [mm-broadband-modem-qmi.c:1324] modem_load_device_identifier(): loading device identifier...
<debug> [1441116470.216729] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '00001e2d00000060358709050011638M9615A-CETWMAZM-2.0.190301[Jul08201302:00:00]0QUALCOMMINCORPORATED'
<debug> [1441116470.225670] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID '6c38cc8aee85cabc91529a6661ae83b27933885c'
<debug> [1441116470.235098] [mm-broadband-modem-qmi.c:1312] modem_load_device_identifier_finish(): loaded device identifier: 6c38cc8aee85cabc91529a6661ae83b27933885c
<debug> [1441116470.245401] [mm-broadband-modem-qmi.c:1727] modem_load_supported_bands(): loading band capabilities...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:07:00:45:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 7
<<<<<< tlv_length = 0
<<<<<< message = "Get Band Capabilities" (0x0045)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 42
>>>>>> data = 01:29:00:80:02:04:02:07:00:45:00:1D:00:02:04:00:00:00:00:00:10:08:00:C5:00:08:00:00:00:00:00:01:08:00:80:03:40:01:00:00:02:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 41
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 7
>>>>>> tlv_length = 29
>>>>>> message = "Get Band Capabilities" (0x0045)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "LTE Band Capability" (0x10)
>>>>>> length = 8
>>>>>> value = C5:00:08:00:00:00:00:00
>>>>>> translated = 1, 3, 7, 8, 20
>>>>>> TLV:
>>>>>> type = "Band Capability" (0x01)
>>>>>> length = 8
>>>>>> value = 80:03:40:01:00:00:02:00
>>>>>> translated = gsm-dcs-1800, gsm-900-extended, gsm-900-primary, wcdma-2100, wcdma-dcs-1800, bc-15
<debug> [1441116470.272115] [mm-broadband-modem-qmi.c:2781] load_power_state(): Getting device operating mode...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:08:00:2D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 0
<<<<<< message = "Get Operating Mode" (0x002D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:02:04:02:08:00:2D:00:0B:00:02:04:00:00:00:00:00:01:01:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 8
>>>>>> tlv_length = 11
>>>>>> message = "Get Operating Mode" (0x002D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Mode" (0x01)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = online
<debug> [1441116470.301721] [mm-broadband-modem-qmi.c:1533] modem_load_unlock_required(): loading unlock required...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:09:00:2B:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get PIN Status" (0x002B)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 32
>>>>>> data = 01:1F:00:80:02:04:02:09:00:2B:00:13:00:02:04:00:00:00:00:00:12:03:00:01:03:0A:11:03:00:02:03:0A
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 31
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 9
>>>>>> tlv_length = 19
>>>>>> message = "UIM Get PIN Status" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "PIN2 Status" (0x12)
>>>>>> length = 3
>>>>>> value = 01:03:0A
>>>>>> translated = [ current_status = 'enabled-not-verified' verify_retries_left = '3' unblock_retries_left = '10' ]
>>>>>> TLV:
>>>>>> type = "PIN1 Status" (0x11)
>>>>>> length = 3
>>>>>> value = 02:03:0A
>>>>>> translated = [ current_status = 'enabled-verified' verify_retries_left = '3' unblock_retries_left = '10' ]
<debug> [1441116470.333941] [mm-broadband-modem-qmi.c:1626] modem_load_unlock_retries(): loading unlock retries...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:0A:00:2B:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get PIN Status" (0x002B)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 32
>>>>>> data = 01:1F:00:80:02:04:02:0A:00:2B:00:13:00:02:04:00:00:00:00:00:12:03:00:01:03:0A:11:03:00:02:03:0A
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 31
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 10
>>>>>> tlv_length = 19
>>>>>> message = "UIM Get PIN Status" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "PIN2 Status" (0x12)
>>>>>> length = 3
>>>>>> value = 01:03:0A
>>>>>> translated = [ current_status = 'enabled-not-verified' verify_retries_left = '3' unblock_retries_left = '10' ]
>>>>>> TLV:
>>>>>> type = "PIN1 Status" (0x11)
>>>>>> length = 3
>>>>>> value = 02:03:0A
>>>>>> translated = [ current_status = 'enabled-verified' verify_retries_left = '3' unblock_retries_left = '10' ]
<debug> [1441116470.399630] [mm-iface-modem.c:3076] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
<debug> [1441116470.415642] [mm-sim-qmi.c:148] load_sim_identifier(): loading SIM identifier...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:0B:00:3C:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 11
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get ICCID" (0x003C)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 42
>>>>>> data = 01:29:00:80:02:04:02:0B:00:3C:00:1D:00:02:04:00:00:00:00:00:01:13:00:38:39:33:34:35:36:35:35:32:31:35:30:30:37:34:36:36:37:36
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 41
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 11
>>>>>> tlv_length = 29
>>>>>> message = "UIM Get ICCID" (0x003C)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "ICCID" (0x01)
>>>>>> length = 19
>>>>>> value = 38:39:33:34:35:36:35:35:32:31:35:30:30:37:34:36:36:37:36
>>>>>> translated = 8934565521500746676
<debug> [1441116470.462016] [mm-sim-qmi.c:95] load_sim_identifier_finish(): loaded SIM identifier: 8934565521500746676
<debug> [1441116470.483673] [mm-sim-qmi.c:224] load_imsi(): loading IMSI...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:0C:00:43:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 12
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get IMSI" (0x0043)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 38
>>>>>> data = 01:25:00:80:02:04:02:0C:00:43:00:19:00:02:04:00:00:00:00:00:01:0F:00:32:31:34:30:31:35:35:31:38:37:39:31:34:33:39
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 37
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 12
>>>>>> tlv_length = 25
>>>>>> message = "UIM Get IMSI" (0x0043)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "IMSI" (0x01)
>>>>>> length = 15
>>>>>> value = 32:31:34:30:31:35:35:31:38:37:39:31:34:33:39
>>>>>> translated = 214015518791439
<debug> [1441116470.524173] [mm-sim-qmi.c:171] load_imsi_finish(): loaded IMSI: 214015518791439
<debug> [1441116470.535697] [mm-broadband-modem-qmi.c:1408] modem_load_own_numbers(): loading own numbers...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:0D:00:24:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 13
<<<<<< tlv_length = 0
<<<<<< message = "Get MSISDN" (0x0024)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:02:04:02:0D:00:24:00:07:00:02:04:00:01:00:10:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 13
>>>>>> tlv_length = 7
>>>>>> message = "Get MSISDN" (0x0024)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:10:00
>>>>>> translated = FAILURE: NotProvisioned
<warn> [1441116470.591506] [mm-iface-modem.c:4096] load_own_numbers_ready(): couldn't load list of Own Numbers: 'Couldn't get MSISDN: QMI protocol error (16): 'NotProvisioned''
<debug> [1441116470.600807] [mm-broadband-modem-qmi.c:1875] modem_load_current_bands(): loading current bands...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:03:00:31:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 0
<<<<<< message = "Get RF Band Information" (0x0031)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 29
>>>>>> data = 01:1C:00:80:03:04:02:03:00:31:00:10:00:02:04:00:00:00:00:00:01:06:00:01:08:7A:00:C8:05
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 28
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 16
>>>>>> message = "Get RF Band Information" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = 0x01
>>>>>> length = 6
>>>>>> value = 01:08:7A:00:C8:05
<warn> [1441116470.653434] [mm-iface-modem.c:4146] load_current_bands_ready(): couldn't load current Bands: 'Couldn't parse the list of current bands'
<debug> [1441116470.697889] [mm-broadband-modem-qmi.c:3380] modem_3gpp_load_imei_finish(): loaded IMEI: 358709050011638
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:02:04:00:0E:00:40:00:04:00:01:01:00:04
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 14
<<<<<< tlv_length = 4
<<<<<< message = "UIM Get CK Status" (0x0040)
<<<<<< TLV:
<<<<<< type = "Facility" (0x01)
<<<<<< length = 1
<<<<<< value = 04
<<<<<< translated = pf
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 26
>>>>>> data = 01:19:00:80:02:04:02:0E:00:40:00:0D:00:02:04:00:00:00:00:00:01:03:00:00:0A:20
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 25
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 14
>>>>>> tlv_length = 13
>>>>>> message = "UIM Get CK Status" (0x0040)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "CK Status" (0x01)
>>>>>> length = 3
>>>>>> value = 00:0A:20
>>>>>> translated = [ facility_state = 'deactivated' verify_retries_left = '10' unblock_retries_left = '32' ]
<debug> [1441116470.748277] [mm-broadband-modem-qmi.c:3475] dms_uim_get_ck_status_ready(): Facility 'ph-sim' is: 'deactivated'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:02:04:00:0F:00:40:00:04:00:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 15
<<<<<< tlv_length = 4
<<<<<< message = "UIM Get CK Status" (0x0040)
<<<<<< TLV:
<<<<<< type = "Facility" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = pn
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 26
>>>>>> data = 01:19:00:80:02:04:02:0F:00:40:00:0D:00:02:04:00:00:00:00:00:01:03:00:00:0A:20
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 25
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 15
>>>>>> tlv_length = 13
>>>>>> message = "UIM Get CK Status" (0x0040)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "CK Status" (0x01)
>>>>>> length = 3
>>>>>> value = 00:0A:20
>>>>>> translated = [ facility_state = 'deactivated' verify_retries_left = '10' unblock_retries_left = '32' ]
<debug> [1441116470.780210] [mm-broadband-modem-qmi.c:3475] dms_uim_get_ck_status_ready(): Facility 'net-pers' is: 'deactivated'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:02:04:00:10:00:40:00:04:00:01:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 16
<<<<<< tlv_length = 4
<<<<<< message = "UIM Get CK Status" (0x0040)
<<<<<< TLV:
<<<<<< type = "Facility" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = pu
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 26
>>>>>> data = 01:19:00:80:02:04:02:10:00:40:00:0D:00:02:04:00:00:00:00:00:01:03:00:00:0A:20
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 25
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 16
>>>>>> tlv_length = 13
>>>>>> message = "UIM Get CK Status" (0x0040)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "CK Status" (0x01)
>>>>>> length = 3
>>>>>> value = 00:0A:20
>>>>>> translated = [ facility_state = 'deactivated' verify_retries_left = '10' unblock_retries_left = '32' ]
<debug> [1441116470.816469] [mm-broadband-modem-qmi.c:3475] dms_uim_get_ck_status_ready(): Facility 'net-sub-pers' is: 'deactivated'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:02:04:00:11:00:40:00:04:00:01:01:00:02
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 17
<<<<<< tlv_length = 4
<<<<<< message = "UIM Get CK Status" (0x0040)
<<<<<< TLV:
<<<<<< type = "Facility" (0x01)
<<<<<< length = 1
<<<<<< value = 02
<<<<<< translated = pp
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 26
>>>>>> data = 01:19:00:80:02:04:02:11:00:40:00:0D:00:02:04:00:00:00:00:00:01:03:00:00:0A:20
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 25
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 17
>>>>>> tlv_length = 13
>>>>>> message = "UIM Get CK Status" (0x0040)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "CK Status" (0x01)
>>>>>> length = 3
>>>>>> value = 00:0A:20
>>>>>> translated = [ facility_state = 'deactivated' verify_retries_left = '10' unblock_retries_left = '32' ]
<debug> [1441116470.875971] [mm-broadband-modem-qmi.c:3475] dms_uim_get_ck_status_ready(): Facility 'provider-pers' is: 'deactivated'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:02:04:00:12:00:40:00:04:00:01:01:00:03
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 18
<<<<<< tlv_length = 4
<<<<<< message = "UIM Get CK Status" (0x0040)
<<<<<< TLV:
<<<<<< type = "Facility" (0x01)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = pc
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 26
>>>>>> data = 01:19:00:80:02:04:02:12:00:40:00:0D:00:02:04:00:00:00:00:00:01:03:00:00:0A:20
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 25
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 18
>>>>>> tlv_length = 13
>>>>>> message = "UIM Get CK Status" (0x0040)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "CK Status" (0x01)
>>>>>> length = 3
>>>>>> value = 00:0A:20
>>>>>> translated = [ facility_state = 'deactivated' verify_retries_left = '10' unblock_retries_left = '32' ]
<debug> [1441116470.907980] [mm-broadband-modem-qmi.c:3475] dms_uim_get_ck_status_ready(): Facility 'corp-pers' is: 'deactivated'
<debug> [1441116470.927705] [mm-broadband-modem.c:8998] iface_modem_3gpp_ussd_initialize_ready(): Couldn't initialize interface: 'USSD not supported'
<debug> [1441116470.963053] [mm-broadband-modem-qmi.c:6796] messaging_check_support(): Messaging capabilities supported
<debug> [1441116470.973861] [mm-iface-modem-messaging.c:1148] load_supported_storages_ready(): Supported storages loaded:
<debug> [1441116470.981490] [mm-iface-modem-messaging.c:1149] load_supported_storages_ready(): mem1 (list/read/delete) storages: 'sm, me'
<debug> [1441116470.990290] [mm-iface-modem-messaging.c:1150] load_supported_storages_ready(): mem2 (write/send) storages: 'sm, me'
<debug> [1441116470.997817] [mm-iface-modem-messaging.c:1151] load_supported_storages_ready(): mem3 (reception) storages: 'sm, me'
<debug> [1441116471.010733] [mm-broadband-modem.c:9002] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
<debug> [1441116471.023489] [mm-broadband-modem-qmi.c:9635] signal_check_support(): Extended signal capabilities supported
<debug> [1441116471.039584] [mm-broadband-modem-qmi.c:8349] oma_check_support(): OMA capabilities not supported
<debug> [1441116471.048291] [mm-broadband-modem.c:9004] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
<debug> [1441116471.060191] [mm-broadband-modem-qmi.c:9301] firmware_check_support(): loading firmware images...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:13:00:49:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 19
<<<<<< tlv_length = 0
<<<<<< message = "List Stored Images" (0x0049)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:02:04:02:13:00:49:00:07:00:02:04:00:01:00:47:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 19
>>>>>> tlv_length = 7
>>>>>> message = "List Stored Images" (0x0049)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:47:00
>>>>>> translated = FAILURE: InvalidQmiCommand
<debug> [1441116471.101486] [mm-broadband-modem.c:9005] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
<info> [1441116471.113774] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem: state changed (unknown -> disabled)
<debug> [1441116471.125416] [mm-port-serial.c:1294] _close_internal(): (ttyUSB2) device open count is 0 (close)
<debug> [1441116471.134459] [mm-port-serial.c:1310] _close_internal(): (ttyUSB2) closing serial port...
<debug> [1441116471.145158] [mm-port-serial.c:1359] _close_internal(): (ttyUSB2) serial port closed
<debug> [1441116471.154205] [mm-base-modem.c:939] initialize_ready(): modem properly initialized
<debug> [1441116471.194583] [mm-device.c:447] export_modem(): Exported modem '/sys/devices/soc0/80080000.ahb/80090000.usb/ci_hdrc.1/usb2/2-1' at path '/org/freedesktop/ModemManager1/Modem/0'
<debug> [1441116471.202534] [mm-device.c:457] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Cinterion' modem, VID 0x1E2D PID 0x0060 (usb)
<info> [1441116621.134486] [mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
<debug> [1441116621.197674] [mm-iface-modem-simple.c:651] connect_auth_ready(): PIN: unspecified
<debug> [1441116621.206698] [mm-iface-modem-simple.c:653] connect_auth_ready(): Operator ID: unspecified
<debug> [1441116621.215668] [mm-iface-modem-simple.c:655] connect_auth_ready(): Allowed roaming: yes
<debug> [1441116621.223158] [mm-iface-modem-simple.c:657] connect_auth_ready(): APN: airtelwap.es
<debug> [1441116621.230853] [mm-iface-modem-simple.c:665] connect_auth_ready(): IP family: unspecified
<debug> [1441116621.264707] [mm-iface-modem-simple.c:673] connect_auth_ready(): Allowed authentication: unspecified
<debug> [1441116621.272219] [mm-iface-modem-simple.c:675] connect_auth_ready(): User: unspecified
<debug> [1441116621.279955] [mm-iface-modem-simple.c:677] connect_auth_ready(): Password: unspecified
<debug> [1441116621.288608] [mm-iface-modem-simple.c:679] connect_auth_ready(): Number: unspecified
<info> [1441116621.296395] [mm-iface-modem-simple.c:461] connection_step(): Simple connect state (3/8): Enable
<info> [1441116621.305028] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
<debug> [1441116621.337938] [mm-broadband-modem.c:8003] enabling_started(): Skipping modem initialization: not required
<debug> [1441116621.347129] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB2) opening serial port...
<warn> [1441116621.358170] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
<debug> [1441116621.367727] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
<debug> [1441116621.375721] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB2): running init sequence...
<debug> [1441116621.384098] [mm-broadband-modem.c:8016] enabling_started(): Flashing primary AT port before enabling...
<debug> [1441116621.395464] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
<debug> [1441116621.415413] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116621.424754] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATV1<CR>'
<debug> [1441116621.447033] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116621.456310] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
<debug> [1441116621.486554] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
<debug> [1441116621.500348] [mm-broadband-modem-qmi.c:2781] load_power_state(): Getting device operating mode...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:04:00:14:00:2D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 20
<<<<<< tlv_length = 0
<<<<<< message = "Get Operating Mode" (0x002D)
<debug> [1441116621.512681] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATX4<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:02:04:02:14:00:2D:00:0B:00:02:04:00:00:00:00:00:01:01:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 20
>>>>>> tlv_length = 11
>>>>>> message = "Get Operating Mode" (0x002D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Mode" (0x01)
>>>>>> length = 1
>>>>>> value = 00
>>>>>> translated = online
<debug> [1441116621.532905] [mm-iface-modem.c:3259] set_power_state(): No need to change power state: already in 'on' power state
<debug> [1441116621.544377] [mm-broadband-modem.c:8592] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
<debug> [1441116621.553945] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 27
<<<<<< data = 01:1A:00:00:03:04:00:04:00:50:00:0E:00:10:0B:00:0A:9C:9F:A1:A4:A6:AB:B0:B5:BA:BF
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 26
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 14
<<<<<< message = "Config Signal Info" (0x0050)
<<<<<< TLV:
<<<<<< type = "RSSI Threshold" (0x10)
<<<<<< length = 11
<<<<<< value = 0A:9C:9F:A1:A4:A6:AB:B0:B5:BA:BF
<<<<<< translated = { [0] = '-100 ' [1] = '-97 ' [2] = '-95 ' [3] = '-92 ' [4] = '-90 ' [5] = '-85 ' [6] = '-80 ' [7] = '-75 ' [8] = '-70 ' [9] = '-65 '}
<debug> [1441116621.569404] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT&C1<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:04:02:04:00:50:00:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 7
>>>>>> message = "Config Signal Info" (0x0050)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:03:04:00:05:00:03:00:04:00:19:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 4
<<<<<< message = "Register Indications" (0x0003)
<<<<<< TLV:
<<<<<< type = "Signal Info" (0x19)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = yes
<debug> [1441116621.654460] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:04:02:05:00:03:00:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 7
>>>>>> message = "Register Indications" (0x0003)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:03:04:00:06:00:03:00:04:00:13:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 4
<<<<<< message = "Register Indications" (0x0003)
<<<<<< TLV:
<<<<<< type = "Serving System Events" (0x13)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = yes
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:04:02:06:00:03:00:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 7
>>>>>> message = "Register Indications" (0x0003)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
<debug> [1441116621.692416] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:07:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 7
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:07:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 7
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116621.734092] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116621.753780] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116621.761628] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116621.770688] [mm-broadband-modem.c:8633] enabling_step(): Modem has location capabilities, enabling the Location interface...
<debug> [1441116621.792583] [mm-iface-modem-location.c:735] setup_gathering(): Location 'gps-raw' gathering is already disabled...
<debug> [1441116622.333344] [mm-iface-modem-location.c:735] setup_gathering(): Location 'gps-nmea' gathering is already disabled...
<debug> [1441116622.341400] [mm-iface-modem-location.c:759] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
<debug> [1441116622.360234] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:08:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
<debug> [1441116622.383675] [mm-broadband-modem.c:8646] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:08:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 8
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<debug> [1441116622.404986] [mm-broadband-modem-qmi.c:6984] messaging_set_default_storage(): setting default messaging routes...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 26
<<<<<< data = 01:19:00:00:05:04:00:01:00:32:00:0D:00:01:0A:00:02:00:00:00:01:01:00:01:01:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 25
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 13
<<<<<< message = "Set Routes" (0x0032)
<<<<<< TLV:
<<<<<< type = "Route List" (0x01)
<<<<<< length = 10
<<<<<< value = 02:00:00:00:01:01:00:01:01:01
<<<<<< translated = { [0] = '[ message_type = 'point' message_class = '0' storage = 'nv' receipt_action = 'store-and-notify' ] ' [1] = '[ message_type = 'point' message_class = '1' storage = 'nv' receipt_action = 'store-and-notify' ] '}
<info> [1441116622.421684] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116622.445144] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116622.452889] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:01:00:32:00:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Set Routes" (0x0032)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
<debug> [1441116622.476627] [mm-broadband-modem-qmi.c:7277] load_initial_sms_parts_step(): loading all 3GPP messages from storage 'sm'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 21
<<<<<< data = 01:14:00:00:05:04:00:02:00:31:00:08:00:12:01:00:01:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 20
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 8
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:02:00:31:00:07:00:02:04:00:01:00:11:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:11:00
>>>>>> translated = FAILURE: MissingArgument
Couldn't read SMS messages: QMI protocol error (17): 'MissingArgument'<debug> [1441116622.524227] [mm-broadband-modem-qmi.c:7282] load_initial_sms_parts_step(): loading 3GPP MT-read messages from storage 'sm'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:03:00:31:00:0C:00:12:01:00:01:11:01:00:00:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = mt-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:03:00:31:00:07:00:02:04:00:01:00:34:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:34:00
>>>>>> translated = FAILURE: DeviceNotReady
Couldn't read SMS messages: QMI protocol error (52): 'DeviceNotReady'<debug> [1441116622.556168] [mm-broadband-modem-qmi.c:7288] load_initial_sms_parts_step(): loading 3GPP MT-not-read messages from storage 'sm'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:04:00:31:00:0C:00:12:01:00:01:11:01:00:01:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = mt-not-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 27
>>>>>> data = 01:1A:00:80:05:04:02:04:00:31:00:0E:00:02:04:00:00:00:00:00:01:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 26
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 14
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Message List" (0x01)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = {}
<debug> [1441116622.683872] [mm-broadband-modem-qmi.c:7294] load_initial_sms_parts_step(): loading 3GPP MO-sent messages from storage 'sm'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:05:00:31:00:0C:00:12:01:00:01:11:01:00:02:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 02
<<<<<< translated = mo-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:05:00:31:00:07:00:02:04:00:01:00:30:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 5
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'<debug> [1441116622.716557] [mm-broadband-modem-qmi.c:7300] load_initial_sms_parts_step(): loading 3GPP MO-not-sent messages from storage 'sm'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:06:00:31:00:0C:00:12:01:00:01:11:01:00:03:01:01:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = mo-not-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = uim
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:06:00:31:00:07:00:02:04:00:01:00:30:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'<debug> [1441116622.748494] [mm-broadband-modem-qmi.c:7277] load_initial_sms_parts_step(): loading all 3GPP messages from storage 'me'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 21
<<<<<< data = 01:14:00:00:05:04:00:07:00:31:00:08:00:12:01:00:01:01:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 20
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 7
<<<<<< tlv_length = 8
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:07:00:31:00:07:00:02:04:00:01:00:11:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 7
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:11:00
>>>>>> translated = FAILURE: MissingArgument
Couldn't read SMS messages: QMI protocol error (17): 'MissingArgument'<debug> [1441116622.780396] [mm-broadband-modem-qmi.c:7282] load_initial_sms_parts_step(): loading 3GPP MT-read messages from storage 'me'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:08:00:31:00:0C:00:12:01:00:01:11:01:00:00:01:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 00
<<<<<< translated = mt-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:08:00:31:00:07:00:02:04:00:01:00:34:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 8
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:34:00
>>>>>> translated = FAILURE: DeviceNotReady
Couldn't read SMS messages: QMI protocol error (52): 'DeviceNotReady'<debug> [1441116622.812267] [mm-broadband-modem-qmi.c:7288] load_initial_sms_parts_step(): loading 3GPP MT-not-read messages from storage 'me'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:09:00:31:00:0C:00:12:01:00:01:11:01:00:01:01:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = mt-not-read
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 27
>>>>>> data = 01:1A:00:80:05:04:02:09:00:31:00:0E:00:02:04:00:00:00:00:00:01:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 26
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 9
>>>>>> tlv_length = 14
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Message List" (0x01)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = {}
<debug> [1441116622.875982] [mm-broadband-modem-qmi.c:7294] load_initial_sms_parts_step(): loading 3GPP MO-sent messages from storage 'me'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:0A:00:31:00:0C:00:12:01:00:01:11:01:00:02:01:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 02
<<<<<< translated = mo-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:0A:00:31:00:07:00:02:04:00:01:00:30:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 10
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'<debug> [1441116622.908780] [mm-broadband-modem-qmi.c:7300] load_initial_sms_parts_step(): loading 3GPP MO-not-sent messages from storage 'me'...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 25
<<<<<< data = 01:18:00:00:05:04:00:0B:00:31:00:0C:00:12:01:00:01:11:01:00:03:01:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 24
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 11
<<<<<< tlv_length = 12
<<<<<< message = "List Messages" (0x0031)
<<<<<< TLV:
<<<<<< type = "Message Mode" (0x12)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = gsm-wcdma
<<<<<< TLV:
<<<<<< type = "Message Tag" (0x11)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = mo-not-sent
<<<<<< TLV:
<<<<<< type = "Storage Type" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = nv
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:0B:00:31:00:07:00:02:04:00:01:00:30:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 11
>>>>>> tlv_length = 7
>>>>>> message = "List Messages" (0x0031)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:30:00
>>>>>> translated = FAILURE: InvalidArgument
Couldn't read SMS messages: QMI protocol error (48): 'InvalidArgument'[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:05:04:00:0C:00:01:00:04:00:10:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "wms"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 12
<<<<<< tlv_length = 4
<<<<<< message = "Set Event Report" (0x0001)
<<<<<< TLV:
<<<<<< type = "New MT Message Indicator" (0x10)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = [ report = 'yes' ]
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:05:04:02:0C:00:01:00:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "wms"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 12
>>>>>> tlv_length = 7
>>>>>> message = "Set Event Report" (0x0001)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
<debug> [1441116622.972616] [mm-broadband-modem.c:8672] enabling_step(): Modem has extended signal reporting capabilities, enabling the Signal interface...
<debug> [1441116622.980692] [mm-iface-modem-signal.c:206] setup_refresh_context(): Extended signal information reporting disabled (rate: 0 seconds)
<info> [1441116622.991291] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> enabled)
<info> [1441116623.020125] [mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
<info> [1441116623.030737] [mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
<debug> [1441116623.040362] [mm-iface-modem-3gpp.c:397] mm_iface_modem_3gpp_register_in_network(): Launching automatic network registration...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:03:04:00:09:00:22:00:04:00:01:01:00:01
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 4
<<<<<< message = "Initiate Network Register" (0x0022)
<<<<<< TLV:
<<<<<< type = "Action" (0x01)
<<<<<< length = 1
<<<<<< value = 01
<<<<<< translated = automatic
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:04:02:09:00:22:00:07:00:02:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 9
>>>>>> tlv_length = 7
>>>>>> message = "Initiate Network Register" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
<debug> [1441116623.100927] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:0A:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:0A:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 10
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116623.135511] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116623.155619] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116623.163287] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116623.171520] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116626.293695] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:0B:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 11
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:0B:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 11
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116626.335642] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116626.360062] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116626.367812] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116626.375885] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116629.293154] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:0C:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 12
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:0C:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 12
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116629.343711] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116629.368413] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116629.376271] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116629.384692] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116632.292847] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:0D:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 13
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:0D:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 13
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116632.319417] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116632.344075] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116632.433756] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116632.443434] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116635.293404] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:0E:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 14
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:0E:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 14
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116635.327511] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116635.344377] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116635.353151] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116635.361644] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116638.293401] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:0F:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 15
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:0F:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 15
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116638.335642] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116638.358897] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116638.366909] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116638.376247] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116641.293560] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:10:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 16
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:10:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 16
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116641.343730] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116641.368147] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116641.375993] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116641.384373] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116644.292616] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:11:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 17
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:11:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 17
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116644.319442] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116644.342912] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116644.350709] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116644.358911] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116647.293356] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:12:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 18
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:12:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 18
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116647.326950] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116647.351261] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116647.359190] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116647.367549] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116650.292759] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:13:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 19
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:13:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 19
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116650.334968] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116650.344043] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116650.351925] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116650.373123] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116653.293362] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:14:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 20
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:14:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 20
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116653.343253] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116653.365203] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116653.372881] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116653.381261] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116656.293239] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:15:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 21
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:15:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 21
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116656.318635] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116656.345207] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116656.354371] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116656.362655] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116659.292880] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:16:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 22
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:16:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 22
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116659.327496] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116659.351086] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116659.358744] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116659.368335] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116662.293583] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:17:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 23
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:17:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 23
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116662.335668] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116662.360563] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116662.368497] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116662.376903] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116665.293021] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:18:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 24
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:18:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 24
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116665.343789] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116665.369279] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116665.377165] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116665.385386] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 33
>>>>>> data = 01:20:00:80:03:04:04:00:00:51:00:14:00:11:08:00:83:05:00:08:96:FF:FF:FF:14:06:00:BE:F8:A3:FF:DE:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 32
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "indication"
>>>>>> transaction = 0
>>>>>> tlv_length = 20
>>>>>> message = "Signal Info" (0x0051)
>>>>>> TLV:
>>>>>> type = "HDR Signal Strength" (0x11)
>>>>>> length = 8
>>>>>> value = 83:05:00:08:96:FF:FF:FF
>>>>>> translated = [ rssi = '-125' ecio = '5' sinr = '8' io = '-106' ]
>>>>>> TLV:
>>>>>> type = "LTE Signal Strength" (0x14)
>>>>>> length = 6
>>>>>> value = BE:F8:A3:FF:DE:00
>>>>>> translated = [ rssi = '-66' rsrq = '-8' rsrp = '-93' snr = '222' ]
<debug> [1441116665.398789] [mm-broadband-modem-qmi.c:6575] signal_info_indication_cb(): RSSI (HDR): -125 dBm
<debug> [1441116665.408010] [mm-broadband-modem-qmi.c:6593] signal_info_indication_cb(): RSSI (LTE): -66 dBm
<debug> [1441116665.415858] [mm-broadband-modem-qmi.c:6606] signal_info_indication_cb(): Ignoring invalid signal strength: 0 dBm
<debug> [1441116668.292727] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:19:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 25
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:19:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 25
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116668.319734] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116668.350451] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116668.358124] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116668.367627] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116671.292668] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:1A:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 26
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:1A:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 26
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116671.327321] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116671.352213] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116671.360127] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116671.368304] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116674.293919] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:1B:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 27
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:1B:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 27
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116674.335236] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116674.359146] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116674.366870] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116674.375209] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116677.292700] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:1C:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 28
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:1C:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 28
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116677.343023] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116677.351178] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116677.371785] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116677.380442] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 33
>>>>>> data = 01:20:00:80:03:04:04:00:00:51:00:14:00:11:08:00:83:05:00:08:96:FF:FF:FF:14:06:00:C0:F7:A4:FF:E0:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 32
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "indication"
>>>>>> transaction = 0
>>>>>> tlv_length = 20
>>>>>> message = "Signal Info" (0x0051)
>>>>>> TLV:
>>>>>> type = "HDR Signal Strength" (0x11)
>>>>>> length = 8
>>>>>> value = 83:05:00:08:96:FF:FF:FF
>>>>>> translated = [ rssi = '-125' ecio = '5' sinr = '8' io = '-106' ]
>>>>>> TLV:
>>>>>> type = "LTE Signal Strength" (0x14)
>>>>>> length = 6
>>>>>> value = C0:F7:A4:FF:E0:00
>>>>>> translated = [ rssi = '-64' rsrq = '-9' rsrp = '-92' snr = '224' ]
<debug> [1441116677.392022] [mm-broadband-modem-qmi.c:6575] signal_info_indication_cb(): RSSI (HDR): -125 dBm
<debug> [1441116677.401069] [mm-broadband-modem-qmi.c:6593] signal_info_indication_cb(): RSSI (LTE): -64 dBm
<debug> [1441116677.410062] [mm-broadband-modem-qmi.c:6606] signal_info_indication_cb(): Ignoring invalid signal strength: 0 dBm
<debug> [1441116680.292583] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:1D:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 29
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:1D:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 29
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116680.319487] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116680.347248] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116680.355018] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116680.363213] [mm-iface-modem-3gpp.c:287] run_registration_checks_ready(): Modem not yet registered in a 3GPP network... will recheck soon
<debug> [1441116683.293481] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:04:00:1E:00:4D:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 4
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 30
<<<<<< tlv_length = 0
<<<<<< message = "Get System Info" (0x004D)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 97
>>>>>> data = 01:60:00:80:03:04:02:1E:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 96
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 30
>>>>>> tlv_length = 84
>>>>>> message = "Get System Info" (0x004D)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "GSM Service Status" (0x12)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "WCDMA Service Status" (0x13)
>>>>>> length = 3
>>>>>> value = 00:00:00
>>>>>> translated = [ service_status = 'none' true_service_status = 'none' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE Service Status" (0x14)
>>>>>> length = 3
>>>>>> value = 02:02:00
>>>>>> translated = [ service_status = 'available' true_service_status = 'available' preferred_data_path = 'no' ]
>>>>>> TLV:
>>>>>> type = "LTE System Info" (0x19)
>>>>>> length = 29
>>>>>> value = 01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11
>>>>>> translated = [ domain_valid = 'yes' domain = 'cs-ps' service_capability_valid = 'yes' service_capability = 'cs-ps' roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes' forbidden = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid = '90573570' registration_reject_info_valid = 'no' registration_reject_domain = 'none' registration_reject_cause = '0' network_id_valid = 'yes' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]
>>>>>> TLV:
>>>>>> type = "Additional LTE System Info" (0x1e)
>>>>>> length = 2
>>>>>> value = FF:FF
>>>>>> translated = [ geo_system_index = '65535' ]
>>>>>> TLV:
>>>>>> type = "LTE Voice Support" (0x21)
>>>>>> length = 1
>>>>>> value = 01
>>>>>> translated = yes
>>>>>> TLV:
>>>>>> type = "SIM Reject Info" (0x27)
>>>>>> length = 4
>>>>>> value = 01:00:00:00
>>>>>> translated = vailable
>>>>>> TLV:
>>>>>> type = 0x29
>>>>>> length = 1
>>>>>> value = 00
>>>>>> TLV:
>>>>>> type = 0x2a
>>>>>> length = 4
>>>>>> value = 00:00:00:00
<info> [1441116683.327394] [mm-broadband-modem-qmi.c:4294] dump(): #### LTE: system info:
service status: available
domain valid: 1
domain: cs-ps
romaing valid: 1
roaming status: off
forbidden valid: 1
forbidden: 0
lac valid: 0
lac: 65535
cid valid: 1
cid: 90573570
networkid valid: 1
mcc: 214
mnc: 01�
cs reg state: unknown
ps reg state: unknown
<info> [1441116683.352351] [mm-broadband-modem-qmi.c:4666] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: LTE reg states: cs 'unknown', ps 'unknown'
<info> [1441116683.360103] [mm-broadband-modem-qmi.c:4707] common_process_system_info_3gpp(): #### common_process_system_info_3gpp: final reg states: cs 'unknown', ps 'unknown'
<debug> [1441116683.368333] [mm-iface-modem-3gpp.c:273] run_registration_checks_ready(): 3GPP registration check timed out
<info> [1441116683.377537] [mm-iface-modem-3gpp.c:1169] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> idle)
<debug> [1441116683.389404] [mm-iface-modem.c:1561] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 38
>>>>>> data = 01:25:00:80:03:04:04:00:00:24:00:19:00:1C:08:00:DF:07:09:01:0D:0D:3B:04:11:02:00:01:0B:01:06:00:01:01:01:02:01:08
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 37
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 4
>>>>>> QMI:
>>>>>> flags = "indication"
>>>>>> transaction = 0
>>>>>> tlv_length = 25
>>>>>> message = "Serving System" (0x0024)
>>>>>> TLV:
>>>>>> type = "Universal Time and Local Time Zone 3GPP" (0x1c)
>>>>>> length = 8
>>>>>> value = DF:07:09:01:0D:0D:3B:04
>>>>>> translated = [ year = '2015' month = '9' day = '1' hour = '13' minute = '13' second = '59' time_zone = '4' ]
>>>>>> TLV:
>>>>>> type = "Data Service Capability" (0x11)
>>>>>> length = 2
>>>>>> value = 01:0B
>>>>>> translated = { [0] = 'lte '}
>>>>>> TLV:
>>>>>> type = "Serving System" (0x01)
>>>>>> length = 6
>>>>>> value = 01:01:01:02:01:08
>>>>>> translated = [ registration_state = 'registered' cs_attach_state = 'attached' ps_attach_state = 'attached' selected_network = '3gpp' radio_interfaces = '{ [0] = 'lte '}' ]
More information about the ModemManager-devel
mailing list