Package: modemmanager
Version: 0.4.997-1
Severity: normal
*** Please type your report below this line ***
I can connect mobile-network over GPRS using pon but connecting using
NetworkManager fails. Pon uses this simplest chatscript for
connection:
ABORT BUSY
ABORT VOICE
ABORT "NO CARRIER"
ABORT "NO DIALTONE"
ABORT "NO DIAL TONE"
"" AT+CGDCONT=1,"IP","internet"
OK ATDT\T
CONNECT ""
There are logs of NetworkManager and modem-manager in attachments, done this
way:
/etc/init.d/network-manager stop
kill pid-of-modemmanager
NM_SERIAL_DEBUG=1 modem-manager --debug 2>&1 | tee /tmp/mm-testing-modem.txt
NM_SERIAL_DEBUG=1 NetworkManager --no-daemon 2>&1 | tee
/tmp/nm-squeeze-modem.txt
LAN connection raised by NM
then I plugged the phone in, and choose configured mobile-net from the
applet's menu
I couldn't connect with squeeze's modem-manager, I updated it to testing but
still I can't.
I've heard somewhere in the net, people had had success with Motorola C380 +
NetworkManager in Ubuntu 8.10... possible regress? May be I try some day
that old distro.
-- System Information:
Debian Release: 6.0.2
APT prefers testing-proposed-updates
APT policy: (500, 'testing-proposed-updates'), (500, 'stable-updates'),
(500, 'proposed-updates'), (500, 'unstable'), (500, 'testing'), (500,
'stable')
Architecture: amd64 (x86_64)
Kernel: Linux 2.6.32-5-amd64 (SMP w/1 CPU core)
Locale: LANG=ru_RU.utf8, LC_CTYPE=ru_RU.utf8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Versions of packages modemmanager depends on:
ii libc6 2.11.2-10 Embedded GNU C Library: Shared
lib
ii libdbus-1-3 1.2.24-4+squeeze1 simple interprocess messaging
syst
ii libdbus-glib-1-2 0.88-2.1 simple interprocess messaging
syst
ii libglib2.0-0 2.24.2-1 The GLib library of C routines
ii libgudev-1.0-0 164-3 GObject-based wrapper library
for
Versions of packages modemmanager recommends:
ii usb-modeswitch 1.1.4-2 mode switching tool for
controllin
modemmanager suggests no packages.
-- no debconf information
NetworkManager[27089]: <info> NetworkManager (version 0.8.1) is starting...
NetworkManager[27089]: <info> Read config file
/etc/NetworkManager/NetworkManager.conf
NetworkManager[27089]: <info> modem-manager is now available
NetworkManager[27089]: SCPlugin-Ifupdown: init!
NetworkManager[27089]: SCPlugin-Ifupdown: update_system_hostname
NetworkManager[27089]: SCPluginIfupdown: management mode: unmanaged
NetworkManager[27089]: SCPlugin-Ifupdown: devices added (path:
/sys/devices/pci0000:00/0000:00:1c.0/0000:09:00.0/net/eth0, iface: eth0)
NetworkManager[27089]: SCPlugin-Ifupdown: device added (path:
/sys/devices/pci0000:00/0000:00:1c.0/0000:09:00.0/net/eth0, iface: eth0): no
ifupdown configuration found.
NetworkManager[27089]: SCPlugin-Ifupdown: devices added (path:
/sys/devices/pci0000:00/0000:00:1c.1/0000:0b:00.0/net/wlan0, iface: wlan0)
NetworkManager[27089]: SCPlugin-Ifupdown: device added (path:
/sys/devices/pci0000:00/0000:00:1c.1/0000:0b:00.0/net/wlan0, iface: wlan0): no
ifupdown configuration found.
NetworkManager[27089]: SCPlugin-Ifupdown: devices added (path:
/sys/devices/virtual/net/lo, iface: lo)
NetworkManager[27089]: SCPlugin-Ifupdown: device added (path:
/sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
NetworkManager[27089]: SCPlugin-Ifupdown: devices added (path:
/sys/devices/virtual/net/pan0, iface: pan0)
NetworkManager[27089]: SCPlugin-Ifupdown: device added (path:
/sys/devices/virtual/net/pan0, iface: pan0): no ifupdown configuration found.
NetworkManager[27089]: SCPlugin-Ifupdown: devices added (path:
/sys/devices/virtual/net/vboxnet0, iface: vboxnet0)
NetworkManager[27089]: SCPlugin-Ifupdown: device added (path:
/sys/devices/virtual/net/vboxnet0, iface: vboxnet0): no ifupdown configuration
found.
NetworkManager[27089]: SCPlugin-Ifupdown: end _init.
NetworkManager[27089]: <info> Loaded plugin ifupdown: (C) 2008 Canonical Ltd.
To report bugs please use the NetworkManager mailing list.
NetworkManager[27089]: <info> Loaded plugin keyfile: (c) 2007 - 2008 Red Hat,
Inc. To report bugs please use the NetworkManager mailing list.
NetworkManager[27089]: Ifupdown: get unmanaged devices count: 0
NetworkManager[27089]: SCPlugin-Ifupdown: (14285248) ... get_connections.
NetworkManager[27089]: SCPlugin-Ifupdown: (14285248) ... get_connections
(managed=false): return empty list.
NetworkManager[27089]: Ifupdown: get unmanaged devices count: 0
NetworkManager[27089]: <info> found WiFi radio killswitch rfkill3 (at
/sys/devices/pci0000:00/0000:00:1c.1/0000:0b:00.0/ieee80211/phy0/rfkill3)
(driver <unknown>)
NetworkManager[27089]: <info> found WiFi radio killswitch rfkill1 (at
/sys/devices/virtual/rfkill/rfkill1) (driver <unknown>)
NetworkManager[27089]: <info> WiFi enabled by radio killswitch; enabled by
state file
NetworkManager[27089]: <info> WWAN enabled by radio killswitch; enabled by
state file
NetworkManager[27089]: <info> WiMAX enabled by radio killswitch; enabled by
state file
NetworkManager[27089]: <info> Networking is enabled by state file
NetworkManager[27089]: <info> (eth0): carrier is ON
NetworkManager[27089]: <info> (eth0): new Ethernet device (driver: 'sky2'
ifindex: 2)
NetworkManager[27089]: <info> (eth0): exported as
/org/freedesktop/NetworkManager/Devices/0
NetworkManager[27089]: <info> (eth0): now managed
NetworkManager[27089]: <info> (eth0): device state change: 1 -> 2 (reason 41)
NetworkManager[27089]: <info> (eth0): preparing device.
NetworkManager[27089]: <info> Activation (eth0) starting connection 'Auto eth0'
NetworkManager[27089]: <info> (eth0): device state change: 2 -> 7 (reason 0)
NetworkManager[27089]: <info> Activation (eth0) Stage 3 of 5 (IP Configure
Start) scheduled.
NetworkManager[27089]: <info> (wlan0): driver supports SSID scans (scan_capa
0x01).
NetworkManager[27089]: <info> (wlan0): new 802.11 WiFi device (driver:
'iwl3945' ifindex: 3)
NetworkManager[27089]: <info> (wlan0): exported as
/org/freedesktop/NetworkManager/Devices/1
NetworkManager[27089]: <info> (wlan0): now managed
NetworkManager[27089]: <info> (wlan0): device state change: 1 -> 2 (reason 2)
NetworkManager[27089]: <info> (wlan0): bringing up device.
NetworkManager[27089]: <info> (wlan0): preparing device.
NetworkManager[27089]: <info> (wlan0): deactivating device (reason: 2).
NetworkManager[27089]: <warn> /sys/devices/virtual/net/pan0: couldn't determine
device driver; ignoring...
NetworkManager[27089]: <warn> /sys/devices/virtual/net/vboxnet0: couldn't
determine device driver; ignoring...
/sbin/ifup: interface lo already configured
NetworkManager[27089]: <info> Activation (eth0) Stage 3 of 5 (IP Configure
Start) started...
NetworkManager[27089]: <info> Activation (eth0) Beginning DHCPv4 transaction
(timeout in 45 seconds)
NetworkManager[27089]: <info> dhclient started with pid 27095
NetworkManager[27089]: <info> Activation (eth0) Stage 3 of 5 (IP Configure
Start) complete.
NetworkManager[27089]: <info> (wlan0): supplicant interface state: starting ->
ready
NetworkManager[27089]: <info> (wlan0): device state change: 2 -> 3 (reason 42)
Internet Systems Consortium DHCP Client 4.1.1-P1
Copyright 2004-2010 Internet Systems Consortium.
All rights reserved.
For info, please visit https://www.isc.org/software/dhcp/
Listening on LPF/eth0/00:1d:09:5e:7b:d5
Sending on LPF/eth0/00:1d:09:5e:7b:d5
Sending on Socket/fallback
NetworkManager[27089]: <info> (eth0): DHCPv4 state changed nbi -> preinit
DHCPREQUEST on eth0 to 255.255.255.255 port 67
DHCPACK from 192.168.236.1
NetworkManager[27089]: <info> (eth0): DHCPv4 state changed preinit -> reboot
NetworkManager[27089]: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure
Get) scheduled...
NetworkManager[27089]: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure
Get) started...
NetworkManager[27089]: <info> address 192.168.236.9
NetworkManager[27089]: <info> prefix 24 (255.255.255.0)
NetworkManager[27089]: <info> gateway 192.168.236.1
NetworkManager[27089]: <info> nameserver '192.168.236.1'
NetworkManager[27089]: nm_ip4_config_add_nameserver: assertion `nameserver !=
s' failed
NetworkManager[27089]: <info> nameserver '192.168.236.1'
NetworkManager[27089]: <info> Activation (eth0) Stage 5 of 5 (IP Configure
Commit) scheduled...
NetworkManager[27089]: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure
Get) complete.
NetworkManager[27089]: <info> Activation (eth0) Stage 5 of 5 (IP Configure
Commit) started...
NetworkManager[27089]: <info> (eth0): writing resolv.conf to /sbin/resolvconf
bound to 192.168.236.9 -- renewal in 40803 seconds.
NetworkManager[27089]: <info> (eth0): device state change: 7 -> 8 (reason 0)
NetworkManager[27089]: <info> (eth0): writing resolv.conf to /sbin/resolvconf
NetworkManager[27089]: <info> Policy set 'Auto eth0' (eth0) as default for IPv4
routing and DNS.
NetworkManager[27089]: <info> Activation (eth0) successful, device activated.
NetworkManager[27089]: <info> Activation (eth0) Stage 5 of 5 (IP Configure
Commit) complete.
NetworkManager[27089]: <warn> (ttyACM0): failed to look up interface index
NetworkManager[27089]: <info> (ttyACM0): new GSM device (driver: 'cdc_acm'
ifindex: -1)
NetworkManager[27089]: <info> (ttyACM0): exported as
/org/freedesktop/NetworkManager/Devices/2
NetworkManager[27089]: <info> (ttyACM0): now managed
NetworkManager[27089]: <info> (ttyACM0): device state change: 1 -> 2 (reason 2)
NetworkManager[27089]: <info> (ttyACM0): deactivating device (reason: 2).
NetworkManager[27089]: <info> (ttyACM0): device state change: 2 -> 3 (reason 0)
NetworkManager[27089]: <info> Activation (ttyACM0) starting connection
'mts.gprs'
NetworkManager[27089]: <info> (ttyACM0): device state change: 3 -> 4 (reason 0)
NetworkManager[27089]: <info> Activation (ttyACM0) Stage 1 of 5 (Device
Prepare) scheduled...
NetworkManager[27089]: <info> Activation (ttyACM0) Stage 1 of 5 (Device
Prepare) started...
NetworkManager[27089]: <info> Activation (ttyACM0) Stage 1 of 5 (Device
Prepare) complete.
NetworkManager[27089]: <warn> GSM connection failed: (32) Operation not
supported
NetworkManager[27089]: <info> (ttyACM0): device state change: 4 -> 9 (reason 1)
NetworkManager[27089]: <info> Marking connection 'mts.gprs' invalid.
NetworkManager[27089]: <warn> Activation (ttyACM0) failed.
NetworkManager[27089]: <info> (ttyACM0): device state change: 9 -> 3 (reason 0)
NetworkManager[27089]: <info> (ttyACM0): deactivating device (reason: 0).
NetworkManager[27089]: <info> (eth0): writing resolv.conf to /sbin/resolvconf
NetworkManager[27089]: <info> Policy set 'Auto eth0' (eth0) as default for IPv4
routing and DNS.
NetworkManager[27089]: <info> (eth0): writing resolv.conf to /sbin/resolvconf
NetworkManager[27089]: <info> Policy set 'Auto eth0' (eth0) as default for IPv4
routing and DNS.
modem-manager[27087]: <info> [1311189194.967747] [main.c:167] main():
ModemManager (version 0.4.997) starting...
modem-manager[27087]: <info> [1311189194.974849] [mm-manager.c:116]
load_plugin(): Loaded plugin Linktop
modem-manager[27087]: <info> [1311189194.975284] [mm-manager.c:116]
load_plugin(): Loaded plugin Huawei
modem-manager[27087]: <info> [1311189194.975636] [mm-manager.c:116]
load_plugin(): Loaded plugin Sierra
modem-manager[27087]: <info> [1311189194.976152] [mm-manager.c:116]
load_plugin(): Loaded plugin ZTE
modem-manager[27087]: <info> [1311189194.976521] [mm-manager.c:116]
load_plugin(): Loaded plugin Ericsson MBM
modem-manager[27087]: <info> [1311189194.976888] [mm-manager.c:116]
load_plugin(): Loaded plugin Nokia
modem-manager[27087]: <info> [1311189194.977231] [mm-manager.c:116]
load_plugin(): Loaded plugin MotoC
modem-manager[27087]: <info> [1311189194.977564] [mm-manager.c:116]
load_plugin(): Loaded plugin AnyData
modem-manager[27087]: <info> [1311189194.977903] [mm-manager.c:116]
load_plugin(): Loaded plugin Samsung
modem-manager[27087]: <info> [1311189194.984381] [mm-manager.c:116]
load_plugin(): Loaded plugin Novatel
modem-manager[27087]: <info> [1311189194.984806] [mm-manager.c:116]
load_plugin(): Loaded plugin Gobi
modem-manager[27087]: <info> [1311189194.985144] [mm-manager.c:116]
load_plugin(): Loaded plugin Generic
modem-manager[27087]: <info> [1311189194.985497] [mm-manager.c:116]
load_plugin(): Loaded plugin Wavecom
modem-manager[27087]: <info> [1311189194.985853] [mm-manager.c:116]
load_plugin(): Loaded plugin SimTech
modem-manager[27087]: <info> [1311189194.986203] [mm-manager.c:116]
load_plugin(): Loaded plugin X22X
modem-manager[27087]: <info> [1311189194.988337] [mm-manager.c:116]
load_plugin(): Loaded plugin Option High-Speed
modem-manager[27087]: <info> [1311189194.988738] [mm-manager.c:116]
load_plugin(): Loaded plugin Longcheer
modem-manager[27087]: <info> [1311189194.989111] [mm-manager.c:116]
load_plugin(): Loaded plugin Option
modem-manager[27087]: <info> [1311189210.545153] [mm-serial-port.c:734]
mm_serial_port_open(): (ttyACM0) opening serial port...
modem-manager[27087]: <debug> [1311189210.554058] [mm-serial-port.c:796]
mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
modem-manager[27087]: <debug> [1311189210.554226] [mm-plugin-base.c:848]
try_open(): (ttyACM0): probe requested by plugin 'MotoC'
modem-manager[27087]: <debug> [1311189210.659090] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+GCAP<CR>'
modem-manager[27087]: <debug> [1311189211.352573] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- 'AT+GCAP'
modem-manager[27087]: <debug> [1311189211.363930] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><CR><LF>+GCAP:
+FCLASS<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189211.364149] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+GCAP<CR>'
modem-manager[27087]: <debug> [1311189212.057531] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- 'AT+GCAP'
modem-manager[27087]: <debug> [1311189212.067959] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><CR><LF>+GCAP:
+FCLASS<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189212.068189] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+GCAP<CR>'
modem-manager[27087]: <debug> [1311189212.761542] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- 'AT+GCAP'
modem-manager[27087]: <debug> [1311189212.771958] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><CR><LF>+GCAP:
+FCLASS<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189212.772187] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATI<CR>'
modem-manager[27087]: <debug> [1311189213.069503] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- 'ATI'
modem-manager[27087]: <debug> [1311189213.079950] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><CR><LF>144<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189213.080180] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CPIN?<CR>'
modem-manager[27087]: <debug> [1311189213.873702] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- 'AT+CPIN?'
modem-manager[27087]: <debug> [1311189213.883974] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189213.884255] [mm-serial-port.c:830]
mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
modem-manager[27087]: <info> [1311189213.884365] [mm-serial-port.c:845]
mm_serial_port_close(): (ttyACM0) closing serial port...
modem-manager[27087]: <info> [1311189213.911267] [mm-serial-port.c:866]
mm_serial_port_close(): (ttyACM0) serial port closed
modem-manager[27087]: <debug> [1311189213.913562] [mm-modem-base.c:155]
mm_modem_base_add_port(): (ttyACM0) type primary claimed by
/sys/devices/pci0000:00/0000:00:1d.0/usb5/5-1
modem-manager[27087]: <info> [1311189213.913698] [mm-serial-port.c:734]
mm_serial_port_open(): (ttyACM0) opening serial port...
modem-manager[27087]: <debug> [1311189213.916878] [mm-serial-port.c:796]
mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
modem-manager[27087]: <debug> [1311189213.916963] [mm-serial-port.c:796]
mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
modem-manager[27087]: <debug> [1311189213.916993] [mm-serial-port.c:796]
mm_serial_port_open(): (ttyACM0) device open count is 3 (open)
modem-manager[27087]: <info> [1311189213.917047] [mm-manager.c:560]
do_grab_port(): (MotoC): GSM modem
/sys/devices/pci0000:00/0000:00:1d.0/usb5/5-1 claimed port ttyACM0
modem-manager[27087]: <debug> [1311189213.917071] [mm-manager.c:313]
add_modem(): Added modem /sys/devices/pci0000:00/0000:00:1d.0/usb5/5-1
modem-manager[27087]: <debug> [1311189213.917094] [mm-manager.c:239]
check_export_modem(): (tty/ttyACM0): outstanding support task prevents export
of /sys/devices/pci0000:00/0000:00:1d.0/usb5/5-1
modem-manager[27087]: <debug> [1311189213.917299] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATE0<CR>'
modem-manager[27087]: <debug> [1311189213.917355] [mm-serial-port.c:830]
mm_serial_port_close(): (ttyACM0) device open count is 2 (close)
modem-manager[27087]: <debug> [1311189213.934180] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- 'ATE0<CR><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189213.934458] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+GMI<CR>'
modem-manager[27087]: <debug> [1311189213.948004] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+GMI: "Motorola CE, Copyright
2000"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189213.948139] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+GMM<CR>'
modem-manager[27087]: <debug> [1311189213.968011] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+GMM:
"GSM900","GSM1800","GSM1900","MODEL=C380"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189213.968148] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+GMR<CR>'
modem-manager[27087]: <debug> [1311189213.984005] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+GMR:
"R364_G_0B.D1.09R"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189213.984282] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGMI<CR>'
modem-manager[27087]: <debug> [1311189213.999992] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CGMI: "Motorola CE, Copyright
2000"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.000113] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGMM<CR>'
modem-manager[27087]: <debug> [1311189214.019980] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CGMM:
"GSM900","GSM1800","GSM1900","MODEL=C380"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.020255] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGMR<CR>'
modem-manager[27087]: <debug> [1311189214.036215] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CGMR:
"R364_G_0B.D1.09R"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.036328] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATI<CR>'
modem-manager[27087]: <debug> [1311189214.052001] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>144<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.052114] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATI1<CR>'
modem-manager[27087]: <debug> [1311189214.067988] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>000<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.068269] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+GSN<CR>'
modem-manager[27087]: <debug> [1311189214.087989] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
modem-manager[27087]: <debug> [1311189214.088077] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189214.088128] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGSN<CR>'
modem-manager[27087]: <debug> [1311189214.103988] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CGSN:
IMEI353113005895036<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.104310] [mm-modem-helpers.c:888]
mm_create_device_identifier(): Device ID source
'000022b800004902144000IMEI353113005895036"R364_G_0B.D1.09R""GSM900","GSM1800","GSM1900","MODEL=C380""MotorolaCE,Copyright2000"'
modem-manager[27087]: <debug> [1311189214.104419] [mm-modem-helpers.c:889]
mm_create_device_identifier(): Device ID
'07b2c197585b9b9b7bf849a342bb45c12ff69d78'
modem-manager[27087]: <debug> [1311189214.104542] [mm-serial-port.c:830]
mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
modem-manager[27087]: <debug> [1311189214.104639] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATE0<CR>'
modem-manager[27087]: <debug> [1311189214.119986] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.120250] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
modem-manager[27087]: <debug> [1311189214.136001] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.136255] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CPIN?<CR>'
modem-manager[27087]: <debug> [1311189214.152300] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189214.152583] [mm-serial-port.c:796]
mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
modem-manager[27087]: <debug> [1311189214.152695] [mm-serial-port.c:830]
mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
modem-manager[27087]: <debug> [1311189214.152802] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
modem-manager[27087]: <debug> [1311189214.168074] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
modem-manager[27087]: <debug> [1311189214.168336] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189214.168446] [mm-serial-port.c:830]
mm_serial_port_close(): (ttyACM0) device open count is 0 (close)
modem-manager[27087]: <info> [1311189214.168539] [mm-serial-port.c:845]
mm_serial_port_close(): (ttyACM0) closing serial port...
modem-manager[27087]: <info> [1311189214.188245] [mm-serial-port.c:866]
mm_serial_port_close(): (ttyACM0) serial port closed
modem-manager[27087]: <debug> [1311189214.188462] [mm-manager.c:261]
check_export_modem(): Exported modem
/sys/devices/pci0000:00/0000:00:1d.0/usb5/5-1 as
/org/freedesktop/ModemManager/Modems/0
modem-manager[27087]: <debug> [1311189214.188543] [mm-manager.c:274]
check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): VID 0x22B8 PID
0x4902 (usb)
modem-manager[27087]: <debug> [1311189214.188560] [mm-manager.c:275]
check_export_modem(): (/org/freedesktop/ModemManager/Modems/0): data port is
ttyACM0
modem-manager[27087]: <info> [1311189224.077727] [mm-serial-port.c:734]
mm_serial_port_open(): (ttyACM0) opening serial port...
modem-manager[27087]: <debug> [1311189224.081796] [mm-serial-port.c:796]
mm_serial_port_open(): (ttyACM0) device open count is 1 (open)
modem-manager[27087]: <info> [1311189224.081946] [mm-modem.c:742]
mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state
changed (disabled -> enabling)
modem-manager[27087]: <debug> [1311189224.186798] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATZ E0 V1<CR>'
modem-manager[27087]: <debug> [1311189224.203978] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.204243] [mm-serial-port.c:796]
mm_serial_port_open(): (ttyACM0) device open count is 2 (open)
modem-manager[27087]: <debug> [1311189224.204391] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATE0<CR>'
modem-manager[27087]: <debug> [1311189224.220006] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- 'ATE0<CR><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.220105] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CMEE=1<CR>'
modem-manager[27087]: <debug> [1311189224.235966] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.236217] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'ATX4 &C1<CR>'
modem-manager[27087]: <debug> [1311189224.255993] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.256277] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+IFC=1,1<CR>'
modem-manager[27087]: <debug> [1311189224.271982] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.272244] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CNMI=2,1,2,1,0<CR>'
modem-manager[27087]: <debug> [1311189224.296401] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CMS ERROR: 305<CR><LF>'
modem-manager[27087]: Invalid error code: 305
modem-manager[27087]: <debug> [1311189224.296506] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189224.296547] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CPMS="ME","ME","ME"<CR>'
modem-manager[27087]: <debug> [1311189224.311987] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CMS ERROR: 516<CR><LF>'
modem-manager[27087]: Invalid error code: 516
modem-manager[27087]: <debug> [1311189224.312287] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189224.312337] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CIND=?<CR>'
modem-manager[27087]: <debug> [1311189224.327996] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CIND: ("Voice
Mail",(0,1)),("service",(0,1)),("call",(0,1)),("Roam",(0-2)),("signal",(0-5)),("callsetup",(0-3)),("smsfull",'
modem-manager[27087]: <debug> [1311189224.336091] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '(0,1))<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.336416] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CRSM=176,12258,0,0,10<CR>'
modem-manager[27087]: <debug> [1311189224.352167] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
modem-manager[27087]: <debug> [1311189224.352250] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189224.352273] [mm-serial-port.c:830]
mm_serial_port_close(): (ttyACM0) device open count is 1 (close)
modem-manager[27087]: <debug> [1311189224.352318] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CSCS=?<CR>'
modem-manager[27087]: <debug> [1311189224.372010] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CSCS:
("8859-1","ASCII","GSM","UCS2","UTF8")<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.372231] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CMER=3,0,0,1<CR>'
modem-manager[27087]: <debug> [1311189224.387989] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.388254] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CSCS="UTF-8"<CR>'
modem-manager[27087]: <debug> [1311189224.403992] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 25<CR><LF>'
modem-manager[27087]: <debug> [1311189224.404079] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 25: Invalid characters in text
string
modem-manager[27087]: <debug> [1311189224.404138] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CSCS=UTF-8<CR>'
modem-manager[27087]: <debug> [1311189224.419972] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 25<CR><LF>'
modem-manager[27087]: <debug> [1311189224.420217] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 25: Invalid characters in text
string
modem-manager[27087]: <debug> [1311189224.420303] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CSCS="UCS2"<CR>'
modem-manager[27087]: <debug> [1311189224.435988] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.436098] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CSCS?<CR>'
modem-manager[27087]: <debug> [1311189224.455976] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CSCS: "UCS2"<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <info> [1311189224.456212] [mm-modem.c:742]
mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state
changed (enabling -> enabled)
modem-manager[27087]: <debug> [1311189224.456381] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CREG=2<CR>'
modem-manager[27087]: <debug> [1311189224.471984] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 25<CR><LF>'
modem-manager[27087]: <debug> [1311189224.472066] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 25: Invalid characters in text
string
modem-manager[27087]: <debug> [1311189224.472120] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[27087]: <debug> [1311189224.491997] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CIND:
0,1,0,0,5,0,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.492285] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CREG=1<CR>'
modem-manager[27087]: <debug> [1311189224.507981] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.508090] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CREG?<CR>'
modem-manager[27087]: <debug> [1311189224.524691] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CREG: 1,1<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.524759] [mm-generic-gsm.c:2569]
mm_generic_gsm_set_reg_status(): CS registration state changed: 1
modem-manager[27087]: <info> [1311189224.524885] [mm-modem.c:742]
mm_modem_set_state(): Modem /org/freedesktop/ModemManager/Modems/0: state
changed (enabled -> registered)
modem-manager[27087]: <debug> [1311189224.524963] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGREG=2<CR>'
modem-manager[27087]: <debug> [1311189224.539971] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
modem-manager[27087]: <debug> [1311189224.540045] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189224.540092] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+COPS=3,2;+COPS?<CR>'
modem-manager[27087]: <debug> [1311189224.559988] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 4<CR><LF>'
modem-manager[27087]: <debug> [1311189224.560069] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 4: Operation not supported
modem-manager[27087]: <debug> [1311189224.560117] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+COPS=3,0;+COPS?<CR>'
modem-manager[27087]: <debug> [1311189224.575980] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 4<CR><LF>'
modem-manager[27087]: <debug> [1311189224.576069] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 4: Operation not supported
modem-manager[27087]: <debug> [1311189224.576119] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[27087]: <debug> [1311189224.596898] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CIND:
0,1,0,0,5,0,0<CR><LF><CR><LF>OK<CR><LF>'
modem-manager[27087]: <debug> [1311189224.597038] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGREG=1<CR>'
modem-manager[27087]: <debug> [1311189224.611999] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
modem-manager[27087]: <debug> [1311189224.612084] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189224.612138] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGREG?<CR>'
modem-manager[27087]: <debug> [1311189224.613763] [mm-generic-gsm.c:5130]
simple_connect(): (ttyACM0): network_mode => 7
modem-manager[27087]: <debug> [1311189224.613808] [mm-generic-gsm.c:5130]
simple_connect(): (ttyACM0): allowed_mode => 3
modem-manager[27087]: <debug> [1311189224.613823] [mm-generic-gsm.c:5130]
simple_connect(): (ttyACM0): number => "*99#"
modem-manager[27087]: <debug> [1311189224.613834] [mm-generic-gsm.c:5130]
simple_connect(): (ttyACM0): apn => "internet"
modem-manager[27087]: <debug> [1311189224.613847] [mm-generic-gsm.c:5130]
simple_connect(): (ttyACM0): home_only => TRUE
modem-manager[27087]: <debug> [1311189224.613871] [mm-generic-gsm.c:5019]
simple_state_machine(): (ttyACM0): simple connect state 0
modem-manager[27087]: <debug> [1311189224.613919] [mm-generic-gsm.c:5019]
simple_state_machine(): (ttyACM0): simple connect state 2
modem-manager[27087]: <debug> [1311189224.627987] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
modem-manager[27087]: <debug> [1311189224.628069] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189255.043512] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CGREG?<CR>'
modem-manager[27087]: <debug> [1311189255.056034] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CME ERROR: 100<CR><LF>'
modem-manager[27087]: <debug> [1311189255.056117] [mm-serial-parsers.c:412]
mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
modem-manager[27087]: <debug> [1311189255.056166] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): --> 'AT+CIND?<CR>'
modem-manager[27087]: <debug> [1311189255.077751] [mm-at-serial-port.c:298]
debug_log(): (ttyACM0): <-- '<CR><LF>+CIND:
0,1,0,0,5,0,0<CR><LF><CR><LF>OK<CR><LF>'
