ModemManager[19798]: <info>  [1369743118.528652] [main.c:128] main(): ModemManager (version 0.7.990) starting...
ModemManager[19798]: <debug> [1369743118.541040] [main.c:61] bus_acquired_cb(): Bus acquired, creating manager...
ModemManager[19798]: <debug> [1369743118.542566] [mm-plugin-manager.c:735] load_plugins(): Looking for plugins in '/usr/local/lib/ModemManager'
ModemManager[19798]: <debug> [1369743118.543808] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Generic'
ModemManager[19798]: <debug> [1369743118.544457] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Nokia'
ModemManager[19798]: <debug> [1369743118.545000] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Nokia (Icera)'
ModemManager[19798]: <debug> [1369743118.545521] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Cinterion'
ModemManager[19798]: <debug> [1369743118.546051] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Iridium'
ModemManager[19798]: <debug> [1369743118.546543] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Gobi'
ModemManager[19798]: <debug> [1369743118.547002] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Motorola'
ModemManager[19798]: <debug> [1369743118.547543] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Novatel'
ModemManager[19798]: <debug> [1369743118.548049] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Novatel LTE'
ModemManager[19798]: <debug> [1369743118.548579] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Altair LTE'
ModemManager[19798]: <debug> [1369743118.550982] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Samsung'
ModemManager[19798]: <debug> [1369743118.551699] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Option'
ModemManager[19798]: <debug> [1369743118.552426] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Option High-Speed'
ModemManager[19798]: <debug> [1369743118.553116] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'AnyDATA'
ModemManager[19798]: <debug> [1369743118.553771] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Linktop'
ModemManager[19798]: <debug> [1369743118.554518] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'SimTech'
ModemManager[19798]: <debug> [1369743118.555240] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Wavecom'
ModemManager[19798]: <debug> [1369743118.555976] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Huawei'
ModemManager[19798]: <debug> [1369743118.556663] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Longcheer'
ModemManager[19798]: <debug> [1369743118.557409] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'X22X'
ModemManager[19798]: <debug> [1369743118.558114] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Pantech'
ModemManager[19798]: <debug> [1369743118.558833] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'ZTE'
ModemManager[19798]: <debug> [1369743118.559635] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Sierra'
ModemManager[19798]: <debug> [1369743118.560345] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Ericsson MBM'
ModemManager[19798]: <debug> [1369743118.561046] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Via CBP7'
ModemManager[19798]: <debug> [1369743118.561757] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Infineon'
ModemManager[19798]: <debug> [1369743118.562457] [mm-plugin-manager.c:760] load_plugins(): Loaded plugin 'Telit'
ModemManager[19798]: <debug> [1369743118.562679] [mm-plugin-manager.c:785] load_plugins(): Successfully loaded 27 plugins
ModemManager[19798]: <debug> [1369743118.568043] [main.c:79] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
ModemManager[19798]: <debug> [1369743118.568395] [mm-manager.c:450] mm_manager_start(): Starting automatic device scan...
ModemManager[19798]: <debug> [1369743118.577135] [mm-manager.c:489] mm_manager_start(): Finished device scan...
ModemManager[19798]: <debug> [1369743118.578188] [mm-manager.c:288] device_added(): (tty/ttyGS0): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.578870] [mm-manager.c:288] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.579476] [mm-manager.c:288] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.580094] [mm-manager.c:288] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.580681] [mm-manager.c:288] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.581904] [mm-plugin-manager.c:622] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/platform/tegra-ehci.1/usb1/1-1] Checking device support...
ModemManager[19798]: <debug> [1369743118.582453] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.582673] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [ttyACM0] filtered by drivers
ModemManager[19798]: <debug> [1369743118.582866] [mm-plugin.c:322] apply_pre_probing_filters(): (Motorola) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.583057] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.583246] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.583434] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.583623] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.583811] [mm-plugin.c:254] apply_pre_probing_filters(): (Option) [ttyACM0] filtered by drivers
ModemManager[19798]: <debug> [1369743118.583999] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [ttyACM0] filtered by drivers
ModemManager[19798]: <debug> [1369743118.584186] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.584421] [mm-plugin.c:322] apply_pre_probing_filters(): (Linktop) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.584611] [mm-plugin.c:322] apply_pre_probing_filters(): (SimTech) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.584800] [mm-plugin.c:322] apply_pre_probing_filters(): (Wavecom) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.584988] [mm-plugin.c:322] apply_pre_probing_filters(): (Huawei) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.585175] [mm-plugin.c:322] apply_pre_probing_filters(): (Longcheer) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.585364] [mm-plugin.c:322] apply_pre_probing_filters(): (X22X) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.585550] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.585737] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [ttyACM0] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.585925] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [ttyACM0] filtered by drivers
ModemManager[19798]: <debug> [1369743118.586114] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [ttyACM0] filtered by udev tags
ModemManager[19798]: <debug> [1369743118.586343] [mm-plugin-manager.c:523] build_plugins_list(): (Plugin Manager) [ttyACM0] Found '2' plugins to try...
ModemManager[19798]: <debug> [1369743118.586534] [mm-plugin-manager.c:527] build_plugins_list(): (Plugin Manager) [ttyACM0]   Will try with plugin 'Infineon'
ModemManager[19798]: <debug> [1369743118.586720] [mm-plugin-manager.c:527] build_plugins_list(): (Plugin Manager) [ttyACM0]   Will try with plugin 'Generic'
ModemManager[19798]: <debug> [1369743118.586966] [mm-plugin.c:772] mm_plugin_supports_port(): (Infineon) [ttyACM0] probe required: 'at'
ModemManager[19798]: <debug> [1369743118.587178] [mm-port-probe.c:1331] mm_port_probe_run(): (tty/ttyACM0) launching port probing: 'at'
ModemManager[19798]: <debug> [1369743118.588223] [mm-plugin.c:322] apply_pre_probing_filters(): (Nokia (Icera)) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.588441] [mm-plugin.c:254] apply_pre_probing_filters(): (Gobi) [ttyACM1] filtered by drivers
ModemManager[19798]: <debug> [1369743118.588634] [mm-plugin.c:322] apply_pre_probing_filters(): (Motorola) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.588824] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.589011] [mm-plugin.c:322] apply_pre_probing_filters(): (Novatel LTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.589265] [mm-plugin.c:322] apply_pre_probing_filters(): (Altair LTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.589494] [mm-plugin.c:322] apply_pre_probing_filters(): (Samsung) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.589740] [mm-plugin.c:254] apply_pre_probing_filters(): (Option) [ttyACM1] filtered by drivers
ModemManager[19798]: <debug> [1369743118.589963] [mm-plugin.c:254] apply_pre_probing_filters(): (Option High-Speed) [ttyACM1] filtered by drivers
ModemManager[19798]: <debug> [1369743118.590153] [mm-plugin.c:322] apply_pre_probing_filters(): (AnyDATA) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.590341] [mm-plugin.c:322] apply_pre_probing_filters(): (Linktop) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.590543] [mm-plugin.c:322] apply_pre_probing_filters(): (SimTech) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.590778] [mm-plugin.c:322] apply_pre_probing_filters(): (Wavecom) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.590972] [mm-plugin.c:322] apply_pre_probing_filters(): (Huawei) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.591161] [mm-plugin.c:322] apply_pre_probing_filters(): (Longcheer) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.591349] [mm-plugin.c:322] apply_pre_probing_filters(): (X22X) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.591537] [mm-plugin.c:322] apply_pre_probing_filters(): (Pantech) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.591724] [mm-plugin.c:322] apply_pre_probing_filters(): (ZTE) [ttyACM1] filtered by vendor/product IDs
ModemManager[19798]: <debug> [1369743118.591934] [mm-plugin.c:254] apply_pre_probing_filters(): (Sierra) [ttyACM1] filtered by drivers
ModemManager[19798]: <debug> [1369743118.592124] [mm-plugin.c:376] apply_pre_probing_filters(): (Ericsson MBM) [ttyACM1] filtered by udev tags
ModemManager[19798]: <debug> [1369743118.592319] [mm-plugin-manager.c:523] build_plugins_list(): (Plugin Manager) [ttyACM1] Found '2' plugins to try...
ModemManager[19798]: <debug> [1369743118.592507] [mm-plugin-manager.c:527] build_plugins_list(): (Plugin Manager) [ttyACM1]   Will try with plugin 'Infineon'
ModemManager[19798]: <debug> [1369743118.592693] [mm-plugin-manager.c:527] build_plugins_list(): (Plugin Manager) [ttyACM1]   Will try with plugin 'Generic'
ModemManager[19798]: <debug> [1369743118.592892] [mm-plugin.c:772] mm_plugin_supports_port(): (Infineon) [ttyACM1] probe required: 'at'
ModemManager[19798]: <debug> [1369743118.593092] [mm-port-probe.c:1331] mm_port_probe_run(): (tty/ttyACM1) launching port probing: 'at'
ModemManager[19798]: <debug> [1369743118.593766] [mm-manager.c:288] device_added(): (tty/ttyHS1): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.594509] [mm-manager.c:288] device_added(): (tty/ttyHS2): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.595176] [mm-manager.c:288] device_added(): (tty/ttyHS3): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.595818] [mm-manager.c:288] device_added(): (tty/ttyHS4): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.599210] [mm-manager.c:288] device_added(): (net/usb0): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.600138] [mm-manager.c:288] device_added(): (net/wlan0): port's parent platform driver is not whitelisted
ModemManager[19798]: <debug> [1369743118.600625] [mm-manager.c:265] device_added(): (net/dummy0): could not get port's parent device
ModemManager[19798]: <debug> [1369743118.601080] [mm-manager.c:265] device_added(): (net/ip6tnl0): could not get port's parent device
ModemManager[19798]: <debug> [1369743118.602196] [mm-manager.c:265] device_added(): (net/sit0): could not get port's parent device
ModemManager[19798]: <debug> [1369743118.603289] [mm-serial-port.c:413] mm_serial_port_open(): (ttyACM0) opening serial port...
ModemManager[19798]: <debug> [1369743118.709032] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
ModemManager[19798]: <debug> [1369743118.713435] [mm-serial-port.c:413] mm_serial_port_open(): (ttyACM1) opening serial port...
ModemManager[19798]: <debug> [1369743118.718143] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM1) device open count is 1 (open)
ModemManager[19798]: <debug> [1369743118.815496] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT<CR>'
ModemManager[19798]: <debug> [1369743118.820773] [mm-at-serial-port.c:411] debug_log(): (ttyACM1): --> 'AT<CR>'
ModemManager[19798]: <debug> [1369743119.038215] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743119.041824] [mm-port-probe.c:151] mm_port_probe_set_result_at(): (tty/ttyACM0) port is AT-capable
ModemManager[19798]: <debug> [1369743119.047145] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
ModemManager[19798]: <debug> [1369743119.048234] [mm-serial-port.c:531] mm_serial_port_close(): (ttyACM0) closing serial port...
ModemManager[19798]: <debug> [1369743119.052936] [mm-serial-port.c:558] mm_serial_port_close(): (ttyACM0) serial port closed
ModemManager[19798]: <debug> [1369743119.053750] [mm-serial-port.c:579] mm_serial_port_close_force(): (ttyACM0) forced to close port
ModemManager[19798]: <debug> [1369743119.054940] [mm-plugin-manager.c:365] plugin_supports_port_ready(): (Plugin Manager) (Infineon) [ttyACM0] found best plugin for port
ModemManager[19798]: <debug> [1369743119.055354] [mm-plugin-manager.c:201] port_probe_context_finished(): (Plugin Manager) (Infineon) [ttyACM0]: found best plugin for device (/sys/devices/platform/tegra-ehci.1/usb1/1-1)
ModemManager[19798]: <debug> [1369743119.055787] [mm-plugin-manager.c:325] suggest_port_probe_result(): (Plugin Manager) (Infineon) [ttyACM1] suggested plugin for port
ModemManager[19798]: <debug> [1369743119.056196] [mm-plugin-manager.c:239] port_probe_context_finished(): (Plugin Manager) 'ttyACM0' port probe finished, still 1 running probes in this device (ttyACM1)
ModemManager[19798]: <debug> [1369743120.696783] [mm-plugin-manager.c:593] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/platform/tegra-ehci.1/usb1/1-1] Minimum probing time consumed
ModemManager[19798]: <debug> [1369743122.697180] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[19798]: <debug> [1369743122.697433] [mm-at-serial-port.c:411] debug_log(): (ttyACM1): --> 'AT<CR>'
ModemManager[19798]: <debug> [1369743125.697396] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[19798]: <debug> [1369743125.698266] [mm-at-serial-port.c:411] debug_log(): (ttyACM1): --> 'AT<CR>'
ModemManager[19798]: <debug> [1369743128.697931] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
ModemManager[19798]: <debug> [1369743128.698942] [mm-port-probe.c:161] mm_port_probe_set_result_at(): (tty/ttyACM1) port is not AT-capable
ModemManager[19798]: <debug> [1369743128.699911] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM1) device open count is 0 (close)
ModemManager[19798]: <debug> [1369743128.700465] [mm-serial-port.c:531] mm_serial_port_close(): (ttyACM1) closing serial port...
ModemManager[19798]: <debug> [1369743128.776585] [mm-serial-port.c:558] mm_serial_port_close(): (ttyACM1) serial port closed
ModemManager[19798]: <debug> [1369743128.778849] [mm-serial-port.c:579] mm_serial_port_close_force(): (ttyACM1) forced to close port
ModemManager[19798]: <debug> [1369743128.781481] [mm-plugin-manager.c:365] plugin_supports_port_ready(): (Plugin Manager) (Infineon) [ttyACM1] found best plugin for port
ModemManager[19798]: <debug> [1369743128.783726] [mm-plugin-manager.c:250] port_probe_context_finished(): (Plugin Manager) 'ttyACM1' port probe finished, last one in device
ModemManager[19798]: <debug> [1369743128.786335] [mm-plugin-manager.c:107] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/platform/tegra-ehci.1/usb1/1-1] device support check finished in '10.204132' seconds
ModemManager[19798]: <info>  [1369743128.790070] [mm-device.c:486] mm_device_create_modem(): Creating modem with plugin 'Infineon' and '2' ports
ModemManager[19798]: <warn>  [1369743128.817264] [mm-plugin.c:900] mm_plugin_create_modem(): Could not grab port (tty/ttyACM1): 'Cannot add port 'tty/ttyACM1', unhandled serial type'
ModemManager[19798]: <debug> [1369743128.819572] [mm-base-modem.c:275] mm_base_modem_grab_port(): (ttyACM0) type 'at' claimed by /sys/devices/platform/tegra-ehci.1/usb1/1-1
ModemManager[19798]: <debug> [1369743128.820659] [mm-base-modem.c:1009] log_port(): (/sys/devices/platform/tegra-ehci.1/usb1/1-1) tty/ttyACM0 at (primary)
ModemManager[19798]: <debug> [1369743128.821647] [mm-base-modem.c:1009] log_port(): (/sys/devices/platform/tegra-ehci.1/usb1/1-1) tty/ttyACM0 data (primary)
ModemManager[19798]: <debug> [1369743128.825480] [mm-serial-port.c:413] mm_serial_port_open(): (ttyACM0) opening serial port...
ModemManager[19798]: <debug> [1369743128.830904] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
ModemManager[19798]: <debug> [1369743128.831602] [mm-at-serial-port.c:448] mm_at_serial_port_run_init_sequence(): (ttyACM0): running init sequence...
ModemManager[19798]: <debug> [1369743128.832414] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743128.833177] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <info>  [1369743128.833962] [mm-manager.c:149] find_device_support_ready(): Modem for device at '/sys/devices/platform/tegra-ehci.1/usb1/1-1' successfully created
ModemManager[19798]: <debug> [1369743128.842024] [mm-broadband-modem.c:675] modem_load_current_capabilities(): loading current capabilities...
ModemManager[19798]: <debug> [1369743128.843000] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743128.843845] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATE0<CR>'
ModemManager[19798]: <debug> [1369743128.867483] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743128.868402] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATV1<CR>'
ModemManager[19798]: <debug> [1369743128.876552] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743128.877189] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
ModemManager[19798]: <debug> [1369743128.891546] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743128.892242] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATX4<CR>'
ModemManager[19798]: <debug> [1369743128.900807] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743128.901516] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT&C1<CR>'
ModemManager[19798]: <debug> [1369743128.915729] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743128.918571] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATE0<CR>'
ModemManager[19798]: <debug> [1369743128.934149] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743128.937001] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743128.939377] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
ModemManager[19798]: <debug> [1369743128.963611] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743128.967484] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743128.970184] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+GCAP<CR>'
ModemManager[19798]: <debug> [1369743128.990559] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
ModemManager[19798]: <debug> [1369743128.995459] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[19798]: <debug> [1369743128.998401] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATI<CR>'
ModemManager[19798]: <debug> [1369743129.010433] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
ModemManager[19798]: <debug> [1369743129.013136] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[19798]: <debug> [1369743129.015802] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPIN?<CR>'
ModemManager[19798]: <debug> [1369743129.039138] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPIN: SIM PIN<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743129.042422] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.045044] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.048782] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+WS46=?<CR>'
ModemManager[19798]: <debug> [1369743129.073549] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
ModemManager[19798]: <debug> [1369743129.076371] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[19798]: <debug> [1369743129.078769] [mm-broadband-modem.c:336] modem_load_current_capabilities_finish(): loaded current capabilities: gsm-umts
ModemManager[19798]: <debug> [1369743129.081491] [mm-iface-modem.c:3885] interface_initialization_step(): Modem allows up to 1 bearers
ModemManager[19798]: <debug> [1369743129.083434] [mm-bearer-list.c:273] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
ModemManager[19798]: <debug> [1369743129.088813] [mm-broadband-modem.c:735] modem_load_manufacturer(): loading manufacturer...
ModemManager[19798]: <debug> [1369743129.091325] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.093700] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.096155] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGMI<CR>'
ModemManager[19798]: <debug> [1369743129.114703] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF> Infineon<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743129.116429] [mm-broadband-modem.c:719] modem_load_manufacturer_finish(): loaded manufacturer: Infineon
ModemManager[19798]: <debug> [1369743129.117674] [mm-broadband-modem.c:775] modem_load_model(): loading model...
ModemManager[19798]: <debug> [1369743129.118775] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.119956] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.121094] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGMM<CR>'
ModemManager[19798]: <debug> [1369743129.138429] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF> XMM6260<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743129.140030] [mm-broadband-modem.c:759] modem_load_model_finish(): loaded model: XMM6260
ModemManager[19798]: <debug> [1369743129.141304] [mm-broadband-modem.c:815] modem_load_revision(): loading revision...
ModemManager[19798]: <debug> [1369743129.142414] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.143602] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.145551] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGMR<CR>'
ModemManager[19798]: <debug> [1369743129.167395] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>1231_0.17.0_1205<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743129.170773] [mm-broadband-modem.c:799] modem_load_revision_finish(): loaded revision: 1231_0.17.0_1205
ModemManager[19798]: <debug> [1369743129.173242] [mm-broadband-modem.c:876] modem_load_equipment_identifier(): loading equipment identifier...
ModemManager[19798]: <debug> [1369743129.175722] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.178120] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.180367] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGSN<CR>'
ModemManager[19798]: <debug> [1369743129.207360] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>354400054096650<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743129.209114] [mm-broadband-modem.c:858] modem_load_equipment_identifier_finish(): loaded equipment identifier: 354400054096650
ModemManager[19798]: <debug> [1369743129.210345] [mm-broadband-modem.c:964] modem_load_device_identifier(): loading device identifier...
ModemManager[19798]: <debug> [1369743129.211458] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.212772] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.213909] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATI<CR>'
ModemManager[19798]: <debug> [1369743129.223293] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
ModemManager[19798]: <debug> [1369743129.225521] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[19798]: <debug> [1369743129.230043] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '00001519000000203544000540966501231_0.17.0_1205XMM6260Infineon'
ModemManager[19798]: <debug> [1369743129.232129] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID '27d915cfc3ffa8b9d415425dd511570fc40a35f5'
ModemManager[19798]: <debug> [1369743129.234043] [mm-broadband-modem.c:927] modem_load_device_identifier_finish(): loaded device identifier: 27d915cfc3ffa8b9d415425dd511570fc40a35f5
ModemManager[19798]: <debug> [1369743129.236935] [mm-broadband-modem.c:1518] modem_load_supported_modes(): loading initial supported modes...
ModemManager[19798]: <debug> [1369743129.239542] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.241885] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.244137] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+WS46=?<CR>'
ModemManager[19798]: <debug> [1369743129.263163] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
ModemManager[19798]: <debug> [1369743129.264624] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[19798]: <debug> [1369743129.265751] [mm-broadband-modem.c:1455] supported_modes_ws46_test_ready(): Generic query of supported 3GPP networks failed: 'Unknown error'
ModemManager[19798]: <debug> [1369743129.267301] [mm-broadband-modem.c:1462] supported_modes_ws46_test_ready(): Assuming device allows (3GPP) 2G/3G network modes
ModemManager[19798]: <debug> [1369743129.269606] [mm-broadband-modem.c:2952] load_power_state(): loading power state...
ModemManager[19798]: <debug> [1369743129.270759] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.271958] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.273117] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CFUN?<CR>'
ModemManager[19798]: <debug> [1369743129.290947] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CFUN: 1,0<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <warn>  [1369743129.294470] [mm-iface-modem.c:3699] load_power_state_ready(): couldn't load Power State: 'Failed to parse +CFUN? response '1,0''
ModemManager[19798]: <debug> [1369743129.296832] [mm-broadband-modem.c:1263] modem_load_unlock_required(): checking if unlock required...
ModemManager[19798]: <debug> [1369743129.299012] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.301368] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.303867] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPIN?<CR>'
ModemManager[19798]: <debug> [1369743129.322045] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPIN: SIM PIN<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <info>  [1369743129.323822] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem: state changed (unknown -> locked)
ModemManager[19798]: <debug> [1369743129.326368] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743129.332009] [mm-sim.c:1077] load_sim_identifier(): loading SIM identifier...
ModemManager[19798]: <debug> [1369743129.333268] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743129.334904] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
ModemManager[19798]: <debug> [1369743129.405478] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CRSM: 144,0,"****"<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743129.410127] [mm-sim.c:1066] load_sim_identifier_finish(): loaded SIM identifier: ****
ModemManager[19798]: <debug> [1369743129.412543] [mm-sim.c:1147] load_imsi(): loading IMSI...
ModemManager[19798]: <debug> [1369743129.414903] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.417360] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.419643] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CIMI<CR>'
ModemManager[19798]: <debug> [1369743129.437413] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
ModemManager[19798]: <debug> [1369743129.438921] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
ModemManager[19798]: <warn>  [1369743129.440197] [mm-sim.c:1528] load_imsi_ready(): couldn't load IMSI: 'SIM PIN required'
ModemManager[19798]: <debug> [1369743129.441220] [mm-sim.c:1283] load_operator_identifier(): loading Operator ID...
ModemManager[19798]: <debug> [1369743129.442325] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.443513] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.444780] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CRSM=176,28589,0,0,4<CR>'
ModemManager[19798]: <debug> [1369743129.525128] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CRSM: 144,0,"01000102"<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <warn>  [1369743129.530281] [mm-sim.c:1529] load_operator_identifier_ready(): couldn't load Operator identifier: 'Cannot load Operator ID without IMSI'
ModemManager[19798]: <debug> [1369743129.532451] [mm-sim.c:1394] load_operator_name(): loading Operator Name...
ModemManager[19798]: <debug> [1369743129.534860] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743129.537709] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743129.540030] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CRSM=176,28486,0,0,17<CR>'
ModemManager[19798]: <debug> [1369743129.606913] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CRSM: 144,0,"004E6574436F6DFFFFFFFFFFFFFFFFFFFF"<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743129.611242] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743129.615766] [mm-broadband-modem.c:1141] modem_load_own_numbers(): loading own numbers...
ModemManager[19798]: <debug> [1369743129.618108] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743129.620707] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CNUM<CR>'
ModemManager[19798]: <debug> [1369743129.639424] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
ModemManager[19798]: <debug> [1369743129.640960] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
ModemManager[19798]: <warn>  [1369743129.642085] [mm-iface-modem.c:3634] load_own_numbers_ready(): couldn't load list of Own Numbers: 'SIM PIN required'
ModemManager[19798]: <debug> [1369743129.644356] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743129.649576] [mm-broadband-modem.c:8709] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
ModemManager[19798]: <debug> [1369743129.652428] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
ModemManager[19798]: <debug> [1369743129.653456] [mm-serial-port.c:531] mm_serial_port_close(): (ttyACM0) closing serial port...
ModemManager[19798]: <debug> [1369743129.659191] [mm-serial-port.c:558] mm_serial_port_close(): (ttyACM0) serial port closed
ModemManager[19798]: <debug> [1369743129.660461] [mm-base-modem.c:989] initialize_ready(): Couldn't finish initialization in the current state: 'Modem is currently locked, cannot fully initialize'
ModemManager[19798]: <debug> [1369743129.669728] [mm-device.c:416] export_modem(): Exported modem '/sys/devices/platform/tegra-ehci.1/usb1/1-1' at path '/org/freedesktop/ModemManager1/Modem/0'
ModemManager[19798]: <debug> [1369743129.670620] [mm-device.c:424] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Infineon' modem, VID 0x1519 PID 0x0020 (usb)
ModemManager[19798]: <debug> [1369743348.747425] [mm-serial-port.c:413] mm_serial_port_open(): (ttyACM0) opening serial port...
ModemManager[19798]: (mm-command-serial-port.c:526):channel_enable: runtime check failed: (self->priv->channel == NULL)
ModemManager[19798]: (mm-command-serial-port.c:530):channel_enable: runtime check failed: (self->priv->watch_id == 0)
ModemManager[19798]: <debug> [1369743348.847959] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
ModemManager[19798]: <debug> [1369743348.848296] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPIN="****"<CR>'
ModemManager[19798]: <debug> [1369743348.899907] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743348.900312] [mm-broadband-modem.c:1263] modem_load_unlock_required(): checking if unlock required...
ModemManager[19798]: <debug> [1369743348.900567] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743348.900824] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743348.901085] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPIN?<CR>'
ModemManager[19798]: <debug> [1369743348.913727] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 14<CR><LF>'
ModemManager[19798]: <debug> [1369743348.914020] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 14: SIM busy
ModemManager[19798]: <debug> [1369743348.914323] [mm-iface-modem.c:2627] load_unlock_required_ready(): Couldn't check if unlock required: 'SIM busy'
ModemManager[19798]: <debug> [1369743348.914548] [mm-iface-modem.c:2633] load_unlock_required_ready(): Retrying (1) unlock required check
ModemManager[19798]: <debug> [1369743348.914768] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
ModemManager[19798]: <debug> [1369743348.914970] [mm-serial-port.c:531] mm_serial_port_close(): (ttyACM0) closing serial port...
ModemManager[19798]: <debug> [1369743348.917860] [mm-serial-port.c:558] mm_serial_port_close(): (ttyACM0) serial port closed

