Attachment 588816 Details for Bug 827849 – NetworkManager and ModemManager debug output

NetworkManager and ModemManager debug output

debugoutput.log (text/x-log), 41.88 KB, created by firefexx on 2012-06-03 09:52:28 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: firefexx

Created: 2012-06-03 09:52:28 UTC

Size: 41.88 KB

patch

obsolete

>// NETWORKMANAGER OUTPUT
>[root@laptop ~]# NM_PPP_DEBUG=1 /usr/sbin/NetworkManager --no-daemon
>NetworkManager[2463]: <info> NetworkManager (version 0.9.4.0-9.git20120521.fc17) is starting...
>NetworkManager[2463]: <info> Read config file /etc/NetworkManager/NetworkManager.conf
>NetworkManager[2463]: <info> WEXT support is enabled
>NetworkManager[2463]: <info> VPN: loaded org.freedesktop.NetworkManager.openvpn
>NetworkManager[2463]: <info> VPN: loaded org.freedesktop.NetworkManager.vpnc
>NetworkManager[2463]: <info> VPN: loaded org.freedesktop.NetworkManager.pptp
>NetworkManager[2463]: <info> VPN: loaded org.freedesktop.NetworkManager.openconnect
>NetworkManager[2463]:    ifcfg-rh: Acquired D-Bus service com.redhat.ifcfgrh1
>NetworkManager[2463]: <info> Loaded plugin ifcfg-rh: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>NetworkManager[2463]: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>// edit: deleted some private wlan and vpn information
>NetworkManager[2463]:    keyfile: parsing O2 Surfstick ... 
>NetworkManager[2463]:    keyfile:     read connection 'O2 Surfstick'
>NetworkManager[2463]: <info> modem-manager is now available
>NetworkManager[2463]: <info> monitoring kernel firmware directory '/lib/firmware'.
>NetworkManager[2463]: <info> found WiFi radio killswitch rfkill1 (at /sys/devices/pci0000:00/0000:00:1c.0/0000:02:00.0/ieee80211/phy0/rfkill1) (driver (unknown))
>NetworkManager[2463]: <info> found WiFi radio killswitch rfkill0 (at /sys/devices/platform/hp-wmi/rfkill/rfkill0) (driver hp-wmi)
>NetworkManager[2463]: <info> WiFi disabled by radio killswitch; disabled by state file
>NetworkManager[2463]: <info> WWAN enabled by radio killswitch; enabled by state file
>NetworkManager[2463]: <info> WiMAX enabled by radio killswitch; enabled by state file
>NetworkManager[2463]: <info> Networking is enabled by state file
>NetworkManager[2463]: <error> [1338715882.212216] [wifi-utils-nl80211.c:669] nl80211_wiphy_info_handler(): Don't know the meaning of NL80211_ATTR_CIPHER_SUITES 0x000fac06.
>NetworkManager[2463]: <info> (wlan0): using nl80211 for WiFi device control
>NetworkManager[2463]: <warn> (wlan0): driver supports Access Point (AP) mode
>NetworkManager[2463]: <info> (wlan0): new 802.11 WiFi device (driver: 'ath9k' ifindex: 3)
>NetworkManager[2463]: <info> (wlan0): exported as /org/freedesktop/NetworkManager/Devices/0
>NetworkManager[2463]: <info> (wlan0): now managed
>NetworkManager[2463]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
>NetworkManager[2463]: <info> (wlan0): bringing up device.
>NetworkManager[2463]: <info> (wlan0): deactivating device (reason 'managed') [2]
>NetworkManager[2463]: <warn> failed to allocate link cache: (-10) Operation not supported
>NetworkManager[2463]: <info> (eth0): carrier is OFF
>NetworkManager[2463]: <info> (eth0): new Ethernet device (driver: 'r8169' ifindex: 2)
>NetworkManager[2463]: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
>NetworkManager[2463]: <info> (eth0): now managed
>NetworkManager[2463]: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
>NetworkManager[2463]: <info> (eth0): bringing up device.
>NetworkManager[2463]: <info> (eth0): preparing device.
>NetworkManager[2463]: <info> (eth0): deactivating device (reason 'managed') [2]
>NetworkManager[2463]: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
>NetworkManager[2463]: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
>NetworkManager[2463]: <warn> (ttyUSB0): failed to look up interface index
>NetworkManager[2463]: <info> (ttyUSB0): new GSM/UMTS device (driver: 'option1' ifindex: 0)
>NetworkManager[2463]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/2
>NetworkManager[2463]: <info> (ttyUSB0): now managed
>NetworkManager[2463]: <info> (ttyUSB0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
>NetworkManager[2463]: <info> (ttyUSB0): deactivating device (reason 'managed') [2]
>NetworkManager[2463]: <info> (ttyUSB0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
>NetworkManager[2463]: <info> WWAN now enabled by management service
>NetworkManager[2463]: <info> Activation (ttyUSB0) starting connection 'O2 Surfstick'
>NetworkManager[2463]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
>NetworkManager[2463]: <info> (ttyUSB0): device state change: prepare -> config (reason 'none') [40 50 0]
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
>NetworkManager[2463]: <info> (ttyUSB0): device state change: config -> ip-config (reason 'none') [50 70 0]
>NetworkManager[2463]: <info> starting PPP connection
>NetworkManager[2463]: <info> pppd started with pid 2479
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv6 Configure Timeout) started...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
>Plugin /usr/lib64/pppd/2.4.5/nm-pppd-plugin.so loaded.
>** Message: nm-ppp-plugin: (plugin_init): initializing
>** Message: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection'
>Can't create lock file /var/lock/ppp/LCK..ttyUSB0: No such file or directory
>** Message: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead'
>** Message: nm-ppp-plugin: (nm_exit_notify): cleaning up
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv4 Configure Timeout) scheduled...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv4 Configure Timeout) started...
>NetworkManager[2463]: <info> (ttyUSB0): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
>NetworkManager[2463]: <warn> Activation (ttyUSB0) failed.
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv4 Configure Timeout) complete.
>NetworkManager[2463]: <warn> pppd pid 2479 exited with error: Serial port lock failed
>NetworkManager[2463]: <info> (ttyUSB0): device state change: failed -> disconnected (reason 'none') [120 30 0]
>NetworkManager[2463]: <info> (ttyUSB0): deactivating device (reason 'none') [0]
>NetworkManager[2463]: <info> Activation (ttyUSB0) starting connection 'O2 Surfstick'
>NetworkManager[2463]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
>NetworkManager[2463]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
>NetworkManager[2463]: <warn> GSM connection failed: (32) Serial command timed out
>NetworkManager[2463]: <info> (ttyUSB0): device state change: prepare -> failed (reason 'unknown') [40 120 1]
>NetworkManager[2463]: <warn> Activation (ttyUSB0) failed.
>NetworkManager[2463]: <info> (ttyUSB0): device state change: failed -> disconnected (reason 'none') [120 30 0]
>NetworkManager[2463]: <info> (ttyUSB0): deactivating device (reason 'none') [0]
>NetworkManager[2463]: <info> WWAN now disabled by management service
>NetworkManager[2463]: <info> (ttyUSB0): now unmanaged
>NetworkManager[2463]: <info> (ttyUSB0): device state change: disconnected -> unmanaged (reason 'removed') [30 10 36]
>NetworkManager[2463]: <info> (ttyUSB0): cleaning up...
>NetworkManager[2463]: <info> (ttyUSB0): taking down device.
>NetworkManager[2463]: <info> the modem manager disappeared
>NetworkManager[2463]: <info> trying to start the modem manager...
>NetworkManager[2463]: <info> modem-manager is now available
>^CNetworkManager[2463]: <info> caught signal 2, shutting down normally.
>NetworkManager[2463]: <info> (wlan0): now unmanaged
>NetworkManager[2463]: <info> (wlan0): device state change: unavailable -> unmanaged (reason 'removed') [20 10 36]
>NetworkManager[2463]: <info> (eth0): now unmanaged
>NetworkManager[2463]: <info> (eth0): device state change: unavailable -> unmanaged (reason 'removed') [20 10 36]
>NetworkManager[2463]: <info> (eth0): cleaning up...
>NetworkManager[2463]: <info> (eth0): taking down device.
>NetworkManager[2463]: <info> exiting (success)
>
>
>
>// MODEMMANAGER OUTPUT
>[root@laptop ~]# modem-manager --debug
>modem-manager[2382]: <info>  [1338715824.556865] [main.c:167] main(): ModemManager (version 0.5.2.0-1.fc17) starting...
>modem-manager[2382]: <info>  [1338715824.561580] [mm-manager.c:120] load_plugin(): Loaded plugin Option High-Speed
>modem-manager[2382]: <info>  [1338715824.562202] [mm-manager.c:120] load_plugin(): Loaded plugin Huawei
>modem-manager[2382]: <info>  [1338715824.562686] [mm-manager.c:120] load_plugin(): Loaded plugin Option
>modem-manager[2382]: <info>  [1338715824.563154] [mm-manager.c:120] load_plugin(): Loaded plugin Wavecom
>modem-manager[2382]: <info>  [1338715824.563591] [mm-manager.c:120] load_plugin(): Loaded plugin X22X
>modem-manager[2382]: <info>  [1338715824.564047] [mm-manager.c:120] load_plugin(): Loaded plugin Novatel
>modem-manager[2382]: <info>  [1338715824.564465] [mm-manager.c:120] load_plugin(): Loaded plugin SimTech
>modem-manager[2382]: <info>  [1338715824.565048] [mm-manager.c:120] load_plugin(): Loaded plugin Samsung
>modem-manager[2382]: <info>  [1338715824.565597] [mm-manager.c:120] load_plugin(): Loaded plugin ZTE
>modem-manager[2382]: <info>  [1338715824.566152] [mm-manager.c:120] load_plugin(): Loaded plugin MotoC
>modem-manager[2382]: <info>  [1338715824.566672] [mm-manager.c:120] load_plugin(): Loaded plugin Longcheer
>modem-manager[2382]: <info>  [1338715824.567216] [mm-manager.c:120] load_plugin(): Loaded plugin Generic
>modem-manager[2382]: <info>  [1338715824.567753] [mm-manager.c:120] load_plugin(): Loaded plugin AnyData
>modem-manager[2382]: <info>  [1338715824.568332] [mm-manager.c:120] load_plugin(): Loaded plugin Gobi
>modem-manager[2382]: <info>  [1338715824.568872] [mm-manager.c:120] load_plugin(): Loaded plugin Sierra
>modem-manager[2382]: <info>  [1338715824.569455] [mm-manager.c:120] load_plugin(): Loaded plugin Ericsson MBM
>modem-manager[2382]: <info>  [1338715824.570031] [mm-manager.c:120] load_plugin(): Loaded plugin Nokia
>modem-manager[2382]: <info>  [1338715824.570621] [mm-manager.c:120] load_plugin(): Loaded plugin Linktop
>modem-manager[2382]: <debug> [1338715824.576760] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB1) deferring support check
>modem-manager[2382]: <debug> [1338715824.577312] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyUSB2) deferring support check
>modem-manager[2382]: <debug> [1338715824.577465] [mm-manager.c:809] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted
>modem-manager[2382]: <debug> [1338715824.577606] [mm-manager.c:809] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
>modem-manager[2382]: <debug> [1338715824.577741] [mm-manager.c:809] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
>modem-manager[2382]: <debug> [1338715824.577924] [mm-manager.c:809] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
>modem-manager[2382]: <info>  [1338715824.584409] [mm-serial-port.c:741] mm_serial_port_open(): (ttyUSB0) opening serial port...
>modem-manager[2382]: <debug> [1338715824.585665] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
>modem-manager[2382]: <debug> [1338715824.585715] [mm-plugin-base.c:859] try_open(): (ttyUSB0): probe requested by plugin 'Huawei'
>modem-manager[2382]: <debug> [1338715824.688696] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
>modem-manager[2382]: <debug> [1338715825.397904] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.398060] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
>modem-manager[2382]: <info>  [1338715825.398093] [mm-serial-port.c:859] mm_serial_port_close(): (ttyUSB0) closing serial port...
>modem-manager[2382]: <info>  [1338715825.399074] [mm-serial-port.c:880] mm_serial_port_close(): (ttyUSB0) serial port closed
>modem-manager[2382]: <debug> [1338715825.406275] [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.1
>modem-manager[2382]: <info>  [1338715825.406415] [mm-serial-port.c:741] mm_serial_port_open(): (ttyUSB0) opening serial port...
>modem-manager[2382]: <debug> [1338715825.407346] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
>modem-manager[2382]: <debug> [1338715825.407463] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
>modem-manager[2382]: <debug> [1338715825.407496] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB0) device open count is 3 (open)
>modem-manager[2382]: <info>  [1338715825.407571] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1 claimed port ttyUSB0
>modem-manager[2382]: <debug> [1338715825.407597] [mm-manager.c:317] add_modem(): Added modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1
>modem-manager[2382]: <debug> [1338715825.407630] [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.1
>modem-manager[2382]: <debug> [1338715825.407663] [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.1
>modem-manager[2382]: <debug> [1338715825.407738] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
>modem-manager[2382]: <debug> [1338715825.419564] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.419695] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+GMI<CR>'
>modem-manager[2382]: <debug> [1338715825.433929] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>huawei<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.434072] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+GMM<CR>'
>modem-manager[2382]: <debug> [1338715825.442633] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>E1750<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.442748] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+GMR<CR>'
>modem-manager[2382]: <debug> [1338715825.454933] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>11.126.08.01.00<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.455062] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGMI<CR>'
>modem-manager[2382]: <debug> [1338715825.469236] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>huawei<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.469385] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGMM<CR>'
>modem-manager[2382]: <debug> [1338715825.483938] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>E1750<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.484066] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGMR<CR>'
>modem-manager[2382]: <debug> [1338715825.498366] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>11.126.08.01.00<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.498515] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATI<CR>'
>modem-manager[2382]: <debug> [1338715825.509300] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1750<CR><LF>Revision: 11.126.08.01.00<CR><LF>IMEI: 355013044763948<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.509454] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATI1<CR>'
>modem-manager[2382]: <debug> [1338715825.516423] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: huawei<CR><LF>Model: E1750<CR><LF>Revision: 11.126.08.01.00<CR><LF>IMEI: 355013044763948<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.516579] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+GSN<CR>'
>modem-manager[2382]: <debug> [1338715825.530381] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>355013044763948<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.530514] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGSN<CR>'
>modem-manager[2382]: <debug> [1338715825.544444] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>355013044763948<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.544633] [mm-modem-helpers.c:920] mm_create_device_identifier(): Device ID source '000012d100001436Manufacturer:huaweiModel:E1750Revision:11.126.08.01.00IMEI:355013044763948+GCAP:+CGSM,+DS,+ES35501304476394811.126.08.01.00E1750huawei'
>modem-manager[2382]: <debug> [1338715825.544671] [mm-modem-helpers.c:921] mm_create_device_identifier(): Device ID 'c76eef3783b95027478a48b6319d3a3942c715cb'
>modem-manager[2382]: <debug> [1338715825.544746] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB0) device open count is 2 (close)
>modem-manager[2382]: <debug> [1338715825.544790] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
>modem-manager[2382]: <debug> [1338715825.551388] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.551584] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
>modem-manager[2382]: <debug> [1338715825.551630] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
>modem-manager[2382]: <debug> [1338715825.569208] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.569317] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CPIN?<CR>'
>modem-manager[2382]: <debug> [1338715825.584653] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.584817] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB0) device open count is 2 (open)
>modem-manager[2382]: <debug> [1338715825.584874] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB0) device open count is 1 (close)
>modem-manager[2382]: <debug> [1338715825.584935] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
>modem-manager[2382]: <debug> [1338715825.669972] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CRSM: 144,0,"989422160143331544F6"<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715825.670099] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
>modem-manager[2382]: <info>  [1338715825.670128] [mm-serial-port.c:859] mm_serial_port_close(): (ttyUSB0) closing serial port...
>modem-manager[2382]: <info>  [1338715825.671092] [mm-serial-port.c:880] mm_serial_port_close(): (ttyUSB0) serial port closed
>modem-manager[2382]: <debug> [1338715825.671237] [mm-generic-gsm.c:507] get_iccid_done(): SIM ID source '8949226110343351446'
>modem-manager[2382]: <debug> [1338715825.671312] [mm-generic-gsm.c:508] get_iccid_done(): SIM ID '8e79028fa7af780b8ddea8fb4f9ba6d26633fb06'
>modem-manager[2382]: <debug> [1338715825.671432] [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.1
>modem-manager[2382]: <debug> [1338715827.579571] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB1): re-checking support...
>modem-manager[2382]: <info>  [1338715827.580410] [mm-serial-port.c:741] mm_serial_port_open(): (ttyUSB1) opening serial port...
>modem-manager[2382]: <debug> [1338715827.581858] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
>modem-manager[2382]: <debug> [1338715827.581968] [mm-manager.c:457] supports_defer_timeout(): (ttyUSB2): re-checking support...
>modem-manager[2382]: <info>  [1338715827.582716] [mm-serial-port.c:741] mm_serial_port_open(): (ttyUSB2) opening serial port...
>modem-manager[2382]: <debug> [1338715827.584195] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
>modem-manager[2382]: <debug> [1338715830.611358] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:44763948,0,0,0,20<CR><LF>'
>modem-manager[2382]: <debug> [1338715830.611499] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
>modem-manager[2382]: <info>  [1338715830.611528] [mm-serial-port.c:859] mm_serial_port_close(): (ttyUSB2) closing serial port...
>modem-manager[2382]: <info>  [1338715830.612524] [mm-serial-port.c:880] mm_serial_port_close(): (ttyUSB2) serial port closed
>modem-manager[2382]: <debug> [1338715830.613503] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB2) type secondary claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1
>modem-manager[2382]: <info>  [1338715830.613938] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1 claimed port ttyUSB2
>modem-manager[2382]: <debug> [1338715830.614024] [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.1
>modem-manager[2382]: <debug> [1338715834.588352] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
>modem-manager[2382]: <info>  [1338715834.588416] [mm-serial-port.c:859] mm_serial_port_close(): (ttyUSB1) closing serial port...
>modem-manager[2382]: <info>  [1338715834.589456] [mm-serial-port.c:880] mm_serial_port_close(): (ttyUSB1) serial port closed
>modem-manager[2382]: <debug> [1338715834.590605] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB1) type ignored claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1
>modem-manager[2382]: <info>  [1338715834.591188] [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1 claimed port ttyUSB1
>modem-manager[2382]: <debug> [1338715834.591460] [mm-manager.c:265] check_export_modem(): Exported modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1 as /org/freedesktop/ModemManager/Modems/0
>modem-manager[2382]: <debug> [1338715834.591603] [mm-manager.c:278] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): VID 0x12D1 PID 0x1436 (usb)
>modem-manager[2382]: <debug> [1338715834.591657] [mm-manager.c:279] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): data port is ttyUSB0
>modem-manager[2382]: <info>  [1338715901.042864] [mm-serial-port.c:741] mm_serial_port_open(): (ttyUSB0) opening serial port...
>modem-manager[2382]: <debug> [1338715901.044675] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
>modem-manager[2382]: <info>  [1338715901.044886] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling)
>modem-manager[2382]: <debug> [1338715901.146024] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATZ E0 V1<CR>'
>modem-manager[2382]: <debug> [1338715901.171144] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.171303] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATZ E0 V1<CR>'
>modem-manager[2382]: <debug> [1338715901.189947] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.190095] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATE0<CR>'
>modem-manager[2382]: <debug> [1338715901.201963] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.202077] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CMEE=1<CR>'
>modem-manager[2382]: <debug> [1338715901.218557] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.218781] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATX4 &C1<CR>'
>modem-manager[2382]: <debug> [1338715901.229329] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.229445] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CFUN=1<CR>'
>modem-manager[2382]: <debug> [1338715901.246783] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <info>  [1338715901.246956] [mm-serial-port.c:741] mm_serial_port_open(): (ttyUSB2) opening serial port...
>modem-manager[2382]: <debug> [1338715901.248418] [mm-serial-port.c:810] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
>modem-manager[2382]: <debug> [1338715901.248559] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+IFC=1,1<CR>'
>modem-manager[2382]: <debug> [1338715901.268211] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.268322] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CPMS="ME","ME","ME"<CR>'
>modem-manager[2382]: <debug> [1338715901.299365] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CPMS: 9,23,9,23,9,23<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.299463] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CNMI=2,1,2,1,0<CR>'
>modem-manager[2382]: <debug> [1338715901.325130] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CMS ERROR: 303<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.325235] [mm-serial-parsers.c:438] mm_serial_parser_v1_parse(): Got failure code 303: Operation not supported
>modem-manager[2382]: <debug> [1338715901.325293] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CMGF=?<CR>'
>modem-manager[2382]: <debug> [1338715901.336882] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CMGF: (0-1)<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.337045] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CUSD=1<CR>'
>modem-manager[2382]: <debug> [1338715901.354441] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.354543] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CIND=?<CR>'
>modem-manager[2382]: <debug> [1338715901.366130] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CIND: ("battchg",(0-5)),("signal",(0-5)),("service",(0-1)),("call",(0-1)),("roam",(0-1)),("smsfull",(0-1)),("GPRS coverage",(0-1)),("callsetup",(0-3))<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.366318] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT^SYSCFG?<CR>'
>modem-manager[2382]: <debug> [1338715901.385209] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSCFG:2,2,3FFFFFFF,1,2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.385382] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CSCS=?<CR>'
>modem-manager[2382]: <debug> [1338715901.404121] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSCS: ("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.404315] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CMGF=1<CR>'
>modem-manager[2382]: <debug> [1338715901.420616] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <info>  [1338715901.420695] [mm-generic-gsm.c:1704] sms_set_format_cb(): (ttyUSB0): using text mode for SMS
>modem-manager[2382]: <debug> [1338715901.420752] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CMER=3,0,0,1<CR>'
>modem-manager[2382]: <debug> [1338715901.443945] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.444048] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): --> 'AT+CMER=3,0,0,1<CR>'
>modem-manager[2382]: <debug> [1338715901.444086] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CSCS="UCS2"<CR>'
>modem-manager[2382]: <debug> [1338715901.467624] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.467759] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CSCS?<CR>'
>modem-manager[2382]: <debug> [1338715901.469727] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.483885] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <info>  [1338715901.484170] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled)
>modem-manager[2382]: <debug> [1338715901.484487] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CREG=2<CR>'
>modem-manager[2382]: <debug> [1338715901.507273] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.507709] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CIND?<CR>'
>modem-manager[2382]: <debug> [1338715901.523633] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CIND: 5,1,1,0,0,0,1,2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.523908] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CIND?<CR>'
>modem-manager[2382]: <debug> [1338715901.539897] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CIND: 5,1,1,0,0,0,1,2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.540110] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
>modem-manager[2382]: <debug> [1338715901.550847] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CREG: 2,1, A2F7, 1B90<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.550944] [mm-generic-gsm.c:3007] mm_generic_gsm_set_reg_status(): CS registration state changed: 1
>modem-manager[2382]: <info>  [1338715901.551134] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered)
>modem-manager[2382]: <debug> [1338715901.551263] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGREG=2<CR>'
>modem-manager[2382]: <debug> [1338715901.568945] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.569090] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): --> 'AT+CREG=2<CR>'
>modem-manager[2382]: <debug> [1338715901.569195] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+COPS=3,2;+COPS?<CR>'
>modem-manager[2382]: <debug> [1338715901.598132] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,2,"26207",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.598444] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+COPS=3,0;+COPS?<CR>'
>modem-manager[2382]: <debug> [1338715901.598945] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.599056] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): --> 'AT+CGREG=2<CR>'
>modem-manager[2382]: <debug> [1338715901.611329] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.627204] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,0,"o2 - de",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.627546] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CIND?<CR>'
>modem-manager[2382]: <debug> [1338715901.643624] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CIND: 5,1,1,0,0,0,1,2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.643948] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT^SYSINFO<CR>'
>modem-manager[2382]: <debug> [1338715901.663750] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.664137] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGREG?<CR>'
>modem-manager[2382]: <debug> [1338715901.681012] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CGREG: 2,1, A2F7, 1B90<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.681144] [mm-generic-gsm.c:3007] mm_generic_gsm_set_reg_status(): PS registration state changed: 1
>modem-manager[2382]: <debug> [1338715901.681328] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+COPS=3,2;+COPS?<CR>'
>modem-manager[2382]: <debug> [1338715901.708255] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,2,"26207",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.708446] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+COPS=3,0;+COPS?<CR>'
>modem-manager[2382]: <debug> [1338715901.737438] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+COPS: 0,0,"o2 - de",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.737620] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CIND?<CR>'
>modem-manager[2382]: <debug> [1338715901.753513] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CIND: 5,1,1,0,0,0,1,2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715901.753719] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT^SYSINFO<CR>'
>modem-manager[2382]: <debug> [1338715901.773516] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>^SYSINFO:2,3,0,5,1,,4<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715902.189888] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:44763948,0,0,0,20<CR><LF>'
>modem-manager[2382]: <debug> [1338715912.980523] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): number => "*99#"
>modem-manager[2382]: <debug> [1338715912.980572] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): network_mode => 6
>modem-manager[2382]: <debug> [1338715912.980590] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): home_only => TRUE
>modem-manager[2382]: <debug> [1338715912.980603] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): apn => "internet"
>modem-manager[2382]: <debug> [1338715912.980616] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): allowed_mode => 2
>modem-manager[2382]: <debug> [1338715912.980629] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): allowed_auth => 63
>modem-manager[2382]: <debug> [1338715912.980651] [mm-generic-gsm.c:5813] simple_state_machine(): (ttyUSB0): simple connect state 0
>modem-manager[2382]: <debug> [1338715912.980699] [mm-generic-gsm.c:5813] simple_state_machine(): (ttyUSB0): simple connect state 2
>modem-manager[2382]: <debug> [1338715912.980753] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
>modem-manager[2382]: <debug> [1338715912.996358] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CREG: 2,1, A2F7, 1B90<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715912.996560] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGREG?<CR>'
>modem-manager[2382]: <debug> [1338715913.008052] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CGREG: 2,1, A2F7, 1B90<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715913.008280] [mm-generic-gsm.c:5813] simple_state_machine(): (ttyUSB0): simple connect state 4
>modem-manager[2382]: <debug> [1338715913.008377] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGDCONT?<CR>'
>modem-manager[2382]: <debug> [1338715913.024787] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>+CGDCONT: 1,"IP","internet","0.0.0.0",0,0<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715913.024957] [mm-generic-gsm.c:5813] simple_state_machine(): (ttyUSB0): simple connect state 5
>modem-manager[2382]: <info>  [1338715913.025089] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting)
>modem-manager[2382]: <debug> [1338715913.025135] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'ATD*99***1#<CR>'
>modem-manager[2382]: <debug> [1338715913.042614] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): <-- '<CR><LF>CONNECT 7200000<CR><LF>'
>modem-manager[2382]: <debug> [1338715913.042756] [mm-port.c:181] mm_port_set_connected(): (ttyUSB0): port now connected
>modem-manager[2382]: <info>  [1338715913.042928] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected)
>modem-manager[2382]: <debug> [1338715913.043017] [mm-generic-gsm.c:5813] simple_state_machine(): (ttyUSB0): simple connect state 6
>modem-manager[2382]: <info>  [1338715913.064788] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
>modem-manager[2382]: <debug> [1338715913.064876] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): --> 'AT+CGACT=0,1<CR>'
>modem-manager[2382]: <debug> [1338715913.080823] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715914.083059] [mm-port.c:181] mm_port_set_connected(): (ttyUSB0): port now disconnected
>modem-manager[2382]: <info>  [1338715914.083282] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> registered)
>modem-manager[2382]: <debug> [1338715931.593468] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CIND?<CR>'
>modem-manager[2382]: <debug> [1338715931.870416] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): number => "*99#"
>modem-manager[2382]: <debug> [1338715931.870452] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): network_mode => 6
>modem-manager[2382]: <debug> [1338715931.870470] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): home_only => TRUE
>modem-manager[2382]: <debug> [1338715931.870508] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): apn => "internet"
>modem-manager[2382]: <debug> [1338715931.870521] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): allowed_mode => 2
>modem-manager[2382]: <debug> [1338715931.870534] [mm-generic-gsm.c:5924] simple_connect(): (ttyUSB0): allowed_auth => 63
>modem-manager[2382]: <debug> [1338715931.870555] [mm-generic-gsm.c:5813] simple_state_machine(): (ttyUSB0): simple connect state 0
>modem-manager[2382]: <debug> [1338715931.870602] [mm-generic-gsm.c:5813] simple_state_machine(): (ttyUSB0): simple connect state 2
>modem-manager[2382]: <debug> [1338715932.192307] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:44763948,0,0,0,20<CR><LF>'
>modem-manager[2382]: <debug> [1338715934.586956] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT^SYSINFO<CR>'
>modem-manager[2382]: <debug> [1338715937.587421] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CREG?<CR>'
>modem-manager[2382]: <debug> [1338715947.593965] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CGREG?<CR>'
>modem-manager[2382]: <debug> [1338715961.588736] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT+CIND?<CR>'
>modem-manager[2382]: <debug> [1338715962.194368] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>^BOOT:44763948,0,0,0,20<CR><LF>'
>modem-manager[2382]: <debug> [1338715964.587050] [mm-at-serial-port.c:333] debug_log(): (ttyUSB0): --> 'AT^SYSINFO<CR>'
>^Cmodem-manager[2382]: <info>  [1338715975.123879] [main.c:41] mm_signal_handler(): Caught signal 2, shutting down...
>modem-manager[2382]: <debug> [1338715975.124109] [mm-generic-gsm.c:2181] disable(): Shutting down secondary port
>modem-manager[2382]: <debug> [1338715975.124581] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): --> 'AT+CREG=0<CR>'
>modem-manager[2382]: <debug> [1338715975.135340] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715975.135533] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): --> 'AT+CGREG=0<CR>'
>modem-manager[2382]: <debug> [1338715975.147520] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715975.147794] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): --> 'AT+CMER=0<CR>'
>modem-manager[2382]: <debug> [1338715975.158977] [mm-at-serial-port.c:333] debug_log(): (ttyUSB2): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[2382]: <debug> [1338715975.159107] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
>modem-manager[2382]: <info>  [1338715975.159208] [mm-serial-port.c:859] mm_serial_port_close(): (ttyUSB2) closing serial port...
>modem-manager[2382]: <info>  [1338715975.160552] [mm-serial-port.c:880] mm_serial_port_close(): (ttyUSB2) serial port closed
>modem-manager[2382]: <info>  [1338715975.160799] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> disabling)
>modem-manager[2382]: <debug> [1338715975.160905] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
>modem-manager[2382]: <info>  [1338715975.160956] [mm-serial-port.c:859] mm_serial_port_close(): (ttyUSB0) closing serial port...
>modem-manager[2382]: <info>  [1338715975.161888] [mm-serial-port.c:880] mm_serial_port_close(): (ttyUSB0) serial port closed
>modem-manager[2382]: <info>  [1338715975.162452] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabling -> disabled)
>modem-manager[2382]: <debug> [1338715975.164217] [mm-manager.c:204] remove_modem(): Removed modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1

Actions: View

Attachments on bug 827849: 588816