Re: poptop on FreeBSD 9.x

Tim Gustafson <[email protected]> Wed, 18 Jul 2012 08:44:28 -0700
Newsgroups gmane.network.poptop
Message-ID <CAG27QgQUsGf_6j29Vy+j_6awC7QxMNZ7yqf5-53E5RxXgWw1qA@mail.gmail.com>
> You are combining Linux pppd and FreeBSD ppp configuration.  FreeBSD
> ppp is complaining that the option provided to it is unrecognised.
>
> Remove the options.pptpd file, and remove the option line from
> pptpd.conf file, and try again.

I did that, and made some other tweaks (based on
http://poripori.net/PPTPD_on_FreeBSD.html) and now I'm getting a
different set of log messages, and its still not connecting.

Here's my pptpd.conf:

debug
noipparam
connections 10
localip 10.10.48.220
remoteip 10.10.48.221-229

Here's my ppp.conf:

default:
 set timeout 0
 set log Phase Chat LCP IPCP CCP TUN Command Connect
 disable vjcomp deflate pred1

pptp:
 set device localhost:pptp
 set ifaddr 10.10.48.220 10.10.48.221-10.10.48.229 255.255.252.0
 set server /tmp/loop "" 0177
 enable chap
 enable MSChapV2
 enable MSChap
 disable pap
 enable proxy
 set dns 10.10.48.21 10.10.48.22 10.10.48.23
 allow mode direct

My ppp.secret file contains a single line: username password

Attached is the new set of syslog messages that I'm getting when I try
to connect.  I can't make heads or tails of the output.

Thanks for your help on this.  I really appreciate it.

-- 

Tim Gustafson
[email protected]
831-459-5354
Baskin Engineering, Room 313A

------------------------------------------------------------------------------
Live Security Virtual Conference
Exclusive live event will cover all the ways today's security and 
threat landscape has changed and how IT managers can respond. Discussions 
will include endpoint security, mobile security and the latest in malware 
threats. http://www.accelacomm.com/jaw/sfrnl04242012/114/50122263/

_______________________________________________
Poptop-server mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/poptop-server
syslog.txt (text/plain, 11.8 KB)
pptpd[1825]: MGR: Launching /usr/local/sbin/pptpctrl to handle client
pptpd[1825]: CTRL: local address = 10.10.48.220
pptpd[1825]: CTRL: remote address = 10.10.48.221
pptpd[1825]: CTRL: Client 10.10.63.210 control connection started
pptpd[1825]: CTRL: Received PPTP Control Message (type: 1)
pptpd[1825]: CTRL: Made a START CTRL CONN RPLY packet
pptpd[1825]: CTRL: I wrote 156 bytes to the client.
pptpd[1825]: CTRL: Sent packet to client
pptpd[1825]: CTRL: Received PPTP Control Message (type: 7)
pptpd[1825]: CTRL: Set parameters to 100000000 maxbps, 64 window size
pptpd[1825]: CTRL: Made a OUT CALL RPLY packet
pptpd[1825]: CTRL: Starting call (launching pppd, opening GRE)
pptpd[1825]: CTRL: pty_fd = 7
pptpd[1825]: CTRL: tty_fd = 6
pptpd[1825]: CTRL: I wrote 32 bytes to the client.
pptpd[1825]: CTRL: Sent packet to client
pptpd[1826]: CTRL (PPPD Launcher): program binary = /usr/sbin/ppp
pptpd[1825]: CTRL: Received PPTP Control Message (type: 15)
pptpd[1825]: CTRL: Got a SET LINK INFO packet with standard ACCMs
ppp[1826]: Phase: Using interface: tun0
kernel: tun0: link state changed to UP
ppp[1826]: Phase: deflink: Created in closed state
ppp[1826]: tun0: Command: default: disable vjcomp deflate pred1
ppp[1826]: tun0: Command: pptp: set device localhost:pptp
ppp[1826]: tun0: Command: pptp: set ifaddr 10.10.48.220 10.10.48.221-10.10.48.229 255.255.252.0
ppp[1826]: tun0: IPCP: Selected IP address 10.10.48.227
ppp[1826]: tun0: Command: pptp: set server /tmp/loop ******** 0177
ppp[1826]: tun0: Phase: Listening at local socket /tmp/loop.
ppp[1826]: tun0: Command: pptp: enable chap
ppp[1826]: tun0: Command: pptp: enable MSChapV2
ppp[1826]: tun0: Command: pptp: enable MSChap
ppp[1826]: tun0: Command: pptp: disable pap
ppp[1826]: tun0: Command: pptp: enable proxy
ppp[1826]: tun0: Command: pptp: set dns 10.10.48.21 10.10.48.22 10.10.48.23
ppp[1826]: tun0: Phase: PPP Started (direct mode).
ppp[1826]: tun0: Phase: bundle: Establish
ppp[1826]: tun0: Phase: deflink: closed -> opening
ppp[1826]: tun0: Phase: deflink: Connected!
ppp[1826]: tun0: Phase: deflink: opening -> carrier
ppp[1826]: tun0: Phase: deflink: carrier -> lcp
ppp[1826]: tun0: LCP: FSM: Using "deflink" as a transport
ppp[1826]: tun0: LCP: deflink: State change Initial --> Closed
ppp[1826]: tun0: LCP: deflink: State change Closed --> Stopped
ppp[1826]: tun0: LCP: deflink: LayerStart
ppp[1826]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: LCP: deflink: State change Stopped --> Req-Sent
pptpd[1825]: GRE: buffering packet #1 (expecting #0, lost or reordered)
pptpd[1825]: GRE: timeout waiting for 1 packets
pptpd[1825]: GRE: accepting #1 from queue
pptpd[1825]: GRE: accepting packet #2
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(1) state = Req-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(2) state = Req-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: LCP: deflink: RecvConfigReq(1) state = Req-Sent
ppp[1826]: tun0: LCP:  MRU[4] 1400
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x6aff193c
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  CALLBACK[3] CBCP
ppp[1826]: tun0: LCP: deflink: SendConfigRej(1) state = Req-Sent
ppp[1826]: tun0: LCP:  CALLBACK[3] CBCP
pptpd[1825]: GRE: accepting packet #3
pptpd[1825]: GRE: accepting packet #4
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(2) state = Req-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(3) state = Req-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: LCP: deflink: RecvConfigReq(2) state = Req-Sent
ppp[1826]: tun0: LCP:  MRU[4] 1400
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x6aff193c
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP: deflink: SendConfigAck(2) state = Req-Sent
ppp[1826]: tun0: LCP:  MRU[4] 1400
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x6aff193c
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP: deflink: State change Req-Sent --> Ack-Sent
pptpd[1825]: GRE: accepting packet #5
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(3) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(4) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #6
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(4) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(5) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #7
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(5) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(6) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #8
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(6) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(7) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #9
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(7) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(8) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #10
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(8) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(9) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #11
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(9) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(10) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #12
ppp[1826]: tun0: LCP: deflink: RecvConfigNak(10) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[4] 0xc227 (unknown)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(11) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #13
ppp[1826]: tun0: LCP: deflink: RecvConfigRej(11) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(12) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #14
ppp[1826]: tun0: LCP: deflink: RecvConfigRej(12) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(13) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #15
ppp[1826]: tun0: LCP: deflink: RecvConfigRej(13) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(14) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #16
ppp[1826]: tun0: LCP: deflink: RecvConfigRej(14) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: LCP: deflink: SendConfigReq(15) state = Ack-Sent
ppp[1826]: tun0: LCP:  ACFCOMP[2]
ppp[1826]: tun0: LCP:  PROTOCOMP[2]
ppp[1826]: tun0: LCP:  ACCMAP[6] 0x00000000
ppp[1826]: tun0: LCP:  MRU[4] 1500
ppp[1826]: tun0: LCP:  MAGICNUM[6] 0x1e7efbd1
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
pptpd[1825]: GRE: accepting packet #17
ppp[1826]: tun0: LCP: deflink: RecvConfigRej(15) state = Ack-Sent
ppp[1826]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
ppp[1826]: tun0: Phase: deflink: Too many LCP REQs sent - abandoning negotiation
ppp[1826]: tun0: LCP: deflink: SendTerminateReq(16) state = Ack-Sent
ppp[1826]: tun0: LCP: deflink: State change Ack-Sent --> Closing
pptpd[1825]: GRE: accepting packet #18
ppp[1826]: tun0: LCP: deflink: RecvTerminateAck(16) state = Closing
ppp[1826]: tun0: LCP: deflink: LayerFinish
ppp[1826]: tun0: LCP: deflink: State change Closing --> Closed
ppp[1826]: tun0: LCP: deflink: State change Closed --> Initial
ppp[1826]: tun0: Phase: deflink: Disconnected!
ppp[1826]: tun0: Phase: deflink: Connect time: 2 secs: 463 octets in, 1016 octets out
ppp[1826]: tun0: Phase: deflink: 16 packets in, 18 packets out
kernel: in_scrubprefix: err=65, prefix delete failed
ppp[1826]: tun0: Phase:  total 739 bytes/sec, peak 0 bytes/sec on Wed Jul 18 08:43:42 2012
ppp[1826]: tun0: Phase: deflink: lcp -> closed
pptpd[1825]: GRE: read(fd=7,buffer=610820,len=8196) from PTY failed: status = 0 error = No error
pptpd[1825]: CTRL: PTY read or GRE write failed (pty,gre)=(7,6)
pptpd[1825]: CTRL: Reaping child PPP[1826]
ppp[1826]: tun0: Phase: bundle: Dead
ppp[1826]: tun0: Phase: PPP Terminated (normal).
kernel: tun0: link state changed to DOWN
ppp[1826]: tun0: Error: Delete proxy arp entry 10.10.48.227: Invalid argument
pptpd[1825]: CTRL: Client 10.10.63.210 control connection finished
pptpd[1825]: CTRL: Exiting now
pptpd[1823]: MGR: Reaped child 1825
Jul 18 08:44:00 bsd-01 /usr/sbin/cron[1839]: (operator) CMD (/usr/libexec/save-entropy)