mpd problem - CCP: rec'd Reset Request

Kirill Alpeev squid at iog.org.ua
Thu Mar 13 21:32:26 UTC 2008 

Hello,

There's a problem with my MPD which I cannot reproduce but it appears 
from time to time. Here's complete session log and mpd configs:

Mar 10 08:26:23 tazek mpd: [pptp] using interface ng0
Mar 10 08:26:23 tazek mpd: [pptp] link: OPEN event
Mar 10 08:26:23 tazek mpd: [pptp] LCP: Open event
Mar 10 08:26:23 tazek mpd: [pptp] LCP: state change Initial --> Starting
Mar 10 08:26:23 tazek mpd: [pptp] LCP: LayerStart
Mar 10 08:26:23 tazek mpd: pptp0: connecting to 193.33.48.3 1723
Mar 10 08:26:23 tazek mpd: pptp0: connected to 193.33.48.3 1723
Mar 10 08:26:23 tazek mpd: pptp0: attached to connection with 
193.33.48.3 1723
Mar 10 08:26:23 tazek mpd: pptp0-0: outgoing call connected at 64000 bps
Mar 10 08:26:23 tazek mpd: [pptp] PPTP call successful
Mar 10 08:26:24 tazek mpd: [pptp] link: UP event
Mar 10 08:26:24 tazek mpd: [pptp] link: origination is local
Mar 10 08:26:24 tazek mpd: [pptp] LCP: Up event
Mar 10 08:26:24 tazek mpd: [pptp] LCP: state change Starting --> Req-Sent
Mar 10 08:26:24 tazek mpd: [pptp] LCP: SendConfigReq #1
Mar 10 08:26:24 tazek mpd:  ACFCOMP
Mar 10 08:26:24 tazek mpd:  PROTOCOMP
Mar 10 08:26:24 tazek mpd:  ACCMAP 0x000a0000
Mar 10 08:26:24 tazek mpd:  MRU 1460
Mar 10 08:26:24 tazek mpd:  MAGICNUM 50e25050
Mar 10 08:26:24 tazek mpd: [pptp] LCP: rec'd Configure Ack #1 (Req-Sent)
Mar 10 08:26:24 tazek mpd:  ACFCOMP
Mar 10 08:26:24 tazek mpd:  PROTOCOMP
Mar 10 08:26:24 tazek mpd:  ACCMAP 0x000a0000
Mar 10 08:26:24 tazek mpd:  MRU 1460
Mar 10 08:26:24 tazek mpd:  MAGICNUM 50e25050
Mar 10 08:26:24 tazek mpd: [pptp] LCP: state change Req-Sent --> Ack-Rcvd
Mar 10 08:26:26 tazek mpd: [pptp] LCP: state change Ack-Rcvd --> Req-Sent
Mar 10 08:26:26 tazek mpd: [pptp] LCP: SendConfigReq #2
Mar 10 08:26:26 tazek mpd:  ACFCOMP
Mar 10 08:26:26 tazek mpd:  PROTOCOMP
Mar 10 08:26:26 tazek mpd:  ACCMAP 0x000a0000
Mar 10 08:26:26 tazek mpd:  MRU 1460
Mar 10 08:26:26 tazek mpd:  MAGICNUM 50e25050
Mar 10 08:26:26 tazek mpd: [pptp] LCP: rec'd Configure Ack #2 (Req-Sent)
Mar 10 08:26:26 tazek mpd:  ACFCOMP
Mar 10 08:26:26 tazek mpd:  PROTOCOMP
Mar 10 08:26:26 tazek mpd:  ACCMAP 0x000a0000
Mar 10 08:26:26 tazek mpd:  MRU 1460
Mar 10 08:26:26 tazek mpd:  MAGICNUM 50e25050
Mar 10 08:26:26 tazek mpd: [pptp] LCP: state change Req-Sent --> Ack-Rcvd
Mar 10 08:26:26 tazek mpd: [pptp] LCP: rec'd Configure Request #1 (Ack-Rcvd)
Mar 10 08:26:26 tazek mpd:  ACCMAP 0x00000000
Mar 10 08:26:26 tazek mpd:  AUTHPROTO CHAP MSOFTv2
Mar 10 08:26:26 tazek mpd:  MAGICNUM e11b37fd
Mar 10 08:26:26 tazek mpd:  PROTOCOMP
Mar 10 08:26:26 tazek mpd:  ACFCOMP
Mar 10 08:26:26 tazek mpd: [pptp] LCP: SendConfigAck #1
Mar 10 08:26:26 tazek mpd:  ACCMAP 0x00000000
Mar 10 08:26:26 tazek mpd:  AUTHPROTO CHAP MSOFTv2
Mar 10 08:26:26 tazek mpd:  MAGICNUM e11b37fd
Mar 10 08:26:26 tazek mpd:  PROTOCOMP
Mar 10 08:26:26 tazek mpd:  ACFCOMP
Mar 10 08:26:26 tazek mpd: [pptp] LCP: state change Ack-Rcvd --> Opened
Mar 10 08:26:26 tazek mpd: [pptp] LCP: auth: peer wants CHAP, I want nothing
Mar 10 08:26:26 tazek mpd: [pptp] LCP: LayerUp
Mar 10 08:26:26 tazek mpd: [pptp] CHAP: rec'd CHALLENGE #153
Mar 10 08:26:26 tazek mpd:  Name: "pptpd"
Mar 10 08:26:26 tazek mpd:  Using authname "u_sn_kpenergy"
Mar 10 08:26:27 tazek mpd: [pptp] CHAP: sending RESPONSE len:63
Mar 10 08:26:27 tazek mpd: [pptp] CHAP: rec'd SUCCESS #153
Mar 10 08:26:27 tazek mpd:  MESG: S=8A3A5371D391A9E723EC05269806C81EA5F42125
Mar 10 08:26:27 tazek mpd: [pptp] LCP: authorization successful
Mar 10 08:26:27 tazek mpd: [pptp] Bundle up: 1 link, total bandwidth 
64000 bps
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: Open event
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: state change Initial --> Starting
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: LayerStart
Mar 10 08:26:27 tazek mpd: [pptp] CCP: Open event
Mar 10 08:26:27 tazek mpd: [pptp] CCP: state change Initial --> Starting
Mar 10 08:26:27 tazek mpd: [pptp] CCP: LayerStart
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: Up event
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: state change Starting --> Req-Sent
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: SendConfigReq #1
Mar 10 08:26:27 tazek mpd:  IPADDR 192.168.132.26
Mar 10 08:26:27 tazek mpd:  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Mar 10 08:26:27 tazek mpd: [pptp] CCP: Up event
Mar 10 08:26:27 tazek mpd: [pptp] CCP: state change Starting --> Req-Sent
Mar 10 08:26:27 tazek mpd: [pptp] CCP: SendConfigReq #1
Mar 10 08:26:27 tazek mpd:  MPPC
Mar 10 08:26:27 tazek mpd:    0x01000040:MPPE(128 bits), stateless
Mar 10 08:26:27 tazek mpd: [pptp] can't get stats, link=0: Invalid argument
Mar 10 08:26:27 tazek mpd: [pptp] CCP: rec'd Configure Request #1 (Req-Sent)
Mar 10 08:26:27 tazek mpd:  MPPC
Mar 10 08:26:27 tazek mpd:    0x01000040:MPPE(128 bits), stateless
Mar 10 08:26:27 tazek mpd: [pptp] CCP: SendConfigAck #1
Mar 10 08:26:27 tazek mpd:  MPPC
Mar 10 08:26:27 tazek mpd:    0x01000040:MPPE(128 bits), stateless
Mar 10 08:26:27 tazek mpd: [pptp] CCP: state change Req-Sent --> Ack-Sent
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: rec'd Terminate Ack #1 (Req-Sent)
Mar 10 08:26:27 tazek mpd: [pptp] CCP: rec'd Configure Ack #1 (Ack-Sent)
Mar 10 08:26:27 tazek mpd:  MPPC
Mar 10 08:26:27 tazek mpd:    0x01000040:MPPE(128 bits), stateless
Mar 10 08:26:27 tazek mpd: [pptp] CCP: state change Ack-Sent --> Opened
Mar 10 08:26:27 tazek mpd: [pptp] CCP: LayerUp
Mar 10 08:26:27 tazek mpd:   Compress using: mppc (MPPE(128 bits), 
stateless)
Mar 10 08:26:27 tazek mpd: Decompress using: mppc (MPPE(128 bits), 
stateless)
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: rec'd Configure Request #1 
(Req-Sent)
Mar 10 08:26:27 tazek mpd:  COMPPROTO VJCOMP, 16 comp. channels, allow 
comp-cid
Mar 10 08:26:27 tazek mpd:  IPADDR 172.16.30.42
Mar 10 08:26:27 tazek mpd:    172.16.30.42 is OK
Mar 10 08:26:27 tazek mpd: [pptp] IPCP: SendConfigAck #1
Mar 10 08:26:27 tazek mpd:  COMPPROTO VJCOMP, 16 comp. channels, allow 
comp-cid
Mar 10 08:26:27 tazek mpd:  IPADDR 172.16.30.42
Mar 10 08:26:29 tazek mpd: [pptp] IPCP: SendConfigReq #2
Mar 10 08:26:29 tazek mpd:  IPADDR 192.168.132.26
Mar 10 08:26:29 tazek mpd:  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Mar 10 08:26:29 tazek mpd: [pptp] IPCP: rec'd Configure Nak #2 (Ack-Sent)
Mar 10 08:26:29 tazek mpd:  IPADDR 193.33.49.198
Mar 10 08:26:29 tazek mpd:    193.33.49.198 is OK
Mar 10 08:26:29 tazek mpd: [pptp] IPCP: SendConfigReq #3
Mar 10 08:26:29 tazek mpd:  IPADDR 193.33.49.198
Mar 10 08:26:29 tazek mpd:  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Mar 10 08:26:29 tazek mpd: [pptp] IPCP: rec'd Configure Ack #3 (Ack-Sent)
Mar 10 08:26:29 tazek mpd:  IPADDR 193.33.49.198
Mar 10 08:26:29 tazek mpd:  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Mar 10 08:26:29 tazek mpd: [pptp] IPCP: state change Ack-Sent --> Opened
Mar 10 08:26:29 tazek mpd: [pptp] IPCP: LayerUp
Mar 10 08:26:29 tazek mpd:   193.33.49.198 -> 172.16.30.42
Mar 10 08:26:29 tazek mpd: [pptp] IFACE: Up event
Mar 10 08:26:29 tazek mpd: [pptp] rec'd unexpected protocol IP
Mar 13 09:16:03 tazek mpd: [pptp] CCP: rec'd Reset Request #2 (Opened)
Mar 13 09:16:17 tazek mpd: last message repeated 13 times
Mar 13 09:16:17 tazek mpd: [pptp] CCP: rec'd Reset Request #3 (Opened)
Mar 13 09:16:21 tazek mpd: last message repeated 2 times
Mar 13 09:16:21 tazek mpd: [pptp] CCP: rec'd Reset Request #4 (Opened)
Mar 13 09:16:22 tazek mpd: [pptp] CCP: rec'd Reset Request #5 (Opened)
Mar 13 09:16:29 tazek mpd: last message repeated 5 times
Mar 13 09:16:29 tazek mpd: [pptp] CCP: rec'd Reset Request #6 (Opened)
Mar 13 09:16:57 tazek mpd: last message repeated 26 times
Mar 13 09:16:57 tazek mpd: [pptp] CCP: rec'd Reset Request #7 (Opened)
Mar 13 09:16:59 tazek mpd: [pptp] CCP: rec'd Reset Request #7 (Opened)
Mar 13 09:16:59 tazek mpd: [pptp] CCP: rec'd Reset Request #8 (Opened)
Mar 13 09:17:15 tazek mpd: last message repeated 14 times
Mar 13 09:17:15 tazek mpd: [pptp] CCP: rec'd Reset Request #9 (Opened)
Mar 13 09:17:17 tazek mpd: [pptp] CCP: rec'd Reset Request #9 (Opened)
Mar 13 09:17:17 tazek mpd: [pptp] CCP: rec'd Reset Request #10 (Opened)
Mar 13 09:17:29 tazek mpd: last message repeated 10 times
Mar 13 09:17:29 tazek mpd: [pptp] CCP: rec'd Reset Request #11 (Opened)
Mar 13 09:17:35 tazek mpd: last message repeated 5 times
Mar 13 09:17:35 tazek mpd: [pptp] CCP: rec'd Reset Request #12 (Opened)
Mar 13 09:17:46 tazek mpd: last message repeated 10 times
Mar 13 09:17:46 tazek mpd: [pptp] CCP: rec'd Reset Request #13 (Opened)
Mar 13 09:18:24 tazek mpd: last message repeated 36 times
Mar 13 09:18:24 tazek mpd: [pptp] CCP: rec'd Reset Request #14 (Opened)
Mar 13 09:18:43 tazek mpd: last message repeated 17 times
[that messages repeated until I reset connection manually]

mpd.conf:

pptp:
         new -i ng0 pptp pptp
         set iface route default
         set iface disable on-demand
         set iface disable proxy-arp
         set iface enable tcpmssfix
         set iface idle 0

         set bundle disable multilink
         set bundle yes compression
         set bundle disable noretry

         set auth authname "u_sn_kpenergy"
         set auth password "password"

         set link accept acfcomp protocomp
         set link accept chap
         set link keep-alive 10 60
         set link max-redial 0
         set link mtu 1460
         set link mru 1460

         set ipcp yes vjcomp

         set ccp yes mppc
         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 193.33.48.3
         set pptp enable originate
         set pptp disable incoming
         set pptp disable windowing
         set pptp disable delayed-ack

I'm open to any suggestions. My ISP is of no use unfortunately, those 
Linux lovers... :)

10x

More information about the freebsd-questions mailing list