(ModemManager:19798): GLib-WARNING **: Invalid file descriptor.

ModemManager[19798]: <warn>  [1369743348.919198] [mm-command-serial-port.c:450] data_available(): (ttyACM0): read error: Bad file descriptor
ModemManager[19798]: <debug> [1369743350.694277] [mm-broadband-modem.c:1263] modem_load_unlock_required(): checking if unlock required...
ModemManager[19798]: <debug> [1369743350.694631] [mm-serial-port.c:413] mm_serial_port_open(): (ttyACM0) opening serial port...
ModemManager[19798]: (mm-command-serial-port.c:526):channel_enable: runtime check failed: (self->priv->channel == NULL)
ModemManager[19798]: (mm-command-serial-port.c:530):channel_enable: runtime check failed: (self->priv->watch_id == 0)
ModemManager[19798]: <debug> [1369743350.698178] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
ModemManager[19798]: <debug> [1369743350.698470] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPIN?<CR>'
ModemManager[19798]: <debug> [1369743350.711510] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.711891] [mm-iface-modem.c:2724] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
ModemManager[19798]: <debug> [1369743350.712292] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
ModemManager[19798]: <debug> [1369743350.712515] [mm-serial-port.c:531] mm_serial_port_close(): (ttyACM0) closing serial port...
ModemManager[19798]: <debug> [1369743350.715083] [mm-serial-port.c:558] mm_serial_port_close(): (ttyACM0) serial port closed

