Date: Fri, 09 Apr 1999 12:52:46 +1000 From: GuRu <guru@b0rk.looksharp.net> To: freebsd-current@freebsd.org Subject: PPP problems in -CURRENT Message-ID: <3.0.3.32.19990409125246.00990d60@b0rk.looksharp.net>
next in thread | raw e-mail | index | archive | help
cvsupped, built CURRENT as of April 8th, upgrading a 3.1-STABLE system to 4.0. A reboot later, all seems fine, except that I'm experiencing severe problems connecting to my ISP. Everything goes well till after the login phase, when entering the lcp negotiation phase, then things get FUBARed. (passwords have been deliberately blanked, of course. :P) I believe that both peers are attempting to negotiate an IP address, but are failing to do so as shown by the repeated negotiation attempts. The same PPP configuration file worked as of 24 hours ago on 3.1-STABLE. Any insight would be greatly appreciated. Apr 8 21:15:56 Tasha ppp[294]: Phase: Using interface: tun0 Apr 8 21:15:56 Tasha ppp[294]: Phase: deflink: Created in closed state Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: default: set device /dev/cuaa1 Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: default: set speed 115200 Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: default: deny lqr Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: default: set dial ABORT BUSY ABORT NO\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK \dATDT\T TIMEOUT 40 CONNECT Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: default: alias enable yes Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: pmdemand: set phone xxxxxxx Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: pmdemand: set login ABORT NO\sCARRIER TIMEOUT 5 ogin:--ogin: login word: word Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: pmdemand: set server xxxx ******** Apr 8 21:15:56 Tasha ppp[294]: tun0: Phase: Listening at port 4040. Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: pmdemand: set timeout 0 Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: pmdemand: set ifaddr 10.0.0.1/0 10.0.0.2/0 0.0.0.0 0.0.0.0 Apr 8 21:15:56 Tasha ppp[294]: tun0: Command: pmdemand: add default HISADDR Apr 8 21:15:56 Tasha ppp[295]: tun0: Phase: PPP Started (background mode). Apr 8 21:15:56 Tasha ppp[295]: tun0: Phase: bundle: Establish Apr 8 21:15:56 Tasha ppp[295]: tun0: Phase: deflink: closed -> opening Apr 8 21:15:56 Tasha ppp[295]: tun0: Phase: deflink: Connected! Apr 8 21:15:56 Tasha ppp[295]: tun0: Phase: deflink: opening -> dial Apr 8 21:15:56 Tasha ppp[295]: tun0: Phase: Phone: xxxxxxx Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: deflink: Dial attempt 1 of 1 Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Send: AT^M Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Expect(5): OK Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Received: AT^M^M Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Received: OK^M Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Send: ATE1Q0^M Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Expect(5): OK Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Received: ATE1Q0^M^M Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Received: OK^M Apr 8 21:15:56 Tasha ppp[295]: tun0: Chat: Send: ATDTxxxxxxxx^M Apr 8 21:15:58 Tasha ppp[295]: tun0: Chat: Expect(40): CONNECT Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Received: ATDTxxxxxxxx^M^M Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Received: CONNECT 33600/ARQ/V34/LAPM/V42BIS^M Apr 8 21:16:13 Tasha ppp[295]: tun0: Phase: deflink: dial -> login Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Expect(5): ogin: Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Received: ^M Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Received: login: Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Send: login^M Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Expect(5): word: Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Received: Password: Apr 8 21:16:13 Tasha ppp[295]: tun0: Chat: Send: password^M Apr 8 21:16:13 Tasha ppp[295]: tun0: Phase: deflink: login -> lcp Apr 8 21:16:13 Tasha ppp[295]: tun0: LCP: FSM: Using "deflink" as a transport Apr 8 21:16:13 Tasha ppp[295]: tun0: LCP: deflink: State change Initial --> Closed Apr 8 21:16:13 Tasha ppp[295]: tun0: LCP: deflink: State change Closed --> Stopped Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: deflink: LayerStart Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x00000000 Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: MRU[4] 1500 Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x49e522ff Apr 8 21:16:14 Tasha ppp[295]: tun0: LCP: deflink: State change Stopped --> Req-Sent Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: deflink: RecvConfigReq(6) state = Req-Sent Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: deflink: SendConfigAck(6) state = Req-Sent Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: deflink: State change Req-Sent --> Ack-Sent Apr 8 21:16:17 Tasha ppp[295]: tun0: LCP: deflink: SendConfigReq(2) state = Ack-Sent Apr 8 21:16:17 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:17 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:17 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:17 Tasha ppp[295]: tun0: LCP: MRU[4] 1500 Apr 8 21:16:17 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x49e522ff Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: deflink: RecvConfigReq(7) state = Ack-Sent Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: deflink: SendConfigAck(7) state = Ack-Sent Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:19 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:20 Tasha ppp[295]: tun0: LCP: deflink: SendConfigReq(2) state = Ack-Sent Apr 8 21:16:20 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:20 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:20 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:20 Tasha ppp[295]: tun0: LCP: MRU[4] 1500 Apr 8 21:16:20 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x49e522ff Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: deflink: RecvConfigReq(8) state = Ack-Sent Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: deflink: SendConfigAck(8) state = Ack-Sent Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:21 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: deflink: RecvConfigReq(9) state = Ack-Sent Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: deflink: SendConfigAck(9) state = Ack-Sent Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: deflink: SendConfigReq(2) state = Ack-Sent Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: MRU[4] 1500 Apr 8 21:16:23 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x49e522ff Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: deflink: RecvConfigReq(10) state = Ack-Sent Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: deflink: SendConfigAck(10) state = Ack-Sent Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:25 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:26 Tasha ppp[295]: tun0: LCP: deflink: SendConfigReq(2) state = Ack-Sent Apr 8 21:16:26 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:26 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:26 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:26 Tasha ppp[295]: tun0: LCP: MRU[4] 1500 Apr 8 21:16:26 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x49e522ff Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: deflink: RecvConfigReq(11) state = Ack-Sent Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: deflink: SendConfigAck(11) state = Ack-Sent Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: ACCMAP[6] 0x000a0000 Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166 Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: PROTOCOMP[2] Apr 8 21:16:27 Tasha ppp[295]: tun0: LCP: ACFCOMP[2] Apr 8 21:16:29 Tasha ppp[295]: tun0: LCP: deflink: LayerFinish Apr 8 21:16:29 Tasha ppp[295]: tun0: LCP: deflink: State change Ack-Sent --> Stopped Apr 8 21:16:29 Tasha ppp[295]: tun0: LCP: deflink: State change Stopped --> Closed Apr 8 21:16:29 Tasha ppp[295]: tun0: LCP: deflink: State change Closed --> Initial Apr 8 21:16:29 Tasha ppp[295]: tun0: Phase: deflink: Disconnected! Apr 8 21:16:29 Tasha ppp[295]: tun0: Phase: deflink: lcp -> hangup Apr 8 21:16:29 Tasha ppp[295]: tun0: Phase: deflink: Connect time: 33 secs: 408 octets in, 539 octets out Apr 8 21:16:29 Tasha ppp[295]: tun0: Phase: total 28 bytes/sec, peak 76 bytes/sec on Thu Apr 8 21:16:29 1999 Apr 8 21:16:29 Tasha ppp[295]: tun0: Phase: deflink: hangup -> closed Apr 8 21:16:29 Tasha ppp[295]: tun0: Phase: bundle: Dead Apr 8 21:16:59 Tasha ppp[295]: tun0: Phase: PPP Terminated (normal). Apr 8 21:16:59 Tasha ppp[295]: tun0: Phase: Parent notified of success. Apr 8 21:16:59 Tasha ppp[294]: tun0: Phase: Parent: Child failed (errdead). -- K To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-current" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?3.0.3.32.19990409125246.00990d60>