[Openswan Users] L2TP/IPSEC over PPP: IPSEC established, no traffic over ipsec0

[Eduan Basson]

> Well, ping is going outside the tunnel which is only for udp/1701 
> packets,
> if you have configured it for l2tp/ipsec.
I believe so, extract from ipsec.conf (I'm not replacing any IP's for 
these emails anymore):
        leftprotoport=17/1701
        left=172.30.26.196
        rightprotoport=17/1701
        right=196.211.225.229

>
> What do the xl2tpd logs say? 
Nov 13 14:39:41 warn xl2tpd[425]: init_config: Using old style config 
files /tmp/l2tpd/l2tpd.conf and /tmp/l2tpd/l2tp-secrets
Nov 13 14:39:41 crit xl2tpd[425]: setsockopt recvref[22]: Protocol not 
available
Nov 13 14:39:41 info xl2tpd[425]: This binary does not support kernel L2TP.
Nov 13 14:39:41 info xl2tpd[426]: xl2tpd version xl2tpd-1.2.3 started on 
Router PID:426
Nov 13 14:39:41 info xl2tpd[426]: Written by Mark Spencer, Copyright (C) 
1998, Adtran, Inc.
Nov 13 14:39:41 info xl2tpd[426]: Forked by Scott Balmos and David 
Stipp, (C) 2001
Nov 13 14:39:41 info xl2tpd[426]: Inherited by Jeff McAdams, (C) 2002
Nov 13 14:39:41 info xl2tpd[426]: Forked again by Xelerance 
(www.xelerance.com) (C) 2006
Nov 13 14:39:41 info xl2tpd[426]: Listening on IP address 0.0.0.0, port 
1701
Nov 13 14:39:48 notice xl2tpd[426]: Connecting to host 196.211.225.229, 
port 1701
Nov 13 14:39:49 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:49 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:49 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 0 (got 1, expected 0)
Nov 13 14:39:49 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:50 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:50 notice xl2tpd[426]: Connection established to 
196.211.225.229, 1701.  Local: 27481, Remote: 2 (ref=0/0).
Nov 13 14:39:50 notice xl2tpd[426]: Calling on tunnel 27481
Nov 13 14:39:50 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 1)
Nov 13 14:39:50 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:51 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 1)
Nov 13 14:39:51 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:51 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:51 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:51 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:51 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 1)
Nov 13 14:39:51 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:51 notice xl2tpd[426]: Call established with 
196.211.225.229, Local: 39790, Remote: 1, Serial: 1 (ref=0/0)
Nov 13 14:39:51 warn pppd[429]: User did not specify an interface (unit)
Nov 13 14:39:51 debug xl2tpd[426]: child_handler : pppd exited for call 
1 with code 2
Nov 13 14:39:51 info xl2tpd[426]: call_close: Call 39790 to 
196.211.225.229 disconnected
Nov 13 14:39:52 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:39:52 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:52 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:52 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:52 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:52 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:53 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:39:53 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:53 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:53 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:39:54 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:39:54 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:58 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:39:58 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:39:58 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:39:58 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:40:06 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:40:06 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:40:06 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:40:06 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:40:15 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:40:15 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:40:16 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 0, expected 2)
Nov 13 14:40:16 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:40:50 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:40:51 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:40:52 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:41:50 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:41:51 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:42:50 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:42:51 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:42:52 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:43:50 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:43:51 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:43:52 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:43:53 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:43:54 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:43:55 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:43:55 notice xl2tpd[426]: Maximum retries exceeded for tunnel 
27481.  Closing.
Nov 13 14:44:02 info xl2tpd[426]: Connection 2 closed to 
196.211.225.229, port 1701 (Timeout)
Nov 13 14:44:03 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:44:04 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:44:05 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:44:06 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:44:07 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:44:07 debug xl2tpd[426]: Unable to deliver closing message for 
tunnel 27481. Destroying anyway.
Nov 13 14:44:14 debug xl2tpd[426]: check_control: Received out of order 
control packet on tunnel 2 (got 2, expected 3)
Nov 13 14:44:14 debug xl2tpd[426]: handle_packet: bad control packet!
Nov 13 14:44:23 info xl2tpd[426]: Can not find tunnel 27481 (refhim=0)
Nov 13 14:44:23 debug xl2tpd[426]: network_thread: unable to find call 
or tunnel to handle packet.  call = 0, tunnel = 27481 Dumping.
Nov 13 14:44:34 info xl2tpd[426]: Can not find tunnel 27481 (refhim=0)
Nov 13 14:44:34 debug xl2tpd[426]: network_thread: unable to find call 
or tunnel to handle packet.  call = 0, tunnel = 27481 Dumping.
Nov 13 14:44:44 info xl2tpd[426]: Can not find tunnel 27481 (refhim=0)
Nov 13 14:44:44 debug xl2tpd[426]: network_thread: unable to find call 
or tunnel to handle packet.  call = 0, tunnel = 27481 Dumping.
Nov 13 14:45:49 debug xl2tpd[426]: Session 'L2TPserver' not up
Nov 13 14:46:02 notice xl2tpd[426]: Connecting to host 196.211.225.229, 
port 1701
Nov 13 14:46:03 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:46:04 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:46:05 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:46:06 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:46:07 debug xl2tpd[426]: network_thread: select timeout
Nov 13 14:46:07 notice xl2tpd[426]: Maximum retries exceeded for tunnel 
25532.  Closing.
Nov 13 14:46:24 info xl2tpd[426]: Disconnecting from 196.211.225.229, 
Local: 25532, Remote: 0
Nov 13 14:46:24 info xl2tpd[426]: Connection 0 closed to 
196.211.225.229, port 1701 (Goodbye!)

> Did the windows machine get a new IP assigned?
The windows machine is my server, linux is client. I believe only the 
client got a new IP, when PPP went up. ipsec0 got the same IP as ppp0 
(172.30.26.196).


Eduan