From owner-freebsd-questions@FreeBSD.ORG Tue Aug 24 01:49:40 2004 Return-Path: Delivered-To: freebsd-questions@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id A356E16A4CF for ; Tue, 24 Aug 2004 01:49:40 +0000 (GMT) Received: from galilee.polands.org (CPE-24-208-53-189.new.rr.com [24.208.53.189]) by mx1.FreeBSD.org (Postfix) with ESMTP id 7AB2F43D1D for ; Tue, 24 Aug 2004 01:49:39 +0000 (GMT) (envelope-from doug@polands.org) Received: from email.polands.org (samaria.polands.org [172.16.1.17]) by galilee.polands.org (8.12.9/8.12.9) with SMTP id i7O1nbGk039123 for ; Mon, 23 Aug 2004 20:49:38 -0500 (CDT) (envelope-from doug@polands.org) Received: from 172.16.1.16 (proxying for 172.16.1.35) (SquirrelMail authenticated user djp) by email.polands.org with HTTP; Mon, 23 Aug 2004 20:49:38 -0500 (CDT) Message-ID: <1531.172.16.1.16.1093312178.squirrel@email.polands.org> Date: Mon, 23 Aug 2004 20:49:38 -0500 (CDT) From: "Doug Poland" To: questions@freebsd.org User-Agent: SquirrelMail/1.4.2 MIME-Version: 1.0 Content-Type: text/plain;charset=iso-8859-1 Content-Transfer-Encoding: 8bit X-Priority: 3 Importance: Normal Subject: Question for the PPP wizards X-BeenThere: freebsd-questions@freebsd.org X-Mailman-Version: 2.1.1 Precedence: list List-Id: User questions List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Tue, 24 Aug 2004 01:49:40 -0000 Hello, My FreeBSD 5.2.1-RELEASE laptop and I are going a trip in the near future to a location that has no broadband access. The only internet connectivity I'll have is dialup. The good news is my ISP is TimeWarner/RoadRunner and they have dial-in access. The bad news is the details for configuration are hidden in an executable GUI that works, of course, only on windows. I broke down and installed XP on a spare drive for the laptop, and installed the GUI dial-up tool. I successfully connected to my RoadRunner ISP and got a log of the session. Also, buried in the installation directory is a text file called login.scp that was very revealing. It appears that Time/Warner has allied with AOL to use their dial-in resources. So they're playing some tricks with a login script by prepending "aolnet/ent." to the username and appending ", raw" to the username and password. With my FBSD disk back in the laptop, I fire up userland PPP, get into the term, and dial the local access number. I enter: aolnet/ent.MYUSERNAME, raw MYPASSWORD, raw I get the 1st capital P in Ppp, but then the session hangs as it waits for: Aug 23 20:03:18 eden ppp[738]: tun0: Phase: Chap Input: CHALLENGE (16 bytes from rrlns1-mc1) Aug 23 20:03:18 eden ppp[738]: tun0: Phase: Chap Output: RESPONSE () I don't know what to enter at this point. If I use the stock ppp.conf and modify it to fit my needs, ppp sends my username but appears to truncate the username at the comma character in the username. It can't get past the Chap Input: CHALLENGE and Chap Output: RESPONSE () either. So here I am, very, very close to getting dial-up working but at an impasse. Has anyone successfully dialed into AOL or RoadRunner from FreeBSD? Can someone shed some light on my predicament? See the following logs/conf files in-line for your perusal. -- Regards, Doug login.scp from WinXP installation: ========================================== proc main string prefix = "aolnet/ent." string UID = prefix + $USERID waitfor "ANSNet" then DoANSLogin, "Login:" then DoPPPLogin, "sername:" then DoDirLogin, "% Username:" then DoPRLogin until 20 DoANSLogin: waitfor "login" until 5 if $SUCCESS then transmit prefix + $USERID, raw transmit "^M" goto DONE endif DoPPPLogin: transmit UID, raw transmit "^M" waitfor "Password" until 5 transmit $PASSWORD, raw transmit "^M" waitfor ">" until 5 transmit "ppp", raw transmit "^M" goto DONE DoDirLogin: transmit UID, raw transmit "^M" waitfor "Password" until 5 transmit $PASSWORD, raw transmit "^M" goto DONE DoPRLogin: waitfor "% Username:" until 20 if $SUCCESS then transmit UID, raw transmit "^M" waitfor "Password" until 5 transmit $PASSWORD, raw transmit "^M" goto DONE endif DONE: delay 2 endproc ========================================== BTW, my login prompt is "Username: " So I was following the DoPRLogin: block Here's a log from a WinXP dial-up session: (Note: On WinXP, I tested with the on-board 3Com PciWinmodem. On FreeBSD I'm using a PCCard <3Com 3CXM/3CCM556> ========================================== 08-21-2004 07:15:14.564 - File: C:\WINDOWS\System32\tapisrv.dll, Version 5.1.2600 08-21-2004 07:15:14.564 - File: C:\WINDOWS\System32\unimdm.tsp, Version 5.1.2600 08-21-2004 07:15:14.564 - File: C:\WINDOWS\System32\unimdmat.dll, Version 5.1.2600 08-21-2004 07:15:14.564 - File: C:\WINDOWS\System32\uniplat.dll, Version 5.1.2600 08-21-2004 07:15:14.594 - File: C:\WINDOWS\System32\drivers\modem.sys, Version 5.1.2600 08-21-2004 07:15:14.594 - File: C:\WINDOWS\System32\modemui.dll, Version 5.1.2600 08-21-2004 07:15:14.594 - File: C:\WINDOWS\System32\mdminst.dll, Version 5.1.2600 08-21-2004 07:15:14.594 - Modem type: 3Com Mini PCI 56K Modem 08-21-2004 07:15:14.594 - Modem inf path: oem4.inf 08-21-2004 07:15:14.594 - Modem inf section: PciWinmodem 08-21-2004 07:15:14.594 - Matching hardware ID: pci\ven_10b7&dev_1007&subsys_615b10b7 08-21-2004 07:15:14.644 - Opening Modem 08-21-2004 07:15:14.644 - 115200,8,N,1, ctsfl=1, rtsctl=2 08-21-2004 07:15:14.644 - Initializing modem. 08-21-2004 07:15:14.654 - Send: AT 08-21-2004 07:15:14.664 - Recv: OK 08-21-2004 07:15:14.664 - Interpreted response: OK 08-21-2004 07:15:14.674 - Send: AT&F1E0V1&D2&C1S0=0 08-21-2004 07:15:14.724 - TSP(0000): Making Call 08-21-2004 07:15:14.815 - Recv: OK 08-21-2004 07:15:14.815 - Interpreted response: OK 08-21-2004 07:15:14.825 - Send: ATS7=60S19=0L0M1&M4&K1&H1&R2&I0B0X4 08-21-2004 07:15:14.865 - Recv: OK 08-21-2004 07:15:14.865 - Interpreted response: OK 08-21-2004 07:15:14.865 - Waiting for a call. 08-21-2004 07:15:14.875 - Send: ATS0=0 08-21-2004 07:15:14.915 - Recv: OK 08-21-2004 07:15:14.915 - Interpreted response: OK 08-21-2004 07:15:14.915 - 115200,8,N,1, ctsfl=1, rtsctl=2 08-21-2004 07:15:14.915 - Initializing modem. 08-21-2004 07:15:14.925 - Send: AT 08-21-2004 07:15:14.965 - Recv: OK 08-21-2004 07:15:14.965 - Interpreted response: OK 08-21-2004 07:15:14.975 - Send: AT&F1E0V1&D2&C1S0=0 08-21-2004 07:15:15.115 - Recv: OK 08-21-2004 07:15:15.115 - Interpreted response: OK 08-21-2004 07:15:15.125 - Send: ATS7=60S19=0L0M1&M4&K1&H1&R2&I0B0X4 08-21-2004 07:15:15.165 - Recv: OK 08-21-2004 07:15:15.165 - Interpreted response: OK 08-21-2004 07:15:15.165 - Dialing. 08-21-2004 07:15:15.165 - TSP Completing Async Operation(0x00010190) Status 0x00000000 08-21-2004 07:15:15.165 - TSP(0000): LINEEVENT: LINECALLSTATE_DIALING 08-21-2004 07:15:15.165 - TSP(0000): LINEEVENT: LINECALLSTATE_PROCEEDING 08-21-2004 07:15:15.175 - Send: ATDT###-#### 08-21-2004 07:15:46.740 - Recv: CONNECT 28800/ARQ/V34/LAPM/V42BIS 08-21-2004 07:15:46.740 - Interpreted response: Connect 08-21-2004 07:15:46.740 - Connection established at 28800bps. 08-21-2004 07:15:46.740 - Error-control on. 08-21-2004 07:15:46.740 - Data compression on. 08-21-2004 07:15:46.740 - TSP(0000): LINEEVENT: LINECALLSTATE_CONNECTED 08-21-2004 07:16:16.744 - Read: Total: 0, Per/Sec: 0, Written: Total: 0, Per/Sec: 0 08-21-2004 07:18:16.746 - Read: Total: 0, Per/Sec: 0, Written: Total: 0, Per/Sec: 0 08-21-2004 07:20:16.749 - Read: Total: 0, Per/Sec: 0, Written: Total: 0, Per/Sec: 0 08-21-2004 07:22:16.751 - Read: Total: 0, Per/Sec: 0, Written: Total: 0, Per/Sec: 0 08-21-2004 07:23:31.929 - TSP(0000): Dropping Call 08-21-2004 07:23:31.929 - Hanging up the modem. 08-21-2004 07:23:31.929 - Hardware hangup by lowering DTR. 08-21-2004 07:23:33.041 - Detected CD dropped from lowering DTR 08-21-2004 07:23:33.041 - Recv: NO CARRIER 08-21-2004 07:23:33.041 - Interpreted response: No Carrier 08-21-2004 07:23:33.051 - Send: ATH 08-21-2004 07:23:33.091 - Recv: OK 08-21-2004 07:23:33.091 - Interpreted response: OK 08-21-2004 07:23:33.091 - 115200,8,N,1, ctsfl=1, rtsctl=2 08-21-2004 07:23:33.091 - Initializing modem. 08-21-2004 07:23:33.101 - Send: AT 08-21-2004 07:23:33.141 - Recv: OK 08-21-2004 07:23:33.141 - Interpreted response: OK 08-21-2004 07:23:33.151 - Send: AT&F1E0V1&D2&C1S0=0 08-21-2004 07:23:33.291 - Recv: OK 08-21-2004 07:23:33.291 - Interpreted response: OK 08-21-2004 07:23:33.301 - Send: ATS7=60S19=0L0M1&M4&K1&H1&R2&I0B0X4 08-21-2004 07:23:33.341 - Recv: OK 08-21-2004 07:23:33.341 - Interpreted response: OK 08-21-2004 07:23:33.341 - Waiting for a call. 08-21-2004 07:23:33.351 - Send: ATS0=0 08-21-2004 07:23:33.391 - Recv: OK 08-21-2004 07:23:33.391 - Interpreted response: OK 08-21-2004 07:23:33.391 - TSP(0000): LINEEVENT: LINECALLSTATE_DISCONNECTED(0x1) 08-21-2004 07:23:33.391 - TSP(0000): LINEEVENT: LINECALLSTATE_IDLE 08-21-2004 07:23:33.391 - TSP Completing Async Operation(0x000102a2) Status 0x00000000 08-21-2004 07:23:33.391 - TSP(0000): Dropping Call 08-21-2004 07:23:33.391 - TSP Completing Async Operation(0x00010291) Status 0x00000000 08-21-2004 07:23:33.391 - TSP(0000): Closing Call 08-21-2004 07:23:33.391 - Session Statistics: 08-21-2004 07:23:33.391 - Reads : 0 bytes 08-21-2004 07:23:33.391 - Writes: 0 bytes ========================================== /etc/ppp/ppp.conf: ========================================== default: set log Phase Chat LCP IPCP CCP tun command ident user-ppp VERSION (built COMPILATIONDATE) set device /dev/cuaa4 set speed 115200 set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \ \"\" AT OK-AT-OK ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT" roadrunner: set phone 2570038 set authname aolnet/ent.MYUSERNAME, raw set authkey MYPASSWORD, raw set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0 ========================================== /var/log/ppp.log: ========================================== Aug 23 20:27:44 eden ppp[819]: Phase: Using interface: tun0 Aug 23 20:27:44 eden ppp[819]: Phase: deflink: Created in closed state Aug 23 20:27:44 eden ppp[819]: tun0: Command: default: ident user-ppp VERSION (built COMPILATIONDATE) Aug 23 20:27:44 eden ppp[819]: tun0: Command: default: set device /dev/cuaa4 Aug 23 20:27:44 eden ppp[819]: tun0: Command: default: set speed 115200 Aug 23 20:27:44 eden ppp[819]: tun0: Command: default: set dial ABORT BUSY ABORT NO\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK \dATDT\T TIMEOUT 40 CONNECT Aug 23 20:27:44 eden ppp[819]: tun0: Command: default: set timeout 180 Aug 23 20:27:44 eden ppp[819]: tun0: Command: default: enable dns Aug 23 20:27:44 eden ppp[819]: tun0: Phase: PPP Started (interactive mode). Aug 23 20:27:49 eden ppp[819]: tun0: Command: /dev/ttyp7: load roadrunner Aug 23 20:27:49 eden ppp[819]: tun0: Command: roadrunner: set phone 2570038 Aug 23 20:27:49 eden ppp[819]: tun0: Command: roadrunner: set authname aolnet/ent.MYUSERNAME, raw Aug 23 20:27:49 eden ppp[819]: tun0: Command: roadrunner: set authkey ******** raw Aug 23 20:27:49 eden ppp[819]: tun0: Command: roadrunner: set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0 Aug 23 20:27:49 eden ppp[819]: tun0: Command: roadrunner: add default HISADDR Aug 23 20:27:53 eden ppp[819]: tun0: Command: /dev/ttyp7: dial Aug 23 20:27:53 eden ppp[819]: tun0: Phase: bundle: Establish Aug 23 20:27:53 eden ppp[819]: tun0: Phase: deflink: closed -> opening Aug 23 20:27:53 eden ppp[819]: tun0: Phase: deflink: Connected! Aug 23 20:27:53 eden ppp[819]: tun0: Phase: deflink: opening -> dial Aug 23 20:27:53 eden ppp[819]: tun0: Chat: Phone: 2570038 Aug 23 20:27:53 eden ppp[819]: tun0: Chat: deflink: Dial attempt 1 of 1 Aug 23 20:27:53 eden ppp[819]: tun0: Chat: Send: AT^M Aug 23 20:27:53 eden ppp[819]: tun0: Chat: Expect(5): OK Aug 23 20:27:53 eden ppp[819]: tun0: Chat: Received: AT^M^M Aug 23 20:27:53 eden ppp[819]: tun0: Chat: Received: OK^M Aug 23 20:27:53 eden ppp[819]: tun0: Chat: Send: ATE1Q0^M Aug 23 20:27:53 eden ppp[819]: tun0: Chat: Expect(5): OK Aug 23 20:27:54 eden ppp[819]: tun0: Chat: Received: ATE1Q0^M^M Aug 23 20:27:54 eden ppp[819]: tun0: Chat: Received: OK^M Aug 23 20:27:54 eden ppp[819]: tun0: Chat: Send: ATDT2570038^M Aug 23 20:27:56 eden ppp[819]: tun0: Chat: Expect(40): CONNECT Aug 23 20:28:11 eden ppp[819]: tun0: Chat: Received: ATDT2570038^M^M Aug 23 20:28:11 eden ppp[819]: tun0: Chat: Received: CONNECT Aug 23 20:28:11 eden ppp[819]: tun0: Phase: deflink: dial -> carrier Aug 23 20:28:12 eden ppp[819]: tun0: Phase: deflink: /dev/cuaa4: CD detected Aug 23 20:28:12 eden ppp[819]: tun0: Phase: deflink: carrier -> login Aug 23 20:28:12 eden ppp[819]: tun0: Phase: deflink: login -> lcp Aug 23 20:28:12 eden ppp[819]: tun0: LCP: FSM: Using "deflink" as a transport Aug 23 20:28:12 eden ppp[819]: tun0: LCP: deflink: State change Initial --> Closed Aug 23 20:28:12 eden ppp[819]: tun0: LCP: deflink: State change Closed --> Stopped Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: LayerStart Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x00000000 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MRU[4] 1500 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0x5aaf3e54 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: State change Stopped --> Req-Sent Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: RecvConfigReq(1) state = Req-Sent Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MRU[4] 1500 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x000a0000 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05) Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0x8f0fa175 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MRRU[4] 1506 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: SendConfigRej(1) state = Req-Sent Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MRRU[4] 1506 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: SendIdent(0) state = Req-Sent Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MAGICNUM 5aaf3e54 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: TEXT user-ppp 3.1 (built Feb 23 2004) Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: RecvConfigAck(1) state = Req-Sent Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x00000000 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MRU[4] 1500 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0x5aaf3e54 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: State change Req-Sent --> Ack-Rcvd Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: RecvConfigReq(2) state = Ack-Rcvd Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MRU[4] 1500 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x000a0000 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05) Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0x8f0fa175 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: SendConfigAck(2) state = Ack-Rcvd Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MRU[4] 1500 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x000a0000 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05) Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0x8f0fa175 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: State change Ack-Rcvd --> Opened Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: LayerUp Aug 23 20:28:13 eden ppp[819]: tun0: LCP: deflink: SendIdent(1) state = Opened Aug 23 20:28:13 eden ppp[819]: tun0: LCP: MAGICNUM 5aaf3e54 Aug 23 20:28:13 eden ppp[819]: tun0: LCP: TEXT user-ppp 3.1 (built Feb 23 2004) Aug 23 20:28:13 eden ppp[819]: tun0: Phase: bundle: Authenticate Aug 23 20:28:13 eden ppp[819]: tun0: Phase: deflink: his = CHAP 0x05, mine = none Aug 23 20:28:14 eden ppp[819]: tun0: Phase: Chap Input: CHALLENGE (16 bytes from qwest) Aug 23 20:28:14 eden ppp[819]: tun0: Phase: Chap Output: RESPONSE (aolnet/ent.MYUSERNAME,) Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: RecvConfigReq(1) state = Opened Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: LayerDown Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x000a0000 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05) Aug 23 20:28:14 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0x806e7cf4 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: SendConfigReq(2) state = Opened Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x00000000 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: MRU[4] 1500 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0xabeda0f1 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: SendConfigAck(1) state = Opened Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x000a0000 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05) Aug 23 20:28:14 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0x806e7cf4 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: State change Opened --> Ack-Sent Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: RecvConfigAck(2) state = Ack-Sent Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACFCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: PROTOCOMP[2] Aug 23 20:28:14 eden ppp[819]: tun0: LCP: ACCMAP[6] 0x00000000 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: MRU[4] 1500 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: MAGICNUM[6] 0xabeda0f1 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: State change Ack-Sent --> Opened Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: LayerUp Aug 23 20:28:14 eden ppp[819]: tun0: LCP: deflink: SendIdent(2) state = Opened Aug 23 20:28:14 eden ppp[819]: tun0: LCP: MAGICNUM abeda0f1 Aug 23 20:28:14 eden ppp[819]: tun0: LCP: TEXT user-ppp 3.1 (built Feb 23 2004) Aug 23 20:28:14 eden ppp[819]: tun0: Phase: deflink: his = CHAP 0x05, mine = none Aug 23 20:28:14 eden ppp[819]: tun0: Phase: Chap Input: CHALLENGE (16 bytes from rrlns1-mc1) Aug 23 20:28:14 eden ppp[819]: tun0: Phase: Chap Output: RESPONSE (aolnet/ent.MYUSERNAME,) Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: Carrier lost Aug 23 20:28:35 eden ppp[819]: tun0: LCP: deflink: LayerDown Aug 23 20:28:35 eden ppp[819]: tun0: LCP: deflink: State change Opened --> Starting Aug 23 20:28:35 eden ppp[819]: tun0: LCP: deflink: LayerFinish Aug 23 20:28:35 eden ppp[819]: tun0: LCP: deflink: State change Starting --> Initial Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: Disconnected! Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: lcp -> logout Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: Disconnected! Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: logout -> hangup Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: Connect time: 42 secs: 393 octets in, 514 octets out Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: 11 packets in, 10 packets out Aug 23 20:28:35 eden ppp[819]: tun0: Phase: total 21 bytes/sec, peak 177 bytes/sec on Mon Aug 23 20:28:15 2004 Aug 23 20:28:35 eden ppp[819]: tun0: Phase: deflink: hangup -> closed Aug 23 20:28:35 eden ppp[819]: tun0: Phase: bundle: Dead Aug 23 20:28:44 eden ppp[819]: tun0: Phase: /dev/ttyp7: Client connection closed. Aug 23 20:28:44 eden ppp[819]: tun0: Phase: PPP Terminated (normal). ========================================== It's interesting to note that the authname and authkey think the comma "," character is part of the authentication string. Probably not a good thing.