Pfsense - OpenVPN Server Not Connecting

696039d4m5s8 · September 9, 2025, 12:09pm

I have an openvpn server on pfsense that stopped working (though I’m not sure when). Below are the logs from pfsense when attempting to connect a client. I didn’t see anything in there that would suggest a root cause, though I’m not an expert. Any help would be greatly appreciated. Also, I realize there’s an IP in there, I didn’t mask it because it’s my mobile carriers IP and I’m not worried about it.

2025-09-09 08:03:07.719845-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=6797fa5b 8c62af57
2025-09-09 08:03:07.719824-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:07.719737-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:07.719708-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:07.719690-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=212ce45f e28c8811
2025-09-09 08:03:07.719666-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:07.719569-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:07.719542-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:07.719524-04:00	openvpn	16028	166.194.191.51:2280 MTU: adding 426 buffer tailroom for compression for 1768 bytes of payload
2025-09-09 08:03:07.719411-04:00	openvpn	16028	166.194.191.51:2280 LZO compression initializing
2025-09-09 08:03:07.719364-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC size=32 block_size=32
2025-09-09 08:03:07.719343-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC KEY: 50c03bea 63150dd9 1b666969 ecde913c af4b5099 a5f04351 29a4b3e1 516eb1d9
2025-09-09 08:03:07.719314-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: Using 256 bit message hash 'SHA256' for HMAC authentication
2025-09-09 08:03:07.719275-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER block_size=16 iv_size=16
2025-09-09 08:03:07.719251-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER KEY: a5f47501 8a57d883 dbe90bd1 0bef8693 3732d936 6cc7ed53 35f968ca 4057a551
2025-09-09 08:03:07.719221-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: Cipher 'AES-256-CTR' initialized with 256 bit key
2025-09-09 08:03:07.719192-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: HMAC size=32 block_size=32
2025-09-09 08:03:07.719171-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: HMAC KEY: 15c2e535 17bb924f e21b65d3 70b702d2 b95c554b eb3a256c e6bceed6 db1b7458
2025-09-09 08:03:07.719138-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: Using 256 bit message hash 'SHA256' for HMAC authentication
2025-09-09 08:03:07.719092-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: CIPHER block_size=16 iv_size=16
2025-09-09 08:03:07.719064-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: CIPHER KEY: 8198abb5 00f4dc72 23b6b201 826fc451 cc05bbc0 715d8482 1c653e5c 413b82fb
2025-09-09 08:03:07.719029-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: Cipher 'AES-256-CTR' initialized with 256 bit key
2025-09-09 08:03:07.718873-04:00	openvpn	16028	166.194.191.51:2280 Re-using SSL/TLS context
2025-09-09 08:03:07.718814-04:00	openvpn	16028	MULTI: multi_create_instance called
2025-09-09 08:03:07.718793-04:00	openvpn	16028	Valid packet (P_CONTROL_V1) with HMAC challenge from peer ([AF_INET]166.194.191.51:2280), accepting new connection.
2025-09-09 08:03:07.718663-04:00	openvpn	16028	TLS-CRYPT UNWRAP TO: 01000000 003d7f04 511000df 59000000 01160301 01190100 01150303 2e10995[more...]
2025-09-09 08:03:07.718562-04:00	openvpn	16028	TLS-CRYPT UNWRAP AD: 20395895 b998934c 6e000000 0a68c017 73
2025-09-09 08:03:07.718524-04:00	openvpn	16028	TLS-CRYPT UNWRAP FROM: 20395895 b998934c 6e000000 0a68c017 73d643b5 1f7ed2e9 b7d580e2 71c8701[more...]
2025-09-09 08:03:07.718402-04:00	openvpn	16028	UDPv4 read returned 352
2025-09-09 08:03:07.718377-04:00	openvpn	16028	I/O WAIT status=0x0001
2025-09-09 08:03:07.718354-04:00	openvpn	16028	event_wait returned 1
2025-09-09 08:03:07.718309-04:00	openvpn	16028	PO_WAIT[0,0] fd=6 rev=0x00000001 rwflags=0x0001 arg=0x002ce9f8
2025-09-09 08:03:07.479718-04:00	openvpn	16028	I/O WAIT TR|Tw|SR|Sw [0/986402]
2025-09-09 08:03:07.479696-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=8 arg=0x002cd98c
2025-09-09 08:03:07.479677-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=3 arg=0x002cd988
2025-09-09 08:03:07.479661-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=5 arg=0x002cd984
2025-09-09 08:03:07.479644-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=6 arg=0x002ce9f8
2025-09-09 08:03:07.479625-04:00	openvpn	16028	SCHEDULE: schedule_find_least wakeup=[2025-09-09 08:03:08 us=466038] pri=804491494
2025-09-09 08:03:07.479602-04:00	openvpn	16028	temp/166.194.191.51:2287 SCHEDULE: schedule_add_modify wakeup=[2025-09-09 08:03:11 us=551830] pri=1933989181
2025-09-09 08:03:07.479571-04:00	openvpn	16028	temp/166.194.191.51:2287 RANDOM USEC=72245
2025-09-09 08:03:07.479519-04:00	openvpn	16028	temp/166.194.191.51:2287 TIMER: coarse timer wakeup 6 seconds
2025-09-09 08:03:07.479496-04:00	openvpn	16028	MULTI: REAP range 192 -> 208
2025-09-09 08:03:07.479475-04:00	openvpn	16028	I/O WAIT status=0x0020
2025-09-09 08:03:07.479428-04:00	openvpn	16028	event_wait returned 0
2025-09-09 08:03:06.710342-04:00	openvpn	16028	I/O WAIT TR|Tw|SR|Sw [0/768482]
2025-09-09 08:03:06.710321-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=8 arg=0x002cd98c
2025-09-09 08:03:06.710304-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=3 arg=0x002cd988
2025-09-09 08:03:06.710287-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=5 arg=0x002cd984
2025-09-09 08:03:06.710268-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=6 arg=0x002ce9f8
2025-09-09 08:03:06.709943-04:00	openvpn	16028	SCHEDULE: schedule_find_least wakeup=[2025-09-09 08:03:07 us=478740] pri=1933989181
2025-09-09 08:03:06.709918-04:00	openvpn	16028	GET INST BY REAL: 166.194.191.51:2280 [failed]
2025-09-09 08:03:06.709886-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709854-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709837-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709821-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709803-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709762-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709745-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709727-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709680-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:06.709644-04:00	openvpn	16028	166.194.191.51:2280 MULTI: multi_close_instance called
2025-09-09 08:03:06.709627-04:00	openvpn	16028	166.194.191.51:2280 MULTI: new incoming connection would exceed maximum number of clients (5)
2025-09-09 08:03:06.709608-04:00	openvpn	16028	166.194.191.51:2280 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1570,tun-mtu 1500,proto UDPv4,comp-lzo,cipher AES-128-CBC,auth SHA256,keysize 128,key-method 2,tls-client'
2025-09-09 08:03:06.709589-04:00	openvpn	16028	166.194.191.51:2280 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1570,tun-mtu 1500,proto UDPv4,comp-lzo,cipher AES-128-CBC,auth SHA256,keysize 128,key-method 2,tls-server'
2025-09-09 08:03:06.709476-04:00	openvpn	16028	166.194.191.51:2280 Data Channel MTU parms [ mss_fix:0 max_frag:0 tun_mtu:1500 tun_max_mtu:1600 headroom:136 payload:1768 tailroom:562 ET:0 ]
2025-09-09 08:03:06.709454-04:00	openvpn	16028	166.194.191.51:2280 Control Channel MTU parms [ mss_fix:0 max_frag:0 tun_mtu:1250 tun_max_mtu:0 headroom:126 payload:1600 tailroom:126 ET:0 ]
2025-09-09 08:03:06.709431-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=d7e35c26 76acfa63
2025-09-09 08:03:06.709408-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:06.709338-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:06.709313-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:06.709297-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=49be011f 3b8b60b3
2025-09-09 08:03:06.709275-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:06.709191-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:06.709163-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:06.709146-04:00	openvpn	16028	166.194.191.51:2280 MTU: adding 426 buffer tailroom for compression for 1768 bytes of payload
2025-09-09 08:03:06.709061-04:00	openvpn	16028	166.194.191.51:2280 LZO compression initializing
2025-09-09 08:03:06.709016-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC size=32 block_size=32
2025-09-09 08:03:06.708996-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC KEY: 50c03bea 63150dd9 1b666969 ecde913c af4b5099 a5f04351 29a4b3e1 516eb1d9
2025-09-09 08:03:06.708962-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: Using 256 bit message hash 'SHA256' for HMAC authentication
2025-09-09 08:03:06.708924-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER block_size=16 iv_size=16
2025-09-09 08:03:06.708901-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER KEY: a5f47501 8a57d883 dbe90bd1 0bef8693 3732d936 6cc7ed53 35f968ca 4057a551
2025-09-09 08:03:06.708872-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: Cipher 'AES-256-CTR' initialized with 256 bit key
2025-09-09 08:03:06.708845-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: HMAC size=32 block_size=32
2025-09-09 08:03:06.708825-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: HMAC KEY: 15c2e535 17bb924f e21b65d3 70b702d2 b95c554b eb3a256c e6bceed6 db1b7458
2025-09-09 08:03:06.708795-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: Using 256 bit message hash 'SHA256' for HMAC authentication
2025-09-09 08:03:06.708752-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: CIPHER block_size=16 iv_size=16
2025-09-09 08:03:06.708725-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: CIPHER KEY: 8198abb5 00f4dc72 23b6b201 826fc451 cc05bbc0 715d8482 1c653e5c 413b82fb
2025-09-09 08:03:06.708693-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: Cipher 'AES-256-CTR' initialized with 256 bit key
2025-09-09 08:03:06.708580-04:00	openvpn	16028	166.194.191.51:2280 Re-using SSL/TLS context
2025-09-09 08:03:06.708514-04:00	openvpn	16028	MULTI: multi_create_instance called
2025-09-09 08:03:06.708493-04:00	openvpn	16028	Valid packet (P_CONTROL_V1) with HMAC challenge from peer ([AF_INET]166.194.191.51:2280), accepting new connection.
2025-09-09 08:03:06.708412-04:00	openvpn	16028	TLS-CRYPT UNWRAP TO: 01000000 003d7f04 511000df 59000000 01160301 01190100 01150303 2e10995[more...]
2025-09-09 08:03:06.708298-04:00	openvpn	16028	TLS-CRYPT UNWRAP AD: 20395895 b998934c 6e000000 0968c017 73
2025-09-09 08:03:06.708261-04:00	openvpn	16028	TLS-CRYPT UNWRAP FROM: 20395895 b998934c 6e000000 0968c017 73c15c0f d2f28b73 83563c9d 819939b[more...]
2025-09-09 08:03:06.708138-04:00	openvpn	16028	UDPv4 read returned 352
2025-09-09 08:03:06.708107-04:00	openvpn	16028	I/O WAIT status=0x0001
2025-09-09 08:03:06.708081-04:00	openvpn	16028	event_wait returned 1
2025-09-09 08:03:06.708034-04:00	openvpn	16028	PO_WAIT[0,0] fd=6 rev=0x00000001 rwflags=0x0001 arg=0x002ce9f8
2025-09-09 08:03:06.321494-04:00	openvpn	16028	I/O WAIT TR|Tw|SR|Sw [1/157326]
2025-09-09 08:03:06.321473-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=8 arg=0x002cd98c
2025-09-09 08:03:06.321456-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=3 arg=0x002cd988
2025-09-09 08:03:06.321440-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=5 arg=0x002cd984
2025-09-09 08:03:06.321422-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=6 arg=0x002ce9f8
2025-09-09 08:03:06.321401-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
2025-09-09 08:03:06.321377-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=00e21876 b9f397b6, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
2025-09-09 08:03:06.321352-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_process: timeout set to 16
2025-09-09 08:03:06.321334-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK reliable_send_timeout 16 [7] 6
2025-09-09 08:03:06.321297-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK reliable_can_send active=1 current=0 : [7] 6
2025-09-09 08:03:06.321279-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_process: chg=1 ks=S_GENERATED_KEYS lame=S_UNDEF to_link->len=0 wakeup=604800
2025-09-09 08:03:06.321261-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_multi_process: i=0 state=S_GENERATED_KEYS, mysid=54575c82 bd19caea, stored-sid=6647b261 8d4c250d, stored-ip=[AF_INET]166.194.191.51:2286
2025-09-09 08:03:06.321232-04:00	openvpn	16028	temp/166.194.191.51:2286 UDPv4 write returned 399
2025-09-09 08:03:06.321193-04:00	openvpn	16028	temp/166.194.191.51:2286 UDPv4 WRITE [399] to [AF_INET]166.194.191.51:2286: P_CONTROL_V1 kid=0 sid=54575c82 bd19caea pid=[ #12 / time = (1757419370) 2025-09-09 08:02:50 ] tls_crypt_hmac=e72f5403 88539c42 1e16e70e a3c3e047 b42e5c6e e6c16fbb c357bb5a 9c79dd68
2025-09-09 08:03:06.321151-04:00	openvpn	16028	SCHEDULE: schedule_find_least wakeup=[2025-09-09 08:03:07 us=478740] pri=1933989181
2025-09-09 08:03:06.321129-04:00	openvpn	16028	temp/166.194.191.51:2286 SCHEDULE: schedule_add_modify wakeup=[2025-09-09 08:03:08 us=466038] pri=1311483497
2025-09-09 08:03:06.321102-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
2025-09-09 08:03:06.321078-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=00e21876 b9f397b6, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
2025-09-09 08:03:06.321053-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_process: timeout set to 16
2025-09-09 08:03:06.321037-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK reliable_send_timeout 16 [7] 6
2025-09-09 08:03:06.321019-04:00	openvpn	16028	temp/166.194.191.51:2286 Reliable -> TCP/UDP
2025-09-09 08:03:06.321001-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS-CRYPT WRAP TO: 2054575c 82bd19ca ea000000 0c68c017 6ae72f54 0388539c 421e16e7 0ea3c3e[more...]
2025-09-09 08:03:06.320871-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS-CRYPT WRAP TAG: e72f5403 88539c42 1e16e70e a3c3e047 b42e5c6e e6c16fbb c357bb5a 9c79dd68
2025-09-09 08:03:06.320809-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS-CRYPT WRAP AD: 2054575c 82bd19ca ea000000 0c68c017 6a
2025-09-09 08:03:06.320785-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS-CRYPT WRAP FROM: 04000000 04000000 03000000 02000000 016647b2 618d4c25 0d000000 0617030[more...]
2025-09-09 08:03:06.320671-04:00	openvpn	16028	temp/166.194.191.51:2286 write_control_auth(): P_CONTROL_V1
2025-09-09 08:03:06.320654-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK write ID 1 (ack->len=0, n=0)
2025-09-09 08:03:06.320638-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK write ID 2 (ack->len=0, n=0)
2025-09-09 08:03:06.320622-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK write ID 3 (ack->len=0, n=0)
2025-09-09 08:03:06.320605-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK write ID 4 (ack->len=0, n=0)
2025-09-09 08:03:06.320587-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK reliable_send ID 6 (size=325 to=16)
2025-09-09 08:03:06.320569-04:00	openvpn	16028	temp/166.194.191.51:2286 ACK reliable_can_send active=1 current=1 : [7] 6
2025-09-09 08:03:06.320548-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_process: chg=1 ks=S_GENERATED_KEYS lame=S_UNDEF to_link->len=0 wakeup=604800
2025-09-09 08:03:06.320529-04:00	openvpn	16028	temp/166.194.191.51:2286 TLS: tls_multi_process: i=0 state=S_GENERATED_KEYS, mysid=54575c82 bd19caea, stored-sid=6647b261 8d4c250d, stored-ip=[AF_INET]166.194.191.51:2286
2025-09-09 08:03:06.320489-04:00	openvpn	16028	MULTI: REAP range 176 -> 192
2025-09-09 08:03:06.320469-04:00	openvpn	16028	I/O WAIT status=0x0020
2025-09-09 08:03:06.320423-04:00	openvpn	16028	event_wait returned 0
2025-09-09 08:03:05.721412-04:00	openvpn	16028	I/O WAIT TR|Tw|SR|Sw [0/598179]
2025-09-09 08:03:05.721389-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=8 arg=0x002cd98c
2025-09-09 08:03:05.721360-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=3 arg=0x002cd988
2025-09-09 08:03:05.721343-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=5 arg=0x002cd984
2025-09-09 08:03:05.721326-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=6 arg=0x002ce9f8
2025-09-09 08:03:05.721307-04:00	openvpn	16028	SCHEDULE: schedule_find_least wakeup=[2025-09-09 08:03:06 us=319497] pri=1311483497
2025-09-09 08:03:05.721280-04:00	openvpn	16028	GET INST BY REAL: 166.194.191.51:2280 [failed]
2025-09-09 08:03:05.721209-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.721131-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.721077-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.721020-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.721002-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.720941-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.720925-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.720906-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.720852-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:05.720818-04:00	openvpn	16028	166.194.191.51:2280 MULTI: multi_close_instance called
2025-09-09 08:03:05.720802-04:00	openvpn	16028	166.194.191.51:2280 MULTI: new incoming connection would exceed maximum number of clients (5)
2025-09-09 08:03:05.720783-04:00	openvpn	16028	166.194.191.51:2280 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1570,tun-mtu 1500,proto UDPv4,comp-lzo,cipher AES-128-CBC,auth SHA256,keysize 128,key-method 2,tls-client'
2025-09-09 08:03:05.720763-04:00	openvpn	16028	166.194.191.51:2280 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1570,tun-mtu 1500,proto UDPv4,comp-lzo,cipher AES-128-CBC,auth SHA256,keysize 128,key-method 2,tls-server'
2025-09-09 08:03:05.720630-04:00	openvpn	16028	166.194.191.51:2280 Data Channel MTU parms [ mss_fix:0 max_frag:0 tun_mtu:1500 tun_max_mtu:1600 headroom:136 payload:1768 tailroom:562 ET:0 ]
2025-09-09 08:03:05.720608-04:00	openvpn	16028	166.194.191.51:2280 Control Channel MTU parms [ mss_fix:0 max_frag:0 tun_mtu:1250 tun_max_mtu:0 headroom:126 payload:1600 tailroom:126 ET:0 ]
2025-09-09 08:03:05.720584-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=f8d96347 5b5d9430
2025-09-09 08:03:05.720561-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:05.720431-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:05.720365-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:05.720287-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=698f65e1 e796a729
2025-09-09 08:03:05.720240-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:05.720072-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:05.720038-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:05.720020-04:00	openvpn	16028	166.194.191.51:2280 MTU: adding 426 buffer tailroom for compression for 1768 bytes of payload
2025-09-09 08:03:05.719929-04:00	openvpn	16028	166.194.191.51:2280 LZO compression initializing
2025-09-09 08:03:05.719854-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC size=32 block_size=32
2025-09-09 08:03:05.719825-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC KEY: 50c03bea 63150dd9 1b666969 ecde913c af4b5099 a5f04351 29a4b3e1 516eb1d9
2025-09-09 08:03:05.719795-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: Using 256 bit message hash 'SHA256' for HMAC authentication
2025-09-09 08:03:05.719753-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER block_size=16 iv_size=16
2025-09-09 08:03:05.719720-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER KEY: a5f47501 8a57d883 dbe90bd1 0bef8693 3732d936 6cc7ed53 35f968ca 4057a551
2025-09-09 08:03:05.719682-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: Cipher 'AES-256-CTR' initialized with 256 bit key
2025-09-09 08:03:05.719653-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: HMAC size=32 block_size=32
2025-09-09 08:03:05.719632-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: HMAC KEY: 15c2e535 17bb924f e21b65d3 70b702d2 b95c554b eb3a256c e6bceed6 db1b7458
2025-09-09 08:03:05.719600-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: Using 256 bit message hash 'SHA256' for HMAC authentication
2025-09-09 08:03:05.719554-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: CIPHER block_size=16 iv_size=16
2025-09-09 08:03:05.719522-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: CIPHER KEY: 8198abb5 00f4dc72 23b6b201 826fc451 cc05bbc0 715d8482 1c653e5c 413b82fb
2025-09-09 08:03:05.719462-04:00	openvpn	16028	166.194.191.51:2280 Outgoing Control Channel Encryption: Cipher 'AES-256-CTR' initialized with 256 bit key
2025-09-09 08:03:05.719190-04:00	openvpn	16028	166.194.191.51:2280 Re-using SSL/TLS context
2025-09-09 08:03:05.719132-04:00	openvpn	16028	MULTI: multi_create_instance called
2025-09-09 08:03:05.719112-04:00	openvpn	16028	Valid packet (P_CONTROL_V1) with HMAC challenge from peer ([AF_INET]166.194.191.51:2280), accepting new connection.
2025-09-09 08:03:05.719033-04:00	openvpn	16028	TLS-CRYPT UNWRAP TO: 01000000 003d7f04 511000df 59000000 01160301 01190100 01150303 2e10995[more...]
2025-09-09 08:03:05.718924-04:00	openvpn	16028	TLS-CRYPT UNWRAP AD: 20395895 b998934c 6e000000 0868c017 73
2025-09-09 08:03:05.718880-04:00	openvpn	16028	TLS-CRYPT UNWRAP FROM: 20395895 b998934c 6e000000 0868c017 73bff2c7 a64887ee a2de57fa c51c6d0[more...]
2025-09-09 08:03:05.718747-04:00	openvpn	16028	UDPv4 read returned 352
2025-09-09 08:03:05.718693-04:00	openvpn	16028	MULTI: REAP range 160 -> 176
2025-09-09 08:03:05.718649-04:00	openvpn	16028	I/O WAIT status=0x0001
2025-09-09 08:03:05.718568-04:00	openvpn	16028	event_wait returned 1
2025-09-09 08:03:05.718437-04:00	openvpn	16028	PO_WAIT[0,0] fd=6 rev=0x00000001 rwflags=0x0001 arg=0x002ce9f8
2025-09-09 08:03:04.710217-04:00	openvpn	16028	I/O WAIT TR|Tw|SR|Sw [1/609359]
2025-09-09 08:03:04.710196-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=8 arg=0x002cd98c
2025-09-09 08:03:04.710179-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=3 arg=0x002cd988
2025-09-09 08:03:04.710163-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=5 arg=0x002cd984
2025-09-09 08:03:04.710146-04:00	openvpn	16028	PO_CTL rwflags=0x0001 ev=6 arg=0x002ce9f8
2025-09-09 08:03:04.710127-04:00	openvpn	16028	SCHEDULE: schedule_find_least wakeup=[2025-09-09 08:03:06 us=319497] pri=1311483497
2025-09-09 08:03:04.710102-04:00	openvpn	16028	GET INST BY REAL: 166.194.191.51:2280 [failed]
2025-09-09 08:03:04.710070-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.710037-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.710020-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.710002-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.709981-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.709907-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.709890-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.709872-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.709823-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_free
2025-09-09 08:03:04.709791-04:00	openvpn	16028	166.194.191.51:2280 MULTI: multi_close_instance called
2025-09-09 08:03:04.709775-04:00	openvpn	16028	166.194.191.51:2280 MULTI: new incoming connection would exceed maximum number of clients (5)
2025-09-09 08:03:04.709756-04:00	openvpn	16028	166.194.191.51:2280 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1570,tun-mtu 1500,proto UDPv4,comp-lzo,cipher AES-128-CBC,auth SHA256,keysize 128,key-method 2,tls-client'
2025-09-09 08:03:04.709737-04:00	openvpn	16028	166.194.191.51:2280 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1570,tun-mtu 1500,proto UDPv4,comp-lzo,cipher AES-128-CBC,auth SHA256,keysize 128,key-method 2,tls-server'
2025-09-09 08:03:04.709614-04:00	openvpn	16028	166.194.191.51:2280 Data Channel MTU parms [ mss_fix:0 max_frag:0 tun_mtu:1500 tun_max_mtu:1600 headroom:136 payload:1768 tailroom:562 ET:0 ]
2025-09-09 08:03:04.709593-04:00	openvpn	16028	166.194.191.51:2280 Control Channel MTU parms [ mss_fix:0 max_frag:0 tun_mtu:1250 tun_max_mtu:0 headroom:126 payload:1600 tailroom:126 ET:0 ]
2025-09-09 08:03:04.709570-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=7bd95fd2 39c7d605
2025-09-09 08:03:04.709549-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:04.709448-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:04.709418-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:04.709401-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: new session object, sid=b8a74fcc 8e448aba
2025-09-09 08:03:04.709366-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:04.709267-04:00	openvpn	16028	166.194.191.51:2280 PID packet_id_init seq_backtrack=64 time_backtrack=15
2025-09-09 08:03:04.709241-04:00	openvpn	16028	166.194.191.51:2280 TLS: tls_session_init: entry
2025-09-09 08:03:04.709224-04:00	openvpn	16028	166.194.191.51:2280 MTU: adding 426 buffer tailroom for compression for 1768 bytes of payload
2025-09-09 08:03:04.709145-04:00	openvpn	16028	166.194.191.51:2280 LZO compression initializing
2025-09-09 08:03:04.709101-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC size=32 block_size=32
2025-09-09 08:03:04.709082-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: HMAC KEY: 50c03bea 63150dd9 1b666969 ecde913c af4b5099 a5f04351 29a4b3e1 516eb1d9
2025-09-09 08:03:04.709054-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: Using 256 bit message hash 'SHA256' for HMAC authentication
2025-09-09 08:03:04.709017-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER block_size=16 iv_size=16
2025-09-09 08:03:04.708993-04:00	openvpn	16028	166.194.191.51:2280 Incoming Control Channel Encryption: CIPHER KEY: a5f47501 8a57d883 dbe90bd1 0bef8693 3732d936 6cc7ed53 35f968ca 4057a551

LTS_Tom · September 9, 2025, 2:17pm

Look at the client logs, does it connect but not route?

696039d4m5s8 · September 9, 2025, 2:39pm

No. It doesn’t connect at all. Eventually the client gives up.

xMAXIMUSx · September 9, 2025, 2:52pm

The client logs are going to be important in figuring out what the issue is.

pavlos · September 9, 2025, 3:29pm

can you post your setup?

696039d4m5s8 · September 9, 2025, 4:55pm

696039d4m5s8 · September 9, 2025, 5:00pm

(included) IPv6 route fc00::/7

[Aug 07, 2025, 08:02:35] Connected via NetworkExtensionTUN

[Aug 07, 2025, 08:02:35] LZO-ASYM init swap=0 asym=1

[Aug 07, 2025, 08:02:35] EVENT: CONNECTED matt@tequilatavern.ddns.net:1194 (24.228.65.90) via /TCP on NetworkExtensionTUN/192.168.7.2/ gw=[/] mtu=(default)

[Aug 07, 2025, 08:02:35] EVENT: COMPRESSION_ENABLED Asymmetric compression enabled.  Server may send compressed data.  This may be a potential security issue.

[Aug 07, 2025, 08:06:03] Stop tunnel requested with reason: 1
[Aug 07, 2025, 08:06:03] EVENT: DISCONNECTED

[Aug 07, 2025, 08:06:03] EVENT: CORE_THREAD_DONE

[Aug 07, 2025, 08:06:03] EVENT: DISCONNECT_PENDING

[Aug 07, 2025, 08:06:03] Raw stats on disconnect:
  BYTES_IN : 73231335
  BYTES_OUT : 4071416
  PACKETS_IN : 47726
  PACKETS_OUT : 34229
  TUN_BYTES_IN : 3143223
  TUN_BYTES_OUT : 71774155
  TUN_PACKETS_IN : 34218
  TUN_PACKETS_OUT : 53811


[Aug 07, 2025, 08:06:03] Performance stats on disconnect:
  CPU usage (microseconds): 9865070
  Tunnel compression ratio (uplink): 1.2953
  Tunnel compression ratio (downlink): 1.0203
  Network bytes per CPU second: 7836006
  Tunnel bytes per CPU second: 7594206

[Aug 15, 2025, 09:43:12] START CONNECTION

[Aug 15, 2025, 09:43:12] ----- OpenVPN Start -----
OpenVPN core 3.11.1 ios arm64 64-bit

[Aug 15, 2025, 09:43:12] OpenVPN core 3.11.1 ios arm64 64-bit

[Aug 15, 2025, 09:43:12] Frame=512/2112/512 mssfix-ctrl=1250

[Aug 15, 2025, 09:43:12] NOTE: This configuration contains options that were not used:

[Aug 15, 2025, 09:43:12] Unsupported option (ignored)

[Aug 15, 2025, 09:43:12] 0 [persist-tun]

[Aug 15, 2025, 09:43:12] 1 [persist-key]

[Aug 15, 2025, 09:43:12] 2 [data-ciphers] [AES-256-GCM]

[Aug 15, 2025, 09:43:12] 3 [data-ciphers-fallback] [AES-256-GCM]

[Aug 15, 2025, 09:43:12] 4 [explicit-exit-notify]

[Aug 15, 2025, 09:43:12] EVENT: RESOLVE

[Aug 15, 2025, 09:43:12] Contacting ip.addr:1194 via UDP

[Aug 15, 2025, 09:43:12] EVENT: WAIT

[Aug 15, 2025, 09:43:12] Connecting to [servername.com]:1194 (ip.addr) via UDPv4

[Aug 15, 2025, 09:43:22] Server poll timeout, trying next remote entry...

[Aug 15, 2025, 09:43:22] EVENT: RECONNECTING

[Aug 15, 2025, 09:43:22] EVENT: RESOLVE

[Aug 15, 2025, 09:43:22] Contacting ip.addr:1194 via UDP

[Aug 15, 2025, 09:43:22] EVENT: WAIT

[Aug 15, 2025, 09:43:22] Connecting to [servername.com]:1194 (ip.addr) via UDPv4

[Aug 15, 2025, 09:43:32] Server poll timeout, trying next remote entry...

[Aug 15, 2025, 09:43:32] EVENT: RECONNECTING

[Aug 15, 2025, 09:43:32] EVENT: RESOLVE

[Aug 15, 2025, 09:43:32] Contacting ip.addr:1194 via UDP

[Aug 15, 2025, 09:43:32] EVENT: WAIT

[Aug 15, 2025, 09:43:32] Connecting to [servername.com]:1194 (ip.addr) via UDPv4

[Aug 15, 2025, 09:43:35] Stop tunnel requested with reason: 1
[Aug 15, 2025, 09:43:35] EVENT: DISCONNECTED

[Aug 15, 2025, 09:43:35] EVENT: CORE_THREAD_DONE

[Aug 15, 2025, 09:43:35] EVENT: DISCONNECT_PENDING

[Aug 15, 2025, 09:43:35] Raw stats on disconnect:
  BYTES_OUT : 1404
  PACKETS_OUT : 26
  N_RECONNECT : 2


[Aug 15, 2025, 09:43:35] Performance stats on disconnect:
  CPU usage (microseconds): 50098
  Network bytes per CPU second: 28025
  Tunnel bytes per CPU second: 0

[Sep 08, 2025, 15:26:03] START CONNECTION

[Sep 08, 2025, 15:26:03] ----- OpenVPN Start -----
OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:26:03] OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:26:03] Frame=512/2112/512 mssfix-ctrl=1250

