Attachment 122785 Details for Bug 94855 – ModemManager debug log

ModemManager debug log

mm-debug.log (text/plain), 125.22 KB, created by Alexander E. Patrakov on 2016-04-07 08:47:50 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Alexander E. Patrakov

Created: 2016-04-07 08:47:50 UTC

Size: 125.22 KB

patch

obsolete

>ModemManager[1614]: <info>  [1460018543.020018] [main.c:136] main(): ModemManager (version 1.4.14) starting in system bus...
>ModemManager[1614]: <debug> [1460018543.024961] [main.c:61] bus_acquired_cb(): Bus acquired, creating manager...
>ModemManager[1614]: <debug> [1460018543.030839] [mm-plugin-manager.c:852] load_plugins(): Looking for plugins in '/usr/lib/ModemManager'
>ModemManager[1614]: <debug> [1460018543.031929] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'ZTE'
>ModemManager[1614]: <debug> [1460018543.032316] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Wavecom'
>ModemManager[1614]: <debug> [1460018543.032783] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'X22X'
>ModemManager[1614]: <debug> [1460018543.033230] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'MTK'
>ModemManager[1614]: <debug> [1460018543.033571] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Generic'
>ModemManager[1614]: <debug> [1460018543.033962] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Altair LTE'
>ModemManager[1614]: <debug> [1460018543.034360] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Samsung'
>ModemManager[1614]: <debug> [1460018543.034952] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia (Icera)'
>ModemManager[1614]: <debug> [1460018543.035236] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Via CBP7'
>ModemManager[1614]: <debug> [1460018543.035560] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'SimTech'
>ModemManager[1614]: <debug> [1460018543.035852] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Pantech'
>ModemManager[1614]: <debug> [1460018543.036143] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'AnyDATA'
>ModemManager[1614]: <debug> [1460018543.036443] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia'
>ModemManager[1614]: <debug> [1460018543.036740] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Iridium'
>ModemManager[1614]: <debug> [1460018543.037031] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Novatel LTE'
>ModemManager[1614]: <debug> [1460018543.037360] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Longcheer'
>ModemManager[1614]: <debug> [1460018543.037702] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Ericsson MBM'
>ModemManager[1614]: <debug> [1460018543.037974] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Motorola'
>ModemManager[1614]: <debug> [1460018543.038285] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Novatel'
>ModemManager[1614]: <debug> [1460018543.038631] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Cinterion'
>ModemManager[1614]: <debug> [1460018543.038927] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Linktop'
>ModemManager[1614]: <debug> [1460018543.039259] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Sierra'
>ModemManager[1614]: <debug> [1460018543.039615] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Huawei'
>ModemManager[1614]: <debug> [1460018543.039954] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option High-Speed'
>ModemManager[1614]: <debug> [1460018543.040292] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Telit'
>ModemManager[1614]: <debug> [1460018543.040623] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option'
>ModemManager[1614]: <debug> [1460018543.040891] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Gobi'
>ModemManager[1614]: <debug> [1460018543.040931] [mm-plugin-manager.c:902] load_plugins(): Successfully loaded 27 plugins
>ModemManager[1614]: <debug> [1460018543.042051] [main.c:83] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
>ModemManager[1614]: <debug> [1460018543.042156] [mm-base-manager.c:485] mm_base_manager_start(): Starting automatic device scan...
>ModemManager[1614]: <debug> [1460018543.052937] [mm-base-manager.c:524] mm_base_manager_start(): Finished device scan...
>ModemManager[1614]: <debug> [1460018543.053572] [mm-base-manager.c:320] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted
>ModemManager[1614]: <debug> [1460018543.053784] [mm-base-manager.c:320] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
>ModemManager[1614]: <debug> [1460018543.054000] [mm-base-manager.c:320] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
>ModemManager[1614]: <debug> [1460018543.054259] [mm-base-manager.c:320] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
>ModemManager[1614]: <debug> [1460018543.056035] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0] Checking device support...
>ModemManager[1614]: <debug> [1460018543.056441] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.056561] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.056642] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.056709] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.056762] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.056825] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.056892] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.056958] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057013] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057065] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.057119] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.057179] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057233] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057281] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.057336] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057385] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wlp1s0] filtered by udev tags
>ModemManager[1614]: <debug> [1460018543.057425] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057473] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.057522] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.057571] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057618] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wlp1s0] filtered by drivers
>ModemManager[1614]: <debug> [1460018543.057667] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wlp1s0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018543.057713] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wlp1s0] filtered by drivers
>ModemManager[1614]: <debug> [1460018543.057765] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057811] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wlp1s0] filtered by subsystem
>ModemManager[1614]: <debug> [1460018543.057882] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wlp1s0] filtered by drivers
>ModemManager[1614]: <debug> [1460018543.057932] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wlp1s0] Found '1' plugins to try...
>ModemManager[1614]: <debug> [1460018543.057952] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wlp1s0]   Will try with plugin 'Generic'
>ModemManager[1614]: <debug> [1460018543.057984] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [wlp1s0] probing deferred until result suggested
>ModemManager[1614]: <debug> [1460018543.058241] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wlp1s0] deferring support check until result suggested
>ModemManager[1614]: <debug> [1460018544.933893] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0] Minimum probing time consumed
>ModemManager[1614]: <debug> [1460018544.934003] [mm-plugin-manager.c:368] suggest_single_port_probe_result(): (Plugin Manager) [wlp1s0] deferred task cancelled, no suggested plugin
>ModemManager[1614]: <debug> [1460018544.934068] [mm-plugin-manager.c:195] port_probe_context_finished(): (Plugin Manager) [wlp1s0] not supported by any plugin
>ModemManager[1614]: <debug> [1460018544.934109] [mm-device.c:368] mm_device_ignore_port(): Fully ignoring port 'net/wlp1s0' from now on
>ModemManager[1614]: <debug> [1460018544.934157] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'wlp1s0' port probe finished, last one in device
>ModemManager[1614]: <debug> [1460018544.934190] [mm-plugin-manager.c:138] 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 '1.877945' seconds
>ModemManager[1614]: <info>  [1460018544.934332] [mm-base-manager.c:153] 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[1614]: <debug> [1460018554.975091] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1] Checking device support...
>ModemManager[1614]: <debug> [1460018554.975162] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975176] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975185] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975195] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB1] filtered by udev tags
>ModemManager[1614]: <debug> [1460018554.975207] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975216] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975225] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975235] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975243] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975252] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975263] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975270] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975280] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB1] filtered by udev tags
>ModemManager[1614]: <debug> [1460018554.975288] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975295] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975305] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975313] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB1] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.975323] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB1] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.975331] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975340] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB1] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975349] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB1] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.975357] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB1] Found '6' plugins to try...
>ModemManager[1614]: <debug> [1460018554.975365] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Huawei'
>ModemManager[1614]: <debug> [1460018554.975374] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Via CBP7'
>ModemManager[1614]: <debug> [1460018554.975382] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Nokia'
>ModemManager[1614]: <debug> [1460018554.975390] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Iridium'
>ModemManager[1614]: <debug> [1460018554.975398] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Cinterion'
>ModemManager[1614]: <debug> [1460018554.975405] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB1]   Will try with plugin 'Generic'
>ModemManager[1614]: <debug> [1460018554.975428] [mm-plugin.c:767] mm_plugin_supports_port(): (Huawei) [ttyUSB1] probe required: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018554.975441] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018554.975709] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975721] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975729] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975740] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB0] filtered by udev tags
>ModemManager[1614]: <debug> [1460018554.975748] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975758] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975766] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975773] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975779] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975786] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975794] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975800] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975808] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB0] filtered by udev tags
>ModemManager[1614]: <debug> [1460018554.975815] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975823] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975832] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975840] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB0] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.975849] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB0] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.975857] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975866] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB0] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.975874] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB0] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.975882] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB0] Found '6' plugins to try...
>ModemManager[1614]: <debug> [1460018554.975890] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Huawei'
>ModemManager[1614]: <debug> [1460018554.975898] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Via CBP7'
>ModemManager[1614]: <debug> [1460018554.975906] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Nokia'
>ModemManager[1614]: <debug> [1460018554.975915] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Iridium'
>ModemManager[1614]: <debug> [1460018554.975922] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Cinterion'
>ModemManager[1614]: <debug> [1460018554.975928] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB0]   Will try with plugin 'Generic'
>ModemManager[1614]: <debug> [1460018554.975940] [mm-plugin.c:767] mm_plugin_supports_port(): (Huawei) [ttyUSB0] probe required: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018554.975951] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018554.976196] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB1) opening serial port...
>ModemManager[1614]: <warn>  [1460018554.978169] [mm-port-serial.c:515] real_config_fd(): (ttyUSB1): port attributes not fully set
>ModemManager[1614]: <debug> [1460018554.978217] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018554.978321] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB0) opening serial port...
>ModemManager[1614]: <warn>  [1460018554.978951] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
>ModemManager[1614]: <debug> [1460018554.978994] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018554.980857] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.980901] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.980922] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.980949] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB2] filtered by udev tags
>ModemManager[1614]: <debug> [1460018554.980969] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.980987] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981005] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981024] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981041] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981058] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981076] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981094] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981112] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB2] filtered by udev tags
>ModemManager[1614]: <debug> [1460018554.981130] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981147] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981164] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981181] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB2] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.981201] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB2] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.981218] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981236] [mm-plugin.c:326] apply_pre_probing_filters(): (Option) [ttyUSB2] filtered by vendor/product IDs
>ModemManager[1614]: <debug> [1460018554.981253] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB2] filtered by drivers
>ModemManager[1614]: <debug> [1460018554.981272] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyUSB2] Found '6' plugins to try...
>ModemManager[1614]: <debug> [1460018554.981288] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Huawei'
>ModemManager[1614]: <debug> [1460018554.981303] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Via CBP7'
>ModemManager[1614]: <debug> [1460018554.981319] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Nokia'
>ModemManager[1614]: <debug> [1460018554.981334] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Iridium'
>ModemManager[1614]: <debug> [1460018554.981348] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Cinterion'
>ModemManager[1614]: <debug> [1460018554.981364] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyUSB2]   Will try with plugin 'Generic'
>ModemManager[1614]: <debug> [1460018554.981389] [mm-plugin.c:767] mm_plugin_supports_port(): (Huawei) [ttyUSB2] probe required: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018554.981414] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018554.981540] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB2) opening serial port...
>ModemManager[1614]: <warn>  [1460018554.987190] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
>ModemManager[1614]: <debug> [1460018554.987258] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018555.078584] [mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018555.078626] [mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
>ModemManager[1614]: <debug> [1460018555.079149] [mm-port-serial.c:1372] _close_internal(): (ttyUSB1) serial port closed
>ModemManager[1614]: <debug> [1460018555.079179] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB1) forced to close port
>ModemManager[1614]: <debug> [1460018555.079262] [mm-plugin-manager.c:514] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB1] deferring support check
>ModemManager[1614]: <debug> [1460018555.079318] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT^CURC=0<CR>'
>ModemManager[1614]: <debug> [1460018555.087557] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018555.087604] [mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
>ModemManager[1614]: <debug> [1460018555.088054] [mm-port-serial.c:1372] _close_internal(): (ttyUSB2) serial port closed
>ModemManager[1614]: <debug> [1460018555.088078] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB2) forced to close port
>ModemManager[1614]: <debug> [1460018555.088202] [mm-plugin-manager.c:514] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB2] deferring support check
>ModemManager[1614]: <debug> [1460018556.181391] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'AT^CURC=0'
>ModemManager[1614]: <debug> [1460018556.186721] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR>'
>ModemManager[1614]: <debug> [1460018556.187573] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018556.187634] [huawei/mm-plugin-huawei.c:201] curc_ready(): (Huawei) unsolicited messages in secondary ports turned off
>ModemManager[1614]: <debug> [1460018556.187685] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT^GETPORTMODE<CR>'
>ModemManager[1614]: <debug> [1460018556.931543] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1] Minimum probing time consumed
>ModemManager[1614]: <debug> [1460018557.587822] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'AT^GETPORTMODE'
>ModemManager[1614]: <debug> [1460018557.594294] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR>'
>ModemManager[1614]: <debug> [1460018557.594377] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>ModemManager[1614]: <debug> [1460018557.594470] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>ModemManager[1614]: <debug> [1460018557.594506] [huawei/mm-plugin-huawei.c:140] getportmode_ready(): (Huawei) couldn't get port mode: 'Unknown error'
>ModemManager[1614]: <debug> [1460018557.594566] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
>ModemManager[1614]: <debug> [1460018557.794626] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- 'AT'
>ModemManager[1614]: <debug> [1460018557.795576] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): <-- '<CR><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018557.795655] [mm-port-probe.c:154] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is AT-capable
>ModemManager[1614]: <debug> [1460018557.795699] [mm-port-serial.c:1307] _close_internal(): (ttyUSB0) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018557.795718] [mm-port-serial.c:1323] _close_internal(): (ttyUSB0) closing serial port...
>ModemManager[1614]: <debug> [1460018557.796343] [mm-port-serial.c:1372] _close_internal(): (ttyUSB0) serial port closed
>ModemManager[1614]: <debug> [1460018557.796375] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB0) forced to close port
>ModemManager[1614]: <debug> [1460018557.796420] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB0] found best plugin for port
>ModemManager[1614]: <debug> [1460018557.796442] [mm-plugin-manager.c:232] port_probe_context_finished(): (Plugin Manager) (Huawei) [ttyUSB0]: found best plugin for device (/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1)
>ModemManager[1614]: <debug> [1460018557.796477] [mm-plugin-manager.c:407] suggest_single_port_probe_result(): (Plugin Manager) (Huawei) [ttyUSB2] suggested plugin for port
>ModemManager[1614]: <debug> [1460018557.796494] [mm-plugin-manager.c:407] suggest_single_port_probe_result(): (Plugin Manager) (Huawei) [ttyUSB1] suggested plugin for port
>ModemManager[1614]: <debug> [1460018557.796507] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB0' port probe finished, still 2 running probes in this device (ttyUSB2, ttyUSB1)
>ModemManager[1614]: <debug> [1460018557.932780] [mm-plugin.c:767] mm_plugin_supports_port(): (Huawei) [ttyUSB1] probe required: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018557.932831] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018557.932861] [mm-plugin.c:767] mm_plugin_supports_port(): (Huawei) [ttyUSB2] probe required: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018557.932875] [mm-port-probe.c:1368] mm_port_probe_run(): (tty/ttyUSB2) launching port probing: 'at, qcdm'
>ModemManager[1614]: <debug> [1460018557.933018] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB1) opening serial port...
>ModemManager[1614]: <warn>  [1460018557.933366] [mm-port-serial.c:515] real_config_fd(): (ttyUSB1): port attributes not fully set
>ModemManager[1614]: <debug> [1460018557.933410] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018557.933501] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB2) opening serial port...
>ModemManager[1614]: <warn>  [1460018557.934170] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
>ModemManager[1614]: <debug> [1460018557.934200] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018557.934470] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^STIN:99,1,0<CR><LF>'
>ModemManager[1614]: <debug> [1460018558.033778] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT<CR>'
>ModemManager[1614]: <debug> [1460018558.034952] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT<CR>'
>ModemManager[1614]: <debug> [1460018558.235004] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- 'AT'
>ModemManager[1614]: <debug> [1460018558.236683] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR>'
>ModemManager[1614]: <debug> [1460018558.236825] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018558.236880] [mm-port-probe.c:154] mm_port_probe_set_result_at(): (tty/ttyUSB2) port is AT-capable
>ModemManager[1614]: <debug> [1460018558.236923] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018558.236940] [mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
>ModemManager[1614]: <debug> [1460018558.237390] [mm-port-serial.c:1372] _close_internal(): (ttyUSB2) serial port closed
>ModemManager[1614]: <debug> [1460018558.237414] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB2) forced to close port
>ModemManager[1614]: <debug> [1460018558.237454] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB2] found best plugin for port
>ModemManager[1614]: <debug> [1460018558.237475] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyUSB2' port probe finished, still 1 running probes in this device (ttyUSB1)
>ModemManager[1614]: <debug> [1460018561.936338] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
>ModemManager[1614]: <debug> [1460018561.936493] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT<CR>'
>ModemManager[1614]: <debug> [1460018564.935046] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
>ModemManager[1614]: <debug> [1460018564.935262] [mm-port-serial-at.c:440] debug_log(): (ttyUSB1): --> 'AT<CR>'
>ModemManager[1614]: <debug> [1460018567.934751] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
>ModemManager[1614]: <debug> [1460018567.934810] [mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB1) port is not AT-capable
>ModemManager[1614]: <debug> [1460018567.934840] [mm-port-probe.c:660] serial_probe_qcdm(): (tty/ttyUSB1) probing QCDM...
>ModemManager[1614]: <debug> [1460018567.934886] [mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018567.934904] [mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
>ModemManager[1614]: <debug> [1460018567.935409] [mm-port-serial.c:1372] _close_internal(): (ttyUSB1) serial port closed
>ModemManager[1614]: <debug> [1460018567.935435] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB1) forced to close port
>ModemManager[1614]: <debug> [1460018567.935500] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB1) opening serial port...
>ModemManager[1614]: <debug> [1460018567.935794] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018567.935842] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB1): --> 7e 00 78 f0 7e
>ModemManager[1614]: <debug> [1460018567.936674] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB1): <-- 00 4e 6f 76 20 31 32 20 32 30 30 39 31 39 3a 35 33 3a 35 34 4e 6f 76 20 31 32 20 32 30 30 39 31 39 3a 35 33 3a 35 34 53 4b 43 41 41 41 5a 4d 00 00 08 00 00 00 02 e0 cc f0 7e
>ModemManager[1614]: <debug> [1460018567.936719] [mm-port-probe.c:242] mm_port_probe_set_result_qcdm(): (tty/ttyUSB1) port is QCDM-capable
>ModemManager[1614]: <debug> [1460018567.936751] [mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018567.936765] [mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
>ModemManager[1614]: <debug> [1460018567.937186] [mm-port-serial.c:1372] _close_internal(): (ttyUSB1) serial port closed
>ModemManager[1614]: <debug> [1460018567.937206] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB1) forced to close port
>ModemManager[1614]: <debug> [1460018567.937240] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Huawei) [ttyUSB1] found best plugin for port
>ModemManager[1614]: <debug> [1460018567.937258] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'ttyUSB1' port probe finished, last one in device
>ModemManager[1614]: <debug> [1460018567.937270] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1] device support check finished in '12.962143' seconds
>ModemManager[1614]: <info>  [1460018567.937292] [mm-device.c:520] mm_device_create_modem(): Creating modem with plugin 'Huawei' and '3' ports
>ModemManager[1614]: <debug> [1460018567.938402] [huawei/mm-plugin-huawei.c:558] grab_port(): (tty/ttyUSB2) Port will have AT flags 'none'
>ModemManager[1614]: <debug> [1460018567.938493] [mm-base-modem.c:304] mm_base_modem_grab_port(): (ttyUSB2) type 'at' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb2/2-1
>ModemManager[1614]: <debug> [1460018567.938525] [huawei/mm-plugin-huawei.c:558] grab_port(): (tty/ttyUSB0) Port will have AT flags 'ppp'
>ModemManager[1614]: <debug> [1460018567.938592] [mm-base-modem.c:304] mm_base_modem_grab_port(): (ttyUSB0) type 'at' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb2/2-1
>ModemManager[1614]: <debug> [1460018567.938620] [huawei/mm-plugin-huawei.c:558] grab_port(): (tty/ttyUSB1) Port will have AT flags 'none'
>ModemManager[1614]: <debug> [1460018567.938641] [mm-base-modem.c:304] mm_base_modem_grab_port(): (ttyUSB1) type 'qcdm' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb2/2-1
>ModemManager[1614]: <debug> [1460018567.938658] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1) tty/ttyUSB2 at (primary)
>ModemManager[1614]: <debug> [1460018567.938668] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1) tty/ttyUSB0 data (primary)
>ModemManager[1614]: <debug> [1460018567.938676] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1) tty/ttyUSB1 qcdm
>ModemManager[1614]: <debug> [1460018567.938910] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB2) opening serial port...
>ModemManager[1614]: <warn>  [1460018567.943445] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
>ModemManager[1614]: <debug> [1460018567.943549] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018567.943593] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB2): running init sequence...
>ModemManager[1614]: <debug> [1460018567.943662] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018567.943708] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <info>  [1460018567.943750] [mm-base-manager.c:162] find_device_support_ready(): Modem for device at '/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1' successfully created
>ModemManager[1614]: <debug> [1460018567.944889] [mm-broadband-modem.c:699] modem_load_current_capabilities(): loading current capabilities...
>ModemManager[1614]: <debug> [1460018567.944917] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB1) opening serial port...
>ModemManager[1614]: <debug> [1460018567.945229] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018567.945275] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
>ModemManager[1614]: <debug> [1460018567.945345] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB1): --> 26 0a 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 b2 37 7e
>ModemManager[1614]: <debug> [1460018567.947734] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB1): <-- 26 0a 00 00 04 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4f 52 7e
>ModemManager[1614]: <debug> [1460018567.947772] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
>ModemManager[1614]: <debug> [1460018567.949473] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- 'ATE0'
>ModemManager[1614]: <debug> [1460018567.950218] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR>'
>ModemManager[1614]: <debug> [1460018567.950538] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018567.950669] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATV1<CR>'
>ModemManager[1614]: <debug> [1460018567.955764] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018567.955834] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
>ModemManager[1614]: <debug> [1460018567.966622] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018567.966806] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATX4<CR>'
>ModemManager[1614]: <debug> [1460018567.972009] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018567.972121] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT&C1<CR>'
>ModemManager[1614]: <debug> [1460018567.978519] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018567.978656] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
>ModemManager[1614]: <debug> [1460018567.983889] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018567.983987] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
>ModemManager[1614]: <debug> [1460018567.984046] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
>ModemManager[1614]: <debug> [1460018567.995164] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018567.995302] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018567.995358] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
>ModemManager[1614]: <debug> [1460018568.003717] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+GCAP: +CGSM,+FCLASS,+DS<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.003850] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.003890] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.003921] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+WS46=?<CR>'
>ModemManager[1614]: <debug> [1460018568.014587] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+WS46: (12,22,25)<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.014677] [mm-broadband-modem.c:353] modem_load_current_capabilities_finish(): loaded current capabilities: gsm-umts
>ModemManager[1614]: <debug> [1460018568.014789] [mm-iface-modem.c:4345] interface_initialization_step(): Modem allows up to 1 bearers
>ModemManager[1614]: <debug> [1460018568.014811] [mm-bearer-list.c:270] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
>ModemManager[1614]: <debug> [1460018568.014872] [mm-broadband-modem.c:759] modem_load_manufacturer(): loading manufacturer...
>ModemManager[1614]: <debug> [1460018568.014895] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.014931] [mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018568.014950] [mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
>ModemManager[1614]: <debug> [1460018568.015691] [mm-port-serial.c:1372] _close_internal(): (ttyUSB1) serial port closed
>ModemManager[1614]: <debug> [1460018568.015722] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.015761] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGMI<CR>'
>ModemManager[1614]: <debug> [1460018568.024810] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>huawei<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.024929] [mm-broadband-modem.c:743] modem_load_manufacturer_finish(): loaded manufacturer: huawei
>ModemManager[1614]: <debug> [1460018568.025005] [mm-broadband-modem.c:799] modem_load_model(): loading model...
>ModemManager[1614]: <debug> [1460018568.025047] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.025107] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.025154] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGMM<CR>'
>ModemManager[1614]: <debug> [1460018568.033896] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>E182E<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.034001] [mm-broadband-modem.c:783] modem_load_model_finish(): loaded model: E182E
>ModemManager[1614]: <debug> [1460018568.034052] [mm-broadband-modem.c:839] modem_load_revision(): loading revision...
>ModemManager[1614]: <debug> [1460018568.034074] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.034107] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.034133] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGMR<CR>'
>ModemManager[1614]: <debug> [1460018568.042661] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>11.825.03.00.00<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.042770] [mm-broadband-modem.c:823] modem_load_revision_finish(): loaded revision: 11.825.03.00.00
>ModemManager[1614]: <debug> [1460018568.042819] [mm-broadband-modem.c:900] modem_load_equipment_identifier(): loading equipment identifier...
>ModemManager[1614]: <debug> [1460018568.042844] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.042879] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.042904] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGSN<CR>'
>ModemManager[1614]: <debug> [1460018568.052589] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>359740023613407<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.052714] [mm-broadband-modem.c:882] modem_load_equipment_identifier_finish(): loaded equipment identifier: 359740023613407
>ModemManager[1614]: <debug> [1460018568.052757] [mm-broadband-modem.c:988] modem_load_device_identifier(): loading device identifier...
>ModemManager[1614]: <debug> [1460018568.052782] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.052815] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.052842] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATI<CR>'
>ModemManager[1614]: <debug> [1460018568.058296] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E182E<CR><LF>Revision: 11.825.03.00.00<CR><LF>IMEI: 359740023613407<CR><LF>+GCAP: +CGSM,+FCLASS,+DS<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.058487] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '000012d100001001Manufacturer:huaweiModel:E182ERevision:11.825.03.00.00IMEI:359740023613407+GCAP:+CGSM,+FCLASS,+DS35974002361340711.825.03.00.00E182Ehuawei'
>ModemManager[1614]: <debug> [1460018568.058504] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID 'ad3ffd720160eb80d5078c32f80349a1da4ff351'
>ModemManager[1614]: <debug> [1460018568.058526] [mm-broadband-modem.c:951] modem_load_device_identifier_finish(): loaded device identifier: ad3ffd720160eb80d5078c32f80349a1da4ff351
>ModemManager[1614]: <debug> [1460018568.058612] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.058653] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.058692] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSCFGEX=?<CR>'
>ModemManager[1614]: <debug> [1460018568.073827] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>COMMAND NOT SUPPORT<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.073905] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>ModemManager[1614]: Error while checking ^SYSCFGEX format: Unknown error
>ModemManager[1614]: <debug> [1460018568.073971] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.073999] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.074030] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSCFG=?<CR>'
>ModemManager[1614]: <debug> [1460018568.087705] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSCFG:(2,13,14,16),(0-3),((2000004E80380,"All Bands"),(2000000400380,"GSM900/GSM1800/WCDMA900/WCDMA2100"),(4A80000,"GSM850/GSM1900/WCDMA850/WCDMA1900")),(0-2),(0-4)<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.088023] [mm-broadband-modem.c:1675] modem_load_supported_ip_families(): loading supported IP families...
>ModemManager[1614]: <debug> [1460018568.088142] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.088196] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.088232] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGDCONT=?<CR>'
>ModemManager[1614]: <debug> [1460018568.102332] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CGDCONT: (1-16),"IP",,,(0-2),(0-3)<CR><LF>+CGDCONT: (1-16),"PPP",,,(0-2),(0-3)<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.102519] [mm-modem-helpers.c:792] mm_3gpp_parse_cgdcont_test_response(): Unhandled PDP type in CGDCONT=? reply: 'PPP'
>ModemManager[1614]: <debug> [1460018568.102614] [huawei/mm-broadband-modem-huawei.c:2931] enable_disable_unsolicited_rfswitch_event_handler(): Disable ^RFSWITCH unsolicited event handler
>ModemManager[1614]: <debug> [1460018568.102649] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.102677] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.102706] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^RFSWITCH?<CR>'
>ModemManager[1614]: <debug> [1460018568.116893] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>COMMAND NOT SUPPORT<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.117001] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>ModemManager[1614]: <debug> [1460018568.117028] [huawei/mm-broadband-modem-huawei.c:2931] enable_disable_unsolicited_rfswitch_event_handler(): Enable ^RFSWITCH unsolicited event handler
>ModemManager[1614]: <debug> [1460018568.117042] [huawei/mm-broadband-modem-huawei.c:2999] huawei_rfswitch_check_ready(): The device does not support ^RFSWITCH
>ModemManager[1614]: <debug> [1460018568.117060] [mm-broadband-modem.c:3132] load_power_state(): loading power state...
>ModemManager[1614]: <debug> [1460018568.117076] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.117095] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.117115] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CFUN?<CR>'
>ModemManager[1614]: <debug> [1460018568.126975] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CFUN: 1<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.127171] [mm-broadband-modem.c:1290] modem_load_unlock_required(): checking if unlock required...
>ModemManager[1614]: <debug> [1460018568.127211] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018568.127250] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018568.127285] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CPIN?<CR>'
>ModemManager[1614]: <debug> [1460018568.136854] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.136978] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018568.137012] [huawei/mm-broadband-modem-huawei.c:676] load_unlock_retries(): loading unlock retries (huawei)...
>ModemManager[1614]: <debug> [1460018568.137043] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018568.137081] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^CPIN?<CR>'
>ModemManager[1614]: <debug> [1460018568.146973] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^CPIN: READY,,10,3,10,3<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018568.147225] [mm-iface-modem.c:3101] update_lock_info_context_step(): SIM is ready, running after SIM unlock step...
>ModemManager[1614]: <debug> [1460018568.147279] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018570.935484] [huawei/mm-sim-huawei.c:118] load_sim_identifier(): loading (Huawei) SIM identifier...
>ModemManager[1614]: <debug> [1460018570.935545] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018570.935588] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^ICCID?<CR>'
>ModemManager[1614]: <debug> [1460018570.946704] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^ICCID: "98070161243612203025"<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018570.946842] [huawei/mm-sim-huawei.c:50] load_sim_identifier_finish(): loaded SIM identifier: 89701016426321020352
>ModemManager[1614]: <debug> [1460018570.946896] [mm-base-sim.c:1083] load_imsi(): loading IMSI...
>ModemManager[1614]: <debug> [1460018570.946926] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018570.946962] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018570.946996] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIMI<CR>'
>ModemManager[1614]: <debug> [1460018570.956160] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>250012632102035<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018570.956257] [mm-base-sim.c:1072] load_imsi_finish(): loaded IMSI: 250012632102035
>ModemManager[1614]: <debug> [1460018570.956295] [mm-base-sim.c:1219] load_operator_identifier(): loading Operator ID...
>ModemManager[1614]: <debug> [1460018570.956315] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018570.956336] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018570.956356] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CRSM=176,28589,0,0,4<CR>'
>ModemManager[1614]: <debug> [1460018571.048352] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CRSM: 144,0,"00000102"<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.048503] [mm-base-sim.c:1330] load_operator_name(): loading Operator Name...
>ModemManager[1614]: <debug> [1460018571.048535] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.048568] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.048594] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CRSM=176,28486,0,0,17<CR>'
>ModemManager[1614]: <debug> [1460018571.125726] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CRSM: 144,0,"004D545320525553FFFFFFFFFFFFFFFFFF"<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.125887] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.125986] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB1) opening serial port...
>ModemManager[1614]: <debug> [1460018571.126334] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018571.126354] [mm-broadband-modem.c:1168] modem_load_own_numbers(): loading own numbers...
>ModemManager[1614]: <debug> [1460018571.126376] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.126427] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CNUM<CR>'
>ModemManager[1614]: <debug> [1460018571.135477] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.135610] [huawei/mm-broadband-modem-huawei.c:1277] load_current_modes(): loading current modes (huawei)...
>ModemManager[1614]: <debug> [1460018571.135651] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.135686] [mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018571.135703] [mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
>ModemManager[1614]: <debug> [1460018571.136186] [mm-port-serial.c:1372] _close_internal(): (ttyUSB1) serial port closed
>ModemManager[1614]: <debug> [1460018571.136216] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.136247] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSCFG?<CR>'
>ModemManager[1614]: <debug> [1460018571.149365] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSCFG:2,2,2000004E80380,0,2<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.149544] [huawei/mm-broadband-modem-huawei.c:853] load_current_bands(): loading current bands (huawei)...
>ModemManager[1614]: <debug> [1460018571.149570] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.149604] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.149634] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSCFG?<CR>'
>ModemManager[1614]: <debug> [1460018571.162421] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSCFG:2,2,2000004E80380,0,2<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.162637] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.162916] [mm-broadband-modem.c:3235] modem_3gpp_load_imei(): loading IMEI...
>ModemManager[1614]: <debug> [1460018571.162948] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.162992] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGSN<CR>'
>ModemManager[1614]: <debug> [1460018571.172156] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>359740023613407<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.172246] [mm-broadband-modem.c:3226] modem_3gpp_load_imei_finish(): loaded IMEI: 359740023613407
>ModemManager[1614]: <debug> [1460018571.172290] [mm-broadband-modem.c:3394] modem_3gpp_load_enabled_facility_locks(): loading enabled facility locks...
>ModemManager[1614]: <debug> [1460018571.172316] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.172343] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.172374] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK=?<CR>'
>ModemManager[1614]: <debug> [1460018571.183370] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: ("AB","AC","AG","AI","AO","IR","OI","OX","SC","FD","PN","PU","PP","PC","PF")<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.183555] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.183593] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.183626] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK="SC",2<CR>'
>ModemManager[1614]: <debug> [1460018571.200152] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.200281] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.200318] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.200346] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK="FD",2<CR>'
>ModemManager[1614]: <debug> [1460018571.216827] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.216966] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.216994] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.217018] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK="PF",2<CR>'
>ModemManager[1614]: <debug> [1460018571.235720] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.235853] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.235889] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.235922] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK="PN",2<CR>'
>ModemManager[1614]: <debug> [1460018571.254229] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.254378] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.254449] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.254503] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK="PU",2<CR>'
>ModemManager[1614]: <debug> [1460018571.272948] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.273107] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.273146] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.273179] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK="PP",2<CR>'
>ModemManager[1614]: <debug> [1460018571.291493] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.291630] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.291663] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.291689] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CLCK="PC",2<CR>'
>ModemManager[1614]: <debug> [1460018571.309984] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.310194] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.310478] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.310533] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CUSD=?<CR>'
>ModemManager[1614]: <debug> [1460018571.321115] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CUSD: (0-2)<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.321267] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.321628] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.321678] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CNMI=?<CR>'
>ModemManager[1614]: <debug> [1460018571.332232] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CNMI: (0,1,2),(0,1,2,3),(0,2),(0,2),(0,1)<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.332360] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.332404] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.332437] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CPMS=?<CR>'
>ModemManager[1614]: <debug> [1460018571.343224] [mm-port-serial-at.c:440] 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[1614]: <debug> [1460018571.343443] [mm-iface-modem-messaging.c:1148] load_supported_storages_ready(): Supported storages loaded:
>ModemManager[1614]: <debug> [1460018571.343486] [mm-iface-modem-messaging.c:1149] load_supported_storages_ready():   mem1 (list/read/delete) storages: 'me, mt, sm, sr'
>ModemManager[1614]: <debug> [1460018571.343500] [mm-iface-modem-messaging.c:1150] load_supported_storages_ready():   mem2 (write/send) storages:       'me, mt, sm, sr'
>ModemManager[1614]: <debug> [1460018571.343510] [mm-iface-modem-messaging.c:1151] load_supported_storages_ready():   mem3 (reception) storages:        'me, mt, sm, sr'
>ModemManager[1614]: <debug> [1460018571.343619] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.343751] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.343804] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^NTCT?<CR>'
>ModemManager[1614]: <debug> [1460018571.353327] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>COMMAND NOT SUPPORT<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.353400] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>ModemManager[1614]: <debug> [1460018571.353460] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^TIME<CR>'
>ModemManager[1614]: <debug> [1460018571.361950] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>COMMAND NOT SUPPORT<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.362039] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>ModemManager[1614]: <debug> [1460018571.362093] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.362127] [mm-broadband-modem.c:9228] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
>ModemManager[1614]: <debug> [1460018571.362329] [mm-broadband-modem.c:9229] iface_modem_signal_initialize_ready(): Couldn't initialize interface: 'Extended Signal information not supported'
>ModemManager[1614]: <debug> [1460018571.362532] [mm-broadband-modem.c:9230] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
>ModemManager[1614]: <debug> [1460018571.362640] [mm-broadband-modem.c:9231] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
>ModemManager[1614]: <info>  [1460018571.362774] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem: state changed (unknown -> disabled)
>ModemManager[1614]: <debug> [1460018571.362911] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018571.362939] [mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
>ModemManager[1614]: <debug> [1460018571.363448] [mm-port-serial.c:1372] _close_internal(): (ttyUSB2) serial port closed
>ModemManager[1614]: <debug> [1460018571.363489] [mm-base-modem.c:939] initialize_ready(): modem properly initialized
>ModemManager[1614]: <debug> [1460018571.364061] [mm-device.c:447] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1' at path '/org/freedesktop/ModemManager1/Modem/0'
>ModemManager[1614]: <debug> [1460018571.364077] [mm-device.c:457] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Huawei' modem, VID 0x12D1 PID 0x1001 (usb)
>ModemManager[1614]: <info>  [1460018571.369832] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
>ModemManager[1614]: <debug> [1460018571.370050] [mm-broadband-modem.c:8163] enabling_started(): Skipping modem initialization: device hotplugged
>ModemManager[1614]: <debug> [1460018571.370065] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB2) opening serial port...
>ModemManager[1614]: <warn>  [1460018571.370342] [mm-port-serial.c:515] real_config_fd(): (ttyUSB2): port attributes not fully set
>ModemManager[1614]: <debug> [1460018571.370384] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018571.370408] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyUSB2): running init sequence...
>ModemManager[1614]: <debug> [1460018571.370441] [mm-port-serial.c:1112] mm_port_serial_open(): (ttyUSB1) opening serial port...
>ModemManager[1614]: <debug> [1460018571.370731] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>ModemManager[1614]: <debug> [1460018571.370752] [mm-broadband-modem.c:8179] enabling_started(): Flashing primary AT port before enabling...
>ModemManager[1614]: <debug> [1460018571.370777] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATE0<CR>'
>ModemManager[1614]: <debug> [1460018571.378280] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.378394] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATV1<CR>'
>ModemManager[1614]: <debug> [1460018571.383430] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.383494] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMEE=1<CR>'
>ModemManager[1614]: <debug> [1460018571.395102] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.395178] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'ATX4<CR>'
>ModemManager[1614]: <debug> [1460018571.400196] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.400309] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT&C1<CR>'
>ModemManager[1614]: <debug> [1460018571.406588] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.471021] [mm-broadband-modem.c:3132] load_power_state(): loading power state...
>ModemManager[1614]: <debug> [1460018571.471282] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.471413] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CFUN?<CR>'
>ModemManager[1614]: <debug> [1460018571.481099] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CFUN: 1<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.481205] [mm-iface-modem.c:3293] set_power_state(): No need to change power state: already in 'on' power state
>ModemManager[1614]: <debug> [1460018571.481237] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.481278] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.481330] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.481359] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+IFC=1,1<CR>'
>ModemManager[1614]: <debug> [1460018571.492981] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.493182] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.493244] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CSCS=?<CR>'
>ModemManager[1614]: <debug> [1460018571.503781] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CSCS: ("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.503982] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.504023] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.504055] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CSCS="UCS2"<CR>'
>ModemManager[1614]: <debug> [1460018571.519989] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.520115] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.520172] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.520212] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CSCS?<CR>'
>ModemManager[1614]: <debug> [1460018571.529688] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.529872] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.529927] [mm-broadband-modem.c:8808] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
>ModemManager[1614]: <debug> [1460018571.529975] [mm-broadband-modem.c:2594] modem_3gpp_setup_unsolicited_events(): Checking indicator support...
>ModemManager[1614]: <debug> [1460018571.530009] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.530058] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND=?<CR>'
>ModemManager[1614]: <debug> [1460018571.540685] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: ("battchg",(0-5)),("signal",(0-5)),("service",(0-1)),("call",(0-1)),("roam",(0-1)),("smsfull",(0-1)),("GPRS coverage",(0-1)),("callsetup",(0-3))<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.540972] [mm-broadband-modem.c:2547] cind_format_check_ready(): Modem supports signal quality indications via CIND at index '2'(min: 0, max: 5)
>ModemManager[1614]: <debug> [1460018571.541021] [mm-broadband-modem.c:2556] cind_format_check_ready(): Modem supports roaming indications via CIND at index '5'
>ModemManager[1614]: <debug> [1460018571.541036] [mm-broadband-modem.c:2565] cind_format_check_ready(): Modem supports service indications via CIND at index '3'
>ModemManager[1614]: <debug> [1460018571.541072] [mm-broadband-modem.c:2498] set_unsolicited_events_handlers(): (ttyUSB2) Setting 3GPP unsolicited events handlers
>ModemManager[1614]: <debug> [1460018571.541158] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.541212] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.541252] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMER=3,0,0,1<CR>'
>ModemManager[1614]: <debug> [1460018571.558380] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.558493] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.558538] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.558567] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^PORTSEL=0<CR>'
>ModemManager[1614]: <debug> [1460018571.572356] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.572591] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^CURC=1<CR>'
>ModemManager[1614]: <debug> [1460018571.583353] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.583575] [mm-broadband-modem.c:3594] modem_3gpp_setup_unsolicited_registration_events(): (ttyUSB2) setting up 3GPP unsolicited registration messages handlers
>ModemManager[1614]: <debug> [1460018571.583606] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.583650] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.583679] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CREG=2<CR>'
>ModemManager[1614]: <debug> [1460018571.594190] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.594324] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.594372] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.594404] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGREG=2<CR>'
>ModemManager[1614]: <debug> [1460018571.606219] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.606443] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.606540] [mm-broadband-modem.c:8821] enabling_step(): Modem has 3GPP/USSD capabilities, enabling the Modem 3GPP/USSD interface...
>ModemManager[1614]: <debug> [1460018571.606647] [mm-broadband-modem.c:4908] set_unsolicited_result_code_handlers(): (ttyUSB2) Setting unsolicited result code handlers
>ModemManager[1614]: <debug> [1460018571.606732] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.606806] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CUSD=1<CR>'
>ModemManager[1614]: <debug> [1460018571.617300] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.617420] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.617567] [mm-broadband-modem.c:8849] enabling_step(): Modem has location capabilities, enabling the Location interface...
>ModemManager[1614]: <debug> [1460018571.618058] [mm-iface-modem-location.c:759] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
>ModemManager[1614]: <debug> [1460018571.618183] [mm-iface-modem-3gpp.c:761] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
>ModemManager[1614]: <debug> [1460018571.618364] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.620092] [mm-broadband-modem.c:8862] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
>ModemManager[1614]: <debug> [1460018571.620194] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.620247] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CREG?<CR>'
>ModemManager[1614]: <debug> [1460018571.629783] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CREG: 2,1, 19D9, 502<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <info>  [1460018571.630003] [mm-iface-modem-3gpp.c:1171] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
>ModemManager[1614]: <debug> [1460018571.630080] [mm-broadband-modem.c:3430] modem_3gpp_load_operator_code(): loading Operator Code...
>ModemManager[1614]: <debug> [1460018571.630138] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
>ModemManager[1614]: <debug> [1460018571.630247] [mm-iface-modem-location.c:295] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '19D9', Cell ID: '502')
>ModemManager[1614]: <debug> [1460018571.630397] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
>ModemManager[1614]: <debug> [1460018571.630460] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
>ModemManager[1614]: <debug> [1460018571.630517] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMGF=?<CR>'
>ModemManager[1614]: <debug> [1460018571.641008] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CMGF: (0-1)<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.641171] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
>ModemManager[1614]: <debug> [1460018571.641206] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
>ModemManager[1614]: <debug> [1460018571.641270] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+COPS=3,2;+COPS?<CR>'
>ModemManager[1614]: <debug> [1460018571.662008] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+COPS: 1,2,"25001",0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.662138] [mm-broadband-modem.c:3420] modem_3gpp_load_operator_code_finish(): loaded Operator Code: 25001
>ModemManager[1614]: <debug> [1460018571.662206] [mm-iface-modem-location.c:295] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '250', MNC: '1', Location area code: '19D9', Cell ID: '502')
>ModemManager[1614]: <debug> [1460018571.662228] [huawei/mm-broadband-modem-huawei.c:2040] modem_3gpp_load_operator_name(): loading Operator Name (huawei)...
>ModemManager[1614]: <debug> [1460018571.662247] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 5 (open)
>ModemManager[1614]: <debug> [1460018571.662277] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 4 (close)
>ModemManager[1614]: <debug> [1460018571.662402] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGREG?<CR>'
>ModemManager[1614]: <debug> [1460018571.672924] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CGREG: 2,1, 19D9, 502<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.673062] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
>ModemManager[1614]: <debug> [1460018571.673102] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMGF=0<CR>'
>ModemManager[1614]: <debug> [1460018571.683710] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.683792] [mm-broadband-modem.c:5485] cmgf_set_ready(): Successfully set preferred SMS mode: 'PDU'
>ModemManager[1614]: <debug> [1460018571.683872] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
>ModemManager[1614]: <debug> [1460018571.683900] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
>ModemManager[1614]: <debug> [1460018571.684041] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+COPS=3,0;+COPS?<CR>'
>ModemManager[1614]: <debug> [1460018571.731168] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+COPS: 1,0,"MTS RUS",0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.731298] [huawei/mm-broadband-modem-huawei.c:2030] modem_3gpp_load_operator_name_finish(): loaded Operator Name: MTS RUS
>ModemManager[1614]: <debug> [1460018571.731364] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <info>  [1460018571.731542] [mm-iface-modem-3gpp.c:1096] update_registration_reload_current_registration_info_ready(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
>ModemManager[1614]: <debug> [1460018571.731608] [mm-iface-modem.c:1600] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
>ModemManager[1614]: <debug> [1460018571.731722] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CPMS="","MT","MT"<CR>'
>ModemManager[1614]: <debug> [1460018571.758616] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 1,5,0,0,0,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.758816] [mm-broadband-modem.c:6257] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'me'
>ModemManager[1614]: <debug> [1460018571.758877] [mm-broadband-modem.c:5379] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (ME), mem2 (none)...
>ModemManager[1614]: <debug> [1460018571.758912] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.758968] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.758997] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CPMS="ME"<CR>'
>ModemManager[1614]: <debug> [1460018571.773568] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 0,0,0,0,0,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.773664] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.773729] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.773779] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMGL=4<CR>'
>ModemManager[1614]: <debug> [1460018571.785159] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.785350] [mm-broadband-modem.c:6257] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'sm'
>ModemManager[1614]: <debug> [1460018571.785388] [mm-broadband-modem.c:5379] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SM), mem2 (none)...
>ModemManager[1614]: <debug> [1460018571.785425] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.785465] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.785499] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CPMS="SM"<CR>'
>ModemManager[1614]: <debug> [1460018571.800056] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 1,5,0,0,0,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.800137] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.800165] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.800183] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMGL=4<CR>'
>ModemManager[1614]: <debug> [1460018571.860296] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CMGL: 0,1,,30<CR><LF>07919720780110F0040B919735003073F90000614070318271020CCD37B9DC06D1CB733AE806<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.860451] [mm-sms-part-3gpp.c:368] mm_sms_part_3gpp_new_from_binary_pdu(): Parsing PDU (0)...
>ModemManager[1614]: <debug> [1460018571.860473] [mm-sms-part-3gpp.c:397] mm_sms_part_3gpp_new_from_binary_pdu():   SMSC address parsed: '+79028710010'
>ModemManager[1614]: <debug> [1460018571.860481] [mm-sms-part-3gpp.c:410] mm_sms_part_3gpp_new_from_binary_pdu():   Deliver type PDU detected
>ModemManager[1614]: <debug> [1460018571.860488] [mm-sms-part-3gpp.c:471] mm_sms_part_3gpp_new_from_binary_pdu():   Number parsed: '+79530003379'
>ModemManager[1614]: <debug> [1460018571.860495] [mm-sms-part-3gpp.c:575] mm_sms_part_3gpp_new_from_binary_pdu():   PID: 0
>ModemManager[1614]: <debug> [1460018571.860501] [mm-sms-part-3gpp.c:586] mm_sms_part_3gpp_new_from_binary_pdu():   user data encoding is GSM7
>ModemManager[1614]: <debug> [1460018571.860508] [mm-sms-part-3gpp.c:614] mm_sms_part_3gpp_new_from_binary_pdu():   user data length: 12 elements
>ModemManager[1614]: <debug> [1460018571.860514] [mm-sms-part-3gpp.c:620] mm_sms_part_3gpp_new_from_binary_pdu():   user data length: 11 bytes
>ModemManager[1614]: <debug> [1460018571.860520] [mm-sms-part-3gpp.c:695] mm_sms_part_3gpp_new_from_binary_pdu(): Decoding SMS text with '12' elements
>ModemManager[1614]: <debug> [1460018571.860526] [mm-sms-part-3gpp.c:244] sms_decode_text(): Converting SMS part text from GSM7 to UTF8...
>ModemManager[1614]: <debug> [1460018571.860542] [mm-sms-part-3gpp.c:247] sms_decode_text():    Got UTF-8 text: 'Modem test 7'
>ModemManager[1614]: <debug> [1460018571.860554] [mm-broadband-modem.c:6190] sms_pdu_part_list_ready(): Correctly parsed PDU (0)
>ModemManager[1614]: <debug> [1460018571.860575] [mm-sms-list.c:384] mm_sms_list_take_part(): SMS part at 'sm/0' is from a singlepart SMS
>ModemManager[1614]: <debug> [1460018571.860874] [mm-iface-modem-messaging.c:511] sms_added(): Added received SMS at '/org/freedesktop/ModemManager1/SMS/0'
>ModemManager[1614]: <debug> [1460018571.860989] [mm-broadband-modem.c:6257] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'sr'
>ModemManager[1614]: <debug> [1460018571.861007] [mm-broadband-modem.c:5379] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SR), mem2 (none)...
>ModemManager[1614]: <debug> [1460018571.861027] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.861082] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.861221] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CPMS="SR"<CR>'
>ModemManager[1614]: <debug> [1460018571.875977] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 0,0,0,0,0,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.876202] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.876275] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.876328] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMGL=4<CR>'
>ModemManager[1614]: <debug> [1460018571.887359] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.887499] [mm-broadband-modem.c:5788] set_messaging_unsolicited_events_handlers(): (ttyUSB2) Setting messaging unsolicited events handlers
>ModemManager[1614]: <debug> [1460018571.887529] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.887561] [mm-broadband-modem.c:5961] modem_messaging_enable_unsolicited_events(): (ttyUSB2) Enabling messaging unsolicited events on primary port
>ModemManager[1614]: <debug> [1460018571.887587] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.887621] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CNMI=2,1,2,1,0<CR>'
>ModemManager[1614]: <debug> [1460018571.906928] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CMS ERROR: 303<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.907058] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 303: Operation not supported
>ModemManager[1614]: <debug> [1460018571.907117] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CNMI=2,1,2,2,0<CR>'
>ModemManager[1614]: <debug> [1460018571.929667] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.929774] [mm-broadband-modem.c:5922] modem_messaging_enable_unsolicited_events_primary_ready(): (ttyUSB2) Messaging unsolicited events enabled on primary
>ModemManager[1614]: <debug> [1460018571.929809] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <info>  [1460018571.929856] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
>ModemManager[1614]: <debug> [1460018571.930113] [mm-iface-modem.c:1355] periodic_signal_quality_check_enable(): Periodic signal quality checks enabled (interval = 3s)
>ModemManager[1614]: <debug> [1460018571.930167] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018571.930214] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018571.930258] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018571.930306] [mm-iface-modem.c:1075] periodic_access_technologies_check_enable(): Periodic access technology checks enabled
>ModemManager[1614]: <debug> [1460018571.930347] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018571.930385] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018571.930531] [mm-iface-modem-3gpp.c:761] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
>ModemManager[1614]: <debug> [1460018571.930581] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
>ModemManager[1614]: <debug> [1460018571.930626] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018571.937168] [mm-iface-modem-location.c:857] handle_setup_auth_ready(): Enabling location signaling
>ModemManager[1614]: <debug> [1460018571.937325] [mm-iface-modem-location.c:875] handle_setup_auth_ready(): Setting up location sources: '3gpp-lac-ci'
>ModemManager[1614]: <debug> [1460018571.937349] [mm-iface-modem-location.c:727] setup_gathering(): Location '3gpp-lac-ci' gathering is already enabled...
>ModemManager[1614]: <debug> [1460018571.941881] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,5,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.941998] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
>ModemManager[1614]: <debug> [1460018571.942061] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (100)
>ModemManager[1614]: <debug> [1460018571.942075] [mm-iface-modem.c:1274] signal_quality_check_ready(): Periodic signal quality checks rescheduled (interval = 30s)
>ModemManager[1614]: <debug> [1460018571.942223] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFOEX<CR>'
>ModemManager[1614]: <debug> [1460018571.957848] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>COMMAND NOT SUPPORT<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.957993] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>ModemManager[1614]: <debug> [1460018571.958055] [huawei/mm-broadband-modem-huawei.c:273] run_sysinfoex_ready(): ^SYSINFOEX failed: Unknown error, assuming unsupported
>ModemManager[1614]: <debug> [1460018571.958122] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
>ModemManager[1614]: <debug> [1460018571.958175] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
>ModemManager[1614]: <debug> [1460018571.958236] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CREG?<CR>'
>ModemManager[1614]: <debug> [1460018571.967645] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CREG: 2,1, 19D9, 502<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.968046] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 4 (open)
>ModemManager[1614]: <debug> [1460018571.968193] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 3 (close)
>ModemManager[1614]: <debug> [1460018571.968281] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018571.979897] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,3,1,,3<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.980017] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'edge'
>ModemManager[1614]: <debug> [1460018571.980060] [mm-iface-modem.c:933] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> edge)
>ModemManager[1614]: <debug> [1460018571.980077] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018571.980176] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGREG?<CR>'
>ModemManager[1614]: <debug> [1460018571.991835] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CGREG: 2,1, 19D9, 502<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018571.991972] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018571.992007] [mm-broadband-modem.c:8201] modem_3gpp_run_registration_checks_ready(): Initial 3GPP registration checks finished
>ModemManager[1614]: <debug> [1460018572.748199] [mm-broadband-modem.c:5379] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SM), mem2 (none)...
>ModemManager[1614]: <debug> [1460018572.748246] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018572.748301] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CPMS="SM"<CR>'
>ModemManager[1614]: <debug> [1460018572.763313] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CPMS: 1,5,0,0,0,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018572.763494] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018572.763552] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018572.763595] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMGD=0<CR>'
>ModemManager[1614]: <debug> [1460018572.893364] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018572.893474] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018572.893569] [mm-iface-modem-messaging.c:521] sms_deleted(): Deleted SMS at '/org/freedesktop/ModemManager1/SMS/0'
>ModemManager[1614]: <debug> [1460018586.528179] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF>'
>ModemManager[1614]: <debug> [1460018601.947863] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018601.947951] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018601.948013] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018601.948045] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018601.948074] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018601.948149] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018601.960938] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,3,1,,3<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018601.961060] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'edge'
>ModemManager[1614]: <debug> [1460018601.961089] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018601.961140] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018601.971301] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,5,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018601.971487] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018601.971577] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (100)
>ModemManager[1614]: <debug> [1460018616.541845] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF>'
>ModemManager[1614]: <debug> [1460018618.925602] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CREG: 1, 19D9, 8B90508<CR><LF><CR><LF>+CGREG: 1, 19D9, 8B90508<CR><LF>'
>ModemManager[1614]: <debug> [1460018618.925805] [mm-iface-modem-location.c:295] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '250', MNC: '1', Location area code: '19D9', Cell ID: '8B90508')
>ModemManager[1614]: <debug> [1460018618.926536] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^MODE:5,4<CR><LF>'
>ModemManager[1614]: <debug> [1460018618.926729] [huawei/mm-broadband-modem-huawei.c:1635] huawei_mode_changed(): Access Technology: 'umts'
>ModemManager[1614]: <debug> [1460018618.926895] [mm-iface-modem.c:933] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (edge -> umts)
>ModemManager[1614]: <debug> [1460018620.890574] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^RSSI:16<CR><LF>'
>ModemManager[1614]: <debug> [1460018620.890671] [huawei/mm-broadband-modem-huawei.c:1545] huawei_signal_changed(): 3GPP signal quality: 51
>ModemManager[1614]: <debug> [1460018620.890813] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (51)
>ModemManager[1614]: <debug> [1460018620.890870] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^CSNR:-84,-8<CR><LF>'
>ModemManager[1614]: <debug> [1460018627.723011] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SMMEMFULL:"ME"<CR><LF>'
>ModemManager[1614]: <debug> [1460018631.936632] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018631.936780] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018631.936911] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018631.936960] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018631.937004] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018631.937091] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018631.949754] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018631.950003] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'umts'
>ModemManager[1614]: <debug> [1460018631.950064] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018631.950118] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018631.960185] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018631.960321] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018631.960408] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
>ModemManager[1614]: <debug> [1460018632.894924] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^RSSI:16<CR><LF><CR><LF>^CSNR:-80,-13<CR><LF>'
>ModemManager[1614]: <debug> [1460018632.895020] [huawei/mm-broadband-modem-huawei.c:1545] huawei_signal_changed(): 3GPP signal quality: 51
>ModemManager[1614]: <debug> [1460018632.895146] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (51)
>ModemManager[1614]: <debug> [1460018646.553759] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF>'
>ModemManager[1614]: <debug> [1460018661.947399] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018661.947514] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018661.947577] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018661.947613] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018661.947659] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018661.947711] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018661.960791] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018661.961104] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'umts'
>ModemManager[1614]: <debug> [1460018661.961181] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018661.961323] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018661.971982] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018661.972180] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018661.972316] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
>ModemManager[1614]: <debug> [1460018669.483924] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CREG: 1, 19D9, 8B97A38<CR><LF><CR><LF>+CGREG: 1, 19D9, 8B97A38<CR><LF>'
>ModemManager[1614]: <debug> [1460018669.484032] [mm-iface-modem-location.c:295] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '250', MNC: '1', Location area code: '19D9', Cell ID: '8B97A38')
>ModemManager[1614]: <debug> [1460018671.906453] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^RSSI:16<CR><LF>'
>ModemManager[1614]: <debug> [1460018671.906658] [huawei/mm-broadband-modem-huawei.c:1545] huawei_signal_changed(): 3GPP signal quality: 51
>ModemManager[1614]: <debug> [1460018671.906822] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (51)
>ModemManager[1614]: <debug> [1460018671.906935] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^CSNR:-87,-10<CR><LF>'
>ModemManager[1614]: <debug> [1460018676.563368] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF>'
>ModemManager[1614]: <debug> [1460018683.909457] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^RSSI:13<CR><LF>'
>ModemManager[1614]: <debug> [1460018683.909627] [huawei/mm-broadband-modem-huawei.c:1545] huawei_signal_changed(): 3GPP signal quality: 41
>ModemManager[1614]: <debug> [1460018683.909845] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (41)
>ModemManager[1614]: <debug> [1460018683.910260] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^CSNR:-86,-10<CR><LF>'
>ModemManager[1614]: <debug> [1460018691.940516] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018691.940687] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018691.940776] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018691.940837] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018691.940880] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018691.941011] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018691.954067] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018691.954350] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'umts'
>ModemManager[1614]: <debug> [1460018691.954415] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018691.954531] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018691.964862] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,2,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018691.965102] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018691.965257] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (40)
>ModemManager[1614]: <debug> [1460018692.911481] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^RSSI:13<CR><LF>'
>ModemManager[1614]: <debug> [1460018692.911656] [huawei/mm-broadband-modem-huawei.c:1545] huawei_signal_changed(): 3GPP signal quality: 41
>ModemManager[1614]: <debug> [1460018692.911828] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (41)
>ModemManager[1614]: <debug> [1460018692.911932] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^CSNR:-88,-14<CR><LF>'
>ModemManager[1614]: <debug> [1460018706.571249] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF>'
>ModemManager[1614]: <debug> [1460018721.947857] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018721.947994] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018721.948235] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018721.948288] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018721.948332] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018721.948407] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018721.961609] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018721.961895] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'umts'
>ModemManager[1614]: <debug> [1460018721.961961] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018721.962032] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018721.972269] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,2,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018721.972543] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018721.972705] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (40)
>ModemManager[1614]: <debug> [1460018786.090332] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF><CR><LF>^RSSI:19<CR><LF><CR><LF>^CSNR:-78,-8<CR><LF>'
>ModemManager[1614]: <debug> [1460018786.090481] [huawei/mm-broadband-modem-huawei.c:1545] huawei_signal_changed(): 3GPP signal quality: 61
>ModemManager[1614]: <debug> [1460018786.090607] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (61)
>ModemManager[1614]: <debug> [1460018786.090671] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018786.090717] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018786.090766] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018786.090799] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018786.090833] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018786.091067] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018786.104234] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018786.104856] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'umts'
>ModemManager[1614]: <debug> [1460018786.105186] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018786.105250] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018786.115465] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018786.115688] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018786.115831] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
>ModemManager[1614]: <debug> [1460018788.927850] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^RSSI:15<CR><LF>'
>ModemManager[1614]: <debug> [1460018788.928034] [huawei/mm-broadband-modem-huawei.c:1545] huawei_signal_changed(): 3GPP signal quality: 48
>ModemManager[1614]: <debug> [1460018788.928229] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (48)
>ModemManager[1614]: <debug> [1460018788.928316] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^CSNR:-92,-14<CR><LF>'
>ModemManager[1614]: <debug> [1460018796.589113] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF>'
>ModemManager[1614]: <debug> [1460018815.951835] [huawei/mm-broadband-modem-huawei.c:597] load_access_technologies(): loading access technology (huawei)...
>ModemManager[1614]: <debug> [1460018815.951975] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018815.952055] [huawei/mm-broadband-modem-huawei.c:2440] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018815.952103] [mm-broadband-modem.c:1991] modem_load_signal_quality(): loading signal quality...
>ModemManager[1614]: <debug> [1460018815.952141] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018815.952207] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^SYSINFO<CR>'
>ModemManager[1614]: <debug> [1460018815.965137] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018815.965378] [huawei/mm-broadband-modem-huawei.c:584] load_access_technologies_finish(): Access Technology: 'umts'
>ModemManager[1614]: <debug> [1460018815.965442] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018815.965508] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CIND?<CR>'
>ModemManager[1614]: <debug> [1460018815.976002] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>+CIND: 5,3,1,0,0,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018815.976288] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018815.976457] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (60)
>ModemManager[1614]: <debug> [1460018826.593581] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:23613407,0,0,0,99<CR><LF>'
>ModemManager[1614]: <info>  [1460018826.792484] [main.c:42] quit_cb(): Caught signal, shutting down...
>ModemManager[1614]: <debug> [1460018826.792578] [mm-base-manager.c:814] set_property(): Stopping connection in object manager server
>ModemManager[1614]: <info>  [1460018826.792718] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling)
>ModemManager[1614]: <debug> [1460018826.792831] [mm-iface-modem.c:1204] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (0)
>ModemManager[1614]: <debug> [1460018826.792851] [mm-iface-modem.c:1321] periodic_signal_quality_check_disable(): Periodic signal quality checks disabled
>ModemManager[1614]: <debug> [1460018826.792880] [mm-iface-modem.c:933] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (umts -> unknown)
>ModemManager[1614]: <debug> [1460018826.792893] [mm-iface-modem.c:1047] periodic_access_technologies_check_disable(): Periodic access technology checks disabled
>ModemManager[1614]: <debug> [1460018826.792911] [mm-broadband-modem.c:8498] disabling_step(): Modem has messaging capabilities, disabling the Messaging interface...
>ModemManager[1614]: <debug> [1460018826.792953] [mm-broadband-modem.c:5788] set_messaging_unsolicited_events_handlers(): (ttyUSB2) Removing messaging unsolicited events handlers
>ModemManager[1614]: <debug> [1460018826.793223] [mm-broadband-modem.c:8510] disabling_step(): Modem has location capabilities, disabling the Location interface...
>ModemManager[1614]: <debug> [1460018826.793250] [mm-iface-modem-location.c:765] setup_gathering(): Need to disable the following location sources: '3gpp-lac-ci'
>ModemManager[1614]: <debug> [1460018826.793611] [mm-broadband-modem.c:8538] disabling_step(): Modem has 3GPP/USSD capabilities, disabling the Modem 3GPP/USSD interface...
>ModemManager[1614]: <debug> [1460018826.793634] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018826.793770] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CUSD=0<CR>'
>ModemManager[1614]: <debug> [1460018826.804026] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018826.804111] [mm-broadband-modem.c:4908] set_unsolicited_result_code_handlers(): (ttyUSB2) Removing unsolicited result code handlers
>ModemManager[1614]: <debug> [1460018826.804164] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018826.804465] [mm-broadband-modem.c:8550] disabling_step(): Modem has 3GPP capabilities, disabling the Modem 3GPP interface...
>ModemManager[1614]: <debug> [1460018826.804512] [mm-iface-modem-3gpp.c:1327] periodic_registration_check_disable(): Periodic 3GPP registration checks disabled
>ModemManager[1614]: <debug> [1460018826.804557] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018826.804715] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CREG=0<CR>'
>ModemManager[1614]: <debug> [1460018826.814954] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018826.815047] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018826.815081] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018826.815215] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CGREG=0<CR>'
>ModemManager[1614]: <debug> [1460018826.826570] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018826.826737] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018826.827135] [mm-broadband-modem.c:3648] modem_3gpp_cleanup_unsolicited_registration_events(): (ttyUSB2) cleaning up unsolicited registration messages handlers
>ModemManager[1614]: <debug> [1460018826.827329] [mm-broadband-modem.c:2498] set_unsolicited_events_handlers(): (ttyUSB2) Removing 3GPP unsolicited events handlers
>ModemManager[1614]: <debug> [1460018826.827498] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
>ModemManager[1614]: <debug> [1460018826.827646] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT^CURC=0<CR>'
>ModemManager[1614]: <debug> [1460018826.838021] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <debug> [1460018826.838135] [mm-port-serial.c:1250] mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
>ModemManager[1614]: <debug> [1460018826.838174] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 2 (close)
>ModemManager[1614]: <debug> [1460018826.838319] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): --> 'AT+CMER=0<CR>'
>ModemManager[1614]: <debug> [1460018826.848570] [mm-port-serial-at.c:440] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>ModemManager[1614]: <info>  [1460018826.848648] [mm-iface-modem-3gpp.c:1186] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown)
>ModemManager[1614]: <debug> [1460018826.848762] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 1 (close)
>ModemManager[1614]: <debug> [1460018826.849034] [mm-port-serial.c:1307] _close_internal(): (ttyUSB2) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018826.849057] [mm-port-serial.c:1323] _close_internal(): (ttyUSB2) closing serial port...
>ModemManager[1614]: <debug> [1460018826.849652] [mm-port-serial.c:1372] _close_internal(): (ttyUSB2) serial port closed
>ModemManager[1614]: <debug> [1460018826.849675] [mm-port-serial.c:1307] _close_internal(): (ttyUSB1) device open count is 0 (close)
>ModemManager[1614]: <debug> [1460018826.849690] [mm-port-serial.c:1323] _close_internal(): (ttyUSB1) closing serial port...
>ModemManager[1614]: <debug> [1460018826.850121] [mm-port-serial.c:1372] _close_internal(): (ttyUSB1) serial port closed
>ModemManager[1614]: <info>  [1460018826.850149] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled)
>ModemManager[1614]: <debug> [1460018826.850401] [mm-device.c:393] unexport_modem(): Unexported modem '/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1' from path '/org/freedesktop/ModemManager1/Modem/0'
>ModemManager[1614]: <debug> [1460018826.850622] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB0) forced to close port
>ModemManager[1614]: <debug> [1460018826.850650] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB1) forced to close port
>ModemManager[1614]: <debug> [1460018826.850666] [mm-port-serial.c:1434] port_serial_close_force(): (ttyUSB2) forced to close port
>ModemManager[1614]: <debug> [1460018826.850718] [mm-base-modem.c:1485] finalize(): Modem (Huawei) '/sys/devices/pci0000:00/0000:00:14.0/usb2/2-1' completely disposed
>ModemManager[1614]: <info>  [1460018826.853727] [main.c:187] main(): ModemManager is shut down

Actions: View

Attachments on bug 94855: 122785

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.