Re: PIN handling problem on Connect automatically
- From: Sérgio Basto <sergio serjux com>
- To: Dan Williams <dcbw redhat com>
- Cc: networkmanager-list <networkmanager-list gnome org>
- Subject: Re: PIN handling problem on Connect automatically
- Date: Thu, 27 Oct 2011 06:25:24 +0100
On Wed, 2011-10-26 at 19:53 -0500, Dan Williams wrote:
> On Wed, 2011-10-26 at 17:48 +0100, Sérgio Basto wrote:
> > Hi, on my HUAWEI E1550 HSDPA usb stick,
> >
> > If I do automatically , I got always
> > Oct 26 17:33:19 segulix modem-manager[1014]: <info> (ttyUSB3) opening
> > serial port...
> > Oct 26 17:33:19 segulix modem-manager[1014]: Invalid error code: 500
> > Oct 26 17:33:19 segulix modem-manager[1014]: Invalid error code: 303
> >
> > but now I checked, if I use PIN dialog that pop-up and go, very fast, to
> > nm-applet to connect broad band , I got same error.
> > If, I use PIN dialog , to unlock modem , and wait a few seconds, I
> > connect without problems .
> > In short, we have to wait a few time (one or two seconds) after unlock
> > modem, to connect.
>
> THis could be a quirk with your modem's firmware, any chance you can
> grab verbose modem-manager debug logs as described here?
sure
> http://live.gnome.org/NetworkManager/Debugging
>
> under the "3G" section. Basically, we need to see what your modem is
> doing and how it's responding. Some modems do need quirks and we could
> add one for yours. We'd also need to know what kind of modem and what
> model it is.
HUAWEI E1550 HSDPA usb stick,
Thanks,
--
Sérgio M. B.
NetworkManager[17319]: <info> NetworkManager (version 0.9.1.90-3.git20110927.fc15) is starting...
NetworkManager[17319]: <info> Read config file /etc/NetworkManager/NetworkManager.conf
NetworkManager[17319]: <info> VPN: loaded org.freedesktop.NetworkManager.vpnc
NetworkManager[17319]: <info> VPN: loaded org.freedesktop.NetworkManager.pptp
NetworkManager[17319]: <info> VPN: loaded org.freedesktop.NetworkManager.openconnect
NetworkManager[17319]: <info> VPN: loaded org.freedesktop.NetworkManager.openvpn
NetworkManager[17319]: ifcfg-rh: Acquired D-Bus service com.redhat.ifcfgrh1
NetworkManager[17319]: <info> Loaded plugin ifcfg-rh: (c) 2007 - 2010 Red Hat, Inc. To report bugs please use the NetworkManager mailing list.
NetworkManager[17319]: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc. To report bugs please use the NetworkManager mailing list.
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_MEO-SERG ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto MEO-SERG'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-eth0 ...
NetworkManager[17319]: ifcfg-rh: read connection 'System eth0'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_Thomson69306A ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto Thomson69306A'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_SAPO-WIFI ...
NetworkManager[17319]: ifcfg-rh: warning: missing IEEE_8021X_CA_CERT for EAP method 'peap'; this is insecure!
NetworkManager[17319]: ifcfg-rh: read connection 'Auto SAPO-WIFI'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-wlan0 ...
NetworkManager[17319]: ifcfg-rh: error: Missing SSID
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_CafeFoguete ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto CafeFoguete'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_ThomsonCFC04F ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto ThomsonCFC04F'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_CODEBITS ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto CODEBITS'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_Thomson14C847 ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto Thomson14C847'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_Geekroom ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto Geekroom'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_Thomson1B3B0C ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto Thomson1B3B0C'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-SERGHOTSPOT ...
NetworkManager[17319]: ifcfg-rh: read connection 'SERGHOTSPOT'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-lo ...
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_notanetgear ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto notanetgear'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_notalinksys ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto notalinksys'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_MEO-E296BE ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto MEO-E296BE'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_Costa ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto Costa'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_SERG ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto SERG'
NetworkManager[17319]: ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-Auto_LUI ...
NetworkManager[17319]: ifcfg-rh: read connection 'Auto LUI'
NetworkManager[17319]: keyfile: parsing cartao 2 ...
NetworkManager[17319]: keyfile: read connection 'cartao 2'
NetworkManager[17319]: keyfile: parsing VPN W ...
NetworkManager[17319]: keyfile: read connection 'VPN W'
NetworkManager[17319]: keyfile: parsing VPN X ...
NetworkManager[17319]: keyfile: read connection 'VPN X'
NetworkManager[17319]: keyfile: parsing cartao1 ...
NetworkManager[17319]: keyfile: read connection 'cartao1'
NetworkManager[17319]: <info> modem-manager is now available
NetworkManager[17319]: <info> monitoring kernel firmware directory '/lib/firmware'.
NetworkManager[17319]: <info> found WiFi radio killswitch rfkill2 (at /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/ieee80211/phy0/rfkill2) (driver (unknown))
NetworkManager[17319]: <info> found WiFi radio killswitch rfkill0 (at /sys/devices/platform/dell-laptop/rfkill/rfkill0) (driver dell-laptop)
NetworkManager[17319]: <info> WiFi disabled by radio killswitch; enabled by state file
NetworkManager[17319]: <info> WWAN enabled by radio killswitch; enabled by state file
NetworkManager[17319]: <info> WiMAX enabled by radio killswitch; enabled by state file
NetworkManager[17319]: <info> Networking is enabled by state file
NetworkManager[17319]: <info> (eth0): carrier is OFF
NetworkManager[17319]: <info> (eth0): new Ethernet device (driver: 'e1000e' ifindex: 2)
NetworkManager[17319]: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/0
NetworkManager[17319]: <info> (eth0): now managed
NetworkManager[17319]: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager[17319]: <info> (eth0): bringing up device.
NetworkManager[17319]: <info> (eth0): preparing device.
NetworkManager[17319]: <info> (eth0): deactivating device (reason 'managed') [2]
NetworkManager[17319]: <info> (wlan0): driver supports SSID scans (scan_capa 0x01).
NetworkManager[17319]: <info> (wlan0): new 802.11 WiFi device (driver: 'iwlagn' ifindex: 3)
NetworkManager[17319]: <info> (wlan0): exported as /org/freedesktop/NetworkManager/Devices/1
NetworkManager[17319]: <info> (wlan0): now managed
NetworkManager[17319]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager[17319]: <info> (wlan0): bringing up device.
NetworkManager[17319]: <info> (wlan0): deactivating device (reason 'managed') [2]
NetworkManager[17319]: <warn> /sys/devices/virtual/net/virbr0: couldn't determine device driver; ignoring...
NetworkManager[17319]: <warn> bluez error getting default adapter: No such adapter
NetworkManager[17319]: <warn> (ttyUSB0): failed to look up interface index
NetworkManager[17319]: <info> (ttyUSB0): new GSM/UMTS device (driver: 'option1' ifindex: -1)
NetworkManager[17319]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/2
NetworkManager[17319]: <info> (ttyUSB0): now managed
NetworkManager[17319]: <info> (ttyUSB0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager[17319]: <info> (ttyUSB0): deactivating device (reason 'managed') [2]
NetworkManager[17319]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
NetworkManager[17319]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
NetworkManager[17319]: <info> (ttyUSB0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
NetworkManager[17319]: <info> Activation (ttyUSB0) starting connection 'cartao1'
NetworkManager[17319]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager[17319]: <warn> GSM modem enable failed: (32) SIM PIN required
NetworkManager[17319]: <info> WWAN now enabled by management service
NetworkManager[17319]: <warn> GSM connection failed: (32) Serial port is now closed
NetworkManager[17319]: <info> (ttyUSB0): device state change: prepare -> failed (reason 'unknown') [40 120 1]
NetworkManager[17319]: <warn> Activation (ttyUSB0) failed.
NetworkManager[17319]: <info> (ttyUSB0): device state change: failed -> disconnected (reason 'none') [120 30 0]
NetworkManager[17319]: <info> (ttyUSB0): deactivating device (reason 'none') [0]
NetworkManager[17319]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
NetworkManager[17319]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
NetworkManager[17319]: <info> (ttyUSB0): now unmanaged
NetworkManager[17319]: <info> (ttyUSB0): device state change: disconnected -> unmanaged (reason 'removed') [30 10 36]
NetworkManager[17319]: <info> (ttyUSB0): cleaning up...
NetworkManager[17319]: <info> (ttyUSB0): taking down device.
NetworkManager[17319]: <warn> (ttyUSB0): failed to look up interface index
NetworkManager[17319]: <info> WWAN now disabled by management service
NetworkManager[17319]: <info> (ttyUSB0): new GSM/UMTS device (driver: 'option1' ifindex: -1)
NetworkManager[17319]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/3
NetworkManager[17319]: <info> (ttyUSB0): now managed
NetworkManager[17319]: <info> (ttyUSB0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager[17319]: <info> (ttyUSB0): deactivating device (reason 'managed') [2]
NetworkManager[17319]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
NetworkManager[17319]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
NetworkManager[17319]: <info> (ttyUSB0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
NetworkManager[17319]: <info> Activation (ttyUSB0) starting connection 'cartao1'
NetworkManager[17319]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager[17319]: <info> (ttyUSB0): device state change: prepare -> need-auth (reason 'none') [40 60 0]
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager[17319]: <info> (ttyUSB0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager[17319]: <info> WWAN now enabled by management service
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
NetworkManager[17319]: <info> (ttyUSB0): device state change: prepare -> config (reason 'none') [40 50 0]
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
NetworkManager[17319]: <info> (ttyUSB0): device state change: config -> ip-config (reason 'none') [50 70 0]
NetworkManager[17319]: <info> starting PPP connection
NetworkManager[17319]: <info> pppd started with pid 17597
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
** Message: nm-ppp-plugin: (plugin_init): initializing
** Message: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection'
** Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
** Message: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate'
** Message: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials...
** Message: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager
** Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
** Message: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running'
** Message: nm-ppp-plugin: (nm_ip_up): ip-up event
** Message: nm-ppp-plugin: (nm_ip_up): sending Ip4Config to NetworkManager...
NetworkManager[17319]: <info> PPP manager(IP Config Get) reply received.
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) scheduled...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) started...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) scheduled...
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) complete.
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) started...
NetworkManager[17319]: <info> (ttyUSB0): device state change: ip-config -> activated (reason 'none') [70 100 0]
NetworkManager[17319]: <info> Policy set 'cartao1' (ppp0) as default for IPv4 routing and DNS.
NetworkManager[17319]: <info> Activation (ttyUSB0) successful, device activated.
NetworkManager[17319]: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) complete.
NetworkManager[17319]: <info> caught signal 2, shutting down normally.
NetworkManager[17319]: <warn> quit request received, terminating...
NetworkManager[17319]: <info> (eth0): now unmanaged
NetworkManager[17319]: <info> (eth0): device state change: unavailable -> unmanaged (reason 'removed') [20 10 36]
NetworkManager[17319]: <info> (eth0): cleaning up...
NetworkManager[17319]: <info> (eth0): taking down device.
NetworkManager[17319]: <info> (wlan0): now unmanaged
NetworkManager[17319]: <info> (wlan0): device state change: unavailable -> unmanaged (reason 'removed') [20 10 36]
NetworkManager[17319]: <info> (ttyUSB0): now unmanaged
NetworkManager[17319]: <info> (ttyUSB0): device state change: activated -> unmanaged (reason 'removed') [100 10 36]
NetworkManager[17319]: <info> (ttyUSB0): deactivating device (reason 'removed') [36]
NetworkManager[17319]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
NetworkManager[17319]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
** Message: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate'
** Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
** Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
** Message: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect'
NetworkManager[17319]: <info> (ttyUSB0): cleaning up...
NetworkManager[17319]: <info> (ttyUSB0): taking down device.
** Message: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead'
** Message: nm-ppp-plugin: (nm_exit_notify): cleaning up
NetworkManager[17319]: <info> exiting (success)
modem-manager[17284]: <info> [1319692161.806670] [main.c:167] main(): ModemManager (version 0.4.998-1.git20110706.fc15) starting...
modem-manager[17284]: <info> [1319692161.810156] [mm-manager.c:120] load_plugin(): Loaded plugin Huawei
modem-manager[17284]: <info> [1319692161.810465] [mm-manager.c:120] load_plugin(): Loaded plugin Linktop
modem-manager[17284]: <info> [1319692161.810714] [mm-manager.c:120] load_plugin(): Loaded plugin Samsung
modem-manager[17284]: <info> [1319692161.810962] [mm-manager.c:120] load_plugin(): Loaded plugin Ericsson MBM
modem-manager[17284]: <info> [1319692161.811201] [mm-manager.c:120] load_plugin(): Loaded plugin Nokia
modem-manager[17284]: <info> [1319692161.811434] [mm-manager.c:120] load_plugin(): Loaded plugin SimTech
modem-manager[17284]: <info> [1319692161.811666] [mm-manager.c:120] load_plugin(): Loaded plugin Option
modem-manager[17284]: <info> [1319692161.811893] [mm-manager.c:120] load_plugin(): Loaded plugin Generic
modem-manager[17284]: <info> [1319692161.812136] [mm-manager.c:120] load_plugin(): Loaded plugin Novatel
modem-manager[17284]: <info> [1319692161.812382] [mm-manager.c:120] load_plugin(): Loaded plugin Sierra
modem-manager[17284]: <info> [1319692161.812618] [mm-manager.c:120] load_plugin(): Loaded plugin AnyData
modem-manager[17284]: <info> [1319692161.812850] [mm-manager.c:120] load_plugin(): Loaded plugin X22X
modem-manager[17284]: <info> [1319692161.813106] [mm-manager.c:120] load_plugin(): Loaded plugin Option High-Speed
modem-manager[17284]: <info> [1319692161.813351] [mm-manager.c:120] load_plugin(): Loaded plugin Gobi
modem-manager[17284]: <info> [1319692161.813593] [mm-manager.c:120] load_plugin(): Loaded plugin Wavecom
modem-manager[17284]: <info> [1319692161.813834] [mm-manager.c:120] load_plugin(): Loaded plugin ZTE
modem-manager[17284]: <info> [1319692161.814109] [mm-manager.c:120] load_plugin(): Loaded plugin MotoC
modem-manager[17284]: <info> [1319692161.814349] [mm-manager.c:120] load_plugin(): Loaded plugin Longcheer
modem-manager[17284]: <debug> [1319692161.817165] [mm-manager.c:809] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted
modem-manager[17284]: <debug> [1319692161.817630] [mm-manager.c:809] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
modem-manager[17284]: <debug> [1319692161.817833] [mm-manager.c:809] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
modem-manager[17284]: <debug> [1319692161.818054] [mm-manager.c:809] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
modem-manager[17284]: <debug> [1319692248.050936] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB2) deferring support check
modem-manager[17284]: <debug> [1319692248.156441] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB3) deferring support check
modem-manager[17284]: <debug> [1319692248.157713] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB1) deferring support check
modem-manager[17284]: <info> [1319692248.158413] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692248.161961] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692248.161996] [mm-plugin-base.c:848] try_open(): (ttyUSB0): probe requested by plugin 'Huawei'
modem-manager[17284]: <debug> [1319692248.264039] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^CURC=0<CR>'
modem-manager[17284]: <debug> [1319692249.164328] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT^CURC=0'
modem-manager[17284]: <debug> [1319692249.165273] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692249.166145] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692249.166229] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^GETPORTMODE<CR>'
modem-manager[17284]: <debug> [1319692250.566433] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT^GETPORTMODE'
modem-manager[17284]: <debug> [1319692250.567411] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692250.568369] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^GETPORTMODE:TYPE:WCDMA:Qualcomm ,MDM:0,NDIS:1 ,DIAG:2,PCUI:3,CDROM:4,SD:5<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692250.568494] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692251.051018] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB2): re-checking support...
modem-manager[17284]: <debug> [1319692251.051460] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB2) deferring support check
modem-manager[17284]: <debug> [1319692251.156514] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB3): re-checking support...
modem-manager[17284]: <debug> [1319692251.156942] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB3) deferring support check
modem-manager[17284]: <debug> [1319692251.157742] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB1): re-checking support...
modem-manager[17284]: <debug> [1319692251.158054] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB1) deferring support check
modem-manager[17284]: <debug> [1319692251.268620] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT+GCAP'
modem-manager[17284]: <debug> [1319692251.269668] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692251.270541] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: SIM PIN required<CR><LF>'
modem-manager[17284]: <debug> [1319692251.270650] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692251.270734] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692251.970852] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT+GCAP'
modem-manager[17284]: <debug> [1319692251.971725] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692252.010809] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: SIM PIN required<CR><LF>'
modem-manager[17284]: <debug> [1319692252.010853] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692252.010913] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692252.711029] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT+GCAP'
modem-manager[17284]: <debug> [1319692252.711859] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692252.712759] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: SIM PIN required<CR><LF>'
modem-manager[17284]: <debug> [1319692252.712802] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692252.712871] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATI<CR>'
modem-manager[17284]: <debug> [1319692253.012942] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'ATI'
modem-manager[17284]: <debug> [1319692253.013885] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692253.016071] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.016180] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692253.016204] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692253.017875] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <debug> [1319692253.048636] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB0) type primary claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692253.048798] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692253.051252] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692253.051343] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
modem-manager[17284]: <debug> [1319692253.051375] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open)
modem-manager[17284]: <info> [1319692253.051516] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 claimed port ttyUSB0
modem-manager[17284]: <debug> [1319692253.051543] [mm-manager.c:317] add_modem(): Added modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692253.051595] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692253.051688] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692253.051793] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692253.055869] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'ATE0'
modem-manager[17284]: <debug> [1319692253.056631] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692253.057513] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.057573] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GMI<CR>'
modem-manager[17284]: <debug> [1319692253.065435] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>huawei<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.065503] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GMM<CR>'
modem-manager[17284]: <debug> [1319692253.073687] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>E1550<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.073756] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GMR<CR>'
modem-manager[17284]: <debug> [1319692253.081937] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>11.608.14.11.00<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.082015] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGMI<CR>'
modem-manager[17284]: <debug> [1319692253.091060] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>huawei<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.091129] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGMM<CR>'
modem-manager[17284]: <debug> [1319692253.100313] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>E1550<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.100380] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGMR<CR>'
modem-manager[17284]: <debug> [1319692253.109245] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>11.608.14.11.00<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.109301] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATI<CR>'
modem-manager[17284]: <debug> [1319692253.115647] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.115724] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATI1<CR>'
modem-manager[17284]: <debug> [1319692253.122894] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.122991] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GSN<CR>'
modem-manager[17284]: <debug> [1319692253.131764] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>352965044809042<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.131831] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGSN<CR>'
modem-manager[17284]: <debug> [1319692253.141640] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>352965044809042<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.154116] [mm-modem-helpers.c:888] mm_create_device_identifier(): Device ID source '000012d10000140cManufacturer:huaweiModel:E1550Revision:11.608.14.11.00IMEI:352965044809042+GCAP:+CGSM,+DS,+ES35296504480904211.608.14.11.00E1550huawei'
modem-manager[17284]: <debug> [1319692253.154140] [mm-modem-helpers.c:889] mm_create_device_identifier(): Device ID 'bae3c3a428ad7f2f4fc1db138d1764eb48e83d60'
modem-manager[17284]: <debug> [1319692253.154192] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close)
modem-manager[17284]: <debug> [1319692253.154222] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692253.159887] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.160003] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
modem-manager[17284]: <debug> [1319692253.160027] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
modem-manager[17284]: <debug> [1319692253.171388] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.171447] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPIN?<CR>'
modem-manager[17284]: <debug> [1319692253.181563] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CPIN: SIM PIN<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.181643] [mm-modem-huawei-gsm.c:617] get_unlock_retries(): pin type 'sim-pin'
modem-manager[17284]: <debug> [1319692253.181674] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
modem-manager[17284]: <debug> [1319692253.181783] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692253.181816] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open)
modem-manager[17284]: <debug> [1319692253.181870] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close)
modem-manager[17284]: <debug> [1319692253.187562] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.187622] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^CPIN?<CR>'
modem-manager[17284]: <debug> [1319692253.197691] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^CPIN: SIM PIN,3,10,3,10,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692253.197794] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
modem-manager[17284]: <debug> [1319692253.197852] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
modem-manager[17284]: <debug> [1319692253.225391] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692253.225436] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692253.225472] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692253.225499] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692253.227251] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <debug> [1319692253.227342] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692254.053311] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB2): re-checking support...
modem-manager[17284]: <info> [1319692254.053849] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB2) opening serial port...
modem-manager[17284]: <debug> [1319692254.056267] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692254.056299] [mm-plugin-base.c:848] try_open(): (ttyUSB2): probe requested by plugin 'Huawei'
modem-manager[17284]: <debug> [1319692254.157453] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB3): re-checking support...
modem-manager[17284]: <debug> [1319692254.158416] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB1): re-checking support...
modem-manager[17284]: <info> [1319692254.158843] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
modem-manager[17284]: <debug> [1319692254.161390] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692254.161419] [mm-plugin-base.c:848] try_open(): (ttyUSB3): probe requested by plugin 'Huawei'
modem-manager[17284]: <debug> [1319692254.163760] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
modem-manager[17284]: <info> [1319692254.163796] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB1) opening serial port...
modem-manager[17284]: <debug> [1319692254.173390] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692254.173421] [mm-plugin-base.c:848] try_open(): (ttyUSB1): probe requested by plugin 'Huawei'
modem-manager[17284]: <debug> [1319692254.264396] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692254.276195] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692254.968844] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692254.968912] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692254.968992] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692255.671849] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692255.671923] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692255.672051] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692256.374857] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692256.374922] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692256.375025] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATI<CR>'
modem-manager[17284]: <debug> [1319692256.678241] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692256.678326] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
modem-manager[17284]: <info> [1319692256.678352] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
modem-manager[17284]: <info> [1319692256.680286] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
modem-manager[17284]: <debug> [1319692256.680830] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB3) type secondary claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692256.681046] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 claimed port ttyUSB3
modem-manager[17284]: <debug> [1319692256.681113] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692258.248828] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692258.248911] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692262.250092] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692262.250175] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692266.250656] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
modem-manager[17284]: <info> [1319692266.250720] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB2) closing serial port...
modem-manager[17284]: <info> [1319692266.252038] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB2) serial port closed
modem-manager[17284]: <info> [1319692266.252161] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB2) opening serial port...
modem-manager[17284]: <debug> [1319692266.254645] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692266.254681] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
modem-manager[17284]: <info> [1319692266.254721] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB1) closing serial port...
modem-manager[17284]: <info> [1319692266.256258] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB1) serial port closed
modem-manager[17284]: <info> [1319692266.256318] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB1) opening serial port...
modem-manager[17284]: <debug> [1319692266.259639] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692266.259694] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692266.259738] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB1): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692269.250146] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692269.250223] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB1): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692269.255507] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): <-- 00 46 65 62 20 32 35 20 32 30 31 30 31 35 3a 35 31 3a 35 37 46 65 62 20 32 35 20 32 30 31 30 31 35 3a 35 31 3a 35 37 4b 50 52 42 4c 00 46 65 00 00 21 00 00 00 01 20 00 6b 7e
modem-manager[17284]: <debug> [1319692269.255586] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
modem-manager[17284]: <info> [1319692269.255612] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB2) closing serial port...
modem-manager[17284]: <info> [1319692269.257415] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB2) serial port closed
modem-manager[17284]: <debug> [1319692269.257945] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB2) type ignored claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692269.258156] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 claimed port ttyUSB2
modem-manager[17284]: <debug> [1319692269.258227] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692272.250338] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
modem-manager[17284]: <info> [1319692272.250427] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB1) closing serial port...
modem-manager[17284]: <info> [1319692272.251692] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB1) serial port closed
modem-manager[17284]: <debug> [1319692272.251761] [mm-manager.c:624] supports_callback(): (tty/ttyUSB1): ignoring port unsupported by physical modem's plugin
modem-manager[17284]: <debug> [1319692272.251869] [mm-manager.c:265] check_export_modem(): Exported modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 as /org/freedesktop/ModemManager/Modems/0
modem-manager[17284]: <debug> [1319692272.251981] [mm-manager.c:278] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): VID 0x12D1 PID 0x140C (usb)
modem-manager[17284]: <debug> [1319692272.252001] [mm-manager.c:279] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): data port is ttyUSB0
modem-manager[17284]: <info> [1319692278.554298] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692278.556770] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692278.556831] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPIN="2575"<CR>'
modem-manager[17284]: <debug> [1319692278.608065] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692278.608174] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPIN?<CR>'
modem-manager[17284]: <debug> [1319692278.618836] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692278.618904] [mm-modem-base.c:299] mm_modem_base_set_unlock_required(): Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required
modem-manager[17284]: <info> [1319692278.618970] [mm-modem-base.c:338] mm_modem_base_set_unlock_retries(): Modem /org/freedesktop/ModemManager/Modems/0: # unlock retries is 0
modem-manager[17284]: <debug> [1319692278.619174] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692278.619201] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692278.620748] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <info> [1319692278.621303] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692278.624141] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <info> [1319692278.624232] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling)
modem-manager[17284]: <debug> [1319692278.725820] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATZ E0 V1<CR>'
modem-manager[17284]: <debug> [1319692278.778475] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692278.778581] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATZ E0 V1<CR>'
modem-manager[17284]: <debug> [1319692278.798912] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692278.799023] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692278.805080] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692278.805140] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
modem-manager[17284]: <debug> [1319692278.816406] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692278.816464] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATX4 &C1<CR>'
modem-manager[17284]: <debug> [1319692278.827157] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692278.827232] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CFUN=1<CR>'
modem-manager[17284]: <debug> [1319692281.413552] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692281.413654] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
modem-manager[17284]: <debug> [1319692281.416685] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692281.416729] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
modem-manager[17284]: <debug> [1319692281.416795] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^CURC=1<CR>'
modem-manager[17284]: <debug> [1319692281.440240] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692281.440302] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+IFC=1,1<CR>'
modem-manager[17284]: <debug> [1319692281.512790] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692281.512894] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPMS="ME","ME","ME"<CR>'
modem-manager[17284]: <debug> [1319692281.760895] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CMS ERROR: 500<CR><LF>'
modem-manager[17284]: Invalid error code: 500
modem-manager[17284]: <debug> [1319692281.761018] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[17284]: <debug> [1319692281.761058] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CNMI=2,1,2,1,0<CR>'
modem-manager[17284]: <debug> [1319692281.784113] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CMS ERROR: 303<CR><LF>'
modem-manager[17284]: Invalid error code: 303
modem-manager[17284]: <debug> [1319692281.784186] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[17284]: <debug> [1319692281.784227] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CUSD=1<CR>'
modem-manager[17284]: <debug> [1319692281.808100] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692281.808201] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CIND=?<CR>'
modem-manager[17284]: <debug> [1319692281.820062] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
modem-manager[17284]: <debug> [1319692281.820106] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[17284]: <debug> [1319692281.820159] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
modem-manager[17284]: <debug> [1319692282.022697] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CRSM: 144,0,"98530106002026298591"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.022820] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
modem-manager[17284]: <debug> [1319692282.022871] [mm-generic-gsm.c:500] get_iccid_done(): SIM ID source '89351060000262925819'
modem-manager[17284]: <debug> [1319692282.022890] [mm-generic-gsm.c:501] get_iccid_done(): SIM ID 'f4c652756e92b0de97d8c3e5c7a02d36f96acf1d'
modem-manager[17284]: <debug> [1319692282.022938] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^SYSCFG?<CR>'
modem-manager[17284]: <debug> [1319692282.037566] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSCFG:14,2,3FFFFFFF,1,2<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.037679] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSCS=?<CR>'
modem-manager[17284]: <debug> [1319692282.050242] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSCS: ("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.050377] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSCS="UCS2"<CR>'
modem-manager[17284]: <debug> [1319692282.070320] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.070383] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSCS?<CR>'
modem-manager[17284]: <debug> [1319692282.081693] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692282.081837] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled)
modem-manager[17284]: <debug> [1319692282.082019] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CREG=2<CR>'
modem-manager[17284]: <debug> [1319692282.094503] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.094790] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSQ<CR>'
modem-manager[17284]: <debug> [1319692282.103250] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSQ: 21,99<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.103349] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
modem-manager[17284]: <debug> [1319692282.117707] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CREG: 2,2,00,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.117791] [mm-generic-gsm.c:2614] mm_generic_gsm_set_reg_status(): CS registration state changed: 2
modem-manager[17284]: <info> [1319692282.117914] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> searching)
modem-manager[17284]: <debug> [1319692282.117993] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGREG=2<CR>'
modem-manager[17284]: <debug> [1319692282.130569] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.130650] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGREG?<CR>'
modem-manager[17284]: <debug> [1319692282.130683] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CREG=2<CR>'
modem-manager[17284]: <debug> [1319692282.131291] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): number => "*99#"
modem-manager[17284]: <debug> [1319692282.131314] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): pin => "2575"
modem-manager[17284]: <debug> [1319692282.131329] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): username => "tmn"
modem-manager[17284]: <debug> [1319692282.131344] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): apn => "internet"
modem-manager[17284]: <debug> [1319692282.131364] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): network_mode => 8
modem-manager[17284]: <debug> [1319692282.131379] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): password => "tmn"
modem-manager[17284]: <debug> [1319692282.131397] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): allowed_mode => 4
modem-manager[17284]: <debug> [1319692282.131421] [mm-generic-gsm.c:5145] simple_state_machine(): (ttyUSB0): simple connect state 0
modem-manager[17284]: <debug> [1319692282.131466] [mm-generic-gsm.c:5145] simple_state_machine(): (ttyUSB0): simple connect state 2
modem-manager[17284]: <debug> [1319692282.144570] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CGREG: 2,2,00,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.144614] [mm-generic-gsm.c:2614] mm_generic_gsm_set_reg_status(): PS registration state changed: 2
modem-manager[17284]: <debug> [1319692282.144685] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
modem-manager[17284]: <debug> [1319692282.146320] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692282.146382] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGREG=2<CR>'
modem-manager[17284]: <debug> [1319692282.163874] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CREG: 2,2,00,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692283.248323] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
modem-manager[17284]: <debug> [1319692286.515475] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGREG?<CR>'
modem-manager[17284]: <debug> [1319692287.467167] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692287.467235] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692287.467283] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <debug> [1319692287.467669] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
modem-manager[17284]: <info> [1319692287.467699] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
modem-manager[17284]: <info> [1319692287.467733] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
modem-manager[17284]: <info> [1319692287.603528] [mm-manager.c:862] device_removed(): (tty/ttyUSB3): released by modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692287.603619] [mm-modem-base.c:185] mm_modem_base_remove_port(): (ttyUSB3) type secondary removed from /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692287.604262] [mm-manager.c:862] device_removed(): (tty/ttyUSB0): released by modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692287.604326] [mm-modem-base.c:185] mm_modem_base_remove_port(): (ttyUSB0) type primary removed from /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692287.604478] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (searching -> disabled)
modem-manager[17284]: <debug> [1319692287.604510] [mm-manager.c:204] remove_modem(): Removed modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692291.924615] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB3) deferring support check
modem-manager[17284]: <debug> [1319692291.925854] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB1) deferring support check
modem-manager[17284]: <debug> [1319692291.939143] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB2) deferring support check
modem-manager[17284]: <info> [1319692291.948734] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692291.951287] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692291.951320] [mm-plugin-base.c:848] try_open(): (ttyUSB0): probe requested by plugin 'Huawei'
modem-manager[17284]: <debug> [1319692292.131260] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^CURC=0<CR>'
modem-manager[17284]: <debug> [1319692293.232373] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT^CURC=0'
modem-manager[17284]: <debug> [1319692293.233434] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692293.234309] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692293.234368] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^GETPORTMODE<CR>'
modem-manager[17284]: <debug> [1319692294.634549] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT^GETPORTMODE'
modem-manager[17284]: <debug> [1319692294.636195] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692294.638075] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^GETPORTMODE:TYPE:WCDMA:Qualcomm ,MDM:0,NDIS:1 ,DIAG:2,PCUI:3,CDROM:4,SD:5<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692294.638146] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692294.924692] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB3): re-checking support...
modem-manager[17284]: <debug> [1319692294.925132] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB3) deferring support check
modem-manager[17284]: <debug> [1319692294.925899] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB1): re-checking support...
modem-manager[17284]: <debug> [1319692294.926205] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB1) deferring support check
modem-manager[17284]: <debug> [1319692294.939214] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB2): re-checking support...
modem-manager[17284]: <debug> [1319692294.939540] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB2) deferring support check
modem-manager[17284]: <debug> [1319692295.338284] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT+GCAP'
modem-manager[17284]: <debug> [1319692295.339201] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692295.339964] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: SIM PIN required<CR><LF>'
modem-manager[17284]: <debug> [1319692295.340006] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692295.340080] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692296.040193] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT+GCAP'
modem-manager[17284]: <debug> [1319692296.041150] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692296.041971] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: SIM PIN required<CR><LF>'
modem-manager[17284]: <debug> [1319692296.042015] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692296.042090] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692296.742205] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'AT+GCAP'
modem-manager[17284]: <debug> [1319692296.743161] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692296.743981] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: SIM PIN required<CR><LF>'
modem-manager[17284]: <debug> [1319692296.744021] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692296.744094] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATI<CR>'
modem-manager[17284]: <debug> [1319692297.044165] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'ATI'
modem-manager[17284]: <debug> [1319692297.045561] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692297.047903] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.047985] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692297.048018] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692297.049707] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <debug> [1319692297.054579] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB0) type primary claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692297.054768] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692297.057206] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692297.057255] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
modem-manager[17284]: <debug> [1319692297.057293] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open)
modem-manager[17284]: <info> [1319692297.057384] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 claimed port ttyUSB0
modem-manager[17284]: <debug> [1319692297.057419] [mm-manager.c:317] add_modem(): Added modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692297.057448] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692297.057493] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692297.057604] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692297.061692] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- 'ATE0'
modem-manager[17284]: <debug> [1319692297.062719] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR>'
modem-manager[17284]: <debug> [1319692297.063597] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.063656] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GMI<CR>'
modem-manager[17284]: <debug> [1319692297.071347] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>huawei<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.071413] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GMM<CR>'
modem-manager[17284]: <debug> [1319692297.079490] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>E1550<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.079555] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GMR<CR>'
modem-manager[17284]: <debug> [1319692297.087471] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>11.608.14.11.00<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.087537] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGMI<CR>'
modem-manager[17284]: <debug> [1319692297.096597] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>huawei<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.096662] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGMM<CR>'
modem-manager[17284]: <debug> [1319692297.105899] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>E1550<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.105989] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGMR<CR>'
modem-manager[17284]: <debug> [1319692297.114991] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>11.608.14.11.00<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.115075] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATI<CR>'
modem-manager[17284]: <debug> [1319692297.121352] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.121426] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATI1<CR>'
modem-manager[17284]: <debug> [1319692297.128603] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.128679] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GSN<CR>'
modem-manager[17284]: <debug> [1319692297.137473] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>352965044809042<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.137540] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGSN<CR>'
modem-manager[17284]: <debug> [1319692297.147723] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>352965044809042<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.147814] [mm-modem-helpers.c:888] mm_create_device_identifier(): Device ID source '000012d10000140cManufacturer:huaweiModel:E1550Revision:11.608.14.11.00IMEI:352965044809042+GCAP:+CGSM,+DS,+ES35296504480904211.608.14.11.00E1550huawei'
modem-manager[17284]: <debug> [1319692297.147838] [mm-modem-helpers.c:889] mm_create_device_identifier(): Device ID 'bae3c3a428ad7f2f4fc1db138d1764eb48e83d60'
modem-manager[17284]: <debug> [1319692297.147882] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close)
modem-manager[17284]: <debug> [1319692297.147906] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692297.153723] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.153820] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
modem-manager[17284]: <debug> [1319692297.153845] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
modem-manager[17284]: <debug> [1319692297.165006] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.165066] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPIN?<CR>'
modem-manager[17284]: <debug> [1319692297.175139] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CPIN: SIM PIN<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.175216] [mm-modem-huawei-gsm.c:617] get_unlock_retries(): pin type 'sim-pin'
modem-manager[17284]: <debug> [1319692297.175244] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
modem-manager[17284]: <debug> [1319692297.175314] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692297.175343] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open)
modem-manager[17284]: <debug> [1319692297.175368] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close)
modem-manager[17284]: <debug> [1319692297.181094] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.181150] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^CPIN?<CR>'
modem-manager[17284]: <debug> [1319692297.191220] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^CPIN: SIM PIN,3,10,3,10,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692297.191297] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
modem-manager[17284]: <debug> [1319692297.191362] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
modem-manager[17284]: <debug> [1319692297.219219] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692297.219265] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692297.219296] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692297.219323] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692297.221212] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <debug> [1319692297.221302] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692297.926116] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB3): re-checking support...
modem-manager[17284]: <debug> [1319692297.926816] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB1): re-checking support...
modem-manager[17284]: <info> [1319692297.927337] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
modem-manager[17284]: <debug> [1319692297.929850] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692297.929878] [mm-plugin-base.c:848] try_open(): (ttyUSB3): probe requested by plugin 'Huawei'
modem-manager[17284]: <info> [1319692297.930832] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB1) opening serial port...
modem-manager[17284]: <debug> [1319692297.933836] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692297.933867] [mm-plugin-base.c:848] try_open(): (ttyUSB1): probe requested by plugin 'Huawei'
modem-manager[17284]: <debug> [1319692297.939898] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB2): re-checking support...
modem-manager[17284]: <info> [1319692297.940420] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB2) opening serial port...
modem-manager[17284]: <debug> [1319692297.942845] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692297.942876] [mm-plugin-base.c:848] try_open(): (ttyUSB2): probe requested by plugin 'Huawei'
modem-manager[17284]: <debug> [1319692298.031503] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692298.036230] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692298.044860] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692298.735130] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692298.735215] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692298.735278] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692299.437760] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692299.437841] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692299.437901] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692300.140345] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 11<CR><LF>'
modem-manager[17284]: <debug> [1319692300.140420] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 11: SIM PIN required
modem-manager[17284]: <debug> [1319692300.140477] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATI<CR>'
modem-manager[17284]: <debug> [1319692300.443641] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1550<CR><LF>Revision: 11.608.14.11.00<CR><LF>IMEI: 352965044809042<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692300.443721] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
modem-manager[17284]: <info> [1319692300.443747] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
modem-manager[17284]: <info> [1319692300.445616] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
modem-manager[17284]: <debug> [1319692300.446301] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB3) type secondary claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692300.446566] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 claimed port ttyUSB3
modem-manager[17284]: <debug> [1319692300.446647] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692302.248602] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692302.248692] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692306.250741] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692306.250828] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
modem-manager[17284]: <debug> [1319692310.247060] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
modem-manager[17284]: <info> [1319692310.247125] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB1) closing serial port...
modem-manager[17284]: <info> [1319692310.248205] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB1) serial port closed
modem-manager[17284]: <info> [1319692310.248285] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB1) opening serial port...
modem-manager[17284]: <debug> [1319692310.251600] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692310.251636] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
modem-manager[17284]: <info> [1319692310.251662] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB2) closing serial port...
modem-manager[17284]: <info> [1319692310.253195] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB2) serial port closed
modem-manager[17284]: <info> [1319692310.253247] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB2) opening serial port...
modem-manager[17284]: <debug> [1319692310.255723] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692310.255776] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB1): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692310.255817] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692313.250203] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB1): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692313.250283] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): --> 00 78 f0 7e
modem-manager[17284]: <debug> [1319692313.254839] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): <-- 00 46 65 62 20 32 35 20 32 30 31 30 31 35 3a 35 31 3a 35 37 46 65 62 20 32 35 20 32 30 31 30 31 35 3a 35 31 3a 35 37 4b 50 52 42 4c 00 46 65 00 00 21 00 00 00 01 20 00 6b 7e
modem-manager[17284]: <debug> [1319692313.254910] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
modem-manager[17284]: <info> [1319692313.254935] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB2) closing serial port...
modem-manager[17284]: <info> [1319692313.256752] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB2) serial port closed
modem-manager[17284]: <debug> [1319692313.257306] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB2) type ignored claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <info> [1319692313.257496] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 claimed port ttyUSB2
modem-manager[17284]: <debug> [1319692313.257561] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692316.249757] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
modem-manager[17284]: <info> [1319692316.249826] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB1) closing serial port...
modem-manager[17284]: <info> [1319692316.251018] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB1) serial port closed
modem-manager[17284]: <debug> [1319692316.251082] [mm-manager.c:624] supports_callback(): (tty/ttyUSB1): ignoring port unsupported by physical modem's plugin
modem-manager[17284]: <debug> [1319692316.251199] [mm-manager.c:265] check_export_modem(): Exported modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2 as /org/freedesktop/ModemManager/Modems/1
modem-manager[17284]: <debug> [1319692316.251290] [mm-manager.c:278] check_export_modem(): (/org/freedesktop/ModemManager/Modems/1): VID 0x12D1 PID 0x140C (usb)
modem-manager[17284]: <debug> [1319692316.251307] [mm-manager.c:279] check_export_modem(): (/org/freedesktop/ModemManager/Modems/1): data port is ttyUSB0
modem-manager[17284]: <info> [1319692324.238223] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692324.240758] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692324.240923] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPIN="2575"<CR>'
modem-manager[17284]: <debug> [1319692324.291822] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692324.292057] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPIN?<CR>'
modem-manager[17284]: <debug> [1319692324.302880] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692324.303035] [mm-modem-base.c:299] mm_modem_base_set_unlock_required(): Modem /org/freedesktop/ModemManager/Modems/1: unlock no longer required
modem-manager[17284]: <info> [1319692324.303138] [mm-modem-base.c:338] mm_modem_base_set_unlock_retries(): Modem /org/freedesktop/ModemManager/Modems/1: # unlock retries is 0
modem-manager[17284]: <debug> [1319692324.303872] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692324.303970] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692324.305367] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <info> [1319692330.948451] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
modem-manager[17284]: <debug> [1319692330.955195] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
modem-manager[17284]: <info> [1319692330.955358] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> enabling)
modem-manager[17284]: <debug> [1319692331.057016] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATZ E0 V1<CR>'
modem-manager[17284]: <debug> [1319692331.081845] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.081930] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATZ E0 V1<CR>'
modem-manager[17284]: <debug> [1319692331.107214] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.107303] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
modem-manager[17284]: <debug> [1319692331.118332] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.118400] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
modem-manager[17284]: <debug> [1319692331.129709] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.129775] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATX4 &C1<CR>'
modem-manager[17284]: <debug> [1319692331.141578] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.141642] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CFUN=1<CR>'
modem-manager[17284]: <debug> [1319692331.157476] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692331.157582] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
modem-manager[17284]: <debug> [1319692331.161080] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
modem-manager[17284]: <debug> [1319692331.161128] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
modem-manager[17284]: <debug> [1319692331.161193] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^CURC=1<CR>'
modem-manager[17284]: <debug> [1319692331.173327] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.173387] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+IFC=1,1<CR>'
modem-manager[17284]: <debug> [1319692331.188078] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.188138] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CPMS="ME","ME","ME"<CR>'
modem-manager[17284]: <debug> [1319692331.249789] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CPMS: 1,23,1,23,1,23<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.249930] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CNMI=2,1,2,1,0<CR>'
modem-manager[17284]: <debug> [1319692331.250964] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^SIMST:1<CR><LF>'
modem-manager[17284]: <debug> [1319692331.253572] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^SRVST:2<CR><LF>'
modem-manager[17284]: <debug> [1319692331.270456] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CMS ERROR: 303<CR><LF>'
modem-manager[17284]: Invalid error code: 303
modem-manager[17284]: <debug> [1319692331.270547] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[17284]: <debug> [1319692331.270583] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CUSD=1<CR>'
modem-manager[17284]: <debug> [1319692331.285330] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.285391] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CIND=?<CR>'
modem-manager[17284]: <debug> [1319692331.300203] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
modem-manager[17284]: <debug> [1319692331.300251] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[17284]: <debug> [1319692331.300289] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
modem-manager[17284]: <debug> [1319692331.506304] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CRSM: 144,0,"98530106002026298591"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.506428] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
modem-manager[17284]: <debug> [1319692331.506479] [mm-generic-gsm.c:500] get_iccid_done(): SIM ID source '89351060000262925819'
modem-manager[17284]: <debug> [1319692331.506499] [mm-generic-gsm.c:501] get_iccid_done(): SIM ID 'f4c652756e92b0de97d8c3e5c7a02d36f96acf1d'
modem-manager[17284]: <debug> [1319692331.506543] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^SYSCFG?<CR>'
modem-manager[17284]: <debug> [1319692331.520708] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSCFG:14,2,3FFFFFFF,1,2<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.520805] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSCS=?<CR>'
modem-manager[17284]: <debug> [1319692331.534713] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSCS: ("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.534855] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSCS="UCS2"<CR>'
modem-manager[17284]: <debug> [1319692331.553982] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.554090] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSCS?<CR>'
modem-manager[17284]: <debug> [1319692331.565722] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692331.565934] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabling -> enabled)
modem-manager[17284]: <debug> [1319692331.566117] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CREG=2<CR>'
modem-manager[17284]: <debug> [1319692331.587089] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.587317] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSQ<CR>'
modem-manager[17284]: <debug> [1319692331.598322] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSQ: 16,99<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.598437] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
modem-manager[17284]: <debug> [1319692331.609344] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CREG: 2,1,131,82E3<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.609429] [mm-generic-gsm.c:2614] mm_generic_gsm_set_reg_status(): CS registration state changed: 1
modem-manager[17284]: <info> [1319692331.609590] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabled -> registered)
modem-manager[17284]: <debug> [1319692331.609661] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGREG=2<CR>'
modem-manager[17284]: <debug> [1319692331.623344] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.623423] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CREG=2<CR>'
modem-manager[17284]: <debug> [1319692331.623487] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+COPS=3,2;+COPS?<CR>'
modem-manager[17284]: <debug> [1319692331.624071] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): number => "*99#"
modem-manager[17284]: <debug> [1319692331.624094] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): pin => "2575"
modem-manager[17284]: <debug> [1319692331.624109] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): username => "tmn"
modem-manager[17284]: <debug> [1319692331.624124] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): apn => "internet"
modem-manager[17284]: <debug> [1319692331.624144] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): network_mode => 8
modem-manager[17284]: <debug> [1319692331.624159] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): password => "tmn"
modem-manager[17284]: <debug> [1319692331.624175] [mm-generic-gsm.c:5256] simple_connect(): (ttyUSB0): allowed_mode => 4
modem-manager[17284]: <debug> [1319692331.624201] [mm-generic-gsm.c:5145] simple_state_machine(): (ttyUSB0): simple connect state 0
modem-manager[17284]: <debug> [1319692331.624251] [mm-generic-gsm.c:5145] simple_state_machine(): (ttyUSB0): simple connect state 2
modem-manager[17284]: <debug> [1319692331.647590] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,2,"26806",2<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.647743] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+COPS=3,0;+COPS?<CR>'
modem-manager[17284]: <debug> [1319692331.649203] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.649279] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGREG=2<CR>'
modem-manager[17284]: <debug> [1319692331.689321] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,0,"P TMN",2<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.689449] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSQ<CR>'
modem-manager[17284]: <debug> [1319692331.691581] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.700700] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSQ: 16,99<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.700792] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^SYSINFO<CR>'
modem-manager[17284]: <debug> [1319692331.715582] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.715727] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGREG?<CR>'
modem-manager[17284]: <debug> [1319692331.729087] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CGREG: 2,1,131,82E3<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.729134] [mm-generic-gsm.c:2614] mm_generic_gsm_set_reg_status(): PS registration state changed: 1
modem-manager[17284]: <debug> [1319692331.729229] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
modem-manager[17284]: <debug> [1319692331.742082] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CREG: 2,1,131,82E3<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.742180] [mm-generic-gsm.c:5145] simple_state_machine(): (ttyUSB0): simple connect state 4
modem-manager[17284]: <debug> [1319692331.742218] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+COPS=3,2;+COPS?<CR>'
modem-manager[17284]: <debug> [1319692331.769017] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,2,"26806",2<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.769109] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+COPS=3,0;+COPS?<CR>'
modem-manager[17284]: <debug> [1319692331.794988] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,0,"P TMN",2<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.795128] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CSQ<CR>'
modem-manager[17284]: <debug> [1319692331.806459] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSQ: 16,99<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.806547] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^SYSINFO<CR>'
modem-manager[17284]: <debug> [1319692331.819710] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.819812] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGDCONT?<CR>'
modem-manager[17284]: <debug> [1319692331.840583] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>+CGDCONT: 1,"IP","internet","0.0.0.0",0,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.840748] [mm-generic-gsm.c:5145] simple_state_machine(): (ttyUSB0): simple connect state 5
modem-manager[17284]: <info> [1319692331.841104] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (registered -> connecting)
modem-manager[17284]: <debug> [1319692331.841204] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATD*99***1#<CR>'
modem-manager[17284]: <debug> [1319692331.866578] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>CONNECT 3600000<CR><LF>'
modem-manager[17284]: <debug> [1319692331.866649] [mm-port.c:181] mm_port_set_connected(): (ttyUSB0): port now connected
modem-manager[17284]: <info> [1319692331.866735] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (connecting -> connected)
modem-manager[17284]: <debug> [1319692331.866779] [mm-generic-gsm.c:5145] simple_state_machine(): (ttyUSB0): simple connect state 6
modem-manager[17284]: <debug> [1319692331.867738] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CSQ<CR>'
modem-manager[17284]: <debug> [1319692331.878601] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CSQ: 16,99<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.878778] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CSQ<CR>'
modem-manager[17284]: <debug> [1319692331.890392] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CSQ: 16,99<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692331.977988] [mm-manager.c:793] device_added(): (net/ppp0): could not get port's parent device
modem-manager[17284]: <debug> [1319692332.111186] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^BOOT:44809042,0,0,0,87<CR><LF>'
modem-manager[17284]: <debug> [1319692333.187899] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692336.189206] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692337.520316] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^MODE:5,5<CR><LF>'
modem-manager[17284]: <debug> [1319692337.520485] [mm-modem-huawei-gsm.c:705] handle_mode_change(): Access Technology: 6
modem-manager[17284]: <debug> [1319692338.250429] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:00000002,0000015E,00000203,00000000000002BC,0000000000000407,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692338.250608] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 2 Up: 2 Kbps Down: 4 Kbps Total: 0 Total: 1
modem-manager[17284]: <debug> [1319692339.189349] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692340.250231] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:00000004,00000098,000000E4,00000000000003EC,00000000000005CF,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692340.250339] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 4 Up: 1 Kbps Down: 1 Kbps Total: 0 Total: 1
modem-manager[17284]: <debug> [1319692342.189621] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692342.250133] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:00000006,00000A1A,0000306F,0000000000001821,00000000000066AD,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692342.250256] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 6 Up: 20 Kbps Down: 99 Kbps Total: 6 Total: 25
modem-manager[17284]: <debug> [1319692344.250918] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:00000008,0000084D,00009CE3,00000000000028BB,000000000001A074,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692344.251116] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 8 Up: 17 Kbps Down: 321 Kbps Total: 10 Total: 104
modem-manager[17284]: <debug> [1319692345.191455] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692346.250714] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:0000000A,000007DB,000013B3,0000000000003871,000000000001C7DB,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692346.250809] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 10 Up: 16 Kbps Down: 40 Kbps Total: 14 Total: 113
modem-manager[17284]: <debug> [1319692348.190559] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692348.250061] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:0000000C,00000715,00000976,000000000000469C,000000000001DAC7,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692348.250160] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 12 Up: 14 Kbps Down: 19 Kbps Total: 17 Total: 118
modem-manager[17284]: <debug> [1319692350.250262] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:0000000E,0000004C,0000004C,0000000000004734,000000000001DB5F,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692350.250359] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 14 Up: 0 Kbps Down: 0 Kbps Total: 17 Total: 118
modem-manager[17284]: <debug> [1319692351.191247] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692352.250489] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:00000010,0000001B,00000000,000000000000476A,000000000001DB5F,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692352.250598] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 16 Up: 0 Kbps Down: 0 Kbps Total: 17 Total: 118
modem-manager[17284]: <debug> [1319692354.249947] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:00000012,00000000,00000000,000000000000476A,000000000001DB5F,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692354.250054] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 18 Up: 0 Kbps Down: 0 Kbps Total: 17 Total: 118
modem-manager[17284]: <debug> [1319692356.250174] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^DSFLOWRPT:00000014,00000020,00000000,00000000000047AA,000000000001DB5F,000B1BC0,0007D000<CR><LF>'
modem-manager[17284]: <debug> [1319692356.250272] [mm-modem-huawei-gsm.c:721] handle_status_change(): Duration: 20 Up: 0 Kbps Down: 0 Kbps Total: 17 Total: 118
modem-manager[17284]: <info> [1319692356.564249] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (connected -> disconnecting)
modem-manager[17284]: <debug> [1319692356.564376] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGACT=0,1<CR>'
modem-manager[17284]: <debug> [1319692356.586094] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 0<CR><LF>'
modem-manager[17284]: <debug> [1319692356.586253] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 0: Phone failure
modem-manager[17284]: <debug> [1319692357.192527] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692357.430402] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^MODE:5,4<CR><LF>'
modem-manager[17284]: <debug> [1319692357.430520] [mm-modem-huawei-gsm.c:705] handle_mode_change(): Access Technology: 5
modem-manager[17284]: <debug> [1319692357.452262] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>NO CARRIER<CR><LF>'
modem-manager[17284]: <debug> [1319692357.452324] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 3: No carrier
modem-manager[17284]: <debug> [1319692357.589222] [mm-port.c:181] mm_port_set_connected(): (ttyUSB0): port now disconnected
modem-manager[17284]: <debug> [1319692357.589284] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+CGACT=0,1<CR>'
modem-manager[17284]: <debug> [1319692357.605006] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692357.605132] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (disconnecting -> registered)
modem-manager[17284]: <debug> [1319692360.192608] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <debug> [1319692362.114094] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^BOOT:44809042,0,0,0,87<CR><LF>'
modem-manager[17284]: <debug> [1319692362.247402] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^SYSINFO<CR>'
modem-manager[17284]: <debug> [1319692362.259697] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[17284]: <debug> [1319692363.192809] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>^RSSI:15<CR><LF>'
modem-manager[17284]: <info> [1319692364.208795] [main.c:41] mm_signal_handler(): Caught signal 2, shutting down...
modem-manager[17284]: <debug> [1319692364.208964] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT^CURC=0<CR>'
modem-manager[17284]: <debug> [1319692364.220529] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[17284]: <info> [1319692364.220926] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (registered -> disabling)
modem-manager[17284]: <debug> [1319692364.220992] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
modem-manager[17284]: <info> [1319692364.221015] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
modem-manager[17284]: <info> [1319692364.222333] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
modem-manager[17284]: <info> [1319692364.222437] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabling -> disabled)
modem-manager[17284]: <debug> [1319692364.223006] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CREG=0<CR>'
modem-manager[17284]: <debug> [1319692364.223174] [mm-manager.c:204] remove_modem(): Removed modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2
modem-manager[17284]: <debug> [1319692364.223275] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
modem-manager[17284]: <info> [1319692364.223301] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
modem-manager[17284]: <info> [1319692364.225315] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
modem-manager[17284]: mm_serial_port_close_force: assertion `priv->open_count > 0' failed
[
Date Prev][
Date Next] [
Thread Prev][
Thread Next]
[
Thread Index]
[
Date Index]
[
Author Index]
