problem with cinterion TC63i rs232 modem



Hi,

i try to use a Cinterion TC63i rs232 modem with the latest mm git snapshot and NM 0.8.4 but i'm unable to get a working connection when i start MM. Afer a MM restart, i get a working connection.

To reproduce, i do the following:

1 ) stop NM, MM and disconnect the modem from power supply
2 ) connect the modem to power supply
3 ) start MM: modem-manager --debug --log-level=DEBUG
4 ) start NM: /etc/init.d/network-manager start
5 ) nmcli con up uuid baa2af1b-e21e-7bcf-f1ac-1a775c46ddc3

No i have no connection (see debug log).

6 ) /etc/init.d/network-manager stop
7 ) kill modem-manager
8 ) start MM again: modem-manager --debug --log-level=DEBUG
9 ) start NM again: /etc/init.d/network-manager start
10) nmcli con up uuid baa2af1b-e21e-7bcf-f1ac-1a775c46ddc3

Now i have a working connection.

Here are the logs from MM:
# modem-manager --debug --log-level=DEBUG
modem-manager[2621]: <info> [1317807363.525644] [main.c:167] main(): ModemManager (version 0.5.999) starting... modem-manager[2621]: <info> [1317807363.652178] [mm-manager.c:158] found_plugin(): Loaded plugin 'Option' modem-manager[2621]: <info> [1317807363.653004] [mm-manager.c:158] found_plugin(): Loaded plugin 'X22X' modem-manager[2621]: <info> [1317807363.653694] [mm-manager.c:158] found_plugin(): Loaded plugin 'Ericsson MBM' modem-manager[2621]: <info> [1317807363.654055] [mm-manager.c:158] found_plugin(): Loaded plugin 'Sierra' modem-manager[2621]: <info> [1317807363.654348] [mm-manager.c:158] found_plugin(): Loaded plugin 'Linktop' modem-manager[2621]: <info> [1317807363.654611] [mm-manager.c:158] found_plugin(): Loaded plugin 'AnyData' modem-manager[2621]: <info> [1317807363.654869] [mm-manager.c:158] found_plugin(): Loaded plugin 'Longcheer' modem-manager[2621]: <info> [1317807363.655125] [mm-manager.c:158] found_plugin(): Loaded plugin 'Wavecom' modem-manager[2621]: <info> [1317807363.655380] [mm-manager.c:158] found_plugin(): Loaded plugin 'Novatel' modem-manager[2621]: <info> [1317807363.655622] [mm-manager.c:158] found_plugin(): Loaded plugin 'SimTech' modem-manager[2621]: <info> [1317807363.655874] [mm-manager.c:158] found_plugin(): Loaded plugin 'Nokia' modem-manager[2621]: <info> [1317807363.656139] [mm-manager.c:158] found_plugin(): Loaded plugin 'Samsung' modem-manager[2621]: <info> [1317807363.656397] [mm-manager.c:158] found_plugin(): Loaded plugin 'Gobi' modem-manager[2621]: <info> [1317807363.656654] [mm-manager.c:158] found_plugin(): Loaded plugin 'Huawei' modem-manager[2621]: <info> [1317807363.657299] [mm-manager.c:158] found_plugin(): Loaded plugin 'MotoC' modem-manager[2621]: <info> [1317807363.658010] [mm-manager.c:158] found_plugin(): Loaded plugin 'ZTE' modem-manager[2621]: <info> [1317807363.658720] [mm-manager.c:158] found_plugin(): Loaded plugin 'Option High-Speed' modem-manager[2621]: <info> [1317807363.659435] [mm-manager.c:158] found_plugin(): Loaded plugin 'Cinterion' modem-manager[2621]: <info> [1317807363.660157] [mm-manager.c:158] found_plugin(): Loaded plugin 'Generic' modem-manager[2621]: <info> [1317807363.660907] [mm-manager.c:210] load_plugins(): Successfully loaded 19 plugins modem-manager[2621]: <debug> [1317807363.668300] [mm-manager.c:1030] mm_manager_start(): Starting device scan... modem-manager[2621]: <debug> [1317807363.707812] [mm-manager.c:848] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted modem-manager[2621]: <debug> [1317807363.761078] [mm-manager.c:848] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted modem-manager[2621]: <debug> [1317807363.764429] [mm-manager.c:848] device_added(): (tty/ttyS4): port's parent platform driver is not whitelisted modem-manager[2621]: <debug> [1317807363.835010] [mm-manager.c:848] device_added(): (net/usb0): port's parent platform driver is not whitelisted modem-manager[2621]: <debug> [1317807363.837450] [mm-manager.c:1048] mm_manager_start(): Finished device scan... modem-manager[2621]: <info> [1317807363.838524] [mm-serial-port.c:805] mm_serial_port_open(): (ttyS1) opening serial port... modem-manager[2621]: <debug> [1317807363.840415] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 1 (open) modem-manager[2621]: <debug> [1317807363.841261] [mm-plugin-base.c:1030] try_open(): (ttyS1): probe requested by plugin 'Cinterion' modem-manager[2621]: <debug> [1317807363.954430] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GCAP<CR>' modem-manager[2621]: <debug> [1317807364.651444] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'AT+GCAP' modem-manager[2621]: <debug> [1317807364.663723] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR>' modem-manager[2621]: <debug> [1317807364.678822] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+GCAP: +CGSM,+FCLASS<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807364.681037] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMI<CR>' modem-manager[2621]: <debug> [1317807365.378346] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'AT+CGMI' modem-manager[2621]: <debug> [1317807365.393841] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR>' modem-manager[2621]: <debug> [1317807365.403782] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807365.405819] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMM<CR>' modem-manager[2621]: <debug> [1317807366.102838] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'AT+CGMM' modem-manager[2621]: <debug> [1317807366.113855] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR>' modem-manager[2621]: <debug> [1317807366.124005] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>TC63i<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.125397] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 0 (close) modem-manager[2621]: <info> [1317807366.125837] [mm-serial-port.c:923] mm_serial_port_close(): (ttyS1) closing serial port... modem-manager[2621]: <info> [1317807366.126507] [mm-serial-port.c:944] mm_serial_port_close(): (ttyS1) serial port closed modem-manager[2621]: <debug> [1317807366.129018] [mm-plugin-cinterion.c:92] check_vendor_cinterion(): Cinterion/Siemens RS232 modem detected modem-manager[2621]: <debug> [1317807366.151778] [mm-modem-base.c:207] mm_modem_base_add_port(): (ttyS1) type primary claimed by /sys/devices/platform/atmel_usart.1 modem-manager[2621]: <info> [1317807366.155801] [mm-serial-port.c:805] mm_serial_port_open(): (ttyS1) opening serial port... modem-manager[2621]: <debug> [1317807366.157271] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 1 (open) modem-manager[2621]: <debug> [1317807366.158624] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 2 (open) modem-manager[2621]: <debug> [1317807366.159610] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 3 (open) modem-manager[2621]: <info> [1317807366.161188] [mm-manager.c:603] do_grab_port(): (Cinterion): GSM modem /sys/devices/platform/atmel_usart.1 claimed port ttyS1 modem-manager[2621]: <debug> [1317807366.162140] [mm-manager.c:356] add_modem(): Added modem /sys/devices/platform/atmel_usart.1 modem-manager[2621]: <debug> [1317807366.163034] [mm-manager.c:282] check_export_modem(): (tty/ttyS1): outstanding support task prevents export of /sys/devices/platform/atmel_usart.1 modem-manager[2621]: <debug> [1317807366.167610] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATE0<CR>' modem-manager[2621]: <debug> [1317807366.183966] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'A' modem-manager[2621]: <debug> [1317807366.213893] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'TE0<CR>' modem-manager[2621]: <debug> [1317807366.224480] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.225645] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GMI<CR>' modem-manager[2621]: <debug> [1317807366.283910] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.285355] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GMM<CR>' modem-manager[2621]: <debug> [1317807366.333918] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>TC63i<CR><LF>' modem-manager[2621]: <debug> [1317807366.343950] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.345253] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GMR<CR>' modem-manager[2621]: <debug> [1317807366.403823] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>REVISION 01.100<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.405183] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMI<CR>' modem-manager[2621]: <debug> [1317807366.463837] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.465182] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMM<CR>' modem-manager[2621]: <debug> [1317807366.513864] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>TC63i<CR><LF>' modem-manager[2621]: <debug> [1317807366.523972] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.525296] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMR<CR>' modem-manager[2621]: <debug> [1317807366.583873] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>REVISION 01.100<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.585220] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATI<CR>' modem-manager[2621]: <debug> [1317807366.644250] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF>TC63i<CR><LF>REVISION 01.100<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.645675] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATI1<CR>' modem-manager[2621]: <debug> [1317807366.703876] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF>TC63i<CR><LF>REVISION 01.100<CR><LF>A-REVISION 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.705330] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GSN<CR>' modem-manager[2621]: <debug> [1317807366.763819] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>353229020722243<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.765181] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGSN<CR>' modem-manager[2621]: <debug> [1317807366.813842] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>353229020722243<CR><LF>' modem-manager[2621]: <debug> [1317807366.823965] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.826227] [mm-modem-helpers.c:886] mm_create_device_identifier(): Device ID source '00001e2d00000000CinterionTC63iREVISION01.100CinterionTC63iREVISION01.100A-REVISION01353229020722243REVISION01.100TC63iCinterion' modem-manager[2621]: <debug> [1317807366.826637] [mm-modem-helpers.c:887] mm_create_device_identifier(): Device ID 'bc9203971d1e1c995145ae9d0e7bcf89a0dce96c' modem-manager[2621]: <debug> [1317807366.827423] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 2 (close) modem-manager[2621]: <debug> [1317807366.827942] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATE0<CR>' modem-manager[2621]: <debug> [1317807366.883909] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.886059] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 1 (close) modem-manager[2621]: <debug> [1317807366.886514] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CMEE=1<CR>' modem-manager[2621]: <debug> [1317807366.943815] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807366.945001] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CPIN?<CR>' modem-manager[2621]: <debug> [1317807367.003871] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CPIN: SIM PIN<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807367.007112] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 2 (open) modem-manager[2621]: <debug> [1317807367.007659] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 1 (close) modem-manager[2621]: <debug> [1317807367.009145] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CRSM=176,12258,0,0,10<CR>' modem-manager[2621]: <debug> [1317807367.123843] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CRSM: 144,0,98940254124062517353<CR><LF><CR><LF>' modem-manager[2621]: <debug> [1317807367.134503] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807367.136153] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 0 (close) modem-manager[2621]: <info> [1317807367.136932] [mm-serial-port.c:923] mm_serial_port_close(): (ttyS1) closing serial port... modem-manager[2621]: <info> [1317807367.137912] [mm-serial-port.c:944] mm_serial_port_close(): (ttyS1) serial port closed modem-manager[2621]: <debug> [1317807367.139053] [mm-generic-gsm.c:495] get_iccid_done(): SIM ID source '89492045210426153735' modem-manager[2621]: <debug> [1317807367.139765] [mm-generic-gsm.c:496] get_iccid_done(): SIM ID '29d1ca4f5abbffc05cd633b0415ade2e0c1cd34b' modem-manager[2621]: <debug> [1317807367.142937] [mm-manager.c:304] check_export_modem(): Exported modem /sys/devices/platform/atmel_usart.1 as /org/freedesktop/ModemManager/Modems/0 modem-manager[2621]: <debug> [1317807367.144276] [mm-manager.c:317] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): VID 0x1E2D PID 0x0000 (platform) modem-manager[2621]: <debug> [1317807367.144618] [mm-manager.c:318] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): data port is ttyS1


Now i start NM, and the connection starts:


modem-manager[2621]: <info> [1317807396.230894] [mm-serial-port.c:805] mm_serial_port_open(): (ttyS1) opening serial port... modem-manager[2621]: <debug> [1317807396.231978] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 1 (open) modem-manager[2621]: <debug> [1317807396.233060] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CPIN="1719"<CR>' modem-manager[2621]: <debug> [1317807398.393870] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807398.395209] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CPIN?<CR>' modem-manager[2621]: <debug> [1317807398.494276] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <info> [1317807398.495276] [mm-modem-base.c:351] mm_modem_base_set_unlock_required(): Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required modem-manager[2621]: <info> [1317807398.496091] [mm-modem-base.c:390] mm_modem_base_set_unlock_retries(): Modem /org/freedesktop/ModemManager/Modems/0: # unlock retries is 0 modem-manager[2621]: <debug> [1317807398.500490] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 0 (close) modem-manager[2621]: <info> [1317807398.500882] [mm-serial-port.c:923] mm_serial_port_close(): (ttyS1) closing serial port... modem-manager[2621]: <info> [1317807398.501443] [mm-serial-port.c:944] mm_serial_port_close(): (ttyS1) serial port closed modem-manager[2621]: <info> [1317807398.522458] [mm-serial-port.c:805] mm_serial_port_open(): (ttyS1) opening serial port... modem-manager[2621]: <debug> [1317807398.524387] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 1 (open) modem-manager[2621]: <info> [1317807398.529528] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling) modem-manager[2621]: <debug> [1317807398.644265] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATZ E0 V1<CR>' modem-manager[2621]: <debug> [1317807399.443863] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807399.445033] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATZ E0 V1<CR>' modem-manager[2621]: <debug> [1317807400.474344] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.476058] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATE0<CR>' modem-manager[2621]: <debug> [1317807400.533863] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.535036] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CMEE=1<CR>' modem-manager[2621]: <debug> [1317807400.603864] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.605046] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATX4 &C1<CR>' modem-manager[2621]: <debug> [1317807400.664241] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.665428] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CFUN=1<CR>' modem-manager[2621]: <debug> [1317807400.723838] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.724754] [mm-modem-cinterion-gsm.c:1014] do_enable_power_up_done(): [1/3] Getting list of supported networks... modem-manager[2621]: <debug> [1317807400.725583] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+WS46=?<CR>' modem-manager[2621]: <debug> [1317807400.773814] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>(12)<CR><LF>' modem-manager[2621]: <debug> [1317807400.783965] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.784909] [mm-modem-cinterion-gsm.c:955] get_supported_networks_cb(): Device allows 2G-only network mode modem-manager[2621]: <debug> [1317807400.785243] [mm-modem-cinterion-gsm.c:987] get_supported_networks_cb(): [2/3] Getting list of supported functionality status... modem-manager[2621]: <debug> [1317807400.785972] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CFUN=?<CR>' modem-manager[2621]: <debug> [1317807400.853821] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CFUN: (0,1,7,9),(0,1)<CR><LF>' modem-manager[2621]: <debug> [1317807400.863964] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.864989] [mm-modem-cinterion-gsm.c:915] get_supported_functionality_status_cb(): Device supports CFUN=7 sleep mode modem-manager[2621]: <debug> [1317807400.865358] [mm-modem-cinterion-gsm.c:923] get_supported_functionality_status_cb(): [3/3] All done modem-manager[2621]: <debug> [1317807400.866905] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT\Q3<CR>' modem-manager[2621]: <debug> [1317807400.928789] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807400.929975] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CPMS="ME","ME"<CR>' modem-manager[2621]: <debug> [1317807404.014088] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CNMI=2,1,2,2,1<CR>' modem-manager[2621]: <debug> [1317807407.014387] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CUSD=1<CR>' modem-manager[2621]: <debug> [1317807407.203857] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CPMS: 0,25,0,25,1,45<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.205179] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CIND=?<CR>' modem-manager[2621]: <debug> [1317807407.263874] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>ERROR<CR><LF>' modem-manager[2621]: <debug> [1317807407.264755] [mm-serial-parsers.c:406] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error modem-manager[2621]: <debug> [1317807407.265583] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSCS=?<CR>' modem-manager[2621]: <debug> [1317807407.324309] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSCS: ("GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.327210] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSCS="UCS2"<CR>' modem-manager[2621]: <debug> [1317807407.383712] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.385374] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSCS?<CR>' modem-manager[2621]: <debug> [1317807407.433868] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF>' modem-manager[2621]: <debug> [1317807407.443839] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <info> [1317807407.450378] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled) modem-manager[2621]: <debug> [1317807407.455676] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CREG=2<CR>' modem-manager[2621]: <debug> [1317807407.513829] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.518831] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CREG?<CR>' modem-manager[2621]: <debug> [1317807407.573852] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CREG: 2,1,"013D","D4BF"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.574693] [mm-generic-gsm.c:2687] mm_generic_gsm_set_reg_status(): CS registration state changed: 1 modem-manager[2621]: <info> [1317807407.576933] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered) modem-manager[2621]: <debug> [1317807407.578430] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGREG=2<CR>' modem-manager[2621]: <debug> [1317807407.633864] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.635691] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,2;+COPS?<CR>' modem-manager[2621]: <debug> [1317807407.657141] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): network_mode => 0 modem-manager[2621]: <debug> [1317807407.657581] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): allowed_mode => 0 modem-manager[2621]: <debug> [1317807407.657880] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): username => "vodafone" modem-manager[2621]: <debug> [1317807407.658162] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): number => "*99#" modem-manager[2621]: <debug> [1317807407.658429] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): pin => "1719" modem-manager[2621]: <debug> [1317807407.658690] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): apn => "web.vodafone.de" modem-manager[2621]: <debug> [1317807407.658952] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): password => "vodafone" modem-manager[2621]: <debug> [1317807407.659460] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 0 modem-manager[2621]: <debug> [1317807407.660465] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 2 modem-manager[2621]: <debug> [1317807407.693913] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,2,"26202"<CR><LF>' modem-manager[2621]: <debug> [1317807407.695814] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.698500] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,0;+COPS?<CR>' modem-manager[2621]: <debug> [1317807407.753981] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,0,"Vodafone.de"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.758001] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2621]: <debug> [1317807407.814256] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 27,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.818274] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SIND?<CR>' modem-manager[2621]: <debug> [1317807407.893945] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: battchg,1,1<CR><LF>^SIND: signal,1,99<CR><LF>^SIND: service,1,1<CR><LF>^SIND: sounder,1,0<CR><LF>^SIND: message,1,1<CR><LF>^SIND: call,1,0' modem-manager[2621]: <debug> [1317807407.903844] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: roam,1,0' modem-manager[2621]: <debug> [1317807407.913880] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: smsfull,1,0<CR><LF>^SIND: rssi,1,4<CR><LF>^SIND: audio,0,0<CR><LF>^SIN' modem-manager[2621]: <debug> [1317807407.954427] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'D: simstatus,0,5<CR><LF>^SIND: vmwait1,0,0<CR><LF>^SIND: vmwait2,0,0<CR><LF>^SIND: ciphcall,0,1<CR><LF>^SIND: adnread,0,1<CR><LF>^SIND: eons,0,4,"0056006F006400610066006F006E0065002E00640065",""<CR><LF>^SIND: nitz,0,,,<CR><LF>^SIND: lsta,0,0<CR><LF>^SIND: band,0,3<CR><LF>^SIND: simlocal,0,1<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807407.957247] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGREG?<CR>' modem-manager[2621]: <debug> [1317807408.014161] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGREG: 2,0<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807408.016142] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CREG?<CR>' modem-manager[2621]: <debug> [1317807408.074118] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CREG: 2,1,"013D","D4BF"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807408.076152] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGREG?<CR>' modem-manager[2621]: <debug> [1317807408.133826] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGREG: 2,0<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807408.135854] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 4 modem-manager[2621]: <debug> [1317807408.136984] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2621]: <debug> [1317807408.193848] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2621]: <debug> [1317807408.234338] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 1 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807408.238855] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGDCONT?<CR>' modem-manager[2621]: <debug> [1317807408.293826] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807408.295149] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGDCONT=?<CR>' modem-manager[2621]: <debug> [1317807408.353836] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGDCONT: (1-2),"IP",,,(0),(0-1)<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807408.355709] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGDCONT=1,"IP","web.vodafone.de"<CR>' modem-manager[2621]: <debug> [1317807408.413816] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807408.415555] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 5 modem-manager[2621]: <info> [1317807408.418998] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting) modem-manager[2621]: <debug> [1317807408.420354] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATD*99***1#<CR>' modem-manager[2621]: <debug> [1317807408.548825] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '\0' modem-manager[2621]: <debug> [1317807410.433152] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>CONNECT<CR><LF>' modem-manager[2621]: <debug> [1317807410.463017] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '\0' modem-manager[2621]: <debug> [1317807410.583166] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}"} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"\140t~' modem-manager[2621]: <debug> [1317807410.893433] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}#} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"\196&~' modem-manager[2621]: <debug> [1317807411.502710] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}$} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"-\145~' modem-manager[2621]: <debug> [1317807412.722138] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}%} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"e\195~' modem-manager[2621]: <debug> [1317807415.161188] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}&} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"\1895~' modem-manager[2621]: <debug> [1317807418.159384] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}'} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"\245g~' modem-manager[2621]: <debug> [1317807421.157876] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}(} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"}^R~' modem-manager[2621]: <debug> [1317807424.156367] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!})} }<}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"6} ~' modem-manager[2621]: <debug> [1317807427.144808] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}*} }<' modem-manager[2621]: <debug> [1317807427.146786] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '}!}$}&@}#}$\192#}%}&\147-*\167}"}&} } } } }'}"}(}"\238\246~' modem-manager[2621]: <debug> [1317807430.143295] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>NO CARRIER<CR><LF>' modem-manager[2621]: <debug> [1317807430.153412] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGREG: 2<CR><LF>' modem-manager[2621]: <debug> [1317807430.153959] [mm-generic-gsm.c:2687] mm_generic_gsm_set_reg_status(): PS registration state changed: 2 modem-manager[2621]: <debug> [1317807430.163442] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGREG: 1,"013D","D4BF"<CR><LF>' modem-manager[2621]: <debug> [1317807430.164146] [mm-generic-gsm.c:2687] mm_generic_gsm_set_reg_status(): PS registration state changed: 1 modem-manager[2621]: <debug> [1317807469.014313] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,2;+COPS?<CR>' modem-manager[2621]: <debug> [1317807469.073828] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,2,"26202"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.075786] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,0;+COPS?<CR>' modem-manager[2621]: <debug> [1317807469.133764] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,0,"Vodafone.de"<CR><LF>' modem-manager[2621]: <debug> [1317807469.135690] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.137660] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2621]: <debug> [1317807469.193734] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 25,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.197679] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2621]: <debug> [1317807469.253737] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2621]: <debug> [1317807469.293808] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 2 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.296122] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2621]: <debug> [1317807469.354325] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 25,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.356430] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2621]: <debug> [1317807469.413900] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2621]: <debug> [1317807469.443694] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 2 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.446014] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2621]: <debug> [1317807469.503559] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 25,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.505453] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2621]: <debug> [1317807469.564147] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2621]: <debug> [1317807469.594076] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 2 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807469.596367] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CEER<CR>' modem-manager[2621]: <debug> [1317807469.653535] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CEER: 243,1,0<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <info> [1317807469.657406] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> registered) modem-manager[2621]: <debug> [1317807498.042726] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2621]: <debug> [1317807498.102345] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 25,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807498.103868] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2621]: <debug> [1317807498.152779] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2621]: <debug> [1317807498.192445] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 2 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807528.043129] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2621]: <debug> [1317807528.102217] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 25,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807528.103712] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2621]: <debug> [1317807528.152370] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2621]: <debug> [1317807528.192459] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 2 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>'


The connection is not working now.
i stop NM and kill MM:


^Cmodem-manager[2621]: <info> [1317807582.942642] [main.c:41] mm_signal_handler(): Caught signal 2, shutting down... modem-manager[2621]: (mm-generic-gsm.c:1788):disable: runtime check failed: (priv->cid == -1) modem-manager[2621]: <info> [1317807582.947475] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> disabling) modem-manager[2621]: <debug> [1317807582.964646] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CREG=0<CR>' modem-manager[2621]: <debug> [1317807583.182269] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807583.202710] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGREG=0<CR>' modem-manager[2621]: <debug> [1317807583.432453] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807583.452289] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CUSD=0<CR>' modem-manager[2621]: <debug> [1317807583.672346] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807583.692692] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CFUN=7<CR>' modem-manager[2621]: <debug> [1317807583.912418] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2621]: <debug> [1317807583.913317] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 0 (close) modem-manager[2621]: <info> [1317807583.913700] [mm-serial-port.c:923] mm_serial_port_close(): (ttyS1) closing serial port... modem-manager[2621]: <info> [1317807583.914204] [mm-serial-port.c:944] mm_serial_port_close(): (ttyS1) serial port closed modem-manager[2621]: <info> [1317807583.915956] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabling -> disabled) modem-manager[2621]: <debug> [1317807583.952280] [mm-manager.c:243] remove_modem(): Removed modem /sys/devices/platform/atmel_usart.1


Now i start MM again:


# modem-manager --debug --log-level=DEBUG
modem-manager[2762]: <info> [1317807612.844043] [main.c:167] main(): ModemManager (version 0.5.999) starting... modem-manager[2762]: <info> [1317807612.972405] [mm-manager.c:158] found_plugin(): Loaded plugin 'Option' modem-manager[2762]: <info> [1317807612.973218] [mm-manager.c:158] found_plugin(): Loaded plugin 'X22X' modem-manager[2762]: <info> [1317807612.973961] [mm-manager.c:158] found_plugin(): Loaded plugin 'Ericsson MBM' modem-manager[2762]: <info> [1317807612.974688] [mm-manager.c:158] found_plugin(): Loaded plugin 'Sierra' modem-manager[2762]: <info> [1317807612.975412] [mm-manager.c:158] found_plugin(): Loaded plugin 'Linktop' modem-manager[2762]: <info> [1317807612.976136] [mm-manager.c:158] found_plugin(): Loaded plugin 'AnyData' modem-manager[2762]: <info> [1317807612.976853] [mm-manager.c:158] found_plugin(): Loaded plugin 'Longcheer' modem-manager[2762]: <info> [1317807612.977563] [mm-manager.c:158] found_plugin(): Loaded plugin 'Wavecom' modem-manager[2762]: <info> [1317807612.978287] [mm-manager.c:158] found_plugin(): Loaded plugin 'Novatel' modem-manager[2762]: <info> [1317807612.979008] [mm-manager.c:158] found_plugin(): Loaded plugin 'SimTech' modem-manager[2762]: <info> [1317807612.979720] [mm-manager.c:158] found_plugin(): Loaded plugin 'Nokia' modem-manager[2762]: <info> [1317807612.980447] [mm-manager.c:158] found_plugin(): Loaded plugin 'Samsung' modem-manager[2762]: <info> [1317807612.981168] [mm-manager.c:158] found_plugin(): Loaded plugin 'Gobi' modem-manager[2762]: <info> [1317807612.982006] [mm-manager.c:158] found_plugin(): Loaded plugin 'Huawei' modem-manager[2762]: <info> [1317807612.982737] [mm-manager.c:158] found_plugin(): Loaded plugin 'MotoC' modem-manager[2762]: <info> [1317807612.983463] [mm-manager.c:158] found_plugin(): Loaded plugin 'ZTE' modem-manager[2762]: <info> [1317807612.984177] [mm-manager.c:158] found_plugin(): Loaded plugin 'Option High-Speed' modem-manager[2762]: <info> [1317807612.984897] [mm-manager.c:158] found_plugin(): Loaded plugin 'Cinterion' modem-manager[2762]: <info> [1317807612.985612] [mm-manager.c:158] found_plugin(): Loaded plugin 'Generic' modem-manager[2762]: <info> [1317807612.986361] [mm-manager.c:210] load_plugins(): Successfully loaded 19 plugins modem-manager[2762]: <debug> [1317807612.992746] [mm-manager.c:1030] mm_manager_start(): Starting device scan... modem-manager[2762]: <debug> [1317807613.031726] [mm-manager.c:848] device_added(): (tty/ttyS0): port's parent platform driver is not whitelisted modem-manager[2762]: <debug> [1317807613.084204] [mm-manager.c:848] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted modem-manager[2762]: <debug> [1317807613.087431] [mm-manager.c:848] device_added(): (tty/ttyS4): port's parent platform driver is not whitelisted modem-manager[2762]: <debug> [1317807613.158956] [mm-manager.c:848] device_added(): (net/usb0): port's parent platform driver is not whitelisted modem-manager[2762]: <debug> [1317807613.161359] [mm-manager.c:1048] mm_manager_start(): Finished device scan... modem-manager[2762]: <info> [1317807613.163027] [mm-serial-port.c:805] mm_serial_port_open(): (ttyS1) opening serial port... modem-manager[2762]: <debug> [1317807613.164566] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 1 (open) modem-manager[2762]: <debug> [1317807613.165019] [mm-plugin-base.c:1030] try_open(): (ttyS1): probe requested by plugin 'Cinterion' modem-manager[2762]: <debug> [1317807613.282950] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GCAP<CR>' modem-manager[2762]: <debug> [1317807614.102399] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>ERROR<CR><LF>' modem-manager[2762]: <debug> [1317807614.103456] [mm-serial-parsers.c:406] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error modem-manager[2762]: <debug> [1317807614.104942] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GCAP<CR>' modem-manager[2762]: <debug> [1317807614.912759] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+GCAP: +CGSM,+FCLASS<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807614.914292] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMI<CR>' modem-manager[2762]: <debug> [1317807615.712360] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF>' modem-manager[2762]: <debug> [1317807615.722472] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807615.724051] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMM<CR>' modem-manager[2762]: <debug> [1317807616.532357] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>TC63i<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.533760] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 0 (close) modem-manager[2762]: <info> [1317807616.534194] [mm-serial-port.c:923] mm_serial_port_close(): (ttyS1) closing serial port... modem-manager[2762]: <info> [1317807616.534856] [mm-serial-port.c:944] mm_serial_port_close(): (ttyS1) serial port closed modem-manager[2762]: <debug> [1317807616.537418] [mm-plugin-cinterion.c:92] check_vendor_cinterion(): Cinterion/Siemens RS232 modem detected modem-manager[2762]: <debug> [1317807616.560204] [mm-modem-base.c:207] mm_modem_base_add_port(): (ttyS1) type primary claimed by /sys/devices/platform/atmel_usart.1 modem-manager[2762]: <info> [1317807616.563560] [mm-serial-port.c:805] mm_serial_port_open(): (ttyS1) opening serial port... modem-manager[2762]: <debug> [1317807616.564954] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 1 (open) modem-manager[2762]: <debug> [1317807616.566372] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 2 (open) modem-manager[2762]: <debug> [1317807616.567360] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 3 (open) modem-manager[2762]: <info> [1317807616.568938] [mm-manager.c:603] do_grab_port(): (Cinterion): GSM modem /sys/devices/platform/atmel_usart.1 claimed port ttyS1 modem-manager[2762]: <debug> [1317807616.569880] [mm-manager.c:356] add_modem(): Added modem /sys/devices/platform/atmel_usart.1 modem-manager[2762]: <debug> [1317807616.570776] [mm-manager.c:282] check_export_modem(): (tty/ttyS1): outstanding support task prevents export of /sys/devices/platform/atmel_usart.1 modem-manager[2762]: <debug> [1317807616.575598] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATE0<CR>' modem-manager[2762]: <debug> [1317807616.632416] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.633988] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GMI<CR>' modem-manager[2762]: <debug> [1317807616.692408] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF>' modem-manager[2762]: <debug> [1317807616.694216] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.695989] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GMM<CR>' modem-manager[2762]: <debug> [1317807616.752477] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>TC63i<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.754194] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GMR<CR>' modem-manager[2762]: <debug> [1317807616.812370] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>REVISION 01.100<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.814136] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMI<CR>' modem-manager[2762]: <debug> [1317807616.872737] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF>' modem-manager[2762]: <debug> [1317807616.874601] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.876327] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMM<CR>' modem-manager[2762]: <debug> [1317807616.932325] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>TC63i<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.934068] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGMR<CR>' modem-manager[2762]: <debug> [1317807616.992321] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>REVISION 01.100<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807616.994073] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATI<CR>' modem-manager[2762]: <debug> [1317807617.052334] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF>TC63i<CR><LF>REVISION 01.100<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.054147] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATI1<CR>' modem-manager[2762]: <debug> [1317807617.122371] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>Cinterion<CR><LF>TC63i<CR><LF>REVISION 01.100<CR><LF>A-REVISION 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.124225] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+GSN<CR>' modem-manager[2762]: <debug> [1317807617.182351] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>353229020722243<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.184124] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGSN<CR>' modem-manager[2762]: <debug> [1317807617.242351] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>353229020722243<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.245012] [mm-modem-helpers.c:886] mm_create_device_identifier(): Device ID source '00001e2d00000000CinterionTC63iREVISION01.100CinterionTC63iREVISION01.100A-REVISION01353229020722243REVISION01.100TC63iCinterion' modem-manager[2762]: <debug> [1317807617.245810] [mm-modem-helpers.c:887] mm_create_device_identifier(): Device ID 'bc9203971d1e1c995145ae9d0e7bcf89a0dce96c' modem-manager[2762]: <debug> [1317807617.247056] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 2 (close) modem-manager[2762]: <debug> [1317807617.247978] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATE0<CR>' modem-manager[2762]: <debug> [1317807617.302449] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.304981] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 1 (close) modem-manager[2762]: <debug> [1317807617.305815] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CMEE=1<CR>' modem-manager[2762]: <debug> [1317807617.362738] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.364333] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CPIN?<CR>' modem-manager[2762]: <debug> [1317807617.432740] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.434462] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 2 (open) modem-manager[2762]: <debug> [1317807617.435417] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 1 (close) modem-manager[2762]: <debug> [1317807617.436472] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CRSM=176,12258,0,0,10<CR>' modem-manager[2762]: <debug> [1317807617.552348] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CRSM: 144,0,98940254124062517353<CR><LF><CR><LF>' modem-manager[2762]: <debug> [1317807617.562329] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807617.563964] [mm-serial-port.c:908] mm_serial_port_close(): (ttyS1) device open count is 0 (close) modem-manager[2762]: <info> [1317807617.564740] [mm-serial-port.c:923] mm_serial_port_close(): (ttyS1) closing serial port... modem-manager[2762]: <info> [1317807617.565719] [mm-serial-port.c:944] mm_serial_port_close(): (ttyS1) serial port closed modem-manager[2762]: <debug> [1317807617.566861] [mm-generic-gsm.c:495] get_iccid_done(): SIM ID source '89492045210426153735' modem-manager[2762]: <debug> [1317807617.567558] [mm-generic-gsm.c:496] get_iccid_done(): SIM ID '29d1ca4f5abbffc05cd633b0415ade2e0c1cd34b' modem-manager[2762]: <debug> [1317807617.570784] [mm-manager.c:304] check_export_modem(): Exported modem /sys/devices/platform/atmel_usart.1 as /org/freedesktop/ModemManager/Modems/0 modem-manager[2762]: <debug> [1317807617.572828] [mm-manager.c:317] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): VID 0x1E2D PID 0x0000 (platform) modem-manager[2762]: <debug> [1317807617.573545] [mm-manager.c:318] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): data port is ttyS1



