PPTP VPN client failing to connect with message LCP closed

smagumo · December 15, 2008, 6:01pm

Good day,

We are running a Mikrotik VPN server on our network which is behind a NAT. From the internet through the public IP 196.xx.xx.40 (NAT IP for VPN server), some networks can connect to the VPN server without a problem but this one network 196.44.xx.xx with transaction log captured below just cannot connect. Client 196.44.xx.xx can do VPN to numerous other VPN servers.

Rough sketch of the setup is as below:

|MS VPN client 196.44.xx.xx|----|internet|----|Mikrotik196.xx.xx.40|----|NAT|----|172.17.102.145 Mikrotik VPN server|

Inorder to troubleshoot further I enabled debug and captured the log below. I was hoping for I will easily figure out but no joy at all.

Please help.

2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 2008-12-12 15:54:23 Local7.Debug 172.17.102.145 pptp,info TCP connection established from 196.44.xx.xx
Local7.Debug 172.17.102.145 pptp,ppp,info : waiting for call…
Local7.Debug 172.17.102.145 pptp,debug,packet rcvd Start-Control-Connection-Request from 196.44.xx.xx
Local7.Debug 172.17.102.145 pptp,debug,packet protocol-version=0x0100
Local7.Debug 172.17.102.145 pptp,debug,packet framing-capabilities=1
Local7.Debug 172.17.102.145 pptp,debug,packet bearer-capabilities=1
Local7.Debug 172.17.102.145 pptp,debug,packet maximum-channels=0
Local7.Debug 172.17.102.145 pptp,debug,packet firmware-revision=0
Local7.Debug 172.17.102.145 pptp,debug,packet host-name=
Local7.Debug 172.17.102.145 pptp,debug,packet vendor-name=Microsoft
Local7.Debug 172.17.102.145 pptp,debug,packet sent Start-Control-Connection-Reply to 196.44.xx.xx
Local7.Debug 172.17.102.145 pptp,debug,packet protocol-version=0x0100
Local7.Debug 172.17.102.145 pptp,debug,packet result-code=1
Local7.Debug 172.17.102.145 pptp,debug,packet error-code=0
Local7.Debug 172.17.102.145 pptp,debug,packet framing-capabilities=2
Local7.Debug 172.17.102.145 pptp,debug,packet bearer-capabilities=0
Local7.Debug 172.17.102.145 pptp,debug,packet maximum-channels=0
Local7.Debug 172.17.102.145 pptp,debug,packet firmware-revision=1
Local7.Debug 172.17.102.145 pptp,debug,packet host-name=Christo Plaatjies
Local7.Debug 172.17.102.145 pptp,debug,packet vendor-name=MikroTik
Local7.Debug 172.17.102.145 pptp,debug,packet rcvd Outgoing-Call-Request from 196.44.xx.xx
Local7.Debug 172.17.102.145 pptp,debug,packet call-id=18572
Local7.Debug 172.17.102.145 pptp,debug,packet call-serial-number=6
Local7.Debug 172.17.102.145 pptp,debug,packet minimum-bps=300
Local7.Debug 172.17.102.145 pptp,debug,packet maximum-bps=100000000
Local7.Debug 172.17.102.145 pptp,debug,packet bearer-type=3
Local7.Debug 172.17.102.145 pptp,debug,packet framing-type=3
Local7.Debug 172.17.102.145 pptp,debug,packet packet-recv-window-size=64
Local7.Debug 172.17.102.145 pptp,debug,packet packet-processing-delay=0
Local7.Debug 172.17.102.145 pptp,debug,packet phone-number-length=0
Local7.Debug 172.17.102.145 pptp,debug,packet phone-number=
Local7.Debug 172.17.102.145 pptp,debug,packet subaddress=
Local7.Debug 172.17.102.145 pptp,ppp,debug <196.44.xx.xx>: LCP lowerup
Local7.Debug 172.17.102.145 pptp,ppp,debug <196.44.xx.xx>: LCP open
Local7.Debug 172.17.102.145 pptp,debug,packet sent Outgoing-Call-Reply to 196.44.xx.xx
Local7.Debug 172.17.102.145 pptp,debug,packet call-id=30
Local7.Debug 172.17.102.145 pptp,debug,packet peers-call-id=18572
Local7.Debug 172.17.102.145 pptp,debug,packet result-code=1
Local7.Debug 172.17.102.145 pptp,debug,packet error-code=0
Local7.Debug 172.17.102.145 pptp,debug,packet cause-code=0
Local7.Debug 172.17.102.145 pptp,debug,packet connect-speed=100000
Local7.Debug 172.17.102.145 pptp,debug,packet packet-recv-window-size=100
Local7.Debug 172.17.102.145 pptp,debug,packet packet-processing-delay=0
Local7.Debug 172.17.102.145 pptp,debug,packet physical-channel-id=0
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <196.44.xx.xx>: rcvd LCP ConfReq id=0x0
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <mru 1400>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <magic 0x318e2e1b>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <callback 0x06>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <196.44.xx.xx>: sent LCP ConfReq id=0x1
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <mru 1460>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <magic 0x195f3516>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <196.44.xx.xx>: sent LCP ConfRej id=0x0
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,debug,packet rcvd Set-Link-Info from 196.44.xx.xx
Local7.Debug 172.17.102.145 pptp,debug,packet peers-call-id=30
Local7.Debug 172.17.102.145 pptp,debug,packet send-accm=0xffffffff
Local7.Debug 172.17.102.145 pptp,debug,packet receive-accm=0xffffffff
Local7.Debug 172.17.102.145 pptp,debug,packet sent Set-Link-Info to 196.44.xx.xx
Local7.Debug 172.17.102.145 pptp,debug,packet peers-call-id=18572
Local7.Debug 172.17.102.145 pptp,debug,packet send-accm=0xffffffff
Local7.Debug 172.17.102.145 pptp,debug,packet receive-accm=0xffffffff
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <196.44.xx.xx>: rcvd LCP ConfAck id=0x1
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <mru 1460>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <magic 0x195f3516>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <196.44.xx.xx>: rcvd LCP ConfReq id=0x1
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <mru 1400>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <magic 0x318e2e1b>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <callback 0x06>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <196.44.xx.xx>: sent LCP ConfAck id=0x1
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <mru 1400>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <magic 0x318e2e1b>
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <callback 0x06>
Local7.Debug 172.17.102.145 pptp,ppp,debug <196.44.xx.xx>: LCP opened
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet <196.44.xx.xx>: sent CHAP Challenge id=0x1
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,ppp,debug,packet
Local7.Debug 172.17.102.145 pptp,ppp,debug <196.44.xx.xx>: LCP lowerdown
Local7.Debug 172.17.102.145 pptp,ppp,debug <196.44.xx.xx>: LCP closed
Local7.Debug 172.17.102.145 pptp,ppp,info : terminating… - disconnected
Local7.Debug 172.17.102.145 pptp,ppp,debug <196.44.xx.xx>: LCP lowerdown
Local7.Debug 172.17.102.145 pptp,ppp,debug <196.44.xx.xx>: LCP down event in starting state
Local7.Debug 172.17.102.145 pptp,ppp,info : disconnected

princenux · December 19, 2008, 6:47am

instead of using PPTP
just use the L2TP…

i’ve do my research for a whole week..
and i got no answer for that problem…

i bet u got the 619 error msg on your Windows right ?
so.. try to use L2TP…