Date: Sun, 27 Apr 2014 17:00:15 +0200 From: martin i <ilavsky.martin@gmail.com> To: freebsd-net@freebsd.org Subject: Random disconnects on 10.0 with mpd5/pptp + PF Message-ID: <CAN5QJX-8SMQ5vspN=REixCxpycstQ62PiK_WhqwkU%2BfTB2kX7w@mail.gmail.com>
next in thread | raw e-mail | index | archive | help
I turned on verbose logging in mpd.conf and did another set of tests. Client just logged in and stayed idle. Traffic of the active PPTP session looked like: Test #1: Apr 27 02:09:35 fbsd10 mpd: pptp0: recv EchoRequest Apr 27 02:09:35 fbsd10 mpd: id=0x6000000 Apr 27 02:09:35 fbsd10 mpd: pptp0: send EchoReply msg Apr 27 02:09:35 fbsd10 mpd: len=20 msgType=1 magic=0x1a2b3c4d type=6 Apr 27 02:09:35 fbsd10 mpd: id=0x6000000 result=1 err=0 ignore=0 Apr 27 02:10:35 fbsd10 mpd: pptp0: send EchoRequest msg Apr 27 02:10:35 fbsd10 mpd: len=16 msgType=1 magic=0x1a2b3c4d type=5 Apr 27 02:10:35 fbsd10 mpd: id=1 Apr 27 02:10:35 fbsd10 mpd: pptp0: recv EchoRequest Apr 27 02:10:35 fbsd10 mpd: id=0x7000000 Apr 27 02:10:35 fbsd10 mpd: pptp0: send EchoReply msg Apr 27 02:10:35 fbsd10 mpd: len=20 msgType=1 magic=0x1a2b3c4d type=6 Apr 27 02:10:35 fbsd10 mpd: id=0x7000000 result=1 err=0 ignore=0 Apr 27 02:10:35 fbsd10 mpd: pptp0: recv EchoReply Apr 27 02:10:35 fbsd10 mpd: id=1 result=1 err=0 ignore=0 Apr 27 02:11:35 fbsd10 mpd: pptp0: send EchoRequest msg Apr 27 02:11:35 fbsd10 mpd: len=16 msgType=1 magic=0x1a2b3c4d type=5 Apr 27 02:11:35 fbsd10 mpd: id=2 Apr 27 02:11:35 fbsd10 mpd: pptp0: read: Connection reset by peer Apr 27 02:11:35 fbsd10 mpd: pptp0: ctrl state ESTABLISHED --> DYING Apr 27 02:11:35 fbsd10 mpd: pptp0: killing connection with <CLIENT_IP> 49595 Apr 27 02:11:35 fbsd10 mpd: pptp0-0: killing channel Apr 27 02:11:35 fbsd10 mpd: [cloud_link-1] PPTP call terminated Apr 27 02:11:35 fbsd10 mpd: [cloud_link-1] device: DOWN event Test #2: Apr 27 02:28:16 fbsd10 mpd: len=20 msgType=1 magic=0x1a2b3c4d type=6 Apr 27 02:28:16 fbsd10 mpd: id=0x5000000 result=1 err=0 ignore=0 Apr 27 02:29:16 fbsd10 mpd: pptp0: recv EchoRequest Apr 27 02:29:16 fbsd10 mpd: id=0x6000000 Apr 27 02:29:16 fbsd10 mpd: pptp0: send EchoReply msg Apr 27 02:29:16 fbsd10 mpd: len=20 msgType=1 magic=0x1a2b3c4d type=6 Apr 27 02:29:16 fbsd10 mpd: id=0x6000000 result=1 err=0 ignore=0 Apr 27 02:30:16 fbsd10 mpd: pptp0: send EchoRequest msg Apr 27 02:30:16 fbsd10 mpd: len=16 msgType=1 magic=0x1a2b3c4d type=5 Apr 27 02:30:16 fbsd10 mpd: id=1 Apr 27 02:30:16 fbsd10 mpd: pptp0: read: Connection reset by peer Apr 27 02:30:16 fbsd10 mpd: pptp0: ctrl state ESTABLISHED --> DYING Apr 27 02:30:16 fbsd10 mpd: pptp0: killing connection with <CLIENT_IP> 49732 In test #2 connection went down even sooner. It seems that the "type 5" message has something to do with it. I checked the RFC 1661 for PPP specification but I found no information on what that type might be. I looked at mpd5 sources (v5.7); it seems it's defined in pptp_ctrl.h as PPTP_EchoRequest (type 6 is PPTP_EchoReply). I rebooted back to 9.2 to check the behavior there. I saw only type 6 messages: Apr 27 16:40:33 fbsd9 mpd: pptp0: recv EchoRequest Apr 27 16:40:33 fbsd9 mpd: id=0x23000000 Apr 27 16:40:33 fbsd9 mpd: pptp0: send EchoReply msg Apr 27 16:40:33 fbsd9 mpd: len=20 msgType=1 magic=0x1a2b3c4d type=6 Apr 27 16:40:33 fbsd9 mpd: id=0x23000000 result=1 err=0 ignore=0 Apr 27 16:41:33 fbsd9 mpd: pptp0: recv EchoRequest Apr 27 16:41:33 fbsd9 mpd: id=0x24000000 Apr 27 16:41:33 fbsd9 mpd: pptp0: send EchoReply msg Apr 27 16:41:33 fbsd9 mpd: len=20 msgType=1 magic=0x1a2b3c4d type=6 Apr 27 16:41:33 fbsd9 mpd: id=0x24000000 result=1 err=0 ignore=0 with no type 5 messages at all. Session stays up without problem. But logic to keep the link up is in the mpd5 which is the same version on 9.2 and 10.0. What can be the reason for sending those type 5 messages ? (or is my assumption even correct that it has something to do with my issue?) Martin
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?CAN5QJX-8SMQ5vspN=REixCxpycstQ62PiK_WhqwkU%2BfTB2kX7w>