Date: Sat, 25 Oct 2008 21:43:12 +0300 From: CK <ck@yourserveradmin.com> To: freebsd-net@freebsd.org Cc: mav@freebsd.org Subject: mpd - lcp protocol rejects Message-ID: <490368C0.1010704@yourserveradmin.com>
next in thread | raw e-mail | index | archive | help
Hello Everyone,
I'm running mpd 4.4 on 6.3-STABLE #4. Connecting with mpd to my ISP's
VPN server running poptop. Everything is ok for some time, and then all
of a sudden mpd starts throwing weird protocol rejects to log file and
vpn connection stops working.
mpd.conf:
pptp:
new -i ng0 pptp pptp
set iface disable on-demand
set iface disable proxy-arp
set iface enable tcpmssfix
set iface up-script /usr/local/etc/mpd4/if_up.sh
set iface down-script /usr/local/etc/mpd4/if_down.sh
set iface idle 0
set bundle disable multilink
set bundle yes compression
set bundle disable noretry
set bundle enable crypt-reqd
set auth authname "login_here"
set link accept acfcomp protocomp
set link accept chap
set link keep-alive 10 60
set link max-redial 0
set link accmap 0x00000000
set ipcp yes vjcomp
set ccp yes mppc
set ccp yes mpp-compress
set ccp no mpp-e40
set ccp yes mpp-e128
set ccp yes mpp-stateless
open
mpd.links:
pptp:
set phys type pptp
set pptp peer [ISP's vpn serv here]
set pptp enable originate
set pptp disable incoming
set pptp enable windowing
And lots of logs:
Oct 19 03:06:10 tazek mpd: [pptp] PPTP call successful
Oct 19 03:06:10 tazek mpd: [pptp] link: UP event
Oct 19 03:06:10 tazek mpd: [pptp] link: origination is local
Oct 19 03:06:10 tazek mpd: [pptp] LCP: Up event
Oct 19 03:06:10 tazek mpd: [pptp] LCP: state change Starting --> Req-Sent
Oct 19 03:06:10 tazek mpd: [pptp] LCP: SendConfigReq #1
Oct 19 03:06:10 tazek mpd: ACFCOMP
Oct 19 03:06:10 tazek mpd: PROTOCOMP
Oct 19 03:06:10 tazek mpd: ACCMAP 0x000a0000
Oct 19 03:06:10 tazek mpd: MRU 1460
Oct 19 03:06:10 tazek mpd: MAGICNUM bc85bd60
Oct 19 03:06:10 tazek mpd: [pptp] LCP: rec'd Configure Request #1 (Req-Sent)
Oct 19 03:06:10 tazek mpd: ACCMAP 0x00000000
Oct 19 03:06:10 tazek mpd: AUTHPROTO CHAP MSOFTv2
Oct 19 03:06:10 tazek mpd: MAGICNUM 0b145760
Oct 19 03:06:10 tazek mpd: PROTOCOMP
Oct 19 03:06:10 tazek mpd: ACFCOMP
Oct 19 03:06:10 tazek mpd: [pptp] LCP: SendConfigAck #1
Oct 19 03:06:10 tazek mpd: ACCMAP 0x00000000
Oct 19 03:06:10 tazek mpd: AUTHPROTO CHAP MSOFTv2
Oct 19 03:06:10 tazek mpd: MAGICNUM 0b145760
Oct 19 03:06:10 tazek mpd: PROTOCOMP
Oct 19 03:06:10 tazek mpd: ACFCOMP
Oct 19 03:06:10 tazek mpd: [pptp] LCP: state change Req-Sent --> Ack-Sent
Oct 19 03:06:12 tazek mpd: [pptp] LCP: SendConfigReq #2
Oct 19 03:06:12 tazek mpd: ACFCOMP
Oct 19 03:06:12 tazek mpd: PROTOCOMP
Oct 19 03:06:12 tazek mpd: ACCMAP 0x000a0000
Oct 19 03:06:12 tazek mpd: MRU 1460
Oct 19 03:06:12 tazek mpd: MAGICNUM bc85bd60
Oct 19 03:06:12 tazek mpd: [pptp] LCP: rec'd Configure Ack #2 (Ack-Sent)
Oct 19 03:06:12 tazek mpd: ACFCOMP
Oct 19 03:06:12 tazek mpd: PROTOCOMP
Oct 19 03:06:12 tazek mpd: ACCMAP 0x000a0000
Oct 19 03:06:12 tazek mpd: MRU 1460
Oct 19 03:06:12 tazek mpd: MAGICNUM bc85bd60
Oct 19 03:06:12 tazek mpd: [pptp] LCP: state change Ack-Sent --> Opened
Oct 19 03:06:12 tazek mpd: [pptp] LCP: auth: peer wants CHAP, I want nothing
Oct 19 03:06:12 tazek mpd: [pptp] LCP: LayerUp
Oct 19 03:06:12 tazek mpd: [pptp] CHAP: rec'd CHALLENGE #19
Oct 19 03:06:12 tazek mpd: Name: "pptpd"
Oct 19 03:06:12 tazek mpd: Using authname "login_here"
Oct 19 03:06:12 tazek mpd: [pptp] CHAP: sending RESPONSE len:63
Oct 19 03:06:12 tazek mpd: [pptp] CHAP: rec'd SUCCESS #19
Oct 19 03:06:12 tazek mpd: MESG: S=376C81163CF8923DF663DC2D672D8802BBDAAD3B
Oct 19 03:06:12 tazek mpd: [pptp] LCP: authorization successful
Oct 19 03:06:12 tazek mpd: [pptp] Bundle up: 1 link, total bandwidth
64000 bps
Oct 19 03:06:12 tazek mpd: [pptp] IPCP: Open event
Oct 19 03:06:12 tazek mpd: [pptp] IPCP: state change Initial --> Starting
Oct 19 03:06:12 tazek mpd: [pptp] IPCP: LayerStart
Oct 19 03:06:12 tazek mpd: [pptp] CCP: Open event
Oct 19 03:06:12 tazek mpd: [pptp] CCP: state change Initial --> Starting
Oct 19 03:06:12 tazek mpd: [pptp] CCP: LayerStart
Oct 19 03:06:12 tazek mpd: [pptp] IPCP: Up event
Oct 19 03:06:12 tazek mpd: [pptp] IPCP: state change Starting --> Req-Sent
Oct 19 03:06:12 tazek mpd: [pptp] IPCP: SendConfigReq #1
Oct 19 03:06:12 tazek mpd: IPADDR 192.168.1.2
Oct 19 03:06:12 tazek mpd: COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Oct 19 03:06:12 tazek mpd: [pptp] CCP: Up event
Oct 19 03:06:12 tazek mpd: [pptp] CCP: state change Starting --> Req-Sent
Oct 19 03:06:12 tazek mpd: [pptp] CCP: SendConfigReq #1
Oct 19 03:06:12 tazek mpd: MPPC
Oct 19 03:06:12 tazek mpd: 0x01000041:MPPC, MPPE(128 bits), stateless
Oct 19 03:06:12 tazek mpd: [pptp] IPCP: rec'd Terminate Ack #1 (Req-Sent)
Oct 19 03:06:12 tazek mpd: [pptp] CCP: rec'd Configure Nak #1 (Req-Sent)
Oct 19 03:06:12 tazek mpd: MPPC
Oct 19 03:06:12 tazek mpd: 0x01000040:MPPE(128 bits), stateless
Oct 19 03:06:12 tazek mpd: [pptp] CCP: SendConfigReq #2
Oct 19 03:06:12 tazek mpd: MPPC
Oct 19 03:06:12 tazek mpd: 0x01000040:MPPE(128 bits), stateless
Oct 19 03:06:12 tazek mpd: [pptp] CCP: rec'd Configure Ack #2 (Req-Sent)
Oct 19 03:06:12 tazek mpd: MPPC
Oct 19 03:06:12 tazek mpd: 0x01000040:MPPE(128 bits), stateless
Oct 19 03:06:12 tazek mpd: [pptp] CCP: state change Req-Sent --> Ack-Rcvd
Oct 19 03:06:14 tazek mpd: [pptp] IPCP: SendConfigReq #2
Oct 19 03:06:14 tazek mpd: IPADDR 192.168.1.2
Oct 19 03:06:14 tazek mpd: COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Oct 19 03:06:14 tazek mpd: [pptp] IPCP: rec'd Terminate Ack #2 (Req-Sent)
Oct 19 03:06:14 tazek mpd: [pptp] CCP: state change Ack-Rcvd --> Req-Sent
Oct 19 03:06:14 tazek mpd: [pptp] CCP: SendConfigReq #3
Oct 19 03:06:14 tazek mpd: MPPC
Oct 19 03:06:14 tazek mpd: 0x01000040:MPPE(128 bits), stateless
Oct 19 03:06:14 tazek mpd: [pptp] CCP: rec'd Configure Ack #3 (Req-Sent)
Oct 19 03:06:14 tazek mpd: MPPC
Oct 19 03:06:14 tazek mpd: 0x01000040:MPPE(128 bits), stateless
Oct 19 03:06:14 tazek mpd: [pptp] CCP: state change Req-Sent --> Ack-Rcvd
Oct 19 03:06:15 tazek mpd: [pptp] CCP: rec'd Configure Request #1 (Ack-Rcvd)
Oct 19 03:06:15 tazek mpd: MPPC
Oct 19 03:06:15 tazek mpd: 0x01000040:MPPE(128 bits), stateless
Oct 19 03:06:15 tazek mpd: [pptp] CCP: SendConfigAck #1
Oct 19 03:06:15 tazek mpd: MPPC
Oct 19 03:06:15 tazek mpd: 0x01000040:MPPE(128 bits), stateless
Oct 19 03:06:15 tazek mpd: [pptp] CCP: state change Ack-Rcvd --> Opened
Oct 19 03:06:15 tazek mpd: [pptp] CCP: LayerUp
Oct 19 03:06:15 tazek mpd: Compress using: mppc (MPPE(128 bits),
stateless)
Oct 19 03:06:15 tazek mpd: Decompress using: mppc (MPPE(128 bits),
stateless)
Oct 19 03:06:15 tazek mpd: [pptp] IPCP: rec'd Configure Request #1
(Req-Sent)
Oct 19 03:06:15 tazek mpd: COMPPROTO VJCOMP, 16 comp. channels, allow
comp-cid
Oct 19 03:06:15 tazek mpd: IPADDR 172.16.30.42
Oct 19 03:06:15 tazek mpd: 172.16.30.42 is OK
Oct 19 03:06:15 tazek mpd: [pptp] IPCP: SendConfigAck #1
Oct 19 03:06:15 tazek mpd: COMPPROTO VJCOMP, 16 comp. channels, allow
comp-cid
Oct 19 03:06:15 tazek mpd: IPADDR 172.16.30.42
Oct 19 03:06:15 tazek mpd: [pptp] IPCP: state change Req-Sent --> Ack-Sent
Oct 19 03:06:16 tazek mpd: [pptp] IPCP: SendConfigReq #3
Oct 19 03:06:16 tazek mpd: IPADDR 192.168.1.2
Oct 19 03:06:16 tazek mpd: COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Oct 19 03:06:16 tazek mpd: [pptp] IPCP: rec'd Configure Nak #3 (Ack-Sent)
Oct 19 03:06:16 tazek mpd: IPADDR ext_ip
Oct 19 03:06:16 tazek mpd: ext_ip is OK
Oct 19 03:06:16 tazek mpd: [pptp] IPCP: SendConfigReq #4
Oct 19 03:06:16 tazek mpd: IPADDR ext_ip
Oct 19 03:06:16 tazek mpd: COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Oct 19 03:06:16 tazek mpd: [pptp] IPCP: rec'd Configure Ack #4 (Ack-Sent)
Oct 19 03:06:16 tazek mpd: IPADDR ext_ip
Oct 19 03:06:16 tazek mpd: COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Oct 19 03:06:16 tazek mpd: [pptp] IPCP: state change Ack-Sent --> Opened
Oct 19 03:06:16 tazek mpd: [pptp] IPCP: LayerUp
Oct 19 03:06:16 tazek mpd: ext_ip -> 172.16.30.42
Oct 19 03:06:16 tazek mpd: [pptp] IFACE: Up event
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #2 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x000b was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #3 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0xf679 was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #4 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x000f was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #5 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol CRYPT was rejected
Oct 19 11:10:26 tazek mpd: [pptp] ECP: protocol was rejected by peer
Oct 19 11:10:26 tazek mpd: [pptp] ECP: Close event
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #6 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x009f was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #7 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x8683 was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #8 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x0073 was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #9 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x7e56 was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #10 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x56f2 was rejected
Oct 19 11:10:26 tazek mpd: [pptp] LCP: rec'd Protocol Reject #11 (Opened)
Oct 19 11:10:26 tazek mpd: [pptp] LCP: protocol 0x0047 was rejected
No errors between up event and protocol rejects. Help...
I've found this post
http://lists.freebsd.org/pipermail/freebsd-stable/2003-June/001878.html
but patch is for older ng_ppp.c and I do not speak C well enough to
write code for kernel modules. Also, saw some other guys having same
problems - but no solutions. Maybe community has something to say?
Please include me in CC because I'm not subscribed to the list.
Thanks
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?490368C0.1010704>