Using NetworkMananger with Sony Ericsson K770i via USB (ttyACM0)

[Alex Buell <alex buell munted org uk>]

Hi!

Whilst I have a fully working pppd connection via my K770i mobile phone
using manual pon / poff manual commands, I can't seem to set it up
properly with Network Mananger. 

lsusb shows:

Bus 001 Device 021: ID 0fce:d0b7 Sony Ericsson Mobile Communications AB 

and it shows up as /dev/ttyACM0. 

Is there an HOWTO out there detailing what I need to do to get pppd to
work with my K770i? 

When I tried to start the pppd connection with NetworkManager I got the
following in the logs:

Aug  3 11:23:09 lithium NetworkManager: <info>  Activation (ttyACM0) starting connection 'Vodafone'
Aug  3 11:23:09 lithium NetworkManager: <info>  (ttyACM0): device state change: 3 -> 4 (reason 0)
Aug  3 11:23:09 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) scheduled...
Aug  3 11:23:09 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) started...
Aug  3 11:23:09 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) complete.
Aug  3 11:23:09 lithium modem-manager: (ttyACM0) opening serial device...
Aug  3 11:23:09 lithium modem-manager: Modem /org/freedesktop/ModemManager/Modems/3: state changed (disabled -> enabling)
Aug  3 11:23:09 lithium modem-manager: Got failure code 3: No carrier
Aug  3 11:23:10 lithium modem-manager: Modem /org/freedesktop/ModemManager/Modems/3: state changed (enabling -> enabled)
Aug  3 11:23:10 lithium modem-manager: Registration state changed: 1
Aug  3 11:23:10 lithium modem-manager: Modem /org/freedesktop/ModemManager/Modems/3: state changed (enabled -> registered)
Aug  3 11:23:10 lithium modem-manager: Modem /org/freedesktop/ModemManager/Modems/3: state changed (registered -> connecting)
Aug  3 11:23:11 lithium modem-manager: Modem /org/freedesktop/ModemManager/Modems/3: state changed (connecting -> connected)
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 2 of 5 (Device Configure) scheduled...
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 2 of 5 (Device Configure) starting...
Aug  3 11:23:11 lithium NetworkManager: <info>  (ttyACM0): device state change: 4 -> 5 (reason 0)
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 2 of 5 (Device Configure) successful.
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 3 of 5 (IP Configure Start) scheduled.
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 2 of 5 (Device Configure) complete.
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 3 of 5 (IP Configure Start) started...
Aug  3 11:23:11 lithium NetworkManager: <info>  (ttyACM0): device state change: 5 -> 7 (reason 0)
Aug  3 11:23:11 lithium NetworkManager: <info>  Starting pppd connection
Aug  3 11:23:11 lithium NetworkManager: <debug> [1280830991.450278] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute ttyACM0 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/2 plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so
Aug  3 11:23:11 lithium NetworkManager: <debug> [1280830991.457036] nm_ppp_manager_start(): ppp started with pid 4980
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 3 of 5 (IP Configure Start) complete.
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 4 of 5 (IP6 Configure Get) started...
Aug  3 11:23:11 lithium NetworkManager: <info>  Activation (ttyACM0) Stage 4 of 5 (IP6 Configure Get) complete.
Aug  3 11:23:11 lithium pppd[4980]: Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
Aug  3 11:23:11 lithium pppd[4980]: pppd 2.4.4 started by root, uid 0
Aug  3 11:23:11 lithium modem-manager: (net/ppp0): could not get port's parent device
Aug  3 11:23:11 lithium pppd[4980]: Using interface ppp0
Aug  3 11:23:11 lithium pppd[4980]: Connect: ppp0 <--> /dev/ttyACM0
Aug  3 11:23:11 lithium pppd[4980]: CHAP authentication succeeded: Congratulations!
Aug  3 11:23:11 lithium pppd[4980]: CHAP authentication succeeded
Aug  3 11:23:12 lithium pppd[4980]: LCP terminated by peer
Aug  3 11:23:12 lithium pppd[4980]: Modem hangup
Aug  3 11:23:12 lithium pppd[4980]: Connection terminated.
Aug  3 11:23:12 lithium NetworkManager: <info>  (ttyACM0): device state change: 7 -> 9 (reason 13)
Aug  3 11:23:12 lithium modem-manager: (ttyACM0) closing serial device...
Aug  3 11:23:12 lithium NetworkManager: <info>  Marking connection 'Vodafone' invalid.
Aug  3 11:23:12 lithium NetworkManager: <info>  Activation (ttyACM0) failed.
Aug  3 11:23:12 lithium NetworkManager: <info>  (ttyACM0): device state change: 9 -> 3 (reason 0)
Aug  3 11:23:12 lithium NetworkManager: <info>  (ttyACM0): deactivating device (reason: 0).
Aug  3 11:23:12 lithium modem-manager: Modem /org/freedesktop/ModemManager/Modems/3: state changed (connected -> disconnecting)
Aug  3 11:23:12 lithium modem-manager: Modem /org/freedesktop/ModemManager/Modems/3: state changed (disconnecting -> connected)
Aug  3 11:23:13 lithium pppd[4980]: Exit.
Aug  3 11:23:13 lithium dbus-daemon: [system] Rejected send message, 1 matched rules; type="error", sender=":1.92" (uid=0 pid=23090 comm="/usr/sbin/NetworkManager) interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply=0 destination=":1.149" (uid=0 pid=4980 comm="/usr/sbin/pppd))
Aug  3 11:23:14 lithium NetworkManager: <debug> [1280830994.999451] ensure_killed(): waiting for ppp pid 4980 to exit
Aug  3 11:23:14 lithium NetworkManager: <debug> [1280830994.999632] ensure_killed(): ppp pid 4980 cleaned up

-- 
http://www.munted.org.uk

One very high maintenance cat living here.