Huawei E160E USB modem fails to connect with ModemManager-1.0.0 and NetworkManager-0.9.8.8
David Allen
david.a58 at optusnet.com.au
Tue Nov 5 06:27:53 PST 2013
On 06/11/13 00:59, david.a58 at optusnet.com.au wrote:
>
>
>
>
> ----- Original Message -----
> From:
> "Aleksander Morgado" <aleksander at lanedo.com>
>
> To:
> "David Allen" <david.a58 at optusnet.com.au>
> Sent:
> Tue, 05 Nov 2013 09:20:31 +0100
> Subject:
> Re: Huawei E160E USB modem fails to connect with
> ModemManager-1.0.0 and NetworkManager-0.9.8.8
>
> >>>
> >> Could you get ModemManager debug logs?
> >> http://www.freedesktop.org/wiki/Software/ModemManager/Debugging
> >>
> >> MM 1.0 is using the QMI support in the modem; not AT+PPP. We
> need to
> >> understand where and why it fails.
> >>
> > Thankyou for your interest. It is much appreciated.
> >
> > I had tried to get the debug messages from ModemManager using the
> > instructions from the page you linked, but something must be
> different
> > with my setup.
> > I have found that if I use the command "su -c
> '/usr/sbin/ModemManager
> > --debug; /usr/sbin/NetworkManager --no-daemon --log-level=DEBUG
> &' " the
> > logs appear to be complete and I can then use nmcli to attempt a
> > connection
> >
> > Please find attached the revised debug logs:
> > dump_working_revised.txt - Recorded with earlier versions
> > dump_notworking_revised.txt - Recorded with later versions
> >
> >
>
> For some reason ModemManager debug logs in the
> 'notworking_revised' one
> do *not* have the chunk of info where the connection attempt is
> done...
> Can you retry that test, with the commands that best work for you to
> setup debug logging, and then retry the connection attempt with nmcli?
>
> Also, please CC the mailing list as well in your reply.
>
>
> --
> Aleksander
>
Please find attached another attempt at getting a full debug log. This
time I renamed the ModemManager and NetworkManager executables and
created scripts that called these renamed files with the debug options
in the hope that any respawned processes would continue debug logging.
David
> ------------------------------------------------------------------------
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freedesktop.org/archives/modemmanager-devel/attachments/20131106/8cb1349f/attachment-0001.html>
-------------- next part --------------
This dump obtained after 'mv /usr/sbin/ModemManager /usr/sbin/ModemManager_orig'
and 'mv /usr/sbin/NetworkManager /usr/sbin/NetworkManager_orig'
then creating executable scripts to call the renamed files with debug options.
This was done so that respawned processes would also provide debug output.
*** /usr/sbin/ModemManager is an executable script containing ***
#!/bin/bash
/usr/sbin/ModemManager_orig --debug
*** /usr/sbin/NetworkManager is an executable script containing ***
#!/bin/bash
/usr/sbin/NetworkManager_orig --no-daemon --log-level=DEBUG
root at Budgie:~# /usr/sbin/ModemManager; /usr/sbin/NetworkManager &
..snip.. Five lines missing here
ModemManager_orig[1263]: <debug> [1383654229.833565] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Novatel LTE'
ModemManager_orig[1263]: <debug> [1383654229.834615] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Novatel'
ModemManager_orig[1263]: <debug> [1383654229.835633] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Motorola'
ModemManager_orig[1263]: <debug> [1383654229.836622] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Wavecom'
ModemManager_orig[1263]: <debug> [1383654229.837625] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Generic'
ModemManager_orig[1263]: <debug> [1383654229.838596] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Linktop'
ModemManager_orig[1263]: <debug> [1383654229.839568] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Option High-Speed'
ModemManager_orig[1263]: <debug> [1383654229.840540] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Cinterion'
ModemManager_orig[1263]: <debug> [1383654229.841550] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Huawei'
ModemManager_orig[1263]: <debug> [1383654229.842580] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Option'
ModemManager_orig[1263]: <debug> [1383654229.843576] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'AnyDATA'
ModemManager_orig[1263]: <debug> [1383654229.844564] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Gobi'
ModemManager_orig[1263]: <debug> [1383654229.845570] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Samsung'
ModemManager_orig[1263]: <debug> [1383654229.846579] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Nokia (Icera)'
ModemManager_orig[1263]: <debug> [1383654229.847602] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'X22X'
ModemManager_orig[1263]: <debug> [1383654229.848632] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Longcheer'
ModemManager_orig[1263]: <debug> [1383654229.849681] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Iridium'
ModemManager_orig[1263]: <debug> [1383654229.850751] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Altair LTE'
ModemManager_orig[1263]: <debug> [1383654229.851810] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Pantech'
ModemManager_orig[1263]: <debug> [1383654229.852922] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'ZTE'
ModemManager_orig[1263]: <debug> [1383654229.853988] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Nokia'
ModemManager_orig[1263]: <debug> [1383654229.855020] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'SimTech'
ModemManager_orig[1263]: <debug> [1383654229.856049] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Via CBP7'
ModemManager_orig[1263]: <debug> [1383654229.857265] [mm-plugin-manager.c:813] load_plugins(): Loaded plugin 'Sierra'
ModemManager_orig[1263]: <debug> [1383654229.857643] [mm-plugin-manager.c:838] load_plugins(): Successfully loaded 26 plugins
ModemManager_orig[1263]: <debug> [1383654229.860079] [main.c:79] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
ModemManager_orig[1263]: <debug> [1383654229.860447] [mm-manager.c:456] mm_manager_start(): Starting automatic device scan...
ModemManager_orig[1263]: <debug> [1383654229.874740] [mm-manager.c:495] mm_manager_start(): Finished device scan...
ModemManager_orig[1263]: <debug> [1383654229.875914] [mm-manager.c:294] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted
ModemManager_orig[1263]: <debug> [1383654229.876651] [mm-manager.c:294] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
ModemManager_orig[1263]: <debug> [1383654229.877314] [mm-manager.c:294] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
ModemManager_orig[1263]: <debug> [1383654229.878059] [mm-manager.c:294] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
ModemManager_orig[1263]: <debug> [1383654229.879100] [mm-manager.c:270] device_added(): (tty/ptyp0): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.879699] [mm-manager.c:270] device_added(): (tty/ptyp1): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.880213] [mm-manager.c:270] device_added(): (tty/ptyp2): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.880747] [mm-manager.c:270] device_added(): (tty/ptyp3): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.881242] [mm-manager.c:270] device_added(): (tty/ptyp4): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.881796] [mm-manager.c:270] device_added(): (tty/ptyp5): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.882293] [mm-manager.c:270] device_added(): (tty/ptyp6): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.882905] [mm-manager.c:270] device_added(): (tty/ptyp7): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.883442] [mm-manager.c:270] device_added(): (tty/ptyp8): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.883941] [mm-manager.c:270] device_added(): (tty/ptyp9): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.884468] [mm-manager.c:270] device_added(): (tty/ptypa): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.884966] [mm-manager.c:270] device_added(): (tty/ptypb): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.885517] [mm-manager.c:270] device_added(): (tty/ptypc): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.886031] [mm-manager.c:270] device_added(): (tty/ptypd): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.886594] [mm-manager.c:270] device_added(): (tty/ptype): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.887098] [mm-manager.c:270] device_added(): (tty/ptypf): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.887617] [mm-manager.c:270] device_added(): (tty/ptyq0): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.888108] [mm-manager.c:270] device_added(): (tty/ptyq1): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.888632] [mm-manager.c:270] device_added(): (tty/ptyq2): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.889127] [mm-manager.c:270] device_added(): (tty/ptyq3): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.889662] [mm-manager.c:270] device_added(): (tty/ptyq4): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.890168] [mm-manager.c:270] device_added(): (tty/ptyq5): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.890726] [mm-manager.c:270] device_added(): (tty/ptyq6): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.891225] [mm-manager.c:270] device_added(): (tty/ptyq7): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.891757] [mm-manager.c:270] device_added(): (tty/ptyq8): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.892294] [mm-manager.c:270] device_added(): (tty/ptyq9): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.892901] [mm-manager.c:270] device_added(): (tty/ptyqa): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.893443] [mm-manager.c:270] device_added(): (tty/ptyqb): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.893956] [mm-manager.c:270] device_added(): (tty/ptyqc): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.894533] [mm-manager.c:270] device_added(): (tty/ptyqd): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.895139] [mm-manager.c:270] device_added(): (tty/ptyqe): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.895703] [mm-manager.c:270] device_added(): (tty/ptyqf): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.898312] [mm-manager.c:270] device_added(): (tty/ttyp0): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.898954] [mm-manager.c:270] device_added(): (tty/ttyp1): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.899569] [mm-manager.c:270] device_added(): (tty/ttyp2): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.900414] [mm-manager.c:270] device_added(): (tty/ttyp3): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.901167] [mm-manager.c:270] device_added(): (tty/ttyp4): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.901912] [mm-manager.c:270] device_added(): (tty/ttyp5): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.902686] [mm-manager.c:270] device_added(): (tty/ttyp6): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.903463] [mm-manager.c:270] device_added(): (tty/ttyp7): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.904177] [mm-manager.c:270] device_added(): (tty/ttyp8): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.904958] [mm-manager.c:270] device_added(): (tty/ttyp9): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.905579] [mm-manager.c:270] device_added(): (tty/ttypa): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.906093] [mm-manager.c:270] device_added(): (tty/ttypb): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.906650] [mm-manager.c:270] device_added(): (tty/ttypc): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.907157] [mm-manager.c:270] device_added(): (tty/ttypd): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.907789] [mm-manager.c:270] device_added(): (tty/ttype): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.908449] [mm-manager.c:270] device_added(): (tty/ttypf): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.908977] [mm-manager.c:270] device_added(): (tty/ttyq0): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.909519] [mm-manager.c:270] device_added(): (tty/ttyq1): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.910073] [mm-manager.c:270] device_added(): (tty/ttyq2): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.910610] [mm-manager.c:270] device_added(): (tty/ttyq3): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.911122] [mm-manager.c:270] device_added(): (tty/ttyq4): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.911663] [mm-manager.c:270] device_added(): (tty/ttyq5): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.912170] [mm-manager.c:270] device_added(): (tty/ttyq6): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.912764] [mm-manager.c:270] device_added(): (tty/ttyq7): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.913272] [mm-manager.c:270] device_added(): (tty/ttyq8): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.913818] [mm-manager.c:270] device_added(): (tty/ttyq9): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.914315] [mm-manager.c:270] device_added(): (tty/ttyqa): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.914851] [mm-manager.c:270] device_added(): (tty/ttyqb): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.915380] [mm-manager.c:270] device_added(): (tty/ttyqc): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.915901] [mm-manager.c:270] device_added(): (tty/ttyqd): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.916460] [mm-manager.c:270] device_added(): (tty/ttyqe): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.916967] [mm-manager.c:270] device_added(): (tty/ttyqf): could not get port's parent device
ModemManager_orig[1263]: <debug> [1383654229.918006] [mm-plugin-manager.c:675] mm_plugin_manager_find_device_support(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0] Checking device support...
ModemManager_orig[1263]: <debug> [1383654229.918699] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [wlan0] filtered by udev tags
ModemManager_orig[1263]: <debug> [1383654229.918973] [mm-plugin.c:213] apply_pre_probing_filters(): (Telit) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.919164] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [wlan0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654229.919374] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [wlan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.919573] [mm-plugin.c:213] apply_pre_probing_filters(): (Motorola) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.919742] [mm-plugin.c:213] apply_pre_probing_filters(): (Wavecom) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.919913] [mm-plugin.c:213] apply_pre_probing_filters(): (Linktop) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.920086] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [wlan0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654229.920260] [mm-plugin.c:213] apply_pre_probing_filters(): (Cinterion) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.920497] [mm-plugin.c:322] apply_pre_probing_filters(): (Huawei) [wlan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.920733] [mm-plugin.c:213] apply_pre_probing_filters(): (Option) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.921000] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [wlan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.921243] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [wlan0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654229.921927] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [wlan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.922182] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [wlan0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654229.922470] [mm-plugin.c:213] apply_pre_probing_filters(): (X22X) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.923010] [mm-plugin.c:213] apply_pre_probing_filters(): (Longcheer) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.923249] [mm-plugin.c:213] apply_pre_probing_filters(): (Iridium) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.923773] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [wlan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.923880] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [wlan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.923981] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [wlan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.924301] [mm-plugin.c:213] apply_pre_probing_filters(): (Nokia) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.924537] [mm-plugin.c:213] apply_pre_probing_filters(): (SimTech) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.924726] [mm-plugin.c:213] apply_pre_probing_filters(): (Via CBP7) [wlan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.924914] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [wlan0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654229.925112] [mm-plugin-manager.c:576] build_plugins_list(): (Plugin Manager) [wlan0] Found '1' plugins to
try...
ModemManager_orig[1263]: <debug> [1383654229.925293] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [wlan0] Will try with plugin
'Generic'
ModemManager_orig[1263]: <debug> [1383654229.925529] [mm-plugin.c:700] mm_plugin_supports_port(): (Generic) [wlan0] probing deferred until result
suggested
ModemManager_orig[1263]: <debug> [1383654229.926271] [mm-plugin-manager.c:675] mm_plugin_manager_find_device_support(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0] Checking device support...
ModemManager_orig[1263]: <debug> [1383654229.926786] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [eth0] filtered by udev tags
ModemManager_orig[1263]: <debug> [1383654229.927024] [mm-plugin.c:213] apply_pre_probing_filters(): (Telit) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.927209] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.927418] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.927593] [mm-plugin.c:213] apply_pre_probing_filters(): (Motorola) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.927807] [mm-plugin.c:213] apply_pre_probing_filters(): (Wavecom) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.927980] [mm-plugin.c:213] apply_pre_probing_filters(): (Linktop) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.928155] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [eth0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654229.928364] [mm-plugin.c:213] apply_pre_probing_filters(): (Cinterion) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.928558] [mm-plugin.c:322] apply_pre_probing_filters(): (Huawei) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.928735] [mm-plugin.c:213] apply_pre_probing_filters(): (Option) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.928914] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.929090] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [eth0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654229.929270] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.929479] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [eth0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654229.929659] [mm-plugin.c:213] apply_pre_probing_filters(): (X22X) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.929839] [mm-plugin.c:213] apply_pre_probing_filters(): (Longcheer) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.930016] [mm-plugin.c:213] apply_pre_probing_filters(): (Iridium) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.930193] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.930401] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.930577] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [eth0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654229.930770] [mm-plugin.c:213] apply_pre_probing_filters(): (Nokia) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.931052] [mm-plugin.c:213] apply_pre_probing_filters(): (SimTech) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.931299] [mm-plugin.c:213] apply_pre_probing_filters(): (Via CBP7) [eth0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654229.931584] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [eth0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654229.931818] [mm-plugin-manager.c:576] build_plugins_list(): (Plugin Manager) [eth0] Found '1' plugins to
try...
ModemManager_orig[1263]: <debug> [1383654229.932068] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [eth0] Will try with plugin
'Generic'
ModemManager_orig[1263]: <debug> [1383654229.932388] [mm-plugin.c:700] mm_plugin_supports_port(): (Generic) [eth0] probing deferred until result
suggested
ModemManager_orig[1263]: <debug> [1383654229.933321] [mm-plugin-manager.c:505] plugin_supports_port_ready(): (Plugin Manager) [wlan0] deferring support
check until result suggested
ModemManager_orig[1263]: <debug> [1383654229.933857] [mm-plugin-manager.c:505] plugin_supports_port_ready(): (Plugin Manager) [eth0] deferring support
check until result suggested
ModemManager_orig[1263]: <debug> [1383654232.595910] [mm-plugin-manager.c:646] min_probing_timeout_cb(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0] Minimum probing time consumed
ModemManager_orig[1263]: <debug> [1383654232.596086] [mm-plugin-manager.c:341] suggest_port_probe_result(): (Plugin Manager) [wlan0] deferred task
cancelled, no suggested plugin
ModemManager_orig[1263]: <debug> [1383654232.596236] [mm-plugin-manager.c:646] min_probing_timeout_cb(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0] Minimum probing time consumed
ModemManager_orig[1263]: <debug> [1383654232.596420] [mm-plugin-manager.c:341] suggest_port_probe_result(): (Plugin Manager) [eth0] deferred task
cancelled, no suggested plugin
ModemManager_orig[1263]: <debug> [1383654232.596592] [mm-plugin-manager.c:164] port_probe_context_finished(): (Plugin Manager) [wlan0] not supported by
any plugin
ModemManager_orig[1263]: <debug> [1383654232.596722] [mm-device.c:339] mm_device_ignore_port(): Fully ignoring port 'net/wlan0' from now on
ModemManager_orig[1263]: <debug> [1383654232.596903] [mm-plugin-manager.c:285] port_probe_context_finished(): (Plugin Manager) 'wlan0' port probe
finished, last one in device
ModemManager_orig[1263]: <debug> [1383654232.597098] [mm-plugin-manager.c:107] find_device_support_context_complete_and_free(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0] device support check finished in '2.678676' seconds
ModemManager_orig[1263]: <warn> [1383654232.597585] [mm-manager.c:140] find_device_support_ready(): Couldn't find support for device at
'/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0': not supported by any plugin
ModemManager_orig[1263]: <debug> [1383654232.597830] [mm-plugin-manager.c:164] port_probe_context_finished(): (Plugin Manager) [eth0] not supported by
any plugin
ModemManager_orig[1263]: <debug> [1383654232.597977] [mm-device.c:339] mm_device_ignore_port(): Fully ignoring port 'net/eth0' from now on
ModemManager_orig[1263]: <debug> [1383654232.598102] [mm-plugin-manager.c:285] port_probe_context_finished(): (Plugin Manager) 'eth0' port probe
finished, last one in device
ModemManager_orig[1263]: <debug> [1383654232.598227] [mm-plugin-manager.c:107] find_device_support_context_complete_and_free(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0] device support check finished in '2.671594' seconds
ModemManager_orig[1263]: <warn> [1383654232.598436] [mm-manager.c:140] find_device_support_ready(): Couldn't find support for device at
'/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0': not supported by any plugin
ModemManager_orig[1263]: <debug> [1383654276.263147] [mm-plugin-manager.c:675] mm_plugin_manager_find_device_support(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3] Checking device support...
ModemManager_orig[1263]: <debug> [1383654276.263632] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm0] filtered by udev tags
ModemManager_orig[1263]: <debug> [1383654276.263755] [mm-plugin.c:213] apply_pre_probing_filters(): (Telit) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.263821] [mm-plugin.c:213] apply_pre_probing_filters(): (Novatel LTE) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.263882] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [cdc-wdm0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.263943] [mm-plugin.c:213] apply_pre_probing_filters(): (Motorola) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.264003] [mm-plugin.c:213] apply_pre_probing_filters(): (Wavecom) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.264064] [mm-plugin.c:213] apply_pre_probing_filters(): (Linktop) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.264125] [mm-plugin.c:213] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm0] filtered by
subsystem
ModemManager_orig[1263]: <debug> [1383654276.264187] [mm-plugin.c:213] apply_pre_probing_filters(): (Cinterion) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.264255] [mm-plugin.c:213] apply_pre_probing_filters(): (Option) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.264521] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.264633] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [cdc-wdm0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.264813] [mm-plugin.c:213] apply_pre_probing_filters(): (Samsung) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.264981] [mm-plugin.c:213] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.265208] [mm-plugin.c:213] apply_pre_probing_filters(): (X22X) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.265440] [mm-plugin.c:213] apply_pre_probing_filters(): (Longcheer) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.265636] [mm-plugin.c:213] apply_pre_probing_filters(): (Iridium) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.265834] [mm-plugin.c:213] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.266033] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [cdc-wdm0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.266233] [mm-plugin.c:213] apply_pre_probing_filters(): (ZTE) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.266473] [mm-plugin.c:213] apply_pre_probing_filters(): (Nokia) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.266681] [mm-plugin.c:213] apply_pre_probing_filters(): (SimTech) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.266882] [mm-plugin.c:213] apply_pre_probing_filters(): (Via CBP7) [cdc-wdm0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.267076] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [cdc-wdm0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.267274] [mm-plugin-manager.c:576] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '2' plugins to
try...
ModemManager_orig[1263]: <debug> [1383654276.267519] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin
'Huawei'
ModemManager_orig[1263]: <debug> [1383654276.267719] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin
'Generic'
ModemManager_orig[1263]: <debug> [1383654276.267998] [mm-plugin.c:772] mm_plugin_supports_port(): (Huawei) [cdc-wdm0] probe required: 'qmi'
ModemManager_orig[1263]: <debug> [1383654276.268307] [mm-port-probe.c:1331] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'qmi'
ModemManager_orig[1263]: <debug> [1383654276.268709] [mm-port-probe.c:453] wdm_probe_qmi(): (usbmisc/cdc-wdm0) probing QMI...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Checking version info (10 retries)...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:01:21:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 11
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Version Info" (0x0021)
ModemManager_orig[1263]: <debug> [1383654276.318082] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [wwan0] filtered by udev tags
ModemManager_orig[1263]: <debug> [1383654276.318215] [mm-plugin.c:213] apply_pre_probing_filters(): (Telit) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.318280] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [wwan0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.318371] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [wwan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.318435] [mm-plugin.c:213] apply_pre_probing_filters(): (Motorola) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.318497] [mm-plugin.c:213] apply_pre_probing_filters(): (Wavecom) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.318559] [mm-plugin.c:213] apply_pre_probing_filters(): (Linktop) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.318621] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [wwan0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.318681] [mm-plugin.c:213] apply_pre_probing_filters(): (Cinterion) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.318746] [mm-plugin.c:213] apply_pre_probing_filters(): (Option) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.318808] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [wwan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.318869] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [wwan0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.318931] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [wwan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.318993] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [wwan0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.319055] [mm-plugin.c:213] apply_pre_probing_filters(): (X22X) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.319117] [mm-plugin.c:213] apply_pre_probing_filters(): (Longcheer) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.319178] [mm-plugin.c:213] apply_pre_probing_filters(): (Iridium) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.319238] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [wwan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.319299] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [wwan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.319387] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [wwan0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.319449] [mm-plugin.c:213] apply_pre_probing_filters(): (Nokia) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.319509] [mm-plugin.c:213] apply_pre_probing_filters(): (SimTech) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.319571] [mm-plugin.c:213] apply_pre_probing_filters(): (Via CBP7) [wwan0] filtered by subsystem
ModemManager_orig[1263]: <debug> [1383654276.319632] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [wwan0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.319694] [mm-plugin-manager.c:576] build_plugins_list(): (Plugin Manager) [wwan0] Found '2' plugins to
try...
ModemManager_orig[1263]: <debug> [1383654276.319757] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin
'Huawei'
ModemManager_orig[1263]: <debug> [1383654276.319817] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin
'Generic'
ModemManager_orig[1263]: <debug> [1383654276.319899] [mm-plugin.c:700] mm_plugin_supports_port(): (Huawei) [wwan0] probing deferred until result
suggested
ModemManager_orig[1263]: <debug> [1383654276.320055] [mm-plugin-manager.c:505] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support
check until result suggested
ModemManager_orig[1263]: <debug> [1383654276.350156] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB2] filtered by udev tags
ModemManager_orig[1263]: <debug> [1383654276.350307] [mm-plugin.c:322] apply_pre_probing_filters(): (Telit) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.350423] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB2] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.350487] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.350549] [mm-plugin.c:322] apply_pre_probing_filters(): (Motorola) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.350615] [mm-plugin.c:322] apply_pre_probing_filters(): (Wavecom) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.350675] [mm-plugin.c:322] apply_pre_probing_filters(): (Linktop) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.350738] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB2] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.350806] [mm-plugin.c:322] apply_pre_probing_filters(): (Option) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.350870] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.350931] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [ttyUSB2] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.350994] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.351924] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB2] filtered by
vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.352168] [mm-plugin.c:322] apply_pre_probing_filters(): (X22X) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.352416] [mm-plugin.c:322] apply_pre_probing_filters(): (Longcheer) [ttyUSB2] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.352647] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [ttyUSB2] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.352860] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.353060] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.353264] [mm-plugin.c:322] apply_pre_probing_filters(): (SimTech) [ttyUSB2] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.353525] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [ttyUSB2] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.353736] [mm-plugin-manager.c:576] build_plugins_list(): (Plugin Manager) [ttyUSB2] Found '6' plugins to
try...
ModemManager_orig[1263]: <debug> [1383654276.353932] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin
'Huawei'
ModemManager_orig[1263]: <debug> [1383654276.354126] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin
'Cinterion'
ModemManager_orig[1263]: <debug> [1383654276.354318] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin
'Iridium'
ModemManager_orig[1263]: <debug> [1383654276.354576] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin
'Nokia'
ModemManager_orig[1263]: <debug> [1383654276.354769] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin
'Via CBP7'
ModemManager_orig[1263]: <debug> [1383654276.355019] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB2] Will try with plugin
'Generic'
ModemManager_orig[1263]: <debug> [1383654276.355383] [mm-plugin.c:772] mm_plugin_supports_port(): (Huawei) [ttyUSB2] probe required: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654276.355710] [mm-port-probe.c:1331] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654276.356986] [mm-serial-port.c:891] mm_serial_port_open(): (ttyUSB2) opening serial port...
ModemManager_orig[1263]: <warn> [1383654276.362779] [mm-serial-port.c:416] real_config_fd(): (ttyUSB2): port attributes not fully set
ModemManager_orig[1263]: <debug> [1383654276.363072] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
ModemManager_orig[1263]: <debug> [1383654276.367115] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB1] filtered by udev tags
ModemManager_orig[1263]: <debug> [1383654276.367464] [mm-plugin.c:322] apply_pre_probing_filters(): (Telit) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.367688] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB1] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.367892] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.368092] [mm-plugin.c:322] apply_pre_probing_filters(): (Motorola) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.368292] [mm-plugin.c:322] apply_pre_probing_filters(): (Wavecom) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.368532] [mm-plugin.c:322] apply_pre_probing_filters(): (Linktop) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.368736] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB1] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.368925] [mm-plugin.c:322] apply_pre_probing_filters(): (Option) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.369099] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.369361] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [ttyUSB1] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.369655] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.369875] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB1] filtered by
vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.370110] [mm-plugin.c:322] apply_pre_probing_filters(): (X22X) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.370373] [mm-plugin.c:322] apply_pre_probing_filters(): (Longcheer) [ttyUSB1] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.370629] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [ttyUSB1] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.370871] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.371093] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.371406] [mm-plugin.c:322] apply_pre_probing_filters(): (SimTech) [ttyUSB1] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.371612] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [ttyUSB1] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.371785] [mm-plugin-manager.c:576] build_plugins_list(): (Plugin Manager) [ttyUSB1] Found '6' plugins to
try...
ModemManager_orig[1263]: <debug> [1383654276.371953] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin
'Huawei'
ModemManager_orig[1263]: <debug> [1383654276.372115] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin
'Cinterion'
ModemManager_orig[1263]: <debug> [1383654276.372307] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin
'Iridium'
ModemManager_orig[1263]: <debug> [1383654276.372565] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin
'Nokia'
ModemManager_orig[1263]: <debug> [1383654276.372823] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin
'Via CBP7'
ModemManager_orig[1263]: <debug> [1383654276.373051] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB1] Will try with plugin
'Generic'
ModemManager_orig[1263]: <debug> [1383654276.373373] [mm-plugin.c:772] mm_plugin_supports_port(): (Huawei) [ttyUSB1] probe required: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654276.373729] [mm-port-probe.c:1331] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654276.374527] [mm-serial-port.c:891] mm_serial_port_open(): (ttyUSB1) opening serial port...
ModemManager_orig[1263]: <warn> [1383654276.378369] [mm-serial-port.c:416] real_config_fd(): (ttyUSB1): port attributes not fully set
ModemManager_orig[1263]: <debug> [1383654276.378887] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
ModemManager_orig[1263]: <debug> [1383654276.386811] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB0] filtered by udev tags
ModemManager_orig[1263]: <debug> [1383654276.387294] [mm-plugin.c:322] apply_pre_probing_filters(): (Telit) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.387639] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.387878] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.388107] [mm-plugin.c:322] apply_pre_probing_filters(): (Motorola) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.388374] [mm-plugin.c:322] apply_pre_probing_filters(): (Wavecom) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.388626] [mm-plugin.c:322] apply_pre_probing_filters(): (Linktop) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.388865] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.389103] [mm-plugin.c:322] apply_pre_probing_filters(): (Option) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.389326] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.389683] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [ttyUSB0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.389920] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.390155] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB0] filtered by
vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.390435] [mm-plugin.c:322] apply_pre_probing_filters(): (X22X) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.390649] [mm-plugin.c:322] apply_pre_probing_filters(): (Longcheer) [ttyUSB0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.390886] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [ttyUSB0] filtered by vendor/product
IDs
ModemManager_orig[1263]: <debug> [1383654276.391123] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.391374] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.391659] [mm-plugin.c:322] apply_pre_probing_filters(): (SimTech) [ttyUSB0] filtered by vendor/product IDs
ModemManager_orig[1263]: <debug> [1383654276.391896] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [ttyUSB0] filtered by drivers
ModemManager_orig[1263]: <debug> [1383654276.392108] [mm-plugin-manager.c:576] build_plugins_list(): (Plugin Manager) [ttyUSB0] Found '6' plugins to
try...
ModemManager_orig[1263]: <debug> [1383654276.392399] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin
'Huawei'
ModemManager_orig[1263]: <debug> [1383654276.392651] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin
'Cinterion'
ModemManager_orig[1263]: <debug> [1383654276.392857] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin
'Iridium'
ModemManager_orig[1263]: <debug> [1383654276.393081] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin
'Nokia'
ModemManager_orig[1263]: <debug> [1383654276.393285] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin
'Via CBP7'
ModemManager_orig[1263]: <debug> [1383654276.393526] [mm-plugin-manager.c:580] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin
'Generic'
ModemManager_orig[1263]: <debug> [1383654276.393835] [mm-plugin.c:772] mm_plugin_supports_port(): (Huawei) [ttyUSB0] probe required: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654276.394103] [mm-port-probe.c:1331] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654276.394943] [mm-serial-port.c:891] mm_serial_port_open(): (ttyUSB0) opening serial port...
ModemManager_orig[1263]: <warn> [1383654276.397883] [mm-serial-port.c:416] real_config_fd(): (ttyUSB0): port attributes not fully set
ModemManager_orig[1263]: <debug> [1383654276.398332] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
ModemManager_orig[1263]: <debug> [1383654276.465467] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
ModemManager_orig[1263]: <debug> [1383654276.465938] [mm-serial-port.c:1021] mm_serial_port_close(): (ttyUSB2) closing serial port...
ModemManager_orig[1263]: <debug> [1383654276.468397] [mm-serial-port.c:1054] mm_serial_port_close(): (ttyUSB2) serial port closed
ModemManager_orig[1263]: <debug> [1383654276.468932] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB2) forced to close port
ModemManager_orig[1263]: <debug> [1383654276.469664] [mm-plugin-manager.c:469] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB2]
deferring support check
ModemManager_orig[1263]: <debug> [1383654276.481144] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
ModemManager_orig[1263]: <debug> [1383654276.481636] [mm-serial-port.c:1021] mm_serial_port_close(): (ttyUSB1) closing serial port...
ModemManager_orig[1263]: <debug> [1383654276.483788] [mm-serial-port.c:1054] mm_serial_port_close(): (ttyUSB1) serial port closed
ModemManager_orig[1263]: <debug> [1383654276.484201] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB1) forced to close port
ModemManager_orig[1263]: <debug> [1383654276.484827] [mm-plugin-manager.c:469] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB1]
deferring support check
ModemManager_orig[1263]: <debug> [1383654276.501508] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): --> 'AT^CURC=0<CR>'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:02:21:00:00:00
ModemManager_orig[1263]: [/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)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data =
01:2F:00:80:00:00:01:02:21:00:24:00:02:04:00:00:00:00:00:01:1A:00:05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 47
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 36
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 26
>>>>>> value = 05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '2' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version
= '3' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '2' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '0' ] ' [4]
= '[ service = 'cat' major_version = '0' minor_version = '0' ] '}
ModemManager_orig[1263]: [/dev/cdc-wdm0] QMI Device supports 5 services:
ModemManager_orig[1263]: [/dev/cdc-wdm0] ctl (1.2)
ModemManager_orig[1263]: [/dev/cdc-wdm0] wds (1.3)
ModemManager_orig[1263]: [/dev/cdc-wdm0] dms (1.2)
ModemManager_orig[1263]: [/dev/cdc-wdm0] nas (1.0)
ModemManager_orig[1263]: [/dev/cdc-wdm0] cat (0.0)
ModemManager_orig[1263]: <debug> [1383654277.601148] [mm-port-probe.c:270] mm_port_probe_set_result_qmi(): (usbmisc/cdc-wdm0) port is QMI-capable
ModemManager_orig[1263]: <debug> [1383654277.704240] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- 'AT^CURC=0'
ModemManager_orig[1263]: <debug> [1383654277.704800] [mm-plugin-manager.c:417] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [cdc-wdm0] found
best plugin for port
ModemManager_orig[1263]: <debug> [1383654277.705045] [mm-plugin-manager.c:201] port_probe_context_finished(): (Plugin Manager) (Huawei) [cdc-wdm0]:
found best plugin for device (/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3)
ModemManager_orig[1263]: <debug> [1383654277.705398] [mm-plugin-manager.c:373] suggest_port_probe_result(): (Plugin Manager) (Huawei) [ttyUSB0]
suggested plugin for port
ModemManager_orig[1263]: <debug> [1383654277.705632] [mm-plugin-manager.c:373] suggest_port_probe_result(): (Plugin Manager) (Huawei) [ttyUSB1]
suggested plugin for port
ModemManager_orig[1263]: <debug> [1383654277.705831] [mm-plugin-manager.c:373] suggest_port_probe_result(): (Plugin Manager) (Huawei) [ttyUSB2]
suggested plugin for port
ModemManager_orig[1263]: <debug> [1383654277.706012] [mm-plugin-manager.c:334] suggest_port_probe_result(): (Plugin Manager) (Huawei) [wwan0] deferred
task completed, got suggested plugin
ModemManager_orig[1263]: <debug> [1383654277.706266] [mm-plugin-manager.c:274] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm0' port probe
finished, still 4 running probes in this device (ttyUSB0, ttyUSB1, ttyUSB2, wwan0)
ModemManager_orig[1263]: <debug> [1383654277.706579] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- '<CR><CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654277.706930] [huawei/mm-plugin-huawei.c:192] curc_ready(): (Huawei) unsolicited messages in secondary ports
turned off
ModemManager_orig[1263]: <debug> [1383654277.707260] [mm-plugin.c:700] mm_plugin_supports_port(): (Huawei) [wwan0] probing deferred until result
suggested
ModemManager_orig[1263]: <debug> [1383654277.707546] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): --> 'AT^GETPORTMODE<CR>'
ModemManager_orig[1263]: <debug> [1383654277.707851] [mm-plugin-manager.c:485] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [wwan0] task
completed, got suggested plugin
ModemManager_orig[1263]: <debug> [1383654277.708127] [mm-plugin-manager.c:274] port_probe_context_finished(): (Plugin Manager) 'wwan0' port probe
finished, still 3 running probes in this device (ttyUSB0, ttyUSB1, ttyUSB2)
ModemManager_orig[1263]: <debug> [1383654278.592320] [mm-plugin-manager.c:646] min_probing_timeout_cb(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3] Minimum probing time consumed
ModemManager_orig[1263]: <debug> [1383654279.108504] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- 'AT^GETPORTMODE'
ModemManager_orig[1263]: <debug> [1383654279.109666] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- '<CR>'
ModemManager_orig[1263]: <debug> [1383654279.111418] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654279.111865] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager_orig[1263]: <debug> [1383654279.112145] [huawei/mm-plugin-huawei.c:137] getportmode_ready(): (Huawei) couldn't get port mode: 'Unknown
error'
ModemManager_orig[1263]: <debug> [1383654279.112593] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): --> 'AT<CR>'
ModemManager_orig[1263]: <debug> [1383654279.313013] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- 'AT'
ModemManager_orig[1263]: <debug> [1383654279.317499] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- '<CR>'
ModemManager_orig[1263]: <debug> [1383654279.318614] [mm-at-serial-port.c:408] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654279.319063] [mm-port-probe.c:151] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is AT-capable
ModemManager_orig[1263]: <debug> [1383654279.319407] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
ModemManager_orig[1263]: <debug> [1383654279.319642] [mm-serial-port.c:1021] mm_serial_port_close(): (ttyUSB0) closing serial port...
ModemManager_orig[1263]: <debug> [1383654279.321428] [mm-serial-port.c:1054] mm_serial_port_close(): (ttyUSB0) serial port closed
ModemManager_orig[1263]: <debug> [1383654279.321695] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB0) forced to close port
ModemManager_orig[1263]: <debug> [1383654279.321987] [mm-plugin-manager.c:417] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB0] found
best plugin for port
ModemManager_orig[1263]: <debug> [1383654279.322217] [mm-plugin-manager.c:274] port_probe_context_finished(): (Plugin Manager) 'ttyUSB0' port probe
finished, still 2 running probes in this device (ttyUSB1, ttyUSB2)
ModemManager_orig[1263]: <debug> [1383654279.593027] [mm-plugin.c:772] mm_plugin_supports_port(): (Huawei) [ttyUSB2] probe required: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654279.593618] [mm-port-probe.c:1331] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654279.594099] [mm-plugin.c:772] mm_plugin_supports_port(): (Huawei) [ttyUSB1] probe required: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654279.594577] [mm-port-probe.c:1331] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at, qcdm'
ModemManager_orig[1263]: <debug> [1383654279.595536] [mm-serial-port.c:891] mm_serial_port_open(): (ttyUSB2) opening serial port...
ModemManager_orig[1263]: <warn> [1383654279.598656] [mm-serial-port.c:416] real_config_fd(): (ttyUSB2): port attributes not fully set
ModemManager_orig[1263]: <debug> [1383654279.599221] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
ModemManager_orig[1263]: <debug> [1383654279.600953] [mm-serial-port.c:891] mm_serial_port_open(): (ttyUSB1) opening serial port...
ModemManager_orig[1263]: <warn> [1383654279.604014] [mm-serial-port.c:416] real_config_fd(): (ttyUSB1): port attributes not fully set
ModemManager_orig[1263]: <debug> [1383654279.604612] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
ModemManager_orig[1263]: <debug> [1383654279.701694] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'AT<CR>'
ModemManager_orig[1263]: <debug> [1383654279.902400] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- 'AT'
ModemManager_orig[1263]: <debug> [1383654279.902844] [mm-at-serial-port.c:408] debug_log(): (ttyUSB1): --> 'AT<CR>'
ModemManager_orig[1263]: <debug> [1383654279.905237] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR>'
ModemManager_orig[1263]: <debug> [1383654279.906419] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654279.906781] [mm-port-probe.c:151] mm_port_probe_set_result_at(): (tty/ttyUSB2) port is AT-capable
ModemManager_orig[1263]: <debug> [1383654279.907064] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
ModemManager_orig[1263]: <debug> [1383654279.907278] [mm-serial-port.c:1021] mm_serial_port_close(): (ttyUSB2) closing serial port...
ModemManager_orig[1263]: <debug> [1383654279.909430] [mm-serial-port.c:1054] mm_serial_port_close(): (ttyUSB2) serial port closed
ModemManager_orig[1263]: <debug> [1383654279.909896] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB2) forced to close port
ModemManager_orig[1263]: <debug> [1383654279.910266] [mm-plugin-manager.c:417] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB2] found
best plugin for port
ModemManager_orig[1263]: <debug> [1383654279.910569] [mm-plugin-manager.c:274] port_probe_context_finished(): (Plugin Manager) 'ttyUSB2' port probe
finished, still 1 running probes in this device (ttyUSB1)
ModemManager_orig[1263]: <debug> [1383654283.596390] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command
timed out'
ModemManager_orig[1263]: <debug> [1383654283.596731] [mm-at-serial-port.c:408] debug_log(): (ttyUSB1): --> 'AT<CR>'
ModemManager_orig[1263]: <debug> [1383654286.595738] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command
timed out'
ModemManager_orig[1263]: <debug> [1383654286.596077] [mm-at-serial-port.c:408] debug_log(): (ttyUSB1): --> 'AT<CR>'
ModemManager_orig[1263]: <debug> [1383654289.595946] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command
timed out'
ModemManager_orig[1263]: <debug> [1383654289.596122] [mm-port-probe.c:161] mm_port_probe_set_result_at(): (tty/ttyUSB1) port is not AT-capable
ModemManager_orig[1263]: <debug> [1383654289.596267] [mm-port-probe.c:657] serial_probe_qcdm(): (tty/ttyUSB1) probing QCDM...
ModemManager_orig[1263]: <debug> [1383654289.596330] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
ModemManager_orig[1263]: <debug> [1383654289.596423] [mm-serial-port.c:1021] mm_serial_port_close(): (ttyUSB1) closing serial port...
ModemManager_orig[1263]: <debug> [1383654289.598287] [mm-serial-port.c:1054] mm_serial_port_close(): (ttyUSB1) serial port closed
ModemManager_orig[1263]: <debug> [1383654289.598492] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB1) forced to close port
ModemManager_orig[1263]: <debug> [1383654289.598755] [mm-serial-port.c:891] mm_serial_port_open(): (ttyUSB1) opening serial port...
ModemManager_orig[1263]: <debug> [1383654289.601466] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
ModemManager_orig[1263]: <debug> [1383654289.601694] [mm-qcdm-serial-port.c:205] debug_log(): (ttyUSB1): --> 7e 00 78 f0 7e
ModemManager_orig[1263]: <debug> [1383654289.603266] [mm-qcdm-serial-port.c:205] debug_log(): (ttyUSB1): <-- 00 4e 6f 76 20 31 36 20 32 30 30 39 31 39
3a 33 38 3a 30 33 4e 6f 76 20 31 36 20 32 30 30 39 31 39 3a 33 38 3a 30 33 4b 50 52 42 4c 00 4e 6f 00 00 21 00 00 00 01 20 2f f4 7e
ModemManager_orig[1263]: <debug> [1383654289.603595] [mm-port-probe.c:239] mm_port_probe_set_result_qcdm(): (tty/ttyUSB1) port is QCDM-capable
ModemManager_orig[1263]: <debug> [1383654289.603810] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
ModemManager_orig[1263]: <debug> [1383654290.294441] [mm-serial-port.c:1021] mm_serial_port_close(): (ttyUSB1) closing serial port...
ModemManager_orig[1263]: <debug> [1383654290.296423] [mm-serial-port.c:1054] mm_serial_port_close(): (ttyUSB1) serial port closed
ModemManager_orig[1263]: <debug> [1383654290.296559] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB1) forced to close port
ModemManager_orig[1263]: <debug> [1383654290.296735] [mm-plugin-manager.c:417] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB1] found
best plugin for port
ModemManager_orig[1263]: <debug> [1383654290.296817] [mm-plugin-manager.c:285] port_probe_context_finished(): (Plugin Manager) 'ttyUSB1' port probe
finished, last one in device
ModemManager_orig[1263]: <debug> [1383654290.296886] [mm-plugin-manager.c:107] find_device_support_context_complete_and_free(): (Plugin Manager)
[/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3] device support check finished in '14.033554' seconds
ModemManager_orig[1263]: <info> [1383654290.296989] [mm-device.c:486] mm_device_create_modem(): Creating modem with plugin 'Huawei' and '5' ports
ModemManager_orig[1263]: <debug> [1383654290.297147] [huawei/mm-plugin-huawei.c:456] create_modem(): QMI-powered Huawei modem found...
ModemManager_orig[1263]: <debug> [1383654290.300778] [huawei/mm-plugin-huawei.c:511] grab_port(): (tty/ttyUSB0) Port will have AT flags 'ppp'
ModemManager_orig[1263]: <debug> [1383654290.301394] [mm-base-modem.c:275] mm_base_modem_grab_port(): (ttyUSB0) type 'at' claimed by
/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3
ModemManager_orig[1263]: <debug> [1383654290.301689] [huawei/mm-plugin-huawei.c:511] grab_port(): (tty/ttyUSB1) Port will have AT flags 'none'
ModemManager_orig[1263]: <debug> [1383654290.302005] [mm-base-modem.c:275] mm_base_modem_grab_port(): (ttyUSB1) type 'qcdm' claimed by
/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3
ModemManager_orig[1263]: <debug> [1383654290.302224] [huawei/mm-plugin-huawei.c:511] grab_port(): (tty/ttyUSB2) Port will have AT flags 'none'
ModemManager_orig[1263]: <debug> [1383654290.302693] [mm-base-modem.c:275] mm_base_modem_grab_port(): (ttyUSB2) type 'at' claimed by
/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3
ModemManager_orig[1263]: <debug> [1383654290.302934] [huawei/mm-plugin-huawei.c:511] grab_port(): (net/wwan0) Port will have AT flags 'none'
ModemManager_orig[1263]: <debug> [1383654290.303249] [mm-base-modem.c:275] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by
/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3
ModemManager_orig[1263]: <debug> [1383654290.303502] [huawei/mm-plugin-huawei.c:511] grab_port(): (usbmisc/cdc-wdm0) Port will have AT flags 'none'
ModemManager_orig[1263]: <debug> [1383654290.303775] [mm-base-modem.c:275] mm_base_modem_grab_port(): (cdc-wdm0) type 'qmi' claimed by
/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3
ModemManager_orig[1263]: <debug> [1383654290.304001] [mm-base-modem.c:1056] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3) tty/ttyUSB2 at
(primary)
ModemManager_orig[1263]: <debug> [1383654290.304189] [mm-base-modem.c:1056] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3) net/wwan0 data
(primary)
ModemManager_orig[1263]: <debug> [1383654290.304407] [mm-base-modem.c:1056] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3) tty/ttyUSB0
data (secondary)
ModemManager_orig[1263]: <debug> [1383654290.304588] [mm-base-modem.c:1056] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3) tty/ttyUSB1
qcdm
ModemManager_orig[1263]: <debug> [1383654290.304772] [mm-base-modem.c:1056] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3) usb/cdc-wdm0
qmi (primary)
ModemManager_orig[1263]: <info> [1383654290.305821] [mm-manager.c:149] find_device_support_ready(): Modem for device at
'/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3' successfully created
ModemManager_orig[1263]: [/dev/cdc-wdm0] Checking version info (10 retries)...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:01:21:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 11
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Version Info" (0x0021)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data =
01:2F:00:80:00:00:01:01:21:00:24:00:02:04:00:00:00:00:00:01:1A:00:05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 47
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 36
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 26
>>>>>> value = 05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '2' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version
= '3' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '2' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '0' ] ' [4]
= '[ service = 'cat' major_version = '0' minor_version = '0' ] '}
ModemManager_orig[1263]: [/dev/cdc-wdm0] QMI Device supports 5 services:
ModemManager_orig[1263]: [/dev/cdc-wdm0] ctl (1.2)
ModemManager_orig[1263]: [/dev/cdc-wdm0] wds (1.3)
ModemManager_orig[1263]: [/dev/cdc-wdm0] dms (1.2)
ModemManager_orig[1263]: [/dev/cdc-wdm0] nas (1.0)
ModemManager_orig[1263]: [/dev/cdc-wdm0] cat (0.0)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Setting network port data format...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 21
<<<<<< data = 01:14:00:00:00:00:00:02:26:00:09:00:10:02:00:01:00:01:01:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 20
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< 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
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 19
>>>>>> data = 01:12:00:80:00:00:01:02:26:00:07:00:02:04:00:01:00:2D:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 18
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 7
>>>>>> message = "Set Data Format" (0x0026)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:2D:00
>>>>>> translated = FAILURE: (null)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Checking version info (10 retries)...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 01:0B:00:00:00:00:00:01:21:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 11
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Version Info" (0x0021)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data =
01:2F:00:80:00:00:01:01:21:00:24:00:02:04:00:00:00:00:00:01:1A:00:05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 47
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 36
>>>>>> message = "Get Version Info" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Service list" (0x01)
>>>>>> length = 26
>>>>>> value = 05:00:01:00:02:00:01:01:00:03:00:02:01:00:02:00:03:01:00:00:00:E0:00:00:00:00
>>>>>> translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '2' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version
= '3' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '2' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '0' ] ' [4]
= '[ service = 'cat' major_version = '0' minor_version = '0' ] '}
ModemManager_orig[1263]: [/dev/cdc-wdm0] QMI Device supports 5 services:
ModemManager_orig[1263]: [/dev/cdc-wdm0] ctl (1.2)
ModemManager_orig[1263]: [/dev/cdc-wdm0] wds (1.3)
ModemManager_orig[1263]: [/dev/cdc-wdm0] dms (1.2)
ModemManager_orig[1263]: [/dev/cdc-wdm0] nas (1.0)
ModemManager_orig[1263]: [/dev/cdc-wdm0] cat (0.0)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Allocating new client ID...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:02:22:00:04:00:01:01:00:02
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 02
<<<<<< translated = dms
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:02:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:02:01
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> 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:01
>>>>>> translated = [ service = 'dms' cid = '1' ]
ModemManager_orig[1263]: [/dev/cdc-wdm0] Registered 'dms' (version 1.2) client with ID '1'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Allocating new client ID...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:0F:00:00:00:00:00:03:22:00:04:00:01:01:00:03
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 15
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 4
<<<<<< message = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<< type = "Service" (0x01)
<<<<<< length = 1
<<<<<< value = 03
<<<<<< translated = nas
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:00:00:01:03:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:03:01
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "ctl"
>>>>>> client = 0
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> 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:01
>>>>>> translated = [ service = 'nas' cid = '1' ]
ModemManager_orig[1263]: [/dev/cdc-wdm0] Registered 'nas' (version 1.0) client with ID '1'
ModemManager_orig[1263]: <debug> [1383654290.360663] [mm-broadband-modem-qmi.c:8467] qmi_port_allocate_client_ready(): Couldn't allocate client for
service 'wms': Couldn't create client for service 'wms': Service 'wms' not supported by the device
ModemManager_orig[1263]: <debug> [1383654290.361276] [mm-broadband-modem-qmi.c:8467] qmi_port_allocate_client_ready(): Couldn't allocate client for
service 'pds': Couldn't create client for service 'pds': Service 'pds' not supported by the device
ModemManager_orig[1263]: <debug> [1383654290.361827] [mm-serial-port.c:891] mm_serial_port_open(): (ttyUSB2) opening serial port...
ModemManager_orig[1263]: <warn> [1383654290.364995] [mm-serial-port.c:416] real_config_fd(): (ttyUSB2): port attributes not fully set
ModemManager_orig[1263]: <debug> [1383654290.365477] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
ModemManager_orig[1263]: <debug> [1383654290.365707] [mm-at-serial-port.c:445] mm_at_serial_port_run_init_sequence(): (ttyUSB2): running init
sequence...
ModemManager_orig[1263]: <debug> [1383654290.365997] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB2) device open count is 2 (open)
ModemManager_orig[1263]: <debug> [1383654290.366366] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB2) device open count is 3 (open)
ModemManager_orig[1263]: <debug> [1383654290.370762] [mm-broadband-modem-qmi.c:520] modem_load_current_capabilities(): loading current capabilities...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:01:00:01:00:2B:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Technology Preference" (0x002B)
ModemManager_orig[1263]: <debug> [1383654290.372264] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
ModemManager_orig[1263]: <debug> [1383654290.377478] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- 'A'
ModemManager_orig[1263]: <debug> [1383654290.378745] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- 'T'
ModemManager_orig[1263]: <debug> [1383654290.382869] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- 'E'
ModemManager_orig[1263]: <debug> [1383654290.383622] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '0'
ModemManager_orig[1263]: <debug> [1383654290.384207] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR>'
ModemManager_orig[1263]: <debug> [1383654290.388503] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.389185] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'ATV1<CR>'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:01:02:01:00:2B:00:07:00:02:04:00:01:00:47:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 7
>>>>>> message = "Get Technology Preference" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:47:00
>>>>>> translated = FAILURE: InvalidQmiCommand
ModemManager_orig[1263]: <debug> [1383654290.394795] [mm-broadband-modem-qmi.c:415] load_current_capabilities_get_technology_preference_ready():
Couldn't get technology preference: QMI protocol error (71): 'InvalidQmiCommand'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:01:00:20:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 1
<<<<<< tlv_length = 0
<<<<<< message = "Get Capabilities" (0x0020)
ModemManager_orig[1263]: <debug> [1383654290.402537] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.403727] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 36
>>>>>> data = 01:23:00:80:02:01:02:01:00:20:00:17:00:02:04:00:00:00:00:00:01:0D:00:60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 35
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 1
>>>>>> tlv_length = 23
>>>>>> message = "Get Capabilities" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Info" (0x01)
>>>>>> length = 13
>>>>>> value = 60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
>>>>>> translated = [ max_tx_channel_rate = '3100000' max_rx_channel_rate = '3100000' data_service_capability = 'non-simultaneous-cs-ps'
sim_capability = 'supported' radio_interface_list = '{ [0] = 'gsm ' [1] = 'umts '}' ]
ModemManager_orig[1263]: <debug> [1383654290.408990] [mm-modem-helpers-qmi.c:1266] mm_modem_capability_from_qmi_capabilities_context(): Current
capabilities built: 'gsm-umts'
SSP mode preference: 'unknown'
TP: 'auto'
DMS Capabilities: 'gsm-umts'
ModemManager_orig[1263]: <debug> [1383654290.409991] [mm-broadband-modem-qmi.c:682] modem_load_supported_capabilities(): loading supported
capabilities...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:02:00:20:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Capabilities" (0x0020)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 36
>>>>>> data = 01:23:00:80:02:01:02:02:00:20:00:17:00:02:04:00:00:00:00:00:01:0D:00:60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 35
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 23
>>>>>> message = "Get Capabilities" (0x0020)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Info" (0x01)
>>>>>> length = 13
>>>>>> value = 60:4D:2F:00:60:4D:2F:00:04:02:02:04:05
>>>>>> translated = [ max_tx_channel_rate = '3100000' max_rx_channel_rate = '3100000' data_service_capability = 'non-simultaneous-cs-ps'
sim_capability = 'supported' radio_interface_list = '{ [0] = 'gsm ' [1] = 'umts '}' ]
ModemManager_orig[1263]: <debug> [1383654290.423300] [mm-iface-modem.c:4105] interface_initialization_step(): Modem allows up to 2 bearers
ModemManager_orig[1263]: <debug> [1383654290.423865] [mm-bearer-list.c:273] mm_bearer_list_new(): Creating bearer list (max: 2, max active: 2)
ModemManager_orig[1263]: <debug> [1383654290.424748] [mm-broadband-modem-qmi.c:984] modem_load_manufacturer(): loading manufacturer...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:03:00:21:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 3
<<<<<< tlv_length = 0
<<<<<< message = "Get Manufacturer" (0x0021)
ModemManager_orig[1263]: <debug> [1383654290.427026] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.427730] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'ATX4<CR>'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 43
>>>>>> data = 01:2A:00:80:02:01:02:03:00:21:00:1E:00:02:04:00:00:00:00:00:01:14:00:48:55:41:57:45:49:20:43:4F:4D:4D:55:4E:49:43:41:54:49:4F:4E
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 42
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 3
>>>>>> tlv_length = 30
>>>>>> message = "Get Manufacturer" (0x0021)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Manufacturer" (0x01)
>>>>>> length = 20
>>>>>> value = 48:55:41:57:45:49:20:43:4F:4D:4D:55:4E:49:43:41:54:49:4F:4E
>>>>>> translated = HUAWEI COMMUNICATION
ModemManager_orig[1263]: <debug> [1383654290.437277] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.437966] [mm-broadband-modem-qmi.c:931] modem_load_manufacturer_finish(): loaded manufacturer: HUAWEI
COMMUNICATION
ModemManager_orig[1263]: <debug> [1383654290.438534] [mm-broadband-modem-qmi.c:1060] modem_load_model(): loading model...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:04:00:22:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 0
<<<<<< message = "Get Model" (0x0022)
ModemManager_orig[1263]: <debug> [1383654290.440618] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'AT&C1<CR>'
ModemManager_orig[1263]: <debug> [1383654290.451275] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.452069] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 25
>>>>>> data = 01:18:00:80:02:01:02:04:00:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:33:33
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 24
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 4
>>>>>> tlv_length = 12
>>>>>> message = "Get Model" (0x0022)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Model" (0x01)
>>>>>> length = 2
>>>>>> value = 33:33
>>>>>> translated = 33
ModemManager_orig[1263]: <debug> [1383654290.456543] [mm-broadband-modem-qmi.c:1007] modem_load_model_finish(): loaded model: 33
ModemManager_orig[1263]: <debug> [1383654290.457240] [mm-broadband-modem-qmi.c:1136] modem_load_revision(): loading revision...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:05:00:23:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 0
<<<<<< message = "Get Revision" (0x0023)
ModemManager_orig[1263]: <debug> [1383654290.465003] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.466082] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB2) device open count is 2 (close)
ModemManager_orig[1263]: <debug> [1383654290.467029] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 75
>>>>>> data =
01:4A:00:80:02:01:02:05:00:23:00:3E:00:02:04:00:00:00:00:00:01:34:00:4D:36:32:34:36:41:2D:4B:50:52:42:4C:2D:31:2E:32:2E:30:30:32:32:5F:33:48:20:20:20:31:20:20:5B:4E:6F:76:20:31:36:20:32:30:30:39:20:31:39:3A:33:38:3A:30:33:5D
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 74
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> 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:36:32:34:36:41:2D:4B:50:52:42:4C:2D:31:2E:32:2E:30:30:32:32:5F:33:48:20:20:20:31:20:20:5B:4E:6F:76:20:31:36:20:32:30:30:39:20:31:39:3A:33:38:3A:30:33:5D
>>>>>> translated = M6246A-KPRBL-1.2.0022_3H 1 [Nov 16 2009 19:38:03]
ModemManager_orig[1263]: <debug> [1383654290.472915] [mm-broadband-modem-qmi.c:1083] modem_load_revision_finish(): loaded revision:
M6246A-KPRBL-1.2.0022_3H 1 [Nov 16 2009 19:38:03]
ModemManager_orig[1263]: <debug> [1383654290.473601] [mm-broadband-modem-qmi.c:1278] modem_load_equipment_identifier(): loading equipment identifier...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:06:00:25:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 6
<<<<<< tlv_length = 0
<<<<<< message = "Get IDs" (0x0025)
ModemManager_orig[1263]: <debug> [1383654290.487425] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.488025] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB2) device open count is 1 (close)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 38
>>>>>> data = 01:25:00:80:02:01:02:06:00:25:00:19:00:02:04:00:00:00:00:00:11:0F:00:33:35:34:37:36:35:30:33:37:36:31:33:33:36:31
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 37
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 6
>>>>>> tlv_length = 25
>>>>>> message = "Get IDs" (0x0025)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 00:00:00:00
>>>>>> translated = SUCCESS
>>>>>> TLV:
>>>>>> type = "Imei" (0x11)
>>>>>> length = 15
>>>>>> value = 33:35:34:37:36:35:30:33:37:36:31:33:33:36:31
>>>>>> translated = 354765037613361
ModemManager_orig[1263]: <debug> [1383654290.490929] [mm-broadband-modem-qmi.c:1175] modem_load_equipment_identifier_finish(): loaded equipment
identifier: 354765037613361
ModemManager_orig[1263]: <debug> [1383654290.491488] [mm-broadband-modem-qmi.c:1313] modem_load_device_identifier(): loading device identifier...
ModemManager_orig[1263]: <debug> [1383654290.492136] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source
'000012d10000140c354765037613361M6246A-KPRBL-1.2.0022_3H1[Nov16200919:38:03]33HUAWEICOMMUNICATION'
ModemManager_orig[1263]: <debug> [1383654290.492643] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID
'8335959fdeb43fd66cb2727060c983bc7b90e51a'
ModemManager_orig[1263]: <debug> [1383654290.493154] [mm-broadband-modem-qmi.c:1301] modem_load_device_identifier_finish(): loaded device identifier:
8335959fdeb43fd66cb2727060c983bc7b90e51a
ModemManager_orig[1263]: <debug> [1383654290.494121] [mm-broadband-modem-qmi.c:1706] modem_load_supported_bands(): loading band capabilities...
ModemManager_orig[1263]: <warn> [1383654290.494899] [mm-iface-modem.c:3775] load_supported_bands_ready(): couldn't load Supported Bands: 'QMI
operation failed: Cannot send message: QMI service 'dms' version '1.3' required, got version '1.2''
ModemManager_orig[1263]: <debug> [1383654290.495662] [mm-broadband-modem-qmi.c:2650] load_power_state(): Getting device operating mode...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:08:00:2D:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 8
<<<<<< tlv_length = 0
<<<<<< message = "Get Operating Mode" (0x002D)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 24
>>>>>> data = 01:17:00:80:02:01:02:08:00:2D:00:0B:00:02:04:00:00:00:00:00:01:01:00:FF
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 23
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> 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 = FF
>>>>>> translated = unknown
ModemManager_orig[1263]: <warn> [1383654290.508769] [mm-iface-modem.c:3807] load_power_state_ready(): couldn't load Power State: 'Unhandled power
state: 'unknown' (255)'
ModemManager_orig[1263]: <debug> [1383654290.509414] [mm-broadband-modem-qmi.c:1512] modem_load_unlock_required(): loading unlock required...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:09:00:2B:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 9
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get PIN Status" (0x002B)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 32
>>>>>> data = 01:1F:00:80:02:01:02:09:00:2B:00:13:00:02:04:00:00:00:00:00:12:03:00:01:03:0A:11:03:00:03:03:0A
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 31
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> 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 = 03:03:0A
>>>>>> translated = [ current_status = 'disabled' verify_retries_left = '3' unblock_retries_left = '10' ]
ModemManager_orig[1263]: <debug> [1383654290.526995] [mm-broadband-modem-qmi.c:1605] modem_load_unlock_retries(): loading unlock retries...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:0A:00:2B:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 10
<<<<<< tlv_length = 0
<<<<<< message = "UIM Get PIN Status" (0x002B)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 32
>>>>>> data = 01:1F:00:80:02:01:02:0A:00:2B:00:13:00:02:04:00:00:00:00:00:12:03:00:01:03:0A:11:03:00:03:03:0A
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 31
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> 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 = 03:03:0A
>>>>>> translated = [ current_status = 'disabled' verify_retries_left = '3' unblock_retries_left = '10' ]
ModemManager_orig[1263]: <debug> [1383654290.545789] [mm-iface-modem.c:2926] update_lock_info_context_step(): SIM is ready, and no need for the after
SIM unlock step...
ModemManager_orig[1263]: <debug> [1383654290.547788] [mm-sim-qmi.c:148] load_sim_identifier(): loading SIM identifier...
ModemManager_orig[1263]: <debug> [1383654290.548867] [mm-sim-qmi.c:148] load_sim_identifier(): loading SIM identifier...
ModemManager_orig[1263]: <warn> [1383654290.549576] [mm-sim.c:1492] load_sim_identifier_ready(): couldn't load SIM identifier: 'QMI operation failed:
Cannot send message: QMI service 'dms' version '1.3' required, got version '1.2''
ModemManager_orig[1263]: <debug> [1383654290.550128] [mm-sim-qmi.c:224] load_imsi(): loading IMSI...
ModemManager_orig[1263]: <warn> [1383654290.550852] [mm-sim.c:1528] load_imsi_ready(): couldn't load IMSI: 'QMI operation failed: Cannot send message:
QMI service 'dms' version '1.3' required, got version '1.2''
ModemManager_orig[1263]: <debug> [1383654290.551869] [mm-broadband-modem-qmi.c:1397] modem_load_own_numbers(): loading own numbers...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:02:01:00:0E:00:24:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "dms"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 14
<<<<<< tlv_length = 0
<<<<<< message = "Get MSISDN" (0x0024)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:02:01:02:0E:00:24:00:07:00:02:04:00:01:00:10:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "dms"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 14
>>>>>> tlv_length = 7
>>>>>> message = "Get MSISDN" (0x0024)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:10:00
>>>>>> translated = FAILURE: NotProvisioned
ModemManager_orig[1263]: <warn> [1383654290.561268] [mm-iface-modem.c:3890] load_own_numbers_ready(): couldn't load list of Own Numbers: 'Couldn't get
MSISDN: QMI protocol error (16): 'NotProvisioned''
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 13
<<<<<< data = 01:0C:00:00:03:01:00:02:00:2B:00:00:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 12
<<<<<< flags = 0x00
<<<<<< service = "nas"
<<<<<< client = 1
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 2
<<<<<< tlv_length = 0
<<<<<< message = "Get Technology Preference" (0x002B)
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 20
>>>>>> data = 01:13:00:80:03:01:02:02:00:2B:00:07:00:02:04:00:01:00:47:00
ModemManager_orig[1263]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> QMUX:
>>>>>> length = 19
>>>>>> flags = 0x80
>>>>>> service = "nas"
>>>>>> client = 1
>>>>>> QMI:
>>>>>> flags = "response"
>>>>>> transaction = 2
>>>>>> tlv_length = 7
>>>>>> message = "Get Technology Preference" (0x002B)
>>>>>> TLV:
>>>>>> type = "Result" (0x02)
>>>>>> length = 4
>>>>>> value = 01:00:47:00
>>>>>> translated = FAILURE: InvalidQmiCommand
ModemManager_orig[1263]: <debug> [1383654290.574106] [mm-broadband-modem-qmi.c:2821] get_technology_preference_ready(): Couldn't get technology
preference: QMI protocol error (71): 'InvalidQmiCommand'
ModemManager_orig[1263]: <warn> [1383654290.574720] [mm-iface-modem.c:3919] load_current_modes_ready(): couldn't load current allowed/preferred modes:
'Loading current modes is not supported by this device'
ModemManager_orig[1263]: <debug> [1383654290.575227] [mm-broadband-modem-qmi.c:1854] modem_load_current_bands(): loading current bands...
ModemManager_orig[1263]: <warn> [1383654290.576092] [mm-iface-modem.c:3940] load_current_bands_ready(): couldn't load current Bands: 'QMI operation
failed: Cannot send message: QMI service 'nas' version '1.1' required, got version '1.0''
ModemManager_orig[1263]: <debug> [1383654290.580181] [mm-broadband-modem-qmi.c:3249] modem_3gpp_load_imei_finish(): loaded IMEI: 354765037613361
ModemManager_orig[1263]: <debug> [1383654290.581244] [mm-broadband-modem-qmi.c:3328] dms_uim_get_ck_status_ready(): Couldn't query facility 'ph-sim'
status, assuming disabled
ModemManager_orig[1263]: <debug> [1383654290.582018] [mm-broadband-modem-qmi.c:3328] dms_uim_get_ck_status_ready(): Couldn't query facility 'net-pers'
status, assuming disabled
ModemManager_orig[1263]: <debug> [1383654290.582799] [mm-broadband-modem-qmi.c:3328] dms_uim_get_ck_status_ready(): Couldn't query facility
'net-sub-pers' status, assuming disabled
ModemManager_orig[1263]: <debug> [1383654290.583263] [mm-broadband-modem-qmi.c:3328] dms_uim_get_ck_status_ready(): Couldn't query facility
'provider-pers' status, assuming disabled
ModemManager_orig[1263]: <debug> [1383654290.583795] [mm-broadband-modem-qmi.c:3328] dms_uim_get_ck_status_ready(): Couldn't query facility 'corp-pers'
status, assuming disabled
ModemManager_orig[1263]: <debug> [1383654290.585716] [mm-broadband-modem.c:8834] iface_modem_3gpp_ussd_initialize_ready(): Couldn't initialize
interface: 'USSD not supported'
ModemManager_orig[1263]: <debug> [1383654290.587746] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB2) device open count is 2 (open)
ModemManager_orig[1263]: <debug> [1383654290.588250] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'AT+CNMI=?<CR>'
ModemManager_orig[1263]: <debug> [1383654290.601874] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>+CNMI:
(0,1,2),(0,1,2,3),(0,2),(0,1,2),(0,1)<CR><LF><CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.602493] [mm-serial-port.c:960] mm_serial_port_open(): (ttyUSB2) device open count is 3 (open)
ModemManager_orig[1263]: <debug> [1383654290.602832] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB2) device open count is 2 (close)
ModemManager_orig[1263]: <debug> [1383654290.603115] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): --> 'AT+CPMS=?<CR>'
ModemManager_orig[1263]: <debug> [1383654290.616510] [mm-at-serial-port.c:408] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS:
("ME","MT","SM","SR"),("ME","MT","SM","SR"),("ME","MT","SM","SR")<CR><LF><CR><LF>OK<CR><LF>'
ModemManager_orig[1263]: <debug> [1383654290.617416] [mm-iface-modem-messaging.c:1113] load_supported_storages_ready(): Supported storages loaded:
ModemManager_orig[1263]: <debug> [1383654290.617672] [mm-iface-modem-messaging.c:1114] load_supported_storages_ready(): mem1 (list/read/delete)
storages: 'me, mt, sm, sr'
ModemManager_orig[1263]: <debug> [1383654290.617855] [mm-iface-modem-messaging.c:1115] load_supported_storages_ready(): mem2 (write/send) storages:
'me, mt, sm, sr'
ModemManager_orig[1263]: <debug> [1383654290.618033] [mm-iface-modem-messaging.c:1116] load_supported_storages_ready(): mem3 (reception) storages:
'me, mt, sm, sr'
ModemManager_orig[1263]: <debug> [1383654290.618510] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB2) device open count is 1 (close)
ModemManager_orig[1263]: <debug> [1383654290.619145] [mm-broadband-modem.c:8838] iface_modem_time_initialize_ready(): Couldn't initialize interface:
'Time not supported'
ModemManager_orig[1263]: <debug> [1383654290.619983] [mm-broadband-modem-qmi.c:8037] firmware_check_support(): loading firmware images...
ModemManager_orig[1263]: <debug> [1383654290.620771] [mm-broadband-modem.c:8839] iface_modem_firmware_initialize_ready(): Couldn't initialize
interface: 'Firmware not supported'
ModemManager_orig[1263]: <info> [1383654290.621965] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem: state changed (unknown ->
disabled)
ModemManager_orig[1263]: <debug> [1383654290.622981] [mm-serial-port.c:1005] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
ModemManager_orig[1263]: <debug> [1383654290.623267] [mm-serial-port.c:1021] mm_serial_port_close(): (ttyUSB2) closing serial port...
ModemManager_orig[1263]: <debug> [1383654290.625391] [mm-serial-port.c:1054] mm_serial_port_close(): (ttyUSB2) serial port closed
ModemManager_orig[1263]: <debug> [1383654290.625670] [mm-base-modem.c:1025] initialize_ready(): modem properly initialized
ModemManager_orig[1263]: <debug> [1383654290.628123] [mm-device.c:416] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3'
at path '/org/freedesktop/ModemManager1/Modem/0'
ModemManager_orig[1263]: <debug> [1383654290.628535] [mm-device.c:424] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Huawei' modem, VID
0x12D1 PID 0x140C (usb)
^CModemManager_orig[1263]: <info> [1383654470.794078] [main.c:46] quit_cb(): Caught signal, shutting down...
ModemManager_orig[1263]: <debug> [1383654470.796094] [mm-device.c:364] unexport_modem(): Unexported modem
'/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3' from path '/org/freedesktop/ModemManager1/Modem/0'
ModemManager_orig[1263]: <debug> [1383654470.797898] [mm-qmi-port.c:312] mm_qmi_port_close(): Releasing client for service 'nas'...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Unregistered 'nas' client with ID '1'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:00:00:00:04:23:00:05:00:01:02:00:03:01
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 4
<<<<<< tlv_length = 5
<<<<<< message = "Release CID" (0x0023)
<<<<<< TLV:
<<<<<< type = "Release Info" (0x01)
<<<<<< length = 2
<<<<<< value = 03:01
<<<<<< translated = [ service = 'nas' cid = '1' ]
ModemManager_orig[1263]: <debug> [1383654470.800913] [mm-qmi-port.c:312] mm_qmi_port_close(): Releasing client for service 'dms'...
ModemManager_orig[1263]: [/dev/cdc-wdm0] Unregistered 'dms' client with ID '1'
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 17
<<<<<< data = 01:10:00:00:00:00:00:05:23:00:05:00:01:02:00:02:01
ModemManager_orig[1263]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< QMUX:
<<<<<< length = 16
<<<<<< flags = 0x00
<<<<<< service = "ctl"
<<<<<< client = 0
<<<<<< QMI:
<<<<<< flags = "none"
<<<<<< transaction = 5
<<<<<< tlv_length = 5
<<<<<< message = "Release CID" (0x0023)
<<<<<< TLV:
<<<<<< type = "Release Info" (0x01)
<<<<<< length = 2
<<<<<< value = 02:01
<<<<<< translated = [ service = 'dms' cid = '1' ]
ModemManager_orig[1263]: <debug> [1383654470.807523] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB0) forced to close port
ModemManager_orig[1263]: <debug> [1383654470.807840] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB1) forced to close port
ModemManager_orig[1263]: <debug> [1383654470.808064] [mm-serial-port.c:1122] mm_serial_port_close_force(): (ttyUSB2) forced to close port
ModemManager_orig[1263]: <debug> [1383654470.808439] [mm-base-modem.c:1556] finalize(): Modem (Huawei) '/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-3'
completely disposed
ModemManager_orig[1263]: <info> [1383654470.813055] [main.c:179] main(): ModemManager is shut down
[1] 1309
root at Budgie:~# NetworkManager_orig[1310]: <info> NetworkManager (version 0.9.8.8) is starting...
NetworkManager_orig[1310]: <info> Read config file /etc/NetworkManager/NetworkManager.conf
NetworkManager_orig[1310]: <info> WEXT support is enabled
NetworkManager_orig[1310]: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc. To report bugs please use the NetworkManager mailing list.
NetworkManager_orig[1310]: keyfile: parsing Optus - Wireless Broadband ...
NetworkManager_orig[1310]: keyfile: read connection 'Optus - Wireless Broadband'
NetworkManager_orig[1310]: keyfile: parsing Wired connection 1 ...
NetworkManager_orig[1310]: keyfile: read connection 'Wired connection 1'
NetworkManager_orig[1310]: keyfile: parsing OPTUSA4680E8 ...
NetworkManager_orig[1310]: keyfile: read connection 'OPTUSA4680E8'
NetworkManager_orig[1310]: <debug> [1383654471.146211] [nm-modem-manager.c:376] modem_manager_disappeared(): trying to start the modem manager...
NetworkManager_orig[1310]: <debug> [1383654471.147058] [nm-modem-manager.c:280] poke_modem_cb(): Requesting to (re)launch modem-manager...
NetworkManager_orig[1310]: <info> monitoring kernel firmware directory '/lib/firmware'.
NetworkManager_orig[1310]: <debug> [1383654471.150696] [nm-firewall-manager.c:248] nm_firewall_manager_init(): firewall is not running
NetworkManager_orig[1310]: <info> rfkill1: found WiFi radio killswitch (at /sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0/ieee80211/phy0/rfkill1)
(driver ath9k)
NetworkManager_orig[1310]: <info> rfkill0: found WiFi radio killswitch (at /sys/devices/platform/acer-wmi/rfkill/rfkill0) (platform driver acer-wmi)
NetworkManager_orig[1310]: <debug> [1383654471.160701] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill platform switch rfkill0 state now
0/1
NetworkManager_orig[1310]: <debug> [1383654471.161252] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill switch rfkill1 state now 2/2
NetworkManager_orig[1310]: <debug> [1383654471.161596] [nm-udev-manager.c:243] recheck_killswitches(): WiFi rfkill state now 'soft-blocked'
NetworkManager_orig[1310]: <info> WiFi hardware radio set disabled
NetworkManager_orig[1310]: <info> WiFi disabled by radio killswitch; disabled by state file
NetworkManager_orig[1310]: <info> WWAN enabled by radio killswitch; enabled by state file
NetworkManager_orig[1310]: <info> WiMAX enabled by radio killswitch; enabled by state file
NetworkManager_orig[1310]: <info> Networking is enabled by state file
NetworkManager_orig[1310]: <debug> [1383654471.244007] [nm-device-wifi.c:309] constructor(): (wlan0): kernel ifindex 3
NetworkManager_orig[1310]: <info> (wlan0): using nl80211 for WiFi device control
NetworkManager_orig[1310]: <info> (wlan0): driver supports Access Point (AP) mode
NetworkManager_orig[1310]: <debug> [1383654471.247538] [nm-device-wifi.c:2930] update_initial_hw_address(): (wlan0): read initial MAC address
C4:17:FE:AF:86:B1
NetworkManager_orig[1310]: <debug> [1383654471.248575] [nm-manager.c:1726] manager_rfkill_update_one_type(): WiFi hw-enabled 1 sw-enabled 0
NetworkManager_orig[1310]: <info> (wlan0): new 802.11 WiFi device (driver: 'ath9k' ifindex: 3)
NetworkManager_orig[1310]: <info> (wlan0): exported as /org/freedesktop/NetworkManager/Devices/0
NetworkManager_orig[1310]: <debug> [1383654471.249480] [nm-device.c:5314] nm_device_set_managed(): (wlan0): now managed
NetworkManager_orig[1310]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager_orig[1310]: <info> (wlan0): bringing up device.
NetworkManager_orig[1310]: <info> (wlan0): deactivating device (reason 'managed') [2]
NetworkManager_orig[1310]: <debug> [1383654471.251022] [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting
'/proc/sys/net/ipv6/conf/wlan0/accept_ra' to '0'
NetworkManager_orig[1310]: <debug> [1383654471.251258] [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting
'/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0'
NetworkManager_orig[1310]: <debug> [1383654471.251540] [nm-device-wifi.c:854] _set_hw_addr(): (wlan0): no MAC address change needed
NetworkManager_orig[1310]: <debug> [1383654471.252297] [nm-system.c:1404] nm_system_iface_flush_routes(): (wlan0): flushing routes ifindex 3 family
INET (2)
NetworkManager_orig[1310]: <debug> [1383654471.253604] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/8
NetworkManager_orig[1310]: <debug> [1383654471.253902] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/32
NetworkManager_orig[1310]: <debug> [1383654471.254086] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/8
NetworkManager_orig[1310]: <debug> [1383654471.254258] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.1/32
NetworkManager_orig[1310]: <debug> [1383654471.254476] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.255.255.255/32
NetworkManager_orig[1310]: <debug> [1383654471.255471] [nm-system.c:194] sync_addresses(): (wlan0): syncing addresses (family 2)
NetworkManager_orig[1310]: <debug> [1383654471.256372] [nm-device-wifi.c:1366] is_available(): (wlan0): not available because not enabled
NetworkManager_orig[1310]: <debug> [1383654471.256678] [nm-device.c:5146] nm_device_state_changed(): (wlan0): device not yet available for transition
to DISCONNECTED
NetworkManager_orig[1310]: <debug> [1383654471.257195] [nm-manager.c:1381] system_create_virtual_devices(): creating virtual devices...
NetworkManager_orig[1310]: <warn> failed to allocate link cache: (-10) Operation not supported
NetworkManager_orig[1310]: <debug> [1383654471.260529] [nm-device-ethernet.c:1607] supports_ethtool_carrier_detect(): ethtool is supported
NetworkManager_orig[1310]: <debug> [1383654471.261107] [nm-device-wired.c:313] constructor(): (eth0): kernel ifindex 2
NetworkManager_orig[1310]: <info> (eth0): carrier is OFF
NetworkManager_orig[1310]: <debug> [1383654471.262892] [nm-device-ethernet.c:260] constructor(): (eth0): kernel ifindex 2
NetworkManager_orig[1310]: <debug> [1383654471.264689] [nm-device-ethernet.c:484] update_initial_hw_address(): (eth0): read initial MAC address
70:5A:B6:28:A1:9B
NetworkManager_orig[1310]: <info> (eth0): new Ethernet device (driver: 'atl1c' ifindex: 2)
NetworkManager_orig[1310]: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
NetworkManager_orig[1310]: <debug> [1383654471.266100] [nm-device.c:5314] nm_device_set_managed(): (eth0): now managed
NetworkManager_orig[1310]: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager_orig[1310]: <info> (eth0): bringing up device.
NetworkManager_orig[1310]: <info> (eth0): preparing device.
NetworkManager_orig[1310]: <info> (eth0): deactivating device (reason 'managed') [2]
NetworkManager_orig[1310]: <debug> [1383654471.286514] [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting
'/proc/sys/net/ipv6/conf/eth0/accept_ra' to '0'
NetworkManager_orig[1310]: <debug> [1383654471.286847] [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting
'/proc/sys/net/ipv6/conf/eth0/use_tempaddr' to '0'
NetworkManager_orig[1310]: <debug> [1383654471.287142] [nm-device-ethernet.c:383] _set_hw_addr(): (eth0): no MAC address change needed
NetworkManager_orig[1310]: <debug> [1383654471.288289] [nm-system.c:1404] nm_system_iface_flush_routes(): (eth0): flushing routes ifindex 2 family INET
(2)
NetworkManager_orig[1310]: <debug> [1383654471.289629] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/8
NetworkManager_orig[1310]: <debug> [1383654471.289975] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/32
NetworkManager_orig[1310]: <debug> [1383654471.290249] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/8
NetworkManager_orig[1310]: <debug> [1383654471.290581] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.1/32
NetworkManager_orig[1310]: <debug> [1383654471.290841] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.255.255.255/32
NetworkManager_orig[1310]: <debug> [1383654471.292087] [nm-system.c:194] sync_addresses(): (eth0): syncing addresses (family 2)
NetworkManager_orig[1310]: <debug> [1383654471.292906] [nm-device.c:5146] nm_device_state_changed(): (eth0): device not yet available for transition to
DISCONNECTED
NetworkManager_orig[1310]: <debug> [1383654471.293485] [nm-manager.c:1381] system_create_virtual_devices(): creating virtual devices...
NetworkManager_orig[1310]: <debug> [1383654471.294391] [nm-udev-manager.c:477] net_add(): (wwan0): ignoring interface with devtype 'wwan'
NetworkManager_orig[1310]: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
NetworkManager_orig[1310]: <debug> [1383654471.298701] [nm-udev-manager.c:477] net_add(): (wwan0): ignoring interface with devtype 'wwan'
NetworkManager_orig[1310]: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
NetworkManager_orig[1310]: <debug> [1383654471.299682] [nm-manager.c:1381] system_create_virtual_devices(): creating virtual devices...
NetworkManager_orig[1310]: <debug> [1383654471.300036] [main.c:611] main(): setting up local loopback
NetworkManager_orig[1310]: <debug> [1383654471.302025] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 2 flags 0x1003
NetworkManager_orig[1310]: <debug> [1383654471.307169] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 1 flags 0x10049
NetworkManager_orig[1310]: <debug> [1383654471.307544] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 2 flags 0x1003
NetworkManager_orig[1310]: <debug> [1383654471.307796] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1002
NetworkManager_orig[1310]: <debug> [1383654471.308017] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 7 flags 0x1002
NetworkManager_orig[1310]: <warn> Couldn't get managed objects: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.bluez was not
provided by any .service files
NetworkManager_orig[1310]: <info> ModemManager disappeared from bus
NetworkManager_orig[1310]: <info> ModemManager available in the bus
NetworkManager_orig[1310]: <warn> (cdc-wdm0): failed to look up interface index
NetworkManager_orig[1310]: <debug> [1383654484.771875] [nm-device.c:410] device_get_driver_info(): SIOCETHTOOL ioctl() failed: cmd=ETHTOOL_GDRVINFO,
iface=cdc-wdm0, errno=19
NetworkManager_orig[1310]: <debug> [1383654484.772233] [NetworkManagerUtils.c:684] nm_utils_get_proc_sys_net_value(): (cdc-wdm0): error reading
/proc/sys/net/ipv6/conf/cdc-wdm0/accept_ra: (4) Failed to open file '/proc/sys/net/ipv6/conf/cdc-wdm0/accept_ra': No such file or directory
NetworkManager_orig[1310]: <debug> [1383654484.772592] [NetworkManagerUtils.c:684] nm_utils_get_proc_sys_net_value(): (cdc-wdm0): error reading
/proc/sys/net/ipv6/conf/cdc-wdm0/use_tempaddr: (4) Failed to open file '/proc/sys/net/ipv6/conf/cdc-wdm0/use_tempaddr': No such file or directory
NetworkManager_orig[1310]: <debug> [1383654484.773494] [nm-manager.c:1723] manager_rfkill_update_one_type(): WWAN hw-enabled 1 sw-enabled 1
daemon-enabled 0
NetworkManager_orig[1310]: <info> (cdc-wdm0): new Broadband device (driver: 'option1, qmi_wwan' ifindex: 0)
NetworkManager_orig[1310]: <info> (cdc-wdm0): exported as /org/freedesktop/NetworkManager/Devices/2
NetworkManager_orig[1310]: <debug> [1383654484.774019] [nm-device.c:5314] nm_device_set_managed(): (cdc-wdm0): now managed
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager_orig[1310]: <info> (cdc-wdm0): deactivating device (reason 'managed') [2]
NetworkManager_orig[1310]: <debug> [1383654484.785187] [nm-device.c:5142] nm_device_state_changed(): (cdc-wdm0): device is available, will transition
to DISCONNECTED
NetworkManager_orig[1310]: <debug> [1383654484.785296] [nm-device.c:5253] nm_device_queue_state(): (cdc-wdm0): queued state change to disconnected (id
51)
NetworkManager_orig[1310]: <debug> [1383654484.785588] [nm-manager.c:1381] system_create_virtual_devices(): creating virtual devices...
NetworkManager_orig[1310]: <debug> [1383654484.786678] [nm-device.c:5211] queued_set_state(): (cdc-wdm0): running queued state change to disconnected
(id 51)
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
*** Note- Needed to hit ^C to get command prompt here ***
root at Budgie:~# nmcli con
NAME UUID TYPE TIMESTAMP-REAL
Optus - Wireless Broadband b326063f-8165-4742-88b3-ed9d16cfbf86 gsm Tue 05 Nov 2013 15:27:10 EST
Wired connection 1 c742b1c8-14cd-4dc0-beb4-8b22db82f8f7 802-3-ethernet Tue 05 Nov 2013 22:39:46 EST
OPTUSA4680E8 73c548dc-0a46-4505-8c5a-186886a85031 802-11-wireless Sun 27 Oct 2013 23:13:30 EST
root at Budgie:~# nmcli con up uuid b326063f-8165-4742-88b3-ed9d16cfbf86
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) starting connection 'Optus - Wireless Broadband'
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
NetworkManager_orig[1310]: <info> NetworkManager state is now CONNECTING
NetworkManager_orig[1310]: <debug> [1383654593.384258] [nm-manager.c:4088] policy_activating_device_changed(): ActivatingConnection now Optus -
Wireless Broadband
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 1 of 5 (Device Prepare) started...
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager_orig[1310]: <info> (cdc-wdm0) modem state changed, 'disabled' --> 'enabling' (reason: user-requested)
NetworkManager_orig[1310]: <info> (cdc-wdm0) modem state changed, 'enabling' --> 'registered' (reason: user-requested)
NetworkManager_orig[1310]: <info> WWAN now enabled by management service
NetworkManager_orig[1310]: <debug> [1383654593.808662] [nm-manager.c:1723] manager_rfkill_update_one_type(): WWAN hw-enabled 1 sw-enabled 1
daemon-enabled 1
NetworkManager_orig[1310]: <debug> [1383654593.809637] [nm-manager.c:1578] manager_update_radio_enabled(): (cdc-wdm0): setting radio enabled
NetworkManager_orig[1310]: <info> (cdc-wdm0) modem state changed, 'registered' --> 'connecting' (reason: user-requested)
NetworkManager_orig[1310]: <info> (cdc-wdm0) modem state changed, 'connecting' --> 'connected' (reason: user-requested)
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 2 of 5 (Device Configure) starting...
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: prepare -> config (reason 'none') [40 50 0]
NetworkManager_orig[1310]: <info> (cdc-wdm0): bringing up device.
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 2 of 5 (Device Configure) successful.
NetworkManager_orig[1310]: <debug> [1383654596.195068] [nm-device.c:3066] nm_device_activate_schedule_stage3_ip_config_start(): Activation (cdc-wdm0)
setting firewall zone 'default'
NetworkManager_orig[1310]: <debug> [1383654596.195172] [nm-firewall-manager.c:107] nm_firewall_manager_add_or_change_zone(): (wwan0) firewall zone
add/change skipped (not running)
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 3 of 5 (IP Configure Start) scheduled.
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 2 of 5 (Device Configure) complete.
NetworkManager_orig[1310]: <debug> [1383654596.195772] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 7 flags 0x11043
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 3 of 5 (IP Configure Start) started...
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: config -> ip-config (reason 'none') [50 70 0]
NetworkManager_orig[1310]: <info> Activation (wwan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
NetworkManager_orig[1310]: <debug> [1383654596.201547] [nm-dhcp-dhcpcd.c:152] ip4_start(): running: /sbin/dhcpcd -B -K -L -G -c
/usr/libexec/nm-dhcp-client.action -h Budgie wwan0
NetworkManager_orig[1310]: <info> dhcpcd started with pid 1333
dhcpcd[1333]: version 6.0.5 starting
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 3 of 5 (IP Configure Start) complete.
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 4 of 5 (IPv6 Configure Timeout) started...
NetworkManager_orig[1310]: <info> Activation (cdc-wdm0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
dhcpcd[1333]: wwan0: soliciting an IPv6 router
dhcpcd[1333]: wwan0: ipv6rs_sendprobe: sendmsg: Cannot assign requested address
NetworkManager_orig[1310]: <info> (wwan0): DHCPv4 state changed nbi -> preinit
NetworkManager_orig[1310]: <debug> [1383654596.234235] [nm-device.c:1945] dhcp4_state_changed(): (cdc-wdm0): new DHCPv4 client state 1
dhcpcd[1333]: wwan0: soliciting a DHCP lease
NetworkManager_orig[1310]: <debug> [1383654600.625156] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 7 flags 0x1002
dhcpcd[1333]: wwan0: removing interface
NetworkManager_orig[1310]: <debug> [1383654600.628166] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 7 flags 0x1002
NetworkManager_orig[1310]: <debug> [1383654600.632429] [nm-udev-manager.c:568] handle_uevent(): UDEV event: action 'remove' subsys 'net' device 'wwan0'
NetworkManager_orig[1310]: <debug> [1383654600.633030] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill platform switch rfkill0 state now
0/1
NetworkManager_orig[1310]: <debug> [1383654600.638634] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill switch rfkill1 state now 2/2
NetworkManager_orig[1310]: <debug> [1383654600.648294] [nm-device.c:5314] nm_device_set_managed(): (cdc-wdm0): now unmanaged
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: ip-config -> unmanaged (reason 'removed') [70 10 36]
NetworkManager_orig[1310]: <info> (cdc-wdm0): deactivating device (reason 'removed') [36]
NetworkManager_orig[1310]: <debug> [1383654600.648822] [nm-firewall-manager.c:157] nm_firewall_manager_remove_from_zone(): (wwan0) firewall zone remove
skipped (not running)
dhcpcd[1333]: exited
NetworkManager_orig[1310]: <info> (wwan0): canceled DHCP transaction, DHCP client pid 1333
NetworkManager_orig[1310]: <warn> (7) failed to find interface name for index
NetworkManager_orig[1310]: nm_system_iface_flush_routes: assertion `iface != NULL' failed
NetworkManager_orig[1310]: <warn> (7) failed to find interface name for index
NetworkManager_orig[1310]: <warn> (7) failed to find interface name for index
NetworkManager_orig[1310]: nm_system_iface_flush_routes: assertion `iface != NULL' failed
NetworkManager_orig[1310]: <warn> (7) failed to find interface name for index
NetworkManager_orig[1310]: <info> (cdc-wdm0): cleaning up...
NetworkManager_orig[1310]: <info> (cdc-wdm0): taking down device.
NetworkManager_orig[1310]: <info> NetworkManager state is now DISCONNECTED
NetworkManager_orig[1310]: <debug> [1383654600.872870] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS
updates (1)
NetworkManager_orig[1310]: <debug> [1383654600.873226] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS
configuration did not change
NetworkManager_orig[1310]: <debug> [1383654600.873486] [nm-dns-manager.c:1017] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes
to commit (0)
NetworkManager_orig[1310]: <debug> [1383654600.873778] [nm-manager.c:4088] policy_activating_device_changed(): ActivatingConnection now (none)
NetworkManager_orig[1310]: <warn> (pid 1333) unhandled DHCP event for interface wwan0
NetworkManager_orig[1310]: <warn> (cdc-wdm0) failed to disconnect modem: GDBus.Error:org.freedesktop.DBus.Error.UnknownMethod: No such interface
`org.freedesktop.ModemManager1.Modem.Simple' on object at path /org/freedesktop/ModemManager1/Modem/0
NetworkManager_orig[1310]: <warn> (pid 1333) unhandled DHCP event for interface wwan0
NetworkManager_orig[1310]: <debug> [1383654605.245801] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 8 flags 0x1002
NetworkManager_orig[1310]: <debug> [1383654605.340519] [nm-udev-manager.c:568] handle_uevent(): UDEV event: action 'add' subsys 'net' device 'wwan0'
NetworkManager_orig[1310]: <debug> [1383654605.340903] [nm-udev-manager.c:477] net_add(): (wwan0): ignoring interface with devtype 'wwan'
NetworkManager_orig[1310]: <debug> [1383654605.341247] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill platform switch rfkill0 state now
0/1
NetworkManager_orig[1310]: <debug> [1383654605.341680] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill switch rfkill1 state now 2/2
NetworkManager_orig[1310]: <warn> (cdc-wdm0): failed to look up interface index
NetworkManager_orig[1310]: <debug> [1383654619.505293] [nm-device.c:410] device_get_driver_info(): SIOCETHTOOL ioctl() failed: cmd=ETHTOOL_GDRVINFO,
iface=cdc-wdm0, errno=19
NetworkManager_orig[1310]: <debug> [1383654619.505635] [NetworkManagerUtils.c:684] nm_utils_get_proc_sys_net_value(): (cdc-wdm0): error reading
/proc/sys/net/ipv6/conf/cdc-wdm0/accept_ra: (4) Failed to open file '/proc/sys/net/ipv6/conf/cdc-wdm0/accept_ra': No such file or directory
NetworkManager_orig[1310]: <debug> [1383654619.505806] [NetworkManagerUtils.c:684] nm_utils_get_proc_sys_net_value(): (cdc-wdm0): error reading
/proc/sys/net/ipv6/conf/cdc-wdm0/use_tempaddr: (4) Failed to open file '/proc/sys/net/ipv6/conf/cdc-wdm0/use_tempaddr': No such file or directory
NetworkManager_orig[1310]: <info> WWAN now disabled by management service
NetworkManager_orig[1310]: <debug> [1383654619.506309] [nm-manager.c:1723] manager_rfkill_update_one_type(): WWAN hw-enabled 1 sw-enabled 1
daemon-enabled 0
NetworkManager_orig[1310]: <debug> [1383654619.506483] [nm-manager.c:1578] manager_update_radio_enabled(): (cdc-wdm0): setting radio disabled
NetworkManager_orig[1310]: <info> (cdc-wdm0): new Broadband device (driver: 'qmi_wwan, option1' ifindex: 0)
NetworkManager_orig[1310]: <info> (cdc-wdm0): exported as /org/freedesktop/NetworkManager/Devices/3
NetworkManager_orig[1310]: <debug> [1383654619.506783] [nm-device.c:5314] nm_device_set_managed(): (cdc-wdm0): now managed
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager_orig[1310]: <info> (cdc-wdm0): deactivating device (reason 'managed') [2]
NetworkManager_orig[1310]: <debug> [1383654619.517598] [nm-device.c:5142] nm_device_state_changed(): (cdc-wdm0): device is available, will transition
to DISCONNECTED
NetworkManager_orig[1310]: <debug> [1383654619.517708] [nm-device.c:5253] nm_device_queue_state(): (cdc-wdm0): queued state change to disconnected (id
146)
NetworkManager_orig[1310]: <debug> [1383654619.517975] [nm-manager.c:1381] system_create_virtual_devices(): creating virtual devices...
NetworkManager_orig[1310]: <debug> [1383654619.519196] [nm-device.c:5211] queued_set_state(): (cdc-wdm0): running queued state change to disconnected
(id 146)
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
Error: Timeout 90 sec expired.
root at Budgie:~#
**** Modem unplugged ****
NetworkManager_orig[1310]: <debug> [1383654697.908460] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 8
flags 0x1002
NetworkManager_orig[1310]: <debug> [1383654697.918066] [nm-udev-manager.c:568] handle_uevent(): UDEV event: action 'remove' subsys 'net' device 'wwan0'
NetworkManager_orig[1310]: <debug> [1383654697.918973] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill platform switch rfkill0 state now
0/1
NetworkManager_orig[1310]: <debug> [1383654697.919822] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill switch rfkill1 state now 2/2
NetworkManager_orig[1310]: <debug> [1383654697.931795] [nm-device.c:5314] nm_device_set_managed(): (cdc-wdm0): now unmanaged
NetworkManager_orig[1310]: <info> (cdc-wdm0): device state change: disconnected -> unmanaged (reason 'removed') [30 10 36]
NetworkManager_orig[1310]: <info> (cdc-wdm0): cleaning up...
NetworkManager_orig[1310]: <info> (cdc-wdm0): taking down device.
root at Budgie:~#
More information about the ModemManager-devel
mailing list