[Sep 08, 2025, 15:26:03] NOTE: This configuration contains options that were not used:

[Sep 08, 2025, 15:26:03] Unsupported option (ignored)

[Sep 08, 2025, 15:26:03] 0 [persist-tun]

[Sep 08, 2025, 15:26:03] 1 [persist-key]

[Sep 08, 2025, 15:26:03] 2 [data-ciphers] [AES-256-GCM:AES-128-GCM:AES-128-CBC]

[Sep 08, 2025, 15:26:03] 3 [data-ciphers-fallback] [AES-128-CBC]

[Sep 08, 2025, 15:26:03] 4 [explicit-exit-notify]

[Sep 08, 2025, 15:26:03] EVENT: RESOLVE

[Sep 08, 2025, 15:26:03] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:26:03] EVENT: WAIT

[Sep 08, 2025, 15:26:03] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:26:13] Server poll timeout, trying next remote entry...

[Sep 08, 2025, 15:26:13] EVENT: RECONNECTING

[Sep 08, 2025, 15:26:13] EVENT: RESOLVE

[Sep 08, 2025, 15:26:13] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:26:13] EVENT: WAIT

[Sep 08, 2025, 15:26:13] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:26:15] Stop tunnel requested with reason: 1
[Sep 08, 2025, 15:26:15] EVENT: DISCONNECTED

