I am running Ubuntu 12.10 and trying to connect to a fortinet VPN server. I use forticlientsslvpn_linux_4.0.2254.
When I try to connect, error occurs during the PPP negotiation (got message
Discarded non-LCP packet when LCP not open and
timeout sending Config-Requests).
I believe the problem is not on the underlying network, because I can connect perfectly fine using my Mac machine from the same network.
Below are messages from forticlientsslvpn.log and syslog.
I would really appreciate any helps.
Thanks in advance!
** forticlientsslvpn.log:
Code:
03/28/2013 12:08:15 [15031] set the loglevel to 1
03/28/2013 12:08:15 [15031] sslvpn connection version:4.0.2254
03/28/2013 12:08:15 [14929] set the loglevel to 1
03/28/2013 12:08:15 [15031] rcv cmd:0 at state[0]
03/28/2013 12:08:15 [15031] starting ssl vpn tunnel[4.0.2254]
no gateway found for vpn.server.net. Trying our own interface
gateway for 1.1.1.1:192.168.123.254 for vpn.server.net:
if has single route record for 1.1.1.1:0 for vpn.server.net:0
03/28/2013 12:08:15 [15057] execl /home/user/forticlientsslvpn/./helper/get_fortisslvpn_info /home/user/forticlientsslvpn/./helper vpn.server.net 10443 ...
03/28/2013 12:08:15 [15057] set loglevel to 1
03/28/2013 12:08:33 [15057] no Content-Length
03/28/2013 12:08:35 [15057] no Content-Length
03/28/2013 12:08:35 [15057] no Content-Length
03/28/2013 12:08:36 [15057] no Content-Length
03/28/2013 12:08:36 [15057] 0|vpn.server.net|10443|1|10.10.0.0/255.255.0.0,[truncated]|+[truncated]==%0a
03/28/2013 12:08:36 [15031] ssl vpn tunnel started
03/28/2013 12:08:36 [15060] server=vpn.server.net[vpn.server.net] port=10443[10443] version=1 tunnel=10.10.0.0/255.255.0.0,[truncated] cookie=[truncated]==%0a
03/28/2013 12:08:36 [15060] starting pppd
03/28/2013 12:08:36 [15060] use tty:/dev/pts/7
03/28/2013 12:08:36 [15060] connecting to vpn.server.net:10443
03/28/2013 12:08:53 [15060] pppd may die...trying to fix it
03/28/2013 12:08:53 [15060] pppd may die...trying to fix it
03/28/2013 12:09:29 [15060] read error from tty[]
03/28/2013 12:09:29 [15060] rcv frame from tty fail
03/28/2013 12:09:52 [15060] ppp interface is not up!!!
03/28/2013 12:09:52 [15060] io finished, kill pppd
03/28/2013 12:09:52 [15060] kill_child:15064
03/28/2013 12:09:52 [15060] tunnel finished, killing session
03/28/2013 12:09:52 [15060] killing pppd ...
03/28/2013 12:09:52 [15031] tunnel terminated
03/28/2013 12:09:52 [15031] tunnel down unexpected
03/28/2013 12:09:52 [15031] kill_child:15057
03/28/2013 12:09:52 [15057] signal rcved, logout now
begin cleanup linux...
restore /etc/resolv.conf
clean up route...
truncate pppd.log
truncate forticlientsslvpn.log
03/28/2013 12:09:52 [15031] select: Interrupted system call
03/28/2013 12:09:52 [15031] rcv cmd:1 at state[0]
03/28/2013 12:09:52 [15031] rcv cmd:2 at state[0]
** syslog
Code:
Mar 28 12:08:36 thinkpad pppd[15064]: pppd 2.4.5 started by root, uid 0
Mar 28 12:08:36 thinkpad pppd[15064]: using channel 30
Mar 28 12:08:36 thinkpad pppd[15064]: Using interface ppp0
Mar 28 12:08:36 thinkpad pppd[15064]: Connect: ppp0 <--> /dev/pts/7
Mar 28 12:08:36 thinkpad pppd[15064]: sent [LCP ConfReq id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:36 thinkpad NetworkManager[1368]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Mar 28 12:08:36 thinkpad NetworkManager[1368]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Mar 28 12:08:36 thinkpad NetworkManager[1368]: <warn> /sys/devices/virtual/net/ppp0: couldn't determine device driver; ignoring...
Mar 28 12:08:39 thinkpad pppd[15064]: sent [LCP ConfReq id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:52 pppd[15064]: last message repeated 4 times
Mar 28 12:08:52 thinkpad pppd[15064]: rcvd [LCP ConfReq id=0x1 <magic 0x8f45618f>]
Mar 28 12:08:52 thinkpad pppd[15064]: sent [LCP ConfAck id=0x1 <magic 0x8f45618f>]
Mar 28 12:08:52 thinkpad pppd[15064]: rcvd [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:52 thinkpad pppd[15064]: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:08:52 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfReq id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: sent [LCP ConfReq id=0x2 <mru 1024> <magic 0x6b7efcd0>]
Mar 28 12:08:53 thinkpad pppd[15064]: sent [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfReq id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: sent [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfAck id=0x1 <mru 1024> <magic 0xae51a48>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [IPCP ConfReq id=0x1 <addr 58.185.224.226> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:08:53 thinkpad pppd[15064]: Discarded non-LCP packet when LCP not open
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ProtRej id=0x2 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f 00 00]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfReq id=0x3 <magic 0x2393d7b8>]
Mar 28 12:08:53 thinkpad pppd[15064]: sent [LCP ConfAck id=0x3 <magic 0x2393d7b8>]
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
Mar 28 12:08:53 thinkpad pppd[15064]: Discarded non-LCP packet when LCP not open
Mar 28 12:08:53 thinkpad pppd[15064]: rcvd [LCP ConfAck id=0x2 <mru 1024> <magic 0x6b7efcd0>]
Mar 28 12:08:53 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:08:53 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:08:56 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:08:56 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:08:59 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:08:59 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:02 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:09:02 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:05 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:09:05 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:08 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:09:08 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:11 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:09:11 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:14 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:09:14 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:17 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:09:17 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:20 thinkpad pppd[15064]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Mar 28 12:09:20 thinkpad pppd[15064]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Mar 28 12:09:23 thinkpad pppd[15064]: CCP: timeout sending Config-Requests
Mar 28 12:09:23 thinkpad pppd[15064]: IPCP: timeout sending Config-Requests
Mar 28 12:09:23 thinkpad pppd[15064]: sent [LCP TermReq id=0x3 "No network protocols running"]
Mar 28 12:09:26 thinkpad pppd[15064]: sent [LCP TermReq id=0x4 "No network protocols running"]
Mar 28 12:09:29 thinkpad pppd[15064]: Connection terminated.
Mar 28 12:09:29 thinkpad NetworkManager[1368]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Mar 28 12:09:29 thinkpad pppd[15064]: Modem hangup
Mar 28 12:09:29 thinkpad pppd[15064]: Exit.