search

schwabe / ics-openvpn

OpenVPN for Android
3.26k stars 1.18k forks source link

VPN Not attempting to reconnect - Stuck at "Waiting N seconds between reconnect" #612

Closed numericOverflow closed 7 years ago

numericOverflow commented 7 years ago

General information

  1. Android Version: 5.1
  2. Android Vendor/Custom ROM: LG stock (rooted)
  3. Device : LG G4
  4. Version of the app: play store version (0.6.64)

    Description of the issue

The app does not seem to correctly retry to connect after wifi is unavailable and then becomes available again. It gets "stuck" at waiting for N seconds to reconnect. I have a strong wifi signal (notification bar signal meter confirms) and as soon as I manually tell the app to reconnect, it is able to connect immediately just fine.

Either hitting Pause/Resume on the notification banner, or 3Dots->Disconnect VPN->Reconnect will do the trick to manually kick and cause a successful reconnect.

I've noticed this issue for several months (where it would take longer to reconnect even with good wifi signal, but eventually would pickup and reconnect). Recently it has worsened and I often have to manually kick it to reconnect. I even tried decreasing the "Seconds between connections" to 5s, and "Max time between connection attempts" to 11s, but this has not helped.

Here's a good scenario, which goes along with the attached log file: OpenVPN_logfile_2017-01-17.txt

1) This morning I connected to VPN over WiFi just fine. Was working at my desk all morning. 2) Just after noon (12:05), I leave my desk and head over to get some lunch - which is about a 5 min walk away. This entails walking across campus during which time the phone jumps to various routers (all configured for seamless coverage of the campus). As usual the phone jumps routers which usually causes several breaks in service, and therefore likely shoddy re-connections attempts to the WiFi network along the way as it bounces around. 3) I had lunch, then at about 12:47 I start walking back to my desk following same route in reverse with same normal router jumping as I walk. 4) I get to my desk and work for a while before, at roughly 14:20, I notice that VPN hasn't automatically reconnected and just continually shows the "Waiting 5s between connection attempts" notification in drawer. The entire time after lunch (about 12:55 and after), I'm sitting at my desk I have full WiFi signal, and haven't moved at my desk. It's not a wifi connectivity issue at this point. One bit of note: At this point, the top status bar OpenVPN icon is "empty" or not-filled (signifying that the app is attempting to reconnect/disconnected), HOWEVER, the little VPN connect key icon android shows when VPN connection is established also appears, which suggests it thinks I've got an active VPN connection. Clearly, I don't have a connection, so I wonder if this conflicting icon information is either a symptom or indicator of what may be preventing OpenVPN app from automatically reconnecting??? 5) I waited a bit just to be sure it was really stuck. Powered on the screen, toyed around with home screen, etc, and waited a couple more mins for it to automatically reconnect, to no avail. 6) Finally, at 14:33, I hit the pause & resume on the notification, at which point VPN happily connects as it should have tried doing so.

I can provide more info if needed. LMK what you need and I'll try to help any way I can.

schwabe commented 7 years ago

that sounds like some bug in my state machine. I could add more debug output to track this down. Are you willing to install a test version for that?

The key symbol is active is the result of the persist-tun option which tells OpenVPN not to close the vpn interface when the connection is lost.

numericOverflow commented 7 years ago

Sure , I can definitely test something for you. Just let me know where to grab the debug apk version.

I do purposely have the persistent tun option enabled, so that makes sense why the key symbol stays showing.

NCols commented 7 years ago

Hi there,

Exactly the same problem here.

I have persistent tun also enabled, the phone is a Fairphone, with Android 5.1 (custom ROM: Fairphone Open OS (rooted)).

Has there been any progress on this since the initial post?

Thanks a lot for your feedback!

Cheers

schwabe commented 7 years ago

