Re: Hello, please help with my 3G device

[Emfox Zhou <emfoxzhou gmail com>]

On Mon, Jul 16, 2012 at 2:52 PM, Aleksander Morgado
<aleksander lanedo com> wrote:
>
>>>>>>> The Huawei plugin always starts probing USB interface 0; and it seems
>>>>>>> that none of the 3 ttyACM ports given has usbif 0, so never starts
>>>>>>> probing the other ports. The plugin should possibly wait up to N
>>>>>>> seconds
>>>>>>> for usbif 0 to appear, and keep on probing normally if it doesn't
>>>>>>> appear
>>>>>>> in that time.
>>>>>>>
>>>>>>> Will try to prepare a patch for that.
>>>>>>
>>>>>>
>>>>>>
>>>>>> Great! cannot wait to try :)
>>>>>>
>>>>>
>>>>> Attached is a patch to apply on top of the MM_05 branch of
>>>>> ModemManager:
>>>>>     $> git clone
>>>>> git://anongit.freedesktop.org/ModemManager/ModemManager
>>>>>     $> cd ModemManager
>>>>>     $> git checkout -b MM_05 origin/MM_05
>>>>>     $> git am /path/to/the/patch.diff
>>>>>     $> ./autogen.sh --prefix=/usr --sysconfdir=/etc
>>>>> --localstatedir=/var
>>>>>     $> make
>>>>>     $> sudo make install
>>>>>
>>>>> It is not a perfect solution, but should do the trick. I'll find a
>>>>> better fix for git master/0.7; as I do have some probing improvements
>>>>> ready there which would help quite a lot also in this case.
>>>>>
>>>>> Let me know if it worked or not, as I don't have any Huawei modem
>>>>> around
>>>>> to play with. Please attach debug logs in any case.
>>>>
>>>>
>>>>
>>>> Hello, it partially works.
>>>>
>>>> I can find the device in nm now, but when try to connect to 3g net, it
>>>> fails.
>>>>
>>>
>>> Seems we're mixing up which is the port we use for control and the one we
>>> use for PPP. Can you run "AT^GETPORTMODE" with minicom in each of the
>>> ttyUSB?
>>
>>
>> I suppose you mean ttACM*?
>>
>> I tried and all of them returned simple 'ERROR', seems not support that AT
>> command. and I do it while connecting to 3g net via wvdial, the result is
>> different: ACM0 just says locked, ACM1 respones the same to the situation
>> when offline, ACM2 instantly return some '^DSFLOWRPT' and '*PHBI'.
>>
>
> Ah wait, just found an error in your setup. When selecting a number to call
> in the connection profile, do *not* explicitly list the PDP context to use,
> so don't write "*99***1", write instead: "*99#". It seems we're building the
> wrong ATD call if you explicitly select the PDP context:
>
> (ttyACM0): --> 'ATD*99***1***2#<CR>'
> (ttyACM0): <-- '<CR><LF>+CME ERROR: 3<CR><LF>'
>
> Just provide a proper APN to connect to in your connection profile, and MM
> will try to create the PDP context if it doesn't exist or just connect to an
> already available one.
>
> The ports mismatch may end up not being an issue here as there seems to be
> no mismatch (ttyACM0 really seems to be the port to use for control).

Hello, it works now! nearly perfect, but still another problem, how
could I lock the
network to 3g(td-scdma), and not automaticly switch back and forth between
3g and 2g(edge, sometimes even gprs)? My signal here is sometimes a little low,
and I'd like to not switch back to 2g.

I tried the option 'Type', change it from 'any' to '3G(UMTS/HSPA)',
then the profile
didn't work.

Again the detailed log.

-- 
Emfox Zhou

GnuPG Public Key: 0xF7142EC2

