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 xxx
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
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: xxx
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: ATDT^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: ATDT^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] 0x
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] 0x000a
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] 0x000a
Apr 8 21:16:16 Tasha ppp[295]: tun0: LCP: MAGICNUM[6] 0x987dd166
Apr 8