[Sep 08, 2025, 15:26:15] EVENT: CORE_THREAD_DONE

[Sep 08, 2025, 15:26:15] EVENT: DISCONNECT_PENDING

[Sep 08, 2025, 15:26:15] Raw stats on disconnect:
  BYTES_OUT : 702
  PACKETS_OUT : 13
  N_RECONNECT : 1


[Sep 08, 2025, 15:26:15] Performance stats on disconnect:
  CPU usage (microseconds): 35818
  Network bytes per CPU second: 19599
  Tunnel bytes per CPU second: 0

[Sep 08, 2025, 15:26:32] START CONNECTION

[Sep 08, 2025, 15:26:32] ----- OpenVPN Start -----
OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:26:32] OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:26:32] Frame=512/2112/512 mssfix-ctrl=1250

[Sep 08, 2025, 15:26:32] NOTE: This configuration contains options that were not used:

[Sep 08, 2025, 15:26:32] Unsupported option (ignored)

[Sep 08, 2025, 15:26:32] 0 [persist-tun]

[Sep 08, 2025, 15:26:32] 1 [persist-key]

[Sep 08, 2025, 15:26:32] 2 [data-ciphers] [AES-256-GCM:AES-128-GCM:AES-128-CBC]

[Sep 08, 2025, 15:26:32] 3 [data-ciphers-fallback] [AES-128-CBC]

