Error Route: Waiting for TUN / TAP interface to come up ... (looping)

Post Reply
cristianors
OpenVpn Newbie
Posts: 1
Joined: Fri Apr 17, 2020 11:11 pm

Error Route: Waiting for TUN / TAP interface to come up ... (looping)

Post by cristianors » Fri Apr 17, 2020 11:19 pm

We set up an openvpn server just right, we have more than 100 users connected, but only 03 cases do not connect at all or connect at random.

an error of "Route: Waiting for TUN / TAP interface to come up ..." appears endlessly (looping), and we have already updated for several versions of the current one for n-3 and the same thing continues.

If someone can guide us, thank you in advance.

The public IP is replaced by 999,999,999,999 for security.

Code: Select all

Thu Apr 16 10:56:54 2020 us=849880 Current Parameter Settings:
Thu Apr 16 10:56:54 2020 us=850877   config = 'MacVOIP.ovpn'
Thu Apr 16 10:56:54 2020 us=850877   mode = 0
Thu Apr 16 10:56:54 2020 us=850877   show_ciphers = DISABLED
Thu Apr 16 10:56:54 2020 us=850877   show_digests = DISABLED
Thu Apr 16 10:56:54 2020 us=850877   show_engines = DISABLED
Thu Apr 16 10:56:54 2020 us=850877   genkey = DISABLED
Thu Apr 16 10:56:54 2020 us=850877   key_pass_file = '[UNDEF]'
Thu Apr 16 10:56:54 2020 us=850877   show_tls_ciphers = DISABLED
Thu Apr 16 10:56:54 2020 us=850877   connect_retry_max = 0
Thu Apr 16 10:56:54 2020 us=850877 NOTE: --mute triggered...
Thu Apr 16 10:56:54 2020 us=850877 288 variation(s) on previous 10 message(s) suppressed by --mute
Thu Apr 16 10:56:54 2020 us=850877 OpenVPN 2.4.8 x86_64-w64-mingw32 [SSL (OpenSSL)] [LZO] [LZ4] [PKCS11] [AEAD] built on Oct 31 2019
Thu Apr 16 10:56:54 2020 us=850877 Windows version 6.2 (Windows 8 or greater) 64bit
Thu Apr 16 10:56:54 2020 us=850877 library versions: OpenSSL 1.1.0l  10 Sep 2019, LZO 2.10
Enter Management Password:
Thu Apr 16 10:56:54 2020 us=850877 MANAGEMENT: TCP Socket listening on [AF_INET]127.0.0.1:25340
Thu Apr 16 10:56:54 2020 us=850877 Need hold release from management interface, waiting...
Thu Apr 16 10:56:55 2020 us=330197 MANAGEMENT: Client connected from [AF_INET]127.0.0.1:25340
Thu Apr 16 10:56:55 2020 us=432064 MANAGEMENT: CMD 'state on'
Thu Apr 16 10:56:55 2020 us=432439 MANAGEMENT: CMD 'log all on'
Thu Apr 16 10:56:55 2020 us=460419 MANAGEMENT: CMD 'echo all on'
Thu Apr 16 10:56:55 2020 us=462414 MANAGEMENT: CMD 'bytecount 5'
Thu Apr 16 10:56:55 2020 us=464408 MANAGEMENT: CMD 'hold off'
Thu Apr 16 10:56:55 2020 us=465406 MANAGEMENT: CMD 'hold release'
Thu Apr 16 10:56:55 2020 us=480454 MANAGEMENT: CMD 'password [...]'
Thu Apr 16 10:56:55 2020 us=483445 Control Channel MTU parms [ L:1623 D:1210 EF:40 EB:0 ET:0 EL:3 ]
Thu Apr 16 10:56:55 2020 us=483445 Data Channel MTU parms [ L:1623 D:1450 EF:123 EB:406 ET:0 EL:3 ]
Thu Apr 16 10:56:55 2020 us=483445 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_CLIENT,cipher AES-256-CBC,auth SHA1,keysize 256,key-method 2,tls-client'
Thu Apr 16 10:56:55 2020 us=483445 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_SERVER,cipher AES-256-CBC,auth SHA1,keysize 256,key-method 2,tls-server'
Thu Apr 16 10:56:55 2020 us=483445 TCP/UDP: Preserving recently used remote address: [AF_INET]999.999.999.999:5194
Thu Apr 16 10:56:55 2020 us=483445 Socket Buffers: R=[65536->65536] S=[65536->65536]
Thu Apr 16 10:56:55 2020 us=483445 Attempting to establish TCP connection with [AF_INET]999.999.999.999:5194 [nonblock]
Thu Apr 16 10:56:55 2020 us=483445 MANAGEMENT: >STATE:1587045415,TCP_CONNECT,,,,,,
Thu Apr 16 10:56:56 2020 us=485439 TCP connection established with [AF_INET]999.999.999.999:5194
Thu Apr 16 10:56:56 2020 us=485439 TCP_CLIENT link local: (not bound)
Thu Apr 16 10:56:56 2020 us=485439 TCP_CLIENT link remote: [AF_INET]999.999.999.999:5194
Thu Apr 16 10:56:56 2020 us=485439 MANAGEMENT: >STATE:1587045416,WAIT,,,,,,
Thu Apr 16 10:56:56 2020 us=486104 MANAGEMENT: >STATE:1587045416,AUTH,,,,,,
Thu Apr 16 10:56:56 2020 us=486104 TLS: Initial packet from [AF_INET]999.999.999.999:5194, sid=1929ed10 47865887
Thu Apr 16 10:56:57 2020 us=61787 VERIFY OK: depth=1, CN=CA
Thu Apr 16 10:56:57 2020 us=61787 VERIFY KU OK
Thu Apr 16 10:56:57 2020 us=61787 Validating certificate extended key usage
Thu Apr 16 10:56:57 2020 us=61787 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
Thu Apr 16 10:56:57 2020 us=61787 VERIFY EKU OK
Thu Apr 16 10:56:57 2020 us=61787 VERIFY OK: depth=0, CN=SERVER
Thu Apr 16 10:56:57 2020 us=477653 Control Channel: TLSv1.2, cipher TLSv1.2 DHE-RSA-AES256-GCM-SHA384, 4096 bit RSA
Thu Apr 16 10:56:57 2020 us=477653 [SERVER] Peer Connection Initiated with [AF_INET]999.999.999.999:5194
Thu Apr 16 10:56:58 2020 us=737376 MANAGEMENT: >STATE:1587045418,GET_CONFIG,,,,,,
Thu Apr 16 10:56:58 2020 us=737376 SENT CONTROL [SERVER]: 'PUSH_REQUEST' (status=1)
Thu Apr 16 10:57:04 2020 us=43245 SENT CONTROL [SERVER]: 'PUSH_REQUEST' (status=1)
Thu Apr 16 10:57:09 2020 us=352472 SENT CONTROL [SERVER]: 'PUSH_REQUEST' (status=1)
Thu Apr 16 10:57:09 2020 us=472792 PUSH: Received control message: 'PUSH_REPLY,dhcp-option DNS 10.100.1.1,dhcp-option DNS 10.100.1.250,ping 20,ping-restart 60,topology subnet,route-gateway 10.100.0.1,ifconfig 10.100.0.192 255.255.255.0'
Thu Apr 16 10:57:09 2020 us=472792 OPTIONS IMPORT: timers and/or timeouts modified
Thu Apr 16 10:57:09 2020 us=472792 OPTIONS IMPORT: --ifconfig/up options modified
Thu Apr 16 10:57:09 2020 us=472792 OPTIONS IMPORT: route-related options modified
Thu Apr 16 10:57:09 2020 us=472792 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
Thu Apr 16 10:57:09 2020 us=473444 Data Channel MTU parms [ L:1559 D:1450 EF:59 EB:406 ET:0 EL:3 ]
Thu Apr 16 10:57:09 2020 us=473444 Outgoing Data Channel: Cipher 'AES-256-CBC' initialized with 256 bit key
Thu Apr 16 10:57:09 2020 us=473444 Outgoing Data Channel: Using 160 bit message hash 'SHA1' for HMAC authentication
Thu Apr 16 10:57:09 2020 us=473444 Incoming Data Channel: Cipher 'AES-256-CBC' initialized with 256 bit key
Thu Apr 16 10:57:09 2020 us=473444 Incoming Data Channel: Using 160 bit message hash 'SHA1' for HMAC authentication
Thu Apr 16 10:57:09 2020 us=473444 interactive service msg_channel=648
Thu Apr 16 10:57:09 2020 us=476625 ROUTE_GATEWAY 192.168.0.1/255.255.255.0 I=16 HWADDR=64:32:a8:9a:dc:6a
Thu Apr 16 10:57:09 2020 us=477623 open_tun
Thu Apr 16 10:57:09 2020 us=478620 TAP-WIN32 device [Conexão Local] opened: \\.\Global\{31D921E0-0A67-4207-ACF4-38AB09EC84EB}.tap
Thu Apr 16 10:57:09 2020 us=478620 TAP-Windows Driver Version 9.24 
Thu Apr 16 10:57:09 2020 us=478620 TAP-Windows MTU=1500
Thu Apr 16 10:57:09 2020 us=479618 Set TAP-Windows TUN subnet mode network/local/netmask = 10.100.0.0/10.100.0.192/255.255.255.0 [SUCCEEDED]
Thu Apr 16 10:57:09 2020 us=480615 Notified TAP-Windows driver to set a DHCP IP/netmask of 10.100.0.192/255.255.255.0 on interface {31D921E0-0A67-4207-ACF4-38AB09EC84EB} [DHCP-serv: 10.100.0.254, lease-time: 31536000]
Thu Apr 16 10:57:09 2020 us=480615 DHCP option string: 06100a64 01010808 08080a64 01010a64 01fa
Thu Apr 16 10:57:09 2020 us=480615 Successful ARP Flush on interface [53] {31D921E0-0A67-4207-ACF4-38AB09EC84EB}
Thu Apr 16 10:57:09 2020 us=484888 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Thu Apr 16 10:57:09 2020 us=484888 MANAGEMENT: >STATE:1587045429,ASSIGN_IP,,10.100.0.192,,,,
Thu Apr 16 10:57:14 2020 us=643494 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:14 2020 us=643494 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:19 2020 us=799848 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:19 2020 us=799848 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:21 2020 us=6128 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:21 2020 us=7126 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:22 2020 us=209490 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:22 2020 us=209490 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:23 2020 us=408713 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:23 2020 us=408713 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:24 2020 us=522761 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:24 2020 us=522761 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:25 2020 us=724803 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:25 2020 us=724803 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:26 2020 us=924544 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:26 2020 us=924544 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:28 2020 us=126080 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:28 2020 us=127077 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:29 2020 us=332433 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:29 2020 us=332433 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:30 2020 us=343538 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:30 2020 us=344448 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:31 2020 us=352478 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:31 2020 us=352478 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:32 2020 us=360012 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:32 2020 us=360012 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:33 2020 us=372380 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:33 2020 us=373373 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:34 2020 us=385731 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:34 2020 us=385731 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:35 2020 us=393163 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:35 2020 us=393163 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:36 2020 us=405533 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:36 2020 us=405533 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:37 2020 us=413800 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:37 2020 us=413800 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:38 2020 us=424002 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:38 2020 us=424002 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:39 2020 us=792339 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:39 2020 us=792339 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:40 2020 us=524828 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:40 2020 us=524828 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:41 2020 us=746962 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:41 2020 us=746962 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:42 2020 us=974946 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:42 2020 us=974946 Route: Waiting for TUN/TAP interface to come up...
Thu Apr 16 10:57:44 2020 us=202206 TEST ROUTES: 0/0 succeeded len=-1 ret=0 a=0 u/d=down
Thu Apr 16 10:57:44 2020 us=203197 MANAGEMENT: >STATE:1587045464,ADD_ROUTES,,,,,,
Thu Apr 16 10:57:44 2020 us=203197 C:\Windows\system32\route.exe ADD 10.100.0.0 MASK 255.255.254.0 10.100.0.1
Thu Apr 16 10:57:44 2020 us=210226 Warning: route gateway is not reachable on any active network adapters: 10.100.0.1
Thu Apr 16 10:57:44 2020 us=210226 Route addition via service failed
SYSTEM ROUTING TABLE
0.0.0.0 0.0.0.0 192.168.0.1 p=0 i=16 t=4 pr=3 a=758 h=0 m=55/0/0/0/0
127.0.0.0 255.0.0.0 127.0.0.1 p=0 i=1 t=3 pr=2 a=800 h=0 m=331/0/0/0/0
127.0.0.1 255.255.255.255 127.0.0.1 p=0 i=1 t=3 pr=2 a=800 h=0 m=331/0/0/0/0
127.255.255.255 255.255.255.255 127.0.0.1 p=0 i=1 t=3 pr=2 a=800 h=0 m=331/0/0/0/0
169.254.0.0 255.255.0.0 169.254.43.157 p=0 i=53 t=3 pr=2 a=144 h=0 m=281/0/0/0/0
169.254.43.157 255.255.255.255 169.254.43.157 p=0 i=53 t=3 pr=2 a=144 h=0 m=281/0/0/0/0
169.254.255.255 255.255.255.255 169.254.43.157 p=0 i=53 t=3 pr=2 a=144 h=0 m=281/0/0/0/0
192.168.0.0 255.255.255.0 192.168.0.111 p=0 i=16 t=3 pr=2 a=758 h=0 m=311/0/0/0/0
192.168.0.111 255.255.255.255 192.168.0.111 p=0 i=16 t=3 pr=2 a=758 h=0 m=311/0/0/0/0
192.168.0.255 255.255.255.255 192.168.0.111 p=0 i=16 t=3 pr=2 a=758 h=0 m=311/0/0/0/0
224.0.0.0 240.0.0.0 127.0.0.1 p=0 i=1 t=3 pr=2 a=800 h=0 m=331/0/0/0/0
224.0.0.0 240.0.0.0 192.168.0.111 p=0 i=16 t=3 pr=2 a=786 h=0 m=311/0/0/0/0
224.0.0.0 240.0.0.0 169.254.43.157 p=0 i=53 t=3 pr=2 a=154 h=0 m=281/0/0/0/0
255.255.255.255 255.255.255.255 127.0.0.1 p=0 i=1 t=3 pr=2 a=800 h=0 m=331/0/0/0/0
255.255.255.255 255.255.255.255 192.168.0.111 p=0 i=16 t=3 pr=2 a=786 h=0 m=311/0/0/0/0
255.255.255.255 255.255.255.255 169.254.43.157 p=0 i=53 t=3 pr=2 a=154 h=0 m=281/0/0/0/0
SYSTEM ADAPTER LIST
Realtek PCIe GbE Family Controller
  Index = 19
  GUID = {DDBB9BAE-9BFD-4CB3-B5DF-5AF2047965C4}
  IP = 0.0.0.0/0.0.0.0 
  MAC = 88:6f:d4:fc:fb:05
  GATEWAY = 0.0.0.0/255.255.255.255 
  DHCP SERV =  
  DHCP LEASE OBTAINED = Thu Apr 16 10:57:44 2020
  DHCP LEASE EXPIRES  = Thu Apr 16 10:57:44 2020
  DNS SERV =  
