From owner-freebsd-current Wed Nov 12 17:26:17 1997 Return-Path: Received: (from root@localhost) by hub.freebsd.org (8.8.7/8.8.7) id RAA29193 for current-outgoing; Wed, 12 Nov 1997 17:26:17 -0800 (PST) (envelope-from owner-freebsd-current) Received: from awfulhak.demon.co.uk (awfulhak.demon.co.uk [158.152.17.1]) by hub.freebsd.org (8.8.7/8.8.7) with ESMTP id RAA29154 for ; Wed, 12 Nov 1997 17:26:05 -0800 (PST) (envelope-from brian@awfulhak.org) Received: from gate.lan.awfulhak.org (localhost [127.0.0.1]) by awfulhak.demon.co.uk (8.8.7/8.8.7) with ESMTP id BAA08951; Thu, 13 Nov 1997 01:05:23 GMT (envelope-from brian@gate.lan.awfulhak.org) Message-Id: <199711130105.BAA08951@awfulhak.demon.co.uk> X-Mailer: exmh version 2.0zeta 7/24/97 To: "Johan Granlund" cc: current@FreeBSD.ORG Subject: Re: ppp and ascend router problems In-reply-to: Your message of "Wed, 12 Nov 1997 23:05:36 +0100." <199711122212.OAA14636@hub.freebsd.org> Mime-Version: 1.0 Content-Type: text/plain; charset=us-ascii Date: Thu, 13 Nov 1997 01:05:23 +0000 From: Brian Somers Sender: owner-freebsd-current@FreeBSD.ORG X-Loop: FreeBSD.org Precedence: bulk > Hi > Once upon a (long) time (ago) i had ppp working, not any more. It has ben > some traffic about ppp and i decided to get it working again. > When trying from a 2.2-stable from around 1 month ago it works fine, but not > from my current machine. > My ISP has some sort of big Ascend router. WinNT and Win95 works. > > Sending ppp.log and hopes anyone have a clue why? > > >From ppp.conf: > > disable lqr > deny lqr > set openmode active > disable pred1 > deny pred1 > > >From ppp.log: > > Nov 12 22:34:58 phoenix ppp[621]: tun0: IPCP: Using trigger address > 255.255.255.0 Why are you using this ? Change it to 0.0.0.0 (or remove it altogether). It's the 4th arg to "set ifaddr". This isn't the problem though, you're not getting as far as IPCP negotiation. > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: State change > Initial --> Closed > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: > LcpSendConfigReq > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: ACCMAP [6] 00000000 > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: MRU [4] 1500 > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: MAGICNUM [6] 58270b8d > Nov 12 22:34:58 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:34:58 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 01 00 18 08 02 > 07 02 02 06 00 00 > Nov 12 22:34:58 phoenix ppp[621]: tun0: HDLC: 00 00 01 04 > 05 dc 05 06 58 27 0b 8d 5d c1 > Nov 12 22:34:58 phoenix ppp[621]: tun0: LCP: State change Closed --> Req-Sent > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: LcpSendConfigReq > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: ACCMAP [6] 00000000 > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: MRU [4] 1500 > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: MAGICNUM [6] 58270b8d > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 02 00 18 08 02 > 07 02 02 06 00 00 Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: 00 00 01 04 > 05 dc 05 06 58 27 0b 8d 17 53 > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: HdlcInput: > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 01 00 1f 01 04 > 05 f4 02 06 00 0a > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: 00 00 03 04 > c0 23 07 02 08 02 13 09 03 00 c0 7b > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: 5f d3 10 50 aa > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: Received Configure Request (1) > state = Req-Sent (6) > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: MRU 1524 > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: ACCMAP 000a0000 > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: AUTHPROTO proto= c023 > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: ???[13] > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: SendConfigRej(Req-Sent) > Nov 12 22:35:01 phoenix ppp[621]: tun0: LCP: ???[13] ppp says it doesn't know what a [13] is. > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 04 01 00 0d 13 09 > 03 00 c0 7b 5f d3 > Nov 12 22:35:01 phoenix ppp[621]: tun0: HDLC: 10 09 96 > Nov 12 22:35:04 phoenix ppp[621]: tun0: LCP: LcpSendConfigReq > Nov 12 22:35:04 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:35:04 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:35:04 phoenix ppp[621]: tun0: LCP: ACCMAP [6] 00000000 > Nov 12 22:35:04 phoenix ppp[621]: tun0: LCP: MRU [4] 1500 > Nov 12 22:35:04 phoenix ppp[621]: tun0: LCP: MAGICNUM [6] 58270b8d > Nov 12 22:35:04 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:35:04 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 03 00 18 08 02 > 07 02 02 06 00 00 > Nov 12 22:35:04 phoenix ppp[621]: tun0: HDLC: 00 00 01 04 > 05 dc 05 06 58 27 0b 8d de da > Nov 12 22:35:05 phoenix ppp[621]: tun0: HDLC: HdlcInput: > Nov 12 22:35:05 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 01 00 1f 01 04 > 05 f4 02 06 00 0a > Nov 12 22:35:05 phoenix ppp[621]: tun0: HDLC: 00 00 03 04 > c0 23 07 02 08 02 13 09 03 00 c0 7b > Nov 12 22:35:05 phoenix ppp[621]: tun0: HDLC: 5f d3 10 50 aa > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: Received Configure Request (1) > state =Req-Sent (6) > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: MRU 1524 > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: ACCMAP 000a0000 > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: AUTHPROTO proto = c023 > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: ???[13] The peer has just violated the ppp protocol by asking for a [13] again :-( > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: SendConfigRej(Req-Sent) > Nov 12 22:35:05 phoenix ppp[621]: tun0: LCP: ???[13] We still don't know. > Nov 12 22:35:05 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:35:05 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 04 01 00 0d 13 09 > 03 00 c0 7b 5f d3 > Nov 12 22:35:05 phoenix ppp[621]: tun0: HDLC: 10 09 96 > Nov 12 22:35:07 phoenix ppp[621]: tun0: LCP: LcpSendConfigReq > Nov 12 22:35:07 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:35:07 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:35:07 phoenix ppp[621]: tun0: LCP: ACCMAP [6] 00000000 > Nov 12 22:35:07 phoenix ppp[621]: tun0: LCP: MRU [4] 1500 > Nov 12 22:35:07 phoenix ppp[621]: tun0: LCP: MAGICNUM [6] 58270b8d > Nov 12 22:35:07 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:35:07 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 04 00 18 08 02 > 07 02 02 06 00 00 > Nov 12 22:35:07 phoenix ppp[621]: tun0: HDLC: 00 00 01 04 > 05 dc 05 06 58 27 0b 8d 92 7f > Nov 12 22:35:09 phoenix ppp[621]: tun0: HDLC: HdlcInput: > Nov 12 22:35:09 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 01 00 1f 01 04 > 05 f4 02 06 00 0a > Nov 12 22:35:09 phoenix ppp[621]: tun0: HDLC: 00 00 03 04 > c0 23 07 02 08 02 13 09 03 00 c0 7b > Nov 12 22:35:09 phoenix ppp[621]: tun0: HDLC: 5f d3 10 50 aa > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: Received Configure Request (1) > state =Req-Sent (6) > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: MRU 1524 > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: ACCMAP 000a0000 > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: AUTHPROTO proto = c023 > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: ???[13] > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: SendConfigRej(Req-Sent) > Nov 12 22:35:09 phoenix ppp[621]: tun0: LCP: ???[13] Deja vous ? > Nov 12 22:35:09 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:35:09 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 04 01 00 0d 13 09 > 03 00 c0 7b 5f d3 > Nov 12 22:35:09 phoenix ppp[621]: tun0: HDLC: 10 09 96 > Nov 12 22:35:10 phoenix ppp[621]: tun0: LCP: LcpSendConfigReq > Nov 12 22:35:10 phoenix ppp[621]: tun0: LCP: ACFCOMP > Nov 12 22:35:10 phoenix ppp[621]: tun0: LCP: PROTOCOMP > Nov 12 22:35:10 phoenix ppp[621]: tun0: LCP: ACCMAP [6] 00000000 > Nov 12 22:35:10 phoenix ppp[621]: tun0: LCP: MRU [4] 1500 > Nov 12 22:35:10 phoenix ppp[621]: tun0: LCP: MAGICNUM [6] 58270b8d > Nov 12 22:35:10 phoenix ppp[621]: tun0: HDLC: HdlcOutput > Nov 12 22:35:10 phoenix ppp[621]: tun0: HDLC: ff 03 c0 21 01 05 00 18 08 02 > 07 02 02 06 00 00 > Nov 12 22:35:10 phoenix ppp[621]: tun0: HDLC: 00 00 01 04 > 05 dc 05 06 58 27 0b 8d 5b f6 > Nov 12 22:35:13 phoenix ppp[621]: tun0: LCP: State change Req-Sent --> > Stopped > Nov 12 22:35:13 phoenix ppp[621]: tun0: LCP: LcpLayerFinish > Nov 12 22:35:14 phoenix ppp[621]: tun0: Phase: Connect time: 37 secs > Nov 12 22:35:14 phoenix ppp[621]: tun0: Phase: Modem: 259 octets in, 362 > octets out > Nov 12 22:35:14 phoenix ppp[621]: tun0: Phase: NewPhase: Dead Nov > 12 22:35:14 phoenix ppp[621]: tun0: IPCP: Using trigger address 255.255.255.0 > Nov 12 22:35:14 phoenix ppp[621]: tun0: Phase: Disconnected! > Nov 12 22:35:14 phoenix ppp[621]: tun0: LCP: LcpLayerFinish > Nov 12 22:35:14 phoenix ppp[621]: tun0: Phase: NewPhase: Dead > Nov 12 22:35:14 phoenix ppp[621]: tun0: IPCP: Using trigger address > 255.255.255.0 > ov 12 22:35:31 phoenix ppp[621]: tun0: Phase: PPP Terminated > (normal). It looks like the peer is misbehaving. I'd be interested in seeing a copy of the logs from the working 2.2 stable from about a month ago. Nothing should have changed with LCP negotiations. > /Johan > ___________________________________________________________ > > Internet: Johang@Algonet.se > > I don't even speak for myself -- Brian , , Don't _EVER_ lose your sense of humour....