[H-GEN] ppp hassles

[Paul Gearon]

[ Humbug *General* list - semi-serious discussions about Humbug and ]
[ Unix-related topics.  Please observe the list's charter.          ]

Hi,
I've just changed from an untimed account to a faster timed account. 
This means that I'm manually starting ppp, which means I'm actually
present when my modem dials up.  As a result I'm noticing some strange
behaviour from my modem.

Every time I log in it fails the first time.  I'm set to redial, so it
tries again immediately.  The second time it always works.

I have debugging enabled, so I looked in the log:

<excerpt>
Dec  7 21:40:15 confusion ifup-ppp: pppd started for ppp0 on /dev/modem
at 115200
Dec  7 21:40:15 confusion pppd[910]: pppd 2.3.10 started by root, uid 0
Dec  7 21:40:42 confusion pppd[910]: Serial connection established.
Dec  7 21:40:42 confusion pppd[910]: Using interface ppp0
Dec  7 21:40:42 confusion pppd[910]: Connect: ppp0 <--> /dev/modem
Dec  7 21:40:43 confusion pppd[910]: sent [LCP ConfReq id=0x1 <asyncmap
0x0> <magic 0x4bc5bc1d> <pcomp> <accomp>]
Dec  7 21:40:43 confusion pppd[910]: Hangup (SIGHUP)
Dec  7 21:40:43 confusion pppd[910]: sent [LCP TermReq id=0x2 "User
request"]
Dec  7 21:40:43 confusion pppd[910]: rcvd [LCP ConfAck id=0x1 <asyncmap
0x0> <magic 0x4bc5bc1d> <pcomp> <accomp>]
Dec  7 21:40:43 confusion pppd[910]: rcvd [LCP TermAck id=0x2]
Dec  7 21:40:43 confusion pppd[910]: Connection terminated.
Dec  7 21:40:43 confusion pppd[910]: Hangup (SIGHUP)
Dec  7 21:40:43 confusion pppd[910]: Exit.
Dec  7 21:40:46 confusion ifup-ppp: pppd started for ppp0 on /dev/modem
at 115200
(goes on to connect successfully now)
</excerpt>

The log from the chat session is just as uninformative:

<excerpt>
Dec  8 20:44:36 confusion chat[2511]: expect (~)
Dec  8 20:44:36 confusion chat[2511]: : p^M
Dec  8 20:44:36 confusion chat[2511]: ^M
Dec  8 20:44:36 confusion chat[2511]: Switching to PPP.^M
Dec  8 20:44:37 confusion chat[2511]: ~
Dec  8 20:44:37 confusion chat[2511]:  -- got it 
Dec  8 20:44:37 confusion chat[2511]: send (^M)
Dec  8 20:44:37 confusion pppd[2499]: Serial connection established.
Dec  8 20:44:37 confusion pppd[2499]: Using interface ppp0
Dec  8 20:44:37 confusion pppd[2499]: Connect: ppp0 <--> /dev/modem
Dec  8 20:44:38 confusion pppd[2499]: Hangup (SIGHUP)
Dec  8 20:44:38 confusion pppd[2499]: Connection terminated.
Dec  8 20:44:38 confusion pppd[2499]: Hangup (SIGHUP)
Dec  8 20:44:38 confusion pppd[2499]: Exit.
Dec  8 20:44:41 confusion ifup-ppp: pppd started for ppp0 on /dev/modem
at 115200
Dec  8 20:44:41 confusion pppd[2512]: pppd 2.3.10 started by root, uid 0
</excerpt>

>From this you can see my machine (named "confusion") starts pppd and
successfully connects.  Then it gets a SIGHUP, so pppd logs it and
initiates a graceful hangup with a TermReq LCP packet.

This is a RH 6.1 system.  Any ideas what would be killing ppp and then
letting it run the second time around?


-- 
Regards,
Paul

Paul Gearon
gearon at computer.org

Catapultam habeo. Nisi pecuniam omnem mihi dabis, ad caput tuum saxum
immane mittam.
(Translation from latin: "I have a catapult. Give me all the money, or I
will fling an enormous rock at your head.")

--
* This is list (humbug) general handled by majordomo at lists.humbug.org.au .
* Postings to this list are only accepted from subscribed addresses of
* lists 'general' or 'general-post'.