Network Manager Looks like pppd didn't initialize our dbus module

[Robert Szucs]

Description: Ubuntu 9.04
Release: 9.0
network-manager:
  Installed: 0.7.1~rc4.1.cf199a964-0ubuntu2
  Candidate: 0.7.1~rc4.1.cf199a964-0ubuntu2
Can not connect with Huawei 800 and 170

ID 12d1:1003 Huawei Technologies Co., Ltd. E220 HSDPA Modem / E270 HSDPA/HSUPA Modem

noname NetworkManager: <info> Activation (ttyUSB0) starting connection '02'
Apr 19 21:20:52 noname NetworkManager: <info> (ttyUSB0): device state change: 3 -> 4
Apr 19 21:20:52 noname NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Apr 19 21:20:52 noname NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Apr 19 21:20:52 noname NetworkManager: <debug> [1240168852.993442] nm_serial_device_open(): (ttyUSB0) opening device...
Apr 19 21:20:52 noname NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Apr 19 21:20:53 noname NetworkManager: <info> (ttyUSB0): powering up...
Apr 19 21:20:53 noname NetworkManager: <info> Registered on Home network
Apr 19 21:20:53 noname NetworkManager: <info> Associated with network: +COPS: 0,2,"23106",0
Apr 19 21:20:53 noname NetworkManager: <info> Connected, Woo!
Apr 19 21:20:53 noname NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
Apr 19 21:20:53 noname NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
Apr 19 21:20:53 noname NetworkManager: <info> (ttyUSB0): device state change: 4 -> 5
Apr 19 21:20:53 noname NetworkManager: <info> Starting pppd connection
Apr 19 21:20:53 noname NetworkManager: <debug> [1240168853.476282] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute ttyUSB0 noipdefault noauth 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
Apr 19 21:20:53 noname pppd[4591]: Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
Apr 19 21:20:53 noname pppd[4591]: pppd 2.4.5 started by root, uid 0
Apr 19 21:20:53 noname NetworkManager: <debug> [1240168853.490790] nm_ppp_manager_start(): ppp started with pid 4591
Apr 19 21:20:53 noname NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Apr 19 21:20:53 noname pppd[4591]: Using interface ppp0
Apr 19 21:20:53 noname pppd[4591]: Connect: ppp0 <--> /dev/ttyUSB0
Apr 19 21:20:53 noname NetworkManager: <info> (ttyUSB0): device state change: 5 -> 6
Apr 19 21:20:53 noname pppd[4591]: CHAP authentication succeeded
Apr 19 21:20:53 noname pppd[4591]: CHAP authentication succeeded
Apr 19 21:20:53 noname NetworkManager: <info> (ttyUSB0): device state change: 6 -> 7
Apr 19 21:21:09 noname NetworkManager: <WARN> pppd_timed_out(): Looks like pppd didn't initialize our dbus module
Apr 19 21:21:09 noname NetworkManager: <info> (ttyUSB0): device state change: 7 -> 9
Apr 19 21:21:09 noname NetworkManager: <debug> [1240168869.002955] nm_serial_device_close(): Closing device 'ttyUSB0'
Apr 19 21:21:09 noname pppd[4591]: Terminating on signal 15
Apr 19 21:21:09 noname NetworkManager: <info> Marking connection '02' invalid.
Apr 19 21:21:09 noname NetworkManager: <info> Activation (ttyUSB0) failed.
Apr 19 21:21:09 noname NetworkManager: <info> (ttyUSB0): device state change: 9 -> 3
Apr 19 21:21:09 noname NetworkManager: <info> (ttyUSB0): deactivating device (reason: 0).
Apr 19 21:21:09 noname NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
Apr 19 21:21:09 noname NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
Apr 19 21:21:09 noname pppd[4591]: Connection terminated.
Apr 19 21:21:10 noname pppd[4591]: Exit.
Apr 19 21:21:11 noname NetworkManager: <debug> [1240168871.001674] ensure_killed(): waiting for ppp pid 4591 to exit
Apr 19 21:21:11 noname NetworkManager: <debug> [1240168871.001773] ensure_killed(): ppp pid 4591 cleaned up

[João Neves (jneves)]

Could you check if you have related messages in /var/log/auth.log?

Maybe something like:

Apr 25 01:43:41 home dbus-daemon: Rejected send message, 1 matched rules; type="method_call", sender=":1.42" (uid=1000 pid=6083 comm="/usr/lib/indicator-applet/indicator-applet --oaf-a") interface="org.freedesktop.DBus.Properties" member="Get" error name="(unset)" requested_reply=0 destination=":1.56" (uid=0 pid=8443 comm="/usr/lib/NetworkManager/nm-dispatcher.action "))

[Robert Szucs (robert-szuecs)]