emfox@emfox:~$ sudo killall -TERM modem-manager 
emfox@emfox:~$ ps aux|grep modem
emfox     9100  0.0  0.0  10492   872 pts/2    S+   17:22   0:00 grep modem
emfox@emfox:~$ sudo modem-manager --debug
modem-manager[9102]: <info>  [1342430572.348990] [main.c:167] main(): ModemManager (version 0.5.3.0) starting...
modem-manager[9102]: <info>  [1342430572.351242] [mm-manager.c:120] load_plugin(): Loaded plugin Nokia
modem-manager[9102]: <info>  [1342430572.351440] [mm-manager.c:120] load_plugin(): Loaded plugin Option
modem-manager[9102]: <info>  [1342430572.351608] [mm-manager.c:120] load_plugin(): Loaded plugin Linktop
modem-manager[9102]: <info>  [1342430572.351782] [mm-manager.c:120] load_plugin(): Loaded plugin X22X
modem-manager[9102]: <info>  [1342430572.351959] [mm-manager.c:120] load_plugin(): Loaded plugin Huawei
modem-manager[9102]: <info>  [1342430572.352139] [mm-manager.c:120] load_plugin(): Loaded plugin Option High-Speed
modem-manager[9102]: <info>  [1342430572.352320] [mm-manager.c:120] load_plugin(): Loaded plugin Novatel
modem-manager[9102]: <info>  [1342430572.352499] [mm-manager.c:120] load_plugin(): Loaded plugin ZTE
modem-manager[9102]: <info>  [1342430572.352674] [mm-manager.c:120] load_plugin(): Loaded plugin Gobi
modem-manager[9102]: <info>  [1342430572.352836] [mm-manager.c:120] load_plugin(): Loaded plugin AnyData
modem-manager[9102]: <info>  [1342430572.353005] [mm-manager.c:120] load_plugin(): Loaded plugin Wavecom
modem-manager[9102]: <info>  [1342430572.353178] [mm-manager.c:120] load_plugin(): Loaded plugin Samsung
modem-manager[9102]: <info>  [1342430572.353349] [mm-manager.c:120] load_plugin(): Loaded plugin Longcheer
modem-manager[9102]: <info>  [1342430572.353512] [mm-manager.c:120] load_plugin(): Loaded plugin Generic
modem-manager[9102]: <info>  [1342430572.353678] [mm-manager.c:120] load_plugin(): Loaded plugin MotoC
modem-manager[9102]: <info>  [1342430572.353854] [mm-manager.c:120] load_plugin(): Loaded plugin Sierra
modem-manager[9102]: <info>  [1342430572.354025] [mm-manager.c:120] load_plugin(): Loaded plugin Ericsson MBM
modem-manager[9102]: <info>  [1342430572.354195] [mm-manager.c:120] load_plugin(): Loaded plugin SimTech
modem-manager[9102]: <debug> [1342430572.357016] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM0) deferring support check
modem-manager[9102]: <debug> [1342430572.359256] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM1) deferring support check
modem-manager[9102]: <debug> [1342430572.360510] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM2) deferring support check
modem-manager[9102]: <debug> [1342430572.360791] [mm-manager.c:809] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted
modem-manager[9102]: <debug> [1342430572.360946] [mm-manager.c:809] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
modem-manager[9102]: <debug> [1342430572.361093] [mm-manager.c:809] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
modem-manager[9102]: <debug> [1342430572.361242] [mm-manager.c:809] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
modem-manager[9102]: <debug> [1342430575.362477] [mm-manager.c:457] supports_defer_timeout(): (ttyACM0): re-checking support...
modem-manager[9102]: <debug> [1342430575.363659] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM0) deferring support check
modem-manager[9102]: <debug> [1342430575.363772] [mm-manager.c:457] supports_defer_timeout(): (ttyACM1): re-checking support...
modem-manager[9102]: <debug> [1342430575.364494] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM1) deferring support check
modem-manager[9102]: <debug> [1342430575.364557] [mm-manager.c:457] supports_defer_timeout(): (ttyACM2): re-checking support...
modem-manager[9102]: <debug> [1342430575.365267] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM2) deferring support check
modem-manager[9102]: <debug> [1342430578.367519] [mm-manager.c:457] supports_defer_timeout(): (ttyACM0): re-checking support...
modem-manager[9102]: <debug> [1342430578.368811] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM0) deferring support check
modem-manager[9102]: <debug> [1342430578.368947] [mm-manager.c:457] supports_defer_timeout(): (ttyACM1): re-checking support...
modem-manager[9102]: <debug> [1342430578.369757] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM1) deferring support check
modem-manager[9102]: <debug> [1342430578.369827] [mm-manager.c:457] supports_defer_timeout(): (ttyACM2): re-checking support...
modem-manager[9102]: <debug> [1342430578.370545] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM2) deferring support check
modem-manager[9102]: <debug> [1342430581.372992] [mm-manager.c:457] supports_defer_timeout(): (ttyACM0): re-checking support...
modem-manager[9102]: <debug> [1342430581.374282] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM0) deferring support check
modem-manager[9102]: <debug> [1342430581.374417] [mm-manager.c:457] supports_defer_timeout(): (ttyACM1): re-checking support...
modem-manager[9102]: <debug> [1342430581.375268] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM1) deferring support check
modem-manager[9102]: <debug> [1342430581.375345] [mm-manager.c:457] supports_defer_timeout(): (ttyACM2): re-checking support...
modem-manager[9102]: <debug> [1342430581.376067] [mm-manager.c:491] try_supports_port(): (Huawei): (ttyACM2) deferring support check
modem-manager[9102]: <debug> [1342430584.377765] [mm-manager.c:457] supports_defer_timeout(): (ttyACM0): re-checking support...
modem-manager[9102]: <debug> [1342430584.378972] [mm-plugin-huawei.c:223] supports_port(): (Huawei): no longer waiting for usbif 0, will launch probing in interface (tty/ttyACM0)
modem-manager[9102]: <info>  [1342430584.379733] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM0) opening serial port...
modem-manager[9102]: <debug> [1342430584.381894] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430584.382033] [mm-manager.c:457] supports_defer_timeout(): (ttyACM1): re-checking support...
modem-manager[9102]: <debug> [1342430584.382897] [mm-plugin-huawei.c:223] supports_port(): (Huawei): no longer waiting for usbif 0, will launch probing in interface (tty/ttyACM1)
modem-manager[9102]: <info>  [1342430584.383274] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM1) opening serial port...
modem-manager[9102]: <debug> [1342430584.383850] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM1) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430584.383971] [mm-manager.c:457] supports_defer_timeout(): (ttyACM2): re-checking support...
modem-manager[9102]: <debug> [1342430584.384765] [mm-plugin-huawei.c:223] supports_port(): (Huawei): no longer waiting for usbif 0, will launch probing in interface (tty/ttyACM2)
modem-manager[9102]: <info>  [1342430584.385079] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM2) opening serial port...
modem-manager[9102]: <debug> [1342430584.385830] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM2) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430584.386888] [mm-at-serial-port.c:333] debug_log(): (ttyACM2): <-- '<CR><LF>+CGREG: 1,"D70A","003F"<CR><LF>'
modem-manager[9102]: <debug> [1342430584.387825] [mm-at-serial-port.c:333] debug_log(): (ttyACM2): <-- '<CR><LF>+CREG: 1,"D70A","003F"<CR><LF>'
modem-manager[9102]: <debug> [1342430584.388827] [mm-at-serial-port.c:333] debug_log(): (ttyACM2): <-- '<CR><LF>+CGREG: 1,"D70A","E455"<CR><LF>'
modem-manager[9102]: <debug> [1342430584.389826] [mm-at-serial-port.c:333] debug_log(): (ttyACM2): <-- '<CR><LF>+CREG: 1,"D70A","E455"<CR><LF>'
modem-manager[9102]: <debug> [1342430591.739237] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
modem-manager[9102]: <info>  [1342430591.739371] [mm-serial-port.c:859] mm_serial_port_close(): (ttyACM0) closing serial port...
modem-manager[9102]: <info>  [1342430591.757083] [mm-serial-port.c:880] mm_serial_port_close(): (ttyACM0) serial port closed
modem-manager[9102]: <debug> [1342430591.762786] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM1) device open count is 0 (close)
modem-manager[9102]: <info>  [1342430591.762867] [mm-serial-port.c:859] mm_serial_port_close(): (ttyACM1) closing serial port...
modem-manager[9102]: <info>  [1342430591.785081] [mm-serial-port.c:880] mm_serial_port_close(): (ttyACM1) serial port closed
modem-manager[9102]: <debug> [1342430591.791100] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM2) device open count is 0 (close)
modem-manager[9102]: <info>  [1342430591.791485] [mm-serial-port.c:859] mm_serial_port_close(): (ttyACM2) closing serial port...
modem-manager[9102]: <info>  [1342430591.812021] [mm-serial-port.c:880] mm_serial_port_close(): (ttyACM2) serial port closed
modem-manager[9102]: <info>  [1342430591.814009] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM0) opening serial port...
modem-manager[9102]: <debug> [1342430591.815017] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430591.815063] [mm-plugin-base.c:859] try_open(): (ttyACM0): probe requested by plugin 'Generic'
modem-manager[9102]: <info>  [1342430591.816007] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM1) opening serial port...
modem-manager[9102]: <debug> [1342430591.817087] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM1) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430591.817217] [mm-plugin-base.c:859] try_open(): (ttyACM1): probe requested by plugin 'Generic'
modem-manager[9102]: <info>  [1342430591.818026] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM2) opening serial port...
modem-manager[9102]: <debug> [1342430591.819044] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM2) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430591.819094] [mm-plugin-base.c:859] try_open(): (ttyACM2): probe requested by plugin 'Generic'
modem-manager[9102]: <debug> [1342430591.820037] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430591.820226] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430591.917073] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+GCAP<CR>'
modem-manager[9102]: <debug> [1342430591.919996] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430592.617436] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>AT+GCAP'
modem-manager[9102]: <debug> [1342430592.617655] [mm-at-serial-port.c:333] debug_log(): (ttyACM2): --> 'AT+GCAP<CR>'
modem-manager[9102]: <debug> [1342430592.617755] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+GCAP<CR>'
modem-manager[9102]: <debug> [1342430592.618076] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR>'
modem-manager[9102]: <debug> [1342430592.621046] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+GCAP:+FCLASS,+CGSM<CR><LF>'
modem-manager[9102]: <debug> [1342430592.622027] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.317891] [mm-at-serial-port.c:333] debug_log(): (ttyACM2): <-- 'AT+GCAP'
modem-manager[9102]: <debug> [1342430593.318037] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+GCAP'
modem-manager[9102]: <debug> [1342430593.318132] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
modem-manager[9102]: <info>  [1342430593.318175] [mm-serial-port.c:859] mm_serial_port_close(): (ttyACM0) closing serial port...
modem-manager[9102]: <info>  [1342430593.336304] [mm-serial-port.c:880] mm_serial_port_close(): (ttyACM0) serial port closed
modem-manager[9102]: <debug> [1342430593.336724] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><CR><LF>+GCAP:+FCLASS,+CGSM<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.336968] [mm-at-serial-port.c:333] debug_log(): (ttyACM2): <-- '<CR><CR><LF>+GCAP:+FCLASS,+CGSM<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.338289] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyACM0) type primary claimed by /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1
modem-manager[9102]: <info>  [1342430593.338592] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM0) opening serial port...
modem-manager[9102]: <debug> [1342430593.340096] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430593.340226] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
modem-manager[9102]: <debug> [1342430593.340334] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
modem-manager[9102]: <info>  [1342430593.340455] [mm-manager.c:564] do_grab_port(): (Generic): GSM modem /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1 claimed port ttyACM0
modem-manager[9102]: <debug> [1342430593.340569] [mm-manager.c:317] add_modem(): Added modem /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1
modem-manager[9102]: <debug> [1342430593.340671] [mm-manager.c:243] check_export_modem(): (tty/ttyACM0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1
modem-manager[9102]: <debug> [1342430593.340818] [mm-manager.c:243] check_export_modem(): (tty/ttyACM1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1
modem-manager[9102]: <debug> [1342430593.341079] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATE0<CR>'
modem-manager[9102]: <debug> [1342430593.341191] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM1) device open count is 0 (close)
modem-manager[9102]: <info>  [1342430593.341286] [mm-serial-port.c:859] mm_serial_port_close(): (ttyACM1) closing serial port...
modem-manager[9102]: <info>  [1342430593.360150] [mm-serial-port.c:880] mm_serial_port_close(): (ttyACM1) serial port closed
modem-manager[9102]: <debug> [1342430593.360562] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM2) device open count is 0 (close)
modem-manager[9102]: <info>  [1342430593.360772] [mm-serial-port.c:859] mm_serial_port_close(): (ttyACM2) closing serial port...
modem-manager[9102]: <info>  [1342430593.379046] [mm-serial-port.c:880] mm_serial_port_close(): (ttyACM2) serial port closed
modem-manager[9102]: <debug> [1342430593.723303] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>ATE0'
modem-manager[9102]: <debug> [1342430593.723675] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyACM1) type secondary claimed by /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1
modem-manager[9102]: <info>  [1342430593.723837] [mm-manager.c:564] do_grab_port(): (Generic): GSM modem /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1 claimed port ttyACM1
modem-manager[9102]: <debug> [1342430593.723897] [mm-manager.c:243] check_export_modem(): (tty/ttyACM2): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1
modem-manager[9102]: <debug> [1342430593.724112] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyACM2) type ignored claimed by /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1
modem-manager[9102]: <info>  [1342430593.724254] [mm-manager.c:564] do_grab_port(): (Generic): GSM modem /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1 claimed port ttyACM2
modem-manager[9102]: <debug> [1342430593.725922] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.725992] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+GMI<CR>'
modem-manager[9102]: <debug> [1342430593.734093] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>HuaWei<CR><LF>'
modem-manager[9102]: <debug> [1342430593.735105] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.735203] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+GMM<CR>'
modem-manager[9102]: <debug> [1342430593.745100] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>ET8282/6282<CR><LF>'
modem-manager[9102]: <debug> [1342430593.746092] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.746168] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+GMR<CR>'
modem-manager[9102]: <debug> [1342430593.755093] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>11.101.01.29.00<CR><LF>'
modem-manager[9102]: <debug> [1342430593.756124] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.756287] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGMI<CR>'
modem-manager[9102]: <debug> [1342430593.766116] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>HuaWei<CR><LF>'
modem-manager[9102]: <debug> [1342430593.767218] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.767538] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGMM<CR>'
modem-manager[9102]: <debug> [1342430593.776120] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>ET8282/6282<CR><LF>'
modem-manager[9102]: <debug> [1342430593.777117] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.777515] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGMR<CR>'
modem-manager[9102]: <debug> [1342430593.786068] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>11.101.01.29.00<CR><LF>'
modem-manager[9102]: <debug> [1342430593.787067] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.787173] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATI<CR>'
modem-manager[9102]: <debug> [1342430593.793077] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>Manufacturer: HuaWei<CR><LF>Model: ET8282/6282<CR><LF>Revision: 11.101.01.29.00<CR><LF>IMEI: 860098000018930<CR><LF>+CGAP: +FCLASS,+CGSM<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.793185] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATI1<CR>'
modem-manager[9102]: <debug> [1342430593.800131] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.800299] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+GSN<CR>'
modem-manager[9102]: <debug> [1342430593.808082] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>860098000018930'
modem-manager[9102]: <debug> [1342430593.809080] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.809146] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGSN<CR>'
modem-manager[9102]: <debug> [1342430593.818070] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>860098000018930'
modem-manager[9102]: <debug> [1342430593.819083] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.819282] [mm-modem-helpers.c:920] mm_create_device_identifier(): Device ID source '000012d100001d09Manufacturer:HuaWeiModel:ET8282/6282Revision:11.101.01.29.00IMEI:860098000018930+CGAP:+FCLASS,+CGSM86009800001893011.101.01.29.00ET8282/6282HuaWei'
modem-manager[9102]: <debug> [1342430593.819393] [mm-modem-helpers.c:921] mm_create_device_identifier(): Device ID '90fc8faabc63cd74fcc92d939eb04f1c5585ea03'
modem-manager[9102]: <debug> [1342430593.819511] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
modem-manager[9102]: <debug> [1342430593.819611] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATE0<CR>'
modem-manager[9102]: <debug> [1342430593.825082] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.825268] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
modem-manager[9102]: <debug> [1342430593.825308] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
modem-manager[9102]: <debug> [1342430593.837077] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.837338] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CPIN?<CR>'
modem-manager[9102]: <debug> [1342430593.864161] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CPIN: READY<CR><LF>'
modem-manager[9102]: <debug> [1342430593.867199] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.867297] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
modem-manager[9102]: <debug> [1342430593.867331] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
modem-manager[9102]: <debug> [1342430593.867426] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
modem-manager[9102]: <debug> [1342430593.932127] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CRSM: 144,0,"98680045911190184037"<CR><LF>'
modem-manager[9102]: <debug> [1342430593.933104] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430593.933176] [mm-serial-port.c:844] mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
modem-manager[9102]: <info>  [1342430593.933196] [mm-serial-port.c:859] mm_serial_port_close(): (ttyACM0) closing serial port...
modem-manager[9102]: <info>  [1342430593.951089] [mm-serial-port.c:880] mm_serial_port_close(): (ttyACM0) serial port closed
modem-manager[9102]: <debug> [1342430593.951222] [mm-generic-gsm.c:507] get_iccid_done(): SIM ID source '89860054191109810473'
modem-manager[9102]: <debug> [1342430593.951291] [mm-generic-gsm.c:508] get_iccid_done(): SIM ID '8818376e31233e18e3fe131b18110d48b549e6c0'
modem-manager[9102]: <debug> [1342430593.951552] [mm-manager.c:265] check_export_modem(): Exported modem /sys/devices/pci0000:00/0000:00:1d.1/usb6/6-1 as /org/freedesktop/ModemManager/Modems/0
modem-manager[9102]: <debug> [1342430593.951713] [mm-manager.c:278] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): VID 0x12D1 PID 0x1D09 (usb)
modem-manager[9102]: <debug> [1342430593.951758] [mm-manager.c:279] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): data port is ttyACM0
modem-manager[9102]: <info>  [1342430616.847570] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM0) opening serial port...
modem-manager[9102]: <debug> [1342430616.848944] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
modem-manager[9102]: <info>  [1342430616.849040] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling)
modem-manager[9102]: <debug> [1342430616.950896] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430616.950976] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATZ E0 V1<CR>'
modem-manager[9102]: <debug> [1342430616.960282] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- 'ATZ E0 V'
modem-manager[9102]: <debug> [1342430616.960879] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '1'
modem-manager[9102]: <debug> [1342430616.961872] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR>'
modem-manager[9102]: <debug> [1342430616.972933] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430616.973340] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATE0<CR>'
modem-manager[9102]: <debug> [1342430616.978893] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430616.980174] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
modem-manager[9102]: <debug> [1342430616.993917] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430616.994322] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATX4 &C1<CR>'
modem-manager[9102]: <debug> [1342430617.004906] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.005279] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CFUN=1<CR>'
modem-manager[9102]: <debug> [1342430617.017892] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <info>  [1342430617.018252] [mm-serial-port.c:741] mm_serial_port_open(): (ttyACM1) opening serial port...
modem-manager[9102]: <debug> [1342430617.019921] [mm-serial-port.c:810] mm_serial_port_open(): (ttyACM1) device open count is 1 (open)
modem-manager[9102]: <debug> [1342430617.020139] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+IFC=1,1<CR>'
modem-manager[9102]: <debug> [1342430617.033894] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
modem-manager[9102]: <debug> [1342430617.034237] [mm-serial-parsers.c:438] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[9102]: <debug> [1342430617.034482] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CPMS="ME","ME","ME"<CR>'
modem-manager[9102]: <debug> [1342430617.067072] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CMS ERROR: 303<CR><LF>'
modem-manager[9102]: <debug> [1342430617.067534] [mm-serial-parsers.c:438] mm_serial_parser_v1_parse(): Got failure code 303: Operation not supported
modem-manager[9102]: <debug> [1342430617.067782] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CNMI=2,1,2,1,0<CR>'
modem-manager[9102]: <debug> [1342430617.090901] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.091324] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CMGF=?<CR>'
modem-manager[9102]: <debug> [1342430617.104395] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CMGF: (0,1)<CR><LF>'
modem-manager[9102]: <debug> [1342430617.104976] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.105220] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CUSD=1<CR>'
modem-manager[9102]: <debug> [1342430617.121183] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.121625] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND=?<CR>'
modem-manager[9102]: <debug> [1342430617.137929] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: ("battchg",(0-5)),("signal",(0-4)),("service",(0-1)),("message",(0-1)),("call",(0-1)),("roam",(0-1)),("smsfull",(0-1))<CR><LF>'
modem-manager[9102]: <debug> [1342430617.138882] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.139330] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CSCS=?<CR>'
modem-manager[9102]: <debug> [1342430617.153139] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CSCS: ("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.153671] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CMGF=1<CR>'
modem-manager[9102]: <debug> [1342430617.164893] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <info>  [1342430617.165195] [mm-generic-gsm.c:1704] sms_set_format_cb(): (ttyACM0): using text mode for SMS
modem-manager[9102]: <debug> [1342430617.165426] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CMER=3,0,0,1<CR>'
modem-manager[9102]: <debug> [1342430617.184915] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 4<CR><LF>'
modem-manager[9102]: <debug> [1342430617.185264] [mm-serial-parsers.c:438] mm_serial_parser_v1_parse(): Got failure code 4: Operation not supported
modem-manager[9102]: <debug> [1342430617.185503] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CSCS="UCS2"<CR>'
modem-manager[9102]: <debug> [1342430617.202902] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.203223] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CSCS?<CR>'
modem-manager[9102]: <debug> [1342430617.213913] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF>'
modem-manager[9102]: <debug> [1342430617.215142] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <info>  [1342430617.215811] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled)
modem-manager[9102]: <debug> [1342430617.218423] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CREG=2<CR>'
modem-manager[9102]: <debug> [1342430617.236962] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.237505] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430617.266910] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430617.267846] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.267997] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CREG?<CR>'
modem-manager[9102]: <debug> [1342430617.280880] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CREG: 2,1,"D70A","BD45"<CR><LF>'
modem-manager[9102]: <debug> [1342430617.280976] [mm-generic-gsm.c:3007] mm_generic_gsm_set_reg_status(): CS registration state changed: 1
modem-manager[9102]: <info>  [1342430617.281080] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered)
modem-manager[9102]: <debug> [1342430617.281856] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.281938] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGREG=2<CR>'
modem-manager[9102]: <debug> [1342430617.293857] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.293960] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CREG=2<CR>'
modem-manager[9102]: <debug> [1342430617.294018] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+COPS=3,2;+COPS?<CR>'
modem-manager[9102]: <debug> [1342430617.294639] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): number => "*99#"
modem-manager[9102]: <debug> [1342430617.294666] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): username => "cmnet"
modem-manager[9102]: <debug> [1342430617.294680] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): password => "cmnet"
modem-manager[9102]: <debug> [1342430617.294692] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): apn => "cmnet"
modem-manager[9102]: <debug> [1342430617.294707] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): network_mode => 8
modem-manager[9102]: <debug> [1342430617.294721] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): allowed_mode => 4
modem-manager[9102]: <debug> [1342430617.294735] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): allowed_auth => 63
modem-manager[9102]: <debug> [1342430617.294755] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 0
modem-manager[9102]: <debug> [1342430617.294816] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 2
modem-manager[9102]: <debug> [1342430617.303251] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CREG=2'
modem-manager[9102]: <debug> [1342430617.305312] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.305941] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CGREG=2<CR>'
modem-manager[9102]: <debug> [1342430617.324590] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+COPS: 0,2,"46000",2<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.331961] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CGREG=2'
modem-manager[9102]: <debug> [1342430617.335364] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.335711] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+COPS=3,0;+COPS?<CR>'
modem-manager[9102]: <debug> [1342430617.357846] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+COPS: '
modem-manager[9102]: <debug> [1342430617.358837] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '0,0,"CHINA MOBILE",2<CR><LF>'
modem-manager[9102]: <debug> [1342430617.359834] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.359969] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430617.390902] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430617.391866] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.391970] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGREG?<CR>'
modem-manager[9102]: <debug> [1342430617.407863] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CGREG: 2,1,"D70A","BD45"<CR><LF>'
modem-manager[9102]: <debug> [1342430617.407930] [mm-generic-gsm.c:3007] mm_generic_gsm_set_reg_status(): PS registration state changed: 1
modem-manager[9102]: <debug> [1342430617.408854] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.408914] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430617.437999] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430617.439926] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.440225] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430617.474975] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430617.475912] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.476206] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430617.511032] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430617.511908] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.512334] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430617.547062] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430617.547916] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.548217] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+COPS=3,2;+COPS?<CR>'
modem-manager[9102]: <debug> [1342430617.574925] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+COPS: '
modem-manager[9102]: <debug> [1342430617.575913] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '0,2,"46000",2<CR><LF>'
modem-manager[9102]: <debug> [1342430617.576898] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.577138] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+COPS=3,0;+COPS?<CR>'
modem-manager[9102]: <debug> [1342430617.599912] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+COPS: '
modem-manager[9102]: <debug> [1342430617.600918] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '0,0,"CHINA MOBILE",2<CR><LF>'
modem-manager[9102]: <debug> [1342430617.601897] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430617.602129] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430617.631945] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430617.632920] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430647.739555] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430647.775303] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430647.776016] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430673.615839] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430673.651720] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430673.652660] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430673.652792] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430673.687751] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430673.688699] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430673.688849] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430673.722733] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430673.723699] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.099647] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): number => "*99#"
modem-manager[9102]: <debug> [1342430683.099684] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): username => "cmnet"
modem-manager[9102]: <debug> [1342430683.099699] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): password => "cmnet"
modem-manager[9102]: <debug> [1342430683.099712] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): apn => "cmnet"
modem-manager[9102]: <debug> [1342430683.099728] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): network_mode => 0
modem-manager[9102]: <debug> [1342430683.099743] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): allowed_mode => 0
modem-manager[9102]: <debug> [1342430683.099764] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): allowed_auth => 63
modem-manager[9102]: <debug> [1342430683.099784] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 0
modem-manager[9102]: <debug> [1342430683.099822] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 2
modem-manager[9102]: <debug> [1342430683.099866] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CREG?<CR>'
modem-manager[9102]: <debug> [1342430683.114060] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CREG: 2,1,"D70A","2105"<CR><LF>'
modem-manager[9102]: <debug> [1342430683.114972] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.115031] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGREG?<CR>'
modem-manager[9102]: <debug> [1342430683.127143] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CGREG: 2,1,"D70A","2105"<CR><LF>'
modem-manager[9102]: <debug> [1342430683.127983] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.128067] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 4
modem-manager[9102]: <debug> [1342430683.128125] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.156994] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.157970] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.158101] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.193033] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.194013] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.194177] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.228055] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.229004] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.229145] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CGDCONT?<CR>'
modem-manager[9102]: <debug> [1342430683.247038] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CGDCONT: 1,"IP","CMWAP","0.0.0.0",0,0<CR><LF>+CGDCONT: 2,"IP","cmnet","0.0.0.0",0,0<CR><LF>+CGDCONT: 3,"IP","","0.0.0.0",0,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.247179] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 5
modem-manager[9102]: <info>  [1342430683.247264] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting)
modem-manager[9102]: <debug> [1342430683.247305] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'ATD*99***2#<CR>'
modem-manager[9102]: <debug> [1342430683.269071] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>CONNECT 2800000<CR><LF>'
modem-manager[9102]: <debug> [1342430683.269354] [mm-port.c:181] mm_port_set_connected(): (ttyACM0): port now connected
modem-manager[9102]: <info>  [1342430683.269628] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected)
modem-manager[9102]: <debug> [1342430683.269809] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 6
modem-manager[9102]: <debug> [1342430683.272926] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.287074] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIND?'
modem-manager[9102]: <debug> [1342430683.288874] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430683.291874] [mm-manager.c:793] device_added(): (net/ppp0): could not get port's parent device
modem-manager[9102]: <debug> [1342430683.320039] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.320973] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.321093] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.329387] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIN'
modem-manager[9102]: <debug> [1342430683.330538] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430683.330994] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430683.332019] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430683.353026] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.355003] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.355214] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.365765] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIND'
modem-manager[9102]: <debug> [1342430683.365978] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430683.366975] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430683.392062] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.393044] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.393186] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.401421] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIND'
modem-manager[9102]: <debug> [1342430683.401998] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430683.403054] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430683.429188] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.430083] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.430461] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.439245] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIN'
modem-manager[9102]: <debug> [1342430683.440063] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430683.441036] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430683.442048] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430683.466184] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.467060] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430683.467467] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430683.476142] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIND'
modem-manager[9102]: <debug> [1342430683.477069] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430683.478483] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430683.504471] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430683.505059] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430690.383346] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430690.392387] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+'
modem-manager[9102]: <debug> [1342430690.393227] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'C'
modem-manager[9102]: <debug> [1342430690.394374] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'I'
modem-manager[9102]: <debug> [1342430690.395247] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'N'
modem-manager[9102]: <debug> [1342430690.396230] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430690.397280] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430690.398241] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430690.419280] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430690.421263] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430690.464490] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430690.473678] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIN'
modem-manager[9102]: <debug> [1342430690.474209] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430690.475252] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430690.476223] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430690.502321] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430690.503252] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430690.503389] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430690.511694] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIN'
modem-manager[9102]: <debug> [1342430690.512241] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430690.513235] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430690.514237] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430690.541293] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430690.542240] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430707.068393] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430707.081436] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430707.119856] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430707.120792] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430737.763397] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430737.772094] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIN'
modem-manager[9102]: <debug> [1342430737.772802] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430737.773797] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430737.776374] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430737.819906] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430737.820804] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430740.069203] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430740.078148] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+'
modem-manager[9102]: <debug> [1342430740.078975] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'C'
modem-manager[9102]: <debug> [1342430740.079926] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'I'
modem-manager[9102]: <debug> [1342430740.082736] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'ND'
modem-manager[9102]: <debug> [1342430740.083071] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430740.084167] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430740.125993] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430740.126960] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430767.736820] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430767.745562] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CIN'
modem-manager[9102]: <debug> [1342430767.745871] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430767.746785] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430767.747800] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430767.776164] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430773.068423] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430773.077089] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CI'
modem-manager[9102]: <debug> [1342430773.077958] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'N'
modem-manager[9102]: <debug> [1342430773.078959] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'D'
modem-manager[9102]: <debug> [1342430773.079961] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '?'
modem-manager[9102]: <debug> [1342430773.081157] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430773.107336] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CIND: 4,3,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430773.109017] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <info>  [1342430785.460664] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
modem-manager[9102]: <debug> [1342430785.460737] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): --> 'AT+CGACT=0,2<CR>'
modem-manager[9102]: <debug> [1342430785.480510] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- 'AT+CGACT=0,2'
modem-manager[9102]: <debug> [1342430785.481307] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR>'
modem-manager[9102]: <debug> [1342430785.488333] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430785.489310] [mm-at-serial-port.c:333] debug_log(): (ttyACM1): <-- '<CR><LF>+CME ERROR: 3<CR><LF>'
modem-manager[9102]: <debug> [1342430785.489361] [mm-serial-parsers.c:438] mm_serial_parser_v1_parse(): Got failure code 3: Operation not allowed
modem-manager[9102]: <debug> [1342430786.493506] [mm-port.c:181] mm_port_set_connected(): (ttyACM0): port now disconnected
modem-manager[9102]: <debug> [1342430786.493793] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <info>  [1342430786.494176] [mm-modem.c:746] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> registered)
modem-manager[9102]: <debug> [1342430786.831490] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>NO CARRIER<CR><LF>'
modem-manager[9102]: <debug> [1342430786.831650] [mm-serial-parsers.c:438] mm_serial_parser_v1_parse(): Got failure code 3: No carrier
modem-manager[9102]: <debug> [1342430792.430023] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): number => "*99#"
modem-manager[9102]: <debug> [1342430792.430053] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): username => "cmnet"
modem-manager[9102]: <debug> [1342430792.430068] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): password => "cmnet"
modem-manager[9102]: <debug> [1342430792.430080] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): apn => "cmnet"
modem-manager[9102]: <debug> [1342430792.430096] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): network_mode => 8
modem-manager[9102]: <debug> [1342430792.430111] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): allowed_mode => 4
modem-manager[9102]: <debug> [1342430792.430125] [mm-generic-gsm.c:5957] simple_connect(): (ttyACM0): allowed_auth => 63
modem-manager[9102]: <debug> [1342430792.430145] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 0
modem-manager[9102]: <debug> [1342430792.430183] [mm-generic-gsm.c:5846] simple_state_machine(): (ttyACM0): simple connect state 2
modem-manager[9102]: <debug> [1342430797.738247] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430797.774960] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,2,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430797.776760] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430827.757938] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430827.793856] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,3,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430827.794821] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430857.754582] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430857.789843] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430857.791722] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[9102]: <debug> [1342430887.751263] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[9102]: <debug> [1342430887.784655] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: 4,4,1,1,0,0,0<CR><LF>'
modem-manager[9102]: <debug> [1342430887.786631] [mm-at-serial-port.c:333] debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'