[Sep 08, 2025, 15:26:32] 4 [explicit-exit-notify]

[Sep 08, 2025, 15:26:32] EVENT: RESOLVE

[Sep 08, 2025, 15:26:32] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:26:32] EVENT: WAIT

[Sep 08, 2025, 15:26:32] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:26:42] Server poll timeout, trying next remote entry...

[Sep 08, 2025, 15:26:42] EVENT: RECONNECTING

[Sep 08, 2025, 15:26:42] EVENT: RESOLVE

[Sep 08, 2025, 15:26:42] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:26:42] EVENT: WAIT

[Sep 08, 2025, 15:26:42] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:26:52] Server poll timeout, trying next remote entry...

[Sep 08, 2025, 15:26:52] EVENT: RECONNECTING

[Sep 08, 2025, 15:26:52] EVENT: RESOLVE

[Sep 08, 2025, 15:26:52] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:26:52] EVENT: WAIT

[Sep 08, 2025, 15:26:52] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:27:02] EVENT: CONNECTION_TIMEOUT [ERR]

[Sep 08, 2025, 15:27:02] EVENT: DISCONNECTED

[Sep 08, 2025, 15:27:02] EVENT: CORE_THREAD_DONE

[Sep 08, 2025, 15:27:02] EVENT: DISCONNECT_PENDING

