tr@tr-lp:~$ sudo /ModemManager --debug notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '4D8D', Cell ID: '65415B6') ModemManager[21583]: [1416847879.516686] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 5 (open) ModemManager[21583]: [1416847879.516753] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 4 (close) ModemManager[21583]: [1416847879.516823] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+COPS=3,2;+COPS?' ModemManager[21583]: [1416847879.540740] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+COPS: 0,2,"25001",2OK' ModemManager[21583]: [1416847879.540986] [mm-broadband-modem.c:3388] modem_3gpp_load_operator_code_finish(): loaded Operator Code: 25001 ModemManager[21583]: [1416847879.541113] [mm-iface-modem-location.c:293] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '250', MNC: '1', Location area code: '4D8D', Cell ID: '65415B6') ModemManager[21583]: [1416847879.541181] [huawei/mm-broadband-modem-huawei.c:2001] modem_3gpp_load_operator_name(): loading Operator Name (huawei)... ModemManager[21583]: [1416847879.541247] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 5 (open) ModemManager[21583]: [1416847879.541324] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 4 (close) ModemManager[21583]: [1416847879.541408] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CMGF=?' ModemManager[21583]: [1416847879.552761] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CMGF: (0,1)OK' ModemManager[21583]: [1416847879.553045] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 5 (open) ModemManager[21583]: [1416847879.553134] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 4 (close) ModemManager[21583]: [1416847879.553221] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CGREG?' ModemManager[21583]: [1416847879.564017] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CGREG: 2,1,"4D8D","065415B6"OK' ModemManager[21583]: [1416847879.564446] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 3 (close) ModemManager[21583]: [1416847879.564648] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+COPS=3,0;+COPS?' ModemManager[21583]: [1416847879.587483] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+COPS: 0,0,"MTS RUS",2OK' ModemManager[21583]: [1416847879.587950] [huawei/mm-broadband-modem-huawei.c:1991] modem_3gpp_load_operator_name_finish(): loaded Operator Name: MTS RUS ModemManager[21583]: [1416847879.588163] [mm-broadband-modem.c:3476] modem_3gpp_load_subscription_state(): Load subscription state: Marking the SIM as provisioned. ModemManager[21583]: [1416847879.588320] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.588543] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CMGF=0' ModemManager[21583]: [1416847879.603683] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- 'OK' ModemManager[21583]: [1416847879.603886] [mm-broadband-modem.c:5460] cmgf_set_ready(): Successfully set preferred SMS mode: 'PDU' ModemManager[21583]: [1416847879.604165] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847879.604763] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.605151] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CPMS="","ME","ME"' ModemManager[21583]: [1416847879.632932] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CMS ERROR: 302' ModemManager[21583]: [1416847879.633203] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 302: Operation not allowed ModemManager[21583]: [1416847879.633299] [mm-iface-modem-messaging.c:792] set_default_storage_ready(): Couldn't set default storage: 'Operation not allowed' ModemManager[21583]: [1416847879.633354] [mm-broadband-modem.c:6158] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'sm' ModemManager[21583]: [1416847879.633400] [mm-broadband-modem.c:5354] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (SM), mem2 (none)... ModemManager[21583]: [1416847879.633464] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847879.633530] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.633598] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CPMS="SM"' ModemManager[21583]: [1416847879.652836] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CPMS: 0,5,0,5,0,5OK' ModemManager[21583]: [1416847879.653026] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847879.653093] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.653150] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CMGL=4' ModemManager[21583]: [1416847879.665018] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- 'OK' ModemManager[21583]: [1416847879.665409] [mm-broadband-modem.c:6158] modem_messaging_load_initial_sms_parts(): Listing SMS parts in storage 'me' ModemManager[21583]: [1416847879.665578] [mm-broadband-modem.c:5354] mm_broadband_modem_lock_sms_storages(): Locking SMS storages to: mem1 (ME), mem2 (none)... ModemManager[21583]: [1416847879.665744] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847879.665940] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.666106] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CPMS="ME"' ModemManager[21583]: [1416847879.681763] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CPMS: 0,20,0,5,0,5OK' ModemManager[21583]: [1416847879.682229] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847879.682472] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.682671] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CMGL=4' ModemManager[21583]: [1416847879.694136] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- 'OK' ModemManager[21583]: [1416847879.694406] [mm-broadband-modem.c:5766] set_messaging_unsolicited_events_handlers(): (ttyUSB0) Setting messaging unsolicited events handlers ModemManager[21583]: [1416847879.694476] [mm-broadband-modem.c:5766] set_messaging_unsolicited_events_handlers(): (ttyUSB1) Setting messaging unsolicited events handlers ModemManager[21583]: [1416847879.694553] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847879.694656] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847879.694752] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CNMI=2,1,2,1,0' ModemManager[21583]: [1416847879.715975] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CMS ERROR: 303' ModemManager[21583]: [1416847879.716123] [mm-serial-parsers.c:364] mm_serial_parser_v1_parse(): Got failure code 303: Operation not supported ModemManager[21583]: [1416847879.716248] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CNMI=2,1,2,2,0' ModemManager[21583]: [1416847879.740617] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- 'OK' ModemManager[21583]: [1416847879.740786] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847879.740919] [mm-iface-modem.c:1371] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) ModemManager[21583]: [1416847879.741218] [mm-iface-modem.c:1295] periodic_signal_quality_check_enable(): Periodic signal quality checks enabled (interval = 3s) ModemManager[21583]: [1416847879.741279] [huawei/mm-broadband-modem-huawei.c:2333] modem_load_signal_quality(): loading signal quality... ModemManager[21583]: [1416847879.741324] [mm-broadband-modem.c:1980] modem_load_signal_quality(): loading signal quality... ModemManager[21583]: [1416847879.741372] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847879.741420] [mm-iface-modem.c:1012] periodic_access_technologies_check_enable(): Periodic access technology checks enabled ModemManager[21583]: [1416847879.741458] [huawei/mm-broadband-modem-huawei.c:559] load_access_technologies(): loading access technology (huawei)... ModemManager[21583]: [1416847879.741497] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847879.743836] [mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled ModemManager[21583]: [1416847879.745250] [mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register ModemManager[21583]: [1416847879.745352] [mm-iface-modem-3gpp.c:388] mm_iface_modem_3gpp_register_in_network(): Already registered in network '25001', automatic registration not launched... ModemManager[21583]: [1416847879.745447] [mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer ModemManager[21583]: [1416847879.745513] [mm-iface-modem-simple.c:521] connection_step(): Creating new bearer... ModemManager[21583]: [1416847879.745580] [huawei/mm-broadband-modem-huawei.c:2147] huawei_modem_create_bearer(): Creating default bearer... ModemManager[21583]: [1416847879.752614] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 4 (open) ModemManager[21583]: [1416847879.752749] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 3 (close) ModemManager[21583]: [1416847879.752843] [huawei/mm-broadband-modem-huawei.c:2040] huawei_modem_create_bearer_finish(): New huawei bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0' ModemManager[21583]: [1416847879.752990] [mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect ModemManager[21583]: [1416847879.753025] [mm-bearer.c:591] mm_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0' ModemManager[21583]: [1416847879.753063] [mm-iface-modem.c:1371] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) ModemManager[21583]: [1416847879.753270] [mm-broadband-bearer.c:1230] connect(): Launching 3GPP connection attempt with APN 'internet.mts.ru' ModemManager[21583]: [1416847879.757506] [mm-broadband-bearer.c:177] detailed_connect_context_new(): No specific IP family requested, defaulting to ipv4 ModemManager[21583]: [1416847879.757555] [mm-broadband-bearer.c:1020] connect_3gpp(): Looking for best CID... ModemManager[21583]: [1416847879.757596] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 4 (open) ModemManager[21583]: [1416847879.757661] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CSQ' ModemManager[21583]: [1416847879.765733] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CSQ: 11,99OK' ModemManager[21583]: [1416847879.765899] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 3 (close) ModemManager[21583]: [1416847879.766027] [mm-iface-modem.c:1144] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (35) ModemManager[21583]: [1416847879.766069] [mm-iface-modem.c:1214] signal_quality_check_ready(): Periodic signal quality checks rescheduled (interval = 30s) ModemManager[21583]: [1416847879.766220] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT^SYSINFOEX' ModemManager[21583]: [1416847879.780332] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '^SYSINFOEX:2,3,0,1,,3,"WCDMA",41,"WCDMA"OK' ModemManager[21583]: [1416847879.780558] [huawei/mm-broadband-modem-huawei.c:546] load_access_technologies_finish(): Access Technology: 'umts' ModemManager[21583]: [1416847879.780666] [mm-iface-modem.c:894] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> umts) ModemManager[21583]: [1416847879.780712] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.780869] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CGDCONT?' ModemManager[21583]: [1416847879.793838] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- '+CGDCONT: 0,"IP","","",0,0,0,0+CGDCONT: 1,"IP","internet.mts.ru","",0,0,0,0+CGDCONT: 2,"IP","internet.mts.ru","",0,0,0,0OK' ModemManager[21583]: [1416847879.794095] [mm-broadband-bearer.c:937] parse_pdp_list(): Found '3' PDP contexts ModemManager[21583]: [1416847879.794147] [mm-broadband-bearer.c:946] parse_pdp_list(): PDP context [cid=0] [type='ipv4'] [apn=''] ModemManager[21583]: [1416847879.794180] [mm-broadband-bearer.c:946] parse_pdp_list(): PDP context [cid=1] [type='ipv4'] [apn='internet.mts.ru'] ModemManager[21583]: [1416847879.794212] [mm-broadband-bearer.c:946] parse_pdp_list(): PDP context [cid=2] [type='ipv4'] [apn='internet.mts.ru'] ModemManager[21583]: [1416847879.794242] [mm-broadband-bearer.c:958] parse_pdp_list(): Found PDP context with CID 0 and no APN ModemManager[21583]: [1416847879.794273] [mm-broadband-bearer.c:970] parse_pdp_list(): Found PDP context with CID 1 and PDP type ipv4 for APN 'internet.mts.ru' ModemManager[21583]: [1416847879.794323] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847879.794354] [mm-broadband-bearer.c:214] common_get_at_data_port(): Connection through a plain serial AT port (ttyUSB0) ModemManager[21583]: [1416847879.794402] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 4 (open) ModemManager[21583]: [1416847879.794450] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 3 (close) ModemManager[21583]: [1416847879.794500] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'ATD*99***1#' ModemManager[21583]: [1416847879.811234] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): <-- 'CONNECT 43200000' ModemManager[21583]: [1416847879.811597] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847879.811783] [mm-port.c:138] mm_port_set_connected(): (ttyUSB0): port now connected ModemManager[21583]: [1416847879.811913] [mm-bearer.c:489] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0' ModemManager[21583]: [1416847879.812135] [mm-iface-modem.c:1371] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) ModemManager[21583]: [1416847879.812510] [mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done ModemManager[21583]: [1416847879.870081] [mm-manager.c:270] device_added(): (net/ppp0): could not get port's parent device ModemManager[21583]: [1416847900.516458] [mm-bearer.c:761] mm_bearer_disconnect(): Disconnecting bearer '/org/freedesktop/ModemManager1/Bearer/0' ModemManager[21583]: [1416847900.516660] [mm-iface-modem.c:1371] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) ModemManager[21583]: [1416847900.517808] [mm-broadband-bearer.c:1593] disconnect_3gpp(): Sending PDP context deactivation in secondary port... ModemManager[21583]: [1416847900.518117] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB1) device open count is 2 (open) ModemManager[21583]: [1416847900.518273] [mm-at-serial-port.c:436] debug_log(): (ttyUSB1): --> 'AT+CGACT=0,1' ModemManager[21583]: [1416847900.578599] [mm-at-serial-port.c:436] debug_log(): (ttyUSB1): <-- 'OK' ModemManager[21583]: [1416847900.578972] [mm-broadband-bearer.c:1516] data_reopen_3gpp(): Reopening data port (ttyUSB0)... ModemManager[21583]: [1416847900.579187] [mm-serial-port.c:1337] mm_serial_port_reopen(): (ttyUSB0) reopening port (2) ModemManager[21583]: [1416847900.579366] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847900.579501] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close) ModemManager[21583]: [1416847900.579630] [mm-serial-port.c:1040] mm_serial_port_close(): (ttyUSB0) closing serial port... ModemManager[21583]: [1416847900.579792] [mm-port.c:138] mm_port_set_connected(): (ttyUSB0): port now disconnected ModemManager[21583]: [1416847900.579975] [mm-serial-port.c:1073] mm_serial_port_close(): (ttyUSB0) serial port closed ModemManager[21583]: [1416847900.580134] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB1) device open count is 1 (close) ModemManager[21583]: [1416847901.581347] [mm-serial-port.c:901] mm_serial_port_open(): (ttyUSB0) opening serial port... ModemManager[21583]: [1416847901.582455] [mm-serial-port.c:416] real_config_fd(): (ttyUSB0): port attributes not fully set ModemManager[21583]: [1416847901.582532] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open) ModemManager[21583]: [1416847901.582556] [mm-at-serial-port.c:473] mm_at_serial_port_run_init_sequence(): (ttyUSB0): running init sequence... ModemManager[21583]: [1416847901.582590] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847901.582610] [mm-broadband-bearer.c:1504] data_reopen_3gpp_ready(): Flashing data port (ttyUSB0)... ModemManager[21583]: [1416847901.582653] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'ATE0' ModemManager[21583]: [1416847902.583124] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847902.583203] [mm-broadband-bearer.c:1472] data_flash_3gpp_ready(): PDP disconnection already sent ModemManager[21583]: [1416847902.583277] [mm-bearer.c:694] disconnect_ready(): Disconnected bearer '/org/freedesktop/ModemManager1/Bearer/0' ModemManager[21583]: [1416847902.583373] [mm-iface-modem.c:1371] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) ModemManager[21583]: [1416847905.318948] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'ATV1' ModemManager[21583]: [1416847909.031659] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CMEE=1' ModemManager[21583]: [1416847909.495786] [huawei/mm-broadband-modem-huawei.c:559] load_access_technologies(): loading access technology (huawei)... ModemManager[21583]: [1416847909.496109] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847910.496519] [huawei/mm-broadband-modem-huawei.c:2333] modem_load_signal_quality(): loading signal quality... ModemManager[21583]: [1416847910.496638] [mm-broadband-modem.c:1980] modem_load_signal_quality(): loading signal quality... ModemManager[21583]: [1416847910.496833] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847912.745032] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'ATX4' ModemManager[21583]: [1416847916.460457] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT&C1' ModemManager[21583]: [1416847920.185652] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT^SYSINFOEX' ModemManager[21583]: [1416847923.898419] [huawei/mm-broadband-modem-huawei.c:242] run_sysinfoex_ready(): ^SYSINFOEX failed: Sending command failed: 'Resource temporarily unavailable' ModemManager[21583]: [1416847923.898701] [mm-iface-modem.c:934] access_technologies_check_ready(): Couldn't refresh access technologies: 'Sending command failed: 'Resource temporarily unavailable'' ModemManager[21583]: [1416847923.898870] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847923.899057] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CSQ' ModemManager[21583]: [1416847927.617780] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847927.618001] [mm-iface-modem.c:1200] signal_quality_check_ready(): Couldn't refresh signal quality: 'Sending command failed: 'Resource temporarily unavailable'' ModemManager[21583]: [1416847939.508187] [huawei/mm-broadband-modem-huawei.c:559] load_access_technologies(): loading access technology (huawei)... ModemManager[21583]: [1416847939.508597] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847939.508791] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT^SYSINFOEX' ModemManager[21583]: [1416847940.496792] [mm-iface-modem.c:1080] expire_signal_quality(): Signal quality value not updated in 60s, marking as not being recent ModemManager[21583]: [1416847940.497071] [huawei/mm-broadband-modem-huawei.c:2333] modem_load_signal_quality(): loading signal quality... ModemManager[21583]: [1416847940.497194] [mm-broadband-modem.c:1980] modem_load_signal_quality(): loading signal quality... ModemManager[21583]: [1416847940.497311] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847943.244203] [huawei/mm-broadband-modem-huawei.c:242] run_sysinfoex_ready(): ^SYSINFOEX failed: Sending command failed: 'Resource temporarily unavailable' ModemManager[21583]: [1416847943.244513] [mm-iface-modem.c:934] access_technologies_check_ready(): Couldn't refresh access technologies: 'Sending command failed: 'Resource temporarily unavailable'' ModemManager[21583]: [1416847943.244680] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847943.244888] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CSQ' ^CModemManager[21583]: [1416847943.733501] [main.c:46] quit_cb(): Caught signal, shutting down... ModemManager[21583]: [1416847943.733892] [mm-iface-modem.c:1371] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) ModemManager[21583]: [1416847943.736393] [mm-iface-modem.c:1144] update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (0) ModemManager[21583]: [1416847943.736560] [mm-iface-modem.c:1261] periodic_signal_quality_check_disable(): Periodic signal quality checks disabled ModemManager[21583]: [1416847943.736807] [mm-iface-modem.c:894] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (umts -> unknown) ModemManager[21583]: [1416847943.736967] [mm-iface-modem.c:984] periodic_access_technologies_check_disable(): Periodic access technology checks disabled ModemManager[21583]: [1416847943.737602] [mm-broadband-modem.c:8239] disabling_step(): Modem has messaging capabilities, disabling the Messaging interface... ModemManager[21583]: [1416847943.739189] [mm-broadband-modem.c:5766] set_messaging_unsolicited_events_handlers(): (ttyUSB0) Removing messaging unsolicited events handlers ModemManager[21583]: [1416847943.739318] [mm-broadband-modem.c:5766] set_messaging_unsolicited_events_handlers(): (ttyUSB1) Removing messaging unsolicited events handlers ModemManager[21583]: [1416847943.739816] [mm-broadband-modem.c:8251] disabling_step(): Modem has location capabilities, disabling the Location interface... ModemManager[21583]: [1416847943.739917] [mm-iface-modem-location.c:745] setup_gathering(): Need to disable the following location sources: '3gpp-lac-ci' ModemManager[21583]: [1416847943.739992] [mm-iface-modem-location.c:660] setup_gathering_step(): Disabled location '3gpp-lac-ci' gathering... ModemManager[21583]: [1416847943.740384] [mm-broadband-modem.c:8279] disabling_step(): Modem has 3GPP/USSD capabilities, disabling the Modem 3GPP/USSD interface... ModemManager[21583]: [1416847943.740985] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open) ModemManager[21583]: [1416847946.640712] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close) ModemManager[21583]: [1416847946.641122] [mm-iface-modem.c:1200] signal_quality_check_ready(): Couldn't refresh signal quality: 'Sending command failed: 'Resource temporarily unavailable'' ModemManager[21583]: [1416847946.641415] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CUSD=0' ModemManager[21583]: [1416847949.923308] [mm-iface-modem-3gpp-ussd.c:509] disable_unsolicited_result_codes_ready(): Couldn't disable unsolicited result codes: 'Sending command failed: 'Resource temporarily unavailable'' ModemManager[21583]: [1416847949.923530] [mm-broadband-modem.c:4883] set_unsolicited_result_code_handlers(): (ttyUSB0) Removing unsolicited result code handlers ModemManager[21583]: [1416847949.923736] [mm-broadband-modem.c:4883] set_unsolicited_result_code_handlers(): (ttyUSB1) Removing unsolicited result code handlers ModemManager[21583]: [1416847949.924075] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847949.926209] [mm-broadband-modem.c:8291] disabling_step(): Modem has 3GPP capabilities, disabling the Modem 3GPP interface... ModemManager[21583]: [1416847949.927660] [mm-iface-modem-3gpp.c:1308] periodic_registration_check_disable(): Periodic 3GPP registration checks disabled ModemManager[21583]: [1416847949.927885] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847949.928152] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CREG=0' ModemManager[21583]: [1416847953.305030] [mm-broadband-modem.c:4183] unsolicited_registration_events_sequence_ready(): Disabling unsolicited registration events in primary port failed: 'AT sequence failed' ModemManager[21583]: [1416847953.305234] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB1) device open count is 2 (open) ModemManager[21583]: [1416847953.305425] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847953.305676] [mm-at-serial-port.c:436] debug_log(): (ttyUSB1): --> 'AT+CREG=0' ModemManager[21583]: [1416847953.358391] [mm-at-serial-port.c:436] debug_log(): (ttyUSB1): <-- 'OK' ModemManager[21583]: [1416847953.358773] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847953.359053] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB1) device open count is 1 (close) ModemManager[21583]: [1416847953.359438] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT+CGREG=0' ModemManager[21583]: [1416847956.752962] [mm-broadband-modem.c:4183] unsolicited_registration_events_sequence_ready(): Disabling unsolicited registration events in primary port failed: 'AT sequence failed' ModemManager[21583]: [1416847956.753254] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB1) device open count is 2 (open) ModemManager[21583]: [1416847956.753439] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847956.753720] [mm-at-serial-port.c:436] debug_log(): (ttyUSB1): --> 'AT+CGREG=0' ModemManager[21583]: [1416847956.808173] [mm-at-serial-port.c:436] debug_log(): (ttyUSB1): <-- 'OK' ModemManager[21583]: [1416847956.808506] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB1) device open count is 1 (close) ModemManager[21583]: [1416847956.809192] [mm-broadband-modem.c:3623] modem_3gpp_cleanup_unsolicited_registration_events(): (ttyUSB0) cleaning up unsolicited registration messages handlers ModemManager[21583]: [1416847956.809382] [mm-broadband-modem.c:3623] modem_3gpp_cleanup_unsolicited_registration_events(): (ttyUSB1) cleaning up unsolicited registration messages handlers ModemManager[21583]: [1416847956.809823] [mm-serial-port.c:978] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open) ModemManager[21583]: [1416847956.810058] [mm-at-serial-port.c:436] debug_log(): (ttyUSB0): --> 'AT^CURC=0' ModemManager[21583]: [1416847960.126954] [mm-iface-modem-3gpp.c:1403] disable_unsolicited_events_ready(): Couldn't disable unsolicited events: 'Sending command failed: 'Resource temporarily unavailable'' ModemManager[21583]: [1416847960.127243] [mm-iface-modem-3gpp.c:1167] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) ModemManager[21583]: [1416847960.127934] [mm-bearer.c:261] modem_3gpp_registration_state_changed(): Bearer not allowed to connect, not registered in 3GPP network ModemManager[21583]: [1416847960.128159] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close) ModemManager[21583]: [1416847960.129913] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close) ModemManager[21583]: [1416847960.130184] [mm-serial-port.c:1040] mm_serial_port_close(): (ttyUSB0) closing serial port... ModemManager[21583]: [1416847960.131629] [mm-serial-port.c:1073] mm_serial_port_close(): (ttyUSB0) serial port closed ModemManager[21583]: [1416847960.131908] [mm-serial-port.c:1024] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close) ModemManager[21583]: [1416847960.132075] [mm-serial-port.c:1040] mm_serial_port_close(): (ttyUSB1) closing serial port... ModemManager[21583]: [1416847960.135980] [mm-serial-port.c:1073] mm_serial_port_close(): (ttyUSB1) serial port closed ModemManager[21583]: [1416847960.136296] [mm-iface-modem.c:1371] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) ModemManager[21583]: [1416847960.138357] [mm-bearer.c:896] mm_bearer_dbus_unexport(): Removing from DBus bearer at '/org/freedesktop/ModemManager1/Bearer/0' ModemManager[21583]: [1416847960.138656] [mm-device.c:364] unexport_modem(): Unexported modem '/sys/devices/pci0000:00/0000:00:12.2/usb1/1-1' from path '/org/freedesktop/ModemManager1/Modem/0' ModemManager[21583]: [1416847960.140504] [mm-serial-port.c:1148] mm_serial_port_close_force(): (ttyUSB0) forced to close port ModemManager[21583]: [1416847960.140688] [mm-serial-port.c:1148] mm_serial_port_close_force(): (ttyUSB1) forced to close port ModemManager[21583]: [1416847960.140820] [mm-base-modem.c:1557] finalize(): Modem (Huawei) '/sys/devices/pci0000:00/0000:00:12.2/usb1/1-1' completely disposed ModemManager[21583]: [1416847960.146380] [main.c:179] main(): ModemManager is shut down tr@tr-lp:~$