New session is created, but cannot connect
Posted: Tue Sep 30, 2014 12:45 pm
Here is the error.log on my server :
2014-09-29 18:05:22.611 On the TCP Listener (Port 443), a Client (IP address xxx.xxx.xx.xxx, Host name "monitoring.cnrg", Port number 2248) has connected.
2014-09-29 18:05:22.611 For the client (IP address: xxx.xxx.xx.xxx, host name: "monitoring.cnrg", port number: 2248), connection "CID-23" has been created.
2014-09-29 18:05:22.611 OpenVPN Module: The OpenVPN Server Module is starting.
2014-09-29 18:05:22.611 OpenVPN Session 1 (xxx.xxx.xx.xxx:2248 -> yyy.yyy.y.yy:443): A new session is created. Protocol: TCP
2014-09-29 18:05:22.611 OpenVPN Session 1 (xxx.xxx.xx.xxx:2248 -> yyy.yyy.y.yy:443) Channel 0: A new channel is created.
-----it stop right here-------
2014-09-29 18:05:52.905 OpenVPN Session 1 (xxx.xxx.xx.xxx:2248 -> yyy.yyy.y.yy:443): Deleting the session.
2014-09-29 18:05:52.905 OpenVPN Module: The OpenVPN Server Module is stopped.
2014-09-29 18:05:52.905 Connection "CID-23" has been terminated.
2014-09-29 18:05:52.905 The connection with the client (IP address xxx.xxx.xx.xxx, Port number 2248) has been disconnected.
It should be like this right :
2014-09-29 18:22:44.512 On the TCP Listener (Port 443), a Client (IP address zzz.zzz.zz.zzz, Host name "desknow.cnrglab.itb.ac.id", Port number 59809) has connected.
2014-09-29 18:22:44.512 For the client (IP address: zzz.zzz.zz.zzz, host name: "desknow.cnrglab.itb.ac.id", port number: 59809), connection "CID-41" has been created.
2014-09-29 18:22:44.512 OpenVPN Module: The OpenVPN Server Module is starting.
2014-09-29 18:22:44.512 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443): A new session is created. Protocol: TCP
2014-09-29 18:22:44.512 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: A new channel is created.
2014-09-29 18:22:44.625 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: Option Strings Received: "V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_CLIENT,cipher AES-128-CBC,auth SHA1,keysize 128,key-method 2,tls-client"
2014-09-29 18:22:44.625 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: Option Strings to Send: "V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_SERVER,cipher AES-128-CBC,auth SHA1,keysize 128,key-method 2,tls-server"
2014-09-29 18:22:46.824 On the TCP Listener (Port 0), a Client (IP address zzz.zzz.zz.zzz, Host name "desknow.cnrglab.itb.ac.id", Port number 59809) has connected.
2014-09-29 18:22:46.824 For the client (IP address: zzz.zzz.zz.zzz, host name: "desknow.cnrglab.itb.ac.id", port number: 59809), connection "CID-42" has been created.
2014-09-29 18:22:46.824 SSL communication for connection "CID-42" has been started. The encryption algorithm name is "(null)".
2014-09-29 18:22:46.824 [HUB "VPN"] The connection "CID-42" (IP address: zzz.zzz.zz.zzz, Host name: desknow.cnrglab.itb.ac.id, Port number: 59809, Client name: "OpenVPN Client", Version: 4.10, Build: 9473) is attempting to connect to the Virtual Hub. The auth type provided is "External server authentication" and the user name is "test".
2014-09-29 18:22:46.824 [HUB "VPN"] Connection "CID-42": Successfully authenticated as user "test".
2014-09-29 18:22:46.824 [HUB "VPN"] Connection "CID-42": The new session "SID-TEST-[OPENVPN_L3]-10" has been created. (IP address: 167.205.22.178, Port number: 59809, Physical underlying protocol: "Legacy VPN - OPENVPN_L3")
2014-09-29 18:22:46.824 [HUB "VPN"] Session "SID-TEST-[OPENVPN_L3]-10": The parameter has been set. Max number of TCP connections: 1, Use of encryption: Yes, Use of compression: No, Use of Half duplex communication: No, Timeout: 20 seconds.
2014-09-29 18:22:46.824 [HUB "VPN"] Session "SID-TEST-[OPENVPN_L3]-10": VPN Client details: (Client product name: "OpenVPN Client", Client version: 410, Client build number: 9473, Server product name: "SoftEther VPN Server (64 bit)", Server version: 410, Server build number: 9473, Client OS name: "OpenVPN Client", Client OS version: "-", Client product ID: "-", Client host name: "", Client IP address: "zzz.zzz.zz.zzz", Client port number: 59809, Server host name: "yyy.yyy.y.yy", Server IP address: "yyy.yyy.y.yy", Server port number: 443, Proxy host name: "", Proxy IP address: "0.0.0.0", Proxy port number: 0, Virtual Hub name: "VPN", Client unique ID: "C118D16506F358CBB4E03C5322F3EE88")
2014-09-29 18:22:47.856 [HUB "VPN"] SecureNAT: The DHCP entry 9 has been created. MAC address: CA-72-41-6D-49-51, IP address: 167.205.29.17, host name: , expiration span: 7200 seconds
2014-09-29 18:22:47.856 [HUB "VPN"] Session "SID-SECURENAT-1": The DHCP server of host "00-AC-D8-59-E1-BE" (167.205.29.1) on this session allocated, for host "SID-TEST-[OPENVPN_L3]-10" on another session "CA-72-41-6D-49-51", the new IP address aaa.aaa.aa.aa.
2014-09-29 18:22:47.856 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: The channel becomes the established state.
2014-09-29 18:22:47.856 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: The IP address and other network information parameters are set successfully. IP Address of Client: aaa.aaa.aa.aa, Subnet Mask: 255.255.255.0, Default Gateway: aaa.aaa.aa.a, DNS Server 1: aaa.aaa.aa.a, DNS Server 2: , WINS Server 1: , WINS Server 2:
2014-09-29 18:22:47.856 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: The full strings replied: "PUSH_REPLY,ping 3,ping-restart 10,ifconfig aaa.aaa.aa.aa aaa.aaa.aa.ab,dhcp-option DNS 167.205.29.1,route-gateway 167.205.29.18,redirect-gateway def1"
2014-09-29 18:22:56.502 [HUB "VPN"] SecureNAT: The UDP session 218 has been created. Connection source 167.205.29.17:51225, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:22:57.209 [HUB "VPN"] SecureNAT: The UDP session 219 has been created. Connection source 167.205.29.17:50567, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:22:57.220 [HUB "VPN"] SecureNAT: The UDP session 220 has been created. Connection source 167.205.29.17:49183, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:22:57.220 [HUB "VPN"] SecureNAT: The UDP session 221 has been created. Connection source 167.205.29.17:57385, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:23:05.023 OpenVPN Module: The OpenVPN Server Module is stopped.
2014-09-29 18:23:05.023 Connection "CID-42" has been terminated.
The other connected client have no problem
My server OS is CentOS release 6.5 (Final)
Softether version softether-vpnserver-v4.10-9473-beta-2014.07.12-linux-x64-64bit.tar.gz
My client OS is Windows 7, with OpenVPN GUI
Can anyone please help me ?
2014-09-29 18:05:22.611 On the TCP Listener (Port 443), a Client (IP address xxx.xxx.xx.xxx, Host name "monitoring.cnrg", Port number 2248) has connected.
2014-09-29 18:05:22.611 For the client (IP address: xxx.xxx.xx.xxx, host name: "monitoring.cnrg", port number: 2248), connection "CID-23" has been created.
2014-09-29 18:05:22.611 OpenVPN Module: The OpenVPN Server Module is starting.
2014-09-29 18:05:22.611 OpenVPN Session 1 (xxx.xxx.xx.xxx:2248 -> yyy.yyy.y.yy:443): A new session is created. Protocol: TCP
2014-09-29 18:05:22.611 OpenVPN Session 1 (xxx.xxx.xx.xxx:2248 -> yyy.yyy.y.yy:443) Channel 0: A new channel is created.
-----it stop right here-------
2014-09-29 18:05:52.905 OpenVPN Session 1 (xxx.xxx.xx.xxx:2248 -> yyy.yyy.y.yy:443): Deleting the session.
2014-09-29 18:05:52.905 OpenVPN Module: The OpenVPN Server Module is stopped.
2014-09-29 18:05:52.905 Connection "CID-23" has been terminated.
2014-09-29 18:05:52.905 The connection with the client (IP address xxx.xxx.xx.xxx, Port number 2248) has been disconnected.
It should be like this right :
2014-09-29 18:22:44.512 On the TCP Listener (Port 443), a Client (IP address zzz.zzz.zz.zzz, Host name "desknow.cnrglab.itb.ac.id", Port number 59809) has connected.
2014-09-29 18:22:44.512 For the client (IP address: zzz.zzz.zz.zzz, host name: "desknow.cnrglab.itb.ac.id", port number: 59809), connection "CID-41" has been created.
2014-09-29 18:22:44.512 OpenVPN Module: The OpenVPN Server Module is starting.
2014-09-29 18:22:44.512 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443): A new session is created. Protocol: TCP
2014-09-29 18:22:44.512 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: A new channel is created.
2014-09-29 18:22:44.625 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: Option Strings Received: "V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_CLIENT,cipher AES-128-CBC,auth SHA1,keysize 128,key-method 2,tls-client"
2014-09-29 18:22:44.625 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: Option Strings to Send: "V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_SERVER,cipher AES-128-CBC,auth SHA1,keysize 128,key-method 2,tls-server"
2014-09-29 18:22:46.824 On the TCP Listener (Port 0), a Client (IP address zzz.zzz.zz.zzz, Host name "desknow.cnrglab.itb.ac.id", Port number 59809) has connected.
2014-09-29 18:22:46.824 For the client (IP address: zzz.zzz.zz.zzz, host name: "desknow.cnrglab.itb.ac.id", port number: 59809), connection "CID-42" has been created.
2014-09-29 18:22:46.824 SSL communication for connection "CID-42" has been started. The encryption algorithm name is "(null)".
2014-09-29 18:22:46.824 [HUB "VPN"] The connection "CID-42" (IP address: zzz.zzz.zz.zzz, Host name: desknow.cnrglab.itb.ac.id, Port number: 59809, Client name: "OpenVPN Client", Version: 4.10, Build: 9473) is attempting to connect to the Virtual Hub. The auth type provided is "External server authentication" and the user name is "test".
2014-09-29 18:22:46.824 [HUB "VPN"] Connection "CID-42": Successfully authenticated as user "test".
2014-09-29 18:22:46.824 [HUB "VPN"] Connection "CID-42": The new session "SID-TEST-[OPENVPN_L3]-10" has been created. (IP address: 167.205.22.178, Port number: 59809, Physical underlying protocol: "Legacy VPN - OPENVPN_L3")
2014-09-29 18:22:46.824 [HUB "VPN"] Session "SID-TEST-[OPENVPN_L3]-10": The parameter has been set. Max number of TCP connections: 1, Use of encryption: Yes, Use of compression: No, Use of Half duplex communication: No, Timeout: 20 seconds.
2014-09-29 18:22:46.824 [HUB "VPN"] Session "SID-TEST-[OPENVPN_L3]-10": VPN Client details: (Client product name: "OpenVPN Client", Client version: 410, Client build number: 9473, Server product name: "SoftEther VPN Server (64 bit)", Server version: 410, Server build number: 9473, Client OS name: "OpenVPN Client", Client OS version: "-", Client product ID: "-", Client host name: "", Client IP address: "zzz.zzz.zz.zzz", Client port number: 59809, Server host name: "yyy.yyy.y.yy", Server IP address: "yyy.yyy.y.yy", Server port number: 443, Proxy host name: "", Proxy IP address: "0.0.0.0", Proxy port number: 0, Virtual Hub name: "VPN", Client unique ID: "C118D16506F358CBB4E03C5322F3EE88")
2014-09-29 18:22:47.856 [HUB "VPN"] SecureNAT: The DHCP entry 9 has been created. MAC address: CA-72-41-6D-49-51, IP address: 167.205.29.17, host name: , expiration span: 7200 seconds
2014-09-29 18:22:47.856 [HUB "VPN"] Session "SID-SECURENAT-1": The DHCP server of host "00-AC-D8-59-E1-BE" (167.205.29.1) on this session allocated, for host "SID-TEST-[OPENVPN_L3]-10" on another session "CA-72-41-6D-49-51", the new IP address aaa.aaa.aa.aa.
2014-09-29 18:22:47.856 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: The channel becomes the established state.
2014-09-29 18:22:47.856 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: The IP address and other network information parameters are set successfully. IP Address of Client: aaa.aaa.aa.aa, Subnet Mask: 255.255.255.0, Default Gateway: aaa.aaa.aa.a, DNS Server 1: aaa.aaa.aa.a, DNS Server 2: , WINS Server 1: , WINS Server 2:
2014-09-29 18:22:47.856 OpenVPN Session 1 (zzz.zzz.zz.zzz:59809 -> yyy.yyy.y.yy:443) Channel 0: The full strings replied: "PUSH_REPLY,ping 3,ping-restart 10,ifconfig aaa.aaa.aa.aa aaa.aaa.aa.ab,dhcp-option DNS 167.205.29.1,route-gateway 167.205.29.18,redirect-gateway def1"
2014-09-29 18:22:56.502 [HUB "VPN"] SecureNAT: The UDP session 218 has been created. Connection source 167.205.29.17:51225, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:22:57.209 [HUB "VPN"] SecureNAT: The UDP session 219 has been created. Connection source 167.205.29.17:50567, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:22:57.220 [HUB "VPN"] SecureNAT: The UDP session 220 has been created. Connection source 167.205.29.17:49183, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:22:57.220 [HUB "VPN"] SecureNAT: The UDP session 221 has been created. Connection source 167.205.29.17:57385, Connection destination aaa.aaa.aa.a:53
2014-09-29 18:23:05.023 OpenVPN Module: The OpenVPN Server Module is stopped.
2014-09-29 18:23:05.023 Connection "CID-42" has been terminated.
The other connected client have no problem
My server OS is CentOS release 6.5 (Final)
Softether version softether-vpnserver-v4.10-9473-beta-2014.07.12-linux-x64-64bit.tar.gz
My client OS is Windows 7, with OpenVPN GUI
Can anyone please help me ?