[Sep 08, 2025, 15:27:02] Raw stats on disconnect:
  BYTES_OUT : 1674
  PACKETS_OUT : 31
  CONNECTION_TIMEOUT : 1
  N_RECONNECT : 2


[Sep 08, 2025, 15:27:02] Performance stats on disconnect:
  CPU usage (microseconds): 56656
  Network bytes per CPU second: 29546
  Tunnel bytes per CPU second: 0

[Sep 08, 2025, 15:28:28] START CONNECTION

[Sep 08, 2025, 15:28:28] ----- OpenVPN Start -----
OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:28:28] OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:28:28] Frame=512/2112/512 mssfix-ctrl=1250

[Sep 08, 2025, 15:28:28] NOTE: This configuration contains options that were not used:

[Sep 08, 2025, 15:28:28] Unsupported option (ignored)

[Sep 08, 2025, 15:28:28] 0 [persist-tun]

[Sep 08, 2025, 15:28:28] 1 [persist-key]

[Sep 08, 2025, 15:28:28] 2 [data-ciphers] [AES-256-GCM:AES-128-GCM:AES-128-CBC]

[Sep 08, 2025, 15:28:28] 3 [data-ciphers-fallback] [AES-128-CBC]

[Sep 08, 2025, 15:28:28] 4 [explicit-exit-notify]

