I'm having trouble getting the new demand dialing feature of pppd to
work. When I start pppd, everything seems fine. Then when I send a
packet, pppd tries to bring up the line, but fails with a "Failed to
negotiate desired IP addresses" error. Any ideas what I'm doing wrong?


Here's what pppd logs with debugging turned on:

Mar 20 14:36:54 spiff pppd[706]: pppd 2.3.0 started by khym, uid 500
Mar 20 14:36:54 spiff pppd[706]: Using interface ppp0
Mar 20 14:36:54 spiff pppd[706]: local  IP address 0.0.0.0
Mar 20 14:36:54 spiff pppd[706]: remote IP address 204.181.161.4
Mar 20 14:37:28 spiff pppd[706]: Starting link
Mar 20 14:37:32 spiff pppd[706]: Serial connection established.
Mar 20 14:37:33 spiff pppd[706]: Connect: ppp0 <--> /dev/tty01
Mar 20 14:37:33 spiff pppd[706]: sent [LCP ConfReq id=0x1 <mru 552> <asyncmap 0x0> <magic 0x45cb6f9d> <pcomp> <accomp>]
Mar 20 14:37:33 spiff pppd[706]: rcvd [LCP ConfAck id=0x1 <mru 552> <asyncmap 0x0> <magic 0x45cb6f9d> <pcomp> <accomp>]
Mar 20 14:37:33 spiff pppd[706]: rcvd [LCP ConfReq id=0x1 <magic 0xb8be7e29> <auth pap>]
Mar 20 14:37:33 spiff pppd[706]: sent [LCP ConfAck id=0x1 <magic 0xb8be7e29> <auth pap>]
Mar 20 14:37:33 spiff pppd[706]: sent [PAP AuthReq id=0x1 user="MyUserName" password="MyPassword"]
Mar 20 14:37:34 spiff pppd[706]: rcvd [PAP AuthAck id=0x1msg="Login Succeeded"]
Mar 20 14:37:34 spiff pppd[706]: Remote message: Login Succeeded
Mar 20 14:37:34 spiff pppd[706]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <compress VJ 0f 01>]
Mar 20 14:37:34 spiff pppd[706]: rcvd [IPCP ConfReq id=0x1 <compress VJ 0f 00> <addr 204.181.161.4>]
Mar 20 14:37:34 spiff pppd[706]: sent [IPCP ConfAck id=0x1 <compress VJ 0f 00> <addr 204.181.161.4>]
Mar 20 14:37:34 spiff pppd[706]: rcvd [IPCP ConfNak id=0x1 <addr 204.181.161.79>]
Mar 20 14:37:34 spiff pppd[706]: sent [IPCP ConfReq id=0x2 <addr 204.181.161.79> <compress VJ 0f 01>]
Mar 20 14:37:34 spiff pppd[706]: rcvd [IPCP ConfAck id=0x2 <addr 204.181.161.79> <compress VJ 0f 01>]
Mar 20 14:37:34 spiff pppd[706]: Failed to negotiate desired IP addresses
Mar 20 14:37:34 spiff pppd[706]: sent [IPCP TermReq id=0x3 57 72 6f 6e 67 20 49 50 20 61 64 64 72 65 73 73 65 73]
Mar 20 14:37:34 spiff pppd[706]: rcvd [IPCP TermAck id=0x2]
Mar 20 14:37:34 spiff pppd[706]: sent [LCP TermReq id=0x2 4e 6f 20 6e 65 74 77 6f 72 6b 20 70 72 6f 74 6f 63 6f 6c 73 20 72 75 6e 6e 69 6e 67]
Mar 20 14:37:34 spiff pppd[706]: Modem hangup
Mar 20 14:37:34 spiff pppd[706]: Connection terminated.


Here's a log with demand dialing turned off:

Mar 20 14:03:32 spiff pppd[613]: pppd 2.3.0 started by khym, uid 500
Mar 20 14:03:36 spiff pppd[613]: Serial connection established.
Mar 20 14:03:37 spiff pppd[613]: Using interface ppp0
Mar 20 14:03:37 spiff pppd[613]: Connect: ppp0 <--> /dev/tty01
Mar 20 14:03:37 spiff pppd[613]: sent [LCP ConfReq id=0x1 <mru 552> <asyncmap 0x0> <magic 0x1c69885f> <pcomp> <accomp>]
Mar 20 14:03:37 spiff pppd[613]: rcvd [LCP ConfAck id=0x1 <mru 552> <asyncmap 0x0> <magic 0x1c69885f> <pcomp> <accomp>]
Mar 20 14:03:37 spiff pppd[613]: rcvd [LCP ConfReq id=0x1 <magic 0x78b438c7> <auth pap>]
Mar 20 14:03:37 spiff pppd[613]: sent [LCP ConfAck id=0x1 <magic 0x78b438c7> <auth pap>]
Mar 20 14:03:37 spiff pppd[613]: sent [PAP AuthReq id=0x1 user="MyUserName" password="MyPassword"]
Mar 20 14:03:37 spiff pppd[613]: rcvd [PAP AuthAck id=0x1msg="Login Succeeded"]
Mar 20 14:03:37 spiff pppd[613]: Remote message: Login Succeeded
Mar 20 14:03:37 spiff pppd[613]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <compress VJ 0f 01>]
Mar 20 14:03:37 spiff pppd[613]: rcvd [IPCP ConfReq id=0x1 <compress VJ 0f 00> <addr 204.181.161.4>]
Mar 20 14:03:37 spiff pppd[613]: sent [IPCP ConfAck id=0x1 <compress VJ 0f 00> <addr 204.181.161.4>]
Mar 20 14:03:37 spiff pppd[613]: rcvd [IPCP ConfNak id=0x1 <addr 204.181.161.77>]
Mar 20 14:03:37 spiff pppd[613]: sent [IPCP ConfReq id=0x2 <addr 204.181.161.77> <compress VJ 0f 01>]
Mar 20 14:03:37 spiff pppd[613]: rcvd [IPCP ConfAck id=0x2 <addr 204.181.161.77> <compress VJ 0f 01>]
Mar 20 14:03:37 spiff pppd[613]: local  IP address 204.181.161.77
Mar 20 14:03:37 spiff pppd[613]: remote IP address 204.181.161.4


And here's my /etc/ppp/options file:

tty01
115200
debug
:204.181.161.4
noipdefault
demand
persist
idle 30
asyncmap 0
connect "chat -v -f /etc/ppp/isdn.chat"
crtscts
defaultroute
lock
vj-max-slots 16
mru 552
mtu 552
name MyUserName
-bsdcomp
-deflate

Name: Dave Huang     |   Mammal, mammal / their names are called /
INet: khym@bga.com   |   they raise a paw / the bat, the cat /
FurryMUCK: Dahan     |   dolphin and dog / koala bear and hog -- TMBG
Dahan: Hani G Y+C 20 Y++ L+++ W- C++ T++ A+ E+ S++ V++ F- Q+++ P+ B+ PA+ PL++