Date: Mon, 18 Sep 2000 22:16:07 -0400 (EDT) From: Peter Berger <peterb@telerama.com> To: freebsd-questions@freebsd.org Subject: PPP and Windows NT RAS? Message-ID: <Pine.BSF.4.21.0009182209380.1990-100000@raven.peterb.telerama.com>
next in thread | raw e-mail | index | archive | help
I am experiencing the exact same symptoms that David May described in his mail of June 2. I didn't see any followups to his mail. I turned on some extra logging. It looks to me like authentication is succeeding but some later phase of the LCP negotiation is failing (perhaps encryption? MPEE? I dunno. The windows server just reports that ppp negotiation "failed to converge") Anyone want to try to clue me in as to what is happening here? I am enclosing relevent logs below. I respectfully request that people cc any answers to me; or just send them to me and I will summarize to the list. This was David's original mail: >I am experiencing difficulties dialing-in to a >Windows NT RAS server with FreeBSD User PPP. > >I have read the stuff about Microsoft PPP quirks >in PPP(1) and have experimented with the mschap, >lanman options - to no avail. > >This is what I see in my log: > >Jun 1 15:33:55 freebsd ppp[21013]: tun1: Phase: bundle: Authenticate >Jun 1 15:33:55 freebsd ppp[21013]: tun1: Phase: deflink: his = CHAP 0x80, >mine = none >Jun 1 15:33:55 freebsd ppp[21013]: tun1: Phase: Chap Input: CHALLENGE (8 >bytes) >Jun 1 15:33:55 freebsd ppp[21013]: tun1: Phase: Chap Output: RESPONSE >(guest) >Jun 1 15:33:58 freebsd ppp[21013]: tun1: Phase: Chap Input: FAILURE >(E=691 > R=1) >Jun 1 15:33:58 freebsd ppp[21013]: tun1: LCP: deflink: LayerDown > >I have configured many PPP connections before to non-NT >servers and they always worked pretty well but this is >the first connection to a NT RAS server I have attempted. > >I am hoping someone reading this list might recognise >the problem and suggest a solution. Here are the relevant logs: Sep 18 10:03:12 raven ppp[1432]: Phase: Using interface: tun0 Sep 18 10:03:12 raven ppp[1432]: Phase: deflink: Created in closed state Sep 18 10:03:12 raven ppp[1432]: Warning: set delay: Invalid command Sep 18 10:03:12 raven ppp[1432]: Warning: set delay: Failed 1 Sep 18 10:03:12 raven ppp[1432]: Phase: PPP Started (direct mode). Sep 18 10:03:12 raven ppp[1432]: Phase: bundle: Establish Sep 18 10:03:12 raven ppp[1432]: Phase: deflink: closed -> opening Sep 18 10:03:12 raven ppp[1432]: Phase: deflink: Connected! Sep 18 10:03:12 raven ppp[1432]: Phase: deflink: opening -> carrier Sep 18 10:03:13 raven ppp[1432]: Phase: deflink: carrier -> lcp Sep 18 10:03:13 raven ppp[1432]: LCP: FSM: Using "deflink" as a transport Sep 18 10:03:13 raven ppp[1432]: LCP: deflink: State change Initial --> Closed Sep 18 10:03:13 raven ppp[1432]: LCP: deflink: State change Closed --> Stopped Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: LayerStart Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: SendConfigReq(1) state = Stopped Sep 18 10:03:14 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:14 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x9491fbdd Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: State change Stopped --> Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: RecvConfigReq(0) state = Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x81) Sep 18 10:03:14 raven ppp[1432]: Warning: CHAP 0x81 not supported Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x000033cb Sep 18 10:03:14 raven ppp[1432]: LCP: PROTOCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: ACFCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: SendConfigNak(0) state = Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: RecvConfigAck(1) state = Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: State change Req-Sent --> Ack-Rcvd Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: RecvConfigReq(1) state = Ack-Rcvd Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x000033cb Sep 18 10:03:14 raven ppp[1432]: LCP: PROTOCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: ACFCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: SendConfigAck(1) state = Ack-Rcvd Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x000033cb Sep 18 10:03:14 raven ppp[1432]: LCP: PROTOCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: ACFCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: State change Ack-Rcvd --> Opened Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: LayerUp Sep 18 10:03:14 raven ppp[1432]: Phase: bundle: Authenticate Sep 18 10:03:14 raven ppp[1432]: Phase: deflink: his = CHAP 0x80, mine = CHAP 0x80 Sep 18 10:03:14 raven ppp[1432]: Phase: Chap Output: CHALLENGE Sep 18 10:03:14 raven ppp[1432]: Phase: Chap Input: CHALLENGE (8 bytes from FISSILE) Sep 18 10:03:14 raven ppp[1432]: Phase: Chap Output: RESPONSE (peterb) Sep 18 10:03:14 raven ppp[1432]: Phase: Chap Input: SUCCESS Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: RecvConfigReq(3) state = Opened Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: LayerDown Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x81) Sep 18 10:03:14 raven ppp[1432]: Warning: CHAP 0x81 not supported Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x0000394b Sep 18 10:03:14 raven ppp[1432]: LCP: PROTOCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: ACFCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: SendConfigReq(2) state = Opened Sep 18 10:03:14 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:14 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: SendConfigNak(3) state = Opened Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: State change Opened --> Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: RecvConfigRej(2) state = Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: SendConfigReq(3) state = Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:14 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: RecvConfigReq(4) state = Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x0000394b Sep 18 10:03:14 raven ppp[1432]: LCP: PROTOCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: ACFCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: SendConfigAck(4) state = Req-Sent Sep 18 10:03:14 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:14 raven ppp[1432]: LCP: MAGICNUM[6] 0x0000394b Sep 18 10:03:14 raven ppp[1432]: LCP: PROTOCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: ACFCOMP[2] Sep 18 10:03:14 raven ppp[1432]: LCP: deflink: State change Req-Sent --> Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: RecvConfigRej(3) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: SendConfigReq(4) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:15 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:15 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: RecvConfigRej(4) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: SendConfigReq(5) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:15 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:15 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: RecvConfigRej(5) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: SendConfigReq(6) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:15 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:15 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: RecvConfigRej(6) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: SendConfigReq(7) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:15 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:15 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:15 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: RecvTerminateReq(5) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: SendTerminateAck(5) state = Ack-Sent Sep 18 10:03:15 raven ppp[1432]: LCP: deflink: State change Ack-Sent --> Req-Sent Sep 18 10:03:18 raven ppp[1432]: LCP: deflink: SendConfigReq(7) state = Req-Sent Sep 18 10:03:18 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:18 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:18 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:18 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:18 raven ppp[1432]: HDLC: hdlc_Output Sep 18 10:03:21 raven ppp[1432]: LCP: deflink: SendConfigReq(7) state = Req-Sent Sep 18 10:03:21 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:21 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:21 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:21 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:24 raven ppp[1432]: LCP: deflink: SendConfigReq(7) state = Req-Sent Sep 18 10:03:24 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:24 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:24 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:24 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:27 raven ppp[1432]: LCP: deflink: SendConfigReq(7) state = Req-Sent Sep 18 10:03:27 raven ppp[1432]: LCP: ACCMAP[6] 0x00000000 Sep 18 10:03:27 raven ppp[1432]: LCP: MRU[4] 1500 Sep 18 10:03:27 raven ppp[1432]: LCP: MAGICNUM[6] 0x0c317aea Sep 18 10:03:27 raven ppp[1432]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x80) Sep 18 10:03:30 raven ppp[1432]: LCP: deflink: LayerFinish Sep 18 10:03:30 raven ppp[1432]: LCP: deflink: State change Req-Sent --> Stopped Sep 18 10:03:30 raven ppp[1432]: LCP: deflink: State change Stopped --> Closed Sep 18 10:03:30 raven ppp[1432]: LCP: deflink: State change Closed --> Initial Sep 18 10:03:30 raven ppp[1432]: Phase: deflink: Disconnected! Sep 18 10:03:30 raven ppp[1432]: Phase: deflink: Connect time: 18 secs: 424 octets in, 854 octets out Sep 18 10:03:30 raven ppp[1432]: Phase: deflink: : 13 packets in, 18 packets out Sep 18 10:03:30 raven ppp[1432]: Phase: total 71 bytes/sec, peak 223 bytes/sec on Mon Sep 18 10:03:30 2000 Sep 18 10:03:30 raven ppp[1432]: Phase: deflink: lcp -> closed Sep 18 10:03:30 raven ppp[1432]: Phase: bundle: Dead Sep 18 10:03:30 raven ppp[1432]: Phase: PPP Terminated (normal). To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-questions" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?Pine.BSF.4.21.0009182209380.1990-100000>