[Sep 08, 2025, 15:28:28] EVENT: RESOLVE

[Sep 08, 2025, 15:28:28] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:28:28] EVENT: WAIT

[Sep 08, 2025, 15:28:28] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:28:38] Server poll timeout, trying next remote entry...

[Sep 08, 2025, 15:28:38] EVENT: RECONNECTING

[Sep 08, 2025, 15:28:38] EVENT: RESOLVE

[Sep 08, 2025, 15:28:38] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:28:38] EVENT: WAIT

[Sep 08, 2025, 15:28:38] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:28:48] Server poll timeout, trying next remote entry...

[Sep 08, 2025, 15:28:48] EVENT: RECONNECTING

[Sep 08, 2025, 15:28:48] EVENT: RESOLVE

[Sep 08, 2025, 15:28:48] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:28:48] EVENT: WAIT

[Sep 08, 2025, 15:28:48] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:28:58] EVENT: CONNECTION_TIMEOUT [ERR]

[Sep 08, 2025, 15:28:58] EVENT: DISCONNECTED

[Sep 08, 2025, 15:28:58] EVENT: CORE_THREAD_DONE

[Sep 08, 2025, 15:28:58] EVENT: DISCONNECT_PENDING

[Sep 08, 2025, 15:28:58] Raw stats on disconnect:
  BYTES_OUT : 1728
  PACKETS_OUT : 32
  CONNECTION_TIMEOUT : 1
  N_RECONNECT : 2


[Sep 08, 2025, 15:28:58] Performance stats on disconnect:
  CPU usage (microseconds): 56518
  Network bytes per CPU second: 30574
  Tunnel bytes per CPU second: 0

[Sep 08, 2025, 15:33:22] START CONNECTION

[Sep 08, 2025, 15:33:22] ----- OpenVPN Start -----
OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:33:22] OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:33:22] Frame=512/2112/512 mssfix-ctrl=1250

[Sep 08, 2025, 15:33:22] NOTE: This configuration contains options that were not used:

[Sep 08, 2025, 15:33:22] Unsupported option (ignored)

[Sep 08, 2025, 15:33:22] 0 [persist-tun]

[Sep 08, 2025, 15:33:22] 1 [persist-key]

[Sep 08, 2025, 15:33:22] 2 [data-ciphers] [AES-256-GCM:AES-128-GCM:AES-128-CBC]

[Sep 08, 2025, 15:33:22] 3 [data-ciphers-fallback] [AES-128-CBC]

[Sep 08, 2025, 15:33:22] 4 [explicit-exit-notify]

[Sep 08, 2025, 15:33:22] EVENT: RESOLVE

[Sep 08, 2025, 15:33:22] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:33:22] EVENT: WAIT

[Sep 08, 2025, 15:33:22] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:33:27] Stop tunnel requested with reason: 1
[Sep 08, 2025, 15:33:27] EVENT: DISCONNECTED

[Sep 08, 2025, 15:33:27] EVENT: CORE_THREAD_DONE

[Sep 08, 2025, 15:33:28] EVENT: DISCONNECT_PENDING

[Sep 08, 2025, 15:33:28] Raw stats on disconnect:
  BYTES_OUT : 324
  PACKETS_OUT : 6


[Sep 08, 2025, 15:33:28] Performance stats on disconnect:
  CPU usage (microseconds): 25877
  Network bytes per CPU second: 12520
  Tunnel bytes per CPU second: 0

[Sep 08, 2025, 15:33:50] START CONNECTION

[Sep 08, 2025, 15:33:50] ----- OpenVPN Start -----
OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:33:50] OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:33:50] Frame=512/2112/512 mssfix-ctrl=1250

[Sep 08, 2025, 15:33:50] NOTE: This configuration contains options that were not used:

