Date: Fri, 24 Oct 2008 22:08:13 +0300 From: CK <ruletko@gmail.com> To: freebsd-questions@freebsd.org Subject: mpd - lcp protocol rejects Message-ID: <49021D1D.7060701@gmail.com>
next in thread | raw e-mail | index | archive | help
Hello,
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?
Thanks
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?49021D1D.7060701>