Clients Timing Out

Post Reply
juanh74
OpenVpn Newbie
Posts: 1
Joined: Tue Oct 01, 2019 2:52 pm

Clients Timing Out

Post by juanh74 » Tue Oct 01, 2019 4:32 pm

I setup an OpenVPN server on the cloud with Microsoft Azure.
The server is running OpeVPN 2.7.5 on a Ubuntu 18.04 OS.

The server is setup and I can add clients and access the WEB UI with no problems.
I try to connect from different clients and none of them can successfully join the virtual network.
They reach the server, but all of them timeout. I even put a timeout of 2 minutes, and it still does not work.
I followed all the steps in the OpenVPN website setting up the cloud server. IP Forwarding is enabled, it uses a routing table, and the firewall for udp 1194 allows the connections to the server.

Here is a log from the server side.

TTP/1.1" 200 57550476 "https://40.86.99.90:943/?src=connect" "Mozilla/5.0 (Windows NT 10.0; WOW64; Trident/7.0; rv:11.0) like Gecko"'
2019-10-01T11:10:35-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:10:35-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53624)"
2019-10-01T11:11:08-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:08-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53638)"
2019-10-01T11:11:08-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:08-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53640)"
2019-10-01T11:11:08-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:08-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53642)"
2019-10-01T11:11:09-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:09-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53641)"
2019-10-01T11:11:16-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:16-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53637)"
2019-10-01T11:11:17-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:17 2019 TCP connection established with [AF_INET]x.x.x.x:53664'
2019-10-01T11:11:17-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:17 2019 Socket flags: TCP_NODELAY=1 succeeded'
2019-10-01T11:11:17-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:17 2019x.x.x.x:53664 Non-OpenVPN client protocol detected'
2019-10-01T11:11:17-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:17 2019 x.x.x.x:53664 SIGTERM[soft,port-share-redirect] received, client-instance exiting'
2019-10-01T11:11:18-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:18-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53639)"
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019 TCP connection established with [AF_INET]x.x.x.x:53665'
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019 Socket flags: TCP_NODELAY=1 succeeded'
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019 x.x.x.x:53665 Non-OpenVPN client protocol detected'
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019 x.x.x.x:53665 SIGTERM[soft,port-share-redirect] received, client-instance exiting'
2019-10-01T11:11:19-0500 [stdout#info] [WEB] OUT: '2019-10-01T11:11:19-0500 [pyovpn.xml.udscli.UDSProxyQueryFactory#info] Starting factory <pyovpn.xml.udscli.UDSProxyQueryFactory instance at 0x7f60c0019a28>'
2019-10-01T11:11:19-0500 [twisted.python.log#info] "-" - - [01/Oct/2019:16:11:18 +0000] "POST /RPC2 HTTP/1.0" 200 1028 "-" "Twisted/XMLRPClib"
2019-10-01T11:11:19-0500 [stdout#info] [WEB] OUT: '2019-10-01T11:11:19-0500 [twisted.python.log#info] "127.0.0.1" - - [01/Oct/2019:16:11:18 +0000] "POST /RPC2 HTTP/1.1" 200 297 "-" "-"'
2019-10-01T11:11:19-0500 [stdout#info] [WEB] OUT: '2019-10-01T11:11:19-0500 [pyovpn.xml.udscli.UDSProxyQueryFactory#info] Stopping factory <pyovpn.xml.udscli.UDSProxyQueryFactory instance at 0x7f60c0019a28>'
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019 TCP connection established with [AF_INET]x.x.x.x:53666'
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019 Socket flags: TCP_NODELAY=1 succeeded'
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019x.x.x.x:53666 Non-OpenVPN client protocol detected'
2019-10-01T11:11:19-0500 [stdout#info] [OVPN 0] OUT: 'Tue Oct 1 16:11:19 2019 x.x.x.x:53666 SIGTERM[soft,port-share-redirect] received, client-instance exiting'
2019-10-01T11:11:19-0500 [stdout#info] [WEB] OUT: '2019-10-01T11:11:19-0500 [pyovpn.xml.udscli.UDSProxyQueryFactory#info] Starting factory <pyovpn.xml.udscli.UDSProxyQueryFactory instance at 0x7f60c0019440>'
2019-10-01T11:11:19-0500 [twisted.python.log#info] "-" - - [01/Oct/2019:16:11:18 +0000] "POST /RPC2 HTTP/1.0" 200 9926 "-" "Twisted/XMLRPClib"
2019-10-01T11:11:19-0500 [stdout#info] [WEB] OUT: '2019-10-01T11:11:19-0500 [twisted.python.log#info] "127.0.0.1" - - [01/Oct/2019:16:11:18 +0000] "POST /RPC2 HTTP/1.1" 200 9926 "-" "-"'
2019-10-01T11:11:19-0500 [stdout#info] [WEB] OUT: '2019-10-01T11:11:19-0500 [pyovpn.xml.udscli.UDSProxyQueryFactory#info] Stopping factory <pyovpn.xml.udscli.UDSProxyQueryFactory instance at 0x7f60c0019440>'
2019-10-01T11:11:23-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:23-0500 [-] Forcibly timing out client: IPv4Address(TCP, 'x.x.x.x', 53638)"
2019-10-01T11:11:23-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:23-0500 [-] Forcibly timing out client: IPv4Address(TCP, 'x.x.x.x', 53640)"
2019-10-01T11:11:23-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:23-0500 [-] Forcibly timing out client: IPv4Address(TCP, 'x.x.x.x', 53642)"
2019-10-01T11:11:24-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:24-0500 [-] Forcibly timing out client: IPv4Address(TCP, 'x.x.x.x', 53641)"
2019-10-01T11:11:31-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:31-0500 [-] Forcibly timing out client: IPv4Address(TCP, 'x.x.x.x', 53637)"
2019-10-01T11:11:33-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:11:33-0500 [-] Forcibly timing out client: IPv4Address(TCP, 'x.x.x.x', 53639)"


Here is the log from a client side.
⏎10/1/2019, 11:11:25 AM Contacting x.x.x.x:1194 via UDP
⏎10/1/2019, 11:11:25 AM Connecting to [x.x.x.x]:1194 (x.x.x.x) via UDPv4
⏎10/1/2019, 11:11:25 AM EVENT: RESOLVE ⏎10/1/2019, 11:11:25 AM EVENT: WAIT ⏎10/1/2019, 11:11:29 AM Server poll timeout, trying next remote entry...
⏎10/1/2019, 11:11:29 AM EVENT: RECONNECTING ⏎10/1/2019, 11:11:29 AM EVENT: RESOLVE ⏎10/1/2019, 11:11:29 AM Contacting x.x.x.x:1194 via UDP
⏎10/1/2019, 11:11:29 AM Connecting to [x.x.x.x]:1194 (x.x.x.x) via UDPv4
⏎10/1/2019, 11:11:29 AM EVENT: WAIT ⏎10/1/2019, 11:11:33 AM Server poll timeout, trying next remote entry...
⏎10/1/2019, 11:11:33 AM EVENT: RECONNECTING ⏎10/1/2019, 11:11:33 AM EVENT: RESOLVE ⏎10/1/2019, 11:11:33 AM Contacting x.x.x.x:443 via TCPv4
⏎10/1/2019, 11:11:33 AM EVENT: WAIT ⏎10/1/2019, 11:11:37 AM Server poll timeout, trying next remote entry...
⏎10/1/2019, 11:12:21 AM Connecting to [x.x.x.x]:1194 (x.x.x.x) via UDPv4
⏎10/1/2019, 11:12:25 AM EVENT: CONNECTION_TIMEOUT ⏎10/1/2019, 11:12:25 AM EVENT: DISCONNECTED ⏎10/1/2019, 11:13:03 AM OpenVPN core 3.git::1ab9727b win x86_64 64-bit PT_PROXY built on May 31 2019 13:25:03


Any help would be appretiated

Regards

novaflash
I should be on the dev team.
Posts: 1017
Joined: Fri Apr 13, 2012 8:43 pm

Re: Clients Timing Out

Post by novaflash » Tue Oct 01, 2019 4:57 pm

Hello,

> 2019-10-01T11:10:35-0500 [stdout#info] [WEB] OUT: "2019-10-01T11:10:35-0500 [-] Timing out client: IPv4Address(TCP, 'x.x.x.x', 53624)"

The keyword [WEB] here indicates that this message is for the web services and not for the OpenVPN connections. So we can completely disregard this.

> ⏎10/1/2019, 11:11:29 AM EVENT: WAIT ⏎10/1/2019, 11:11:33 AM Server poll timeout, trying next remote entry...

For this message I suggest you read:
https://openvpn.net/vpn-server-resource ... nectivity/

Post Reply