emfox@emfox:~$ sudo NM_PPP_DEBUG=1 /usr/sbin/NetworkManager --no-daemon
NetworkManager[9133]: <info> NetworkManager (version 0.9.4.0) is starting...
NetworkManager[9133]: <info> Read config file /etc/NetworkManager/NetworkManager.conf
NetworkManager[9133]:    SCPlugin-Ifupdown: init!
NetworkManager[9133]:    SCPlugin-Ifupdown: update_system_hostname
NetworkManager[9133]:    SCPluginIfupdown: management mode: unmanaged
NetworkManager[9133]:    SCPlugin-Ifupdown: devices added (path: /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/ssb0:0/net/wlan0, iface: wlan0)
NetworkManager[9133]:    SCPlugin-Ifupdown: device added (path: /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/ssb0:0/net/wlan0, iface: wlan0): no ifupdown configuration found.
NetworkManager[9133]:    SCPlugin-Ifupdown: devices added (path: /sys/devices/pci0000:00/0000:00:1c.5/0000:85:00.0/net/eth0, iface: eth0)
NetworkManager[9133]:    SCPlugin-Ifupdown: device added (path: /sys/devices/pci0000:00/0000:00:1c.5/0000:85:00.0/net/eth0, iface: eth0): no ifupdown configuration found.
NetworkManager[9133]:    SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/lo, iface: lo)
NetworkManager[9133]:    SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
NetworkManager[9133]:    SCPlugin-Ifupdown: end _init.
NetworkManager[9133]: <info> Loaded plugin ifupdown: (C) 2008 Canonical Ltd.  To report bugs please use the NetworkManager mailing list.
NetworkManager[9133]: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
NetworkManager[9133]:    Ifupdown: get unmanaged devices count: 0
NetworkManager[9133]:    SCPlugin-Ifupdown: (32680096) ... get_connections.
NetworkManager[9133]:    SCPlugin-Ifupdown: (32680096) ... get_connections (managed=false): return empty list.
NetworkManager[9133]:    keyfile: parsing China Mobile Internet 1 ... 
NetworkManager[9133]:    keyfile:     read connection 'China Mobile Internet 1'
NetworkManager[9133]:    keyfile: parsing LiangAn Coffee Free Wi-Fi ... 
NetworkManager[9133]:    keyfile:     read connection 'LiangAn Coffee Free Wi-Fi'
NetworkManager[9133]:    keyfile: parsing emfoxleojane ... 
NetworkManager[9133]:    keyfile:     read connection 'emfoxleojane'
NetworkManager[9133]:    Ifupdown: get unmanaged devices count: 0
NetworkManager[9133]: <info> modem-manager is now available
NetworkManager[9133]: <info> monitoring kernel firmware directory '/lib/firmware'.
NetworkManager[9133]: <info> found WiFi radio killswitch rfkill0 (at /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/ssb0:0/ieee80211/phy0/rfkill0) (driver (unknown))
NetworkManager[9133]: <info> found WiFi radio killswitch rfkill1 (at /sys/devices/platform/hp-wmi/rfkill/rfkill1) (driver hp-wmi)
NetworkManager[9133]: <info> WiFi enabled by radio killswitch; enabled by state file
NetworkManager[9133]: <info> WWAN enabled by radio killswitch; enabled by state file
NetworkManager[9133]: <info> WiMAX enabled by radio killswitch; enabled by state file
NetworkManager[9133]: <info> Networking is enabled by state file
NetworkManager[9133]: <info> (wlan0): using nl80211 for WiFi device control
NetworkManager[9133]: <warn> (wlan0): driver supports Access Point (AP) mode
NetworkManager[9133]: <info> (wlan0): new 802.11 WiFi device (driver: 'b43' ifindex: 3)
NetworkManager[9133]: <info> (wlan0): exported as /org/freedesktop/NetworkManager/Devices/0
NetworkManager[9133]: <info> (wlan0): now managed
NetworkManager[9133]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager[9133]: <info> (wlan0): bringing up device.
NetworkManager[9133]: <info> (wlan0): preparing device.
NetworkManager[9133]: <info> (wlan0): deactivating device (reason 'managed') [2]
NetworkManager[9133]: <warn> failed to allocate link cache: (-10) Operation not supported
NetworkManager[9133]: <info> (eth0): carrier is OFF
NetworkManager[9133]: <info> (eth0): new Ethernet device (driver: 'sky2' ifindex: 2)
NetworkManager[9133]: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
NetworkManager[9133]: <info> (eth0): now managed
NetworkManager[9133]: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager[9133]: <info> (eth0): bringing up device.
NetworkManager[9133]: <info> (eth0): preparing device.
NetworkManager[9133]: <info> (eth0): deactivating device (reason 'managed') [2]
NetworkManager[9133]: <info> Added default wired connection 'Wired connection 1' for /sys/devices/pci0000:00/0000:00:1c.5/0000:85:00.0/net/eth0
/sbin/ifup: interface lo already configured
NetworkManager[9133]: <warn> (ttyACM0): failed to look up interface index
NetworkManager[9133]: <info> (ttyACM0): new GSM/UMTS device (driver: 'cdc_acm' ifindex: 0)
NetworkManager[9133]: <info> (ttyACM0): exported as /org/freedesktop/NetworkManager/Devices/2
NetworkManager[9133]: <info> (ttyACM0): now managed
NetworkManager[9133]: <info> (ttyACM0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
NetworkManager[9133]: <info> (ttyACM0): deactivating device (reason 'managed') [2]
NetworkManager[9133]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
NetworkManager[9133]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
NetworkManager[9133]: <info> WWAN now enabled by management service
NetworkManager[9133]: <info> (wlan0): supplicant interface state: starting -> ready
NetworkManager[9133]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
NetworkManager[9133]: <info> (wlan0): supplicant interface state: ready -> inactive
NetworkManager[9133]: <warn> Trying to remove a non-existant call id.
NetworkManager[9133]: <info> (ttyACM0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
NetworkManager[9133]: <info> Activation (ttyACM0) starting connection 'China Mobile Internet 1'
NetworkManager[9133]: <info> (ttyACM0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 1 of 5 (Device Prepare) started...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 2 of 5 (Device Configure) starting...
NetworkManager[9133]: <info> (ttyACM0): device state change: prepare -> config (reason 'none') [40 50 0]
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 2 of 5 (Device Configure) successful.
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 3 of 5 (IP Configure Start) scheduled.
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 2 of 5 (Device Configure) complete.
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 3 of 5 (IP Configure Start) started...
NetworkManager[9133]: <info> (ttyACM0): device state change: config -> ip-config (reason 'none') [50 70 0]
NetworkManager[9133]: <info> starting PPP connection
NetworkManager[9133]: <info> pppd started with pid 9149
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 3 of 5 (IP Configure Start) complete.
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 4 of 5 (IPv6 Configure Timeout) started...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
Plugin /usr/lib/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'
using channel 12
Using interface ppp0
Connect: ppp0 <--> /dev/ttyACM0
** Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xe8c174aa> <pcomp> <accomp>]
NetworkManager[9133]:    SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
NetworkManager[9133]:    SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
rcvd [LCP ConfReq id=0x1 <asyncmap 0xa0000> <auth pap>]
sent [LCP ConfAck id=0x1 <asyncmap 0xa0000> <auth pap>]
rcvd [LCP ConfRej id=0x1 <magic 0xe8c174aa> <pcomp> <accomp>]
sent [LCP ConfReq id=0x2 <asyncmap 0x0>]
rcvd [LCP ConfAck id=0x2 <asyncmap 0x0>]
sent [LCP EchoReq id=0x0 magic=0x0]
** 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
sent [PAP AuthReq id=0x1 user="cmnet" password=<hidden>]
rcvd [LCP EchoRep id=0x0 magic=0x0]
rcvd [PAP AuthAck id=0x1 "Login OK"]
Remote message: Login OK
PAP authentication succeeded
** Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
rcvd [LCP ProtRej id=0x2 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
rcvd [IPCP ConfReq id=0x1 <addr 192.200.1.21>]
sent [IPCP ConfAck id=0x1 <addr 192.200.1.21>]
rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
sent [IPCP ConfReq id=0x2 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
rcvd [IPCP ConfNak id=0x2 <addr 10.253.112.185> <ms-dns1 211.140.13.188> <ms-dns2 211.140.188.188>]
sent [IPCP ConfReq id=0x3 <addr 10.253.112.185> <ms-dns1 211.140.13.188> <ms-dns2 211.140.188.188>]
rcvd [IPCP ConfAck id=0x3 <addr 10.253.112.185> <ms-dns1 211.140.13.188> <ms-dns2 211.140.188.188>]
local  IP address 10.253.112.185
remote IP address 192.200.1.21
primary   DNS address 211.140.13.188
secondary DNS address 211.140.188.188
** 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[9133]: <info> PPP manager(IP Config Get) reply received.
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 5 of 5 (IPv4 Commit) started...
Script /etc/ppp/ip-up started (pid 9157)
Script /etc/ppp/ip-up finished (pid 9157), status = 0x0
NetworkManager[9133]: <info> (ttyACM0): device state change: ip-config -> activated (reason 'none') [70 100 0]
NetworkManager[9133]: <info> Policy set 'China Mobile Internet 1' (ppp0) as default for IPv4 routing and DNS.
NetworkManager[9133]: <info> Activation (ttyACM0) successful, device activated.
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 5 of 5 (IPv4 Commit) complete.
NetworkManager[9133]: <info> (ttyACM0): device state change: activated -> disconnected (reason 'user-requested') [100 30 39]
NetworkManager[9133]: <info> (ttyACM0): deactivating device (reason 'user-requested') [39]
NetworkManager[9133]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
NetworkManager[9133]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
Terminating on signal 15
** Message: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate'
** Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
Connect time 1.6 minutes.
Sent 189091 bytes, received 4136036 bytes.
Script /etc/ppp/ip-down started (pid 9264)
** Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
sent [LCP TermReq id=0x3 "User request"]
rcvd [LCP TermAck id=0x3]
** Message: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect'
Connection terminated.
NetworkManager[9133]:    SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
** Message: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead'
Script /etc/ppp/ip-down finished (pid 9264), status = 0x0
** Message: nm-ppp-plugin: (nm_exit_notify): cleaning up
NetworkManager[9133]: <info> Activation (ttyACM0) starting connection 'China Mobile Internet 1'
NetworkManager[9133]: <info> (ttyACM0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 1 of 5 (Device Prepare) started...
NetworkManager[9133]: <info> Activation (ttyACM0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager[9133]: <warn> GSM connection failed: (32) Operation not supported
NetworkManager[9133]: <info> (ttyACM0): device state change: prepare -> failed (reason 'unknown') [40 120 1]
NetworkManager[9133]: <warn> Activation (ttyACM0) failed.
NetworkManager[9133]: <info> (ttyACM0): device state change: failed -> disconnected (reason 'none') [120 30 0]
NetworkManager[9133]: <info> (ttyACM0): deactivating device (reason 'none') [0]
NetworkManager[9133]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
NetworkManager[9133]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed