Attachment 598631 Details for Bug 834871 – My 'modem-manager --debug' log

My 'modem-manager --debug' log

modem-manager-debug.txt (text/plain), 50.38 KB, created by Massimiliano on 2012-07-17 13:13:26 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Massimiliano

Created: 2012-07-17 13:13:26 UTC

Size: 50.38 KB

patch

obsolete

># /usr/sbin/modem-manager --debug
>modem-manager[6721]: <info>  [1342529332.394760] [main.c:167] main(): ModemManager (version 0.4.998-1.git20110706.fc16) starting...
>modem-manager[6721]: <info>  [1342529332.397908] [mm-manager.c:120] load_plugin(): Loaded plugin Linktop
>modem-manager[6721]: <info>  [1342529332.398182] [mm-manager.c:120] load_plugin(): Loaded plugin Option High-Speed
>modem-manager[6721]: <info>  [1342529332.398375] [mm-manager.c:120] load_plugin(): Loaded plugin MotoC
>modem-manager[6721]: <info>  [1342529332.398565] [mm-manager.c:120] load_plugin(): Loaded plugin Nokia
>modem-manager[6721]: <info>  [1342529332.398754] [mm-manager.c:120] load_plugin(): Loaded plugin Wavecom
>modem-manager[6721]: <info>  [1342529332.398953] [mm-manager.c:120] load_plugin(): Loaded plugin AnyData
>modem-manager[6721]: <info>  [1342529332.399142] [mm-manager.c:120] load_plugin(): Loaded plugin Novatel
>modem-manager[6721]: <info>  [1342529332.399332] [mm-manager.c:120] load_plugin(): Loaded plugin X22X
>modem-manager[6721]: <info>  [1342529332.399524] [mm-manager.c:120] load_plugin(): Loaded plugin Samsung
>modem-manager[6721]: <info>  [1342529332.399714] [mm-manager.c:120] load_plugin(): Loaded plugin Sierra
>modem-manager[6721]: <info>  [1342529332.399930] [mm-manager.c:120] load_plugin(): Loaded plugin Generic
>modem-manager[6721]: <info>  [1342529332.400135] [mm-manager.c:120] load_plugin(): Loaded plugin Huawei
>modem-manager[6721]: <info>  [1342529332.400343] [mm-manager.c:120] load_plugin(): Loaded plugin SimTech
>modem-manager[6721]: <info>  [1342529332.400556] [mm-manager.c:120] load_plugin(): Loaded plugin ZTE
>modem-manager[6721]: <info>  [1342529332.400765] [mm-manager.c:120] load_plugin(): Loaded plugin Gobi
>modem-manager[6721]: <info>  [1342529332.401233] [mm-manager.c:120] load_plugin(): Loaded plugin Ericsson MBM
>modem-manager[6721]: <info>  [1342529332.401604] [mm-manager.c:120] load_plugin(): Loaded plugin Longcheer
>modem-manager[6721]: <info>  [1342529332.401858] [mm-manager.c:120] load_plugin(): Loaded plugin Option
>modem-manager[6721]: <debug> [1342529332.403994] [mm-manager.c:809] device_added(): (tty/ttyS1): port's parent platform driver is not whitelisted
>modem-manager[6721]: <debug> [1342529332.404172] [mm-manager.c:809] device_added(): (tty/ttyS2): port's parent platform driver is not whitelisted
>modem-manager[6721]: <debug> [1342529332.404313] [mm-manager.c:809] device_added(): (tty/ttyS3): port's parent platform driver is not whitelisted
>modem-manager[6721]: <debug> [1342529332.404445] [mm-manager.c:793] device_added(): (tty/ttyS0): could not get port's parent device
>
>## == HERE I START TO PLUG MY INTERNET KEY ==
>
>modem-manager[6721]: <debug> [1342529444.460192] [mm-manager.c:491] try_supports_port(): (ZTE): (wwan0) deferring support check
>modem-manager[6721]: <info>  [1342529444.465824] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB1) opening serial port...
>modem-manager[6721]: <debug> [1342529444.467215] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529444.467259] [mm-plugin-base.c:848] try_open(): (ttyUSB1): probe requested by plugin 'ZTE'
>modem-manager[6721]: <info>  [1342529444.467632] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
>modem-manager[6721]: <debug> [1342529444.468879] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529444.468906] [mm-plugin-base.c:848] try_open(): (ttyUSB3): probe requested by plugin 'ZTE'
>modem-manager[6721]: <info>  [1342529444.469242] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB2) opening serial port...
>modem-manager[6721]: <debug> [1342529444.470388] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529444.470468] [mm-plugin-base.c:848] try_open(): (ttyUSB2): probe requested by plugin 'ZTE'
>modem-manager[6721]: <info>  [1342529444.470844] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB0) opening serial port...
>modem-manager[6721]: <debug> [1342529444.472014] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB0) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529444.472081] [mm-plugin-base.c:848] try_open(): (ttyUSB0): probe requested by plugin 'ZTE'
>modem-manager[6721]: <debug> [1342529444.569839] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529444.569967] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529444.571671] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529445.571868] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'ATE0+CPMS?'
>modem-manager[6721]: <debug> [1342529445.572532] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529445.970212] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- 'ATE0+CPMS?'
>modem-manager[6721]: <debug> [1342529445.970301] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- 'ATE0+CPMS?'
>modem-manager[6721]: <debug> [1342529445.970360] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529445.971467] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529445.971793] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529445.971975] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529445.972033] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529445.977575] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529445.977647] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529445.977726] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529446.977295] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529446.977389] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529446.977472] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529446.979910] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529446.979977] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529446.980086] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529446.986686] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529446.986748] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529446.986815] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529447.461183] [mm-manager.c:457] supports_defer_timeout(): (wwan0): re-checking support...
>modem-manager[6721]: <debug> [1342529447.461887] [mm-manager.c:491] try_supports_port(): (ZTE): (wwan0) deferring support check
>modem-manager[6721]: <debug> [1342529447.984540] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529447.984629] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529447.984697] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529447.987009] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529447.987069] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529447.987135] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529447.999871] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529447.999957] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529448.000039] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529448.775115] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529448.989759] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529448.989828] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529448.991919] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529448.991951] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529449.005095] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529449.005156] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529449.775401] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'ATE0+CPMS?'
>modem-manager[6721]: <debug> [1342529449.775479] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529449.775511] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529449.775606] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529449.776793] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529450.462732] [mm-manager.c:457] supports_defer_timeout(): (wwan0): re-checking support...
>modem-manager[6721]: <debug> [1342529450.463405] [mm-manager.c:491] try_supports_port(): (ZTE): (wwan0) deferring support check
>modem-manager[6721]: <debug> [1342529450.780717] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529450.780808] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529450.780961] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529450.781155] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529450.781213] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529450.781307] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529450.786038] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529450.786092] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529450.786186] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529451.485264] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529451.485352] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529451.485437] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529451.496043] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529451.496108] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529451.496208] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529451.786700] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529451.786791] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529451.786896] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529452.189720] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529452.189824] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529452.189941] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529452.201304] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529452.201389] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529452.201488] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529452.490990] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529452.491078] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529452.491162] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529452.774748] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529452.894386] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529452.894453] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529452.913523] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529452.913614] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529453.193236] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529453.193302] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529453.463459] [mm-manager.c:457] supports_defer_timeout(): (wwan0): re-checking support...
>modem-manager[6721]: <debug> [1342529453.463799] [mm-manager.c:491] try_supports_port(): (ZTE): (wwan0) deferring support check
>modem-manager[6721]: <debug> [1342529453.775036] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'ATE0+CPMS?'
>modem-manager[6721]: <debug> [1342529453.775150] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'ATI<CR>'
>modem-manager[6721]: <debug> [1342529453.775259] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATI<CR>'
>modem-manager[6721]: <debug> [1342529453.775326] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529453.777024] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529454.084501] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>Manufacturer: Vodafone (ZTE)<CR><LF>Model: K4505-Z<CR><LF>Revision: BD_P680A2V1.0.0B10<CR><LF>IMEI: 356009031736300<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.084642] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB1) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529454.084667] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB1) closing serial port...
>modem-manager[6721]: <info>  [1342529454.085742] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB1) serial port closed
>modem-manager[6721]: <debug> [1342529454.088762] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB1) type secondary claimed by /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <info>  [1342529454.089212] [mm-manager.c:564] do_grab_port(): (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3 claimed port ttyUSB1
>modem-manager[6721]: <debug> [1342529454.089266] [mm-manager.c:317] add_modem(): Added modem /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <debug> [1342529454.089296] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <debug> [1342529454.089380] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <debug> [1342529454.089808] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>Manufacturer: Vodafone (ZTE)<CR><LF>Model: K4505-Z<CR><LF>Revision: BD_P680A2V1.0.0B10<CR><LF>IMEI: 356009031736300<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.089952] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529454.089987] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
>modem-manager[6721]: <info>  [1342529454.091013] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
>modem-manager[6721]: <debug> [1342529454.091560] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB3) type primary claimed by /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <info>  [1342529454.091834] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
>modem-manager[6721]: <debug> [1342529454.093540] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529454.093623] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 2 (open)
>modem-manager[6721]: <debug> [1342529454.093722] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 3 (open)
>modem-manager[6721]: <info>  [1342529454.093965] [mm-manager.c:564] do_grab_port(): (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3 claimed port ttyUSB3
>modem-manager[6721]: <debug> [1342529454.094088] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <debug> [1342529454.094171] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0<CR>'
>modem-manager[6721]: <debug> [1342529454.099925] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.100052] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GMI<CR>'
>modem-manager[6721]: <debug> [1342529454.114475] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>Vodafone (ZTE)<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.114639] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GMM<CR>'
>modem-manager[6721]: <debug> [1342529454.130250] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>K4505-Z<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.130378] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GMR<CR>'
>modem-manager[6721]: <debug> [1342529454.146961] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>BD_P680A2V1.0.0B10<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.147129] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGMI<CR>'
>modem-manager[6721]: <debug> [1342529454.164709] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>Vodafone (ZTE)<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.164840] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGMM<CR>'
>modem-manager[6721]: <debug> [1342529454.182477] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>K4505-Z<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.182646] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGMR<CR>'
>modem-manager[6721]: <debug> [1342529454.200263] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>BD_P680A2V1.0.0B10<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.200343] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATI<CR>'
>modem-manager[6721]: <debug> [1342529454.217023] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>Manufacturer: Vodafone (ZTE)<CR><LF>Model: K4505-Z<CR><LF>Revision: BD_P680A2V1.0.0B10<CR><LF>IMEI: 356009031736300<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.217131] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATI1<CR>'
>modem-manager[6721]: <debug> [1342529454.233828] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>Manufacturer: Vodafone (ZTE)<CR><LF>Model: K4505-Z<CR><LF>Revision: BD_P680A2V1.0.0B10<CR><LF>IMEI: 356009031736300<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.233925] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+GSN<CR>'
>modem-manager[6721]: <debug> [1342529454.250619] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>356009031736300<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.250742] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGSN<CR>'
>modem-manager[6721]: <debug> [1342529454.268775] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>356009031736300<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.268899] [mm-modem-helpers.c:888] mm_create_device_identifier(): Device ID source '000019d200000104Manufacturer:Vodafone(ZTE)Model:K4505-ZRevision:BD_P680A2V1.0.0B10IMEI:356009031736300+GCAP:+CGSM,+DS,+ES356009031736300BD_P680A2V1.0.0B10K4505-ZVodafone(ZTE)'
>modem-manager[6721]: <debug> [1342529454.268932] [mm-modem-helpers.c:889] mm_create_device_identifier(): Device ID '00d4daee6e3394de039c5ba3fecd621f1dbe27f3'
>modem-manager[6721]: <debug> [1342529454.268979] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 2 (close)
>modem-manager[6721]: <debug> [1342529454.269005] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0<CR>'
>modem-manager[6721]: <debug> [1342529454.282332] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.282482] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 1 (close)
>modem-manager[6721]: <debug> [1342529454.282500] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CMEE=1<CR>'
>modem-manager[6721]: <debug> [1342529454.293793] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.293938] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPIN?<CR>'
>modem-manager[6721]: <debug> [1342529454.311524] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CME ERROR: 14<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.311606] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 14: SIM busy
>modem-manager[6721]: <debug> [1342529454.479347] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.479438] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529454.479545] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): --> 'ATI<CR>'
>modem-manager[6721]: <debug> [1342529454.786231] [mm-at-serial-port.c:298] debug_log(): (ttyUSB0): <-- '<CR><LF>Manufacturer: Vodafone (ZTE)<CR><LF>Model: K4505-Z<CR><LF>Revision: BD_P680A2V1.0.0B10<CR><LF>IMEI: 356009031736300<CR><LF>+GCAP: +CGSM,+DS,+ES<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529454.786377] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB0) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529454.786413] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB0) closing serial port...
>modem-manager[6721]: <info>  [1342529454.787496] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB0) serial port closed
>modem-manager[6721]: <debug> [1342529454.788097] [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB0) type ignored claimed by /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <info>  [1342529454.788379] [mm-manager.c:564] do_grab_port(): (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3 claimed port ttyUSB0
>modem-manager[6721]: <debug> [1342529454.788454] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB2): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <debug> [1342529456.466232] [mm-manager.c:457] supports_defer_timeout(): (wwan0): re-checking support...
>modem-manager[6721]: <debug> [1342529456.467040] [mm-modem-base.c:155] mm_modem_base_add_port(): (wwan0) type ignored claimed by /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <info>  [1342529456.467118] [mm-manager.c:564] do_grab_port(): (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3 claimed port wwan0
>modem-manager[6721]: <debug> [1342529456.467185] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB2): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <debug> [1342529456.775705] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529456.775783] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPIN?<CR>'
>modem-manager[6721]: <debug> [1342529456.790975] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CPIN: SIM PIN<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529457.776008] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'ATE0+CPMS?'
>modem-manager[6721]: <debug> [1342529457.776167] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 2 (open)
>modem-manager[6721]: <debug> [1342529457.776254] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 1 (close)
>modem-manager[6721]: <debug> [1342529457.776311] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CRSM=176,12258,0,0,10<CR>'
>modem-manager[6721]: <debug> [1342529457.776773] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529457.885077] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CRSM: 144,0,"989301130110410271F5"<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529457.885207] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529457.885234] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
>modem-manager[6721]: <info>  [1342529457.887325] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
>modem-manager[6721]: <debug> [1342529457.887419] [mm-generic-gsm.c:500] get_iccid_done(): SIM ID source '8939103110011420175'
>modem-manager[6721]: <debug> [1342529457.887457] [mm-generic-gsm.c:501] get_iccid_done(): SIM ID '87079183246625f7733efe834dbd9115265a720a'
>modem-manager[6721]: <debug> [1342529457.887576] [mm-manager.c:243] check_export_modem(): (tty/ttyUSB2): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3
>modem-manager[6721]: <debug> [1342529460.777681] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'ATE0+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529461.777971] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'ATE0+CPMS?'
>modem-manager[6721]: <debug> [1342529461.778922] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529464.778164] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529465.478377] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'AT+GCAP'
>modem-manager[6721]: <debug> [1342529465.479217] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529468.778031] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529469.478260] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'AT+GCAP'
>modem-manager[6721]: <debug> [1342529469.479046] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529472.778600] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): --> 'AT+GCAP<CR>'
>modem-manager[6721]: <debug> [1342529473.479261] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- 'AT+GCAP'
>modem-manager[6721]: <debug> [1342529473.480033] [mm-at-serial-port.c:298] debug_log(): (ttyUSB2): <-- '<CR>'
>modem-manager[6721]: <debug> [1342529476.777977] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529476.778056] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB2) closing serial port...
>modem-manager[6721]: <info>  [1342529476.779111] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB2) serial port closed
>modem-manager[6721]: <info>  [1342529476.779230] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB2) opening serial port...
>modem-manager[6721]: <debug> [1342529476.780507] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB2) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529476.780613] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): --> 00 78 f0 7e
>modem-manager[6721]: <debug> [1342529476.783675] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): <-- 00 78 f0
>modem-manager[6721]: <debug> [1342529476.784250] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): <-- 7e
>modem-manager[6721]: <debug> [1342529476.784301] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): --> 00 78 f0 7e
>modem-manager[6721]: <debug> [1342529476.787384] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): <-- 00 78 f0
>modem-manager[6721]: <debug> [1342529476.788003] [mm-qcdm-serial-port.c:194] debug_log(): (ttyUSB2): <-- 7e
>modem-manager[6721]: (ttyUSB2) failed to parse QCDM version info command result: (2) DM command 0 response not long enough (got 1, expected at least 55)..
>modem-manager[6721]: <debug> [1342529476.788097] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB2) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529476.788130] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB2) closing serial port...
>modem-manager[6721]: <info>  [1342529476.789229] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB2) serial port closed
>modem-manager[6721]: <debug> [1342529476.789274] [mm-manager.c:624] supports_callback(): (tty/ttyUSB2): ignoring port unsupported by physical modem's plugin
>modem-manager[6721]: <debug> [1342529476.789370] [mm-manager.c:265] check_export_modem(): Exported modem /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3 as /org/freedesktop/ModemManager/Modems/0
>modem-manager[6721]: <debug> [1342529476.789493] [mm-manager.c:278] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): VID 0x19D2 PID 0x0104 (usb)
>modem-manager[6721]: <debug> [1342529476.789507] [mm-manager.c:279] check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): data port is wwan0
>
>## == HERE I TYPE MY PIN ==
>
>modem-manager[6721]: <info>  [1342529551.952436] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
>modem-manager[6721]: <debug> [1342529551.955285] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529551.955403] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPIN="WXYZ"<CR>'
>modem-manager[6721]: <debug> [1342529552.053728] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529552.053823] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPIN?<CR>'
>modem-manager[6721]: <debug> [1342529552.069466] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <info>  [1342529552.069581] [mm-modem-base.c:299] mm_modem_base_set_unlock_required(): Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required
>modem-manager[6721]: <info>  [1342529552.069644] [mm-modem-base.c:338] mm_modem_base_set_unlock_retries(): Modem /org/freedesktop/ModemManager/Modems/0: # unlock retries is 0
>modem-manager[6721]: <debug> [1342529552.069907] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529552.069937] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
>modem-manager[6721]: <info>  [1342529552.071022] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
>
>## == HERE I TRY TO CONNECT ==
>
>modem-manager[6721]: <info>  [1342529551.952436] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
>modem-manager[6721]: <debug> [1342529551.955285] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529551.955403] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPIN="WXYZ"<CR>'
>modem-manager[6721]: <debug> [1342529552.053728] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529552.053823] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPIN?<CR>'
>modem-manager[6721]: <debug> [1342529552.069466] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <info>  [1342529552.069581] [mm-modem-base.c:299] mm_modem_base_set_unlock_required(): Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required
>modem-manager[6721]: <info>  [1342529552.069644] [mm-modem-base.c:338] mm_modem_base_set_unlock_retries(): Modem /org/freedesktop/ModemManager/Modems/0: # unlock retries is 0
>modem-manager[6721]: <debug> [1342529552.069907] [mm-serial-port.c:838] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
>modem-manager[6721]: <info>  [1342529552.069937] [mm-serial-port.c:853] mm_serial_port_close(): (ttyUSB3) closing serial port...
>modem-manager[6721]: <info>  [1342529552.071022] [mm-serial-port.c:874] mm_serial_port_close(): (ttyUSB3) serial port closed
>modem-manager[6721]: <info>  [1342529641.566431] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB3) opening serial port...
>modem-manager[6721]: <debug> [1342529641.568295] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB3) device open count is 1 (open)
>modem-manager[6721]: <info>  [1342529641.568404] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling)
>modem-manager[6721]: <debug> [1342529641.569108] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CSQ<CR>'
>modem-manager[6721]: <debug> [1342529641.583487] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CSQ: 16,99<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.670463] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0 V1<CR>'
>modem-manager[6721]: <debug> [1342529641.688029] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.688220] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT%IPSYS?<CR>'
>modem-manager[6721]: <debug> [1342529641.700504] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>ERROR<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.700612] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529641.700723] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATZ E0 V1 X4 &C1 +CMEE=1;+CFUN=1;<CR>'
>modem-manager[6721]: <debug> [1342529641.750181] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.750333] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATE0<CR>'
>modem-manager[6721]: <debug> [1342529641.761817] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.761935] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPMS?<CR>'
>modem-manager[6721]: <debug> [1342529641.774694] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CPMS: "SM",0,50,"SM",0,50,"ME",0,100<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <info>  [1342529641.774795] [mm-serial-port.c:735] mm_serial_port_open(): (ttyUSB1) opening serial port...
>modem-manager[6721]: <debug> [1342529641.776335] [mm-serial-port.c:804] mm_serial_port_open(): (ttyUSB1) device open count is 1 (open)
>modem-manager[6721]: <debug> [1342529641.776607] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+IFC=1,1<CR>'
>modem-manager[6721]: <debug> [1342529641.795285] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.795410] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CPMS="ME","ME","ME"<CR>'
>modem-manager[6721]: <debug> [1342529641.831261] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CPMS: 0,100,0,100,0,100<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.831378] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CNMI=2,1,2,1,0<CR>'
>modem-manager[6721]: <debug> [1342529641.851839] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CMS ERROR: 303<CR><LF>'
>modem-manager[6721]: Invalid error code: 303
>modem-manager[6721]: <debug> [1342529641.852037] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
>modem-manager[6721]: <debug> [1342529641.852117] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CUSD=1<CR>'
>modem-manager[6721]: <debug> [1342529641.871876] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.872023] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND=?<CR>'
>modem-manager[6721]: <debug> [1342529641.884597] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CIND: ("battchg",(0-5)),("signal",(0-5)),("service",(0-1)),("call",(0-1)),("roam",(0-1)),("smsfull",(0-1)),("GPRS coverage",(0-1)),("callsetup",(0-3))<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.884805] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZSNT?<CR>'
>modem-manager[6721]: <debug> [1342529641.908064] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+ZSNT: 0,0,2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.908245] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CSCS=?<CR>'
>modem-manager[6721]: <debug> [1342529641.926272] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CSCS: ("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.926421] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CMER=3,0,0,1<CR>'
>modem-manager[6721]: <debug> [1342529641.951951] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.952063] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+CMER=3,0,0,1<CR>'
>modem-manager[6721]: <debug> [1342529641.952130] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CSCS="UCS2"<CR>'
>modem-manager[6721]: <debug> [1342529641.973516] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.977758] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529641.977884] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CSCS?<CR>'
>modem-manager[6721]: <debug> [1342529641.993181] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <info>  [1342529641.993437] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled)
>modem-manager[6721]: <debug> [1342529641.993723] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CREG=2<CR>'
>modem-manager[6721]: <debug> [1342529642.014362] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.014758] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CREG?<CR>'
>modem-manager[6721]: <debug> [1342529642.032606] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CREG: 2,1, 3AB7, 7CCA28<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.032680] [mm-generic-gsm.c:2614] mm_generic_gsm_set_reg_status(): CS registration state changed: 1
>modem-manager[6721]: <info>  [1342529642.032835] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered)
>modem-manager[6721]: <debug> [1342529642.032936] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGREG=2<CR>'
>modem-manager[6721]: <debug> [1342529642.054952] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.055072] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+CREG=2<CR>'
>modem-manager[6721]: <debug> [1342529642.055169] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+COPS=3,2;+COPS?<CR>'
>modem-manager[6721]: <debug> [1342529642.056136] [mm-generic-gsm.c:5256] simple_connect(): (wwan0): number => "*99#"
>modem-manager[6721]: <debug> [1342529642.056181] [mm-generic-gsm.c:5256] simple_connect(): (wwan0): network_mode => 0
>modem-manager[6721]: <debug> [1342529642.056206] [mm-generic-gsm.c:5256] simple_connect(): (wwan0): apn => "mobile.vodafone.it"
>modem-manager[6721]: <debug> [1342529642.056230] [mm-generic-gsm.c:5256] simple_connect(): (wwan0): allowed_mode => 0
>modem-manager[6721]: <debug> [1342529642.056253] [mm-generic-gsm.c:5256] simple_connect(): (wwan0): allowed_auth => 63
>modem-manager[6721]: <debug> [1342529642.056287] [mm-generic-gsm.c:5145] simple_state_machine(): (wwan0): simple connect state 0
>modem-manager[6721]: <debug> [1342529642.056382] [mm-generic-gsm.c:5145] simple_state_machine(): (wwan0): simple connect state 2
>modem-manager[6721]: <debug> [1342529642.068844] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.069023] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+CGREG=2<CR>'
>modem-manager[6721]: <debug> [1342529642.078909] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+COPS: 0,2,"22210",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.079154] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+COPS=3,0;+COPS?<CR>'
>modem-manager[6721]: <debug> [1342529642.081890] [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.108272] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+COPS: 0,0,"vodafone IT",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.108539] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529642.120321] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CIND: 5,3,1,0,0,0,1,0<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.120477] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529642.140114] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+ZPAS: "UMTS","CS_PS"<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.140371] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGREG?<CR>'
>modem-manager[6721]: <debug> [1342529642.157167] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CGREG: 2,1, 3AB7, 7CCA28<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.157278] [mm-generic-gsm.c:2614] mm_generic_gsm_set_reg_status(): PS registration state changed: 1
>modem-manager[6721]: <debug> [1342529642.157438] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CREG?<CR>'
>modem-manager[6721]: <debug> [1342529642.167974] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CREG: 2,1, 3AB7, 7CCA28<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.168141] [mm-generic-gsm.c:5145] simple_state_machine(): (wwan0): simple connect state 4
>modem-manager[6721]: <debug> [1342529642.168211] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+COPS=3,2;+COPS?<CR>'
>modem-manager[6721]: <debug> [1342529642.196332] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+COPS: 0,2,"22210",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.196451] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+COPS=3,0;+COPS?<CR>'
>modem-manager[6721]: <debug> [1342529642.224334] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+COPS: 0,0,"vodafone IT",2<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.224493] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529642.241988] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CIND: 5,3,1,0,0,0,1,0<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.242141] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529642.253628] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+ZPAS: "UMTS","CS_PS"<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.253758] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGDCONT?<CR>'
>modem-manager[6721]: <debug> [1342529642.267829] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CGDCONT: 1,"IP","cmnet","",0,0<CR><LF>+CGDCONT: 2,"IP","ibox.tim.it","",0,0<CR><LF>+CGDCONT: 3,"IP","mobile.vodafone.it","",0,0<CR><LF><CR><LF>OK<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.268089] [mm-generic-gsm.c:5145] simple_state_machine(): (wwan0): simple connect state 5
>modem-manager[6721]: <info>  [1342529642.268256] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting)
>modem-manager[6721]: <debug> [1342529642.268345] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATD*99***3#<CR>'
>modem-manager[6721]: <debug> [1342529642.284089] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>CONNECT 28000000<CR><LF>'
>modem-manager[6721]: <debug> [1342529642.284189] [mm-port.c:181] mm_port_set_connected(): (wwan0): port now connected
>modem-manager[6721]: <info>  [1342529642.284378] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected)
>modem-manager[6721]: <debug> [1342529642.284453] [mm-generic-gsm.c:5145] simple_state_machine(): (wwan0): simple connect state 6
>modem-manager[6721]: <info>  [1342529642.293778] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
>modem-manager[6721]: <debug> [1342529643.296155] [mm-port.c:181] mm_port_set_connected(): (wwan0): port now disconnected
>modem-manager[6721]: <debug> [1342529643.296251] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGACT=0,3<CR>'
>modem-manager[6721]: <info>  [1342529646.777744] [mm-modem.c:742] mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> registered)
>modem-manager[6721]: <debug> [1342529671.794058] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529674.778349] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529701.798747] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529704.777961] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529731.799378] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529734.777566] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529761.791974] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529764.778210] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529791.798640] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529794.777845] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529821.799219] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529824.777448] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529851.798011] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529854.778286] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529881.798998] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529884.778237] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529911.798599] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529914.777986] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529941.799409] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529944.777712] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342529971.799176] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342529974.777472] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342530001.798755] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342530004.777946] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>modem-manager[6721]: <debug> [1342530031.799145] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CIND?<CR>'
>modem-manager[6721]: <debug> [1342530034.778243] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+ZPAS?<CR>'
>

Actions: View

Attachments on bug 834871: 598631 | 598632