[Sep 08, 2025, 15:33:50] Unsupported option (ignored)

[Sep 08, 2025, 15:33:50] 0 [persist-tun]

[Sep 08, 2025, 15:33:50] 1 [persist-key]

[Sep 08, 2025, 15:33:50] 2 [data-ciphers] [AES-256-GCM:AES-128-GCM:AES-128-CBC]

[Sep 08, 2025, 15:33:50] 3 [data-ciphers-fallback] [AES-128-CBC]

[Sep 08, 2025, 15:33:50] 4 [explicit-exit-notify]

[Sep 08, 2025, 15:33:50] EVENT: RESOLVE

[Sep 08, 2025, 15:33:50] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:33:50] EVENT: WAIT

[Sep 08, 2025, 15:33:50] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:33:50] EVENT: CONNECTING

[Sep 08, 2025, 15:33:50] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:33:50] Creds: Username/Password

[Sep 08, 2025, 15:33:50] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:33:51] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:33:51] Session is ACTIVE

[Sep 08, 2025, 15:33:51] EVENT: GET_CONFIG

[Sep 08, 2025, 15:33:51] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:33:52] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:33:53] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [0]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:33:53] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 0


[Sep 08, 2025, 15:33:53] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:33:53] NIP: preparing TUN network settings

[Sep 08, 2025, 15:33:53] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:33:53] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:33:53] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:33:55] EVENT: RECONNECTING

[Sep 08, 2025, 15:33:55] EVENT: RESOLVE

[Sep 08, 2025, 15:33:55] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:33:55] EVENT: WAIT

[Sep 08, 2025, 15:33:55] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:33:55] EVENT: CONNECTING

[Sep 08, 2025, 15:33:55] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:33:55] Creds: Username/Password

[Sep 08, 2025, 15:33:55] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:33:55] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:33:55] Session is ACTIVE

[Sep 08, 2025, 15:33:55] EVENT: GET_CONFIG

[Sep 08, 2025, 15:33:55] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:33:56] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:33:56] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [1]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:33:56] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 1


[Sep 08, 2025, 15:33:56] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:33:56] NIP: preparing TUN network settings

[Sep 08, 2025, 15:33:56] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:33:56] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:33:56] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:33:58] EVENT: RECONNECTING

[Sep 08, 2025, 15:33:58] EVENT: RESOLVE

[Sep 08, 2025, 15:33:58] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:33:58] EVENT: WAIT

[Sep 08, 2025, 15:33:58] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:33:59] EVENT: CONNECTING

[Sep 08, 2025, 15:33:59] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:33:59] Creds: Username/Password

[Sep 08, 2025, 15:33:59] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:33:59] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:33:59] Session is ACTIVE

[Sep 08, 2025, 15:33:59] EVENT: GET_CONFIG

[Sep 08, 2025, 15:33:59] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:34:00] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:34:01] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [2]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:34:01] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 2


[Sep 08, 2025, 15:34:01] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:34:01] NIP: preparing TUN network settings

[Sep 08, 2025, 15:34:01] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:34:01] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:34:01] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:34:03] EVENT: RECONNECTING

[Sep 08, 2025, 15:34:03] EVENT: RESOLVE

[Sep 08, 2025, 15:34:03] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:34:03] EVENT: WAIT

[Sep 08, 2025, 15:34:03] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:34:03] EVENT: CONNECTING

[Sep 08, 2025, 15:34:03] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:34:03] Creds: Username/Password

[Sep 08, 2025, 15:34:03] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:34:03] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:34:03] Session is ACTIVE

[Sep 08, 2025, 15:34:03] EVENT: GET_CONFIG

[Sep 08, 2025, 15:34:03] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:34:04] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:34:05] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [3]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:34:05] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 3


[Sep 08, 2025, 15:34:05] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:34:05] NIP: preparing TUN network settings

[Sep 08, 2025, 15:34:05] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:34:05] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:34:05] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:34:07] EVENT: RECONNECTING

[Sep 08, 2025, 15:34:07] EVENT: RESOLVE

[Sep 08, 2025, 15:34:07] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:34:07] EVENT: WAIT

[Sep 08, 2025, 15:34:07] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:34:07] EVENT: CONNECTING

[Sep 08, 2025, 15:34:07] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:34:07] Creds: Username/Password

[Sep 08, 2025, 15:34:07] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:34:07] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:34:07] Session is ACTIVE

[Sep 08, 2025, 15:34:07] EVENT: GET_CONFIG

[Sep 08, 2025, 15:34:07] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:34:08] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:34:09] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [4]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:34:09] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 4


[Sep 08, 2025, 15:34:09] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:34:09] NIP: preparing TUN network settings

[Sep 08, 2025, 15:34:09] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:34:09] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:34:09] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:34:11] EVENT: RECONNECTING

[Sep 08, 2025, 15:34:11] EVENT: RESOLVE

[Sep 08, 2025, 15:34:11] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:34:11] EVENT: WAIT

[Sep 08, 2025, 15:34:11] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:34:11] EVENT: CONNECTING

[Sep 08, 2025, 15:34:11] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:34:11] Creds: Username/Password

[Sep 08, 2025, 15:34:11] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:34:16] Stop tunnel requested with reason: 1
[Sep 08, 2025, 15:34:16] EVENT: DISCONNECTED

[Sep 08, 2025, 15:34:16] EVENT: CORE_THREAD_DONE

[Sep 08, 2025, 15:34:16] EVENT: DISCONNECT_PENDING

[Sep 08, 2025, 15:34:16] Raw stats on disconnect:
  BYTES_IN : 21213
  BYTES_OUT : 9939
  PACKETS_IN : 44
  PACKETS_OUT : 51
  N_RECONNECT : 5


[Sep 08, 2025, 15:34:16] Performance stats on disconnect:
  CPU usage (microseconds): 204032
  Network bytes per CPU second: 152681
  Tunnel bytes per CPU second: 0

[Sep 08, 2025, 15:37:08] START CONNECTION

[Sep 08, 2025, 15:37:08] ----- OpenVPN Start -----
OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:37:08] OpenVPN core 3.11.1 ios arm64 64-bit

[Sep 08, 2025, 15:37:08] Frame=512/2112/512 mssfix-ctrl=1250

[Sep 08, 2025, 15:37:08] NOTE: This configuration contains options that were not used:

[Sep 08, 2025, 15:37:08] Unsupported option (ignored)

[Sep 08, 2025, 15:37:08] 0 [persist-tun]

[Sep 08, 2025, 15:37:08] 1 [persist-key]

[Sep 08, 2025, 15:37:08] 2 [data-ciphers] [AES-256-GCM:AES-128-GCM:AES-128-CBC]

[Sep 08, 2025, 15:37:08] 3 [data-ciphers-fallback] [AES-128-CBC]

