* PPP connection corruption with Windows client, MPPE, and RDP
@ 2014-10-08 21:16 Francesco Pretto
2014-10-08 22:53 ` Michael Richardson
` (2 more replies)
0 siblings, 3 replies; 4+ messages in thread
From: Francesco Pretto @ 2014-10-08 21:16 UTC (permalink / raw)
To: linux-ppp
[-- Attachment #1: Type: text/plain, Size: 3622 bytes --]
Hello PPP mantainers,
I configured an IPsec-L2TP VPN on my work network. The VPN has both
endpoints on natted networks: ipsec client/server are both NAT enabled
and routers are configured to properly forward IPSEC UPD ports and to
passthrough VPN traffic. For some weeks it has worked reliably.
Recently it stopped working properly with RDP (Remote Desktop
Protocol) seeming to be the most effective trigger that leads the
connection to a corrupted state.
Enabling the full PPP debug, when the connection is corrupted the log
begin to be spammed with plenty of warnings of spurious packets:
Oct 1 14:18:55 lanmaster pppd[1977]: rcvd [proto=0xa1] 5f e4 25 5a 19
6b ad 6b
b7 0d 60 f7 49 f8 47 f3
5d 87 73 97 12 b2 a7 63 54 21 05 35 43 6a 94 14 ...
Oct 1 14:18:55 lanmaster pppd[1977]: Unsupported protocol 0xa1 received
Oct 1 14:18:55 lanmaster pppd[1977]: sent [LCP ProtRej id=0x21 00 a1
5f e4 25 5
a 19 6b ad 6b b7 0d 60
f7 49 f8 47 f3 5d 87 73 97 12 b2 a7 63 54 21 05 35 43 6a
...]
Oct 1 14:18:55 lanmaster pppd[1977]: rcvd [proto=0x36f4] 76 df 4c 41
50 1b ad 4
d 5d c6 2e fb c7 77 1d
6f ae b3 6c 55 db 2b 89 94 6c 7b e3 66 1d 2c d2 57 ...
Oct 1 14:18:55 lanmaster pppd[1977]: Unsupported protocol 0x36f4 received
Oct 1 14:18:55 lanmaster pppd[1977]: sent [LCP ProtRej id=0x22 36 f4
76 df 4c 4
1 50 1b ad 4d 5d c6 2e
fb c7 77 1d 6f ae b3 6c 55 db 2b 89 94 6c 7b e3 66 1d 2c
...]
Oct 1 14:18:56 lanmaster pppd[1977]: rcvd [proto=0xda76] 17 88 8a 2f
86 5e 3f 4
c 69 3e e4 ff bb 61 5d
f8 0f 3e da ab 0b 7c 29 3b 99 87 7c 7e f7 12 4a 7b ...
Oct 1 14:18:56 lanmaster pppd[1977]: Unsupported protocol 0xda76 received
Oct 1 14:18:56 lanmaster pppd[1977]: sent [LCP ProtRej id=0x23 da 76 17 88 8a 2
[...]
This initially seemed to me an IPSEC problem but, after much
troubleshooting, removing the ppp option "require-mppe-128" option and
adding "nomppe", effectively disabling MPPE, resulted in a extremely
reliable connection again.
My observations:
- PPP doesn't detect a disconnection of a corruption. The client can
still proper hang-up;
- It's not RDP client-server related: RDP it's just the trigger, after
the whole connection TCP/IP connection is corrupted and must be reset;
- It's not Windows ipsec-ppp-l2tp client problem: same happen with
Windows 8.1 and fresh Windows7 client installed;
- It doesn't seem to be linux kernel problem: I tried to install older
ubuntu 3.2.0 kernels observing same problems. Now I use 3.13.0 kernel
with no changes as well;
- Tweaking PPP MTU doesn't help. I haven't tried tweaking ipsec MTU.
My stack version has been recently updated (from Ubuntu 12.04, that
had the same problem. Now it's 14.04):
- ppp 2.4.5-5.1ubuntu2
- xl2tpd 1.3.6+dfsg-1:
- openswan 1:2.6.38-1
- kernel 3.13.0-36
I'm unable to say if updates on these packages triggered the problem.
The workaround is effective for me as I don't need the PPP link to be
encrypted but the configuration should be supported with MPPE enabled
I offer my help to do further testing if someone notice there could be
a problem in PPP (for example the MPPE state could be partially
corrupted but PPP is unable to detect it). Also it may be useful for
others that may have the same problem.
I attached the faulty configuration and the initial log of the
l2tp-ppp connection.
In case CC me as I'm not subscribed. Thanks.
Francesco
[-- Attachment #2: xl2tpd.conf --]
[-- Type: application/octet-stream, Size: 171 bytes --]
[global]
ipsec saref = yes
[lns default]
ip range = 192.168.101.200-192.168.101.250
local ip = 192.168.101.26
pppoptfile = /etc/ppp/options.xl2tpd
length bit = yes
[-- Attachment #3: ipsec.conf --]
[-- Type: application/octet-stream, Size: 726 bytes --]
version 2.0
config setup
nat_traversal=yes
virtual_private=%v4:10.0.0.0/8,%v4:192.168.0.0/16,%v4:172.16.0.0/12
oe=off
protostack=netkey
# klipsdebug="all"
# plutodebug="all"
# Removed as said here http://ubuntuforums.org/showthread.php?t=2238692
#conn L2TP-PSK-NAT
# rightsubnet=vhost:%priv
# also=L2TP-PSK-noNAT
conn L2TP-PSK-noNAT
authby=secret
pfs=no
auto=add
# rekey seems ok
# rekey=no
# keyingtries=3
rekey=yes
keyingtries=%forever
ikelifetime=8h
keylife=1h
type=transport
left=192.168.101.20
leftprotoport=17/1701
right=%any
rightprotoport=17/%any
dpddelay=10
dpdtimeout=10
dpdaction=restart
[-- Attachment #4: l2tp-ppp-init.log --]
[-- Type: application/octet-stream, Size: 6803 bytes --]
Oct 1 14:26:20 lanmaster xl2tpd[2331]: Enabling IPsec SAref processing for L2TP transport mode SAs
Oct 1 14:26:20 lanmaster xl2tpd[2331]: IPsec SAref does not work with L2TP kernel mode yet, enabling force userspace=yes
Oct 1 14:26:20 lanmaster xl2tpd[2331]: setsockopt recvref[30]: Protocol not available
Oct 1 14:26:20 lanmaster xl2tpd[2331]: This binary does not support kernel L2TP.
Oct 1 14:26:20 lanmaster xl2tpd[2332]: xl2tpd version xl2tpd-1.3.6 started on lanmaster PID:2332
Oct 1 14:26:20 lanmaster xl2tpd[2332]: Written by Mark Spencer, Copyright (C) 1998, Adtran, Inc.
Oct 1 14:26:20 lanmaster xl2tpd[2332]: Forked by Scott Balmos and David Stipp, (C) 2001
Oct 1 14:26:20 lanmaster xl2tpd[2332]: Inherited by Jeff McAdams, (C) 2002
Oct 1 14:26:20 lanmaster xl2tpd[2332]: Forked again by Xelerance (www.xelerance.com) (C) 2006
Oct 1 14:26:20 lanmaster xl2tpd[2332]: Listening on IP address 0.0.0.0, port 1701
Oct 1 14:26:52 lanmaster xl2tpd[2332]: Connection established to 151.44.6.95, 1701. Local: 56337, Remote: 4 (ref=0/0). LNS session is 'default'
Oct 1 14:26:52 lanmaster xl2tpd[2332]: check_control: Received out of order control packet on tunnel 4 (got 3, expected 2)
Oct 1 14:26:52 lanmaster xl2tpd[2332]: handle_packet: bad control packet!
Oct 1 14:26:52 lanmaster xl2tpd[2332]: result_code_avp: result code not appropriate for Incoming-Call-Request. Ignoring.
Oct 1 14:26:52 lanmaster xl2tpd[2332]: start_pppd: I'm running:
Oct 1 14:26:52 lanmaster xl2tpd[2332]: "/usr/sbin/pppd"
Oct 1 14:26:52 lanmaster xl2tpd[2332]: "passive"
Oct 1 14:26:52 lanmaster xl2tpd[2332]: "nodetach"
Oct 1 14:26:52 lanmaster xl2tpd[2332]: "192.168.101.26:192.168.101.200"
Oct 1 14:26:52 lanmaster xl2tpd[2332]: "file"
Oct 1 14:26:52 lanmaster xl2tpd[2332]: "/etc/ppp/options.xl2tpd"
Oct 1 14:26:52 lanmaster xl2tpd[2332]: "/dev/pts/4"
Oct 1 14:26:52 lanmaster xl2tpd[2332]: Call established with 151.44.6.95, Local: 64253, Remote: 1, Serial: 0
Oct 1 14:26:52 lanmaster pppd[2342]: pppd 2.4.5 started by administrator, uid 0
Oct 1 14:26:52 lanmaster pppd[2342]: using channel 4
Oct 1 14:26:52 lanmaster pppd[2342]: Using interface ppp0
Oct 1 14:26:52 lanmaster pppd[2342]: Connect: ppp0 <--> /dev/pts/4
Oct 1 14:26:52 lanmaster pppd[2342]: sent [LCP ConfReq id=0x1 <mru 1400> <asyncmap 0x0> <auth chap MS-v2> <magic 0x1bdc7d96> <pcomp> <accomp>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [LCP ConfReq id=0x0 <mru 1400> <magic 0x73850649> <pcomp> <accomp> <callback CBCP>]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [LCP ConfRej id=0x0 <callback CBCP>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [LCP ConfAck id=0x1 <mru 1400> <asyncmap 0x0> <auth chap MS-v2> <magic 0x1bdc7d96> <pcomp> <accomp>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [LCP ConfReq id=0x1 <mru 1400> <magic 0x73850649> <pcomp> <accomp>]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [LCP ConfAck id=0x1 <mru 1400> <magic 0x73850649> <pcomp> <accomp>]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [LCP EchoReq id=0x0 magic=0x1bdc7d96]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [CHAP Challenge id=0x18 <f7ec1620075266e102f103ddfb989f86>, name = "l2tpd"]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [LCP Ident id=0x2 magic=0x73850649 "MSRASV5.20"]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [LCP Ident id=0x3 magic=0x73850649 "MSRAS-0-LAPTOP-BBK"]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [LCP Ident id=0x4 magic=0x73850649 "\37777777626\023?\37777777630\37777777625mPH\37777777671\37777777643D\37777777765\37777777773\027\001\37777777612"]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [LCP EchoRep id=0x0 magic=0x73850649]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [CHAP Response id=0x18 <de5861c0f4009dc81e025457924a91a80000000000000000b2f777b87d2e6f9080658f8695a93ecdf7f76bea2d6ccf6800>, name = "francesco"]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [CHAP Success id=0x18 "S=469AE82D1A5BB2133DA584D684BA3DD3698DF8D1 M=Access granted"]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [CCP ConfReq id=0x1 <mppe +H -M +S -L -D -C>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [IPV6CP ConfReq id=0x5 <addr fe80::1014:1fd1:5e08:301a>]
Oct 1 14:26:52 lanmaster pppd[2342]: Unsupported protocol 'IPv6 Control Protocol' (0x8057) received
Oct 1 14:26:52 lanmaster pppd[2342]: sent [LCP ProtRej id=0x2 80 57 01 05 00 0e 01 0a 10 14 1f d1 5e 08 30 1a]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [CCP ConfReq id=0x6 <mppe +H -M -S -L -D -C>]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [CCP ConfNak id=0x6 <mppe +H -M +S -L -D -C>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [IPCP ConfReq id=0x7 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns2 0.0.0.0> <ms-wins 0.0.0.0>]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [IPCP TermAck id=0x7]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [CCP ConfAck id=0x1 <mppe +H -M +S -L -D -C>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [CCP ConfReq id=0x8 <mppe +H -M +S -L -D -C>]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [CCP ConfAck id=0x8 <mppe +H -M +S -L -D -C>]
Oct 1 14:26:52 lanmaster pppd[2342]: MPPE 128-bit stateless compression enabled
Oct 1 14:26:52 lanmaster pppd[2342]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.101.26>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
Oct 1 14:26:52 lanmaster pppd[2342]: sent [IPCP ConfReq id=0x2 <addr 192.168.101.26>]
Oct 1 14:26:52 lanmaster pppd[2342]: rcvd [IPCP ConfAck id=0x2 <addr 192.168.101.26>]
Oct 1 14:26:54 lanmaster pppd[2342]: rcvd [IPCP ConfReq id=0x9 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns2 0.0.0.0> <ms-wins 0.0.0.0>]
Oct 1 14:26:54 lanmaster pppd[2342]: sent [IPCP ConfRej id=0x9 <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns2 0.0.0.0> <ms-wins 0.0.0.0>]
Oct 1 14:26:54 lanmaster pppd[2342]: rcvd [IPCP ConfReq id=0xa <addr 0.0.0.0>]
Oct 1 14:26:54 lanmaster pppd[2342]: sent [IPCP ConfNak id=0xa <addr 192.168.101.200>]
Oct 1 14:26:54 lanmaster pppd[2342]: rcvd [IPCP ConfReq id=0xb <addr 192.168.101.200>]
Oct 1 14:26:54 lanmaster pppd[2342]: sent [IPCP ConfAck id=0xb <addr 192.168.101.200>]
Oct 1 14:26:54 lanmaster pppd[2342]: found interface eth0 for proxy arp
Oct 1 14:26:54 lanmaster pppd[2342]: local IP address 192.168.101.26
Oct 1 14:26:54 lanmaster pppd[2342]: remote IP address 192.168.101.200
Oct 1 14:26:54 lanmaster pppd[2342]: Script /etc/ppp/ip-up started (pid 2362)
Oct 1 14:26:54 lanmaster pppd[2342]: Script /etc/ppp/ip-up finished (pid 2362), status = 0x0
Oct 1 14:26:54 lanmaster dnsmasq-dhcp[1164]: DHCPINFORM(ppp0) 192.168.101.200 00:33:a9:52:3d:30:f0:34:40:bc:8e:63:24:56:ff:aa:1e
Oct 1 14:26:54 lanmaster dnsmasq-dhcp[1164]: DHCPACK(ppp0) 192.168.101.200 00:33:a9:52:3d:30:f0:34:40:bc:8e:63:24:56:ff:aa:1e laptop-bbk
[-- Attachment #5: ppp.xl2tpd --]
[-- Type: application/octet-stream, Size: 332 bytes --]
name l2tpd
auth
crtscts
hide-password
modem
#debug
#dump
proxyarp
nodefaultroute
refuse-pap
refuse-chap
refuse-mschap
require-mschap-v2
nobsdcomp
# The following dosn't work
require-mppe-128
#nomppe
lcp-echo-interval 30
lcp-echo-failure 4
# Tweak
#mtu 1280 # ipv6 minimum
#mru 1280
mtu 1400
mru 1400
^ permalink raw reply [flat|nested] 4+ messages in thread
* Re: PPP connection corruption with Windows client, MPPE, and RDP
2014-10-08 21:16 PPP connection corruption with Windows client, MPPE, and RDP Francesco Pretto
@ 2014-10-08 22:53 ` Michael Richardson
2014-10-09 0:10 ` Francesco Pretto
2014-10-09 14:20 ` Michael Richardson
2 siblings, 0 replies; 4+ messages in thread
From: Michael Richardson @ 2014-10-08 22:53 UTC (permalink / raw)
To: linux-ppp
Francesco Pretto <ceztko@gmail.com> wrote:
> I configured an IPsec-L2TP VPN on my work network. The VPN has both
> endpoints on natted networks: ipsec client/server are both NAT enabled
Sadly, I know too much about this stuff, since I forked l2tpd all those years ago.
> and routers are configured to properly forward IPSEC UPD ports and to
> passthrough VPN traffic. For some weeks it has worked reliably.
> Recently it stopped working properly with RDP (Remote Desktop Protocol)
> seeming to be the most effective trigger that leads the connection to a
> corrupted state.
Can you tcpdump on the pppX interfaces on both sides?
I suspect that RDP triggers it with a full-sized TCP packet.
> Enabling the full PPP debug, when the connection is corrupted the log
> begin to be spammed with plenty of warnings of spurious packets: Oct 1
> 14:18:55 lanmaster pppd[1977]: rcvd [proto=0xa1] 5f e4 25 5a 19 6b ad
> 6b b7 0d 60 f7 49 f8 47 f3 5d 87 73 97 12 b2 a7 63 54 21 05 35 43 6a 94
> 14 ... Oct 1 14:18:55 lanmaster pppd[1977]: Unsupported protocol 0xa1
In the world of async ppp, if you lose bytes, etc. the framing breaks and you
get lots of stuff like that. With sync ppp, that shouldn't happen.
I also point out that you can't get corruption from the wire, because the ESP
header will take care of that. Do you have appropriate
patches/things-enabled, so that the esp/l2tp/ppp packets all stay in the
kernel? If not, then you might also get some debug from xl2tp.
> ...] Oct 1 14:18:55 lanmaster pppd[1977]: rcvd
> [proto=0x36f4] 76 df 4c 41 50 1b ad 4 d 5d c6 2e fb c7 77 1d 6f ae b3
> 6c 55 db 2b 89 94 6c 7b e3 66 1d 2c d2 57 ... Oct 1 14:18:55 lanmaster
> This initially seemed to me an IPSEC problem but, after much
> troubleshooting, removing the ppp option "require-mppe-128" option and
> adding "nomppe", effectively disabling MPPE, resulted in a extremely
> reliable connection again.
MPPE and IPsec are not related. AFAIK, MPPE provides for encryption within
PPP. you would be double encrypting.
> client-server related: RDP it's just the trigger, after the whole
> connection TCP/IP connection is corrupted and must be reset; - It's not
Does other traffic continue to function?
Is one end Windows?
> I'm unable to say if updates on these packages triggered the problem.
> The workaround is effective for me as I don't need the PPP link to be
> encrypted but the configuration should be supported with MPPE enabled I
> offer my help to do further testing if someone notice there could be a
> problem in PPP (for example the MPPE state could be partially corrupted
> but PPP is unable to detect it). Also it may be useful for others that
> may have the same problem.
--
] Never tell me the odds! | ipv6 mesh networks [
] Michael Richardson, Sandelman Software Works | network architect [
] mcr@sandelman.ca http://www.sandelman.ca/ | ruby on rails [
^ permalink raw reply [flat|nested] 4+ messages in thread
* Re: PPP connection corruption with Windows client, MPPE, and RDP
2014-10-08 21:16 PPP connection corruption with Windows client, MPPE, and RDP Francesco Pretto
2014-10-08 22:53 ` Michael Richardson
@ 2014-10-09 0:10 ` Francesco Pretto
2014-10-09 14:20 ` Michael Richardson
2 siblings, 0 replies; 4+ messages in thread
From: Francesco Pretto @ 2014-10-09 0:10 UTC (permalink / raw)
To: linux-ppp
[-- Attachment #1: Type: text/plain, Size: 1851 bytes --]
2014-10-09 0:53 GMT+02:00 Michael Richardson <mcr@sandelman.ca>:
>I suspect that RDP triggers it with a full-sized TCP packet.
[...]
> Do you have appropriate
> patches/things-enabled, so that the esp/l2tp/ppp packets all stay in the
> kernel? If not, then you might also get some debug from xl2tp.
>
I am not sure what esp is. PPP and MPPE are in the kernel. xl2tpd log
says: This binary does not support kernel L2TP. So I guess l2tp
traffic is not in the kernel with my build. I enabled all xl2tpd debug
options and get some results that seems to confirm what you say about
the full-sized TCP packet. A whole connect/troubles/disconnect session
is logged. Troubles start at "Unsupported protocol..." lines. I don't
know how to sort, though.
Log is attached.
> Can you tcpdump on the pppX interfaces on both sides?
> I suspect that RDP triggers it with a full-sized TCP packet.
>
I can't now but I'll do it tomorrow if the provided xl2tpd debug isn't enough.
>
> > This initially seemed to me an IPSEC problem but, after much
> > troubleshooting, removing the ppp option "require-mppe-128" option and
> > adding "nomppe", effectively disabling MPPE, resulted in a extremely
> > reliable connection again.
>
> MPPE and IPsec are not related. AFAIK, MPPE provides for encryption within
> PPP. you would be double encrypting.
>
Yes, I knew. In fact I was more than satisfied with the reliability I
get with "nomppe". But maybe MS-CHAP v2 use MPPE for authentication
encryption? I don't know.
> > client-server related: RDP it's just the trigger, after the whole
> > connection TCP/IP connection is corrupted and must be reset; - It's not
>
> Does other traffic continue to function?
> Is one end Windows?
>
>
No, other traffic stops as well. VPN traffic is Windows-Windows.
ipsec-ppp-l2tp endpoints are Windows-Linux.
[-- Attachment #2: log-xl2tpd-pppd --]
[-- Type: application/octet-stream, Size: 46365 bytes --]
Oct 9 01:46:43 lanmaster xl2tpd[3884]: Enabling IPsec SAref processing for L2TP transport mode SAs
Oct 9 01:46:43 lanmaster xl2tpd[3884]: IPsec SAref does not work with L2TP kernel mode yet, enabling force userspace=yes
Oct 9 01:46:43 lanmaster xl2tpd[3884]: setsockopt recvref[30]: Protocol not available
Oct 9 01:46:43 lanmaster xl2tpd[3884]: This binary does not support kernel L2TP.
Oct 9 01:46:43 lanmaster xl2tpd[3885]: xl2tpd version xl2tpd-1.3.6 started on lanmaster PID:3885
Oct 9 01:46:43 lanmaster xl2tpd[3885]: Written by Mark Spencer, Copyright (C) 1998, Adtran, Inc.
Oct 9 01:46:43 lanmaster xl2tpd[3885]: Forked by Scott Balmos and David Stipp, (C) 2001
Oct 9 01:46:43 lanmaster xl2tpd[3885]: Inherited by Jeff McAdams, (C) 2002
Oct 9 01:46:43 lanmaster xl2tpd[3885]: Forked again by Xelerance (www.xelerance.com) (C) 2006
Oct 9 01:46:43 lanmaster xl2tpd[3885]: Listening on IP address 0.0.0.0, port 1701
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 103, tunnel = 0, call = 0 ref=0 refhim=0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: get_call: allocating new tunnel for host 151.46.15.96, port 1701.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: handle_avps: handling avp's for tunnel 9379, call 0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: message_type_avp: message type 1 (Start-Control-Connection-Request)
Oct 9 01:47:07 lanmaster xl2tpd[3885]: protocol_version_avp: peer is using version 1, revision 0.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: framing_caps_avp: supported peer frames: sync
Oct 9 01:47:07 lanmaster xl2tpd[3885]: bearer_caps_avp: supported peer bearers:
Oct 9 01:47:07 lanmaster xl2tpd[3885]: firmware_rev_avp: peer reports firmware version 1539 (0x0603)
Oct 9 01:47:07 lanmaster xl2tpd[3885]: hostname_avp: peer reports hostname 'laptop-bbk'
Oct 9 01:47:07 lanmaster xl2tpd[3885]: vendor_avp: peer reports vendor 'Microsoft'
Oct 9 01:47:07 lanmaster xl2tpd[3885]: assigned_tunnel_avp: using peer's tunnel 7
Oct 9 01:47:07 lanmaster xl2tpd[3885]: receive_window_size_avp: peer wants RWS of 8. Will use flow control.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: control_finish: message type is Start-Control-Connection-Request(1). Tunnel is 7, call is 0.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: control_finish: sending SCCRP
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 20, tunnel = 9379, call = 0 ref=0 refhim=0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: handle_avps: handling avp's for tunnel 9379, call 0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: message_type_avp: message type 3 (Start-Control-Connection-Connected)
Oct 9 01:47:07 lanmaster xl2tpd[3885]: control_finish: message type is Start-Control-Connection-Connected(3). Tunnel is 7, call is 0.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: Connection established to 151.46.15.96, 1701. Local: 9379, Remote: 7 (ref=0/0). LNS session is 'default'
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 12, tunnel = 9379, call = 0 ref=0 refhim=0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: check_control: Received out of order control packet on tunnel 7 (got 3, expected 2)
Oct 9 01:47:07 lanmaster xl2tpd[3885]: handle_packet: bad control packet!
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: bad packet
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 70, tunnel = 9379, call = 0 ref=0 refhim=0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: handle_avps: handling avp's for tunnel 9379, call 0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: message_type_avp: message type 10 (Incoming-Call-Request)
Oct 9 01:47:07 lanmaster xl2tpd[3885]: message_type_avp: new incoming call
Oct 9 01:47:07 lanmaster xl2tpd[3885]: assigned_call_avp: using peer's call 1
Oct 9 01:47:07 lanmaster xl2tpd[3885]: call_serno_avp: serial number is 0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: bearer_type_avp: peer bears: analog
Oct 9 01:47:07 lanmaster xl2tpd[3885]: result_code_avp: result code not appropriate for Incoming-Call-Request. Ignoring.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: control_finish: message type is Incoming-Call-Request(10). Tunnel is 7, call is 0.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: control_finish: Sending ICRP
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 48, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: handle_avps: handling avp's for tunnel 9379, call 63004
Oct 9 01:47:07 lanmaster xl2tpd[3885]: message_type_avp: message type 12 (Incoming-Call-Connected)
Oct 9 01:47:07 lanmaster xl2tpd[3885]: tx_speed_avp: transmit baud rate is 150000000
Oct 9 01:47:07 lanmaster xl2tpd[3885]: frame_type_avp: peer uses:sync frames
Oct 9 01:47:07 lanmaster xl2tpd[3885]: ignore_avp : Ignoring AVP
Oct 9 01:47:07 lanmaster xl2tpd[3885]: control_finish: message type is Incoming-Call-Connected(12). Tunnel is 7, call is 1.
Oct 9 01:47:07 lanmaster xl2tpd[3885]: start_pppd: I'm running:
Oct 9 01:47:07 lanmaster xl2tpd[3885]: "/usr/sbin/pppd"
Oct 9 01:47:07 lanmaster xl2tpd[3885]: "passive"
Oct 9 01:47:07 lanmaster xl2tpd[3885]: "nodetach"
Oct 9 01:47:07 lanmaster xl2tpd[3885]: "192.168.101.26:192.168.101.200"
Oct 9 01:47:07 lanmaster xl2tpd[3885]: "file"
Oct 9 01:47:07 lanmaster xl2tpd[3885]: "/etc/ppp/options.xl2tpd"
Oct 9 01:47:07 lanmaster xl2tpd[3885]: "/dev/pts/4"
Oct 9 01:47:07 lanmaster xl2tpd[3885]: Call established with 151.46.15.96, Local: 63004, Remote: 1, Serial: 0
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 60, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:07 lanmaster pppd[3900]: pppd 2.4.5 started by administrator, uid 0
Oct 9 01:47:07 lanmaster pppd[3900]: using channel 4
Oct 9 01:47:07 lanmaster pppd[3900]: Using interface ppp0
Oct 9 01:47:07 lanmaster pppd[3900]: Connect: ppp0 <--> /dev/pts/4
Oct 9 01:47:07 lanmaster pppd[3900]: sent [LCP ConfReq id=0x1 <mru 1400> <asyncmap 0x0> <auth chap MS-v2> <magic 0x7d89ee94> <pcomp> <accomp>]
Oct 9 01:47:07 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 41, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:07 lanmaster pppd[3900]: rcvd [LCP ConfAck id=0x1 <mru 1400> <asyncmap 0x0> <auth chap MS-v2> <magic 0x7d89ee94> <pcomp> <accomp>]
Oct 9 01:47:08 lanmaster xl2tpd[3885]: network_thread: select timeout
Oct 9 01:47:08 lanmaster xl2tpd[3885]: network_thread: select timeout
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 60, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [LCP ConfReq id=0x1 <mru 1400> <magic 0x3d2a283c> <pcomp> <accomp> <callback CBCP> <mrru 1614> <endpoint [local:b1.23.7d.2b.b4.1d.49.da.b2.a8.31.4b.08.cb.b3.7f.00.00.00.06]>]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [LCP ConfRej id=0x1 <callback CBCP> <mrru 1614>]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 53, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [LCP ConfReq id=0x2 <mru 1400> <magic 0x3d2a283c> <pcomp> <accomp> <endpoint [local:b1.23.7d.2b.b4.1d.49.da.b2.a8.31.4b.08.cb.b3.7f.00.00.00.06]>]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [LCP ConfAck id=0x2 <mru 1400> <magic 0x3d2a283c> <pcomp> <accomp> <endpoint [local:b1.23.7d.2b.b4.1d.49.da.b2.a8.31.4b.08.cb.b3.7f.00.00.00.06]>]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [LCP EchoReq id=0x0 magic=0x7d89ee94]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [CHAP Challenge id=0xf1 <c5b66d6af8e8cdc673ede97821983a1c>, name = "l2tpd"]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 28, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [LCP Ident id=0x3 magic=0x3d2a283c "MSRASV5.20"]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 36, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [LCP Ident id=0x4 magic=0x3d2a283c "MSRAS-0-LAPTOP-BBK"]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 34, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [LCP Ident id=0x5 magic=0x3d2a283c "+\026roGzQA\37777777671\037n!W\37777777666\37777777656\37777777763"]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 18, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [LCP EchoRep id=0x0 magic=0x3d2a283c]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [CHAP Response id=0xf1 <b7b28300f94503582c98d6673d29e86300000000000000008f15090d0cb7879ca76f8621ce48b53fbeeafdafcd0ceedd00>, name = "francesco"]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [CHAP Success id=0xf1 "S=D2999FA3ADB15A4A3F93397B86161CE2117E990E M=Access granted"]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [CCP ConfReq id=0x1 <mppe +H -M +S -L -D -C>]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 24, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [IPV6CP ConfReq id=0x6 <addr fe80::70f1:5385:11b1:b274>]
Oct 9 01:47:09 lanmaster pppd[3900]: Unsupported protocol 'IPv6 Control Protocol' (0x8057) received
Oct 9 01:47:09 lanmaster pppd[3900]: sent [LCP ProtRej id=0x2 80 57 01 06 00 0e 01 0a 70 f1 53 85 11 b1 b2 74]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 20, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [CCP ConfReq id=0x7 <mppe +H -M -S -L -D -C>]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [CCP ConfNak id=0x7 <mppe +H -M +S -L -D -C>]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 44, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [IPCP ConfReq id=0x8 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns2 0.0.0.0> <ms-wins 0.0.0.0>]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [IPCP TermAck id=0x8]
Oct 9 01:47:09 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 20, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [CCP ConfAck id=0x1 <mppe +H -M +S -L -D -C>]
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [CCP ConfReq id=0x9 <mppe +H -M +S -L -D -C>]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [CCP ConfAck id=0x9 <mppe +H -M +S -L -D -C>]
Oct 9 01:47:09 lanmaster pppd[3900]: MPPE 128-bit stateless compression enabled
Oct 9 01:47:09 lanmaster pppd[3900]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.101.26>]
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
Oct 9 01:47:09 lanmaster pppd[3900]: sent [IPCP ConfReq id=0x2 <addr 192.168.101.26>]
Oct 9 01:47:09 lanmaster pppd[3900]: rcvd [IPCP ConfAck id=0x2 <addr 192.168.101.26>]
Oct 9 01:47:10 lanmaster dnsmasq-dhcp[1126]: DHCPREQUEST(eth0) 192.168.101.123 7c:05:07:0f:fa:91
Oct 9 01:47:10 lanmaster dnsmasq-dhcp[1126]: DHCPACK(eth0) 192.168.101.123 7c:05:07:0f:fa:91 Matteo-PC-ITR
Oct 9 01:47:09 lanmaster xl2tpd[3885]: message repeated 3 times: [ network_thread: recv packet from 151.46.15.96, size = 20, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 44, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster pppd[3900]: rcvd [IPCP ConfReq id=0xa <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns2 0.0.0.0> <ms-wins 0.0.0.0>]
Oct 9 01:47:12 lanmaster pppd[3900]: sent [IPCP ConfRej id=0xa <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns2 0.0.0.0> <ms-wins 0.0.0.0>]
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 20, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster pppd[3900]: rcvd [IPCP ConfReq id=0xb <addr 0.0.0.0>]
Oct 9 01:47:12 lanmaster pppd[3900]: sent [IPCP ConfNak id=0xb <addr 192.168.101.200>]
Oct 9 01:47:12 lanmaster pppd[3900]: rcvd [IPCP ConfReq id=0xc <addr 192.168.101.200>]
Oct 9 01:47:12 lanmaster pppd[3900]: sent [IPCP ConfAck id=0xc <addr 192.168.101.200>]
Oct 9 01:47:12 lanmaster pppd[3900]: found interface eth0 for proxy arp
Oct 9 01:47:12 lanmaster pppd[3900]: local IP address 192.168.101.26
Oct 9 01:47:12 lanmaster pppd[3900]: remote IP address 192.168.101.200
Oct 9 01:47:12 lanmaster pppd[3900]: Script /etc/ppp/ip-up started (pid 3920)
Oct 9 01:47:12 lanmaster pppd[3900]: Script /etc/ppp/ip-up finished (pid 3920), status = 0x0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 20, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 53, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 78, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 80, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 341, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster dnsmasq-dhcp[1126]: DHCPINFORM(ppp0) 192.168.101.200 00:33:a9:52:3d:30:f0:34:40:bc:8e:63:24:56:ff:aa:1e
Oct 9 01:47:12 lanmaster dnsmasq-dhcp[1126]: DHCPACK(ppp0) 192.168.101.200 00:33:a9:52:3d:30:f0:34:40:bc:8e:63:24:56:ff:aa:1e laptop-bbk
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 53, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 94, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: message repeated 2 times: [ network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: message repeated 8 times: [ network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 94, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: message repeated 8 times: [ network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 138, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 61, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:12 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 164, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: message repeated 4 times: [ network_thread: recv packet from 151.46.15.96, size = 164, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 68, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: message repeated 8 times: [ network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 86, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 83, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 81, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:13 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:14 lanmaster xl2tpd[3885]: message repeated 5 times: [ network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:14 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 75, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:14 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 82, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:14 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:14 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:14 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:14 lanmaster pppd[3900]: rcvd [proto=0x97] bf ed 81 9d de ba 2f 81 0f 0d 93 b4 fd 6f f9 ae 3e e5 fb 7a 6f d5 7c 8e 19 d8 bc f0 de 91 74 06 ...
Oct 9 01:47:14 lanmaster pppd[3900]: Unsupported protocol 0x97 received
Oct 9 01:47:14 lanmaster pppd[3900]: sent [LCP ProtRej id=0x3 00 97 bf ed 81 9d de ba 2f 81 0f 0d 93 b4 fd 6f f9 ae 3e e5 fb 7a 6f d5 7c 8e 19 d8 bc f0 de 91 ...]
Oct 9 01:47:14 lanmaster pppd[3900]: rcvd [proto=0x6d] d6 b9 d4 58 bb d4 8c b1 d6 2c a5 08 1a 69 b8 21 28 8e e4 96 d2 1a a5 e6 68 64 a2 65 1e f2 18 f0 ...
Oct 9 01:47:14 lanmaster pppd[3900]: Unsupported protocol 0x6d received
Oct 9 01:47:14 lanmaster pppd[3900]: sent [LCP ProtRej id=0x4 00 6d d6 b9 d4 58 bb d4 8c b1 d6 2c a5 08 1a 69 b8 21 28 8e e4 96 d2 1a a5 e6 68 64 a2 65 1e f2 ...]
Oct 9 01:47:14 lanmaster pppd[3900]: rcvd [proto=0x69] 6e cb a0 fd 02 22 ad 26 f3 fc e5 18 c2 b3 3b d7 51 83 e0 b3 d1 bf c5 7d ce 79 51 b1 f7 b4 89 38 ...
Oct 9 01:47:14 lanmaster pppd[3900]: Unsupported protocol 'RTP IPHC Compressed RTP 8' (0x69) received
Oct 9 01:47:14 lanmaster pppd[3900]: sent [LCP ProtRej id=0x5 00 69 6e cb a0 fd 02 22 ad 26 f3 fc e5 18 c2 b3 3b d7 51 83 e0 b3 d1 bf c5 7d ce 79 51 b1 f7 b4 ...]
Oct 9 01:47:14 lanmaster pppd[3900]: rcvd [proto=0x8ae] fc 30 72 46 6b 51 43 f1 d1 02 ca bd c8 68 4c d2 d6 bf c2 29 71 ef 67 d3 e4 70 b6 96 75 18 76 37 ...
Oct 9 01:47:14 lanmaster pppd[3900]: Unsupported protocol 0x8ae received
Oct 9 01:47:14 lanmaster pppd[3900]: sent [LCP ProtRej id=0x6 08 ae fc 30 72 46 6b 51 43 f1 d1 02 ca bd c8 68 4c d2 d6 bf c2 29 71 ef 67 d3 e4 70 b6 96 75 18 ...]
Oct 9 01:47:14 lanmaster xl2tpd[3885]: message repeated 11 times: [ network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:15 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:15 lanmaster pppd[3900]: rcvd [proto=0x3] 5f c7 57 ee 7c 93 60 18 c6 78 5b ca 95 83 e4 52 61 99 ab 0b 7f 17 c8 87 6c d4 5c 09 fe ee 66 6e ...
Oct 9 01:47:15 lanmaster pppd[3900]: Unsupported protocol 0x3 received
Oct 9 01:47:15 lanmaster pppd[3900]: sent [LCP ProtRej id=0x7 00 03 5f c7 57 ee 7c 93 60 18 c6 78 5b ca 95 83 e4 52 61 99 ab 0b 7f 17 c8 87 6c d4 5c 09 fe ee ...]
Oct 9 01:47:15 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:15 lanmaster pppd[3900]: rcvd [proto=0xc7] 4d 07 b2 59 4c a8 0b 83 8b fd 2f fc 0c 2a 81 34 bb d4 5e 37 a1 12 c4 36 0d 0c bd ab 3e d5 51 fd ...
Oct 9 01:47:15 lanmaster pppd[3900]: Unsupported protocol 0xc7 received
Oct 9 01:47:15 lanmaster pppd[3900]: sent [LCP ProtRej id=0x8 00 c7 4d 07 b2 59 4c a8 0b 83 8b fd 2f fc 0c 2a 81 34 bb d4 5e 37 a1 12 c4 36 0d 0c bd ab 3e d5 ...]
Oct 9 01:47:15 lanmaster pppd[3900]: rcvd [proto=0x9438] 06 c9 ec e0 c7 1b 0b 4a bf f8 7a 44 d6 72 2a 7b 1b f4 cc 74 54 d6 6d f6 62 32 52 a0 78 9b c7 b8 ...
Oct 9 01:47:15 lanmaster pppd[3900]: Unsupported protocol 0x9438 received
Oct 9 01:47:15 lanmaster pppd[3900]: sent [LCP ProtRej id=0x9 94 38 06 c9 ec e0 c7 1b 0b 4a bf f8 7a 44 d6 72 2a 7b 1b f4 cc 74 54 d6 6d f6 62 32 52 a0 78 9b ...]
Oct 9 01:47:15 lanmaster pppd[3900]: rcvd [proto=0x33] 99 dc 07 b6 9d f8 e0 7c 43 2a 63 95 69 00 16 d3 c7 0e e1 49 ca 72 d2 5a 2a 8b cf 18 f8 1d 42 d9 ...
Oct 9 01:47:15 lanmaster pppd[3900]: Unsupported protocol 'Stream Protocol ST-II' (0x33) received
Oct 9 01:47:15 lanmaster pppd[3900]: sent [LCP ProtRej id=0xa 00 33 99 dc 07 b6 9d f8 e0 7c 43 2a 63 95 69 00 16 d3 c7 0e e1 49 ca 72 d2 5a 2a 8b cf 18 f8 1d ...]
Oct 9 01:47:15 lanmaster pppd[3900]: rcvd [proto=0x31] 20 0f 2a 41 5f 40 9a 14 fc 75 68 4c f5 ce 35 3e f9 26 ec f4 ce 27 9f d9 b7 c8 3e 58 3c b8 0e 25 ...
Oct 9 01:47:15 lanmaster pppd[3900]: Unsupported protocol 'Bridging PDU' (0x31) received
Oct 9 01:47:15 lanmaster pppd[3900]: sent [LCP ProtRej id=0xb 00 31 20 0f 2a 41 5f 40 9a 14 fc 75 68 4c f5 ce 35 3e f9 26 ec f4 ce 27 9f d9 b7 c8 3e 58 3c b8 ...]
Oct 9 01:47:15 lanmaster xl2tpd[3885]: message repeated 3 times: [ network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:15 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:15 lanmaster pppd[3900]: rcvd [proto=0xf9] 07 40 db 5d d1 96 5c 6e ad 26 47 13 84 27 e1 6e 25 c5 6c b6 52 f9 8c 84 ba b0 23 09 77 e3 bd e7 ...
Oct 9 01:47:15 lanmaster pppd[3900]: Unsupported protocol 0xf9 received
Oct 9 01:47:15 lanmaster pppd[3900]: sent [LCP ProtRej id=0xc 00 f9 07 40 db 5d d1 96 5c 6e ad 26 47 13 84 27 e1 6e 25 c5 6c b6 52 f9 8c 84 ba b0 23 09 77 e3 ...]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0xa5] ea 27 df fd 8d 75 ad a9 37 9a 30 31 3b 81 71 eb 45 84 c1 83 4d 70 cc f2 b4 b6 ea 0f 14 a4 fb 00 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0xa5 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0xd 00 a5 ea 27 df fd 8d 75 ad a9 37 9a 30 31 3b 81 71 eb 45 84 c1 83 4d 70 cc f2 b4 b6 ea 0f 14 a4 ...]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 138, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x66b0] 62 9e 05 0c 34 a2 57 01 11 95 cf c0 4a 87 da 8e 4e 42 20 fc d3 8c bf a6 e4 5f c3 b6 bd 98 2b a9 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0x66b0 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0xe 66 b0 62 9e 05 0c 34 a2 57 01 11 95 cf c0 4a 87 da 8e 4e 42 20 fc d3 8c bf a6 e4 5f c3 b6 bd 98 ...]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 164, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x58d9] b7 95 1b fa 58 17 58 81 05 88 ca ea 2d 67 06 9f 1b 37 4e 4a d7 12 f1 8a 14 1b 04 08 51 33 f7 d2 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0x58d9 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0xf 58 d9 b7 95 1b fa 58 17 58 81 05 88 ca ea 2d 67 06 9f 1b 37 4e 4a d7 12 f1 8a 14 1b 04 08 51 33 ...]
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x4b] d9 8c c6 40 2e 4c 3b 69 ad 89 67 8f cb 24 de 14 4e 95 5c 58 61 9d e7 e7 5d e8 42 6b 37 dd 28 89 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 'SNA over 802.2' (0x4b) received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0x10 00 4b d9 8c c6 40 2e 4c 3b 69 ad 89 67 8f cb 24 de 14 4e 95 5c 58 61 9d e7 e7 5d e8 42 6b 37 dd ...]
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x75] 15 cb cc 84 90 85 37 6b f1 57 d7 94 7f 96 17 4c 80 99 1a 6c 27 3f 3c e9 5d aa 08 41 3b 84 64 80 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0x75 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0x11 00 75 15 cb cc 84 90 85 37 6b f1 57 d7 94 7f 96 17 4c 80 99 1a 6c 27 3f 3c e9 5d aa 08 41 3b 84 ...]
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0xcee4] 01 b0 e6 22 4f e3 db d7 ea 51 8b e4 49 53 18 f3 90 74 f6 4e 3c 16 53 12 c9 53 ac 9e 16 da d0 a6 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0xcee4 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0x12 ce e4 01 b0 e6 22 4f e3 db d7 ea 51 8b e4 49 53 18 f3 90 74 f6 4e 3c 16 53 12 c9 53 ac 9e 16 da ...]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: message repeated 3 times: [ network_thread: recv packet from 151.46.15.96, size = 164, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 82, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x1667] d9 39 bf 0e b8 12 18 db 5a 84 65 42 31 8c ab 26 5f 40 e5 5a f3 85 f9 c4 2b 5d ca 2a e9 3f 22 f2 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0x1667 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0x13 16 67 d9 39 bf 0e b8 12 18 db 5a 84 65 42 31 8c ab 26 5f 40 e5 5a f3 85 f9 c4 2b 5d ca 2a e9 3f ...]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 164, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x92a7] 00 0c 50 28 a1 c1 61 f0 44 51 74 4b a5 af 71 c5 5f 5d cb 50 e2 af a0 01 e8 9f 2e 09 94 03 c0 e4 ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0x92a7 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0x14 92 a7 00 0c 50 28 a1 c1 61 f0 44 51 74 4b a5 af 71 c5 5f 5d cb 50 e2 af a0 01 e8 9f 2e 09 94 03 ...]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x8879] db 8f de 9b e7 ec 52 12 0e e1 3b de e5 31 bf 3f 47 a7 74 69 ab 60 b4 15 15 ac 53 a6 e3 f6 3c 3d ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0x8879 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0x15 88 79 db 8f de 9b e7 ec 52 12 0e e1 3b de e5 31 bf 3f 47 a7 74 69 ab 60 b4 15 15 ac 53 a6 e3 f6 ...]
Oct 9 01:47:16 lanmaster pppd[3900]: rcvd [proto=0x85] e9 51 93 43 0f 81 af 22 9d 73 65 83 c8 37 42 5e 6f d3 f4 b7 eb 8b ed 97 35 11 47 f4 fb 6a 56 dd ...
Oct 9 01:47:16 lanmaster pppd[3900]: Unsupported protocol 0x85 received
Oct 9 01:47:16 lanmaster pppd[3900]: sent [LCP ProtRej id=0x16 00 85 e9 51 93 43 0f 81 af 22 9d 73 65 83 c8 37 42 5e 6f d3 f4 b7 eb 8b ed 97 35 11 47 f4 fb 6a ...]
Oct 9 01:47:16 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:17 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:17 lanmaster pppd[3900]: rcvd [proto=0x4f] 47 14 cb 02 2a 06 af 46 3d 09 37 46 3b 4e 53 bd 03 67 42 e7 72 d7 ac 21 0f e8 e4 c7 b1 21 e5 3b ...
Oct 9 01:47:17 lanmaster pppd[3900]: Unsupported protocol 'IP6 Header Compression' (0x4f) received
Oct 9 01:47:17 lanmaster pppd[3900]: sent [LCP ProtRej id=0x17 00 4f 47 14 cb 02 2a 06 af 46 3d 09 37 46 3b 4e 53 bd 03 67 42 e7 72 d7 ac 21 0f e8 e4 c7 b1 21 ...]
Oct 9 01:47:17 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 82, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:17 lanmaster pppd[3900]: rcvd [proto=0x71] 05 18 49 c6 c5 c8 21 a3 45 46 54 05 d3 f8 70 12 e4 64 31 73 28 6b 00 96 3e 9f 50 8b 47 16 5e 9a ...
Oct 9 01:47:17 lanmaster pppd[3900]: Unsupported protocol 0x71 received
Oct 9 01:47:17 lanmaster pppd[3900]: sent [LCP ProtRej id=0x18 00 71 05 18 49 c6 c5 c8 21 a3 45 46 54 05 d3 f8 70 12 e4 64 31 73 28 6b 00 96 3e 9f 50 8b 47 16 ...]
Oct 9 01:47:17 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:17 lanmaster pppd[3900]: rcvd [proto=0x48ff] 20 22 fd 36 89 92 c1 01 7d 9e 8f e8 80 75 90 d4 a3 6a 92 f2 77 a2 9e 63 51 6d 38 c3 22 39 9e 56 ...
Oct 9 01:47:17 lanmaster pppd[3900]: Unsupported protocol 0x48ff received
Oct 9 01:47:17 lanmaster pppd[3900]: sent [LCP ProtRej id=0x19 48 ff 20 22 fd 36 89 92 c1 01 7d 9e 8f e8 80 75 90 d4 a3 6a 92 f2 77 a2 9e 63 51 6d 38 c3 22 39 ...]
Oct 9 01:47:17 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:17 lanmaster pppd[3900]: rcvd [proto=0x27] f1 29 2b 7c d5 13 a1 c6 b2 91 78 f6 c0 de 70 5c a0 31 34 c0 7f 0b d8 72 c4 d3 dd 29 86 e5 b0 05 ...
Oct 9 01:47:17 lanmaster pppd[3900]: Unsupported protocol 'DECnet Phase IV' (0x27) received
Oct 9 01:47:17 lanmaster pppd[3900]: sent [LCP ProtRej id=0x1a 00 27 f1 29 2b 7c d5 13 a1 c6 b2 91 78 f6 c0 de 70 5c a0 31 34 c0 7f 0b d8 72 c4 d3 dd 29 86 e5 ...]
Oct 9 01:47:18 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:18 lanmaster pppd[3900]: rcvd [proto=0xb2df] 00 17 83 93 f4 69 f1 72 bf 7c d5 3f 37 37 a7 96 25 b5 09 51 34 98 4f 3e 34 2f 8e a0 ff e9 b0 5a ...
Oct 9 01:47:18 lanmaster pppd[3900]: Unsupported protocol 0xb2df received
Oct 9 01:47:18 lanmaster pppd[3900]: sent [LCP ProtRej id=0x1b b2 df 00 17 83 93 f4 69 f1 72 bf 7c d5 3f 37 37 a7 96 25 b5 09 51 34 98 4f 3e 34 2f 8e a0 ff e9 ...]
Oct 9 01:47:18 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:18 lanmaster pppd[3900]: rcvd [proto=0xb9] 37 27 40 d1 bc 83 e0 f3 94 71 f5 d0 24 ab 47 b9 9f 4a 34 d8 3b 1c 79 d2 b2 a8 a1 89 e0 4f 53 86 ...
Oct 9 01:47:18 lanmaster pppd[3900]: Unsupported protocol 0xb9 received
Oct 9 01:47:18 lanmaster pppd[3900]: sent [LCP ProtRej id=0x1c 00 b9 37 27 40 d1 bc 83 e0 f3 94 71 f5 d0 24 ab 47 b9 9f 4a 34 d8 3b 1c 79 d2 b2 a8 a1 89 e0 4f ...]
Oct 9 01:47:18 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:18 lanmaster pppd[3900]: rcvd [proto=0x27] 33 cb bf 71 3e f8 03 71 45 c2 18 48 b0 be 90 e6 cb 43 3d 7e 28 11 4c fb 0c 05 6b 72 5d a6 7f 60 ...
Oct 9 01:47:18 lanmaster pppd[3900]: Unsupported protocol 'DECnet Phase IV' (0x27) received
Oct 9 01:47:18 lanmaster pppd[3900]: sent [LCP ProtRej id=0x1d 00 27 33 cb bf 71 3e f8 03 71 45 c2 18 48 b0 be 90 e6 cb 43 3d 7e 28 11 4c fb 0c 05 6b 72 5d a6 ...]
Oct 9 01:47:19 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 82, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:19 lanmaster pppd[3900]: rcvd [proto=0xc86e] b9 25 3b 25 fa 5a 67 06 13 b5 23 5b d9 a0 45 9d f9 64 ff 2f af d3 83 c4 1a c2 04 40 88 47 ac c7 ...
Oct 9 01:47:19 lanmaster pppd[3900]: Unsupported protocol 0xc86e received
Oct 9 01:47:19 lanmaster pppd[3900]: sent [LCP ProtRej id=0x1e c8 6e b9 25 3b 25 fa 5a 67 06 13 b5 23 5b d9 a0 45 9d f9 64 ff 2f af d3 83 c4 1a c2 04 40 88 47 ...]
Oct 9 01:47:19 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 109, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:19 lanmaster pppd[3900]: rcvd [proto=0x821] e4 5d 7d 32 0d d3 67 50 a6 47 07 db 86 44 4d 74 6f ce b8 66 bb d1 94 fc ba c3 83 52 90 73 9b 41 ...
Oct 9 01:47:19 lanmaster pppd[3900]: Unsupported protocol 0x821 received
Oct 9 01:47:19 lanmaster pppd[3900]: sent [LCP ProtRej id=0x1f 08 21 e4 5d 7d 32 0d d3 67 50 a6 47 07 db 86 44 4d 74 6f ce b8 66 bb d1 94 fc ba c3 83 52 90 73 ...]
Oct 9 01:47:19 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:19 lanmaster pppd[3900]: rcvd [proto=0x62c4] c0 08 67 87 da 7f 1c 3e df 8f 0e 57 fe 21 89 d3 f6 81 5d 7f 01 8f 88 6d 10 1a 6a b0 ec 2f 6e ab ...
Oct 9 01:47:19 lanmaster pppd[3900]: Unsupported protocol 0x62c4 received
Oct 9 01:47:19 lanmaster pppd[3900]: sent [LCP ProtRej id=0x20 62 c4 c0 08 67 87 da 7f 1c 3e df 8f 0e 57 fe 21 89 d3 f6 81 5d 7f 01 8f 88 6d 10 1a 6a b0 ec 2f ...]
Oct 9 01:47:20 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:20 lanmaster pppd[3900]: rcvd [proto=0xb224] 54 74 f9 97 fd 15 f5 35 2a 9e 5f a5 c0 a2 79 ac 14 ac 10 4c e4 a6 7b 30 ba e5 e1 4f 56 4a fa 46 ...
Oct 9 01:47:20 lanmaster pppd[3900]: Unsupported protocol 0xb224 received
Oct 9 01:47:20 lanmaster pppd[3900]: sent [LCP ProtRej id=0x21 b2 24 54 74 f9 97 fd 15 f5 35 2a 9e 5f a5 c0 a2 79 ac 14 ac 10 4c e4 a6 7b 30 ba e5 e1 4f 56 4a ...]
Oct 9 01:47:20 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:20 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:20 lanmaster pppd[3900]: rcvd [proto=0xe6a8] 47 1b 13 7e 9e ca 08 2d df ab 6e 98 6d 5f db ef 1e b8 1a 81 39 b0 4d 96 39 4e 84 e6 97 1c 77 f6 ...
Oct 9 01:47:20 lanmaster pppd[3900]: Unsupported protocol 0xe6a8 received
Oct 9 01:47:20 lanmaster pppd[3900]: sent [LCP ProtRej id=0x22 e6 a8 47 1b 13 7e 9e ca 08 2d df ab 6e 98 6d 5f db ef 1e b8 1a 81 39 b0 4d 96 39 4e 84 e6 97 1c ...]
Oct 9 01:47:21 lanmaster pppd[3900]: rcvd [proto=0xfb] 7e c1 8d ff e9 72 55 bc 9b fb 89 94 97 67 cd 4b 40 ac d7 61 65 5c 18 f3 4e 76 97 42 bb d2 c0 75 ...
Oct 9 01:47:21 lanmaster pppd[3900]: Unsupported protocol 'single-link compression' (0xfb) received
Oct 9 01:47:21 lanmaster pppd[3900]: sent [LCP ProtRej id=0x23 00 fb 7e c1 8d ff e9 72 55 bc 9b fb 89 94 97 67 cd 4b 40 ac d7 61 65 5c 18 f3 4e 76 97 42 bb d2 ...]
Oct 9 01:47:23 lanmaster pppd[3900]: rcvd [proto=0xbecb] 4b 6b 49 2d 9d 43 e2 af 0c 03 88 52 3e 90 8a df ca a2 5c b1 7e 58 2f e3 4b cc f2 ae 22 1f 3c 3d ...
Oct 9 01:47:23 lanmaster pppd[3900]: Unsupported protocol 0xbecb received
Oct 9 01:47:23 lanmaster pppd[3900]: sent [LCP ProtRej id=0x24 be cb 4b 6b 49 2d 9d 43 e2 af 0c 03 88 52 3e 90 8a df ca a2 5c b1 7e 58 2f e3 4b cc f2 ae 22 1f ...]
Oct 9 01:47:23 lanmaster xl2tpd[3885]: message repeated 2 times: [ network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0]
Oct 9 01:47:23 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 75, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:23 lanmaster pppd[3900]: rcvd [proto=0xaa3e] 55 65 02 ea 01 71 e9 94 40 79 f6 ed 5b 72 03 b6 62 b5 88 8c 90 de 52 0b e6 a7 47 39 08 3d 7c 4a ...
Oct 9 01:47:23 lanmaster pppd[3900]: Unsupported protocol 0xaa3e received
Oct 9 01:47:23 lanmaster pppd[3900]: sent [LCP ProtRej id=0x25 aa 3e 55 65 02 ea 01 71 e9 94 40 79 f6 ed 5b 72 03 b6 62 b5 88 8c 90 de 52 0b e6 a7 47 39 08 3d ...]
Oct 9 01:47:23 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:23 lanmaster pppd[3900]: rcvd [proto=0xbf] 0e 05 c8 59 b4 a3 94 ed 65 42 30 d4 bf fe 2d 6c e0 5b d4 1e 46 72 41 1b 95 47 d1 9e 6c 8b 72 3f ...
Oct 9 01:47:23 lanmaster pppd[3900]: Unsupported protocol 0xbf received
Oct 9 01:47:23 lanmaster pppd[3900]: sent [LCP ProtRej id=0x26 00 bf 0e 05 c8 59 b4 a3 94 ed 65 42 30 d4 bf fe 2d 6c e0 5b d4 1e 46 72 41 1b 95 47 d1 9e 6c 8b ...]
Oct 9 01:47:24 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:24 lanmaster pppd[3900]: rcvd [proto=0xb4ae] 55 06 3a d3 76 b9 4b a9 75 82 3e c6 39 05 03 b7 93 d6 d1 05 80 13 d1 1d 7d 52 63 1f 69 f6 32 12 ...
Oct 9 01:47:24 lanmaster pppd[3900]: Unsupported protocol 0xb4ae received
Oct 9 01:47:24 lanmaster pppd[3900]: sent [LCP ProtRej id=0x27 b4 ae 55 06 3a d3 76 b9 4b a9 75 82 3e c6 39 05 03 b7 93 d6 d1 05 80 13 d1 1d 7d 52 63 1f 69 f6 ...]
Oct 9 01:47:24 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 75, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:24 lanmaster pppd[3900]: rcvd [proto=0x9f] e8 aa c2 58 20 4d 20 7d ce 9d b1 37 f5 10 be e9 45 92 a6 56 bd 20 a1 46 83 c7 db 9d 08 1c d2 a1 ...
Oct 9 01:47:24 lanmaster pppd[3900]: Unsupported protocol 0x9f received
Oct 9 01:47:24 lanmaster pppd[3900]: sent [LCP ProtRej id=0x28 00 9f e8 aa c2 58 20 4d 20 7d ce 9d b1 37 f5 10 be e9 45 92 a6 56 bd 20 a1 46 83 c7 db 9d 08 1c ...]
Oct 9 01:47:24 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 91, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:24 lanmaster pppd[3900]: rcvd [proto=0xe2f] 13 fe d1 d7 22 b4 06 76 07 4f 59 f3 89 18 38 f3 fd f0 33 e2 05 32 97 88 36 23 73 6d 5d 44 0a 74 ...
Oct 9 01:47:24 lanmaster pppd[3900]: Unsupported protocol 0xe2f received
Oct 9 01:47:24 lanmaster pppd[3900]: sent [LCP ProtRej id=0x29 0e 2f 13 fe d1 d7 22 b4 06 76 07 4f 59 f3 89 18 38 f3 fd f0 33 e2 05 32 97 88 36 23 73 6d 5d 44 ...]
Oct 9 01:47:24 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:24 lanmaster pppd[3900]: rcvd [proto=0xdc47] 06 69 b8 41 d3 06 c6 56 cd fe d7 2b 3a fe 96 29 b2 76 30 e3 a4 0f d6 86 9f 03 b9 0d db e7 62 4f ...
Oct 9 01:47:24 lanmaster pppd[3900]: Unsupported protocol 0xdc47 received
Oct 9 01:47:24 lanmaster pppd[3900]: sent [LCP ProtRej id=0x2a dc 47 06 69 b8 41 d3 06 c6 56 cd fe d7 2b 3a fe 96 29 b2 76 30 e3 a4 0f d6 86 9f 03 b9 0d db e7 ...]
Oct 9 01:47:26 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 75, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:26 lanmaster pppd[3900]: rcvd [proto=0x7669] 17 07 d7 c4 aa 6e 37 cc d2 d6 e8 09 28 77 4f 08 15 4f 52 87 12 68 cb 0d f6 ab 3b 92 04 87 f6 b3 ...
Oct 9 01:47:26 lanmaster pppd[3900]: Unsupported protocol 0x7669 received
Oct 9 01:47:26 lanmaster pppd[3900]: sent [LCP ProtRej id=0x2b 76 69 17 07 d7 c4 aa 6e 37 cc d2 d6 e8 09 28 77 4f 08 15 4f 52 87 12 68 cb 0d f6 ab 3b 92 04 87 ...]
Oct 9 01:47:27 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 80, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:27 lanmaster pppd[3900]: rcvd [proto=0x5292] ee e6 2e c2 a9 0a b8 e3 8c 86 66 05 a1 1b d7 e3 9e 7a 4e 91 1c 29 0f 4b f2 1d 43 79 79 92 3d 79 ...
Oct 9 01:47:27 lanmaster pppd[3900]: Unsupported protocol 0x5292 received
Oct 9 01:47:27 lanmaster pppd[3900]: sent [LCP ProtRej id=0x2c 52 92 ee e6 2e c2 a9 0a b8 e3 8c 86 66 05 a1 1b d7 e3 9e 7a 4e 91 1c 29 0f 4b f2 1d 43 79 79 92 ...]
Oct 9 01:47:28 lanmaster pppd[3900]: rcvd [proto=0x7] 0a 7d 0d 2d e2 ce 17 c4 d5 98 97 82 f1 ca 32 66 d6 95 5f 6c a4 bd d8 e7 19 9c 91 67 e9 cc 2f 4a ...
Oct 9 01:47:28 lanmaster pppd[3900]: Unsupported protocol 0x7 received
Oct 9 01:47:28 lanmaster pppd[3900]: sent [LCP ProtRej id=0x2d 00 07 0a 7d 0d 2d e2 ce 17 c4 d5 98 97 82 f1 ca 32 66 d6 95 5f 6c a4 bd d8 e7 19 9c 91 67 e9 cc ...]
Oct 9 01:47:28 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 80, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:28 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 174, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:28 lanmaster pppd[3900]: rcvd [proto=0x6f] e1 0b 3a 88 42 1f 91 96 fd 87 b9 68 e9 1f 8d ae 85 98 28 60 f5 3a c6 7e a4 0b ae 11 4c 3c c2 ed ...
Oct 9 01:47:28 lanmaster pppd[3900]: Unsupported protocol 'Stampede Bridging' (0x6f) received
Oct 9 01:47:28 lanmaster pppd[3900]: sent [LCP ProtRej id=0x2e 00 6f e1 0b 3a 88 42 1f 91 96 fd 87 b9 68 e9 1f 8d ae 85 98 28 60 f5 3a c6 7e a4 0b ae 11 4c 3c ...]
Oct 9 01:47:29 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 80, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:29 lanmaster pppd[3900]: rcvd [proto=0x645b] 80 f9 53 3b 2c 70 12 e6 9d e9 d4 b1 7e d7 e4 98 57 9d 0e 24 8e 09 51 9a 39 66 cf 96 47 2e dc c8 ...
Oct 9 01:47:29 lanmaster pppd[3900]: Unsupported protocol 0x645b received
Oct 9 01:47:29 lanmaster pppd[3900]: sent [LCP ProtRej id=0x2f 64 5b 80 f9 53 3b 2c 70 12 e6 9d e9 d4 b1 7e d7 e4 98 57 9d 0e 24 8e 09 51 9a 39 66 cf 96 47 2e ...]
Oct 9 01:47:30 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:30 lanmaster pppd[3900]: rcvd [proto=0x6ee7] 0e 05 57 d1 df e7 4c 50 db bb 48 b3 8b fa 15 7e d5 b6 b7 69 70 58 87 73 54 96 a8 ea 2a 1b d6 d4 ...
Oct 9 01:47:30 lanmaster pppd[3900]: Unsupported protocol 0x6ee7 received
Oct 9 01:47:30 lanmaster pppd[3900]: sent [LCP ProtRej id=0x30 6e e7 0e 05 57 d1 df e7 4c 50 db bb 48 b3 8b fa 15 7e d5 b6 b7 69 70 58 87 73 54 96 a8 ea 2a 1b ...]
Oct 9 01:47:31 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 80, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:31 lanmaster pppd[3900]: rcvd [proto=0x4f] e6 b1 82 ff bc bf 53 b7 93 45 e3 3b 70 73 67 56 c5 b9 2d 3c 00 ac 95 51 33 87 fd 90 9e ee 98 2b ...
Oct 9 01:47:31 lanmaster pppd[3900]: Unsupported protocol 'IP6 Header Compression' (0x4f) received
Oct 9 01:47:31 lanmaster pppd[3900]: sent [LCP ProtRej id=0x31 00 4f e6 b1 82 ff bc bf 53 b7 93 45 e3 3b 70 73 67 56 c5 b9 2d 3c 00 ac 95 51 33 87 fd 90 9e ee ...]
Oct 9 01:47:31 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 73, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:31 lanmaster pppd[3900]: rcvd [proto=0x1836] 46 74 b7 9f e7 17 5f 7e 17 af 6e eb 5e ba 62 5a ed 0f e1 83 1f 1d e6 86 7d f5 eb 20 cb 0c 2e c0 ...
Oct 9 01:47:31 lanmaster pppd[3900]: Unsupported protocol 0x1836 received
Oct 9 01:47:31 lanmaster pppd[3900]: sent [LCP ProtRej id=0x32 18 36 46 74 b7 9f e7 17 5f 7e 17 af 6e eb 5e ba 62 5a ed 0f e1 83 1f 1d e6 86 7d f5 eb 20 cb 0c ...]
Oct 9 01:47:31 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 28, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:31 lanmaster pppd[3900]: rcvd [LCP TermReq id=0xd "=*(<\000<\37777777715t\000\000\000\000"]
Oct 9 01:47:31 lanmaster pppd[3900]: LCP terminated by peer (=*(<^@<M-Mt^@^@^@^@)
Oct 9 01:47:31 lanmaster pppd[3900]: Connect time 0.4 minutes.
Oct 9 01:47:31 lanmaster pppd[3900]: Sent 3425 bytes, received 11028 bytes.
Oct 9 01:47:31 lanmaster pppd[3900]: Script /etc/ppp/ip-down started (pid 3934)
Oct 9 01:47:31 lanmaster pppd[3900]: sent [LCP TermAck id=0xd]
Oct 9 01:47:31 lanmaster pppd[3900]: Script /etc/ppp/ip-down finished (pid 3934), status = 0x0
Oct 9 01:47:32 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 38, tunnel = 9379, call = 63004 ref=0 refhim=0
Oct 9 01:47:32 lanmaster xl2tpd[3885]: handle_avps: handling avp's for tunnel 9379, call 63004
Oct 9 01:47:32 lanmaster xl2tpd[3885]: message_type_avp: message type 14 (Call-Disconnect-Notify)
Oct 9 01:47:32 lanmaster xl2tpd[3885]: result_code_avp: peer closing for reason 3 (Control channel already exists), error = 0 ()
Oct 9 01:47:32 lanmaster xl2tpd[3885]: assigned_call_avp: using peer's call 1
Oct 9 01:47:32 lanmaster xl2tpd[3885]: control_finish: message type is Call-Disconnect-Notify(14). Tunnel is 7, call is 1.
Oct 9 01:47:32 lanmaster xl2tpd[3885]: control_finish: Connection closed to 151.46.15.96, serial 0 ()
Oct 9 01:47:32 lanmaster xl2tpd[3885]: Terminating pppd: sending TERM signal to pid 3900
Oct 9 01:47:32 lanmaster pppd[3900]: Terminating on signal 15
Oct 9 01:47:32 lanmaster pppd[3900]: Modem hangup
Oct 9 01:47:32 lanmaster pppd[3900]: Connection terminated.
Oct 9 01:47:32 lanmaster pppd[3900]: Exit.
Oct 9 01:47:32 lanmaster xl2tpd[3885]: network_thread: select returned error 4 (Interrupted system call)
Oct 9 01:47:32 lanmaster xl2tpd[3885]: network_thread: recv packet from 151.46.15.96, size = 38, tunnel = 9379, call = 0 ref=0 refhim=0
Oct 9 01:47:32 lanmaster xl2tpd[3885]: handle_avps: handling avp's for tunnel 9379, call 0
Oct 9 01:47:32 lanmaster xl2tpd[3885]: message_type_avp: message type 4 (Stop-Control-Connection-Notification)
Oct 9 01:47:32 lanmaster xl2tpd[3885]: assigned_tunnel_avp: using peer's tunnel 7
Oct 9 01:47:32 lanmaster xl2tpd[3885]: result_code_avp: peer closing for reason 6 (Requester is being shut down), error = 0 ()
Oct 9 01:47:32 lanmaster xl2tpd[3885]: control_finish: message type is Stop-Control-Connection-Notification(4). Tunnel is 7, call is 0.
Oct 9 01:47:32 lanmaster xl2tpd[3885]: control_finish: Connection closed to 151.46.15.96, port 1701 (), Local: 9379, Remote: 7
Oct 9 01:47:32 lanmaster xl2tpd[3885]: build_fdset: closing down tunnel 9379
^ permalink raw reply [flat|nested] 4+ messages in thread
* Re: PPP connection corruption with Windows client, MPPE, and RDP
2014-10-08 21:16 PPP connection corruption with Windows client, MPPE, and RDP Francesco Pretto
2014-10-08 22:53 ` Michael Richardson
2014-10-09 0:10 ` Francesco Pretto
@ 2014-10-09 14:20 ` Michael Richardson
2 siblings, 0 replies; 4+ messages in thread
From: Michael Richardson @ 2014-10-09 14:20 UTC (permalink / raw)
To: linux-ppp
Francesco Pretto <ceztko@gmail.com> wrote:
>> I suspect that RDP triggers it with a full-sized TCP packet.
> [...]
>> Do you have appropriate patches/things-enabled, so that the
>> esp/l2tp/ppp packets all stay in the kernel? If not, then you might
>> also get some debug from xl2tp.
>>
> I am not sure what esp is. PPP and MPPE are in the kernel. xl2tpd log
ESP is IPsec.
>> MPPE and IPsec are not related. AFAIK, MPPE provides for encryption
>> within PPP. you would be double encrypting.
> Yes, I knew. In fact I was more than satisfied with the reliability I
> get with "nomppe". But maybe MS-CHAP v2 use MPPE for authentication
> encryption? I don't know.
No.
>> Does other traffic continue to function? Is one end Windows?
> No, other traffic stops as well. VPN traffic is Windows-Windows.
> ipsec-ppp-l2tp endpoints are Windows-Linux.
Do you continue to see raw packets transmitted in both directions, if you
tcpdump the wire? I'm wondering if one end is broken and does not transmit,
or if one is broken, and receives incorrectly.
--
] Never tell me the odds! | ipv6 mesh networks [
] Michael Richardson, Sandelman Software Works | network architect [
] mcr@sandelman.ca http://www.sandelman.ca/ | ruby on rails [
^ permalink raw reply [flat|nested] 4+ messages in thread
end of thread, other threads:[~2014-10-09 14:20 UTC | newest]
Thread overview: 4+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2014-10-08 21:16 PPP connection corruption with Windows client, MPPE, and RDP Francesco Pretto
2014-10-08 22:53 ` Michael Richardson
2014-10-09 0:10 ` Francesco Pretto
2014-10-09 14:20 ` Michael Richardson
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).