TAP-Windows Adapter V9
  Index = 53
  GUID = {31D921E0-0A67-4207-ACF4-38AB09EC84EB}
  IP = 169.254.43.157/255.255.0.0 
  MAC = 00:ff:31:d9:21:e0
  GATEWAY = 0.0.0.0/255.255.255.255 
  DHCP SERV = 0.0.0.0/255.255.255.255 
  DHCP LEASE OBTAINED = Thu Apr 16 10:57:44 2020
  DHCP LEASE EXPIRES  = Thu Apr 16 10:57:44 2020
  DNS SERV =  
Intel(R) Wireless-AC 9462
  Index = 16
  GUID = {C75E36F3-137A-4CD0-B647-1595E9772D0E}
  IP = 192.168.0.111/255.255.255.0 
  MAC = 64:32:a8:9a:dc:6a
  GATEWAY = 192.168.0.1/255.255.255.255 
  DHCP SERV = 192.168.0.1/255.255.255.255 
  DHCP LEASE OBTAINED = Thu Apr 16 10:44:23 2020
  DHCP LEASE EXPIRES  = Thu Apr 16 12:44:23 2020
  DNS SERV = 8.8.8.8/255.255.255.255 8.8.4.4/255.255.255.255 
Microsoft Wi-Fi Direct Virtual Adapter
  Index = 7
  GUID = {289375DF-4DC1-4628-974E-E057569C900B}
  IP = 0.0.0.0/0.0.0.0 
  MAC = 64:32:a8:9a:dc:6b
  GATEWAY = 0.0.0.0/255.255.255.255 
  DHCP SERV =  
  DHCP LEASE OBTAINED = Thu Apr 16 10:57:44 2020
  DHCP LEASE EXPIRES  = Thu Apr 16 10:57:44 2020
  DNS SERV =  
Microsoft Wi-Fi Direct Virtual Adapter #2
  Index = 15
  GUID = {B5E5C007-DA65-4635-BC9A-2FFCE30823EE}
  IP = 0.0.0.0/0.0.0.0 
  MAC = 66:32:a8:9a:dc:6a
  GATEWAY = 0.0.0.0/255.255.255.255 
  DHCP SERV =  
  DHCP LEASE OBTAINED = Thu Apr 16 10:57:44 2020
  DHCP LEASE EXPIRES  = Thu Apr 16 10:57:44 2020
  DNS SERV =  
Thu Apr 16 10:57:44 2020 us=247111 Initialization Sequence Completed With Errors ( see http://openvpn.net/faq.html#dhcpclientserv )
Thu Apr 16 10:57:44 2020 us=247111 MANAGEMENT: >STATE:1587045464,CONNECTED,ERROR,10.100.0.192,999.999.999.999,5194,192.168.0.111,50076
we have more than 100 users connected and with VOIP working, but these 03 we didn't get any solution.

If anyone knows and can help, we will be forever grateful.
Last edited by Pippin on Sat Apr 18, 2020 7:34 am, edited 1 time in total.
Reason: Formatting

Post Reply