I have been quite busy with other stuff, so not much done. Can you run this apk which includes more log? (http://plai.de/android/ics-openvpn-0.6.65pre.apk)

NCols commented 7 years ago

I've installed and it's running. I'll let you know how it goes. Thanks!

numericOverflow commented 7 years ago

I've installed too, will let you know how testing goes

nordurljosahvida commented 7 years ago

Hi! Always had this problem as well [over one year] with multiple and completely separate ovpn servers. Always have to press reconnect and works perfectly. I'm pretty sure this also happens without persistent-tun but I cannot remember my settings right now. Can I help testing out in any way? Is the new version out already? Thank you!

schwabe commented 7 years ago

THe new version is out with a OpenSSL fix but no fix that would affect this issue. I am still waiting for a log with debug output from the apk that shows the issue.

NCols commented 7 years ago

Hey @schwabe sorry I haven't provided any log yet, I've had to reinstall my phone and have to retry from scratch, and I have not reimported the ovpn config yet. As soon as I'm there, I'll let you know!

TheBestTheBestTheBest commented 7 years ago

Here is a log of the app not reconnecting and being stuck to "waiting N seconds". It happens very often if you are connected to one wifi network, then you move to another access point with same name.

log.txt

TheBestTheBestTheBest commented 7 years ago

@schwabe Did that log give you any hint about what is causing this issue?

NCols commented 7 years ago

Hey,

Here's my log from today's use, where the problem occured as usual.

Let us know if you need more info.

Looking forward to your feedback.

On 16 February 2017 18:42:05 CET, TheBestTheBestTheBest notifications@github.com wrote:

@schwabe Did that log give you any hint about what is causing this issue?

-- You are receiving this because you commented. Reply to this email directly or view it on GitHub: https://github.com/schwabe/ics-openvpn/issues/612#issuecomment-280403436

-- Sent from my Android device with K-9 Mail. Please excuse my brevity. 2017-02-22 12:21:01 official build 0.6.64 running on Fairphone FP2 (FP2), Android 5.1 (FP2) API 22, ABI armeabi-v7a, (Fairphone/FP2/FP2:5.1/FP2/fp2-sibon-16.12.0:userdebug/release-keys) 2017-02-22 12:21:01 New OpenVPN Status (NOPROCESS->LEVEL_NOTCONNECTED): 2017-02-22 11:06:33 Reread (48) log items from log cache file 2017-02-22 12:21:01 official build 0.6.64 running on Fairphone FP2 (FP2), Android 5.1 (FP2) API 22, ABI armeabi-v7a, (Fairphone/FP2/FP2:5.1/FP2/fp2-sibon-16.12.0:userdebug/release-keys) 2017-02-22 12:21:01 Reread (1) log items from log cache file 2017-02-22 12:21:03 New OpenVPN Status (USER_VPN_PERMISSION->LEVEL_WAITING_FOR_USER_INPUT): 2017-02-22 12:21:05 Building configuration… 2017-02-22 12:21:05 New OpenVPN Status (VPN_GENERATE_CONFIG->LEVEL_START): 2017-02-22 12:21:05 New OpenVPN Status (VPN_GENERATE_CONFIG->LEVEL_START): 2017-02-22 12:21:05 started Socket Thread 2017-02-22 12:21:05 Network Status: CONNECTED to WIFI "GF2017" 2017-02-22 12:21:05 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:21:05 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:21:05 P:WARNING: linker: /data/data/de.blinkt.openvpn/cache/c_pie_openvpn.armeabi-v7a: unused DT entry: type 0x6ffffffe arg 0x2a0 2017-02-22 12:21:05 P:WARNING: linker: /data/data/de.blinkt.openvpn/cache/c_pie_openvpn.armeabi-v7a: unused DT entry: type 0x6fffffff arg 0x1 2017-02-22 12:21:05 P:WARNING: linker: libopenvpn.so: unused DT entry: type 0x6ffffffe arg 0x3c488 2017-02-22 12:21:05 P:WARNING: linker: libopenvpn.so: unused DT entry: type 0x6fffffff arg 0x2 2017-02-22 12:21:05 P:Initializing Google Breakpad! 2017-02-22 12:21:05 Current Parameter Settings: 2017-02-22 12:21:05 Waiting 0s seconds between connection attempt 2017-02-22 12:21:05 config = '/data/data/de.blinkt.openvpn/cache/android.conf' 2017-02-22 12:21:05 mode = 0 2017-02-22 12:21:05 NOTE: --mute triggered... 2017-02-22 12:21:05 250 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:21:05 OpenVPN 2.5-icsopenvpn [git:HEAD-3bb5086974d443b6] android-14-armeabi-v7a [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on Jan 30 2017 2017-02-22 12:21:05 library versions: OpenSSL 1.0.2k 26 Jan 2017, LZO 2.09 2017-02-22 12:21:05 MANAGEMENT: Connected to management server at /data/data/de.blinkt.openvpn/cache/mgmtsocket 2017-02-22 12:21:05 MANAGEMENT: CMD 'hold release' 2017-02-22 12:21:05 MANAGEMENT: CMD 'username 'Auth' ea4753b10d86e3c20f7823dee00649085e96ae22ed30accb2d9557fa056b58805ef14b3462b27897c255c79ebadf0ac4ef7ccfbf353ec851bb26c5bd7c061f6e' 2017-02-22 12:21:05 MANAGEMENT: CMD 'bytecount 2' 2017-02-22 12:21:05 NOTE: --mute triggered... 2017-02-22 12:21:06 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:21:06 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:21:06 3 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:21:06 LZO compression initializing 2017-02-22 12:21:06 Control Channel MTU parms [ L:1624 D:1210 EF:40 EB:0 ET:0 EL:3 ] 2017-02-22 12:21:06 MANAGEMENT: >STATE:1487762466,RESOLVE,,,,,, 2017-02-22 12:21:07 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:21:07 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:21:07 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ] 2017-02-22 12:21:07 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-client' 2017-02-22 12:21:07 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-server' 2017-02-22 12:21:07 TCP/UDP: Preserving recently used remote address: [AF_INET]176.10.104.50:443 2017-02-22 12:21:07 Socket Buffers: R=[1048576->1048576] S=[524288->524288] 2017-02-22 12:21:07 Attempting to establish TCP connection with [AF_INET]176.10.104.50:443 [nonblock] 2017-02-22 12:21:07 MANAGEMENT: >STATE:1487762467,TCP_CONNECT,,,,,, 2017-02-22 12:21:07 MANAGEMENT: CMD 'needok 'PROTECTFD' ok' 2017-02-22 12:22:30 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:22:30 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:22:30 TCP: connect to [AF_INET]176.10.104.50:443 failed: Connection timed out 2017-02-22 12:22:30 SIGUSR1[connection failed(soft),init_instance] received, process restarting 2017-02-22 12:22:30 MANAGEMENT: >STATE:1487762550,RECONNECTING,init_instance,,,,, 2017-02-22 12:22:30 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:22:30 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:22:30 Waiting 2s seconds between connection attempt 2017-02-22 12:22:32 MANAGEMENT: CMD 'hold release' 2017-02-22 12:22:32 MANAGEMENT: CMD 'proxy NONE' 2017-02-22 12:22:32 MANAGEMENT: CMD 'bytecount 2' 2017-02-22 12:22:32 NOTE: --mute triggered... 2017-02-22 12:22:33 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:22:33 LZO compression initializing 2017-02-22 12:22:33 Control Channel MTU parms [ L:1624 D:1210 EF:40 EB:0 ET:0 EL:3 ] 2017-02-22 12:22:33 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ] 2017-02-22 12:22:33 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-client' 2017-02-22 12:22:33 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-server' 2017-02-22 12:22:33 TCP/UDP: Preserving recently used remote address: [AF_INET]185.60.147.79:443 2017-02-22 12:22:33 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:22:33 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:22:33 Socket Buffers: R=[1048576->1048576] S=[524288->524288] 2017-02-22 12:22:33 Attempting to establish TCP connection with [AF_INET]185.60.147.79:443 [nonblock] 2017-02-22 12:22:33 MANAGEMENT: >STATE:1487762553,TCP_CONNECT,,,,,, 2017-02-22 12:22:33 MANAGEMENT: CMD 'needok 'PROTECTFD' ok' 2017-02-22 12:22:34 TCP connection established with [AF_INET]185.60.147.79:443 2017-02-22 12:22:34 MANAGEMENT: CMD 'needok 'PROTECTFD' ok' 2017-02-22 12:22:34 TCP_CLIENT link local: (not bound) 2017-02-22 12:22:34 TCP_CLIENT link remote: [AF_INET]185.60.147.79:443 2017-02-22 12:22:34 MANAGEMENT: >STATE:1487762554,WAIT,,,,,, 2017-02-22 12:22:34 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:22:34 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:22:34 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:22:34 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:22:34 MANAGEMENT: >STATE:1487762554,AUTH,,,,,, 2017-02-22 12:22:34 TLS: Initial packet from [AF_INET]185.60.147.79:443, sid=61b55d8a 17141078 2017-02-22 12:22:34 WARNING: this configuration may cache passwords in memory -- use the auth-nocache option to prevent this 2017-02-22 12:22:34 VERIFY OK: depth=1, C=CA, ST=QC, L=Montreal, O=Katana Holdings Limite / cryptostorm_darknet, OU=Tech Ops, CN=cryptostorm_is, emailAddress=certadmin@cryptostorm.is 2017-02-22 12:22:34 VERIFY OK: nsCertType=SERVER 2017-02-22 12:22:34 VERIFY OK: depth=0, C=CA, ST=QC, L=Montreal, O=Katana Holdings Limite / cryptostorm_darknet, OU=Tech Ops, CN=server, emailAddress=certadmin@cryptostorm.is 2017-02-22 12:22:35 NOTE: --mute triggered... 2017-02-22 12:22:35 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:22:35 [server] Peer Connection Initiated with [AF_INET]185.60.147.79:443 2017-02-22 12:22:41 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:22:41 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:22:41 MANAGEMENT: >STATE:1487762561,GET_CONFIG,,,,,, 2017-02-22 12:22:41 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1) 2017-02-22 12:22:41 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.34.17.60,,,, 2017-02-22 12:22:41 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.34.17.60,,,, 2017-02-22 12:22:41 PUSH: Received control message: 'PUSH_REPLY,persist-key,persist-tun,redirect-gateway def1,dhcp-option DNS 185.60.147.77,route-gateway 10.34.0.1,topology subnet,ping 20,ping-restart 60,ifconfig 10.34.17.60 255.255.0.0' 2017-02-22 12:22:41 OPTIONS IMPORT: timers and/or timeouts modified 2017-02-22 12:22:41 NOTE: --mute triggered... 2017-02-22 12:22:41 5 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:22:41 Data Channel MTU parms [ L:1604 D:1450 EF:104 EB:406 ET:0 EL:3 ] 2017-02-22 12:22:41 Data Channel Encrypt: Cipher 'AES-256-CBC' initialized with 256 bit key 2017-02-22 12:22:41 Data Channel Encrypt: Using 512 bit message hash 'SHA512' for HMAC authentication 2017-02-22 12:22:41 Data Channel Decrypt: Cipher 'AES-256-CBC' initialized with 256 bit key 2017-02-22 12:22:41 NOTE: --mute triggered... 2017-02-22 12:22:41 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:22:41 ROUTE_GATEWAY 127.100.103.119/255.0.0.0 IFACE=lo HWADDR=00:00:00:00:00:00 2017-02-22 12:22:41 do_ifconfig, tt->did_ifconfig_ipv6_setup=0 2017-02-22 12:22:41 MANAGEMENT: >STATE:1487762561,ASSIGN_IP,,10.34.17.60,,,, 2017-02-22 12:22:41 MANAGEMENT: CMD 'needok 'IFCONFIG' ok' 2017-02-22 12:22:41 MANAGEMENT: CMD 'needok 'ROUTE' ok' 2017-02-22 12:22:41 MANAGEMENT: CMD 'needok 'DNSSERVER' ok' 2017-02-22 12:22:41 NOTE: --mute triggered... 2017-02-22 12:22:41 Opening tun interface: 2017-02-22 12:22:41 Local IPv4: 10.34.17.60/16 IPv6: null MTU: 1500 2017-02-22 12:22:41 DNS Server: 185.60.147.77, Domain: null 2017-02-22 12:22:41 Routes: 0.0.0.0/0, 10.34.0.0/16 2017-02-22 12:22:41 Routes excluded: 172.17.49.5/20 2017-02-22 12:22:41 VpnService routes installed: 0.0.0.0/1, 128.0.0.0/3, 160.0.0.0/5, 168.0.0.0/6, 172.0.0.0/12, 172.16.0.0/16, 172.17.0.0/19, 172.17.32.0/20, 172.17.64.0/18, 172.17.128.0/17, 172.18.0.0/15, 172.20.0.0/14, 172.24.0.0/13, 172.32.0.0/11, 172.64.0.0/10, 172.128.0.0/9, 173.0.0.0/8, 174.0.0.0/7, 176.0.0.0/4, 192.0.0.0/2 2017-02-22 12:22:41 Disallowed VPN apps: 2017-02-22 12:22:41 2 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:22:41 Initialization Sequence Completed 2017-02-22 12:22:41 MANAGEMENT: >STATE:1487762561,CONNECTED,SUCCESS,10.34.17.60,185.60.147.79,443,172.17.49.5,60132 2017-02-22 12:22:41 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.34.17.60,185.60.147.79,443,172.17.49.5,60132 2017-02-22 12:22:41 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.34.17.60,185.60.147.79,443,172.17.49.5,60132 2017-02-22 12:22:41 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:42:34 VERIFY OK: depth=1, C=CA, ST=QC, L=Montreal, O=Katana Holdings Limite / cryptostorm_darknet, OU=Tech Ops, CN=cryptostorm_is, emailAddress=certadmin@cryptostorm.is 2017-02-22 12:42:34 VERIFY OK: nsCertType=SERVER 2017-02-22 12:42:34 VERIFY OK: depth=0, C=CA, ST=QC, L=Montreal, O=Katana Holdings Limite / cryptostorm_darknet, OU=Tech Ops, CN=server, emailAddress=certadmin@cryptostorm.is 2017-02-22 12:42:35 NOTE: --mute triggered... 2017-02-22 12:49:30 5 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:49:30 read TCP_CLIENT [NO-INFO]: Connection timed out (code=110) 2017-02-22 12:49:30 Connection reset, restarting [0] 2017-02-22 12:49:30 TCP/UDP: Closing socket 2017-02-22 12:49:30 SIGUSR1[soft,connection-reset] received, process restarting 2017-02-22 12:49:30 MANAGEMENT: >STATE:1487764170,RECONNECTING,connection-reset,,,,, 2017-02-22 12:49:30 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): connection-reset,,,,, 2017-02-22 12:49:30 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): connection-reset,,,,, 2017-02-22 12:49:30 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:49:30 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:49:30 Waiting 2s seconds between connection attempt 2017-02-22 12:49:30 Network Status: DISCONNECTED to WIFI 2017-02-22 12:49:30 Debug state info: DISCONNECTED to WIFI , pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:49:30 Network Status: not connected 2017-02-22 12:49:30 Debug state info: not connected, pause: userPause, shouldbeconnected: false, network: PENDINGDISCONNECT 2017-02-22 12:49:31 MANAGEMENT: CMD 'network-change' 2017-02-22 12:49:32 Network Status: CONNECTED HSPA+ to MOBILE mworld.be 2017-02-22 12:49:32 Debug state info: CONNECTED HSPA+ to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:49:32 MANAGEMENT: CMD 'hold release' 2017-02-22 12:49:32 MANAGEMENT: CMD 'proxy NONE' 2017-02-22 12:49:32 NOTE: --mute triggered... 2017-02-22 12:49:33 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:49:33 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:49:33 2 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:49:33 Re-using SSL/TLS context 2017-02-22 12:49:33 LZO compression initializing 2017-02-22 12:49:33 Control Channel MTU parms [ L:1624 D:1210 EF:40 EB:0 ET:0 EL:3 ] 2017-02-22 12:49:33 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ] 2017-02-22 12:49:33 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-client' 2017-02-22 12:49:33 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-server' 2017-02-22 12:49:33 TCP/UDP: Preserving recently used remote address: [AF_INET]185.60.147.79:443 2017-02-22 12:49:33 Socket Buffers: R=[87380->87380] S=[16384->16384] 2017-02-22 12:49:33 Attempting to establish TCP connection with [AF_INET]185.60.147.79:443 [nonblock] 2017-02-22 12:49:33 MANAGEMENT: >STATE:1487764173,TCP_CONNECT,,,,,, 2017-02-22 12:49:33 MANAGEMENT: CMD 'needok 'PROTECTFD' ok' 2017-02-22 12:49:34 TCP connection established with [AF_INET]185.60.147.79:443 2017-02-22 12:49:34 MANAGEMENT: CMD 'needok 'PROTECTFD' ok' 2017-02-22 12:49:34 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:49:34 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:49:34 TCP_CLIENT link local: (not bound) 2017-02-22 12:49:34 TCP_CLIENT link remote: [AF_INET]185.60.147.79:443 2017-02-22 12:49:34 MANAGEMENT: >STATE:1487764174,WAIT,,,,,, 2017-02-22 12:49:34 MANAGEMENT: >STATE:1487764174,AUTH,,,,,, 2017-02-22 12:49:34 TLS: Initial packet from [AF_INET]185.60.147.79:443, sid=f7b7ea20 cbef6016 2017-02-22 12:49:34 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:49:34 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:49:34 VERIFY OK: depth=1, C=CA, ST=QC, L=Montreal, O=Katana Holdings Limite / cryptostorm_darknet, OU=Tech Ops, CN=cryptostorm_is, emailAddress=certadmin@cryptostorm.is 2017-02-22 12:49:34 VERIFY OK: nsCertType=SERVER 2017-02-22 12:49:34 NOTE: --mute triggered... 2017-02-22 12:49:35 2 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:49:35 [server] Peer Connection Initiated with [AF_INET]185.60.147.79:443 2017-02-22 12:49:36 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:49:36 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,, 2017-02-22 12:49:36 MANAGEMENT: >STATE:1487764176,GET_CONFIG,,,,,, 2017-02-22 12:49:36 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1) 2017-02-22 12:49:36 PUSH: Received control message: 'PUSH_REPLY,persist-key,persist-tun,redirect-gateway def1,dhcp-option DNS 185.60.147.77,route-gateway 10.34.0.1,topology subnet,ping 20,ping-restart 60,ifconfig 10.34.94.136 255.255.0.0' 2017-02-22 12:49:36 OPTIONS IMPORT: timers and/or timeouts modified 2017-02-22 12:49:36 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.34.94.136,,,, 2017-02-22 12:49:36 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.34.94.136,,,, 2017-02-22 12:49:36 NOTE: --mute triggered... 2017-02-22 12:49:36 5 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:49:36 Data Channel MTU parms [ L:1604 D:1450 EF:104 EB:406 ET:0 EL:3 ] 2017-02-22 12:49:36 Data Channel Encrypt: Cipher 'AES-256-CBC' initialized with 256 bit key 2017-02-22 12:49:36 Data Channel Encrypt: Using 512 bit message hash 'SHA512' for HMAC authentication 2017-02-22 12:49:36 Data Channel Decrypt: Cipher 'AES-256-CBC' initialized with 256 bit key 2017-02-22 12:49:36 NOTE: --mute triggered... 2017-02-22 12:49:36 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:49:36 ROUTE_GATEWAY 127.100.103.119/255.0.0.0 IFACE=lo HWADDR=00:00:00:00:00:00 2017-02-22 12:49:36 do_ifconfig, tt->did_ifconfig_ipv6_setup=0 2017-02-22 12:49:36 MANAGEMENT: >STATE:1487764176,ASSIGN_IP,,10.34.94.136,,,, 2017-02-22 12:49:36 MANAGEMENT: CMD 'needok 'IFCONFIG' ok' 2017-02-22 12:49:36 MANAGEMENT: CMD 'needok 'ROUTE' ok' 2017-02-22 12:49:36 MANAGEMENT: CMD 'needok 'DNSSERVER' ok' 2017-02-22 12:49:36 NOTE: --mute triggered... 2017-02-22 12:49:36 Opening tun interface: 2017-02-22 12:49:36 Local IPv4: 10.34.94.136/16 IPv6: null MTU: 1500 2017-02-22 12:49:36 DNS Server: 185.60.147.77, Domain: null 2017-02-22 12:49:36 Routes: 0.0.0.0/0, 10.34.0.0/16 2017-02-22 12:49:36 Routes excluded:
2017-02-22 12:49:36 VpnService routes installed: 0.0.0.0/0 2017-02-22 12:49:36 Disallowed VPN apps: 2017-02-22 12:49:36 Debug state info: CONNECTED HSPA+ to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:49:36 Debug state info: CONNECTED HSPA+ to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:49:37 2 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:49:37 Initialization Sequence Completed 2017-02-22 12:49:37 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.34.94.136,185.60.147.79,443,10.75.71.134,50093 2017-02-22 12:49:37 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.34.94.136,185.60.147.79,443,10.75.71.134,50093 2017-02-22 12:49:37 MANAGEMENT: >STATE:1487764177,CONNECTED,SUCCESS,10.34.94.136,185.60.147.79,443,10.75.71.134,50093 2017-02-22 12:50:15 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): SIGUSR1,,,,, 2017-02-22 12:50:15 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): SIGUSR1,,,,, 2017-02-22 12:50:15 MANAGEMENT: CMD 'network-change' 2017-02-22 12:50:15 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:50:15 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:50:15 Waiting 2s seconds between connection attempt 2017-02-22 12:50:15 TCP/UDP: Closing socket 2017-02-22 12:50:15 SIGUSR1[hard,] received, process restarting 2017-02-22 12:50:15 MANAGEMENT: >STATE:1487764215,RECONNECTING,SIGUSR1,,,,, 2017-02-22 12:50:15 Network Status: CONNECTED to WIFI "GF2017" 2017-02-22 12:50:15 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:15 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:17 MANAGEMENT: CMD 'hold release' 2017-02-22 12:50:17 MANAGEMENT: CMD 'proxy NONE' 2017-02-22 12:50:17 MANAGEMENT: CMD 'bytecount 2' 2017-02-22 12:50:17 NOTE: --mute triggered... 2017-02-22 12:50:18 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:50:18 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:50:18 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:50:18 Re-using SSL/TLS context 2017-02-22 12:50:18 LZO compression initializing 2017-02-22 12:50:18 Control Channel MTU parms [ L:1624 D:1210 EF:40 EB:0 ET:0 EL:3 ] 2017-02-22 12:50:18 MANAGEMENT: >STATE:1487764218,RESOLVE,,,,,, 2017-02-22 12:50:23 Network Status: DISCONNECTED to WIFI 2017-02-22 12:50:23 Debug state info: DISCONNECTED to WIFI , pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:38 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.org:443 (No address associated with hostname) 2017-02-22 12:50:38 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ] 2017-02-22 12:50:38 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-client' 2017-02-22 12:50:38 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-server' 2017-02-22 12:50:38 MANAGEMENT: >STATE:1487764238,RESOLVE,,,,,, 2017-02-22 12:50:58 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:50:38 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:50:58 Network Status: CONNECTED HSPA to MOBILE mworld.be 2017-02-22 12:50:58 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:58 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.org:443 (No address associated with hostname) 2017-02-22 12:50:58 MANAGEMENT: CMD 'network-change' 2017-02-22 12:50:58 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:58 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:58 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:58 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:50:58 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:51:23 Network Status: CONNECTED to WIFI "GF2017" 2017-02-22 12:51:23 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:51:23 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.org:443 (No address associated with hostname) 2017-02-22 12:51:23 MANAGEMENT: CMD 'network-change' 2017-02-22 12:51:23 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:51:48 Network Status: CONNECTED HSPA to MOBILE mworld.be 2017-02-22 12:51:48 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:51:48 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.org:443 (No address associated with hostname) 2017-02-22 12:51:48 MANAGEMENT: CMD 'network-change' 2017-02-22 12:51:48 Network Status: CONNECTED to WIFI "GF2017" 2017-02-22 12:51:48 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:51:48 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:51:48 Debug state info: CONNECTED to WIFI "GF2017", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:51:48 MANAGEMENT: CMD 'network-change' 2017-02-22 12:52:33 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:52:33 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:52:33 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.org:443 (No address associated with hostname) 2017-02-22 12:52:33 Could not determine IPv4/IPv6 protocol 2017-02-22 12:52:33 SIGUSR1[soft,init_instance] received, process restarting 2017-02-22 12:52:33 MANAGEMENT: >STATE:1487764353,RECONNECTING,init_instance,,,,, 2017-02-22 12:52:33 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:52:33 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:52:33 Waiting 2s seconds between connection attempt 2017-02-22 12:52:35 MANAGEMENT: CMD 'hold release' 2017-02-22 12:52:35 MANAGEMENT: CMD 'proxy NONE' 2017-02-22 12:52:35 MANAGEMENT: CMD 'bytecount 2' 2017-02-22 12:52:35 NOTE: --mute triggered... 2017-02-22 12:52:36 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:52:37 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:52:36 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:52:37 Re-using SSL/TLS context 2017-02-22 12:52:37 LZO compression initializing 2017-02-22 12:52:37 Control Channel MTU parms [ L:1624 D:1210 EF:40 EB:0 ET:0 EL:3 ] 2017-02-22 12:52:37 MANAGEMENT: >STATE:1487764356,RESOLVE,,,,,, 2017-02-22 12:52:57 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:52:57 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:52:57 RESOLVE: Cannot resolve host address: linux-switzerland.cstorm.pw:443 (No address associated with hostname) 2017-02-22 12:52:57 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ] 2017-02-22 12:52:57 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-client' 2017-02-22 12:52:57 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-server' 2017-02-22 12:52:57 MANAGEMENT: >STATE:1487764377,RESOLVE,,,,,, 2017-02-22 12:53:17 RESOLVE: Cannot resolve host address: linux-switzerland.cstorm.pw:443 (No address associated with hostname) 2017-02-22 12:53:41 RESOLVE: Cannot resolve host address: linux-switzerland.cstorm.pw:443 (No address associated with hostname) 2017-02-22 12:54:02 Network Status: DISCONNECTED to WIFI 2017-02-22 12:54:02 Debug state info: DISCONNECTED to WIFI , pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:54:02 Network Status: not connected 2017-02-22 12:54:02 Debug state info: not connected, pause: userPause, shouldbeconnected: false, network: PENDINGDISCONNECT 2017-02-22 12:54:06 RESOLVE: Cannot resolve host address: linux-switzerland.cstorm.pw:443 (No address associated with hostname) 2017-02-22 12:54:31 NOTE: --mute triggered... 2017-02-22 12:54:31 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:54:31 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:54:31 Network Status: CONNECTED LTE to MOBILE mworld.be 2017-02-22 12:54:31 Debug state info: CONNECTED LTE to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 12:54:31 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:54:31 Could not determine IPv4/IPv6 protocol 2017-02-22 12:54:31 SIGUSR1[soft,init_instance] received, process restarting 2017-02-22 12:54:31 MANAGEMENT: >STATE:1487764471,RECONNECTING,init_instance,,,,, 2017-02-22 12:54:31 MANAGEMENT: CMD 'network-change' 2017-02-22 12:54:31 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:54:31 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2 2017-02-22 12:54:31 Waiting 2s seconds between connection attempt 2017-02-22 12:54:33 MANAGEMENT: CMD 'hold release' 2017-02-22 12:54:33 MANAGEMENT: CMD 'proxy NONE' 2017-02-22 12:54:33 NOTE: --mute triggered... 2017-02-22 12:54:34 2 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:54:34 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:54:34 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:54:34 Re-using SSL/TLS context 2017-02-22 12:54:34 LZO compression initializing 2017-02-22 12:54:34 Control Channel MTU parms [ L:1624 D:1210 EF:40 EB:0 ET:0 EL:3 ] 2017-02-22 12:54:34 MANAGEMENT: >STATE:1487764474,RESOLVE,,,,,, 2017-02-22 12:55:14 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:55:14 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:55:14 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.nu:443 (No address associated with hostname) 2017-02-22 12:55:14 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ] 2017-02-22 12:55:14 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-client' 2017-02-22 12:55:14 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-server' 2017-02-22 12:55:14 MANAGEMENT: >STATE:1487764514,RESOLVE,,,,,, 2017-02-22 12:55:54 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.nu:443 (No address associated with hostname) 2017-02-22 12:56:55 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.nu:443 (No address associated with hostname) 2017-02-22 12:58:44 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.nu:443 (No address associated with hostname) 2017-02-22 12:59:29 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:59:30 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): init_instance,,,,, 2017-02-22 12:59:29 NOTE: --mute triggered... 2017-02-22 12:59:30 1 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:59:30 Could not determine IPv4/IPv6 protocol 2017-02-22 12:59:30 SIGUSR1[soft,init_instance] received, process restarting 2017-02-22 12:59:30 MANAGEMENT: >STATE:1487764769,RECONNECTING,init_instance,,,,, 2017-02-22 12:59:30 MANAGEMENT: CMD 'signal SIGUSR1' 2017-02-22 12:59:30 New OpenVPN Status (USERPAUSE->LEVEL_VPNPAUSED): 2017-02-22 12:59:30 New OpenVPN Status (USERPAUSE->LEVEL_VPNPAUSED): 2017-02-22 12:59:30 New OpenVPN Status (USERPAUSE->LEVEL_VPNPAUSED): 2017-02-22 12:59:30 New OpenVPN Status (USERPAUSE->LEVEL_VPNPAUSED): 2017-02-22 12:59:33 MANAGEMENT: CMD 'hold release' 2017-02-22 12:59:33 MANAGEMENT: CMD 'proxy NONE' 2017-02-22 12:59:33 NOTE: --mute triggered... 2017-02-22 12:59:34 2 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 12:59:34 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:59:34 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 12:59:34 Re-using SSL/TLS context 2017-02-22 12:59:34 LZO compression initializing 2017-02-22 12:59:34 Control Channel MTU parms [ L:1624 D:1210 EF:40 EB:0 ET:0 EL:3 ] 2017-02-22 12:59:34 MANAGEMENT: >STATE:1487764774,RESOLVE,,,,,, 2017-02-22 13:00:14 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 13:00:14 New OpenVPN Status (RESOLVE->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,, 2017-02-22 13:00:14 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.net:443 (No address associated with hostname) 2017-02-22 13:00:14 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ] 2017-02-22 13:00:14 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-client' 2017-02-22 13:00:14 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1604,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,cipher AES-256-CBC,auth SHA512,keysize 256,key-method 2,tls-server' 2017-02-22 13:00:14 MANAGEMENT: >STATE:1487764814,RESOLVE,,,,,, 2017-02-22 13:00:54 RESOLVE: Cannot resolve host address: linux-switzerland.cryptostorm.net:443 (No address associated with hostname) 2017-02-22 13:00:54 MANAGEMENT: CMD 'signal SIGINT' 2017-02-22 13:01:34 RESOLVE: signal received during DNS resolution attempt 2017-02-22 13:01:34 Could not determine IPv4/IPv6 protocol 2017-02-22 13:01:34 Sorry, deleting routes on Android is not possible. The VpnService API allows routes to be set on connect only. 2017-02-22 13:01:34 Sorry, deleting routes on Android is not possible. The VpnService API allows routes to be set on connect only. 2017-02-22 13:01:34 Closing TUN/TAP interface 2017-02-22 13:01:35 Network Status: CONNECTED HSPA to MOBILE mworld.be 2017-02-22 13:01:35 Debug state info: CONNECTED HSPA to MOBILE mworld.be, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED 2017-02-22 13:01:36 SIGHUP[hard,close_context usr1 to hup] received, process restarting 2017-02-22 13:01:36 Waiting 0s seconds between connection attempt 2017-02-22 13:01:36 MANAGEMENT: >STATE:1487764896,RECONNECTING,close_context usr1 to hup,,,,, 2017-02-22 13:01:36 Current Parameter Settings: 2017-02-22 13:01:36 config = '/data/data/de.blinkt.openvpn/cache/android.conf' 2017-02-22 13:01:36 mode = 0 2017-02-22 13:01:36 NOTE: --mute triggered... 2017-02-22 13:01:36 250 variation(s) on previous 3 message(s) suppressed by --mute 2017-02-22 13:01:36 OpenVPN 2.5-icsopenvpn [git:HEAD-3bb5086974d443b6] android-14-armeabi-v7a [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on Jan 30 2017 2017-02-22 13:01:36 library versions: OpenSSL 1.0.2k 26 Jan 2017, LZO 2.09 2017-02-22 13:01:36 MANAGEMENT: Client disconnected 2017-02-22 13:01:36 MANAGEMENT: Triggering management exit 2017-02-22 13:01:36 Signal received from management interface, exiting 2017-02-22 13:01:36 New OpenVPN Status (NOPROCESS->LEVEL_NOTCONNECTED): No process running. 2017-02-22 13:01:36 New OpenVPN Status (NOPROCESS->LEVEL_NOTCONNECTED): No process running.

ghost commented 7 years ago

I've been having this exact problem as well on my OnePlus 3 - stock Marshmallow, cm14.1, laos14.1, omni7.1, it doesn't matter. I'd be happy to test the issue in some way if that would help fix it. I'm able to reproduce it by running a script that causes a WiFi-reconnect. edit: I'll be using OpenVPN connect for a while for the IPv6 support, but if there is interest I'll keep the possibility of testing this issue in mind.

nordurljosahvida commented 7 years ago

Hi again. I can confirm this happens to me on CM13 on Oneplus 3 even without persistent tun, every time my network changes. If I press reconnect it works every time. Would it be possible to add an option to force the VPN to "reconnect" [as in the function associated to the "reconnect" button on the contextual overlay] every time the network changes? Thank you

schwabe commented 7 years ago

@nikksno and @ev3y2 can you also send me your logs? I haven't seen anything in the other logs that I could reproduce maybe your logs are more helpful

@nikksno the code should do that, but for some reason it doesn't. For some reason the state machine gets confused

ghost commented 7 years ago

@schwabe yes; where/how should I send them to you?

schwabe commented 7 years ago

post here or to arne-openvpn@rfc2549.org

TheBestTheBestTheBest commented 7 years ago

@schwabe Another update: after switching from TCP file to UDP config file, the reconnect works almost flawlessly. Is it possible there is a problem using TCP?

ghost commented 7 years ago

cleared my log, set logging to full verbosity 09:01:09 connected to my VPN 09:01:36 ran as root a script that disables IPv6, which I believe causes a reset of the wlan0 interface (note: this script is simply something I can use to reproduce the issue - I don't believe the act of disabling IPv6 itself has anything to do with the issue) WiFi disconnects and reconnects successfully 09:01:46 notification status is "Waiting 2 seconds between reconnect attempts" for over one minute with no change 09:03:09 I manually pause and unpause the VPN via the button in the notification tray VPN successfully reconnects

ICS OpenVPN log file
2017-03-28 09:00:42 official build 0.6.65 running on OnePlus ONEPLUS A3000 (msm8996), Android 7.1.1 (N4F26T) API 25, ABI arm64-v8a, (OnePlus/OnePlus3/OnePlus3:7.1.1/NMF26F/02070826:user/release-keys)
2017-03-28 09:00:42 Log cleared.
2017-03-28 09:01:09 Building configuration…
2017-03-28 09:01:09 New OpenVPN Status (VPN_GENERATE_CONFIG->LEVEL_START):
2017-03-28 09:01:09 New OpenVPN Status (VPN_GENERATE_CONFIG->LEVEL_START):
2017-03-28 09:01:09 started Socket Thread
2017-03-28 09:01:09 Network Status: CONNECTED to WIFI "my_ssid"
2017-03-28 09:01:09 Debug state info: CONNECTED to WIFI "my_ssid", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
2017-03-28 09:01:09 Debug state info: CONNECTED to WIFI "my_ssid", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
2017-03-28 09:01:09 P:Initializing Google Breakpad!
2017-03-28 09:01:09 Current Parameter Settings:
2017-03-28 09:01:09 config = '/data/user/0/de.blinkt.openvpn/cache/android.conf'
2017-03-28 09:01:09 mode = 0
2017-03-28 09:01:09 show_ciphers = DISABLED
2017-03-28 09:01:09 show_digests = DISABLED
2017-03-28 09:01:09 show_engines = DISABLED
2017-03-28 09:01:09 genkey = DISABLED
2017-03-28 09:01:09 key_pass_file = '[UNDEF]'
2017-03-28 09:01:09 show_tls_ciphers = DISABLED
2017-03-28 09:01:09 connect_retry_max = 0
2017-03-28 09:01:09 Connection profiles [0]:
2017-03-28 09:01:09 proto = tcp-client
2017-03-28 09:01:09 local = '[UNDEF]'
2017-03-28 09:01:09 local_port = '[UNDEF]'
2017-03-28 09:01:09 Waiting 0s seconds between connection attempt
2017-03-28 09:01:09 remote = 'my.vpn.ip.address'
2017-03-28 09:01:09 remote_port = '636'
2017-03-28 09:01:09 remote_float = DISABLED
2017-03-28 09:01:09 bind_defined = DISABLED
2017-03-28 09:01:09 bind_local = DISABLED
2017-03-28 09:01:09 bind_ipv6_only = DISABLED
2017-03-28 09:01:09 connect_retry_seconds = 2
2017-03-28 09:01:09 connect_timeout = 120
2017-03-28 09:01:09 socks_proxy_server = '[UNDEF]'
2017-03-28 09:01:09 socks_proxy_port = '[UNDEF]'
2017-03-28 09:01:09 tun_mtu = 1500
2017-03-28 09:01:09 tun_mtu_defined = ENABLED
2017-03-28 09:01:09 link_mtu = 1500
2017-03-28 09:01:09 link_mtu_defined = DISABLED
2017-03-28 09:01:09 tun_mtu_extra = 0
2017-03-28 09:01:09 tun_mtu_extra_defined = DISABLED
2017-03-28 09:01:09 mtu_discover_type = -1
2017-03-28 09:01:09 fragment = 0
2017-03-28 09:01:09 mssfix = 1450
2017-03-28 09:01:09 explicit_exit_notification = 0
2017-03-28 09:01:09 Connection profiles END
2017-03-28 09:01:09 remote_random = DISABLED
2017-03-28 09:01:09 ipchange = '[UNDEF]'
2017-03-28 09:01:09 dev = 'tun'
2017-03-28 09:01:09 dev_type = '[UNDEF]'
2017-03-28 09:01:09 dev_node = '[UNDEF]'
2017-03-28 09:01:09 lladdr = '[UNDEF]'
2017-03-28 09:01:09 topology = 1
2017-03-28 09:01:09 ifconfig_local = '[UNDEF]'
2017-03-28 09:01:09 ifconfig_remote_netmask = '[UNDEF]'
2017-03-28 09:01:09 ifconfig_noexec = DISABLED
2017-03-28 09:01:09 ifconfig_nowarn = ENABLED
2017-03-28 09:01:09 ifconfig_ipv6_local = '[UNDEF]'
2017-03-28 09:01:09 ifconfig_ipv6_netbits = 0
2017-03-28 09:01:09 ifconfig_ipv6_remote = '[UNDEF]'
2017-03-28 09:01:09 shaper = 0
2017-03-28 09:01:09 mtu_test = 0
2017-03-28 09:01:09 mlock = DISABLED
2017-03-28 09:01:09 keepalive_ping = 0
2017-03-28 09:01:09 keepalive_timeout = 0
2017-03-28 09:01:09 inactivity_timeout = 0
2017-03-28 09:01:09 ping_send_timeout = 0
2017-03-28 09:01:09 ping_rec_timeout = 0
2017-03-28 09:01:09 ping_rec_timeout_action = 0
2017-03-28 09:01:09 ping_timer_remote = DISABLED
2017-03-28 09:01:09 remap_sigusr1 = 0
2017-03-28 09:01:09 persist_tun = ENABLED
2017-03-28 09:01:09 persist_local_ip = DISABLED
2017-03-28 09:01:09 persist_remote_ip = DISABLED
2017-03-28 09:01:09 persist_key = DISABLED
2017-03-28 09:01:09 passtos = DISABLED
2017-03-28 09:01:09 resolve_retry_seconds = 1000000000
2017-03-28 09:01:09 resolve_in_advance = ENABLED
2017-03-28 09:01:09 username = '[UNDEF]'
2017-03-28 09:01:09 groupname = '[UNDEF]'
2017-03-28 09:01:09 chroot_dir = '[UNDEF]'
2017-03-28 09:01:09 cd_dir = '[UNDEF]'
2017-03-28 09:01:09 writepid = '[UNDEF]'
2017-03-28 09:01:09 up_script = '[UNDEF]'
2017-03-28 09:01:09 down_script = '[UNDEF]'
2017-03-28 09:01:09 down_pre = DISABLED
2017-03-28 09:01:09 up_restart = DISABLED
2017-03-28 09:01:09 up_delay = DISABLED
2017-03-28 09:01:09 daemon = DISABLED
2017-03-28 09:01:09 inetd = 0
2017-03-28 09:01:09 log = DISABLED
2017-03-28 09:01:09 suppress_timestamps = DISABLED
2017-03-28 09:01:09 machine_readable_output = ENABLED
2017-03-28 09:01:09 nice = 0
2017-03-28 09:01:09 verbosity = 4
2017-03-28 09:01:09 mute = 0
2017-03-28 09:01:09 gremlin = 0
2017-03-28 09:01:09 status_file = '[UNDEF]'
2017-03-28 09:01:09 status_file_version = 1
2017-03-28 09:01:09 status_file_update_freq = 60
2017-03-28 09:01:09 occ = ENABLED
2017-03-28 09:01:09 rcvbuf = 0
2017-03-28 09:01:09 sndbuf = 0
2017-03-28 09:01:09 sockflags = 0
2017-03-28 09:01:09 fast_io = DISABLED
2017-03-28 09:01:09 comp.alg = 2
2017-03-28 09:01:09 comp.flags = 1
2017-03-28 09:01:09 route_script = '[UNDEF]'
2017-03-28 09:01:09 route_default_gateway = '[UNDEF]'
2017-03-28 09:01:09 route_default_metric = 0
2017-03-28 09:01:09 route_noexec = DISABLED
2017-03-28 09:01:09 route_delay = 0
2017-03-28 09:01:09 route_delay_window = 30
2017-03-28 09:01:09 route_delay_defined = DISABLED
2017-03-28 09:01:09 route_nopull = DISABLED
2017-03-28 09:01:09 route_gateway_via_dhcp = DISABLED
2017-03-28 09:01:09 allow_pull_fqdn = DISABLED
2017-03-28 09:01:09 route 0.0.0.0/0.0.0.0/vpn_gateway/default (not set)
2017-03-28 09:01:09 management_addr = '/data/user/0/de.blinkt.openvpn/cache/mgmtsocket'
2017-03-28 09:01:09 management_port = 'unix'
2017-03-28 09:01:09 management_user_pass = '[UNDEF]'
2017-03-28 09:01:09 management_log_history_cache = 250
2017-03-28 09:01:09 management_echo_buffer_size = 100
2017-03-28 09:01:09 management_write_peer_info_file = '[UNDEF]'
2017-03-28 09:01:09 management_client_user = '[UNDEF]'
2017-03-28 09:01:09 management_client_group = '[UNDEF]'
2017-03-28 09:01:09 management_flags = 4390
2017-03-28 09:01:09 shared_secret_file = '[UNDEF]'
2017-03-28 09:01:09 key_direction = 1
2017-03-28 09:01:09 ciphername = 'AES-256-CBC'
2017-03-28 09:01:09 ncp_enabled = ENABLED
2017-03-28 09:01:09 ncp_ciphers = 'AES-256-GCM:AES-128-GCM'
2017-03-28 09:01:09 authname = 'SHA256'
2017-03-28 09:01:09 prng_hash = 'SHA1'
2017-03-28 09:01:09 prng_nonce_secret_len = 16
2017-03-28 09:01:09 keysize = 0
2017-03-28 09:01:09 engine = DISABLED
2017-03-28 09:01:09 replay = ENABLED
2017-03-28 09:01:09 mute_replay_warnings = DISABLED
2017-03-28 09:01:09 replay_window = 64
2017-03-28 09:01:09 replay_time = 15
2017-03-28 09:01:09 packet_id_file = '[UNDEF]'
2017-03-28 09:01:09 test_crypto = DISABLED
2017-03-28 09:01:09 tls_server = DISABLED
2017-03-28 09:01:09 tls_client = ENABLED
2017-03-28 09:01:09 key_method = 2
2017-03-28 09:01:09 ca_file = '[[INLINE]]'
2017-03-28 09:01:09 ca_path = '[UNDEF]'
2017-03-28 09:01:09 dh_file = '[UNDEF]'
2017-03-28 09:01:09 cert_file = '[[INLINE]]'
2017-03-28 09:01:09 extra_certs_file = '[UNDEF]'
2017-03-28 09:01:09 priv_key_file = '[[INLINE]]'
2017-03-28 09:01:09 pkcs12_file = '[UNDEF]'
2017-03-28 09:01:09 cipher_list = '[UNDEF]'
2017-03-28 09:01:09 tls_verify = '[UNDEF]'
2017-03-28 09:01:09 tls_export_cert = '[UNDEF]'
2017-03-28 09:01:09 verify_x509_type = 2
2017-03-28 09:01:09 verify_x509_name = 'tarpaulin.whippet'
2017-03-28 09:01:09 crl_file = '[UNDEF]'
2017-03-28 09:01:09 ns_cert_type = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 160
2017-03-28 09:01:09 remote_cert_ku[i] = 136
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_ku[i] = 0
2017-03-28 09:01:09 remote_cert_eku = 'TLS Web Server Authentication'
2017-03-28 09:01:09 ssl_flags = 192
2017-03-28 09:01:09 tls_timeout = 2
2017-03-28 09:01:09 renegotiate_bytes = -1
2017-03-28 09:01:09 renegotiate_packets = 0
2017-03-28 09:01:09 renegotiate_seconds = 3600
2017-03-28 09:01:09 handshake_window = 60
2017-03-28 09:01:09 transition_window = 3600
2017-03-28 09:01:09 single_session = DISABLED
2017-03-28 09:01:09 push_peer_info = DISABLED
2017-03-28 09:01:09 tls_exit = DISABLED
2017-03-28 09:01:09 tls_auth_file = '[[INLINE]]'
2017-03-28 09:01:09 tls_crypt_file = '[UNDEF]'
2017-03-28 09:01:09 client = ENABLED
2017-03-28 09:01:09 pull = ENABLED
2017-03-28 09:01:09 auth_user_pass_file = '[UNDEF]'
2017-03-28 09:01:09 OpenVPN 2.5-icsopenvpn [git:icsopenvpn-5711c5bd3a04f48b] android-21-arm64-v8a [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on Feb 4 2017
2017-03-28 09:01:09 library versions: OpenSSL 1.0.2k 26 Jan 2017, LZO 2.09
2017-03-28 09:01:09 MANAGEMENT: Connected to management server at /data/user/0/de.blinkt.openvpn/cache/mgmtsocket
2017-03-28 09:01:09 MANAGEMENT: CMD 'hold release'
2017-03-28 09:01:09 MANAGEMENT: CMD 'proxy NONE'
2017-03-28 09:01:09 MANAGEMENT: CMD 'bytecount 2'
2017-03-28 09:01:09 MANAGEMENT: CMD 'state on'
2017-03-28 09:01:10 Outgoing Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:01:10 Incoming Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:01:10 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:01:10 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:01:10 LZO compression initializing
2017-03-28 09:01:10 Control Channel MTU parms [ L:1624 D:1170 EF:80 EB:0 ET:0 EL:3 ]
2017-03-28 09:01:10 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ]
2017-03-28 09:01:10 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1572,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,keydir 1,cipher AES-256-CBC,auth SHA256,keysize 256,tls-auth,key-method 2,tls-client'
2017-03-28 09:01:10 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1572,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,keydir 0,cipher AES-256-CBC,auth SHA256,keysize 256,tls-auth,key-method 2,tls-server'
2017-03-28 09:01:10 TCP/UDP: Preserving recently used remote address: [AF_INET]my.vpn.ip.address:636
2017-03-28 09:01:10 Socket Buffers: R=[2097152->2097152] S=[524288->524288]
2017-03-28 09:01:10 Attempting to establish TCP connection with [AF_INET]my.vpn.ip.address:636 [nonblock]
2017-03-28 09:01:10 MANAGEMENT: >STATE:1490706070,TCP_CONNECT,,,,,,
2017-03-28 09:01:10 MANAGEMENT: CMD 'needok 'PROTECTFD' ok'
2017-03-28 09:01:11 TCP connection established with [AF_INET]my.vpn.ip.address:636
2017-03-28 09:01:11 MANAGEMENT: CMD 'needok 'PROTECTFD' ok'
2017-03-28 09:01:11 TCP_CLIENT link local: (not bound)
2017-03-28 09:01:11 TCP_CLIENT link remote: [AF_INET]my.vpn.ip.address:636
2017-03-28 09:01:11 MANAGEMENT: >STATE:1490706071,WAIT,,,,,,
2017-03-28 09:01:11 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:01:11 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:01:11 MANAGEMENT: >STATE:1490706071,AUTH,,,,,,
2017-03-28 09:01:11 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:01:11 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:01:11 TLS: Initial packet from [AF_INET]my.vpn.ip.address:636, sid=11f40cb3 c83263d7
2017-03-28 09:01:11 VERIFY OK: depth=1, C=US, ST=California, L=Beverly Hills, O=ACME CORPORATION, OU=Anvil Department, CN=ca-certificate
2017-03-28 09:01:11 Validating certificate key usage
2017-03-28 09:01:11 ++ Certificate has key usage 00a0, expects 00a0
2017-03-28 09:01:11 VERIFY KU OK
2017-03-28 09:01:11 Validating certificate extended key usage
2017-03-28 09:01:11 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
2017-03-28 09:01:11 VERIFY EKU OK
2017-03-28 09:01:11 VERIFY X509NAME OK: C=US, ST=California, L=Beverly Hills, O=ACME CORPORATION, OU=Anvil Department, CN=tarpaulin.whippet
2017-03-28 09:01:11 VERIFY OK: depth=0, C=US, ST=California, L=Beverly Hills, O=ACME CORPORATION, OU=Anvil Department, CN=tarpaulin.whippet
2017-03-28 09:01:11 Control Channel: TLSv1.2, cipher TLSv1/SSLv3 DHE-RSA-AES256-GCM-SHA384, 2048 bit RSA
2017-03-28 09:01:11 [tarpaulin.whippet] Peer Connection Initiated with [AF_INET]my.vpn.ip.address:636
2017-03-28 09:01:12 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:01:12 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:01:12 MANAGEMENT: >STATE:1490706072,GET_CONFIG,,,,,,
2017-03-28 09:01:12 SENT CONTROL [tarpaulin.whippet]: 'PUSH_REQUEST' (status=1)
2017-03-28 09:01:12 PUSH: Received control message: 'PUSH_REPLY,dhcp-option DNS 10.8.0.1,redirect-gateway def1,block-outside-dns,route 10.8.0.0 255.255.255.0,topology net30,ping 10,ping-restart 120,ifconfig 10.8.0.6 10.8.0.5'
2017-03-28 09:01:12 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.8.0.6,,,,
2017-03-28 09:01:12 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.8.0.6,,,,
2017-03-28 09:01:12 Options error: Unrecognized option or missing or extra parameter(s) in [PUSH-OPTIONS]:3: block-outside-dns (2.5_master)
2017-03-28 09:01:12 OPTIONS IMPORT: timers and/or timeouts modified
2017-03-28 09:01:12 OPTIONS IMPORT: --ifconfig/up options modified
2017-03-28 09:01:12 OPTIONS IMPORT: route options modified
2017-03-28 09:01:12 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
2017-03-28 09:01:12 Data Channel MTU parms [ L:1572 D:1450 EF:72 EB:406 ET:0 EL:3 ]
2017-03-28 09:01:12 Data Channel Encrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
2017-03-28 09:01:12 Data Channel Encrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:01:12 Data Channel Decrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
2017-03-28 09:01:12 Data Channel Decrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:01:12 GDG: SIOCGIFHWADDR(lo) failed
2017-03-28 09:01:12 ROUTE_GATEWAY 127.100.103.119/255.0.0.0 IFACE=lo
2017-03-28 09:01:12 GDG6: remote_host_ipv6=n/a
2017-03-28 09:01:12 ROUTE6: default_gateway=UNDEF
2017-03-28 09:01:12 OpenVPN ROUTE6: OpenVPN needs a gateway parameter for a --route-ipv6 option and no default was specified by either --route-ipv6-gateway or --ifconfig-ipv6 options
2017-03-28 09:01:12 OpenVPN ROUTE: failed to parse/resolve route for host/network: ::/0
2017-03-28 09:01:12 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
2017-03-28 09:01:12 MANAGEMENT: >STATE:1490706072,ASSIGN_IP,,10.8.0.6,,,,
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'IFCONFIG' ok'
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2017-03-28 09:01:12 MANAGEMENT: >STATE:1490706072,ADD_ROUTES,,,,,,
2017-03-28 09:01:12 New OpenVPN Status (ADD_ROUTES->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:01:12 New OpenVPN Status (ADD_ROUTES->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'DNSSERVER' ok'
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'DNSSERVER' ok'
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'DNSSERVER' ok'
2017-03-28 09:01:12 MANAGEMENT: CMD 'needok 'DNSDOMAIN' ok'
2017-03-28 09:01:13 MANAGEMENT: CMD 'needok 'PERSIST_TUN_ACTION' OPEN_BEFORE_CLOSE'
2017-03-28 09:01:13 Opening tun interface:
2017-03-28 09:01:13 Local IPv4: 10.8.0.6/30 IPv6: null MTU: 1500
2017-03-28 09:01:13 DNS Server: my.dns.server.1, my.dns.server.2, 10.8.0.1, Domain: blinkt.de
2017-03-28 09:01:13 Routes: 0.0.0.0/0, 10.8.0.0/24, 10.8.0.4/30
2017-03-28 09:01:13 Routes excluded: 10.0.0.32/24
2017-03-28 09:01:13 VpnService routes installed: 0.0.0.0/5, 8.0.0.0/7, 10.0.1.0/24, 10.0.2.0/23, 10.0.4.0/22, 10.0.8.0/21, 10.0.16.0/20, 10.0.32.0/19, 10.0.64.0/18, 10.0.128.0/17, 10.1.0.0/16, 10.2.0.0/15, 10.4.0.0/14, 10.8.0.0/13, 10.16.0.0/12, 10.32.0.0/11, 10.64.0.0/10, 10.128.0.0/9, 11.0.0.0/8, 12.0.0.0/6, 16.0.0.0/4, 32.0.0.0/3, 64.0.0.0/2, 128.0.0.0/1
2017-03-28 09:01:13 Disallowed VPN apps:
2017-03-28 09:01:13 MANAGEMENT: CMD 'needok 'OPENTUN' ok'
2017-03-28 09:01:13 Initialization Sequence Completed
2017-03-28 09:01:13 MANAGEMENT: >STATE:1490706073,CONNECTED,SUCCESS,10.8.0.6,my.vpn.ip.address,636,10.0.0.32,49513
2017-03-28 09:01:13 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.8.0.6,my.vpn.ip.address,636,10.0.0.32,49513
2017-03-28 09:01:13 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.8.0.6,my.vpn.ip.address,636,10.0.0.32,49513
2017-03-28 09:01:13 Debug state info: CONNECTED to WIFI "my_ssid", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
2017-03-28 09:01:36 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): connection-reset,,,,,
2017-03-28 09:01:36 New OpenVPN Status (RECONNECTING->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): connection-reset,,,,,
2017-03-28 09:01:36 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2
2017-03-28 09:01:37 New OpenVPN Status (CONNECTRETRY->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): 2
2017-03-28 09:01:36 read TCP_CLIENT []: Software caused connection abort (code=103)
2017-03-28 09:01:37 Connection reset, restarting [0]
2017-03-28 09:01:37 TCP/UDP: Closing socket
2017-03-28 09:01:37 SIGUSR1[soft,connection-reset] received, process restarting
2017-03-28 09:01:37 MANAGEMENT: >STATE:1490706096,RECONNECTING,connection-reset,,,,,
2017-03-28 09:01:37 Waiting 2s seconds between connection attempt
2017-03-28 09:01:37 Network Status: not connected
2017-03-28 09:01:37 Debug state info: not connected, pause: userPause, shouldbeconnected: false, network: PENDINGDISCONNECT
2017-03-28 09:01:41 MANAGEMENT: CMD 'network-change'
2017-03-28 09:01:41 Network Status: CONNECTED EDGE to MOBILE my.data.apn
2017-03-28 09:01:41 Debug state info: CONNECTED EDGE to MOBILE my.data.apn, pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
2017-03-28 09:01:46 MANAGEMENT: CMD 'network-change'
2017-03-28 09:01:46 Network Status: CONNECTED to WIFI "my_ssid"
2017-03-28 09:01:46 Debug state info: CONNECTED to WIFI "my_ssid", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
2017-03-28 09:01:46 Debug state info: CONNECTED to WIFI "my_ssid", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
2017-03-28 09:03:09 New OpenVPN Status (USERPAUSE->LEVEL_VPNPAUSED):
2017-03-28 09:03:09 New OpenVPN Status (USERPAUSE->LEVEL_VPNPAUSED):
2017-03-28 09:03:09 MANAGEMENT: CMD 'signal SIGUSR1'
2017-03-28 09:03:10 MANAGEMENT: CMD 'hold release'
2017-03-28 09:03:10 MANAGEMENT: CMD 'proxy NONE'
2017-03-28 09:03:10 MANAGEMENT: CMD 'bytecount 2'
2017-03-28 09:03:10 MANAGEMENT: CMD 'state on'
2017-03-28 09:03:11 Outgoing Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:03:11 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:03:11 New OpenVPN Status (TCP_CONNECT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:03:11 Incoming Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:03:11 LZO compression initializing
2017-03-28 09:03:11 Control Channel MTU parms [ L:1624 D:1170 EF:80 EB:0 ET:0 EL:3 ]
2017-03-28 09:03:11 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ]
2017-03-28 09:03:11 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1572,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,keydir 1,cipher AES-256-CBC,auth SHA256,keysize 256,tls-auth,key-method 2,tls-client'
2017-03-28 09:03:11 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1572,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,keydir 0,cipher AES-256-CBC,auth SHA256,keysize 256,tls-auth,key-method 2,tls-server'
2017-03-28 09:03:11 TCP/UDP: Preserving recently used remote address: [AF_INET]my.vpn.ip.address:636
2017-03-28 09:03:11 Socket Buffers: R=[2097152->2097152] S=[524288->524288]
2017-03-28 09:03:11 Attempting to establish TCP connection with [AF_INET]my.vpn.ip.address:636 [nonblock]
2017-03-28 09:03:11 MANAGEMENT: >STATE:1490706191,TCP_CONNECT,,,,,,
2017-03-28 09:03:11 MANAGEMENT: CMD 'needok 'PROTECTFD' ok'
2017-03-28 09:03:12 TCP connection established with [AF_INET]my.vpn.ip.address:636
2017-03-28 09:03:12 MANAGEMENT: CMD 'needok 'PROTECTFD' ok'
2017-03-28 09:03:12 TCP_CLIENT link local: (not bound)
2017-03-28 09:03:12 TCP_CLIENT link remote: [AF_INET]my.vpn.ip.address:636
2017-03-28 09:03:12 MANAGEMENT: >STATE:1490706192,WAIT,,,,,,
2017-03-28 09:03:12 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:03:12 New OpenVPN Status (WAIT->LEVEL_CONNECTING_NO_SERVER_REPLY_YET): ,,,,,
2017-03-28 09:03:12 MANAGEMENT: >STATE:1490706192,AUTH,,,,,,
2017-03-28 09:03:12 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:03:12 New OpenVPN Status (AUTH->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:03:12 TLS: Initial packet from [AF_INET]my.vpn.ip.address:636, sid=0fa381b2 db8f99fe
2017-03-28 09:03:12 VERIFY OK: depth=1, C=US, ST=California, L=Beverly Hills, O=ACME CORPORATION, OU=Anvil Department, CN=ca-certificate
2017-03-28 09:03:12 Validating certificate key usage
2017-03-28 09:03:12 ++ Certificate has key usage 00a0, expects 00a0
2017-03-28 09:03:12 VERIFY KU OK
2017-03-28 09:03:12 Validating certificate extended key usage
2017-03-28 09:03:12 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
2017-03-28 09:03:12 VERIFY EKU OK
2017-03-28 09:03:12 VERIFY X509NAME OK: C=US, ST=California, L=Beverly Hills, O=ACME CORPORATION, OU=Anvil Department, CN=tarpaulin.whippet
2017-03-28 09:03:12 VERIFY OK: depth=0, C=US, ST=California, L=Beverly Hills, O=ACME CORPORATION, OU=Anvil Department, CN=tarpaulin.whippet
2017-03-28 09:03:12 Control Channel: TLSv1.2, cipher TLSv1/SSLv3 DHE-RSA-AES256-GCM-SHA384, 2048 bit RSA
2017-03-28 09:03:12 [tarpaulin.whippet] Peer Connection Initiated with [AF_INET]my.vpn.ip.address:636
2017-03-28 09:03:13 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:03:13 New OpenVPN Status (GET_CONFIG->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:03:13 MANAGEMENT: >STATE:1490706193,GET_CONFIG,,,,,,
2017-03-28 09:03:13 SENT CONTROL [tarpaulin.whippet]: 'PUSH_REQUEST' (status=1)
2017-03-28 09:03:13 PUSH: Received control message: 'PUSH_REPLY,dhcp-option DNS 10.8.0.1,redirect-gateway def1,block-outside-dns,route 10.8.0.0 255.255.255.0,topology net30,ping 10,ping-restart 120,ifconfig 10.8.0.6 10.8.0.5'
2017-03-28 09:03:13 Options error: Unrecognized option or missing or extra parameter(s) in [PUSH-OPTIONS]:3: block-outside-dns (2.5_master)
2017-03-28 09:03:13 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.8.0.6,,,,
2017-03-28 09:03:13 New OpenVPN Status (ASSIGN_IP->LEVEL_CONNECTING_SERVER_REPLIED): ,10.8.0.6,,,,
2017-03-28 09:03:13 OPTIONS IMPORT: timers and/or timeouts modified
2017-03-28 09:03:13 OPTIONS IMPORT: --ifconfig/up options modified
2017-03-28 09:03:13 OPTIONS IMPORT: route options modified
2017-03-28 09:03:13 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
2017-03-28 09:03:13 Data Channel MTU parms [ L:1572 D:1450 EF:72 EB:406 ET:0 EL:3 ]
2017-03-28 09:03:13 Data Channel Encrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
2017-03-28 09:03:13 Data Channel Encrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:03:13 Data Channel Decrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
2017-03-28 09:03:13 Data Channel Decrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
2017-03-28 09:03:13 GDG: SIOCGIFHWADDR(lo) failed
2017-03-28 09:03:13 ROUTE_GATEWAY 127.100.103.119/255.0.0.0 IFACE=lo
2017-03-28 09:03:13 GDG6: remote_host_ipv6=n/a
2017-03-28 09:03:13 ROUTE6: default_gateway=UNDEF
2017-03-28 09:03:13 OpenVPN ROUTE6: OpenVPN needs a gateway parameter for a --route-ipv6 option and no default was specified by either --route-ipv6-gateway or --ifconfig-ipv6 options
2017-03-28 09:03:13 OpenVPN ROUTE: failed to parse/resolve route for host/network: ::/0
2017-03-28 09:03:13 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
2017-03-28 09:03:13 MANAGEMENT: >STATE:1490706193,ASSIGN_IP,,10.8.0.6,,,,
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'IFCONFIG' ok'
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2017-03-28 09:03:13 MANAGEMENT: >STATE:1490706193,ADD_ROUTES,,,,,,
2017-03-28 09:03:13 New OpenVPN Status (ADD_ROUTES->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:03:13 New OpenVPN Status (ADD_ROUTES->LEVEL_CONNECTING_SERVER_REPLIED): ,,,,,
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'DNSSERVER' ok'
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'DNSSERVER' ok'
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'DNSSERVER' ok'
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'DNSDOMAIN' ok'
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'PERSIST_TUN_ACTION' OPEN_BEFORE_CLOSE'
2017-03-28 09:03:13 Opening tun interface:
2017-03-28 09:03:13 Local IPv4: 10.8.0.6/30 IPv6: null MTU: 1500
2017-03-28 09:03:13 DNS Server: my.dns.server.1, my.dns.server.2, 10.8.0.1, Domain: blinkt.de
2017-03-28 09:03:13 Routes: 0.0.0.0/0, 10.8.0.0/24, 10.8.0.4/30
2017-03-28 09:03:13 Routes excluded: 10.0.0.32/24
2017-03-28 09:03:13 VpnService routes installed: 0.0.0.0/5, 8.0.0.0/7, 10.0.1.0/24, 10.0.2.0/23, 10.0.4.0/22, 10.0.8.0/21, 10.0.16.0/20, 10.0.32.0/19, 10.0.64.0/18, 10.0.128.0/17, 10.1.0.0/16, 10.2.0.0/15, 10.4.0.0/14, 10.8.0.0/13, 10.16.0.0/12, 10.32.0.0/11, 10.64.0.0/10, 10.128.0.0/9, 11.0.0.0/8, 12.0.0.0/6, 16.0.0.0/4, 32.0.0.0/3, 64.0.0.0/2, 128.0.0.0/1
2017-03-28 09:03:13 Disallowed VPN apps:
2017-03-28 09:03:13 MANAGEMENT: CMD 'needok 'OPENTUN' ok'
2017-03-28 09:03:13 Initialization Sequence Completed
2017-03-28 09:03:13 MANAGEMENT: >STATE:1490706193,CONNECTED,SUCCESS,10.8.0.6,my.vpn.ip.address,636,10.0.0.32,49541
2017-03-28 09:03:13 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.8.0.6,my.vpn.ip.address,636,10.0.0.32,49541
2017-03-28 09:03:13 New OpenVPN Status (CONNECTED->LEVEL_CONNECTED): SUCCESS,10.8.0.6,my.vpn.ip.address,636,10.0.0.32,49541
2017-03-28 09:03:13 Debug state info: CONNECTED to WIFI "my_ssid", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
2017-03-28 09:03:14 Debug state info: CONNECTED to WIFI "my_ssid", pause: userPause, shouldbeconnected: true, network: SHOULDBECONNECTED
ZaherZohbi commented 7 years ago

Same issue :( Note that unlike my colleagues, persistent tunnel was disabled on my configuration

openvpn logs.txt

numericOverflow commented 7 years ago

Any chance this is fixable?

futurealecks commented 7 years ago

I can confirm this also is the case on a nexus 5x and Pixel running 7.1.2. I can also post logs if more are needed.

schwabe commented 7 years ago

Yeah, more logs would be helpful as I still cannot reproduce it :(

futurealecks commented 7 years ago

I can't get it to do it when I need to capture the logs. It seems like it happens the most when you either leave WiFi and connect to cellular (leaving the office/house) and vice versa. However, it's not 100% reproducible.

numericOverflow commented 7 years ago

@schwabe - Is there any way to enable more verbose debugging, which might be more helpful?

aarnoud commented 7 years ago

Issue happens most of the time on mobile networks, it seems related to a connection retry when DATA is not available or too slow it gets stuck at this point. When a WIFI hotspot is available it connect to it, but no data is seen on remote VPN server. At this step it's a permanent error (tunnel no longer works), only a "reconnect" fixes the issue.

nordurljosahvida commented 7 years ago

Exactly the same as @aarnoud. @schwabe, I see you've published a new release, how do I find the .apk and install it to see if it works?

Thank you so much!

schwabe commented 7 years ago

Enroll into the beta version, I just pushed a version

aarnoud commented 7 years ago

@schwabe Thanks for the possible fix, I'm testing and will provide feedback.

aarnoud commented 7 years ago

@schwabe so far, so good, it seems stable now, will give it more time as it's really not a 100% reproductible one and happens most of the time in roadwarrior mode...

futurealecks commented 7 years ago

@schwabe I'm also now on the beta. Thanks for putting this out. Just like @aarnoud saidI can only reproduce it if I'm heavily using it. Will report back.

schwabe commented 7 years ago

I will close the bug for now, if anyone still experiences the bug, please report here, so I can reopen it.

nordurljosahvida commented 7 years ago

Solved for me, thank you so much!

glith commented 7 years ago

I got "Waiting for usable network" today when roaming from wifi to 4G. Had to do a reconnect. Using OpenVPN from 2017-05-29(Beta)

schwabe commented 7 years ago

Please use a newer beta version of my app that actually includes the fix.

glith commented 7 years ago

How do I get a later beta? I am in the beta-program and got an update just some day ago. Can I force some update at Google Play? Log says: 07:05 official build 0.6.70 running on Sony E5823 (msm8994), Android 7.0 (32.3.A.2.33) API 24, ABI arm64-v8a, (Sony/E5823/E5823:7.0/32.3.A.2.33/175102619:user/release-keys) 07:05 OpenVPN 2.5-icsopenvpn [git:icsopenvpn-a3a71dc0a6604559] android-21-arm64-v8a [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on May 29 2017

schwabe commented 7 years ago

opnvpn was built on May 29. The version you have is current.

melkopisi commented 6 years ago

i have this problem but with one device only : infinix hot 4 7.0 nougat rom it works fine with marshmallow in the same device i tried beta version and still not working

schwabe commented 6 years ago

This might then actually be problem of the ROM. In my experience custom ROMs often patch things they don't really understand and break "cornercases" like VPN.

melkopisi commented 6 years ago

But this is the official firmware the latest update

schwabe commented 6 years ago

Google gives me https://forum.xda-developers.com/android/general/rom-aosp-n-7-1-1-infinix-hot-4-x557-16-2-t3680529 and that does not look very official.

melkopisi commented 6 years ago

i've got the update via OTA and here you can find the rom from their official site : http://www.infinixmobility.com/download-center/hot/hot4/?D=1

futurealecks commented 6 years ago

@melkopisi Google official, not Infinix official.