[Sep 08, 2025, 15:37:08] 4 [explicit-exit-notify]

[Sep 08, 2025, 15:37:08] EVENT: RESOLVE

[Sep 08, 2025, 15:37:08] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:37:08] EVENT: WAIT

[Sep 08, 2025, 15:37:08] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:37:08] EVENT: CONNECTING

[Sep 08, 2025, 15:37:08] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:37:08] Creds: Username/Password

[Sep 08, 2025, 15:37:08] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:37:08] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:37:08] Session is ACTIVE

[Sep 08, 2025, 15:37:08] EVENT: GET_CONFIG

[Sep 08, 2025, 15:37:08] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:37:09] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:37:10] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [0]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:37:10] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 0


[Sep 08, 2025, 15:37:10] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:37:10] NIP: preparing TUN network settings

[Sep 08, 2025, 15:37:10] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:37:10] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:37:10] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:37:12] EVENT: RECONNECTING

[Sep 08, 2025, 15:37:12] EVENT: RESOLVE

[Sep 08, 2025, 15:37:12] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:37:12] EVENT: WAIT

[Sep 08, 2025, 15:37:12] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:37:12] EVENT: CONNECTING

[Sep 08, 2025, 15:37:12] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:37:12] Creds: Username/Password

[Sep 08, 2025, 15:37:12] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:37:12] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:37:12] Session is ACTIVE

[Sep 08, 2025, 15:37:12] EVENT: GET_CONFIG

[Sep 08, 2025, 15:37:12] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:37:13] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:37:14] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [1]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:37:14] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 1


[Sep 08, 2025, 15:37:14] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:37:14] NIP: preparing TUN network settings

[Sep 08, 2025, 15:37:14] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:37:14] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:37:14] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:37:16] EVENT: RECONNECTING

[Sep 08, 2025, 15:37:16] EVENT: RESOLVE

[Sep 08, 2025, 15:37:16] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:37:16] EVENT: WAIT

[Sep 08, 2025, 15:37:16] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:37:16] EVENT: CONNECTING

[Sep 08, 2025, 15:37:16] Tunnel Options:V4,dev-type tun,link-mtu 1554,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA256,keysize 128,key-method 2,tls-client

[Sep 08, 2025, 15:37:16] Creds: Username/Password

[Sep 08, 2025, 15:37:16] Sending Peer Info:
IV_VER=3.11.1
IV_PLAT=ios
IV_NCP=2
IV_TCPNL=1
IV_PROTO=8094
IV_MTU=1600
IV_CIPHERS=AES-128-CBC:AES-192-CBC:AES-256-CBC:AES-128-GCM:AES-192-GCM:AES-256-GCM:CHACHA20-POLY1305
IV_LZO=1
IV_GUI_VER=net.openvpn.connect.ios_3.7.2-6402
IV_SSO=webauth,crtext
IV_BS64DL=1


[Sep 08, 2025, 15:37:16] SSL Handshake: peer certificate: CN=OpenVPN, 2048 bit RSA, cipher: TLS_AES_256_GCM_SHA384         TLSv1.3 Kx=any      Au=any   Enc=AESGCM(256)            Mac=AEAD


[Sep 08, 2025, 15:37:16] Session is ACTIVE

[Sep 08, 2025, 15:37:16] EVENT: GET_CONFIG

[Sep 08, 2025, 15:37:16] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:37:17] Sending PUSH_REQUEST to server...

[Sep 08, 2025, 15:37:19] OPTIONS:
0 [dhcp-option] [DNS] [10.0.4.2]
1 [dhcp-option] [DNS] [1.1.1.1]
2 [register-dns]
3 [redirect-gateway] [def1]
4 [route] [10.0.0.0] [255.255.0.0]
5 [route-gateway] [10.9.0.1]
6 [topology] [subnet]
7 [ping] [10]
8 [ping-restart] [60]
9 [ifconfig] [10.9.0.4] [10.9.0.3]
10 [peer-id] [2]
11 [cipher] [AES-256-GCM]
12 [protocol-flags] [cc-exit] [tls-ekm] [dyn-tls-crypt]
13 [tun-mtu] [1500]
14 [block-ipv6] [NOARG]


[Sep 08, 2025, 15:37:19] PROTOCOL OPTIONS:
  key-derivation: TLS Keying Material Exporter [RFC5705]
  compress: LZO
  control channel: tls-crypt enabled
  data channel: cipher AES-256-GCM, peer-id 2


[Sep 08, 2025, 15:37:19] EVENT: ASSIGN_IP

[Sep 08, 2025, 15:37:19] NIP: preparing TUN network settings

[Sep 08, 2025, 15:37:19] NIP: init TUN network settings with endpoint: ip.addr

[Sep 08, 2025, 15:37:19] Client exception in transport_recv: addr_pair_mask_parse_error: AddrMaskPair parse error 'ifconfig': 10.9.0.4/10.9.0.3 : ipv4_exception: malformed netmask

[Sep 08, 2025, 15:37:19] Client terminated, restarting in 2000 ms...

[Sep 08, 2025, 15:37:21] EVENT: RECONNECTING

[Sep 08, 2025, 15:37:21] EVENT: RESOLVE

[Sep 08, 2025, 15:37:21] Contacting ip.addr:1195 via UDP

[Sep 08, 2025, 15:37:21] EVENT: WAIT

[Sep 08, 2025, 15:37:21] Connecting to [servername.com]:1195 (ip.addr) via UDPv4

[Sep 08, 2025, 15:37:21] EVENT: CONNECTING

pavlos · September 9, 2025, 6:16pm

My .ovpn file (remote ip masked). Your server listens to 1195.

dev tun
persist-tun
persist-key
data-ciphers AES-256-GCM:AES-256-CBC
data-ciphers-fallback AES-256-CBC
auth SHA256
tls-client
client
resolv-retry infinite
remote <REMOTE-IP> 1194 udp4
setenv opt block-outside-dns
nobind
verify-x509-name “vpn” name
auth-user-pass
remote-cert-tls server
explicit-exit-notify

witzendcs · September 10, 2025, 12:16pm

Is this not quite a big clue?

pavlos · September 10, 2025, 12:35pm

Edit OpenVPN, Tunnel settings, increase concurrent connections.

696039d4m5s8 · September 10, 2025, 1:27pm

Good find, but that’s super strange. I don’t have any clients currently connected. BUT, just to be safe, I increased the number of concurrent connects to 50 and it still doesn’t work.

xMAXIMUSx · September 10, 2025, 1:31pm

If I were you I’d recreate the server with fresh new configs.

pavlos · September 10, 2025, 1:53pm

basic test: sudo openvpn --config your.ovpn

I tested mine/connected, tunnel created. In the handshake you can see what’s going on.

696039d4m5s8 · September 10, 2025, 2:45pm

Good call. It looks like a DNS issue I need to resolve.