MikroTik

Hi,

I have a RB750 V4.2 working as a PPTP Server.
Several clients using RB433 V4.2 and RB493 V4.2 routerboards connect to this server.

In the past (since the release of V4.2) clients could connect without problems.
The first client stopped working a few days ago. The second client died today. Another client is still alive.

I can see the client attemps to connect in the log, but I don't figure out the reason for the failure.

The Licenses in all devices were upgraded to 8 digits. Firmware in the Routerboards was also upgraded to the version contained in V4.2.

This is an extract from the log:

Nov/19/2009 12:14:32 pptp,info TCP connection established from 81.47.xxx.yyy
Nov/19/2009 12:14:32 pptp,ppp,info <pptp-0>: waiting for call...
Nov/19/2009 12:14:32 pptp,debug,packet rcvd Start-Control-Connection-Request from 81.47.xxx.yyy
Nov/19/2009 12:14:32 pptp,debug,packet protocol-version=0x0100
Nov/19/2009 12:14:32 pptp,debug,packet framing-capabilities=2
Nov/19/2009 12:14:32 pptp,debug,packet bearer-capabilities=0
Nov/19/2009 12:14:32 pptp,debug,packet maximum-channels=0
Nov/19/2009 12:14:32 pptp,debug,packet firmware-revision=1
Nov/19/2009 12:14:32 pptp,debug,packet host-name=Remote_CBK
Nov/19/2009 12:14:32 pptp,debug,packet vendor-name=MikroTik
Nov/19/2009 12:14:32 pptp,debug,packet sent Start-Control-Connection-Reply to 81.47.xxx.yyy
Nov/19/2009 12:14:32 pptp,debug,packet protocol-version=0x0100
Nov/19/2009 12:14:32 pptp,debug,packet result-code=1
Nov/19/2009 12:14:32 pptp,debug,packet error-code=0
Nov/19/2009 12:14:32 pptp,debug,packet framing-capabilities=2
Nov/19/2009 12:14:32 pptp,debug,packet bearer-capabilities=0
Nov/19/2009 12:14:32 pptp,debug,packet maximum-channels=0
Nov/19/2009 12:14:32 pptp,debug,packet firmware-revision=1
Nov/19/2009 12:14:32 pptp,debug,packet host-name=Local
Nov/19/2009 12:14:32 pptp,debug,packet vendor-name=MikroTik
Nov/19/2009 12:14:48 pptp,info TCP connection established from 88.17.zzz.ttt
Nov/19/2009 12:14:48 pptp,ppp,info <pptp-1>: waiting for call...
Nov/19/2009 12:14:48 pptp,debug,packet rcvd Start-Control-Connection-Request from 88.17.zzz.ttt
Nov/19/2009 12:14:48 pptp,debug,packet protocol-version=0x0100
Nov/19/2009 12:14:48 pptp,debug,packet framing-capabilities=2
Nov/19/2009 12:14:48 pptp,debug,packet bearer-capabilities=0
Nov/19/2009 12:14:48 pptp,debug,packet maximum-channels=0
Nov/19/2009 12:14:48 pptp,debug,packet firmware-revision=1
Nov/19/2009 12:14:48 pptp,debug,packet host-name=Remote-PB
Nov/19/2009 12:14:48 pptp,debug,packet vendor-name=MikroTik
Nov/19/2009 12:14:48 pptp,debug,packet sent Start-Control-Connection-Reply to 88.17.zzz.ttt
Nov/19/2009 12:14:48 pptp,debug,packet protocol-version=0x0100
Nov/19/2009 12:14:48 pptp,debug,packet result-code=1
Nov/19/2009 12:14:48 pptp,debug,packet error-code=0
Nov/19/2009 12:14:48 pptp,debug,packet framing-capabilities=2
Nov/19/2009 12:14:48 pptp,debug,packet bearer-capabilities=0
Nov/19/2009 12:14:48 pptp,debug,packet maximum-channels=0
Nov/19/2009 12:14:48 pptp,debug,packet firmware-revision=1
Nov/19/2009 12:14:48 pptp,debug,packet host-name=Local
Nov/19/2009 12:14:48 pptp,debug,packet vendor-name=MikroTik
Nov/19/2009 12:14:48 pptp,debug,packet rcvd Outgoing-Call-Request from 88.17.zzz.ttt
Nov/19/2009 12:14:48 pptp,debug,packet call-id=0
Nov/19/2009 12:14:48 pptp,debug,packet call-serial-number=0
Nov/19/2009 12:14:48 pptp,debug,packet minimum-bps=2400
Nov/19/2009 12:14:48 pptp,debug,packet maximum-bps=10000000
Nov/19/2009 12:14:48 pptp,debug,packet bearer-type=3
Nov/19/2009 12:14:48 pptp,debug,packet framing-type=2
Nov/19/2009 12:14:48 pptp,debug,packet packet-recv-window-size=100
Nov/19/2009 12:14:48 pptp,debug,packet packet-processing-delay=0
Nov/19/2009 12:14:48 pptp,debug,packet phone-number-length=0
Nov/19/2009 12:14:48 pptp,debug,packet phone-number=
Nov/19/2009 12:14:48 pptp,debug,packet subaddress=
Nov/19/2009 12:14:48 pptp,ppp,debug <88.17.zzz.ttt>: LCP lowerup
Nov/19/2009 12:14:48 pptp,ppp,debug <88.17.zzz.ttt>: LCP open
Nov/19/2009 12:14:48 pptp,debug,packet sent Outgoing-Call-Reply to 88.17.zzz.ttt
Nov/19/2009 12:14:48 pptp,debug,packet call-id=276
Nov/19/2009 12:14:48 pptp,debug,packet peers-call-id=0
Nov/19/2009 12:14:48 pptp,debug,packet result-code=1
Nov/19/2009 12:14:48 pptp,debug,packet error-code=0
Nov/19/2009 12:14:48 pptp,debug,packet cause-code=0
Nov/19/2009 12:14:48 pptp,debug,packet connect-speed=100000
Nov/19/2009 12:14:48 pptp,debug,packet packet-recv-window-size=100
Nov/19/2009 12:14:48 pptp,debug,packet packet-processing-delay=0
Nov/19/2009 12:14:48 pptp,debug,packet physical-channel-id=0
Nov/19/2009 12:14:49 pptp,ppp,debug <88.17.zzz.ttt>: LCP timer
Nov/19/2009 12:14:49 pptp,ppp,debug,packet <88.17.zzz.ttt>: sent LCP ConfReq id=0x1
Nov/19/2009 12:14:49 pptp,ppp,debug,packet <mru 1460>
Nov/19/2009 12:14:49 pptp,ppp,debug,packet <magic 0x517**d9b>
Nov/19/2009 12:14:49 pptp,ppp,debug,packet <auth mschap2>
Nov/19/2009 12:14:50 pptp,ppp,debug <88.17.zzz.ttt>: LCP timer
Nov/19/2009 12:14:50 pptp,ppp,debug,packet <88.17.zzz.ttt>: sent LCP ConfReq id=0x2
Nov/19/2009 12:14:50 pptp,ppp,debug,packet <mru 1460>
Nov/19/2009 12:14:50 pptp,ppp,debug,packet <magic 0x517**d9b>
Nov/19/2009 12:14:50 pptp,ppp,debug,packet <auth mschap2>
Nov/19/2009 12:14:52 pptp,ppp,debug <88.17.zzz.ttt>: LCP timer
Nov/19/2009 12:14:52 pptp,ppp,debug,packet <88.17.zzz.ttt>: sent LCP ConfReq id=0x3
Nov/19/2009 12:14:52 pptp,ppp,debug,packet <mru 1460>
Nov/19/2009 12:14:52 pptp,ppp,debug,packet <magic 0x517**d9b>
Nov/19/2009 12:14:52 pptp,ppp,debug,packet <auth mschap2>
Nov/19/2009 12:14:54 pptp,ppp,debug <88.17.zzz.ttt>: LCP timer
Nov/19/2009 12:14:54 pptp,ppp,debug <88.17.zzz.ttt>: LCP timeout sending ConfReq
Nov/19/2009 12:14:54 pptp,ppp,debug <88.17.zzz.ttt>: LCP lowerdown
Nov/19/2009 12:14:54 pptp,ppp,info <pptp-1>: terminating...
Nov/19/2009 12:14:54 pptp,ppp,debug <88.17.zzz.ttt>: LCP lowerdown
Nov/19/2009 12:14:54 pptp,ppp,debug <88.17.zzz.ttt>: LCP down event in starting state
Nov/19/2009 12:14:54 pptp,ppp,info <pptp-1>: disconnected
Nov/19/2009 12:15:02 pptp,ppp,info <pptp-0>: terminating... - could not connect - timed out
Nov/19/2009 12:15:02 pptp,ppp,debug <81.47.xxx.yyy>: LCP lowerdown
Nov/19/2009 12:15:02 pptp,ppp,debug <81.47.xxx.yyy>: LCP down event in initial state
Nov/19/2009 12:15:02 pptp,ppp,info <pptp-0>: disconnected

If you could send me some light on the problem, I would be grateful....

I downgraded RB750 to V3.30 and one of the "died" clients is connecting again.

Settings remain the same, and clients are still running V4.2.

The other still don't connect.

Looks like a timing problem in the PPTP protocol.

If it's a bug, it won't be solved here. Send a supout.rif from the router to support@mikrotik.com.

Tom

Switched the PPTP tunnel to L2TP.

Downgraded Server Router to V3.3
Upgraded it again to V4.2
All clients came alive for some minutes.
Created L2TP tunnels and changed routing table accordingly.