[Pkg-utopia-maintainers] Bug#563554: network-manager: Connections in twice with the Huawei E220 3G USB modem
Frederic MASSOT
frederic at juliana-multimedia.com
Sun Jan 3 18:53:38 UTC 2010
Package: network-manager
Version: 0.7.2-2
Severity: normal
Hi,
To connect to the network (Connexion GSM SFR) with Huawei E220 3G USB modem, I have to run twice NetworkManager:
The first time is quite long:
~# NM_SERIAL_DEBUG=1 NM_PPP_DEBUG=1 /usr/sbin/NetworkManager --no-daemon
NetworkManager: <info> starting...
/sbin/ifup: interface lo already configured
NetworkManager: <info> Found radio killswitch /org/freedesktop/Hal/devices/pci_168c_13_rfkill_phy0_wlan
NetworkManager: <info> (eth0): new Ethernet device (driver: 'r8169')
NetworkManager: <info> (eth0): exported as /org/freedesktop/Hal/devices/net_00_18_f3_05_ea_a9
NetworkManager: <info> (ath18): driver supports SSID scans (scan_capa 0x01).
NetworkManager: <info> (ath18): new 802.11 WiFi device (driver: 'ath5k')
NetworkManager: <info> (ath18): exported as /org/freedesktop/Hal/devices/net_00_1c_f0_9d_3e_f2
NetworkManager: <info> (ttyS0): ignoring due to lack of mobile broadband capabilties
NetworkManager: <info> (ttyS1): ignoring due to lack of mobile broadband capabilties
NetworkManager: <info> (eth0): device state change: 1 -> 2 (reason 2)
NetworkManager: <info> (eth0): bringing up device.
NetworkManager: <info> (eth0): preparing device.
NetworkManager: <info> (eth0): deactivating device (reason: 2).
NetworkManager: <info> (ath18): device state change: 1 -> 2 (reason 2)
NetworkManager: <info> (ath18): bringing up device.
NetworkManager: <info> (ath18): preparing device.
NetworkManager: <info> (ath18): deactivating device (reason: 2).
NetworkManager: <info> (ath18): supplicant interface state: starting -> ready
NetworkManager: <info> (ath18): device state change: 2 -> 3 (reason 0)
NetworkManager: <info> (ttyUSB1): ignoring due to lack of mobile broadband capabilties
NetworkManager: <info> (ttyUSB0): found serial port (udev:GSM hal:GSM)
NetworkManager: <info> (ttyUSB0): new Modem device (driver: 'option')
NetworkManager: <info> (ttyUSB0): exported as /org/freedesktop/Hal/devices/usb_device_12d1_1003_noserial_if0_serial_usb_0
NetworkManager: <info> (ttyUSB0): device state change: 1 -> 2 (reason 2)
NetworkManager: <info> (ttyUSB0): deactivating device (reason: 2).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info> (ttyUSB0): device state change: 2 -> 3 (reason 0)
NetworkManager: <info> Activation (ttyUSB0) starting connection 'Connexion GSM SFR'
NetworkManager: <info> (ttyUSB0): device state change: 3 -> 4 (reason 0)
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <debug> [1262543978.038383] nm_serial_device_open(): (ttyUSB0) opening device...
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1262543978.145444] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1262543978.203065] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLAS'
NetworkManager: <debug> [1262543978.203635] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0'
NetworkManager: <debug> [1262543978.204435] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1262543978.216393] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0
+CME ERROR: SIM PIN required
'
NetworkManager: <WARN> init_done(): Trying alternate modem initialization (1)
NetworkManager: <debug> [1262543990.002436] nm_serial_debug(): Sending: 'ATZ E0 V1 &C1
'
NetworkManager: <debug> [1262543990.044550] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262543990.044841] nm_serial_debug(): Sending: 'AT+CPIN?
'
NetworkManager: <debug> [1262543990.066045] nm_serial_debug(): Got: '
+CPIN: SIM PIN
OK
'
NetworkManager: <info> (ttyUSB0): GSM pin secret required
NetworkManager: <debug> [1262543990.066768] nm_serial_device_close(): Closing device 'ttyUSB0'
NetworkManager: <info> (ttyUSB0): device state change: 4 -> 6 (reason 0)
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <info> (ttyUSB0): device state change: 6 -> 4 (reason 0)
NetworkManager: <debug> [1262543990.077958] nm_serial_device_open(): (ttyUSB0) opening device...
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1262543990.183573] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1262543990.255553] nm_serial_debug(): Got: '
+CME ERROR: SIM PIN required
'
NetworkManager: <WARN> init_done(): Trying alternate modem initialization (1)
NetworkManager: <debug> [1262544002.002364] nm_serial_debug(): Sending: 'ATZ E0 V1 &C1
'
NetworkManager: <debug> [1262544002.045581] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262544002.045699] nm_serial_debug(): Sending: 'AT+CPIN?
'
NetworkManager: <debug> [1262544002.065652] nm_serial_debug(): Got: '
+CPIN: SIM PIN
OK
'
NetworkManager: <debug> [1262544002.065792] nm_serial_debug(): Sending: 'AT+CPIN="****"
'
NetworkManager: <debug> [1262544002.152108] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262544002.152213] nm_serial_debug(): Sending: 'ATZ E0 V1 &C1
'
NetworkManager: <debug> [1262544002.198560] nm_serial_debug(): Got: '
OK
'
NetworkManager: <info> (ttyUSB0): powering up...
NetworkManager: <debug> [1262544002.199063] nm_serial_debug(): Sending: 'AT+CFUN=1
'
NetworkManager: <debug> [1262544002.223579] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262544002.223702] nm_serial_debug(): Sending: 'AT+CGMM
'
NetworkManager: <debug> [1262544002.243639] nm_serial_debug(): Got: '
E220
OK
'
NetworkManager: <debug> [1262544002.243819] nm_serial_debug(): Sending: 'AT+CREG?
'
NetworkManager: <debug> [1262544002.262847] nm_serial_debug(): Got: '
+CREG: 0,2
OK
'
NetworkManager: <info> Searching for a network...
NetworkManager: <debug> [1262544003.999886] nm_serial_debug(): Sending: 'AT+CREG?
'
NetworkManager: <debug> [1262544004.031210] nm_serial_debug(): Got: '
+CREG: 0,2
OK
'
NetworkManager: <info> Searching for a network...
NetworkManager: <debug> [1262544005.002561] nm_serial_debug(): Sending: 'AT+CREG?
'
NetworkManager: <debug> [1262544005.024574] nm_serial_debug(): Got: '
+CREG: 0,1
OK
'
NetworkManager: <info> Registered on Home network
NetworkManager: <debug> [1262544005.024713] nm_serial_debug(): Sending: 'AT+COPS?
'
NetworkManager: <debug> [1262544005.131914] nm_serial_debug(): Got: '
+COPS: 0,0,"FFFFFFFFFFFFFFFF",2
OK
'
NetworkManager: <info> Associated with network: +COPS: 0,0,"FFFFFFFFFFFFFFFF",2
NetworkManager: <debug> [1262544005.132065] nm_serial_debug(): Sending: 'AT+CGDCONT=1,"IP","slsfr"
'
NetworkManager: <debug> [1262544005.220558] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262544005.220905] nm_serial_debug(): Sending: 'ATD*99***1#
'
NetworkManager: <debug> [1262544005.250589] nm_serial_debug(): Got: '
CONNECT
'
NetworkManager: <info> Connected, Woo!
NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
NetworkManager: <info> (ttyUSB0): device state change: 4 -> 5 (reason 0)
NetworkManager: <info> Starting pppd connection
NetworkManager: <debug> [1262544005.258481] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute debug user slsfr ttyUSB0 noipdefault noauth refuse-eap refuse-mschap refuse-mschap-v2 usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/0 plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so
NetworkManager: <debug> [1262544005.261985] nm_ppp_manager_start(): ppp started with pid 8065
NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
** Message: nm-ppp-plugin: (plugin_init): initializing
** Message: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection'
using channel 6
Using interface ppp0
Connect: ppp0 <--> /dev/ttyUSB0
** Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xd89367ea> <pcomp> <accomp>]
rcvd [LCP ConfReq id=0x0 <asyncmap 0x0> <auth chap MD5> <magic 0xb797a2> <pcomp> <accomp>]
sent [LCP ConfAck id=0x0 <asyncmap 0x0> <auth chap MD5> <magic 0xb797a2> <pcomp> <accomp>]
rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xd89367ea> <pcomp> <accomp>]
** Message: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate'
NetworkManager: <info> (ttyUSB0): device state change: 5 -> 6 (reason 0)
rcvd [LCP DiscReq id=0x1 magic=0xb797a2]
rcvd [CHAP Challenge id=0x1 <161abdc5c6fffb012e2155479877f525>, name = "UMTS_CHAP_SRVR"]
** Message: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials...
** Message: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager
sent [CHAP Response id=0x1 <1da76ab61eea03ef97f8c0d7c513a8ed>, name = "slsfr"]
rcvd [CHAP Success id=0x1 ""]
CHAP authentication succeeded
CHAP authentication succeeded
** Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
rcvd [LCP ProtRej id=0x2 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
NetworkManager: <info> (ttyUSB0): device state change: 6 -> 7 (reason 0)
rcvd [IPCP ConfNak id=0x1 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14>]
rcvd [IPCP ConfNak id=0x2 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x3 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14>]
rcvd [IPCP ConfNak id=0x3 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x4 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14>]
rcvd [IPCP ConfNak id=0x4 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x5 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14>]
rcvd [IPCP ConfNak id=0x5 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x6 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x6 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x7 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x7 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x8 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x8 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x9 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x9 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0xa <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0xa <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0xb <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0xb <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0xc <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0xc <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0xd <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0xd <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0xe <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0xe <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0xf <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0xf <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x10 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x10 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x11 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x11 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x12 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x12 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x13 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x13 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x14 <compress VJ 0f 01> <addr 0.0.0.0>]
rcvd [IPCP ConfNak id=0x14 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x15 <compress VJ 0f 01> <addr 0.0.0.0>]
NetworkManager: <WARN> pppd_timed_out(): Looks like pppd didn't initialize our dbus module
NetworkManager: <info> (ttyUSB0): device state change: 7 -> 9 (reason 14)
NetworkManager: <debug> [1262544025.999941] nm_serial_device_close(): Closing device 'ttyUSB0'
Terminating on signal 15
** Message: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate'
** Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
sent [LCP TermReq id=0x2 "User request"]
NetworkManager: <info> Marking connection 'Connexion GSM SFR' invalid.
NetworkManager: <info> Activation (ttyUSB0) failed.
rcvd [LCP TermAck id=0x2]
** Message: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect'
Connection terminated.
NetworkManager: <info> (ttyUSB0): device state change: 9 -> 3 (reason 0)
NetworkManager: <info> (ttyUSB0): deactivating device (reason: 0).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
** Message: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead'
** Message: nm-ppp-plugin: (nm_exit_notify): cleaning up
NetworkManager: <debug> [1262544027.999549] ensure_killed(): waiting for ppp pid 8065 to exit
NetworkManager: <debug> [1262544027.999674] ensure_killed(): ppp pid 8065 cleaned up
The second is faster and does not fail:
NetworkManager: <info> Activation (ttyUSB0) starting connection 'Connexion GSM SFR'
NetworkManager: <info> (ttyUSB0): device state change: 3 -> 4 (reason 0)
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <debug> [1262544082.390326] nm_serial_device_open(): (ttyUSB0) opening device...
NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1262544082.498325] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1262544082.567632] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262544082.567746] nm_serial_debug(): Sending: 'AT+CPIN?
'
NetworkManager: <debug> [1262544082.588013] nm_serial_debug(): Got: '
+CPIN: READY
OK
'
NetworkManager: <debug> [1262544082.588179] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1262544082.658565] nm_serial_debug(): Got: '
OK
'
NetworkManager: <info> (ttyUSB0): powering up...
NetworkManager: <debug> [1262544082.658714] nm_serial_debug(): Sending: 'AT+CFUN=1
'
NetworkManager: <debug> [1262544082.682410] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262544082.682534] nm_serial_debug(): Sending: 'AT+CREG?
'
NetworkManager: <debug> [1262544082.702379] nm_serial_debug(): Got: '
+CREG: 0,1
OK
'
NetworkManager: <info> Registered on Home network
NetworkManager: <debug> [1262544082.702546] nm_serial_debug(): Sending: 'AT+COPS?
'
NetworkManager: <debug> [1262544082.722418] nm_serial_debug(): Got: '
+COPS: 0,0,"FFFFFFFFFFFFFFFF",2
OK
'
NetworkManager: <info> Associated with network: +COPS: 0,0,"FFFFFFFFFFFFFFFF",2
NetworkManager: <debug> [1262544082.722590] nm_serial_debug(): Sending: 'AT+CGDCONT=1,"IP","slsfr"
'
NetworkManager: <debug> [1262544082.785894] nm_serial_debug(): Got: '
OK
'
NetworkManager: <debug> [1262544082.786020] nm_serial_debug(): Sending: 'ATD*99***1#
'
NetworkManager: <debug> [1262544082.816585] nm_serial_debug(): Got: '
CONNECT 3600000
'
NetworkManager: <info> Connected, Woo!
NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
NetworkManager: <info> (ttyUSB0): device state change: 4 -> 5 (reason 0)
NetworkManager: <info> Starting pppd connection
NetworkManager: <debug> [1262544082.824332] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute debug user slsfr ttyUSB0 noipdefault noauth refuse-eap refuse-mschap refuse-mschap-v2 usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/1 plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so
NetworkManager: <debug> [1262544082.828307] nm_ppp_manager_start(): ppp started with pid 11067
NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
** Message: nm-ppp-plugin: (plugin_init): initializing
** Message: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection'
using channel 7
Using interface ppp0
Connect: ppp0 <--> /dev/ttyUSB0
** Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xee2c33d9> <pcomp> <accomp>]
rcvd [LCP ConfReq id=0x3 <asyncmap 0x0> <auth chap MD5> <magic 0xb8c6b1> <pcomp> <accomp>]
sent [LCP ConfAck id=0x3 <asyncmap 0x0> <auth chap MD5> <magic 0xb8c6b1> <pcomp> <accomp>]
rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xee2c33d9> <pcomp> <accomp>]
** Message: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate'
NetworkManager: <info> (ttyUSB0): device state change: 5 -> 6 (reason 0)
rcvd [LCP DiscReq id=0x4 magic=0xb8c6b1]
rcvd [CHAP Challenge id=0x1 <bc11c3b3d6a9c1cb1c8975174c997c25>, name = "UMTS_CHAP_SRVR"]
** Message: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials...
** Message: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager
sent [CHAP Response id=0x1 <462f9f3b0a99a2745e8ad28cebfdd8a2>, name = "slsfr"]
rcvd [CHAP Success id=0x1 ""]
CHAP authentication succeeded
CHAP authentication succeeded
** Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
NetworkManager: <info> (ttyUSB0): device state change: 6 -> 7 (reason 0)
rcvd [LCP ProtRej id=0x5 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
rcvd [IPCP ConfNak id=0x1 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14>]
rcvd [IPCP ConfNak id=0x2 <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
sent [IPCP ConfReq id=0x3 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14>]
rcvd [IPCP ConfReq id=0x0]
sent [IPCP ConfNak id=0x0 <addr 0.0.0.0>]
rcvd [IPCP ConfRej id=0x3 <compress VJ 0f 01>]
sent [IPCP ConfReq id=0x4 <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns3 10.11.12.14>]
rcvd [IPCP ConfNak id=0x4 <addr 10.50.53.175> <ms-dns1 172.20.2.10> <ms-dns3 172.20.2.39>]
sent [IPCP ConfReq id=0x5 <addr 10.50.53.175> <ms-dns1 172.20.2.10> <ms-dns3 172.20.2.39>]
rcvd [IPCP ConfAck id=0x5 <addr 10.50.53.175> <ms-dns1 172.20.2.10> <ms-dns3 172.20.2.39>]
rcvd [IPCP ConfReq id=0x1]
sent [IPCP ConfAck id=0x1]
Could not determine remote IP address: defaulting to 10.64.64.64
Cannot determine ethernet address for proxy ARP
local IP address 10.50.53.175
remote IP address 10.64.64.64
primary DNS address 172.20.2.10
secondary DNS address 172.20.2.39
** Message: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running'
** Message: nm-ppp-plugin: (nm_ip_up): ip-up event
** Message: nm-ppp-plugin: (nm_ip_up): sending Ip4Config to NetworkManager...
NetworkManager: <info> PPP manager(IP Config Get) reply received.
NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) scheduled...
NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) started...
NetworkManager: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) scheduled...
NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) complete.
NetworkManager: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) started...
Script /etc/ppp/ip-up started (pid 11072)
Script /etc/ppp/ip-up finished (pid 11072), status = 0x0
NetworkManager: <info> (ppp0): writing resolv.conf to /sbin/resolvconf
NetworkManager: <info> (ttyUSB0): device state change: 7 -> 8 (reason 0)
NetworkManager: <info> (ppp0): writing resolv.conf to /sbin/resolvconf
NetworkManager: <info> Policy set 'Connexion GSM SFR' (ppp0) as default for routing and DNS.
NetworkManager: <info> Activation (ttyUSB0) successful, device activated.
NetworkManager: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) complete.
Regards.
-- System Information:
Debian Release: squeeze/sid
APT prefers testing
APT policy: (500, 'testing'), (500, 'stable')
Architecture: i386 (i686)
Kernel: Linux 2.6.32 (PREEMPT)
Locale: LANG=fr_FR at euro, LC_CTYPE=fr_FR at euro (charmap=ISO-8859-15)
Shell: /bin/sh linked to /bin/dash
Versions of packages network-manager depends on:
ii adduser 3.112 add and remove users and groups
ii dbus 1.2.16-2 simple interprocess messaging syst
ii dhcp3-client 3.1.3-1 DHCP client
ii hal 0.5.14-1 Hardware Abstraction Layer
ii ifupdown 0.6.9 high level tools to configure netw
ii libc6 2.10.2-2 GNU C Library: Shared libraries
ii libdbus-1-3 1.2.16-2 simple interprocess messaging syst
ii libdbus-glib-1-2 0.82-2 simple interprocess messaging syst
ii libgcrypt11 1.4.4-6 LGPL Crypto library - runtime libr
ii libglib2.0-0 2.22.3-1 The GLib library of C routines
ii libgnutls26 2.8.5-2 the GNU TLS library - runtime libr
ii libhal1 0.5.14-1 Hardware Abstraction Layer - share
ii libnl1 1.1-5 library for dealing with netlink s
ii libnm-glib0 0.7.2-2 network management framework (GLib
ii libnm-util1 0.7.2-2 network management framework (shar
ii libpolkit-dbus2 0.9-4 library for accessing PolicyKit vi
ii libpolkit2 0.9-4 library for accessing PolicyKit
ii libudev0 149-2 libudev shared library
ii libuuid1 2.16.2-0 Universally Unique ID library
ii lsb-base 3.2-23 Linux Standard Base 3.2 init scrip
ii wpasupplicant 0.6.9-3 client support for WPA and WPA2 (I
Versions of packages network-manager recommends:
ii dnsmasq-base 2.51-1 A small caching DNS proxy and DHCP
ii iptables 1.4.6-2 administration tools for packet fi
ii network-manager-gnome 0.7.2-1 network management framework (GNOM
ii policykit 0.9-4 framework for managing administrat
ii ppp 2.4.4rel-10.1 Point-to-Point Protocol (PPP) - da
Versions of packages network-manager suggests:
ii avahi-autoipd 0.6.25-2 Avahi IPv4LL network address confi
-- no debconf information
More information about the Pkg-utopia-maintainers
mailing list