Please look at this :
Thanks
Apr 26 20:12:29 noname dbus-daemon: Rejected send message, 3 matched rules;
type="error", sender=":1.7" (uid=0 pid=3302 comm="/usr/sbin/NetworkManager
--pid-file /var/run/Netwo") interface="(unset)" member="(unset)" error
name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply=0
destination=":1.52" (uid=0 pid=5064 comm="/usr/sbin/pppd nodetach lock
nodefaultroute ttyUSB"))
Apr 26 20:12:29 noname dbus-daemon: Rejected send message, 3 matched rules;
type="error", sender=":1.7" (uid=0 pid=3302 comm="/usr/sbin/NetworkManager
--pid-file /var/run/Netwo") interface="(unset)" member="(unset)" error
name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply=0
destination=":1.52" (uid=0 pid=5064 comm="/usr/sbin/pppd nodetach lock
nodefaultroute ttyUSB"))
Apr 26 20:12:29 noname dbus-daemon: Rejected send message, 3 matched rules;
type="error", sender=":1.7" (uid=0 pid=3302 comm="/usr/sbin/NetworkManager
--pid-file /var/run/Netwo") interface="(unset)" member="(unset)" error
name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply=0
destination=":1.52" (uid=0 pid=5064 comm="/usr/sbin/pppd nodetach lock
nodefaultroute ttyUSB"))

2009/4/25 João Neves <email address hidden>

> Could you check if you have related messages in /var/log/auth.log?
>
> Maybe something like:
>
> Apr 25 01:43:41 home dbus-daemon: Rejected send message, 1 matched
> rules; type="method_call", sender=":1.42" (uid=1000 pid=6083
> comm="/usr/lib/indicator-applet/indicator-applet --oaf-a")
> interface="org.freedesktop.DBus.Properties" member="Get" error
> name="(unset)" requested_reply=0 destination=":1.56" (uid=0 pid=8443
> comm="/usr/lib/NetworkManager/nm-dispatcher.action "))
>
> --
> Network Manager Looks like pppd didn't initialize our dbus module
> https://bugs.launchpad.net/bugs/363848
> You received this bug notification because you are a direct subscriber
> of the bug.
>

[João Neves (jneves)]

The 'error name="org.freedesktop.DBus.Error.UnknownMethod"' indicates that pppd tried to send a message that NetworkManager does not know. Could you post both your pppd and NM versions?

[Robert Szucs (robert-szuecs)]

Sorry I dont understand. Please be so kind and explain me what shall I do.

Thank you

2009/4/27 João Neves <email address hidden>

> The 'error name="org.freedesktop.DBus.Error.UnknownMethod"' indicates
> that pppd tried to send a message that NetworkManager does not know.
> Could you post both your pppd and NM versions?
>
> --
> Network Manager Looks like pppd didn't initialize our dbus module
> https://bugs.launchpad.net/bugs/363848
> You received this bug notification because you are a direct subscriber
> of the bug.
>

[Robert Szucs (robert-szuecs)]

NM : 0.7.1~rc4.1.cf199a964-0ubuntu2

Package: ppp
Status: install ok installed
Priority: optional
Section: admin
Installed-Size: 1088
Maintainer: Ubuntu Core Developers <email address hidden>
Architecture: i386
Version: 2.4.5~git20081126t100229-0ubuntu2
Replaces: ppp-pam, ppp-udeb
Depends: libc6 (>= 2.4), libpam0g (>= 0.99.7.1), libpcap0.8 (>=
1.0.0-1~exp1), libpam-modules, libpam-runtime (>= 0.76-13.1), netbase,
procps
Suggests: iptables
Conflicts: makedev (<< 2.3.1-56), ppp-pam, ppp-udeb, pppdcapiplugin (<=
1:3.7.2005-07-09-2)
Conffiles:
 /etc/bash_completion.d/pon 41cf8cde5bd9fefe51100a051947b118
 /etc/apm/event.d/ppp c894b205a1638f6fbb7bb477c8d253b6
 /etc/ppp/ip-up.d/0000usepeerdns 47b1eee2bd4e9e492ad5a9f5870ca272
 /etc/ppp/ip-down.d/0000usepeerdns 71822da78b9163dfbcb6f1bbd662b9b6
 /etc/ppp/pppoe_on_boot c3ea78aee841d29ca779783a013b4dac
 /etc/ppp/options b2ec4487e38e801b70ac36b20b3de798
 /etc/ppp/ip-up 612431b1564d97e3925bc692079aabdb
 /etc/ppp/ip-down 7a44bcdb7d4a0920669b496bb4d007b5
 /etc/ppp/ipv6-up 02838ef669ec30a3a6afef7b1ce7ecc9
 /etc/ppp/ipv6-down 831796b566df95e0d5143ca6b35f082d
 /etc/chatscripts/pap 17dbbede1dc894aa6c6c4e8be5727c1d
 /etc/logrotate.d/ppp 8434ebaff1b3b33bb0ea0bce523adfd3
 /etc/init.d/pppd-dns 24aa351f9dac83a4214556b55b8f2070
 /etc/pam.d/ppp cc163be3dbe4258e639238ccd5bcdea0
Description: Point-to-Point Protocol (PPP) - daemon
 The Point-to-Point Protocol provides a standard way to transmit
 datagrams over a serial link, as well as a standard way for the machines
 at either end of the link to negotiate various optional characteristics
 of the link.
 .
 This package is most commonly used to manage a modem for dial-up or
 certain kinds of broadband connections.

2009/4/27 João Neves <email address hidden>

> The 'error name="org.freedesktop.DBus.Error.UnknownMethod"' indicates
> that pppd tried to send a message that NetworkManager does not know.
> Could you post both your pppd and NM versions?
>
> --
> Network Manager Looks like pppd didn't initialize our dbus module
> https://bugs.launchpad.net/bugs/363848
> You received this bug notification because you are a direct subscriber
> of the bug.
>

[Alexander Sack (asac)]

dupe of bug 371291 ... see the "official workaround" in that bugs summary.