EM7345 probing fails when coming back from suspend
Bjørn Mork
bjorn at mork.no
Sun Jun 1 13:45:27 PDT 2014
What is going wrong here? It seems the probing never finishes after
resuming (I'm including more than necessary here - the ttyUSB0 appearing
briefly is a generic Infineon flashloader interface). This is the
complete log after waiting "forever", i.e. more than 5 minutes:
ModemManager[15914]: <debug> [1401651503.146749] [mm-port-serial.c:1415] port_serial_close_force(): (ttyACM0) forced to close port
ModemManager[15914]: <info> [1401651503.151471] [mm-manager.c:375] device_removed(): (usbmisc/cdc-wdm0): released by modem /sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4
ModemManager[15914]: <info> [1401651503.163140] [mm-manager.c:375] device_removed(): (net/wwan0): released by modem /sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4
ModemManager[15914]: <info> [1401651503.166726] [mm-manager.c:375] device_removed(): (tty/ttyACM0): released by modem /sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4
ModemManager[15914]: <debug> [1401651503.166827] [mm-manager.c:380] device_removed(): Removing empty device '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4'
ModemManager[15914]: <debug> [1401651503.167234] [mm-bearer.c:896] mm_bearer_dbus_unexport(): Removing from DBus bearer at '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[15914]: <debug> [1401651503.167294] [mm-device.c:382] unexport_modem(): Unexported modem '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4' from path '/org/freedesktop/ModemManager1/Modem/0'
ModemManager[15914]: <debug> [1401651503.167794] [mm-base-modem.c:1633] finalize(): Modem (Generic) '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4' completely disposed
ModemManager[15914]: <debug> [1401651503.436853] [mm-plugin-manager.c:706] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] Checking device support...
ModemManager[15914]: <debug> [1401651503.437066] [mm-plugin.c:253] apply_pre_probing_filters(): (Option) [ttyUSB0] filtered by drivers
ModemManager[15914]: <debug> [1401651503.437116] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437157] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437196] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyUSB0] filtered by drivers
ModemManager[15914]: <debug> [1401651503.437234] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437273] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437312] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437353] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437394] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437433] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437472] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437509] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437548] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437586] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437624] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437664] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyUSB0] filtered by udev tags
ModemManager[15914]: <debug> [1401651503.437702] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437740] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437780] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyUSB0] filtered by drivers
ModemManager[15914]: <debug> [1401651503.437820] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyUSB0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651503.437859] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB0] filtered by drivers
ModemManager[15914]: <debug> [1401651503.437897] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB0] filtered by udev tags
ModemManager[15914]: <debug> [1401651503.437935] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [ttyUSB0] Found '5' plugins to try...
ModemManager[15914]: <debug> [1401651503.437973] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Iridium'
ModemManager[15914]: <debug> [1401651503.438005] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Via CBP7'
ModemManager[15914]: <debug> [1401651503.438041] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Nokia'
ModemManager[15914]: <debug> [1401651503.438077] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Cinterion'
ModemManager[15914]: <debug> [1401651503.438114] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyUSB0] Will try with plugin 'Generic'
ModemManager[15914]: <debug> [1401651503.438196] [mm-plugin.c:782] mm_plugin_supports_port(): (Iridium) [ttyUSB0] probe required: 'at, at-vendor, at-product'
ModemManager[15914]: <debug> [1401651503.438246] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at, at-vendor, at-product'
ModemManager[15914]: <debug> [1401651503.438439] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
ModemManager[15914]: <warn> [1401651503.438652] [mm-port-serial.c:515] real_config_fd(): (ttyUSB0): port attributes not fully set
ModemManager[15914]: <debug> [1401651503.438749] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
ModemManager[15914]: <debug> [1401651503.539191] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
ModemManager[15914]: <debug> [1401651505.753650] [mm-plugin-manager.c:677] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] Minimum probing time consumed
ModemManager[15914]: <debug> [1401651506.752018] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[15914]: <debug> [1401651506.752246] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
ModemManager[15914]: <debug> [1401651509.752910] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[15914]: <debug> [1401651509.753121] [mm-port-serial-at.c:440] debug_log(): (ttyUSB0): --> 'AT<CR>'
ModemManager[15914]: <debug> [1401651512.753594] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[15914]: <debug> [1401651512.753712] [mm-port-probe.c:161] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is not AT-capable
ModemManager[15914]: <debug> [1401651512.753829] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 0 (close)
ModemManager[15914]: <debug> [1401651512.753896] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB0) closing serial port...
ModemManager[15914]: <debug> [1401651512.754556] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB0) serial port closed
ModemManager[15914]: <debug> [1401651512.754627] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB0) forced to close port
ModemManager[15914]: <debug> [1401651512.754724] [mm-plugin.c:454] apply_post_probing_filters(): (Iridium) [ttyUSB0] filtered as no vendor/product strings given
ModemManager[15914]: <debug> [1401651512.754842] [mm-plugin.c:782] mm_plugin_supports_port(): (Via CBP7) [ttyUSB0] probe required: 'at, at-vendor, at-product'
ModemManager[15914]: <debug> [1401651512.754931] [mm-plugin.c:454] apply_post_probing_filters(): (Via CBP7) [ttyUSB0] filtered as no vendor/product strings given
ModemManager[15914]: <debug> [1401651512.755027] [mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyUSB0] probe required: 'at, at-vendor, at-icera'
ModemManager[15914]: <debug> [1401651512.755108] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyUSB0] filtered by vendor strings
ModemManager[15914]: <debug> [1401651512.755197] [mm-plugin.c:782] mm_plugin_supports_port(): (Cinterion) [ttyUSB0] probe required: 'at, at-vendor'
ModemManager[15914]: <debug> [1401651512.755277] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyUSB0] filtered by vendor strings
ModemManager[15914]: <debug> [1401651512.755364] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [ttyUSB0] probe required: 'at, qcdm'
ModemManager[15914]: <debug> [1401651512.755418] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'qcdm'
ModemManager[15914]: <debug> [1401651512.755503] [mm-port-probe.c:657] serial_probe_qcdm(): (tty/ttyUSB0) probing QCDM...
ModemManager[15914]: <debug> [1401651512.755647] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyUSB0) opening serial port...
ModemManager[15914]: <debug> [1401651512.755946] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
ModemManager[15914]: <debug> [1401651512.756219] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB0): --> 7e 00 78 f0 7e
ModemManager[15914]: <debug> [1401651515.754637] [mm-port-serial-qcdm.c:201] debug_log(): (ttyUSB0): --> 7e 00 78 f0 7e
ModemManager[15914]: <debug> [1401651518.753911] [mm-port-probe.c:257] mm_port_probe_set_result_qcdm(): (tty/ttyUSB0) port is not QCDM-capable
ModemManager[15914]: <debug> [1401651518.754089] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyUSB0) device open count is 0 (close)
ModemManager[15914]: <debug> [1401651518.754196] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyUSB0) closing serial port...
ModemManager[15914]: <debug> [1401651518.755141] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyUSB0) serial port closed
ModemManager[15914]: <debug> [1401651518.755216] [mm-port-serial.c:1415] port_serial_close_force(): (ttyUSB0) forced to close port
ModemManager[15914]: <debug> [1401651518.755319] [mm-plugin-manager.c:448] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyUSB0] found best plugin for port
ModemManager[15914]: <debug> [1401651518.755413] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'ttyUSB0' port probe finished, last one in device
ModemManager[15914]: <debug> [1401651518.755475] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] device support check finished in '15.318523' seconds
ModemManager[15914]: <info> [1401651518.755557] [mm-device.c:509] mm_device_create_modem(): Creating modem with plugin 'Generic' and '1' ports
ModemManager[15914]: <warn> [1401651518.756057] [mm-plugin.c:919] mm_plugin_create_modem(): Could not grab port (tty/ttyUSB0): 'Cannot add port 'tty/ttyUSB0', unhandled serial type'
ModemManager[15914]: <debug> [1401651518.756186] [mm-base-modem.c:1633] finalize(): Modem (Generic) '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4' completely disposed
ModemManager[15914]: <warn> [1401651518.756257] [mm-manager.c:158] find_device_support_ready(): Couldn't create modem for device at '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4': Failed to find primary AT port
ModemManager[15914]: <info> [1401651576.022215] [mm-manager.c:375] device_removed(): (tty/ttyUSB0): released by modem /sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4
ModemManager[15914]: <debug> [1401651576.022322] [mm-manager.c:380] device_removed(): Removing empty device '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4'
ModemManager[15914]: <debug> [1401651576.461831] [mm-plugin-manager.c:706] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] Checking device support...
ModemManager[15914]: <debug> [1401651576.462011] [mm-plugin.c:253] apply_pre_probing_filters(): (Option) [ttyACM1] filtered by drivers
ModemManager[15914]: <debug> [1401651576.462046] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462075] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462104] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyACM1] filtered by drivers
ModemManager[15914]: <debug> [1401651576.462173] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462203] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462231] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462261] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462291] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462319] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.462346] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464138] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464185] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464216] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464244] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464274] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyACM1] filtered by udev tags
ModemManager[15914]: <debug> [1401651576.464302] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464329] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464357] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyACM1] filtered by drivers
ModemManager[15914]: <debug> [1401651576.464387] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyACM1] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.464416] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyACM1] filtered by drivers
ModemManager[15914]: <debug> [1401651576.464443] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyACM1] filtered by udev tags
ModemManager[15914]: <debug> [1401651576.466019] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [ttyACM1] Found '5' plugins to try...
ModemManager[15914]: <debug> [1401651576.466061] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Iridium'
ModemManager[15914]: <debug> [1401651576.466090] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Via CBP7'
ModemManager[15914]: <debug> [1401651576.466117] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Nokia'
ModemManager[15914]: <debug> [1401651576.466173] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Cinterion'
ModemManager[15914]: <debug> [1401651576.466200] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Generic'
ModemManager[15914]: <debug> [1401651576.466245] [mm-plugin.c:782] mm_plugin_supports_port(): (Iridium) [ttyACM1] probe required: 'at, at-vendor, at-product'
ModemManager[15914]: <debug> [1401651576.466282] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyACM1) launching port probing: 'at, at-vendor, at-product'
ModemManager[15914]: <debug> [1401651576.466461] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyACM1) opening serial port...
ModemManager[15914]: <debug> [1401651576.469506] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyACM1) device open count is 1 (open)
ModemManager[15914]: <debug> [1401651576.474318] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474384] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474415] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.474444] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474472] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [cdc-wdm0] filtered by drivers
ModemManager[15914]: <debug> [1401651576.474500] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474528] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474555] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.474582] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474610] [mm-plugin.c:212] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474638] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.474665] [mm-plugin.c:212] apply_pre_probing_filters(): (Samsung) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.476401] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.476449] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.476479] [mm-plugin.c:212] apply_pre_probing_filters(): (Novatel LTE) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.476506] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.476534] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.476561] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.476589] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.476617] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.476643] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.476672] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [cdc-wdm0] filtered by drivers
ModemManager[15914]: <debug> [1401651576.476699] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.478184] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.478228] [mm-plugin.c:212] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.478261] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm0] filtered by udev tags
ModemManager[15914]: <debug> [1401651576.478291] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '1' plugins to try...
ModemManager[15914]: <debug> [1401651576.478318] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin 'Generic'
ModemManager[15914]: <debug> [1401651576.478359] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [cdc-wdm0] probe required: 'mbim'
ModemManager[15914]: <debug> [1401651576.478392] [mm-port-probe.c:1352] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'mbim'
ModemManager[15914]: <debug> [1401651576.478461] [mm-port-probe.c:522] wdm_probe_mbim(): (usbmisc/cdc-wdm0) probing MBIM...
ModemManager[15914]: [/dev/cdc-wdm0] Queried max control message size: 512
ModemManager[15914]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:00:00:00:10:00:00:00:01:00:00:00:00:02:00:00
ModemManager[15914]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 16
<<<<<< type = open (0x00000001)
<<<<<< transaction = 1
<<<<<< Contents:
<<<<<< max_control_transfer = 512
ModemManager[15914]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 01:00:00:80:10:00:00:00:01:00:00:00:00:00:00:00
ModemManager[15914]: <debug> [1401651576.486389] [mm-port-probe.c:300] mm_port_probe_set_result_mbim(): (usbmisc/cdc-wdm0) port is MBIM-capable
ModemManager[15914]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 02:00:00:00:0C:00:00:00:02:00:00:00
ModemManager[15914]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 12
<<<<<< type = close (0x00000002)
<<<<<< transaction = 2
ModemManager[15914]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 02:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
ModemManager[15914]: <debug> [1401651576.492705] [mm-plugin-manager.c:448] plugin_supports_port_ready(): (Plugin Manager) (Generic) [cdc-wdm0] found best plugin for port
ModemManager[15914]: <debug> [1401651576.492784] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm0' port probe finished, still 1 running probes in this device (ttyACM1)
ModemManager[15914]: <debug> [1401651576.497130] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.497195] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.497225] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.497254] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.497281] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wwan0] filtered by drivers
ModemManager[15914]: <debug> [1401651576.497309] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.497336] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.497363] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.497390] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.497418] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.497445] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.497472] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.499201] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.499249] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.499279] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.499306] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.499334] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.499360] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.499388] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.499415] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.499442] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.499469] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wwan0] filtered by drivers
ModemManager[15914]: <debug> [1401651576.499496] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wwan0] filtered by vendor/product IDs
ModemManager[15914]: <debug> [1401651576.500988] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wwan0] filtered by subsystem
ModemManager[15914]: <debug> [1401651576.501033] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wwan0] filtered by drivers
ModemManager[15914]: <debug> [1401651576.501065] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wwan0] filtered by udev tags
ModemManager[15914]: <debug> [1401651576.501095] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [wwan0] Found '1' plugins to try...
ModemManager[15914]: <debug> [1401651576.501122] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin 'Generic'
ModemManager[15914]: <debug> [1401651576.501159] [mm-plugin.c:704] mm_plugin_supports_port(): (Generic) [wwan0] probing deferred until result suggested
ModemManager[15914]: <debug> [1401651576.501232] [mm-plugin-manager.c:536] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support check until result suggested
ModemManager[15914]: <debug> [1401651576.572442] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT<CR>'
ModemManager[15914]: <debug> [1401651576.772681] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT'
ModemManager[15914]: <debug> [1401651576.773737] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15914]: <debug> [1401651576.777780] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15914]: <debug> [1401651576.778801] [mm-port-probe.c:151] mm_port_probe_set_result_at(): (tty/ttyACM1) port is AT-capable
ModemManager[15914]: <debug> [1401651576.779598] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT+CGMI<CR>'
ModemManager[15914]: <debug> [1401651577.480662] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT+CGMI'
ModemManager[15914]: <debug> [1401651577.481765] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15914]: <debug> [1401651577.485044] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>Sierra Wireless Inc.<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[15914]: <debug> [1401651577.485172] [mm-port-probe.c:178] mm_port_probe_set_result_at_vendor(): (tty/ttyACM1) vendor probing finished
ModemManager[15914]: <debug> [1401651577.485270] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT+CGMM<CR>'
ModemManager[15914]: <debug> [1401651578.185632] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT+CGMM'
ModemManager[15914]: <debug> [1401651578.186661] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15914]: <debug> [1401651578.189174] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>Sierra Wireless EM7345 4G LTE<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[15914]: <debug> [1401651578.189509] [mm-port-probe.c:198] mm_port_probe_set_result_at_product(): (tty/ttyACM1) product probing finished
ModemManager[15914]: <debug> [1401651578.189728] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyACM1) device open count is 0 (close)
ModemManager[15914]: <debug> [1401651578.189901] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyACM1) closing serial port...
ModemManager[15914]: <debug> [1401651578.197406] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyACM1) serial port closed
ModemManager[15914]: <debug> [1401651578.197483] [mm-port-serial.c:1415] port_serial_close_force(): (ttyACM1) forced to close port
ModemManager[15914]: <debug> [1401651578.197557] [mm-plugin.c:477] apply_post_probing_filters(): (Iridium) [ttyACM1] filtered by vendor/product strings
ModemManager[15914]: <debug> [1401651578.197645] [mm-plugin.c:782] mm_plugin_supports_port(): (Via CBP7) [ttyACM1] probe required: 'at, at-vendor, at-product'
ModemManager[15914]: <debug> [1401651578.197704] [mm-plugin.c:477] apply_post_probing_filters(): (Via CBP7) [ttyACM1] filtered by vendor/product strings
ModemManager[15914]: <debug> [1401651578.197760] [mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyACM1] probe required: 'at, at-vendor, at-icera'
ModemManager[15914]: <debug> [1401651578.197794] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyACM1) launching port probing: 'at-icera'
ModemManager[15914]: <debug> [1401651578.197960] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyACM1) opening serial port...
ModemManager[15914]: <debug> [1401651578.199661] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyACM1) device open count is 1 (open)
ModemManager[15914]: <debug> [1401651578.302266] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT%IPSYS?<CR>'
ModemManager[15914]: <debug> [1401651578.750402] [mm-plugin-manager.c:677] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] Minimum probing time consumed
ModemManager[15914]: <debug> [1401651579.202792] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT%IPSYS?'
ModemManager[15914]: <debug> [1401651579.203827] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15914]: <debug> [1401651579.206217] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>ERROR<CR><LF>'
ModemManager[15914]: <debug> [1401651579.210644] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[15914]: <debug> [1401651579.211632] [mm-port-probe.c:223] mm_port_probe_set_result_at_icera(): (tty/ttyACM1) Modem is probably not Icera-based
ModemManager[15914]: <debug> [1401651579.212433] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyACM1) device open count is 0 (close)
ModemManager[15914]: <debug> [1401651579.213163] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyACM1) closing serial port...
ModemManager[15914]: <debug> [1401651579.221429] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyACM1) serial port closed
ModemManager[15914]: <debug> [1401651579.221511] [mm-port-serial.c:1415] port_serial_close_force(): (ttyACM1) forced to close port
ModemManager[15914]: <debug> [1401651579.221584] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyACM1] filtered by vendor strings
ModemManager[15914]: <debug> [1401651579.221670] [mm-plugin.c:782] mm_plugin_supports_port(): (Cinterion) [ttyACM1] probe required: 'at, at-vendor'
ModemManager[15914]: <debug> [1401651579.221727] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyACM1] filtered by vendor strings
ModemManager[15914]: <debug> [1401651579.221796] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [ttyACM1] probe required: 'at, qcdm'
ModemManager[15914]: <debug> [1401651579.221856] [mm-plugin-manager.c:448] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyACM1] found best plugin for port
ModemManager[15914]: <debug> [1401651579.221889] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'ttyACM1' port probe finished, still 1 running probes in this device (wwan0)
The kernel log shows nothing suspicious:
Jun 1 21:39:36 nemi kernel: [155322.432749] flashloader ttyUSB0: flashloader converter now disconnected from ttyUSB0
Jun 1 21:39:36 nemi kernel: [155322.432788] usb_serial_simple 3-4:1.0: device disconnected
Jun 1 21:39:36 nemi kernel: [155322.672125] usb 3-4: new high-speed USB device number 50 using ehci-pci
Jun 1 21:39:36 nemi kernel: [155322.816334] usb 3-4: New USB device found, idVendor=1199, idProduct=a001
Jun 1 21:39:36 nemi kernel: [155322.816343] usb 3-4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jun 1 21:39:36 nemi kernel: [155322.816349] usb 3-4: Product: Sierra Wireless EM7345 4G LTE
Jun 1 21:39:36 nemi kernel: [155322.816353] usb 3-4: Manufacturer: Sierra Wireless Inc.
Jun 1 21:39:36 nemi kernel: [155322.816358] usb 3-4: SerialNumber: 013937000536191
Jun 1 21:39:36 nemi kernel: [155322.829592] cdc_mbim 3-4:1.0: driver_info updated to 'CDC MBIM'
Jun 1 21:39:36 nemi kernel: [155322.830453] cdc_mbim 3-4:1.0: dwNtbInMaxSize=15360 dwNtbOutMaxSize=15360 wNdpOutPayloadRemainder=0 wNdpOutDivisor=32 wNdpOutAlignment=4 wNtbOutMaxDatagrams=32 flags=0x4
Jun 1 21:39:36 nemi kernel: [155322.836965] cdc_mbim 3-4:1.0: cdc-wdm0: USB WDM device
Jun 1 21:39:36 nemi kernel: [155322.837772] cdc_mbim 3-4:1.0 wwan0: register 'cdc_mbim' at usb-0000:00:1d.7-4, CDC MBIM, 46:24:7e:1e:48:55
Jun 1 21:39:36 nemi kernel: [155322.839646] cdc_acm 3-4:1.2: This device cannot do calls on its own. It is not a modem.
Jun 1 21:39:36 nemi kernel: [155322.839807] cdc_acm 3-4:1.2: ttyACM1: USB ACM device
Jun 1 21:39:36 nemi kernel: [155322.900741] cdc_mbim 3-4:1.0: cdc_mbim_manage_power() pmcount=0, on=1
Jun 1 21:39:36 nemi kernel: [155322.914416] cdc_mbim 3-4:1.0: cdc_mbim_manage_power() pmcount=1, on=0
And if I kill and restart MM, then it probes the modem just fine:
nemi:/home/bjorn# ModemManager --debug
ModemManager[15482]: <info> [1401655232.248637] [main.c:140] main(): ModemManager (version 1.3.0) starting in system bus...
ModemManager[15482]: <debug> [1401655232.254427] [main.c:65] bus_acquired_cb(): Bus acquired, creating manager...
ModemManager[15482]: <debug> [1401655232.258592] [mm-plugin-manager.c:819] load_plugins(): Looking for plugins in '/usr/lib/ModemManager'
ModemManager[15482]: <debug> [1401655232.259318] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Iridium'
ModemManager[15482]: <debug> [1401655232.259638] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Option'
ModemManager[15482]: <debug> [1401655232.259937] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'AnyDATA'
ModemManager[15482]: <debug> [1401655232.260218] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Generic'
ModemManager[15482]: <debug> [1401655232.260518] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Longcheer'
ModemManager[15482]: <debug> [1401655232.260808] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Gobi'
ModemManager[15482]: <debug> [1401655232.261111] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Nokia (Icera)'
ModemManager[15482]: <debug> [1401655232.261398] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Motorola'
ModemManager[15482]: <debug> [1401655232.261694] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'X22X'
ModemManager[15482]: <debug> [1401655232.261994] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Via CBP7'
ModemManager[15482]: <debug> [1401655232.262285] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Altair LTE'
ModemManager[15482]: <debug> [1401655232.262588] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Nokia'
ModemManager[15482]: <debug> [1401655232.262889] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Samsung'
ModemManager[15482]: <debug> [1401655232.263258] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Wavecom'
ModemManager[15482]: <debug> [1401655232.263557] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'SimTech'
ModemManager[15482]: <debug> [1401655232.263863] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Novatel LTE'
ModemManager[15482]: <debug> [1401655232.264419] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Telit'
ModemManager[15482]: <debug> [1401655232.264856] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'ZTE'
ModemManager[15482]: <debug> [1401655232.265276] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Pantech'
ModemManager[15482]: <debug> [1401655232.265698] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'MTK'
ModemManager[15482]: <debug> [1401655232.266140] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Huawei'
ModemManager[15482]: <debug> [1401655232.266558] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Novatel'
ModemManager[15482]: <debug> [1401655232.267076] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Sierra'
ModemManager[15482]: <debug> [1401655232.267524] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Cinterion'
ModemManager[15482]: <debug> [1401655232.267944] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Linktop'
ModemManager[15482]: <debug> [1401655232.268380] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Option High-Speed'
ModemManager[15482]: <debug> [1401655232.268808] [mm-plugin-manager.c:844] load_plugins(): Loaded plugin 'Ericsson MBM'
ModemManager[15482]: <debug> [1401655232.268981] [mm-plugin-manager.c:869] load_plugins(): Successfully loaded 27 plugins
ModemManager[15482]: <debug> [1401655232.270880] [main.c:87] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
ModemManager[15482]: <debug> [1401655232.271153] [mm-manager.c:479] mm_manager_start(): Starting automatic device scan...
ModemManager[15482]: <debug> [1401655232.279989] [mm-manager.c:518] mm_manager_start(): Finished device scan...
ModemManager[15482]: <debug> [1401655232.281214] [mm-plugin-manager.c:706] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] Checking device support...
ModemManager[15482]: <debug> [1401655232.281561] [mm-plugin.c:253] apply_pre_probing_filters(): (Option) [ttyACM1] filtered by drivers
ModemManager[15482]: <debug> [1401655232.281732] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.281895] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.282057] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyACM1] filtered by drivers
ModemManager[15482]: <debug> [1401655232.282215] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.282376] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.282535] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.282696] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.282858] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.283058] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.283218] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.283405] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.283566] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.283724] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.283884] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.284043] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyACM1] filtered by udev tags
ModemManager[15482]: <debug> [1401655232.284201] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.284360] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.284519] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyACM1] filtered by drivers
ModemManager[15482]: <debug> [1401655232.284679] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyACM1] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.284837] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyACM1] filtered by drivers
ModemManager[15482]: <debug> [1401655232.284996] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyACM1] filtered by udev tags
ModemManager[15482]: <debug> [1401655232.285154] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [ttyACM1] Found '5' plugins to try...
ModemManager[15482]: <debug> [1401655232.285339] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Iridium'
ModemManager[15482]: <debug> [1401655232.285482] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Via CBP7'
ModemManager[15482]: <debug> [1401655232.285621] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Nokia'
ModemManager[15482]: <debug> [1401655232.285759] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Cinterion'
ModemManager[15482]: <debug> [1401655232.285898] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [ttyACM1] Will try with plugin 'Generic'
ModemManager[15482]: <debug> [1401655232.286069] [mm-plugin.c:782] mm_plugin_supports_port(): (Iridium) [ttyACM1] probe required: 'at, at-vendor, at-product'
ModemManager[15482]: <debug> [1401655232.286221] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyACM1) launching port probing: 'at, at-vendor, at-product'
ModemManager[15482]: <debug> [1401655232.289164] [mm-plugin-manager.c:706] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:19.0] Checking device support...
ModemManager[15482]: <debug> [1401655232.289486] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.289654] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.289816] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.290007] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.290165] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [eth0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.290324] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.290482] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.290639] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.290797] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.290988] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.291153] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.291310] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.291468] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.291624] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.291781] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.291937] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.292093] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.292275] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.292432] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.292588] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.292746] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.292903] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [eth0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.293059] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [eth0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.293216] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [eth0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.293371] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [eth0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.293529] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [eth0] filtered by udev tags
ModemManager[15482]: <debug> [1401655232.293686] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [eth0] Found '1' plugins to try...
ModemManager[15482]: <debug> [1401655232.293842] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [eth0] Will try with plugin 'Generic'
ModemManager[15482]: <debug> [1401655232.294003] [mm-plugin.c:704] mm_plugin_supports_port(): (Generic) [eth0] probing deferred until result suggested
ModemManager[15482]: <debug> [1401655232.294633] [mm-plugin-manager.c:706] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0] Checking device support...
ModemManager[15482]: <debug> [1401655232.294941] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.295117] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.295275] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.295433] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.295590] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wlan0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.295746] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.295903] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.296059] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.296216] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.296371] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.296527] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.296710] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.296868] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.297023] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.297179] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.297335] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.297490] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.297648] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.297804] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.297960] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.298117] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.298273] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wlan0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.298428] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wlan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.298584] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wlan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.298766] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wlan0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.298967] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wlan0] filtered by udev tags
ModemManager[15482]: <debug> [1401655232.299135] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [wlan0] Found '1' plugins to try...
ModemManager[15482]: <debug> [1401655232.299291] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [wlan0] Will try with plugin 'Generic'
ModemManager[15482]: <debug> [1401655232.299464] [mm-plugin.c:704] mm_plugin_supports_port(): (Generic) [wlan0] probing deferred until result suggested
ModemManager[15482]: <debug> [1401655232.300334] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.300490] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.300632] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.300775] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.300914] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wwan0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.301053] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.301194] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.301354] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.301540] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.301697] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.301853] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.302081] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.302242] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.302401] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.302558] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel LTE) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.302714] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.302870] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.303074] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.303232] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.303386] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.303570] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.303727] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wwan0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.303883] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wwan0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.304039] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wwan0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.304195] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wwan0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.304354] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wwan0] filtered by udev tags
ModemManager[15482]: <debug> [1401655232.304511] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [wwan0] Found '1' plugins to try...
ModemManager[15482]: <debug> [1401655232.304667] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [wwan0] Will try with plugin 'Generic'
ModemManager[15482]: <debug> [1401655232.304828] [mm-plugin.c:704] mm_plugin_supports_port(): (Generic) [wwan0] probing deferred until result suggested
ModemManager[15482]: <debug> [1401655232.305437] [mm-manager.c:290] device_added(): (net/tap0): could not get port's parent device
ModemManager[15482]: <debug> [1401655232.305820] [mm-manager.c:290] device_added(): (net/tap0.42): could not get port's parent device
ModemManager[15482]: <debug> [1401655232.306683] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.306854] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.307084] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.307245] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.307404] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [cdc-wdm0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.307562] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.307719] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.307876] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.308034] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.308191] [mm-plugin.c:212] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.308348] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.308505] [mm-plugin.c:212] apply_pre_probing_filters(): (Samsung) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.308660] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.308815] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.308997] [mm-plugin.c:212] apply_pre_probing_filters(): (Novatel LTE) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.309155] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.309312] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.309471] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.309629] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.309785] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.309943] [mm-plugin.c:326] apply_pre_probing_filters(): (Novatel) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.310101] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [cdc-wdm0] filtered by drivers
ModemManager[15482]: <debug> [1401655232.310259] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [cdc-wdm0] filtered by vendor/product IDs
ModemManager[15482]: <debug> [1401655232.310416] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.310571] [mm-plugin.c:212] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm0] filtered by subsystem
ModemManager[15482]: <debug> [1401655232.310729] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm0] filtered by udev tags
ModemManager[15482]: <debug> [1401655232.310887] [mm-plugin-manager.c:607] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '1' plugins to try...
ModemManager[15482]: <debug> [1401655232.311126] [mm-plugin-manager.c:611] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Will try with plugin 'Generic'
ModemManager[15482]: <debug> [1401655232.311294] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [cdc-wdm0] probe required: 'mbim'
ModemManager[15482]: <debug> [1401655232.311457] [mm-port-probe.c:1352] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'mbim'
ModemManager[15482]: <debug> [1401655232.311662] [mm-plugin-manager.c:536] plugin_supports_port_ready(): (Plugin Manager) [eth0] deferring support check until result suggested
ModemManager[15482]: <debug> [1401655232.311833] [mm-plugin-manager.c:536] plugin_supports_port_ready(): (Plugin Manager) [wlan0] deferring support check until result suggested
ModemManager[15482]: <debug> [1401655232.311999] [mm-plugin-manager.c:536] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support check until result suggested
ModemManager[15482]: <debug> [1401655232.312504] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyACM1) opening serial port...
ModemManager[15482]: <debug> [1401655232.490435] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyACM1) device open count is 1 (open)
ModemManager[15482]: <debug> [1401655232.491728] [mm-port-probe.c:522] wdm_probe_mbim(): (usbmisc/cdc-wdm0) probing MBIM...
ModemManager[15482]: [/dev/cdc-wdm0] Queried max control message size: 512
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:00:00:00:10:00:00:00:01:00:00:00:00:02:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 16
<<<<<< type = open (0x00000001)
<<<<<< transaction = 1
<<<<<< Contents:
<<<<<< max_control_transfer = 512
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 01:00:00:80:10:00:00:00:01:00:00:00:00:00:00:00
ModemManager[15482]: <debug> [1401655232.504698] [mm-port-probe.c:300] mm_port_probe_set_result_mbim(): (usbmisc/cdc-wdm0) port is MBIM-capable
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 12
<<<<<< data = 02:00:00:00:0C:00:00:00:02:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 12
<<<<<< type = close (0x00000002)
<<<<<< transaction = 2
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 02:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
ModemManager[15482]: <debug> [1401655232.511114] [mm-plugin-manager.c:448] plugin_supports_port_ready(): (Plugin Manager) (Generic) [cdc-wdm0] found best plugin for port
ModemManager[15482]: <debug> [1401655232.511312] [mm-plugin-manager.c:365] suggest_port_probe_result(): (Plugin Manager) (Generic) [wwan0] deferred task completed, got suggested plugin
ModemManager[15482]: <debug> [1401655232.511488] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm0' port probe finished, still 2 running probes in this device (wwan0, ttyACM1)
ModemManager[15482]: <debug> [1401655232.511678] [mm-plugin.c:704] mm_plugin_supports_port(): (Generic) [wwan0] probing deferred until result suggested
ModemManager[15482]: <debug> [1401655232.511857] [mm-plugin-manager.c:516] plugin_supports_port_ready(): (Plugin Manager) (Generic) [wwan0] task completed, got suggested plugin
ModemManager[15482]: <debug> [1401655232.512050] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'wwan0' port probe finished, still 1 running probes in this device (ttyACM1)
ModemManager[15482]: <debug> [1401655232.593400] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT<CR>'
ModemManager[15482]: <debug> [1401655232.793589] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT'
ModemManager[15482]: <debug> [1401655232.794678] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15482]: <debug> [1401655232.796053] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655232.796307] [mm-port-probe.c:151] mm_port_probe_set_result_at(): (tty/ttyACM1) port is AT-capable
ModemManager[15482]: <debug> [1401655232.796534] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT+CGMI<CR>'
ModemManager[15482]: <debug> [1401655233.496925] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT+CGMI'
ModemManager[15482]: <debug> [1401655233.497938] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15482]: <debug> [1401655233.500324] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>Sierra Wireless Inc.<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655233.500575] [mm-port-probe.c:178] mm_port_probe_set_result_at_vendor(): (tty/ttyACM1) vendor probing finished
ModemManager[15482]: <debug> [1401655233.500825] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT+CGMM<CR>'
ModemManager[15482]: <debug> [1401655234.201213] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT+CGMM'
ModemManager[15482]: <debug> [1401655234.202856] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15482]: <debug> [1401655234.204195] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>Sierra Wireless EM7345 4G LTE<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655234.204417] [mm-port-probe.c:198] mm_port_probe_set_result_at_product(): (tty/ttyACM1) product probing finished
ModemManager[15482]: <debug> [1401655234.204636] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyACM1) device open count is 0 (close)
ModemManager[15482]: <debug> [1401655234.204800] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyACM1) closing serial port...
ModemManager[15482]: <debug> [1401655234.212352] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyACM1) serial port closed
ModemManager[15482]: <debug> [1401655234.212566] [mm-port-serial.c:1415] port_serial_close_force(): (ttyACM1) forced to close port
ModemManager[15482]: <debug> [1401655234.212794] [mm-plugin.c:477] apply_post_probing_filters(): (Iridium) [ttyACM1] filtered by vendor/product strings
ModemManager[15482]: <debug> [1401655234.213034] [mm-plugin.c:782] mm_plugin_supports_port(): (Via CBP7) [ttyACM1] probe required: 'at, at-vendor, at-product'
ModemManager[15482]: <debug> [1401655234.213256] [mm-plugin.c:477] apply_post_probing_filters(): (Via CBP7) [ttyACM1] filtered by vendor/product strings
ModemManager[15482]: <debug> [1401655234.213477] [mm-plugin.c:782] mm_plugin_supports_port(): (Nokia) [ttyACM1] probe required: 'at, at-vendor, at-icera'
ModemManager[15482]: <debug> [1401655234.213666] [mm-port-probe.c:1352] mm_port_probe_run(): (tty/ttyACM1) launching port probing: 'at-icera'
ModemManager[15482]: <debug> [1401655234.214053] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyACM1) opening serial port...
ModemManager[15482]: <debug> [1401655234.215404] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyACM1) device open count is 1 (open)
ModemManager[15482]: <debug> [1401655234.317772] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT%IPSYS?<CR>'
ModemManager[15482]: <debug> [1401655234.495164] [mm-plugin-manager.c:677] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] Minimum probing time consumed
ModemManager[15482]: <debug> [1401655234.495453] [mm-plugin-manager.c:677] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:19.0] Minimum probing time consumed
ModemManager[15482]: <debug> [1401655234.495626] [mm-plugin-manager.c:372] suggest_port_probe_result(): (Plugin Manager) [eth0] deferred task cancelled, no suggested plugin
ModemManager[15482]: <debug> [1401655234.495793] [mm-plugin-manager.c:677] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0] Minimum probing time consumed
ModemManager[15482]: <debug> [1401655234.495952] [mm-plugin-manager.c:372] suggest_port_probe_result(): (Plugin Manager) [wlan0] deferred task cancelled, no suggested plugin
ModemManager[15482]: <debug> [1401655235.219440] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'AT%IPSYS?'
ModemManager[15482]: <debug> [1401655235.219789] [mm-plugin-manager.c:195] port_probe_context_finished(): (Plugin Manager) [eth0] not supported by any plugin
ModemManager[15482]: <debug> [1401655235.219967] [mm-device.c:357] mm_device_ignore_port(): Fully ignoring port 'net/eth0' from now on
ModemManager[15482]: <debug> [1401655235.220128] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'eth0' port probe finished, last one in device
ModemManager[15482]: <debug> [1401655235.220324] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:19.0] device support check finished in '2.930913' seconds
ModemManager[15482]: <warn> [1401655235.220587] [mm-manager.c:153] find_device_support_ready(): Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:19.0': not supported by any plugin
ModemManager[15482]: <debug> [1401655235.220772] [mm-plugin-manager.c:195] port_probe_context_finished(): (Plugin Manager) [wlan0] not supported by any plugin
ModemManager[15482]: <debug> [1401655235.220932] [mm-device.c:357] mm_device_ignore_port(): Fully ignoring port 'net/wlan0' from now on
ModemManager[15482]: <debug> [1401655235.221088] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'wlan0' port probe finished, last one in device
ModemManager[15482]: <debug> [1401655235.221244] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0] device support check finished in '2.926425' seconds
ModemManager[15482]: <warn> [1401655235.221410] [mm-manager.c:153] find_device_support_ready(): Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0': not supported by any plugin
ModemManager[15482]: <debug> [1401655235.221609] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR>'
ModemManager[15482]: <debug> [1401655235.222355] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>ERROR<CR><LF>'
ModemManager[15482]: <debug> [1401655235.222621] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[15482]: <debug> [1401655235.222835] [mm-port-probe.c:223] mm_port_probe_set_result_at_icera(): (tty/ttyACM1) Modem is probably not Icera-based
ModemManager[15482]: <debug> [1401655235.223060] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyACM1) device open count is 0 (close)
ModemManager[15482]: <debug> [1401655235.223221] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyACM1) closing serial port...
ModemManager[15482]: <debug> [1401655235.230473] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyACM1) serial port closed
ModemManager[15482]: <debug> [1401655235.230660] [mm-port-serial.c:1415] port_serial_close_force(): (ttyACM1) forced to close port
ModemManager[15482]: <debug> [1401655235.230849] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyACM1] filtered by vendor strings
ModemManager[15482]: <debug> [1401655235.231099] [mm-plugin.c:782] mm_plugin_supports_port(): (Cinterion) [ttyACM1] probe required: 'at, at-vendor'
ModemManager[15482]: <debug> [1401655235.231290] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyACM1] filtered by vendor strings
ModemManager[15482]: <debug> [1401655235.231477] [mm-plugin.c:782] mm_plugin_supports_port(): (Generic) [ttyACM1] probe required: 'at, qcdm'
ModemManager[15482]: <debug> [1401655235.231669] [mm-plugin-manager.c:448] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyACM1] found best plugin for port
ModemManager[15482]: <debug> [1401655235.231831] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'ttyACM1' port probe finished, last one in device
ModemManager[15482]: <debug> [1401655235.231990] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4] device support check finished in '2.950571' seconds
ModemManager[15482]: <info> [1401655235.232157] [mm-device.c:509] mm_device_create_modem(): Creating modem with plugin 'Generic' and '3' ports
ModemManager[15482]: <debug> [1401655235.232353] [generic/mm-plugin-generic.c:73] create_modem(): MBIM-powered generic modem found...
ModemManager[15482]: <debug> [1401655235.234045] [mm-base-modem.c:303] mm_base_modem_grab_port(): (cdc-wdm0) type 'mbim' claimed by /sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4
ModemManager[15482]: <debug> [1401655235.234258] [mm-base-modem.c:303] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by /sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4
ModemManager[15482]: <debug> [1401655235.234509] [mm-base-modem.c:303] mm_base_modem_grab_port(): (ttyACM1) type 'at' claimed by /sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4
ModemManager[15482]: <debug> [1401655235.234684] [mm-base-modem.c:1118] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4) tty/ttyACM1 at (primary)
ModemManager[15482]: <debug> [1401655235.234844] [mm-base-modem.c:1118] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4) net/wwan0 data (primary)
ModemManager[15482]: <debug> [1401655235.235031] [mm-base-modem.c:1118] log_port(): (/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4) usb/cdc-wdm0 mbim (primary)
ModemManager[15482]: <info> [1401655235.235517] [mm-manager.c:162] find_device_support_ready(): Modem for device at '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4' successfully created
ModemManager[15482]: [/dev/cdc-wdm0] Queried max control message size: 512
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 16
<<<<<< data = 01:00:00:00:10:00:00:00:01:00:00:00:00:02:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 16
<<<<<< type = open (0x00000001)
<<<<<< transaction = 1
<<<<<< Contents:
<<<<<< max_control_transfer = 512
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 16
>>>>>> data = 01:00:00:80:10:00:00:00:01:00:00:00:00:00:00:00
ModemManager[15482]: <debug> [1401655235.239758] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyACM1) opening serial port...
ModemManager[15482]: <debug> [1401655235.241024] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyACM1) device open count is 1 (open)
ModemManager[15482]: <debug> [1401655235.241186] [mm-port-serial-at.c:476] mm_port_serial_at_run_init_sequence(): (ttyACM1): running init sequence...
ModemManager[15482]: <debug> [1401655235.241387] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyACM1) device open count is 2 (open)
ModemManager[15482]: <debug> [1401655235.241603] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyACM1) device open count is 3 (open)
ModemManager[15482]: <debug> [1401655235.242926] [mm-broadband-modem-mbim.c:210] modem_load_current_capabilities(): loading current capabilities...
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 2
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'device-caps' (0x00000001)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: <debug> [1401655235.243833] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'ATE0<CR>'
ModemManager[15482]: <debug> [1401655235.259489] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'A'
ModemManager[15482]: <debug> [1401655235.261607] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- 'TE'
ModemManager[15482]: <debug> [1401655235.262366] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '0'
ModemManager[15482]: <debug> [1401655235.265090] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655235.265329] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'ATV1<CR>'
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 264
>>>>>> data = 03:00:00:80:08:01:00:00:02:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:D8:00:00:00:01:00:00:00:01:00:00:00:01:00:00:00:02:00:00:00:3F:00:00:00:03:00:00:00:01:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:40:00:00:00:1E:00:00:00:60:00:00:00:3A:00:00:00:9C:00:00:00:3C:00:00:00:30:00:31:00:33:00:39:00:33:00:37:00:30:00:30:00:30:00:35:00:33:00:36:00:31:00:39:00:31:00:00:00:46:00:49:00:48:00:37:00:31:00:36:00:30:00:5F:00:56:00:31:00:2E:00:31:00:5F:00:4D:00:4F:00:44:00:45:00:4D:00:5F:00:30:00:31:00:2E:00:31:00:33:00:34:00:39:00:2E:00:31:00:32:00:00:00:58:00:4D:00:4D:00:37:00:31:00:36:00:30:00:5F:00:56:00:31:00:2E:00:31:00:5F:00:4D:00:42:00:49:00:4D:00:5F:00:47:00:4E:00:53:00:53:00:5F:00:4E:00:41:00:4E:00:44:00:5F:00:52:00:45:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 264
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 2
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'device-caps' (0x00000001)
ModemManager[15482]: <debug> [1401655235.267264] [mm-broadband-modem-mbim.c:140] modem_load_current_capabilities_finish(): loaded modem capabilities: gsm-umts, lte
ModemManager[15482]: <debug> [1401655235.267550] [mm-iface-modem.c:4327] interface_initialization_step(): Modem allows up to 1 bearers
ModemManager[15482]: <debug> [1401655235.267714] [mm-bearer-list.c:276] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
ModemManager[15482]: <debug> [1401655235.268192] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '000011990000a001013937000536191FIH7160_V1.1_MODEM_01.1349.12MBIM[1199:A001]Generic'
ModemManager[15482]: <debug> [1401655235.269933] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID 'd4f9081cf51f562690a9c873a7bda6706ccff777'
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 3
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'radio-state' (0x00000003)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 56
>>>>>> data = 03:00:00:80:38:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 56
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 3
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'radio-state' (0x00000003)
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 4
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: <debug> [1401655235.274480] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655235.274700] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT+CMEE=1<CR>'
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:44:00:00:00:06:00:00:00:1C:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:32:00:31:00:30:00:31:00:31:00:30:00:30:00:38:00:31:00:39:00:35:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 4
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'subscriber-ready-status' (0x00000002)
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 5
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'pin' (0x00000004)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: <debug> [1401655235.291114] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655235.291392] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'ATX4<CR>'
ModemManager[15482]: <debug> [1401655235.301351] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655235.301634] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT&C1<CR>'
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 60
>>>>>> data = 03:00:00:80:3C:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 60
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 5
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'pin' (0x00000004)
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 6
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'pin' (0x00000004)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: <debug> [1401655235.311349] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655235.311580] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'ATE0<CR>'
ModemManager[15482]: <debug> [1401655235.318980] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655235.319197] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyACM1) device open count is 2 (close)
ModemManager[15482]: <debug> [1401655235.319420] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): --> 'AT+CMEE=1<CR>'
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 60
>>>>>> data = 03:00:00:80:3C:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 60
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 6
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'pin' (0x00000004)
ModemManager[15482]: <info> [1401655235.326479] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem: state changed (unknown -> locked)
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:07:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 7
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74:00:00:00:07:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:44:00:00:00:06:00:00:00:1C:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:32:00:31:00:30:00:31:00:31:00:30:00:30:00:38:00:31:00:39:00:35:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 7
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'subscriber-ready-status' (0x00000002)
ModemManager[15482]: <debug> [1401655235.334511] [mm-port-serial-at.c:440] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
ModemManager[15482]: <debug> [1401655235.334705] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyACM1) device open count is 1 (close)
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 8
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:44:00:00:00:06:00:00:00:1C:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:32:00:31:00:30:00:31:00:31:00:30:00:30:00:38:00:31:00:39:00:35:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 8
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'subscriber-ready-status' (0x00000002)
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:09:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 9
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'home-provider' (0x00000006)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 03:00:00:80:30:00:00:00:09:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:04:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 48
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 9
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'BadSim' (0x00000004)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'home-provider' (0x00000006)
ModemManager[15482]: <warn> [1401655235.374602] [mm-sim.c:1465] load_operator_identifier_ready(): couldn't load Operator identifier: 'BadSim'
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 10
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'home-provider' (0x00000006)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 48
>>>>>> data = 03:00:00:80:30:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:04:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 48
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 10
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'BadSim' (0x00000004)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'home-provider' (0x00000006)
ModemManager[15482]: <warn> [1401655235.407203] [mm-sim.c:1466] load_operator_name_ready(): couldn't load Operator name: 'BadSim'
ModemManager[15482]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:0B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
ModemManager[15482]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 11
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'subscriber-ready-status' (0x00000002)
<<<<<< type = 'query' (0x00000000)
ModemManager[15482]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 116
>>>>>> data = 03:00:00:80:74:00:00:00:0B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:44:00:00:00:06:00:00:00:1C:00:00:00:00:00:00:00:1C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:37:00:30:00:33:00:30:00:35:00:31:00:32:00:31:00:30:00:31:00:31:00:30:00:30:00:38:00:31:00:39:00:35:00
ModemManager[15482]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 116
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 11
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'subscriber-ready-status' (0x00000002)
ModemManager[15482]: <debug> [1401655235.413977] [mm-broadband-modem.c:9011] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
ModemManager[15482]: <debug> [1401655235.414303] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyACM1) device open count is 0 (close)
ModemManager[15482]: <debug> [1401655235.414503] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyACM1) closing serial port...
ModemManager[15482]: <debug> [1401655235.421598] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyACM1) serial port closed
ModemManager[15482]: <debug> [1401655235.421807] [mm-base-modem.c:1098] initialize_ready(): Couldn't finish initialization in the current state: 'Modem is currently locked, cannot fully initialize'
ModemManager[15482]: <debug> [1401655235.422615] [mm-device.c:436] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:1d.7/usb3/3-4' at path '/org/freedesktop/ModemManager1/Modem/0'
ModemManager[15482]: <debug> [1401655235.422808] [mm-device.c:446] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Generic' modem, VID 0x1199 PID 0xA001 (usb)
I'm running a pretty recent MM and libmbim from the master branches,
with the most recent commits being respectively
cdb3346 altair-lte: fix memory leak in PCO parsing code
and
b886057 libmbim-glib: consistently use spaces for indentation
Bjørn
More information about the ModemManager-devel
mailing list