Comment 14 for bug 509738

Revision history for this message
Torsten Spindler (tspindler) wrote : Re: ModemManager from PPA not working in Lucid

For the record, here the syslog output on Karmic:

 Jan 22 17:42:54 wm0830 NetworkManager: <info> Activation (ttyUSB2) starting connection 'LVM-Mobil'
Jan 22 17:42:54 wm0830 NetworkManager: <info> (ttyUSB2): device state change: 3 -> 4 (reason 0)
Jan 22 17:42:54 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled...
Jan 22 17:42:54 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started...
Jan 22 17:42:54 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete.
Jan 22 17:42:54 wm0830 modem-manager: (ttyUSB2) opening serial device...
Jan 22 17:42:54 wm0830 modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> enabling)
Jan 22 17:42:54 wm0830 modem-manager: Got failure code 100: Unknown error
Jan 22 17:42:54 wm0830 modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabling -> enabled)
Jan 22 17:43:05 wm0830 modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabled -> disabled)
Jan 22 17:43:05 wm0830 modem-manager: Registration state changed: 2
Jan 22 17:43:05 wm0830 modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> searching)
Jan 22 17:43:10 wm0830 modem-manager: Registration state changed: 1
Jan 22 17:43:10 wm0830 modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (searching -> registered)
Jan 22 17:43:10 wm0830 modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (registered -> connecting)
Jan 22 17:43:10 wm0830 modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (connecting -> connected)
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) scheduled...
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) starting...
Jan 22 17:43:10 wm0830 NetworkManager: <info> (ttyUSB2): device state change: 4 -> 5 (reason 0)
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) successful.
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) scheduled.
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) complete.
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) started...
Jan 22 17:43:10 wm0830 NetworkManager: <info> (ttyUSB2): device state change: 5 -> 7 (reason 0)
Jan 22 17:43:10 wm0830 NetworkManager: <info> Starting pppd connection
Jan 22 17:43:10 wm0830 NetworkManager: <debug> [1264178590.143451] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute user itu002 ttyUSB2 noipdefault noauth refuse-eap refuse-pap 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
Jan 22 17:43:10 wm0830 NetworkManager: <debug> [1264178590.155159] nm_ppp_manager_start(): ppp started with pid 2614
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 4 of 5 (IP6 Configure Get) scheduled...
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) complete.
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 4 of 5 (IP6 Configure Get) started...
Jan 22 17:43:10 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 4 of 5 (IP6 Configure Get) complete.
Jan 22 17:43:10 wm0830 pppd[2614]: Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
Jan 22 17:43:10 wm0830 pppd[2614]: pppd 2.4.5 started by root, uid 0
Jan 22 17:43:10 wm0830 pppd[2614]: Using interface ppp0
Jan 22 17:43:10 wm0830 pppd[2614]: Connect: ppp0 <--> /dev/ttyUSB2
Jan 22 17:43:10 wm0830 NetworkManager: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Jan 22 17:43:10 wm0830 NetworkManager: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Jan 22 17:43:10 wm0830 pppd[2614]: CHAP authentication succeeded
Jan 22 17:43:10 wm0830 pppd[2614]: CHAP authentication succeeded
Jan 22 17:43:10 wm0830 kernel: [ 1078.760296] PPP BSD Compression module registered
Jan 22 17:43:10 wm0830 kernel: [ 1078.773512] PPP Deflate Compression module registered
Jan 22 17:43:20 wm0830 pppd[2614]: Could not determine remote IP address: defaulting to 10.64.64.64
Jan 22 17:43:20 wm0830 pppd[2614]: Cannot determine ethernet address for proxy ARP
Jan 22 17:43:20 wm0830 pppd[2614]: local IP address 10.33.151.6
Jan 22 17:43:20 wm0830 pppd[2614]: remote IP address 10.64.64.64
Jan 22 17:43:20 wm0830 NetworkManager: <info> PPP manager(IP Config Get) reply received.
Jan 22 17:43:20 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 4 of 5 (IP4 Configure Get) scheduled...
Jan 22 17:43:20 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 4 of 5 (IP4 Configure Get) started...
Jan 22 17:43:20 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 5 of 5 (IP Configure Commit) scheduled...
Jan 22 17:43:20 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 4 of 5 (IP4 Configure Get) complete.
Jan 22 17:43:20 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 5 of 5 (IP Configure Commit) started...
Jan 22 17:43:21 wm0830 NetworkManager: <info> Policy set 'Auto mosquito' (wlan0) as default for routing and DNS.
Jan 22 17:43:21 wm0830 NetworkManager: <info> (ttyUSB2): device state change: 7 -> 8 (reason 0)
Jan 22 17:43:21 wm0830 NetworkManager: <info> Activation (ttyUSB2) successful, device activated.
Jan 22 17:43:21 wm0830 NetworkManager: <info> Activation (ttyUSB2) Stage 5 of 5 (IP Configure Commit) complete.
Jan 22 17:43:21 wm0830 nm-dispatcher.action: Script '/etc/NetworkManager/dispatcher.d/10nm-printing-hook' exited with error status 1.
Jan 22 17:43:22 wm0830 ntpdate[2676]: adjust time server 91.189.94.4 offset 0.021696 sec
Jan 22 17:43:51 wm0830 wpa_supplicant[1225]: CTRL-EVENT-SCAN-RESULTS