[Openswan Users] l2tpd problem?

[Tomasz Grzelak]

Hi!

I use OpenSwan 2.2.0 on the Linux server (Debian Woody) to allow win xp native 
clients establish vpn sessions. But all sessions are destroyed sooner or 
later (I've never reached session time >1h59m; statistically sessions last 
for about an hour). I suspect the problem is with l2tpd (the logs are at the 
end); I tried l2tpd 0.69 and 0.70 from Debian unstable (both compiled), but 
there was no difference.
After the:
 Mar 20 17:30:30 guardian l2tpd[31255]: control_xmit: Maximum retries exceeded 
 for tunnel 6816.  Closing.
pppd also fails, and a tunnel is destroyed.
Just look at the log, please.

Does any one know the reason for this, and how to solve this?

Thank you,
Tomasz Grzelak


/var/log/daemon.log:

Mar 20 17:22:29 guardian pppd[10098]: local  IP address 172.22.22.1
Mar 20 17:22:29 guardian pppd[10098]: remote IP address 172.22.22.2
Mar 20 17:22:29 guardian pppd[10098]: Script /etc/ppp/ip-up started (pid 
10100)
Mar 20 17:22:29 guardian pppd[10098]: Script /etc/ppp/ip-up finished (pid 
10100), status = 0x1
Mar 20 17:22:58 guardian pppd[10098]: sent [LCP EchoReq id=0x1 
magic=0xef39349f]
Mar 20 17:22:58 guardian pppd[10098]: rcvd [LCP EchoRep id=0x1 
magic=0x7661506]
Mar 20 17:23:25 guardian l2tpd[31255]: check_control: control, cid = 0, Ns = 
4, Nr = 3
Mar 20 17:23:28 guardian pppd[10098]: sent [LCP EchoReq id=0x2 
magic=0xef39349f]
Mar 20 17:23:28 guardian pppd[10098]: rcvd [LCP EchoRep id=0x2 
magic=0x7661506]
Mar 20 17:23:58 guardian pppd[10098]: sent [LCP EchoReq id=0x3 
magic=0xef39349f]
Mar 20 17:23:58 guardian pppd[10098]: rcvd [LCP EchoRep id=0x3 
magic=0x7661506]
Mar 20 17:24:25 guardian l2tpd[31255]: check_control: control, cid = 0, Ns = 
4, Nr = 4
Mar 20 17:24:28 guardian pppd[10098]: sent [LCP EchoReq id=0x4 
magic=0xef39349f]
Mar 20 17:24:28 guardian pppd[10098]: rcvd [LCP EchoRep id=0x4 
magic=0x7661506]
Mar 20 17:24:58 guardian pppd[10098]: sent [LCP EchoReq id=0x5 
magic=0xef39349f]
Mar 20 17:24:58 guardian pppd[10098]: rcvd [LCP EchoRep id=0x5 
magic=0x7661506]
Mar 20 17:25:25 guardian l2tpd[31255]: check_control: control, cid = 0, Ns = 
4, Nr = 5
Mar 20 17:25:28 guardian pppd[10098]: sent [LCP EchoReq id=0x6 
magic=0xef39349f]
Mar 20 17:25:28 guardian pppd[10098]: rcvd [LCP EchoRep id=0x6 
magic=0x7661506]
Mar 20 17:25:58 guardian pppd[10098]: sent [LCP EchoReq id=0x7 
magic=0xef39349f]
Mar 20 17:25:58 guardian pppd[10098]: rcvd [LCP EchoRep id=0x7 
magic=0x7661506]
Mar 20 17:26:25 guardian l2tpd[31255]: check_control: control, cid = 0, Ns = 
4, Nr = 6
Mar 20 17:26:28 guardian pppd[10098]: sent [LCP EchoReq id=0x8 
magic=0xef39349f]
Mar 20 17:26:28 guardian pppd[10098]: rcvd [LCP EchoRep id=0x8 
magic=0x7661506]
Mar 20 17:26:58 guardian pppd[10098]: sent [LCP EchoReq id=0x9 
magic=0xef39349f]
Mar 20 17:26:58 guardian pppd[10098]: rcvd [LCP EchoRep id=0x9 
magic=0x7661506]
Mar 20 17:27:25 guardian l2tpd[31255]: check_control: control, cid = 0, Ns = 
4, Nr = 7
Mar 20 17:27:28 guardian pppd[10098]: sent [LCP EchoReq id=0xa 
magic=0xef39349f]
Mar 20 17:27:28 guardian pppd[10098]: rcvd [LCP EchoRep id=0xa 
magic=0x7661506]
Mar 20 17:27:58 guardian pppd[10098]: sent [LCP EchoReq id=0xb 
magic=0xef39349f]
Mar 20 17:27:58 guardian pppd[10098]: rcvd [LCP EchoRep id=0xb 
magic=0x7661506]
Mar 20 17:28:25 guardian l2tpd[31255]: check_control: control, cid = 0, Ns = 
4, Nr = 8
Mar 20 17:28:28 guardian pppd[10098]: sent [LCP EchoReq id=0xc 
magic=0xef39349f]
Mar 20 17:28:28 guardian pppd[10098]: rcvd [LCP EchoRep id=0xc 
magic=0x7661506]
Mar 20 17:28:58 guardian pppd[10098]: sent [LCP EchoReq id=0xd 
magic=0xef39349f]
Mar 20 17:28:58 guardian pppd[10098]: rcvd [LCP EchoRep id=0xd 
magic=0x7661506]
Mar 20 17:29:25 guardian l2tpd[31255]: check_control: control, cid = 0, Ns = 
4, Nr = 9
Mar 20 17:29:28 guardian pppd[10098]: sent [LCP EchoReq id=0xe 
magic=0xef39349f]
Mar 20 17:29:28 guardian pppd[10098]: rcvd [LCP EchoRep id=0xe 
magic=0x7661506]
Mar 20 17:29:58 guardian pppd[10098]: sent [LCP EchoReq id=0xf 
magic=0xef39349f]
Mar 20 17:30:28 guardian pppd[10098]: sent [LCP EchoReq id=0x10 
magic=0xef39349f]
Mar 20 17:30:30 guardian l2tpd[31255]: control_xmit: Maximum retries exceeded 
for tunnel 6816.  Closing.
Mar 20 17:30:30 guardian pppd[10098]: Terminating on signal 15.
Mar 20 17:30:30 guardian pppd[10098]: Script /etc/ppp/ip-down started (pid 
10131)
Mar 20 17:30:30 guardian pppd[10098]: sent [LCP TermReq id=0x6 "User request"]
Mar 20 17:30:30 guardian pppd[10098]: Script /etc/ppp/ip-down finished (pid 
10131), status = 0x0
Mar 20 17:30:33 guardian pppd[10098]: sent [LCP TermReq id=0x7 "User request"]
Mar 20 17:30:36 guardian pppd[10098]: Connection terminated.
Mar 20 17:30:36 guardian pppd[10098]: Connect time 8.1 minutes.
Mar 20 17:30:36 guardian pppd[10098]: Sent 120946 bytes, received 81451 bytes.
Mar 20 17:30:36 guardian pppd[10098]: tcflush failed: Input/output error
Mar 20 17:30:36 guardian pppd[10098]: Exit.
Mar 20 17:30:36 guardian l2tpd[31255]: call_close : Connection 1 closed to 
xx.yy.zz.vv, port 1701 (Timeout)
Mar 20 17:30:40 guardian l2tpd[31255]: control_xmit: Unable to deliver closing 
message for tunnel 6816. Destroying anyway.
Mar 20 17:30:57 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:30:57 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:03 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:03 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:05 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:05 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 0, tunnel = 6816 Dumping.
Mar 20 17:31:09 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:09 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:09 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:09 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:09 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:09 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:09 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:09 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:10 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:10 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:12 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:12 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:13 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:13 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:14 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:14 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 41672, tunnel = 6816 Dumping.
Mar 20 17:31:15 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:15 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 0, tunnel = 6816 Dumping.
Mar 20 17:31:25 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:25 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 0, tunnel = 6816 Dumping.
Mar 20 17:31:35 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:35 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 0, tunnel = 6816 Dumping.
Mar 20 17:31:45 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:45 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 0, tunnel = 6816 Dumping.
Mar 20 17:31:55 guardian l2tpd[31255]: get_call:can't find tunnel 6816
Mar 20 17:31:55 guardian l2tpd[31255]: network_thread: unable to find call or 
tunnel to handle packet.  call = 0, tunnel = 6816 Dumping.