Now i start NM and and do nmcli con up uuid baa2af1b-e21e-7bcf-f1ac-1a775c46ddc3:


modem-manager[2762]: <info> [1317807796.029018] [mm-serial-port.c:805] mm_serial_port_open(): (ttyS1) opening serial port... modem-manager[2762]: <debug> [1317807796.030105] [mm-serial-port.c:874] mm_serial_port_open(): (ttyS1) device open count is 1 (open) modem-manager[2762]: <info> [1317807796.044863] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling) modem-manager[2762]: <debug> [1317807796.162519] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATZ E0 V1<CR>' modem-manager[2762]: <debug> [1317807797.562083] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807797.563264] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATZ E0 V1<CR>' modem-manager[2762]: <debug> [1317807797.702057] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807797.703703] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATE0<CR>' modem-manager[2762]: <debug> [1317807797.761618] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807797.762807] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CMEE=1<CR>' modem-manager[2762]: <debug> [1317807797.811620] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807797.812830] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATX4 &C1<CR>' modem-manager[2762]: <debug> [1317807797.871634] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807797.872824] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CFUN=1<CR>' modem-manager[2762]: <debug> [1317807797.931651] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807797.932559] [mm-modem-cinterion-gsm.c:1014] do_enable_power_up_done(): [1/3] Getting list of supported networks... modem-manager[2762]: <debug> [1317807797.933387] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+WS46=?<CR>' modem-manager[2762]: <debug> [1317807797.982101] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>(12)<CR><LF>' modem-manager[2762]: <debug> [1317807797.991791] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807797.992737] [mm-modem-cinterion-gsm.c:955] get_supported_networks_cb(): Device allows 2G-only network mode modem-manager[2762]: <debug> [1317807797.993048] [mm-modem-cinterion-gsm.c:987] get_supported_networks_cb(): [2/3] Getting list of supported functionality status... modem-manager[2762]: <debug> [1317807797.993791] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CFUN=?<CR>' modem-manager[2762]: <debug> [1317807798.052148] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CFUN: (0,1,7,9),(0,1)<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.053180] [mm-modem-cinterion-gsm.c:915] get_supported_functionality_status_cb(): Device supports CFUN=7 sleep mode modem-manager[2762]: <debug> [1317807798.053562] [mm-modem-cinterion-gsm.c:923] get_supported_functionality_status_cb(): [3/3] All done modem-manager[2762]: <debug> [1317807798.055121] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT\Q3<CR>' modem-manager[2762]: <debug> [1317807798.111527] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.112695] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CPMS="ME","ME"<CR>' modem-manager[2762]: <debug> [1317807798.181647] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CPMS: 0,25,0,25,1,45<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.182925] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CNMI=2,1,2,2,1<CR>' modem-manager[2762]: <debug> [1317807798.231993] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.233174] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CUSD=1<CR>' modem-manager[2762]: <debug> [1317807798.291695] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.292922] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CIND=?<CR>' modem-manager[2762]: <debug> [1317807798.371740] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CIND: ((battchg,(0-5)),(signal,(0-7,99)),(service,(0-1)),(sounder,(0-1)),(message,(0-1)),(call,(0-1)),(roam,(0-1)),(smsfull,(0-1)),(rssi,(0-5,99)))<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.374703] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSCS=?<CR>' modem-manager[2762]: <debug> [1317807798.431629] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSCS: ("GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.434167] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CMER=3,0,0,2<CR>' modem-manager[2762]: <debug> [1317807798.491642] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.493251] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSCS="UCS2"<CR>' modem-manager[2762]: <debug> [1317807798.511674] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CIEV: battchg,1<CR><LF>\0\0\0\0' modem-manager[2762]: <debug> [1317807798.551668] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.553435] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSCS?<CR>' modem-manager[2762]: <debug> [1317807798.558155] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CIEV: rssi,3<CR><LF>' modem-manager[2762]: <debug> [1317807798.612054] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <info> [1317807798.618897] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled) modem-manager[2762]: <debug> [1317807798.639704] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CREG=2<CR>' modem-manager[2762]: <debug> [1317807798.691673] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.701801] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CREG?<CR>' modem-manager[2762]: <debug> [1317807798.761693] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CREG: 2,1,"013D","D4BF"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.762478] [mm-generic-gsm.c:2687] mm_generic_gsm_set_reg_status(): CS registration state changed: 1 modem-manager[2762]: <info> [1317807798.764683] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered) modem-manager[2762]: <debug> [1317807798.766165] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGREG=2<CR>' modem-manager[2762]: <debug> [1317807798.822055] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.831827] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,2;+COPS?<CR>' modem-manager[2762]: <debug> [1317807798.846295] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): network_mode => 0 modem-manager[2762]: <debug> [1317807798.846731] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): allowed_mode => 0 modem-manager[2762]: <debug> [1317807798.847028] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): username => "vodafone" modem-manager[2762]: <debug> [1317807798.847302] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): number => "*99#" modem-manager[2762]: <debug> [1317807798.847561] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): pin => "1719" modem-manager[2762]: <debug> [1317807798.847825] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): apn => "web.vodafone.de" modem-manager[2762]: <debug> [1317807798.848084] [mm-generic-gsm.c:5175] simple_connect(): (ttyS1): password => "vodafone" modem-manager[2762]: <debug> [1317807798.848587] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 0 modem-manager[2762]: <debug> [1317807798.849567] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 2 modem-manager[2762]: <debug> [1317807798.892249] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,2,"26202"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.894908] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,0;+COPS?<CR>' modem-manager[2762]: <debug> [1317807798.951663] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,0,"Vodafone.de"<CR><LF>' modem-manager[2762]: <debug> [1317807798.953576] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807798.957676] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2762]: <debug> [1317807799.012014] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 19,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.016163] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SIND?<CR>' modem-manager[2762]: <debug> [1317807799.102157] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: battchg,1,1<CR><LF>^SIND: signal,1,99<CR><LF>^SIND: service,1,1<CR><LF>^SIND: sounder,1,0<CR><LF>^SIND: message,1,1<CR><LF>^SIND: call,1,0<CR><LF>^SIND: roam,1,0<CR><LF>^SIND: smsfull,1,0<CR><LF>^SIND: rssi,1,3' modem-manager[2762]: <debug> [1317807799.104463] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: audio,0,0' modem-manager[2762]: <debug> [1317807799.121630] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: simstatus,0,5<CR><LF>^SIND: vmwait1,0,0' modem-manager[2762]: <debug> [1317807799.124070] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: vmwait2,0,0<CR><LF>^SIND: ciphcall,0,1<CR><LF>^SIND: adnread,0,1' modem-manager[2762]: <debug> [1317807799.157524] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: eons,0,4,"0056006F006400610066006F006E0065002E00640065",""<CR><LF>^SIND: nitz,0,,,<CR><LF>^SIND: lsta,0,0<CR><LF>^SIND: band,0,3<CR><LF>^SIND: simlocal,0,1<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.160233] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGREG?<CR>' modem-manager[2762]: <debug> [1317807799.221637] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGREG: 2,1,"013D","D4BF"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.222729] [mm-generic-gsm.c:2687] mm_generic_gsm_set_reg_status(): PS registration state changed: 1 modem-manager[2762]: <debug> [1317807799.225048] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CREG?<CR>' modem-manager[2762]: <debug> [1317807799.281669] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CREG: 2,1,"013D","D4BF"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.283670] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGREG?<CR>' modem-manager[2762]: <debug> [1317807799.341652] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGREG: 2,1,"013D","D4BF"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.343831] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 4 modem-manager[2762]: <debug> [1317807799.344920] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2762]: <debug> [1317807799.406658] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2762]: <debug> [1317807799.441636] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 2 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.446285] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,2;+COPS?<CR>' modem-manager[2762]: <debug> [1317807799.501550] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,2,"26202"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.503504] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+COPS=3,0;+COPS?<CR>' modem-manager[2762]: <debug> [1317807799.571656] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+COPS: 0,0,"Vodafone.de"<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.573612] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CSQ<CR>' modem-manager[2762]: <debug> [1317807799.631624] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CSQ: 19,99<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.633552] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SIND?<CR>' modem-manager[2762]: <debug> [1317807799.711734] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: battchg,1,1<CR><LF>^SIND: signal,1,99<CR><LF>^SIND: service,1,1<CR><LF>^SIND: sounder,1,0<CR><LF>^SIND: message,1,1<CR><LF>^SIND: call,1,0<CR><LF>^SIND: roam,1,0' modem-manager[2762]: <debug> [1317807799.721651] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: smsfull,1,0<CR><LF>^SIND: rssi,1,3' modem-manager[2762]: <debug> [1317807799.723902] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: audio,0,0' modem-manager[2762]: <debug> [1317807799.732275] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>^SIND: simstatus,0,5<CR><LF>^SIND: vmwait1,' modem-manager[2762]: <debug> [1317807799.771750] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '0,0<CR><LF>^SIND: vmwait2,0,0<CR><LF>^SIND: ciphcall,0,1<CR><LF>^SIND: adnread,0,1<CR><LF>^SIND: eons,0,4,"0056006F006400610066006F006E0065002E00640065",""<CR><LF>^SIND: nitz,0,,,<CR><LF>^SIND: lsta,0,0<CR><LF>^SIND: band,0,3<CR><LF>^SIND: simlocal,0,1<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.774328] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGDCONT?<CR>' modem-manager[2762]: <debug> [1317807799.831619] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.833271] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT^SMONG<CR>' modem-manager[2762]: <debug> [1317807799.891652] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>GPRS Monitor<CR><LF>' modem-manager[2762]: <debug> [1317807799.911766] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- 'BCCH G PBCCH PAT MCC MNC NOM TA RAC # Cell #<CR><LF>0073 2 - - 262 02 2 00 01<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.914092] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGDCONT=?<CR>' modem-manager[2762]: <debug> [1317807799.981644] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>+CGDCONT: (1-2),"IP",,,(0),(0-1)<CR><LF><CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807799.983882] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'AT+CGDCONT=1,"IP","web.vodafone.de"<CR>' modem-manager[2762]: <debug> [1317807800.041667] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>OK<CR><LF>' modem-manager[2762]: <debug> [1317807800.043377] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 5 modem-manager[2762]: <info> [1317807800.046889] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting) modem-manager[2762]: <debug> [1317807800.048231] [mm-at-serial-port.c:298] debug_log(): (ttyS1): --> 'ATD*99***1#<CR>' modem-manager[2762]: <debug> [1317807800.121628] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '<CR><LF>CONNECT<CR><LF>' modem-manager[2762]: <debug> [1317807800.123145] [mm-port.c:181] mm_port_set_connected(): (ttyS1): port now connected modem-manager[2762]: <info> [1317807800.126512] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected) modem-manager[2762]: <debug> [1317807800.127809] [mm-generic-gsm.c:5064] simple_state_machine(): (ttyS1): simple connect state 6 modem-manager[2762]: <debug> [1317807800.304932] [mm-at-serial-port.c:298] debug_log(): (ttyS1): <-- '~\255}#\192!}!}"} }<}!}$}&@}#}$\192#}%}&v}4Y}%}"}&} } } } }'}"}(}"1k~' modem-manager[2762]: <debug> [1317807800.369347] [mm-manager.c:832] device_added(): (net/ppp0): could not get port's parent device



The connection is working now.
my NM config is:

[connection]
id=ModemGSM
uuid=baa2af1b-e21e-7bcf-f1ac-1a775c46ddc3
type=gsm
autoconnect=false

[ppp]
nodeflate=true
no-vj-comp=true
nobsdcomp=true

[ipv4]
method=auto

[gsm]
number=*99#
username=vodafone
password=vodafone
apn=web.vodafone.de
pin=1719

[serial]
baud=56400





Any help appreciated.


Cheers,

Tom








[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]