(ModemManager:19798): GLib-WARNING **: Invalid file descriptor.

ModemManager[19798]: <warn>  [1369743350.715445] [mm-command-serial-port.c:450] data_available(): (ttyACM0): read error: Bad file descriptor

(ModemManager:19798): GLib-WARNING **: Invalid file descriptor.

ModemManager[19798]: <warn>  [1369743350.715795] [mm-command-serial-port.c:450] data_available(): (ttyACM0): read error: Bad file descriptor
ModemManager[19798]: <info>  [1369743350.720158] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (locked -> initializing)
ModemManager[19798]: <debug> [1369743350.721868] [mm-serial-port.c:413] mm_serial_port_open(): (ttyACM0) opening serial port...
ModemManager[19798]: (mm-command-serial-port.c:526):channel_enable: runtime check failed: (self->priv->channel == NULL)
ModemManager[19798]: (mm-command-serial-port.c:530):channel_enable: runtime check failed: (self->priv->watch_id == 0)
ModemManager[19798]: <debug> [1369743350.726682] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
ModemManager[19798]: <debug> [1369743350.726811] [mm-at-serial-port.c:448] mm_at_serial_port_run_init_sequence(): (ttyACM0): running init sequence...
ModemManager[19798]: <debug> [1369743350.727003] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743350.727178] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743350.727601] [mm-broadband-modem.c:2952] load_power_state(): loading power state...
ModemManager[19798]: <debug> [1369743350.727752] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743350.727949] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATE0<CR>'
ModemManager[19798]: <debug> [1369743350.736506] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.736953] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATV1<CR>'
ModemManager[19798]: <debug> [1369743350.745044] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.745571] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
ModemManager[19798]: <debug> [1369743350.759029] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.759580] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATX4<CR>'
ModemManager[19798]: <debug> [1369743350.768923] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.769610] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT&C1<CR>'
ModemManager[19798]: <debug> [1369743350.778110] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.778367] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATE0<CR>'
ModemManager[19798]: <debug> [1369743350.786236] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.786438] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743350.786638] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
ModemManager[19798]: <debug> [1369743350.800102] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.800295] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743350.800486] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CFUN?<CR>'
ModemManager[19798]: <debug> [1369743350.812727] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CFUN: 1,0<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <warn>  [1369743350.813000] [mm-iface-modem.c:3699] load_power_state_ready(): couldn't load Power State: 'Failed to parse +CFUN? response '1,0''
ModemManager[19798]: <debug> [1369743350.813169] [mm-sim.c:1147] load_imsi(): loading IMSI...
ModemManager[19798]: <debug> [1369743350.813323] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743350.813541] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743350.813729] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CIMI<CR>'
ModemManager[19798]: <debug> [1369743350.824736] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>*****<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.824935] [mm-sim.c:1136] load_imsi_finish(): loaded IMSI: ******
ModemManager[19798]: <debug> [1369743350.825119] [mm-sim.c:1283] load_operator_identifier(): loading Operator ID...
ModemManager[19798]: <debug> [1369743350.825266] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743350.825428] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743350.825900] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CRSM=176,28589,0,0,4<CR>'
ModemManager[19798]: <debug> [1369743350.875591] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CRSM: 144,0,"01000102"<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743350.875956] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743350.876389] [mm-broadband-modem.c:1141] modem_load_own_numbers(): loading own numbers...
ModemManager[19798]: <debug> [1369743350.876504] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743350.876648] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CNUM<CR>'
ModemManager[19798]: <debug> [1369743350.922785] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CNUM: "","",0<CR><LF>'
ModemManager[19798]: <debug> [1369743350.970624] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CNUM: "","",0<CR><LF>'
ModemManager[19798]: <debug> [1369743351.018406] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CNUM: "","",0<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.019115] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743351.020265] [mm-broadband-modem.c:3055] modem_3gpp_load_imei(): loading IMEI...
ModemManager[19798]: <debug> [1369743351.020445] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743351.020661] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGSN<CR>'
ModemManager[19798]: <debug> [1369743351.042770] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>354400054096650<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.042993] [mm-broadband-modem.c:3046] modem_3gpp_load_imei_finish(): loaded IMEI: 354400054096650
ModemManager[19798]: <debug> [1369743351.043170] [mm-broadband-modem.c:3214] modem_3gpp_load_enabled_facility_locks(): loading enabled facility locks...
ModemManager[19798]: <debug> [1369743351.043316] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.043472] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.043658] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK=?<CR>'
ModemManager[19798]: <debug> [1369743351.056874] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CLCK: ("AO","OI","AI","IR","OX","AB","AG","AC","PS","PN","PU","PP","PC","SC","FD")<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.057206] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.057374] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.057562] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK="SC",2<CR>'
ModemManager[19798]: <debug> [1369743351.076933] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CLCK: 1<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.078080] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.078740] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.079452] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK="FD",2<CR>'
ModemManager[19798]: <debug> [1369743351.107079] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CLCK: 0<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.108452] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.109338] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.110280] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK="PS",2<CR>'
ModemManager[19798]: <debug> [1369743351.133684] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF><CR><LF>+CLCK: 0<CR><LF><CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.135835] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.136784] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.137750] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK="PN",2<CR>'
ModemManager[19798]: <debug> [1369743351.161231] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF><CR><LF>+CLCK: 0<CR><LF><CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.162793] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.163669] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.164686] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK="PU",2<CR>'
ModemManager[19798]: <debug> [1369743351.187971] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF><CR><LF>+CLCK: 0<CR><LF><CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.189181] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.190034] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.190973] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK="PP",2<CR>'
ModemManager[19798]: <debug> [1369743351.214853] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF><CR><LF>+CLCK: 0<CR><LF><CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.216043] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.216912] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.217855] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CLCK="PC",2<CR>'
ModemManager[19798]: <debug> [1369743351.242123] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF><CR><LF>+CLCK: 0<CR><LF><CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.246544] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743351.250278] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743351.251389] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CUSD=?<CR>'
ModemManager[19798]: <debug> [1369743351.268854] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CUSD: (0-2)<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.272717] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743351.279603] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743351.280958] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CNMI=?<CR>'
ModemManager[19798]: <debug> [1369743351.298746] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CNMI: (0-2),(0-3),(0-3),(0-2),(0-1)<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.300082] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743351.301338] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743351.302510] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPMS=?<CR>'
ModemManager[19798]: <debug> [1369743351.318991] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPMS: ("BM","ME","SM","SR"),("ME","SM"),("BM","ME","SM","SR")<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743351.320733] [mm-iface-modem-messaging.c:1113] load_supported_storages_ready(): Supported storages loaded:
ModemManager[19798]: <debug> [1369743351.321781] [mm-iface-modem-messaging.c:1114] load_supported_storages_ready():   mem1 (list/read/delete) storages: 'bm, me, sm, sr'
ModemManager[19798]: <debug> [1369743351.322609] [mm-iface-modem-messaging.c:1115] load_supported_storages_ready():   mem2 (write/send) storages:       'me, sm'
ModemManager[19798]: <debug> [1369743351.323297] [mm-iface-modem-messaging.c:1116] load_supported_storages_ready():   mem3 (reception) storages:        'bm, me, sm, sr'
ModemManager[19798]: <debug> [1369743351.326616] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743351.328498] [mm-broadband-modem.c:8708] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
ModemManager[19798]: <debug> [1369743351.329879] [mm-broadband-modem.c:8709] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
ModemManager[19798]: <info>  [1369743351.330940] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (initializing -> disabled)
ModemManager[19798]: <debug> [1369743351.335695] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
ModemManager[19798]: <debug> [1369743351.336508] [mm-serial-port.c:531] mm_serial_port_close(): (ttyACM0) closing serial port...
ModemManager[19798]: <debug> [1369743351.341381] [mm-serial-port.c:558] mm_serial_port_close(): (ttyACM0) serial port closed
ModemManager[19798]: <info>  [1369743413.826296] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
ModemManager[19798]: <debug> [1369743413.827149] [mm-serial-port.c:413] mm_serial_port_open(): (ttyACM0) opening serial port...
ModemManager[19798]: (mm-command-serial-port.c:526):channel_enable: runtime check failed: (self->priv->channel == NULL)
ModemManager[19798]: (mm-command-serial-port.c:530):channel_enable: runtime check failed: (self->priv->watch_id == 0)
ModemManager[19798]: <debug> [1369743413.869049] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
ModemManager[19798]: <debug> [1369743413.869296] [mm-broadband-modem.c:7782] enabling_started(): Flashing primary AT port before enabling...
ModemManager[19798]: <debug> [1369743413.871257] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<LF><LF>+PBREADY<LF><LF>'
ModemManager[19798]: <debug> [1369743413.973449] [mm-broadband-modem.c:7671] enabling_flash_done(): Running modem initialization sequence...
ModemManager[19798]: <debug> [1369743413.974719] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743413.975915] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATZ<CR>'
ModemManager[19798]: <debug> [1369743413.984339] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743413.985518] [mm-broadband-modem.c:7653] enabling_modem_init_ready(): Giving some time to settle the modem...
ModemManager[19798]: <debug> [1369743413.986309] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743414.487229] [mm-at-serial-port.c:448] mm_at_serial_port_run_init_sequence(): (ttyACM0): running init sequence...
ModemManager[19798]: <debug> [1369743414.488189] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743414.488679] [mm-iface-modem.c:2835] modem_power_up_ready(): Modem set in full-power mode...
ModemManager[19798]: <debug> [1369743414.495167] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.496512] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743414.497517] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATE0<CR>'
ModemManager[19798]: <debug> [1369743414.504185] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- 'ATE0'
ModemManager[19798]: <debug> [1369743414.505680] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR>'
ModemManager[19798]: <debug> [1369743414.506839] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.507943] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATV1<CR>'
ModemManager[19798]: <debug> [1369743414.517316] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.518480] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
ModemManager[19798]: <debug> [1369743414.534694] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.535982] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'ATX4<CR>'
ModemManager[19798]: <debug> [1369743414.545327] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.546485] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT&C1<CR>'
ModemManager[19798]: <debug> [1369743414.557184] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.558323] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CFUN=1<CR>'
ModemManager[19798]: <debug> [1369743414.575215] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.576197] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743414.577181] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+IFC=1,1<CR>'
ModemManager[19798]: <debug> [1369743414.595093] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
ModemManager[19798]: <debug> [1369743414.596073] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[19798]: <debug> [1369743414.596852] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.597878] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSCS=?<CR>'
ModemManager[19798]: <debug> [1369743414.614867] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSCS: ("UCS2", "IRA", "HEX", "GSM")<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.616374] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.617292] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.618379] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSCS="UCS2"<CR>'
ModemManager[19798]: <debug> [1369743414.641567] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.642625] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.643921] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.645125] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSCS?<CR>'
ModemManager[19798]: <debug> [1369743414.660075] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.661738] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743414.662884] [mm-broadband-modem.c:8326] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
ModemManager[19798]: <debug> [1369743414.663991] [mm-broadband-modem.c:2414] modem_3gpp_setup_unsolicited_events(): Checking indicator support...
ModemManager[19798]: <debug> [1369743414.665005] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743414.666090] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CIND=?<CR>'
ModemManager[19798]: <debug> [1369743414.686129] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
ModemManager[19798]: <debug> [1369743414.686993] [mm-serial-parsers.c:363] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
ModemManager[19798]: <debug> [1369743414.687528] [mm-broadband-modem.c:2344] cind_format_check_ready(): Marking indications as unsupported: 'Unknown error'
ModemManager[19798]: <debug> [1369743414.688074] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743414.689858] [mm-broadband-modem.c:3378] modem_3gpp_setup_unsolicited_registration_events(): (ttyACM0) setting up 3GPP unsolicited registration messages handlers
ModemManager[19798]: <debug> [1369743414.690787] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743414.691482] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CREG=2<CR>'
ModemManager[19798]: <debug> [1369743414.706636] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.707609] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.708238] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.708933] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGREG=2<CR>'
ModemManager[19798]: <debug> [1369743414.731542] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.733063] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743414.734287] [mm-iface-modem-3gpp.c:745] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[19798]: <debug> [1369743414.734977] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743414.735412] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CREG?<CR>'
ModemManager[19798]: <debug> [1369743414.758381] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CREG: 2,0<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <info>  [1369743414.758763] [mm-iface-modem-3gpp.c:1105] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> idle)
ModemManager[19798]: <debug> [1369743414.759238] [mm-iface-modem.c:1372] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
ModemManager[19798]: <debug> [1369743414.759542] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.759727] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.761379] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGREG?<CR>'
ModemManager[19798]: <debug> [1369743414.774616] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CGREG: 2,4<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.774974] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743414.775228] [mm-broadband-modem.c:8339] enabling_step(): Modem has 3GPP/USSD capabilities, enabling the Modem 3GPP/USSD interface...
ModemManager[19798]: <debug> [1369743414.775403] [mm-broadband-modem.c:4692] set_unsolicited_result_code_handlers(): (ttyACM0) Setting unsolicited result code handlers
ModemManager[19798]: <debug> [1369743414.775611] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743414.775803] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CUSD=1<CR>'
ModemManager[19798]: <debug> [1369743414.788728] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.789007] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743414.790396] [mm-broadband-modem.c:8367] enabling_step(): Modem has location capabilities, enabling the Location interface...
ModemManager[19798]: <debug> [1369743414.790586] [mm-iface-modem-location.c:739] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
ModemManager[19798]: <debug> [1369743414.790874] [mm-iface-modem-3gpp.c:745] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[19798]: <debug> [1369743414.791037] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743414.792368] [mm-broadband-modem.c:8380] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
ModemManager[19798]: <debug> [1369743414.792690] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.792888] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CREG?<CR>'
ModemManager[19798]: <debug> [1369743414.805348] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CREG: 2,0<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.806179] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743414.806588] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743414.807092] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMGF=?<CR>'
ModemManager[19798]: <debug> [1369743414.821613] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CMGF: (0-1)<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.822336] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743414.822819] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743414.823503] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGREG?<CR>'
ModemManager[19798]: <debug> [1369743414.843025] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CGREG: 2,4<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.845770] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.846886] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMGF=0<CR>'
ModemManager[19798]: <debug> [1369743414.863447] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.864947] [mm-broadband-modem.c:5269] cmgf_set_ready(): Successfully set preferred SMS mode: 'PDU'
ModemManager[19798]: <debug> [1369743414.865648] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.866069] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.869141] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPMS="","ME","ME"<CR>'
ModemManager[19798]: <debug> [1369743414.896381] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPMS: 0,20,0,8,0,8<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.896685] [mm-broadband-modem.c:5967] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'bm'
ModemManager[19798]: <debug> [1369743414.896820] [mm-broadband-modem.c:5163] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (BM), mem2 (none)...
ModemManager[19798]: <debug> [1369743414.896980] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.897146] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.897342] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPMS="BM"<CR>'
ModemManager[19798]: <debug> [1369743414.913729] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPMS: 0,8,0,8,0,8<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.913973] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.914142] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.914383] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMGL=4<CR>'
ModemManager[19798]: <debug> [1369743414.926976] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.927244] [mm-broadband-modem.c:5967] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'me'
ModemManager[19798]: <debug> [1369743414.927372] [mm-broadband-modem.c:5163] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (ME), mem2 (none)...
ModemManager[19798]: <debug> [1369743414.927523] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.927683] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.927872] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPMS="ME"<CR>'
ModemManager[19798]: <debug> [1369743414.944361] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPMS: 0,8,0,8,0,8<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.944590] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.944757] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.944957] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMGL=4<CR>'
ModemManager[19798]: <debug> [1369743414.957861] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.958153] [mm-broadband-modem.c:5967] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'sm'
ModemManager[19798]: <debug> [1369743414.958284] [mm-broadband-modem.c:5163] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SM), mem2 (none)...
ModemManager[19798]: <debug> [1369743414.958471] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.958634] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.958828] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPMS="SM"<CR>'
ModemManager[19798]: <debug> [1369743414.975738] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPMS: 0,20,0,8,0,8<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.975984] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.976150] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.976340] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMGL=4<CR>'
ModemManager[19798]: <debug> [1369743414.996264] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743414.996784] [mm-broadband-modem.c:5967] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'sr'
ModemManager[19798]: <debug> [1369743414.997025] [mm-broadband-modem.c:5163] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SR), mem2 (none)...
ModemManager[19798]: <debug> [1369743414.997268] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743414.997526] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743414.997811] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CPMS="SR"<CR>'
ModemManager[19798]: <debug> [1369743415.014493] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CPMS: 0,8,0,8,0,8<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743415.014844] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743415.015106] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743415.015384] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CMGL=4<CR>'
ModemManager[19798]: <debug> [1369743415.034479] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743415.034904] [mm-broadband-modem.c:5575] set_messaging_unsolicited_events_handlers(): (ttyACM0) Setting messaging unsolicited events handlers
ModemManager[19798]: <debug> [1369743415.035205] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <debug> [1369743415.035519] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743415.035803] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CNMI=2,1,2,1,0<CR>'
ModemManager[19798]: <debug> [1369743415.058882] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743415.059100] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
ModemManager[19798]: <info>  [1369743415.059273] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> enabled)
ModemManager[19798]: <info>  [1369743424.330103] [mm-iface-modem-simple.c:779] connect_auth_ready(): Simple connect started...
ModemManager[19798]: <debug> [1369743424.330372] [mm-iface-modem-simple.c:793] connect_auth_ready():    PIN: unspecified
ModemManager[19798]: <debug> [1369743424.330512] [mm-iface-modem-simple.c:803] connect_auth_ready():    Allowed mode: unspecified
ModemManager[19798]: <debug> [1369743424.330633] [mm-iface-modem-simple.c:804] connect_auth_ready():    Preferred mode: unspecified
ModemManager[19798]: <debug> [1369743424.330773] [mm-iface-modem-simple.c:809] connect_auth_ready():    Bands: unknown
ModemManager[19798]: <debug> [1369743424.330949] [mm-iface-modem-simple.c:814] connect_auth_ready():    Operator ID: unspecified
ModemManager[19798]: <debug> [1369743424.331077] [mm-iface-modem-simple.c:816] connect_auth_ready():    Allowed roaming: yes
ModemManager[19798]: <debug> [1369743424.331202] [mm-iface-modem-simple.c:818] connect_auth_ready():    APN: internet.netcom.no
ModemManager[19798]: <debug> [1369743424.331325] [mm-iface-modem-simple.c:824] connect_auth_ready():    IP family: unspecified
ModemManager[19798]: <debug> [1369743424.331448] [mm-iface-modem-simple.c:832] connect_auth_ready():    Allowed authentication: unspecified
ModemManager[19798]: <debug> [1369743424.331572] [mm-iface-modem-simple.c:835] connect_auth_ready():    User: unspecified
ModemManager[19798]: <debug> [1369743424.331691] [mm-iface-modem-simple.c:837] connect_auth_ready():    Password: unspecified
ModemManager[19798]: <debug> [1369743424.331815] [mm-iface-modem-simple.c:839] connect_auth_ready():    Number: unspecified
ModemManager[19798]: <info>  [1369743424.331927] [mm-iface-modem-simple.c:552] connection_step(): Simple connect state (4/10): Wait to get fully enabled
ModemManager[19798]: <info>  [1369743424.332121] [mm-iface-modem-simple.c:564] connection_step(): Simple connect state (5/10): Allowed mode
ModemManager[19798]: <info>  [1369743424.332237] [mm-iface-modem-simple.c:587] connection_step(): Simple connect state (6/10): Bands
ModemManager[19798]: <info>  [1369743424.332352] [mm-iface-modem-simple.c:616] connection_step(): Simple connect state (7/10): Register
ModemManager[19798]: <debug> [1369743424.332515] [mm-iface-modem-3gpp.c:391] mm_iface_modem_3gpp_register_in_network(): Launching automatic network registration...
ModemManager[19798]: <debug> [1369743424.332680] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
ModemManager[19798]: <debug> [1369743424.332887] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+COPS=0<CR>'
ModemManager[19798]: <debug> [1369743429.371413] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF><CR><LF>+CREG: 1,"10D1","012CE303",4<CR><LF>'
ModemManager[19798]: <info>  [1369743429.372334] [mm-iface-modem-3gpp.c:1090] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (idle -> registering)
ModemManager[19798]: <debug> [1369743429.372670] [mm-broadband-modem.c:3250] modem_3gpp_load_operator_code(): loading Operator Code...
ModemManager[19798]: <debug> [1369743429.373008] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <info>  [1369743429.373842] [mm-iface-modem.c:726] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> hsdpa)
ModemManager[19798]: <debug> [1369743429.374559] [mm-iface-modem-3gpp.c:745] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
ModemManager[19798]: <debug> [1369743429.374915] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743429.375249] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743429.384525] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+COPS=3,2;+COPS?<CR>'
ModemManager[19798]: <debug> [1369743429.409531] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CREG: 1,"10D1","012CE303",4<CR><LF><CR><LF>+CGREG: 1,"10D1","012CE303",4,"E6"<CR><LF>'
ModemManager[19798]: <debug> [1369743429.412892] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+COPS: 0,2,"24202",2<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743429.414116] [mm-broadband-modem.c:3240] modem_3gpp_load_operator_code_finish(): loaded Operator Code: 24202
ModemManager[19798]: <info>  [1369743429.415371] [mm-iface-modem-location.c:293] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '242', MNC: '2', Location area code: '0', Cell ID: '0')
ModemManager[19798]: <debug> [1369743429.416333] [mm-broadband-modem.c:3286] modem_3gpp_load_operator_name(): loading Operator Name...
ModemManager[19798]: <debug> [1369743429.417257] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743429.418107] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743429.425156] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CREG?<CR>'
ModemManager[19798]: <debug> [1369743429.438318] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CREG: 2,1,"10D1","012CE303",4<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <info>  [1369743429.439096] [mm-iface-modem-location.c:293] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '0', Cell ID: '0')
ModemManager[19798]: <debug> [1369743429.439836] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743429.440394] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743429.440937] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+COPS=3,0;+COPS?<CR>'
ModemManager[19798]: <debug> [1369743429.466746] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+COPS: 0,0,"N NetCom",2<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743429.468116] [mm-broadband-modem.c:3276] modem_3gpp_load_operator_name_finish(): loaded Operator Name: N NetCom
ModemManager[19798]: <debug> [1369743429.469183] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <info>  [1369743429.474671] [mm-iface-modem-3gpp.c:1023] update_registration_reload_current_operator_ready(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
ModemManager[19798]: <info>  [1369743429.476010] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabled -> registered)
ModemManager[19798]: <debug> [1369743429.485767] [mm-iface-modem.c:1127] periodic_signal_quality_check_enable(): Periodic signal quality checks enabled (interval = 3s)
ModemManager[19798]: <debug> [1369743429.486289] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743429.486742] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743429.487200] [mm-iface-modem.c:844] periodic_access_technologies_check_enable(): Periodic access technology checks enabled
ModemManager[19798]: <debug> [1369743429.490049] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGREG?<CR>'
ModemManager[19798]: <debug> [1369743429.506344] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CGREG: 2,1,"10D1","012CE303",4,"E6"<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <info>  [1369743429.507108] [mm-iface-modem-location.c:293] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '10D1', Cell ID: '12CE303')
ModemManager[19798]: <debug> [1369743429.507708] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743429.508264] [mm-iface-modem-3gpp.c:259] run_registration_checks_ready(): Modem is currently registered in a 3GPP network
ModemManager[19798]: <info>  [1369743429.508921] [mm-iface-modem-simple.c:639] connection_step(): Simple connect state (8/10): Bearer
ModemManager[19798]: <debug> [1369743429.509348] [mm-iface-modem-simple.c:659] connection_step(): Creating new bearer...
ModemManager[19798]: <debug> [1369743429.509783] [infineon/mm-broadband-modem-infineon.c:85] modem_create_bearer(): Creating Infineon bearer...
ModemManager[19798]: <debug> [1369743429.512243] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743429.512787] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743429.513573] [infineon/mm-broadband-modem-infineon.c:48] modem_create_bearer_finish(): New Infineon bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[19798]: <info>  [1369743429.514118] [mm-iface-modem-simple.c:721] connection_step(): Simple connect state (9/10): Connect
ModemManager[19798]: <debug> [1369743429.514604] [mm-bearer.c:586] mm_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[19798]: <info>  [1369743429.515073] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
ModemManager[19798]: <debug> [1369743429.520484] [mm-broadband-bearer.c:173] detailed_connect_context_new(): No specific IP family requested, defaulting to ipv4
ModemManager[19798]: <debug> [1369743429.520978] [mm-broadband-bearer.c:1015] connect_3gpp(): Looking for best CID...
ModemManager[19798]: <debug> [1369743429.521409] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743429.521943] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743429.532822] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 17,1<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743429.533192] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <info>  [1369743429.533745] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (54)
ModemManager[19798]: <debug> [1369743429.533890] [mm-iface-modem.c:1046] signal_quality_check_ready(): Periodic signal quality checks rescheduled (interval = 30s)
ModemManager[19798]: <debug> [1369743429.537531] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGDCONT?<CR>'
ModemManager[19798]: <debug> [1369743429.555647] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743429.556202] [mm-broadband-bearer.c:932] parse_pdp_list(): No PDP contexts found
ModemManager[19798]: <debug> [1369743429.556640] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGDCONT=?<CR>'
ModemManager[19798]: <debug> [1369743429.574383] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CGDCONT: (1-20),"IP",,,(0,1,2),(0,1,2,3,4)<CR><LF><CR><LF>+CGDCONT: (1-20),"IPV6",,,(0,1,2),(0,1,2,3,4)<CR><LF><CR><LF>+CGDCONT: (1-20),"IPV4V6",,,(0,1,2),(0,1,2,3,4)<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743429.574962] [mm-broadband-bearer.c:891] parse_cid_range(): Using CID 1
ModemManager[19798]: <debug> [1369743429.575347] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743429.575672] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
ModemManager[19798]: <debug> [1369743429.576051] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CGDCONT=1,"IP","internet.netcom.no"<CR>'
ModemManager[19798]: <debug> [1369743429.629718] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743429.630540] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
ModemManager[19798]: <debug> [1369743429.631155] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743429.631727] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743429.632430] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+XGAUTH=1,0,"",""<CR>'
ModemManager[19798]: <debug> [1369743429.672302] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
ModemManager[19798]: (infineon/mm-broadband-bearer-infineon.c:422):authenticate_ready: code should not be reached
ModemManager[19798]: <debug> [1369743429.674429] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: mm_at_serial_port_queue_command: assertion `command != NULL' failed
ModemManager[19798]: <debug> [1369743429.675521] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <debug> [1369743459.724735] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743459.725360] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743459.726012] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743459.737983] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 16,2<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743459.738918] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <info>  [1369743459.740145] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (51)
ModemManager[19798]: <debug> [1369743489.696869] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743489.697676] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743489.698314] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743489.711558] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 19,1<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743489.712904] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <info>  [1369743489.714558] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (61)
ModemManager[19798]: <debug> [1369743519.724785] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743519.725435] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743519.726156] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743519.792290] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 19,1<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743519.793079] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <info>  [1369743519.794052] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (61)
ModemManager[19798]: <debug> [1369743549.724847] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743549.725527] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743549.726227] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743549.739380] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 19,1<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743549.740662] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <info>  [1369743549.742162] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (61)
ModemManager[19798]: <info>  [1369743571.648517] [mm-iface-modem-simple.c:779] connect_auth_ready(): Simple connect started...
ModemManager[19798]: <debug> [1369743571.648724] [mm-iface-modem-simple.c:793] connect_auth_ready():    PIN: unspecified
ModemManager[19798]: <debug> [1369743571.648786] [mm-iface-modem-simple.c:803] connect_auth_ready():    Allowed mode: unspecified
ModemManager[19798]: <debug> [1369743571.648837] [mm-iface-modem-simple.c:804] connect_auth_ready():    Preferred mode: unspecified
ModemManager[19798]: <debug> [1369743571.648894] [mm-iface-modem-simple.c:809] connect_auth_ready():    Bands: unknown
ModemManager[19798]: <debug> [1369743571.648945] [mm-iface-modem-simple.c:814] connect_auth_ready():    Operator ID: unspecified
ModemManager[19798]: <debug> [1369743571.648997] [mm-iface-modem-simple.c:816] connect_auth_ready():    Allowed roaming: yes
ModemManager[19798]: <debug> [1369743571.649050] [mm-iface-modem-simple.c:818] connect_auth_ready():    APN: internet.netcom.no
ModemManager[19798]: <debug> [1369743571.649102] [mm-iface-modem-simple.c:824] connect_auth_ready():    IP family: unspecified
ModemManager[19798]: <debug> [1369743571.649154] [mm-iface-modem-simple.c:832] connect_auth_ready():    Allowed authentication: unspecified
ModemManager[19798]: <debug> [1369743571.649207] [mm-iface-modem-simple.c:835] connect_auth_ready():    User: unspecified
ModemManager[19798]: <debug> [1369743571.649257] [mm-iface-modem-simple.c:837] connect_auth_ready():    Password: unspecified
ModemManager[19798]: <debug> [1369743571.650240] [mm-iface-modem-simple.c:839] connect_auth_ready():    Number: unspecified
ModemManager[19798]: <info>  [1369743571.650304] [mm-iface-modem-simple.c:552] connection_step(): Simple connect state (4/10): Wait to get fully enabled
ModemManager[19798]: <info>  [1369743571.650432] [mm-iface-modem-simple.c:564] connection_step(): Simple connect state (5/10): Allowed mode
ModemManager[19798]: <info>  [1369743571.650492] [mm-iface-modem-simple.c:587] connection_step(): Simple connect state (6/10): Bands
ModemManager[19798]: <info>  [1369743571.650544] [mm-iface-modem-simple.c:616] connection_step(): Simple connect state (7/10): Register
ModemManager[19798]: <debug> [1369743571.650639] [mm-iface-modem-3gpp.c:384] mm_iface_modem_3gpp_register_in_network(): Already registered in network '24202', automatic registration not launched...
ModemManager[19798]: <info>  [1369743571.650776] [mm-iface-modem-simple.c:639] connection_step(): Simple connect state (8/10): Bearer
ModemManager[19798]: <debug> [1369743571.650858] [mm-iface-modem-simple.c:712] connection_step(): Using already existing bearer at '/org/freedesktop/ModemManager1/Bearer/0'...
ModemManager[19798]: <info>  [1369743571.650915] [mm-iface-modem-simple.c:721] connection_step(): Simple connect state (9/10): Connect
ModemManager[19798]: <debug> [1369743571.651026] [mm-iface-modem-simple.c:228] connect_bearer_ready(): Couldn't connect bearer: 'Bearer already being connected'
ModemManager[19798]: <debug> [1369743579.698753] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743579.699295] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743579.699669] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743579.712256] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 18,2<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743579.713017] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <info>  [1369743579.714025] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (58)
ModemManager[19798]: <debug> [1369743609.724552] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743609.724951] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743609.725466] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743609.794456] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 19,2<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743609.797760] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <info>  [1369743609.801894] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (61)
ModemManager[19798]: <debug> [1369743639.724735] [mm-broadband-modem.c:1833] modem_load_signal_quality(): loading signal quality...
ModemManager[19798]: <debug> [1369743639.725418] [mm-serial-port.c:477] mm_serial_port_open(): (ttyACM0) device open count is 4 (open)
ModemManager[19798]: <debug> [1369743639.726062] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): --> 'AT+CSQ<CR>'
ModemManager[19798]: <debug> [1369743639.739124] [mm-at-serial-port.c:411] debug_log(): (ttyACM0): <-- '<CR><LF>+CSQ: 19,1<CR><LF><CR><LF>OK<CR><LF>'
ModemManager[19798]: <debug> [1369743639.740415] [mm-serial-port.c:523] mm_serial_port_close(): (ttyACM0) device open count is 3 (close)
ModemManager[19798]: <info>  [1369743639.741917] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (61)
ModemManager[19798]: <info>  [1369743667.448531] [main.c:46] quit_cb(): Caught signal, shutting down...
ModemManager[19798]: <info>  [1369743667.449827] [mm-iface-modem.c:1203] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> disabling)
ModemManager[19798]: <info>  [1369743667.456735] [mm-iface-modem.c:976] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (0)
ModemManager[19798]: <debug> [1369743667.457879] [mm-iface-modem.c:1093] periodic_signal_quality_check_disable(): Periodic signal quality checks disabled
ModemManager[19798]: <info>  [1369743667.459024] [mm-iface-modem.c:726] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (hsdpa -> unknown)
ModemManager[19798]: <debug> [1369743667.459948] [mm-iface-modem.c:816] periodic_access_technologies_check_disable(): Periodic access technology checks disabled
ModemManager[19798]: <debug> [1369743667.460855] [mm-bearer.c:756] mm_bearer_disconnect(): Disconnecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[19798]: <warn>  [1369743687.449826] [main.c:169] main(): Disabling modems took too long, shutting down with '1' modems around
ModemManager[19798]: <info>  [1369743687.490924] [main.c:179] main(): ModemManager is shut down
