From owner-freebsd-stable Fri Feb 12 04:15:25 1999 Return-Path: Received: (from majordom@localhost) by hub.freebsd.org (8.8.8/8.8.8) id EAA02420 for freebsd-stable-outgoing; Fri, 12 Feb 1999 04:15:25 -0800 (PST) (envelope-from owner-freebsd-stable@FreeBSD.ORG) Received: from alushta.NL.net (alushta.NL.net [193.78.240.22]) by hub.freebsd.org (8.8.8/8.8.8) with ESMTP id EAA02414 for ; Fri, 12 Feb 1999 04:15:22 -0800 (PST) (envelope-from benst@nemesis.stuyts.nl) Received: from stuyts by alushta.NL.net with UUCP id <4980-8405>; Fri, 12 Feb 1999 13:15:01 +0100 Received: from nemesis.stuyts.nl (uucp@localhost) by terminus.stuyts.nl (8.9.2/8.9.2) with UUCP id NAA21655 for stable@freebsd.org; Fri, 12 Feb 1999 13:10:10 +0100 (MET) (envelope-from benst@nemesis.stuyts.nl) Received: from giskard.stuyts.nl (giskard.stuyts.nl [193.78.231.1]) by nemesis.stuyts.nl (8.8.8/8.8.8) with ESMTP id NAA04486 for ; Fri, 12 Feb 1999 13:09:22 +0100 (CET) (envelope-from benst) Received: (from benst@localhost) by giskard.stuyts.nl (8.8.5/8.8.5) id NAA03283 for stable@freebsd.org; Fri, 12 Feb 1999 13:09:21 +0100 (MET) Message-Id: <199902121209.NAA03283@giskard.stuyts.nl> Content-Type: text/plain MIME-Version: 1.0 (NeXT Mail 3.3 v118.2) X-Nextstep-Mailer: Mail 3.3 (Enhance 2.0b6) Received: by NeXT.Mailer (1.118.2) From: Ben Stuyts Date: Fri, 12 Feb 99 13:09:19 +0100 To: stable@FreeBSD.ORG Subject: ppp problem Reply-To: ben@stuyts.nl Sender: owner-freebsd-stable@FreeBSD.ORG Precedence: bulk X-Loop: FreeBSD.ORG Hello, Sometimes I have a problem connecting to my ISP. It looks like an authentication problem, but I'm not sure. It shouldn't happen really, because usually the ppp connection comes up fine. Sometimes it keeps on failing however, and the only solution is to power cycle the modem. (a ZyXEL Elite 2864 ISDN) ATZ is not enough. It is a dial on demand connection, so it is really annoying that it sometimes won't work. Here is the ppp log file, and I hope someone can help me understand what is actually going wrong: Feb 12 12:45:03 nemesis ppp[2181]: tun0: Phase: bundle: Establish Feb 12 12:45:03 nemesis ppp[2181]: tun0: Phase: deflink: closed -> opening Feb 12 12:45:05 nemesis ppp[2181]: tun0: Phase: deflink: Redial timer expired. Feb 12 12:45:05 nemesis ppp[2181]: tun0: Phase: deflink: Connected! Feb 12 12:45:05 nemesis ppp[2181]: tun0: Phase: deflink: opening -> dial Feb 12 12:45:05 nemesis ppp[2181]: tun0: Phase: Phone: xxxxxxxxxx Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: deflink: Dial attempt 1 of 1 Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Send: ATZ^M Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Expect(5): OK Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Received: ATZ^M^M Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Received: OK^M Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Send: ATE1Q0^M Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Expect(5): OK Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Received: ATE1Q0^M^M Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Received: OK^M Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Send: ATB50DIxxxxxxxxxx ^M Feb 12 12:45:05 nemesis ppp[2181]: tun0: Chat: Expect(60): CONNECT Feb 12 12:45:06 nemesis ppp[2181]: tun0: Chat: Received: ATB50DIxxxxxxxxxx ^M^M Feb 12 12:45:06 nemesis ppp[2181]: tun0: Chat: Received: CONNECT 115200/PPP 64000/NONE^M Feb 12 12:45:06 nemesis ppp[2181]: tun0: Chat: Send: ^M Feb 12 12:45:08 nemesis ppp[2181]: tun0: Phase: deflink: dial -> login Feb 12 12:45:08 nemesis ppp[2181]: tun0: Phase: deflink: login -> lcp Feb 12 12:45:08 nemesis ppp[2181]: tun0: LCP: FSM: Using "deflink" as a transport Feb 12 12:45:08 nemesis ppp[2181]: tun0: LCP: deflink: State change Initial --> Closed Feb 12 12:45:08 nemesis ppp[2181]: tun0: LCP: deflink: State change Closed --> Stopped Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: LayerStart Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigReq(17) state = Stopped Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: ACFCOMP[2] Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: PROTOCOMP[2] Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: MRU[4] 1500 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0x57e051b2 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: State change Stopped --> Req-Sent Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: RecvConfigRej(17) state = Req-Sent Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: PROTOCOMP[2] Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: ACFCOMP[2] Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigReq(18) state = Req-Sent Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: MRU[4] 1500 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0x57e051b2 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: RecvConfigReq(1) state = Req-Sent Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigAck(1) state = Req-Sent Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:09 nemesis ppp[2181]: tun0: LCP: deflink: State change Req-Sent --> Ack-Sent Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigReq(18) state = Ack-Sent Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: MRU[4] 1500 Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0x57e051b2 Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: deflink: RecvConfigReq(2) state = Ack-Sent Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigAck(2) state = Ack-Sent Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:12 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigReq(18) state = Ack-Sent Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: MRU[4] 1500 Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0x57e051b2 Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: deflink: RecvConfigReq(3) state = Ack-Sent Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigAck(3) state = Ack-Sent Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:15 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigReq(18) state = Ack-Sent Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: MRU[4] 1500 Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0x57e051b2 Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: deflink: RecvConfigReq(4) state = Ack-Sent Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigAck(4) state = Ack-Sent Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:18 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigReq(18) state = Ack-Sent Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: MRU[4] 1500 Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0x57e051b2 Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: deflink: RecvConfigReq(5) state = Ack-Sent Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: deflink: SendConfigAck(5) state = Ack-Sent Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: ACCMAP[6] 0x00000000 Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 12 12:45:21 nemesis ppp[2181]: tun0: LCP: MAGICNUM[6] 0xc36eb7d9 Feb 12 12:45:24 nemesis ppp[2181]: tun0: LCP: deflink: LayerFinish Feb 12 12:45:24 nemesis ppp[2181]: tun0: LCP: deflink: State change Ack-Sent --> Stopped Feb 12 12:45:24 nemesis ppp[2181]: tun0: LCP: deflink: State change Stopped --> Closed Feb 12 12:45:24 nemesis ppp[2181]: tun0: LCP: deflink: State change Closed --> Initial Feb 12 12:45:24 nemesis ppp[2181]: tun0: Phase: deflink: Disconnected! Feb 12 12:45:24 nemesis ppp[2181]: tun0: Phase: deflink: lcp -> hangup Feb 12 12:45:24 nemesis ppp[2181]: tun0: Phase: deflink: Connect time: 19 secs: 237 octets in, 487 octets out Feb 12 12:45:24 nemesis ppp[2181]: tun0: Phase: total 38 bytes/sec, peak 67 bytes/sec on Fri Feb 12 12:45:24 1999 Feb 12 12:45:24 nemesis ppp[2181]: tun0: Phase: deflink: hangup -> closed Feb 12 12:45:24 nemesis ppp[2181]: tun0: Phase: bundle: Dead Here is my ppp.conf file. I'm using the xs4all-demand entry. default: set log Phase Chat LCP IPCP CCP tun command set device /dev/cuaa1 set speed 115200 disable lqr deny lqr set dial "ABORT BUSY ABORT NO\\sCARRIER ABORT NO\\sANSWER TIMEOUT 5 \"\" ATZ OK ATE1Q0 OK-AT-OK ATB50DI\\T TIMEOUT 30 CONNECT \\d" set redial 3 set filter alive 0 deny icmp set filter alive 1 deny udp src eq 53 set filter alive 2 deny udp dst eq 53 set filter alive 3 deny udp src eq 520 set filter alive 4 deny udp dst eq 520 set filter alive 5 deny udp src eq 123 set filter alive 6 deny udp dst eq 123 set filter alive 7 permit 0/0 0/0 set filter dial 0 deny icmp set filter dial 1 deny udp src eq 123 set filter dial 2 deny udp dst eq 123 set filter dial 3 deny udp src eq 137 set filter dial 4 deny udp dst eq 137 set filter dial 5 permit 0/0 0/0 set timeout 300 xs4all-demand: allow user xxxx set phone xxxxxxx accept pap set authname "xxxx" set authkey "xxxx" set ifaddr 194.109.57.80/0 194.109.6.1/0 add default HISADDR set openmode active alias enable yes set server /var/tmp/internet "" 0177 set timeout 300 Thanks, Ben To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-stable" in the body of the message