2020-06-05 10:20:46.350 INFO OpenVPNTunnelProvider.startTunnel():216 - Starting tunnel... 2020-06-05 10:20:46.363 INFO OpenVPNTunnelProvider+Configuration.print():642 - Protocols: [UDP:1194, TCP:1195, TCP:443] 2020-06-05 10:20:46.364 INFO OpenVPNTunnelProvider+Configuration.print():643 - Cipher: AES-256-GCM 2020-06-05 10:20:46.364 INFO OpenVPNTunnelProvider+Configuration.print():644 - Digest: HMAC-SHA1 2020-06-05 10:20:46.364 INFO OpenVPNTunnelProvider+Configuration.print():645 - Compression framing: disabled 2020-06-05 10:20:46.364 INFO OpenVPNTunnelProvider+Configuration.print():649 - Compression algorithm: disabled 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():652 - Client verification: enabled 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():657 - TLS wrapping: crypt 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():662 - TLS security level: 3 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():669 - Keep-alive interval: never 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():674 - Keep-alive timeout: never 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():679 - Renegotiation: never 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():682 - Server EKU verification: enabled 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():689 - Host SAN verification: disabled 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():697 - Gateway: not configured 2020-06-05 10:20:46.365 INFO OpenVPNTunnelProvider+Configuration.print():702 - DNS: not configured 2020-06-05 10:20:46.366 INFO OpenVPNTunnelProvider+Configuration.print():408 - MTU: 1250 2020-06-05 10:20:46.366 INFO OpenVPNTunnelProvider+Configuration.print():409 - Debug: true 2020-06-05 10:20:46.366 INFO OpenVPNTunnelProvider+Configuration.print():410 - Masks private data: false 2020-06-05 10:20:46.378 DEBUG OpenVPNTunnelProvider.logCurrentSSID():826 - Current SSID: none (disconnected from WiFi) 2020-06-05 10:20:46.378 INFO OpenVPNTunnelProvider.connectTunnel():317 - Creating link session 2020-06-05 10:20:46.378 DEBUG ConnectionStrategy.createSocket():164 - No endpoints available, will resort to DNS resolution 2020-06-05 10:20:46.378 DEBUG ConnectionStrategy.createSocket():171 - DNS resolve hostname: internet.nl.eduvpn.org 2020-06-05 10:20:46.393 DEBUG ConnectionStrategy.createSocket():175 - DNS resolved addresses: ["145.100.179.13"] 2020-06-05 10:20:46.394 DEBUG ConnectionStrategy.unrolledEndpoints():122 - Unrolled endpoints: [145.100.179.13:UDP:1194, 145.100.179.13:TCP:1195, 145.100.179.13:TCP:443] 2020-06-05 10:20:46.395 DEBUG ConnectionStrategy.createSocket():190 - Pick current endpoint: 145.100.179.13:UDP:1194 2020-06-05 10:20:46.416 INFO OpenVPNTunnelProvider.connectTunnel():336 - Will connect to 145.100.179.13:1194 2020-06-05 10:20:46.418 DEBUG OpenVPNTunnelProvider.connectTunnel():339 - Socket type is NEUDPSocket 2020-06-05 10:20:46.421 DEBUG NEUDPSocket.observeValueInTunnelQueue():149 - Socket state is ready (endpoint: 145.100.179.13:1194 -> in progress) 2020-06-05 10:20:46.421 DEBUG OpenVPNSession.setLink():261 - Starting VPN session 2020-06-05 10:20:46.425 DEBUG OpenVPNSession.hardReset():601 - Send hard reset 2020-06-05 10:20:46.425 DEBUG OpenVPNSession.hardReset():609 - Negotiation key index is 0 2020-06-05 10:20:46.426 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [0] 2020-06-05 10:20:46.426 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 7d36227503c206d5, pid: 0, [0 bytes]} 2020-06-05 10:20:46.426 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 387d36227503c206d5000000015eda005ed6c958a540ae0e8e96e78076fc37086f99d82b3cabc7c11ac2e9ed083d7e016839cfa53436 2020-06-05 10:20:46.428 DEBUG NEUDPSocket.observeValueInTunnelQueue():147 - Socket state is ready (endpoint: 145.100.179.13:1194 -> 145.100.179.13:1194) 2020-06-05 10:20:46.448 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code HARD_RESET_SERVER_V2 and key 0 2020-06-05 10:20:46.449 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {HARD_RESET_SERVER_V2 | 0, sid: e605441196bbab9f, acks: {[0], 7d36227503c206d5}, pid: 0} 2020-06-05 10:20:46.449 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 0 2020-06-05 10:20:46.449 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 7d36227503c206d5, acks: {[0], e605441196bbab9f}} 2020-06-05 10:20:46.449 DEBUG ControlChannel.remoteSessionId():50 - Control: Remote sessionId is e605441196bbab9f 2020-06-05 10:20:46.449 DEBUG OpenVPNSession.handleControlPacket():785 - Start TLS handshake 2020-06-05 10:20:46.454 DEBUG OpenVPNSession.handleControlPacket():819 - TLS.connect: Pulled ciphertext (263 bytes) 2020-06-05 10:20:46.454 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [1] 2020-06-05 10:20:46.454 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 1, [263 bytes]} 2020-06-05 10:20:46.455 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (317 bytes): 207d36227503c206d5000000035eda005e94acbb6bcd8285754a51968091ecf22ec80201a0fff9cc7aa49462537ccab5609a2725ed4bbd07ba7166ff2db74a7da88bd0843aeafb4acc4e0e3d002014baae51bf493ee2c3db4c813b8254d25e2734a908c2fc93bd9e9786d47b80c1ef08667bed5cf3eeee054e1ee33da99c89ffe4fa2f7ca9969da545707c0d67108eda69effc03828ea5022aadef71e8e3ddf912e66ee56572fc259c4b5da65d77f4c11c3203aade6becf3e2a11df8d0d0c3424d746fd8297c0155c2f5b57bdb524a2258e5ddf55d6f83edbd64860b68244450c6b7e84ac641984dba870746083f6d785c2176ba8b94932ddb7b628032c99a8c1f5a2988ca935a0015fed55b42cbb64652c94a2cd68fb7c7edba0492a6bce16d936221b6d2c8962ed4e1797cc697768e0ce0beb361b6fe0cbecc444615 2020-06-05 10:20:46.455 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 0 2020-06-05 10:20:46.478 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:20:46.479 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: e605441196bbab9f, acks: {[1], 7d36227503c206d5}, pid: 1, [1062 bytes]} 2020-06-05 10:20:46.479 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 1 2020-06-05 10:20:46.482 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 7d36227503c206d5, acks: {[1], e605441196bbab9f}} 2020-06-05 10:20:46.482 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (1062 bytes) 2020-06-05 10:20:46.489 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 1 2020-06-05 10:20:46.490 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:20:46.490 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: e605441196bbab9f, pid: 2, [1062 bytes]} 2020-06-05 10:20:46.490 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 2 2020-06-05 10:20:46.490 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 7d36227503c206d5, acks: {[2], e605441196bbab9f}} 2020-06-05 10:20:46.491 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (1062 bytes) 2020-06-05 10:20:46.491 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:20:46.491 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: e605441196bbab9f, pid: 3, [606 bytes]} 2020-06-05 10:20:46.491 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 3 2020-06-05 10:20:46.491 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 7d36227503c206d5, acks: {[3], e605441196bbab9f}} 2020-06-05 10:20:46.492 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (606 bytes) 2020-06-05 10:20:46.502 DEBUG OpenVPNSession.handleControlPacket():846 - TLS.connect: Send pulled ciphertext (2661 bytes) 2020-06-05 10:20:46.502 DEBUG ControlChannel.enqueueOutboundPackets():157 - Control: Enqueued 3 packets [2-4] 2020-06-05 10:20:46.502 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 2, [1250 bytes]} 2020-06-05 10:20:46.502 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 3, [1250 bytes]} 2020-06-05 10:20:46.502 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 4, [161 bytes]} 2020-06-05 10:20:46.507 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (1304 bytes): 207d36227503c206d5000000075eda005e2d1e5cd03639bb78e3c1cbb21514283f8aa627ac3925ca9885d845261e18a7fd8edb49467eac297868bf6d85bb7248949186c0c1aa9b9714309af794492f849fc66a3197076b616618b01c2a4520ee0e6adeb808bf98ceb3071dee32c8dbe44fcf22adda96dec504c125c5720fc17cc35cbcbd161480daa03aedc13eac11210a979188bc2fbb77e70ce4034fc5dc644dcca2ff0eaf0a2b8bc902e579b4ea6f21f651567ae8aceb50020b7814eda3aec21ba6270b44888996ab153ff853336d6d987e9726d6f3e225d470defa876f1cd67a994e28ee53097e3c1ef7eb4016b4abbd0508da00621d56ad186af14bbbfa81c82de2ac930dcc46b95d2e1c8538ee2fecf530d1a35e36f401a9e58be2439936f3b57eadba3bac20f29070776186e3525e17d39025cd0b5d60452806b71aff9e51faf90144814ad9635f13f34060d05df38fd803ad64c3b599c57060149e646a5681180f3caa18e20cb8676aa687cf2143a915142501c14a6a342d742995f385086eef1dde75c2d5fbc564d07e5e05417d5e36aaf93ba6db2e1128d7119c5e1ab7218871055f737d31c272d4355995f98e4674c9b652e5b23858cfa21a5a203ab1e079b253cc84fed76c99fa937e5ba4434c07849eab799684d43bf274e97e24fcd59424a7b25bb7df4770dbcd7dbc43008649aa9f27ac7cd44ed64499ce2ebb8bcd5355c9bf9bac0f5548ab76b54ba58e9dca73100eceae46f506495cf609039843568bfb703d235ee4c9c833c8b1879db93c20cf1726a1990250728bfd39737b316c52a917dcf80f03023e5eb9ffefa2974aca94f6bb9711939b3dd67b55269b731ab30592a254637b9510942091e54db8b564d7872d82ee047df2c80faa535a5a3e47928d0fa22f45dc657fa580203074d5860adf874ba649c4b8ba999131cd1b0fd1e166ecfc66de93c9e17648dd1aa93120fd7dd907bededdcc359157ccab14b6971d701c7c550a41862c1ebe43ffae65cd5b8754b2e68fbb6e2eb741903905990a87531f4b4715e9a3d9099b4a972bc82cd5d5c897617b9697210e51a39340fcb3cb15e2b8d7774dfa816163743bf385afa8c8e41953d180a6815f923a74a4ffa99579223349a25fb023e7893799cdcf8ca592d61d22f8c3e64a7256d24c9b475df1f54d9d9c16983045bff484116004dbc01d201b2f4a985505ca763291b83ae0943bad6ae9f1431c14bce95b9ad4f3b0828537b8f736a0ad2d91e649fb9530db038218e04183081f3f84906d1a2f83cfdd30e747f0b1c1ce4d9f4850f424fdcd453f37fad0ec2d92602db9b4d8a00dd9941c4c360011d5753f101ddfc5cf486469faaf2ee1398206e5b2f58b5706f6f38da20b51b262ff3d59a68b60dfbacb76339d39abeeba4fb42edfcbb4e039efb23b5ba2ccb6dbc82fbc339d6f2eabc4f942e4d7064c8bdb1f409ea2f467dd7154674b2d77d45b0f789cc44b73250f49d46360cff77d01902f932de77e15a24db3df8a6db92a2fd67bf8390be3875107836ed7ce35fd8543fb171db251b25dbe25e5ef1d2999c6a9396d6e27968f00e67dae16b86ac221fddcfa1f6fe3a3b8e375438838473fa5712981066738475522723f4f7b0ea5ea940151ff7d2b768dd86d385385cdd5c184785580c32e9d82015532ee4a72d56ec26cc6cb7609fb56b27b5c9dd1d0afaf855b4b6f3f605d68e7606f1c4725a15080c3773643c2f2d899335f7b6175d92d73a0d6fb7a2d4ff7ea16459b80ecd4f10d4c79066061ea863a8b1ec5fff7f15cf648a9d507d635a6787f5725e8f159a4a1d7655efccde743d23d628edc 2020-06-05 10:20:46.519 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (1304 bytes): 207d36227503c206d5000000085eda005e8e5c927bdcc33634fb432650c0868731d85adebd74572c466f7c67cb1443f1217353bafc15fc33ce3235056ec7448029310c2bf548342efadc5bad674f286c21b6c704dea070176b15db71e59f88f6b813d06e9077a848ea21cf034967cc28b9028cb02a1ff259eeed6beabe2a4c65fb630bed903f1b613c59532e2b5e3a1dd661698496fd726c8adffca394f8eed075f84b50b061148e396fec546f968be3f8aba5f1e487a996ccfa37a232647b8ea5a6ab3c4e519227f3c834c96d36eded5caf08535aaf928104024ade288cc0a4b4fd6a2c7654c1344ebd6d8793b1d42817187fa888a3544fd24f99eb163d76355f8da5047e8bb9943e316274fabfdafb98d458a8a2a1d73b9a2e47365c472d54115be6775769d91067e0fedac81faca0369ab102362aac740f2b077a4cac045be94ff6627a5d32617b8e87319ec7985f530143ec7ce7ebd8fb57bec9ae82edc9b2bbba1a8136b227c4c6ee4503b7b1fe7af8abb76b689b74beb47947b8ae9fb39671ee8e5084f12a92eaa8cddcfc7cce35c0102ffde896c1ceafc377b4e67b1424ec5c830e70a82712147003a7259733e610a39a529fe064e12d33be3f88b973ebfb180434300152472e0606c7c4eac80fe685893661b1b981b029edb762f59ba2d66cfa550bfb118edcdcdb661efe4901c4971d5be6b5f82a47269554be8367bff1900949b19fb56188865c24c16fd73e7ae099e8420aceb1d28e8c591802398384cbc073c56b56436a3a28091ab6ce0e610b0591a9ffbbcef31048de6bd318f68c437c91a3259115d7c3810be5a65db57aadaa61d9e7735155e272ff4a64b20b20e2e8416a701c53ad7e92f8bee5c2312202b4c0cca90926276e4eed4112fe863fa01fcdad74022ea2bebde1f49992b0098eddfa26d11f169a0194088803bd58334b255104389917854b86b44f67bfa56beb8f44abc28426d741b69ee464d6b3ce9bd1386a94ac5a729236f47554d32d0c363a4a9053f867cc3cb4a4cdfec2bcd7ddafa425714d61b407e749b2ea53ea15f085dbd5309067655ce162342a8fa2b0cdc7938d21a0aaf6c2137ece8ac077e18131c98e359b63a424d4250609272b82f1ff3b8f2760add2f4c2b4c02c0749c2c450cc200b2d66d9724fa5c256414922ae98bf4a0f689429a73220f421ebaa1f9df7ed4a4caa7bc5979213269d42b50e03aa8d941758a24968bc68cbad6dcc262f3cc57bdc56fc01d5f66c83550c5a71bd0d139b05d52f12982b50a368f7544fe9a4bc3921b4b4736d0f6442027eeec08f0b130687b59cbe1fba589bc57ff4660b21c31939d05d6e8d1c167a6648a4823f5f1903354d4a213d98aacaf7c006171e70d91f143f763f1ae18214796b55220375cd1f58c2c8e16b6b531292cd1eea150d7406325a3f3863248d664505394ca56735b2a9aaf0466a4416d9a85d8d69191d559c12e8b16baceb038bda3303b2e88628ef9a41b2a75523cb6b1e9738c534c380a92b4d3a2d0b0d979b98c6328e29a963d1e6b65cdbddb329cc530c4c3f6e4a0415c3dc4238919c6922e8628f27724fdfdcc41f6eec43be18ac71c0f75d51d0d7811df47b42d15944155b942c97c834e14e23c6b5f4a2e57f24f034046163a655d4745900b57311525d390d8d368159dcf8aafcfe6daa5346a24d0e6991fd1b2debc185db229c8c4129606e2a23720dec0ece83bba1ee237bffd8ddaac8286b6a79b35bfd9b436dd932493b87502be84bf7ce248f78c7e68f3095563176aeae943af4344739caddf4bd6b6e3462ba5a5dd131403addbae5c203776a3ffa819c1ea156ea 2020-06-05 10:20:46.520 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (215 bytes): 207d36227503c206d5000000095eda005edd58b89e351b58235cb4a5690bbae6652d0b98edb28b35fb8270946c6640f2e75711b3154f753780a4dfe2808ba8971ae2889a01b879ff4ca6a9201348b0044dc0cbe72b0c07a2c67909d6e47e72c69634a1689bd4e713476475ac187e619926d7e8fbacbea886cb4f372e75f6399194e1e7949f16485ae6c17a10c9e45390f4d0bfb155a8e671cdbdb8c65f161188914cbb9e52836bb03e6473b2a3fdb8b65257dbec5596c10f484ac170e4114d2e7238f18539d372e62ccd7137f49570fc2c6cbdc8407988 2020-06-05 10:20:46.521 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 2 2020-06-05 10:20:46.521 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 3 2020-06-05 10:20:46.538 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:20:46.539 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: e605441196bbab9f, acks: {[2], 7d36227503c206d5}} 2020-06-05 10:20:46.545 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:20:46.545 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: e605441196bbab9f, acks: {[3], 7d36227503c206d5}} 2020-06-05 10:20:46.546 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:20:46.546 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: e605441196bbab9f, acks: {[4], 7d36227503c206d5}, pid: 4, [51 bytes]} 2020-06-05 10:20:46.546 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 4 2020-06-05 10:20:46.547 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 7d36227503c206d5, acks: {[4], e605441196bbab9f}} 2020-06-05 10:20:46.547 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (51 bytes) 2020-06-05 10:20:46.548 DEBUG OpenVPNSession.onTLSConnect():667 - TLS.connect: Handshake is complete 2020-06-05 10:20:46.548 DEBUG Authenticator.putAuth():146 - TLS.auth: Local options: V4,dev-type tun,keydir 1,cipher AES-256-GCM,auth SHA1,keysize 256,tls-crypt,key-method 2,tls-client 2020-06-05 10:20:46.551 DEBUG Authenticator.putAuth():164 - TLS.auth: Put plaintext (360 bytes) 2020-06-05 10:20:46.552 DEBUG OpenVPNSession.onTLSConnect():693 - TLS.auth: Pulled ciphertext (389 bytes) 2020-06-05 10:20:46.552 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [5] 2020-06-05 10:20:46.552 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 5, [389 bytes]} 2020-06-05 10:20:46.554 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (443 bytes): 207d36227503c206d50000000b5eda005e13c21e36e80ae0f15bc25772d24e297262f16b1c3aa28b4482a8968d9f172b7dac9c174f3fbbd3dd03b6870feed56b4e813d317455b1f3b3810e22900ae6db0015065cba39e47267728a1f4cb70021b1bdce69bc170eb9cd3c41d3c545f79283879c62876fc8105f97c4db6d11ff00acb81616adb3bc11dda141046db58c0a0a08f20935beb1b9c20496a75d4d0544a630a92108514dd08fc77eb438b9653903e4de96e46be9795079eb5ce56437662c73abc8c7d17e84d8b55b0a81e17611c01c3d91fb029ad7f6080a81e06c1467bc581c627da3ac806e2411e55250c0f794f00205f14600951f26a392f3fb06376c20322c5446f492c10d64b7e45e46bccf654beff8b83da0bf26033a6ef61402f92e3dc540f07fc9bd9dffe9122d362f388931ce20b3c6b07463d61c82b5bb8a0e185b19918c3741c40dd138cc857aa6c3d0eab07a8e5cf85c1e2335e1bea66aaf786c43bbf57c16f6f0860df0925c2bed11bc2260ed1c47173ad001f813ac6cebdb76fa544ed7c7283ad74f5284c799a8ca65ea698ad43b444ecf3a2b349749d626c4d271165192a76bd0324ce32e60b37e0be0aa1922bfaba5e5 2020-06-05 10:20:46.555 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 4 2020-06-05 10:20:46.573 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:20:46.574 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: e605441196bbab9f, acks: {[5], 7d36227503c206d5}, pid: 5, [235 bytes]} 2020-06-05 10:20:46.574 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 5 2020-06-05 10:20:46.575 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 7d36227503c206d5, acks: {[5], e605441196bbab9f}} 2020-06-05 10:20:46.575 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (235 bytes) 2020-06-05 10:20:46.575 DEBUG OpenVPNSession.handleControlData():880 - Pulled plain control data (206 bytes) 2020-06-05 10:20:46.576 DEBUG Authenticator.parseAuthReply():209 - TLS.auth: Parsed server random 2020-06-05 10:20:46.576 DEBUG Authenticator.parseAuthReply():213 - TLS.auth: Parsed server options: "V4,dev-type tun,link-mtu 1549,tun-mtu 1500,proto UDPv4,cipher AES-256-GCM,auth [null-digest],keysize 256,key-method 2,tls-server" 2020-06-05 10:20:46.576 DEBUG OpenVPNSession.pushRequest():706 - TLS.ifconfig: Put plaintext (PUSH_REQUEST) 2020-06-05 10:20:46.576 DEBUG OpenVPNSession.pushRequest():722 - TLS.ifconfig: Send pulled ciphertext (42 bytes) 2020-06-05 10:20:46.576 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [6] 2020-06-05 10:20:46.576 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 6, [42 bytes]} 2020-06-05 10:20:46.580 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (96 bytes): 207d36227503c206d50000000d5eda005eafdc9af836060cc1449c013ddafb9451aa94f76453770693b944fc2d26bc4411a1841fb4afc17c5539c566ad30427d9ff4b16018301cff99c95ec1f345e82cf1d42bbf8aa4f81c6944ae45a3320b91 2020-06-05 10:20:46.580 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:20:46.580 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:20:46.580 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:20:46.580 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:20:46.581 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:20:46.581 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:20:46.581 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 5 2020-06-05 10:20:46.681 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 6, [42 bytes]} 2020-06-05 10:20:46.682 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (96 bytes): 207d36227503c206d50000000e5eda005e7d2f2d492ed4c08c4320da6d01fbe04139e02ab0e1bdf609e1932ad56d9f1cf30ed86dc13916f5d6abfe256038b581206c56d929487059cb2cbb2f4a34e9c5b55bd13980ff73ec7fe5d49870945ef8 2020-06-05 10:20:46.896 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 7d36227503c206d5, pid: 6, [42 bytes]} 2020-06-05 10:20:46.899 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (96 bytes): 207d36227503c206d50000000f5eda005ef1debbf198e8e160b106c25ff48a0c59e67f2047974266e6c2efb1717ca9280a4908164870df1cd6e8b9bf1df20fe5c7e7ece0541c3347f2ad238cec6af06f067581b9ee142fc5fd9d382f8f7bf14a 2020-06-05 10:20:47.028 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:20:47.029 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: e605441196bbab9f, acks: {[6], 7d36227503c206d5}} 2020-06-05 10:20:47.030 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:20:47.030 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: e605441196bbab9f, pid: 6, [476 bytes]} 2020-06-05 10:20:47.030 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 6 2020-06-05 10:20:47.030 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 7d36227503c206d5, acks: {[6], e605441196bbab9f}} 2020-06-05 10:20:47.031 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (476 bytes) 2020-06-05 10:20:47.031 DEBUG OpenVPNSession.handleControlData():880 - Pulled plain control data (447 bytes) 2020-06-05 10:20:47.031 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (446 bytes) 2020-06-05 10:20:47.035 DEBUG OpenVPNSession.handleControlMessage():956 - Received PUSH_REPLY: "PUSH_REPLY,block-outside-dns,dhcp-option DNS 192.87.106.106,dhcp-option DNS 192.87.36.36,dhcp-option DNS 2001:610:1:800a:192:87:106:106,dhcp-option DNS 2001:610:3:200a:192:87:36:36,explicit-exit-notify 1,redirect-gateway def1 ipv6 block-local,tun-ipv6,route-gateway 145.90.228.1,topology subnet,ping 10,ping-restart 60,ifconfig-ipv6 2001:610:450:40::1019/112 2001:610:450:40::1,ifconfig 145.90.228.27 255.255.255.192,peer-id 19,cipher AES-256-GCM" 2020-06-05 10:20:47.035 DEBUG OpenVPNSession.setupEncryption():1086 - Set up encryption 2020-06-05 10:20:47.035 INFO OpenVPNSession.setupEncryption():1091 - Negotiated cipher: AES-256-GCM 2020-06-05 10:20:47.036 INFO OpenVPNSession.setupEncryption():1102 - Negotiated keep-alive interval: 10.0 seconds 2020-06-05 10:20:47.036 INFO OpenVPNSession.setupEncryption():1105 - Negotiated keep-alive timeout: 60.0 seconds 2020-06-05 10:20:47.037 INFO OpenVPNTunnelProvider.sessionDidStart():518 - Session did start 2020-06-05 10:20:47.038 INFO OpenVPNTunnelProvider.sessionDidStart():520 - Returned ifconfig parameters: 2020-06-05 10:20:47.038 INFO OpenVPNTunnelProvider.sessionDidStart():521 - Remote: 145.100.179.13 2020-06-05 10:20:47.038 INFO OpenVPNTunnelProvider.sessionDidStart():522 - IPv4: addr 145.90.228.27 netmask 255.255.255.192 gw 145.90.228.1 routes [] 2020-06-05 10:20:47.038 INFO OpenVPNTunnelProvider.sessionDidStart():523 - IPv6: addr 2001:610:450:40::1019/112 gw 2001:610:450:40::1 routes [] 2020-06-05 10:20:47.039 INFO OpenVPNTunnelProvider.sessionDidStart():525 - Gateway: ["IPv4", "IPv6", "blockLocal"] 2020-06-05 10:20:47.039 INFO OpenVPNTunnelProvider.sessionDidStart():530 - DNS: ["192.87.106.106", "192.87.36.36", "2001:610:1:800a:192:87:106:106", "2001:610:3:200a:192:87:36:36"] 2020-06-05 10:20:47.039 INFO OpenVPNTunnelProvider.sessionDidStart():537 - Search domains: not configured 2020-06-05 10:20:47.041 INFO OpenVPNTunnelProvider.bringNetworkUp():616 - Routing.IPv4: Setting default gateway to 145.90.228.1 2020-06-05 10:20:47.041 INFO OpenVPNTunnelProvider.bringNetworkUp():645 - Routing.IPv6: Setting default gateway to 2001:610:450:40::1 2020-06-05 10:20:47.041 INFO OpenVPNTunnelProvider.bringNetworkUp():677 - DNS: Using servers ["192.87.106.106", "192.87.36.36", "2001:610:1:800a:192:87:106:106", "2001:610:3:200a:192:87:36:36"] 2020-06-05 10:20:47.076 INFO OpenVPNTunnelProvider.bringNetworkUp():750 - Block local: Suppressing IPv4 route default/32 2020-06-05 10:20:47.076 INFO OpenVPNTunnelProvider.bringNetworkUp():750 - Block local: Suppressing IPv4 route default/32 2020-06-05 10:20:47.077 INFO OpenVPNTunnelProvider.bringNetworkUp():765 - Block local: Suppressing IPv6 route default/128 2020-06-05 10:20:47.077 INFO OpenVPNTunnelProvider.bringNetworkUp():765 - Block local: Suppressing IPv6 route default/128 2020-06-05 10:20:47.084 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:20:47.086 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: e605441196bbab9f, acks: {[6], 7d36227503c206d5}} 2020-06-05 10:20:47.086 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:20:47.086 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: e605441196bbab9f, acks: {[6], 7d36227503c206d5}} 2020-06-05 10:20:47.086 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 6 2020-06-05 10:20:47.613 DEBUG OpenVPNTunnelProvider.reasserting():137 - Reasserting flag cleared 2020-06-05 10:20:47.613 INFO OpenVPNTunnelProvider.sessionDidStart():569 - Tunnel interface is now UP 2020-06-05 10:20:48.117 DEBUG NEUDPSocket.observeValueInTunnelQueue():179 - Socket has a better path 2020-06-05 10:20:48.117 DEBUG OpenVPNTunnelProvider.socketHasBetterPath():506 - Stopping tunnel due to a new better path 2020-06-05 10:20:48.117 DEBUG OpenVPNTunnelProvider.logCurrentSSID():826 - Current SSID: none (disconnected from WiFi) 2020-06-05 10:20:48.125 ERROR OpenVPNSession.doReconnect():1290 - Trigger reconnection (error: networkChanged) 2020-06-05 10:20:48.125 ERROR OpenVPNTunnelProvider.sessionDidStop():584 - Session did stop with error: networkChanged 2020-06-05 10:20:48.137 WARNING OpenVPNSession.receiveTunnel():543 - Discarding 1 TUN packets (should not handle) 2020-06-05 10:20:48.137 WARNING OpenVPNSession.receiveTunnel():543 - Discarding 2 TUN packets (should not handle) 2020-06-05 10:20:48.139 WARNING OpenVPNSession.receiveTunnel():543 - Discarding 1 TUN packets (should not handle) 2020-06-05 10:20:48.146 ERROR OpenVPNSession.loopLink():410 - Failed LINK read: Error Domain=NSPOSIXErrorDomain Code=89 "Operation canceled" 2020-06-05 10:20:48.152 DEBUG NEUDPSocket.observeValueInTunnelQueue():147 - Socket state is cancelled (endpoint: 145.100.179.13:1194 -> 145.100.179.13:1194) 2020-06-05 10:20:48.152 INFO OpenVPNSession.cleanup():334 - Cleaning up... 2020-06-05 10:20:48.155 ERROR OpenVPNTunnelProvider.finishTunnelDisconnection():355 - Tunnel did stop (error: networkChanged) 2020-06-05 10:20:48.159 DEBUG OpenVPNTunnelProvider.socket():484 - Disconnection is recoverable, tunnel will reconnect in 1000 milliseconds... 2020-06-05 10:20:48.159 WARNING OpenVPNSession.loopLink():406 - Ignoring read from outdated LINK 2020-06-05 10:20:49.249 DEBUG OpenVPNTunnelProvider.socket():493 - Tunnel is about to reconnect... 2020-06-05 10:20:49.251 DEBUG OpenVPNTunnelProvider.reasserting():137 - Reasserting flag set 2020-06-05 10:20:49.251 INFO OpenVPNTunnelProvider.connectTunnel():317 - Creating link session 2020-06-05 10:20:49.251 DEBUG OpenVPNTunnelProvider.connectTunnel():321 - Socket follows a path upgrade 2020-06-05 10:20:49.251 INFO OpenVPNTunnelProvider.connectTunnel():336 - Will connect to 145.100.179.13:1194 2020-06-05 10:20:49.256 DEBUG OpenVPNTunnelProvider.connectTunnel():339 - Socket type is NEUDPSocket 2020-06-05 10:20:49.257 DEBUG NEUDPSocket.observeValueInTunnelQueue():147 - Socket state is ready (endpoint: 145.100.179.13:1194 -> 145.100.179.13:1194) 2020-06-05 10:20:49.257 DEBUG OpenVPNSession.setLink():261 - Starting VPN session 2020-06-05 10:20:49.257 DEBUG OpenVPNSession.hardReset():601 - Send hard reset 2020-06-05 10:20:49.257 DEBUG OpenVPNSession.hardReset():609 - Negotiation key index is 0 2020-06-05 10:20:49.257 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [0] 2020-06-05 10:20:49.257 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:49.258 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000015eda005ecb0db027cafa29569f6470c91f62ec323061809c446485743554bbd67a650bc12edf28f71d 2020-06-05 10:20:49.532 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:49.540 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000025eda005eb25ba4a3a1300bdef4655a6074717108b01906324762e984b3182646c340c9146a89bda51a 2020-06-05 10:20:49.752 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:49.752 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000035eda005ee88341e9607649b7b134cfc2612623ba4901f7863c1ee20b4c37ecd35aaecbe5f747bab68a 2020-06-05 10:20:49.971 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:49.972 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000045eda005ebc9baed0e032137ded4b460abcbb13e5612596b4ab3328d89e20e2411047dc33a266cd9766 2020-06-05 10:20:50.192 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:50.192 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000055eda005ee82e6202e1b494f8cc4f6e028e467d93867512db99cdce497458a15ec8470b51482d0114d3 2020-06-05 10:20:50.410 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:50.410 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000065eda005eb20fd29955e7cf806579a57837f12002094722007afab5b08531c544c7081a4f2a7a32615d 2020-06-05 10:20:50.625 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:50.627 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000075eda005e6f5c05c9e653b176af3c5b52bad1cb1cdb39cdaaf1899c297b3c63b7a1f117cea658037a20 2020-06-05 10:20:50.848 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:50.849 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000085eda005e0f9d94e56290eb4354388a7a4c5eecfeee93f1064989acbfbf6514010ee666965932581717 2020-06-05 10:20:51.065 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:51.065 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000095eda005eb8d0a56d749e5026a008ff81d90437fd9dc5be22e704dcc2346d46fd599e7cf4161091fd6b 2020-06-05 10:20:51.266 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:51.267 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000000a5eda005ed269c697f07773944aaf27ef9644bbc8e7e4140769899e529246c756b7a9b026cac309cc68 2020-06-05 10:20:51.472 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:51.472 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000000b5eda005e4051c590b9380060790b7040c64d9dff6e00b8c1d06b13183e97e15c03a7b8bae3ad70c937 2020-06-05 10:20:51.682 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:51.683 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000000c5eda005e58e2ca30b028acf53bdbf5e75971e6e2d0686a797c61367ab027c07d58697ef75056372564 2020-06-05 10:20:51.903 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:51.903 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000000d5eda005e2162cd23e4aa70ea7e57d3d4bf4faa45cbfd2eb634e90627aa702677bde899e5a8775cc489 2020-06-05 10:20:52.108 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:52.109 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000000e5eda005eaac485d12f696116b7497acf2f29aaa3634cd049bcbc0c58452c911b9c35a88b00c43bf3c5 2020-06-05 10:20:52.317 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:52.318 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000000f5eda005e34d17c0136e19e7eec5438a4a8d9918bd6715ef1d337d76564c728412ba09c3c742c71ee85 2020-06-05 10:20:52.529 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:52.530 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000105eda005e12b0d2cfde394a9bb53c724dac492f77425df47e6588580b32dd8397a2ebd7db7654e9356c 2020-06-05 10:20:52.743 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:52.743 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000115eda005ef33a0ac8320e712696b84e21ae0fba57d1254f89c3d540bcd6ef0e91c498731a88ae9f2647 2020-06-05 10:20:52.958 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:52.960 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000125eda005ecc2f9e515a06540e7710dee20239d0e08f38cf7fc5508611f73ed0874697ba23ee0ac51800 2020-06-05 10:20:53.172 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:53.173 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000135eda005e4c84c475ba7308719b7310c1c63aaff939b7b20ed01763eff7b97cc4b85b48416a292959fa 2020-06-05 10:20:53.389 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:53.389 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000145eda005e80a627ab150bcb0f187d1b45fcea2f19ed69c43197591ccdcd508afe6d4a8461187a80ee32 2020-06-05 10:20:53.606 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:53.608 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000155eda005e78798648c3e3be7b10231da28c413804752e5b562bd865f2ddecc3f45676dea6fc32b6b84f 2020-06-05 10:20:53.824 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:53.826 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000165eda005ec4a268d2855c98ba7cba9d15f22df8b21e14d86fa02091b0f7e598863bfbb31dd839e5607c 2020-06-05 10:20:54.047 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:54.050 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000175eda005eeb2a1f461a7231693708ab5e9ab5e1236f9e92be44fd5edeef1293ba9e8d6129255b34f58f 2020-06-05 10:20:54.265 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:54.266 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000185eda005e120721768b11b53f4fe720e6051a3b3c3aea9f3a48299f9805258ea89308150721b76d8f4a 2020-06-05 10:20:54.478 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:54.479 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000195eda005e9aa8d3bd892f224ab88a3da55a84b455a3fe6bfc39d590ad4a1f0ba0605db1e65817b91d15 2020-06-05 10:20:54.694 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:54.695 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000001a5eda005eba77ebc2a6d563d1153badb909e0739f58dc4ec40754968b6d48391d6bac3d81048d44d3ea 2020-06-05 10:20:54.909 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:54.910 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000001b5eda005eded49127f12cc83928b0e2909c888d784f5318600376b26d4b8fe8e7c2741ad12ccecb605e 2020-06-05 10:20:55.112 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:55.113 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000001c5eda005e0410807d902aef687cf095e40575bed0b7f189a76acdb89737b8fcb7acec0cc9d24274964b 2020-06-05 10:20:55.314 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:55.315 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000001d5eda005e2dea486b8f92cc7c2538534cdd926fda81cfdcacf6e7c6c5030bed5063590947e6ce0cf189 2020-06-05 10:20:55.531 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:55.532 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000001e5eda005ee934f8692b4393b3ae57ea8bde51c3ac669c56eee2c5af26c217af44f1ff53f1aa2b5bf549 2020-06-05 10:20:55.748 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:55.749 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000001f5eda005e23ee6ff28d22abc29f0a6716c35f8c0526a8843a6e113fc0b2839fd6b4410ffbfd09ef5c4d 2020-06-05 10:20:55.964 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:55.965 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000205eda005e1463e2c309de14afee42f16bc30befff888e8b91948a86ce16b4443a648d9eeb3834df98d1 2020-06-05 10:20:56.177 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:56.178 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000215eda005eab6ff66254ba2198471e4b55f661c9961dff540e857ed942b3ba8eb95d2823e4c0dfb78c1b 2020-06-05 10:20:56.394 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:56.395 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000225eda005ecfe33fbd63a9f966f24fd32ba9377d8d3960cfb3b180edb4ae8afbce50ad436ebb5a430cb2 2020-06-05 10:20:56.612 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:56.612 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000235eda005eff017c7ee7057f0f7c9be8fd38a72fd32fcbe28f2f0e77b76825e70f9970687b67a4d8b3ed 2020-06-05 10:20:56.829 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:56.831 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000245eda005ec85dcd27afb6b6b38b8f8ef9a42198a9a7d0a3967647b1ed41260ded44415d140348d13230 2020-06-05 10:20:57.032 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:57.032 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000255eda005ebaaa0d7b9eccaea7424934798f1a20a67a941c9a653708397d85e0ff406afa9b2269649bfb 2020-06-05 10:20:57.240 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:57.242 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000265eda005edcc95970b4f4918b84e045cc34eb0c126d15df088586aa72847aa92b36df0f1905a192628d 2020-06-05 10:20:57.444 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:57.445 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000275eda005e974a7fd45cc381c57374bc91c410707b4a34db1d3d38f7e5ed53ab41a4c9fb4fc10d2afce9 2020-06-05 10:20:57.659 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:57.660 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000285eda005e6f0c64807a5f12763d2250e0895393f6128ea3c1764b7d67107b5038ff615c63ff747ba0a7 2020-06-05 10:20:57.884 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:57.885 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a000000295eda005ed9ab320a87aa21afe0043d89c9d5631d8061eb8092d1b815c3e3403bbf0132f48795ef93bc 2020-06-05 10:20:58.098 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:58.099 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000002a5eda005e2bf5074f2e263b4854dd68b98bb987ed1d64d1ebfb07b64fedab4030a8872be8419d1c475a 2020-06-05 10:20:58.314 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:58.315 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000002b5eda005e8a5a76b1a2e29d8b34099ba981eeb08b1f4721990726e11b6d782b7e0d2002c57c8325dc22 2020-06-05 10:20:58.529 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:58.530 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000002c5eda005ea4bbda23232e0e2fcbf175358e1ec1d269eba286abffb61963b1cd16ed5d227342404ac1c6 2020-06-05 10:20:58.739 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:58.741 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000002d5eda005ec31646eae70a5e4e866100e72c6fe71e39e1b2cf0e8feaf05e4188bcf45854a4a7f77eafde 2020-06-05 10:20:58.955 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:58.957 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000002e5eda005e5980b86a72c8c3e7246f0c1c22fc6ee1e036ebf22395a28d6e0aacf056b14be672c919f366 2020-06-05 10:20:59.172 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 8f0b72b87dc31f3a, pid: 0, [0 bytes]} 2020-06-05 10:20:59.172 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 388f0b72b87dc31f3a0000002f5eda005e006ac4dd079cf74a6bd3f6af8d73323e445ef314bcb3bd6431428c8249844747443a71e2c3 2020-06-05 10:20:59.374 ERROR OpenVPNSession.doReconnect():1290 - Trigger reconnection (error: negotiationTimeout) 2020-06-05 10:20:59.374 ERROR OpenVPNTunnelProvider.sessionDidStop():584 - Session did stop with error: negotiationTimeout 2020-06-05 10:20:59.379 ERROR OpenVPNSession.loopLink():410 - Failed LINK read: Error Domain=NSPOSIXErrorDomain Code=89 "Operation canceled" 2020-06-05 10:20:59.380 DEBUG NEUDPSocket.observeValueInTunnelQueue():147 - Socket state is cancelled (endpoint: 145.100.179.13:1194 -> 145.100.179.13:1194) 2020-06-05 10:20:59.380 INFO OpenVPNSession.cleanup():334 - Cleaning up... 2020-06-05 10:20:59.380 ERROR OpenVPNTunnelProvider.finishTunnelDisconnection():355 - Tunnel did stop (error: negotiationTimeout) 2020-06-05 10:20:59.381 DEBUG ConnectionStrategy.tryNextEndpoint():147 - Try next endpoint: 145.100.179.13:TCP:1195 2020-06-05 10:20:59.381 DEBUG OpenVPNTunnelProvider.socket():484 - Disconnection is recoverable, tunnel will reconnect in 1000 milliseconds... 2020-06-05 10:20:59.381 WARNING OpenVPNSession.loopLink():406 - Ignoring read from outdated LINK 2020-06-05 10:21:00.472 DEBUG OpenVPNTunnelProvider.socket():493 - Tunnel is about to reconnect... 2020-06-05 10:21:00.474 DEBUG OpenVPNTunnelProvider.reasserting():137 - Reasserting flag set 2020-06-05 10:21:00.475 INFO OpenVPNTunnelProvider.connectTunnel():317 - Creating link session 2020-06-05 10:21:00.475 DEBUG ConnectionStrategy.createSocket():159 - Pick current endpoint: 145.100.179.13:TCP:1195 2020-06-05 10:21:00.479 INFO OpenVPNTunnelProvider.connectTunnel():336 - Will connect to 145.100.179.13:1195 2020-06-05 10:21:00.483 DEBUG OpenVPNTunnelProvider.connectTunnel():339 - Socket type is NETCPSocket 2020-06-05 10:21:00.484 DEBUG NETCPSocket.observeValueInTunnelQueue():149 - Socket state is waiting (endpoint: 145.100.179.13:1195 -> in progress) 2020-06-05 10:21:05.890 DEBUG OpenVPNTunnelProvider.socketDidTimeout():423 - Socket timed out waiting for activity, cancelling... 2020-06-05 10:21:05.892 DEBUG ConnectionStrategy.tryNextEndpoint():147 - Try next endpoint: 145.100.179.13:TCP:443 2020-06-05 10:21:05.893 DEBUG NETCPSocket.observeValueInTunnelQueue():149 - Socket state is cancelled (endpoint: 145.100.179.13:1195 -> in progress) 2020-06-05 10:21:05.893 INFO OpenVPNSession.cleanup():334 - Cleaning up... 2020-06-05 10:21:05.893 INFO OpenVPNTunnelProvider.finishTunnelDisconnection():358 - Tunnel did stop on request 2020-06-05 10:21:05.893 DEBUG OpenVPNTunnelProvider.socket():484 - Disconnection is recoverable, tunnel will reconnect in 1000 milliseconds... 2020-06-05 10:21:06.906 DEBUG OpenVPNTunnelProvider.socket():493 - Tunnel is about to reconnect... 2020-06-05 10:21:06.907 DEBUG OpenVPNTunnelProvider.reasserting():137 - Reasserting flag set 2020-06-05 10:21:06.908 INFO OpenVPNTunnelProvider.connectTunnel():317 - Creating link session 2020-06-05 10:21:06.908 DEBUG ConnectionStrategy.createSocket():159 - Pick current endpoint: 145.100.179.13:TCP:443 2020-06-05 10:21:06.909 INFO OpenVPNTunnelProvider.connectTunnel():336 - Will connect to 145.100.179.13:443 2020-06-05 10:21:06.911 DEBUG OpenVPNTunnelProvider.connectTunnel():339 - Socket type is NETCPSocket 2020-06-05 10:21:06.914 DEBUG NETCPSocket.observeValueInTunnelQueue():149 - Socket state is waiting (endpoint: 145.100.179.13:443 -> in progress) 2020-06-05 10:21:12.258 DEBUG OpenVPNTunnelProvider.socketDidTimeout():423 - Socket timed out waiting for activity, cancelling... 2020-06-05 10:21:12.258 DEBUG ConnectionStrategy.tryNextEndpoint():144 - Exhausted endpoints 2020-06-05 10:21:12.259 DEBUG OpenVPNTunnelProvider.flushLog():816 - Flushing log... --- EOF --- 2020-06-05 10:21:13.289 INFO OpenVPNTunnelProvider.startTunnel():216 - Starting tunnel... 2020-06-05 10:21:13.304 INFO OpenVPNTunnelProvider+Configuration.print():642 - Protocols: [UDP:1194, TCP:1195, TCP:443] 2020-06-05 10:21:13.304 INFO OpenVPNTunnelProvider+Configuration.print():643 - Cipher: AES-256-GCM 2020-06-05 10:21:13.304 INFO OpenVPNTunnelProvider+Configuration.print():644 - Digest: HMAC-SHA1 2020-06-05 10:21:13.304 INFO OpenVPNTunnelProvider+Configuration.print():645 - Compression framing: disabled 2020-06-05 10:21:13.305 INFO OpenVPNTunnelProvider+Configuration.print():649 - Compression algorithm: disabled 2020-06-05 10:21:13.305 INFO OpenVPNTunnelProvider+Configuration.print():652 - Client verification: enabled 2020-06-05 10:21:13.306 INFO OpenVPNTunnelProvider+Configuration.print():657 - TLS wrapping: crypt 2020-06-05 10:21:13.306 INFO OpenVPNTunnelProvider+Configuration.print():662 - TLS security level: 3 2020-06-05 10:21:13.306 INFO OpenVPNTunnelProvider+Configuration.print():669 - Keep-alive interval: never 2020-06-05 10:21:13.306 INFO OpenVPNTunnelProvider+Configuration.print():674 - Keep-alive timeout: never 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():679 - Renegotiation: never 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():682 - Server EKU verification: enabled 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():689 - Host SAN verification: disabled 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():697 - Gateway: not configured 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():702 - DNS: not configured 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():408 - MTU: 1250 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():409 - Debug: true 2020-06-05 10:21:13.307 INFO OpenVPNTunnelProvider+Configuration.print():410 - Masks private data: false 2020-06-05 10:21:13.322 DEBUG OpenVPNTunnelProvider.logCurrentSSID():826 - Current SSID: none (disconnected from WiFi) 2020-06-05 10:21:13.322 INFO OpenVPNTunnelProvider.connectTunnel():317 - Creating link session 2020-06-05 10:21:13.322 DEBUG ConnectionStrategy.createSocket():164 - No endpoints available, will resort to DNS resolution 2020-06-05 10:21:13.322 DEBUG ConnectionStrategy.createSocket():171 - DNS resolve hostname: internet.nl.eduvpn.org 2020-06-05 10:21:13.336 DEBUG ConnectionStrategy.createSocket():175 - DNS resolved addresses: ["145.100.179.13"] 2020-06-05 10:21:13.336 DEBUG ConnectionStrategy.unrolledEndpoints():122 - Unrolled endpoints: [145.100.179.13:UDP:1194, 145.100.179.13:TCP:1195, 145.100.179.13:TCP:443] 2020-06-05 10:21:13.336 DEBUG ConnectionStrategy.createSocket():190 - Pick current endpoint: 145.100.179.13:UDP:1194 2020-06-05 10:21:13.337 INFO OpenVPNTunnelProvider.connectTunnel():336 - Will connect to 145.100.179.13:1194 2020-06-05 10:21:13.337 DEBUG OpenVPNTunnelProvider.connectTunnel():339 - Socket type is NEUDPSocket 2020-06-05 10:21:13.340 DEBUG NEUDPSocket.observeValueInTunnelQueue():149 - Socket state is preparing (endpoint: 145.100.179.13:1194 -> in progress) 2020-06-05 10:21:13.355 DEBUG NEUDPSocket.observeValueInTunnelQueue():147 - Socket state is ready (endpoint: 145.100.179.13:1194 -> 145.100.179.13:1194) 2020-06-05 10:21:13.355 DEBUG OpenVPNSession.setLink():261 - Starting VPN session 2020-06-05 10:21:13.355 DEBUG OpenVPNSession.hardReset():601 - Send hard reset 2020-06-05 10:21:13.356 DEBUG OpenVPNSession.hardReset():609 - Negotiation key index is 0 2020-06-05 10:21:13.357 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [0] 2020-06-05 10:21:13.358 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {HARD_RESET_CLIENT_V2 | 0, sid: 82c34e425f62d809, pid: 0, [0 bytes]} 2020-06-05 10:21:13.358 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (54 bytes): 3882c34e425f62d809000000015eda0079c5150115360291c17c5ad4986d8082450c5a4054d1eb9fc090f5fd2e7aa963351c5306002e 2020-06-05 10:21:13.380 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code HARD_RESET_SERVER_V2 and key 0 2020-06-05 10:21:13.380 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {HARD_RESET_SERVER_V2 | 0, sid: 6c157ebc5101a885, acks: {[0], 82c34e425f62d809}, pid: 0} 2020-06-05 10:21:13.380 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 0 2020-06-05 10:21:13.380 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 82c34e425f62d809, acks: {[0], 6c157ebc5101a885}} 2020-06-05 10:21:13.381 DEBUG ControlChannel.remoteSessionId():50 - Control: Remote sessionId is 6c157ebc5101a885 2020-06-05 10:21:13.381 DEBUG OpenVPNSession.handleControlPacket():785 - Start TLS handshake 2020-06-05 10:21:13.383 DEBUG OpenVPNSession.handleControlPacket():819 - TLS.connect: Pulled ciphertext (263 bytes) 2020-06-05 10:21:13.383 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [1] 2020-06-05 10:21:13.383 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 1, [263 bytes]} 2020-06-05 10:21:13.385 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (317 bytes): 2082c34e425f62d809000000035eda00795b95f947d64b3cbe01d7fe177396b7d2008de58e4b478434f0ebcbab7edee0dc40409da1e98e53d246ac003c618b1f09d5fae87d03bd86087d8fa22cbb8996ec2b951932cc7eeed6499dc825e94964b7005c714d037ae6651d3511beb2f1a598e2a9f2b9ed97fca3fb2edc186992a3918c5d872baef8f4629ace04e1800d71c375fe31764e81adc7400ca4e278479f7b13751678928b28a2e9b45bb143b2707519be315db4b1e661156e58472fdc568bd14857d9a96930af77a2d28bf6157a4eb2dd0e649045b6f46a89ffc1b924b22f7a0d79bc016587dbc36081d57a0a0bb72ff0fb186494f3d89da19f791bb5fc020019992898a1dff39e3c2b4b94e91815fd2ac7844690737cecbf174148e390719fca7ae5429574a551d09e68fa3d03e18eaa2d0b81c2c5fac7b10d9e 2020-06-05 10:21:13.390 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 0 2020-06-05 10:21:13.431 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:21:13.431 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: 6c157ebc5101a885, acks: {[1], 82c34e425f62d809}, pid: 1, [1062 bytes]} 2020-06-05 10:21:13.432 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 1 2020-06-05 10:21:13.433 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 82c34e425f62d809, acks: {[1], 6c157ebc5101a885}} 2020-06-05 10:21:13.433 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (1062 bytes) 2020-06-05 10:21:13.434 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:21:13.435 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: 6c157ebc5101a885, pid: 2, [1062 bytes]} 2020-06-05 10:21:13.435 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 2 2020-06-05 10:21:13.435 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 82c34e425f62d809, acks: {[2], 6c157ebc5101a885}} 2020-06-05 10:21:13.436 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (1062 bytes) 2020-06-05 10:21:13.437 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:21:13.438 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: 6c157ebc5101a885, pid: 3, [606 bytes]} 2020-06-05 10:21:13.438 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 3 2020-06-05 10:21:13.463 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 82c34e425f62d809, acks: {[3], 6c157ebc5101a885}} 2020-06-05 10:21:13.467 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (606 bytes) 2020-06-05 10:21:13.475 DEBUG OpenVPNSession.handleControlPacket():846 - TLS.connect: Send pulled ciphertext (2661 bytes) 2020-06-05 10:21:13.475 DEBUG ControlChannel.enqueueOutboundPackets():157 - Control: Enqueued 3 packets [2-4] 2020-06-05 10:21:13.476 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 2, [1250 bytes]} 2020-06-05 10:21:13.483 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 3, [1250 bytes]} 2020-06-05 10:21:13.486 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 4, [161 bytes]} 2020-06-05 10:21:13.495 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (1304 bytes): 2082c34e425f62d809000000075eda0079635174d50d6d27e347e22c3863b4bb63cfcfe9f306187d2fb92f5ffa8564df675bf83871e05e9fa699114fb54893e4cd57937aeb9a9f9b9728e9e7870ae5de99f08ce50cec4b0eadf63333814d8fadeca4b84000f3af16cb4d7741ca5a8888276af787625433d9b4c2ee414543cc4fd3768db2d8000015d9b728ee26d4e72643267195146a335c3d4a89d99ed819a811ea2085bd938825bd8fa5c5f8bc1fd5c6d05b5cda1653d66df646c076c89e8f24de891423e02e05ea90f2dec95b2604a679f7966ecd35af5f6461a5cd60a721bac372c96652245bbec0dfa31db095858392bd6ed4ed49b56745d219d18004b49014d176ff7797e5725e7ae68b9b0cf71e14bf763e3a0a12e3c2e4de693ec84cdff2e073ece2edadb1cef50c4e39cb5ab7c846b3088d3a1bcead34698c271b8c7a8443b3993eb2e9b6aacca807299b9f6818f234171ed6c69a18b5ca59c9e0beb582167c2bc9381ce4906a1ca5249423ae377f44f5000708ba4978a07abe26d3afde3d8da213c09bcf52211ed0a7e6d29dd4a3e1ff40c40604ac8b485d66bc908aa740ffe6d0c37885072ec3a103040258050b261ced79cb350c68e404c878afb3ab7a2bf3f70ba5cd68a1f949c6953c4128d85eeab4b167727ab39a9a28b533bb316a11e57b2460fa62c1aa396b100f458a3fe94c479418f18dff4d5b0e666daeb3476f2f576685bcf50fe2b384ce8135c0ad8d637a10a325cf391d2191c054e685f9afe873e4547b4eec799266d681efee778698aa067c3f61c4e92678b53817be8157fbff301a9b2725ae54ff498b94c80588eab32720cbafc3f1a57023bb4fc2758aab3894efe8d1e08d96aa5ab89819b3af753cf200ae106aa2c5f49a839ff26fe85d1c684d8a2438f0ebaa27e6fde0e9bc0e274781823533948b7032332901e91014bf9dbdea0722fc78e0a1c9b8651a7ca78beda45287447b287d8469a56f5d9eeb6a8a9c14f743fef918fda6f17ed0e50d5dedd62ea742a994fa3acbc1033a9a4a0ed6842c99926b8e576a8a0cf7b135fee9cd44d2568bcdd922316c0c5560c4e26af4c4efbda071e2815398c1767f6c13dd90288b34aa077d26f548ad9adb7c537f6575f571f21c7da65d130777a53f44df6034a3eca1285cb211d3ee70cd86ac639d7d7f2ab55d742e198e68fed8c9de2e86d236c6dcd385aca0b2a9a3b9bb4106c425e9873ac088480509bc4f92e917911cd000882b9e1d14134db627c8c24ec49ae7bbf3e1f98386b92df3f34a3dac709834d2650835cfa0f7be4a1a2f466d08254532cbc517fc7e99a5a61d0c4ffdf0a4dad9f4b348cfa5685abe347df741a7a6825a2b046cd5769537112efe9125c704fc6b5e07ef3f7a9a871975ae6b46cfba12f7c388b6df2c6bc173c2e5f18c9eef49c41def5423c913d83b269ac39dd9afd45ed40aa15dd5c6c8cb1ab50f427915cd35581b51aa50b620c02c9d722bcb26c97b239929698038472fea0cbc5b6148798594c7f1053664a4ac5f6984acc0f378602a86e7a25d810488456d72bd159f003d269bd60230916d8bdaca956988db3327ffc8585c7177efd952679bc711564c8faede071b87d31c12bffe26b041c714ab08329df310a00927173e58e7c42484ee5819dfe8a887752e9253e64196d028b9b4978844e68652e7da22a706f9c3b203b68908661b0d91e3a887430188bf57272e05b93726a26f630e2ba0d3484f01b4df77a2c83421874c155c714c5d3e361bffd8b8cdec653639649dcff52e189fdf18574af96d878068b9d18dff605a101f34a72ce0a9599623803cd9eb61844a 2020-06-05 10:21:13.507 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (1304 bytes): 2082c34e425f62d809000000085eda0079554ba9722b31642b2ca8c5c265a8ffd05764afdc81ef744020ff07671473fdae4f74330233686253c9bd16616c52268b290ee5e24c05e645f5facdb1ec5088af0af5df1db37d3059e868255725c1bb51ed096122c304690c7ff6636544eee70744099be4ef7d27edb7ed810728fc08ccba4e2ba2eef38bb0318cde737d3c8770a2742ec6ad0cc8e9aed4f6c0338faae6154a16add71b87304526da579bed6903b9c7172000f02b6105bae9946b0c3ecaab90613426dd4d0322a36711ddf69d4e6f8c2ca79e768c697ef2d806a89ae5d1f703a33ab9351ab1771796747af9b27fe7063093f0084cfa7c659de3d245a3b620da193c536e1ca5c4e98c2bc5d8151c2513768dab444300b48e30b5ff10529d08c9ac5cbdccc296db9ab46967929b98dea6a1175032b268dd0a08fed730a45d14342d3ed02afdeb132c2c670886f92bd74c403595d904137c399f05a95086a6ac121e91c8f86ad75fedf8925e693c4b9310831cea4f9a7312a413504aaeaa38123b9c4c3eb113d2b968894e7d9c798adf950ad679d5983d5a61b6433c6e33fe4bfa01bfbb97a66ea86da20e0df9b4088d9d10c26e7bbeb76175310dc9aaca93cce25413fe483a3355862c50e5f71db17c31e908c40908fe4da9ee6bdfa7a85f7c25250e177c49a9143f7940f94c3ab69376426650ba88202d6361c0ecd42eb697ef3bc5a78d646f5c9216348b0e25f86d8d5ff9188e2f7e8d4ac332f4cb26b7c0430cc0676a751b8d858948e5097fa93e280cabce981ade5dc6231934296b79cacc1d5c291a7ebea74d3778c62181a49561d25fdaea5d1d869d62a8d07a4e4b0d4b9d79882196246ef7ac1c615ec935f15a1c311dc204b58c9d506518fbf4f055066e5358eca014e7e1a5bbcbaab0ccf3530b0b1b4b80429821c178ef93a2c6546f8fd9aeeeb7c02460714f9326d85dbfd67c125c75417c7f8a96386bcaec111b887767d5e86fb0c6a56eac2a77f83b561bb155679312cad8f506d69d035b706e3cdce02fdb8e0b2a9a02ca41107125201f7d2be0b333c1d8d23771884e11e7a740ca29305eb8e7319d61b996542dd2288b76d0f1408fc850b074c30b845a2706718d1ef889dad884469ddf015d1f2cd45d77627648075557f5450f828a66eeb66425d7c25b090ce11b3fd810727055efea75cee3f640580c596570a2469af0cf82097846b28d30b65c628c8e35b257201277064fb6bbb20740a002a6013cd605af53c2db03ded3ab04aa9677dbd8e0415ca354c9ba04ec414f19052b67fc4501fde6b0e2c3f253892d3b4e157ceb0b161bdcfec7b6072de6ad4efade08a9c14f19f95b626482d41cb18678c711200c2132692066ca5ef0963149c4cead48a4db852c1ef37f0053b7faec8af8708e97b748ab79368bfa4fe87fdaa7f146f8b5fbc439294eb998c39081a8632c07d7a6cced4fbc349435d1c50e99c3d93a7c654b1c8fc871331671c0aaf8b4c0b47d12d7699a00cdb5ca7f50e273ca0705a1cb05e8e322aa341a450c5f82df01da984b2afb0a61501c7fe81d1311fb712dde7bd79c3b7d29821bd25c1406bfe1692db9c5247f1c55f9d2189b02e50c36d8b8a7042572365ebd5415cba5a6978075e0a0513f6eaa184a672a348aa58c714c8a2cc2d27cf7595a939661809c60428f6af101c94cfc4aa65b8857255c5dfd563d11f8789b6219d8abbdeb5801c44628927bb2806b11107e9a9fddf095a7becf2f229759894408d11737d7be9377afccb2c78d7139e0cdc872e1ac2f5421a4cc773c8d000e50bb58f4690be1b798ca820b82a382cfb8f4513b 2020-06-05 10:21:13.508 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (215 bytes): 2082c34e425f62d809000000095eda0079bda427dba147187a314b609986694299a42510ac041d13bcd80baac6d8c903a7e02c775e344334dcf8cae027615e9a4b9fac5d9f34224692331806078ce1cf9fa1c255d1ac11a923572cc68067e21959a83ba607feda86eeb39aaeb27a6f79df0e334dc12eb5cf25f2b162c683f841af421a862f163567d450488ebe62dec8134ed0a54013abfb895b8ba5cf7261afcda8aaa8178eb50368d36369c98d3970294f4988331b759ef0c37a3d91a7bcfb4cd7645d1c11d56cdf545205d0b44224bebeeb8cf88674 2020-06-05 10:21:13.509 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 1 2020-06-05 10:21:13.509 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 2 2020-06-05 10:21:13.509 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 3 2020-06-05 10:21:13.546 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:21:13.547 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: 6c157ebc5101a885, acks: {[2], 82c34e425f62d809}} 2020-06-05 10:21:13.547 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:21:13.548 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: 6c157ebc5101a885, acks: {[3], 82c34e425f62d809}} 2020-06-05 10:21:13.549 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:21:13.549 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: 6c157ebc5101a885, acks: {[4], 82c34e425f62d809}, pid: 4, [51 bytes]} 2020-06-05 10:21:13.550 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 4 2020-06-05 10:21:13.551 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 82c34e425f62d809, acks: {[4], 6c157ebc5101a885}} 2020-06-05 10:21:13.552 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (51 bytes) 2020-06-05 10:21:13.553 DEBUG OpenVPNSession.onTLSConnect():667 - TLS.connect: Handshake is complete 2020-06-05 10:21:13.557 DEBUG Authenticator.putAuth():146 - TLS.auth: Local options: V4,dev-type tun,keydir 1,cipher AES-256-GCM,auth SHA1,keysize 256,tls-crypt,key-method 2,tls-client 2020-06-05 10:21:13.561 DEBUG Authenticator.putAuth():164 - TLS.auth: Put plaintext (360 bytes) 2020-06-05 10:21:13.561 DEBUG OpenVPNSession.onTLSConnect():693 - TLS.auth: Pulled ciphertext (389 bytes) 2020-06-05 10:21:13.561 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [5] 2020-06-05 10:21:13.562 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 5, [389 bytes]} 2020-06-05 10:21:13.569 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (443 bytes): 2082c34e425f62d8090000000b5eda0079bfd96148ecd7d140242da42cca3de75eec30fe68193cd1f1d08970e696bfd41f074974d1ebb4e1e01a09e33070f2e84084f25bdef7da9a599c3cc98aa8e06b55ed9dd1a072b48e2d5f5c2a4ebbe83c0f5c231b0f09585e24caa36a012227945378edc2452533602ad18ebad5bf5fa3f7d1718c1c56b1af377d7452635e463b23e87940c18aceeb443a0053e9f0172ae59bb52aeed5e1e333aa10c0f99700e938182259e58539f4aabaf8d80029c1c0379fcfaca32c4681271d2826559e6e658d400f43f8c3e8c8b3517ba5af876f456e7c330d0c5ef4f4b5291fc34079a83173ddadfc86da178800c5b2b73e2c0b16bc5dbced05cfdaf3a0929be125783de6b226b4702899fdebb184500291f47a76c797abfe0002174ba01865a166adfbb42cfbf6cd9185ffc6cda3613d3d1ac8ff28f258ba24cba034ee7f44a006ec2bb17da39873818e5495588aeaa66d56b00651be88458ef4500e566d0a066a6c5b4d9d0f11c7f25c0af3cf76f0e8f5481718eb4a94408c5872358f975c9e3757ab7ec4f635aed24e91b13abbacbe468265cfd09ef9bce9cbb9b44af80e78837db9b895655dd7a053570030e89d 2020-06-05 10:21:13.572 DEBUG ControlChannel.writeOutboundPackets():169 - Control: Skip writing packet with packetId 5 (sent on 2020-06-05 08:21:13 +0000, 0.007948994636535645 seconds ago) 2020-06-05 10:21:13.582 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 4 2020-06-05 10:21:13.590 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:21:13.591 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: 6c157ebc5101a885, acks: {[5], 82c34e425f62d809}, pid: 5, [235 bytes]} 2020-06-05 10:21:13.592 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 5 2020-06-05 10:21:13.597 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 82c34e425f62d809, acks: {[5], 6c157ebc5101a885}} 2020-06-05 10:21:13.605 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (235 bytes) 2020-06-05 10:21:13.606 DEBUG OpenVPNSession.handleControlData():880 - Pulled plain control data (206 bytes) 2020-06-05 10:21:13.606 DEBUG Authenticator.parseAuthReply():209 - TLS.auth: Parsed server random 2020-06-05 10:21:13.607 DEBUG Authenticator.parseAuthReply():213 - TLS.auth: Parsed server options: "V4,dev-type tun,link-mtu 1549,tun-mtu 1500,proto UDPv4,cipher AES-256-GCM,auth [null-digest],keysize 256,key-method 2,tls-server" 2020-06-05 10:21:13.607 DEBUG OpenVPNSession.pushRequest():706 - TLS.ifconfig: Put plaintext (PUSH_REQUEST) 2020-06-05 10:21:13.607 DEBUG OpenVPNSession.pushRequest():722 - TLS.ifconfig: Send pulled ciphertext (42 bytes) 2020-06-05 10:21:13.607 DEBUG ControlChannel.enqueueOutboundPackets():159 - Control: Enqueued 1 packet [6] 2020-06-05 10:21:13.607 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 6, [42 bytes]} 2020-06-05 10:21:13.612 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (96 bytes): 2082c34e425f62d8090000000d5eda0079a966a31adb2403bdbdd3a4a0a61bcd172f995d94abb492a963f01a3a0ad42803069fb8ba676876757894b424eafe88e8cb2ee8a81ad5f71edfc9b1bdbfad7ea8ae3711f43ccdf2bf153a6d73ec231e 2020-06-05 10:21:13.612 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:21:13.616 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:21:13.616 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:21:13.617 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:21:13.624 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:21:13.625 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (0 bytes) 2020-06-05 10:21:13.626 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 5 2020-06-05 10:21:13.776 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 6, [42 bytes]} 2020-06-05 10:21:13.777 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (96 bytes): 2082c34e425f62d8090000000e5eda0079424c9bb671a48c41bed0422d01340e426bb8e02db226f3996e1d16be4f462a8b89e58337b656cc6ade99fd7c8122804584f2bf16f13d77fca1daf3aa42dd34a53dc86be53e8afdcf4ae5f57bfa8227 2020-06-05 10:21:13.997 DEBUG ControlChannel.writeOutboundPackets():174 - Control: Write control packet {CONTROL_V1 | 0, sid: 82c34e425f62d809, pid: 6, [42 bytes]} 2020-06-05 10:21:13.998 DEBUG OpenVPNSession.flushControlQueue():1038 - Send control packet (96 bytes): 2082c34e425f62d8090000000f5eda0079a1eb84ef60e218824941fd172656965c7894bd9f7c6cccd7687d34c3cc01467a0903c4cc2eeb6ec65e23b4b8eb31ad81f5e96cd73e7b982443b556a9c57e0108f46d3cf30cef4d021d86959dea76a6 2020-06-05 10:21:14.013 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:21:14.013 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: 6c157ebc5101a885, acks: {[6], 82c34e425f62d809}} 2020-06-05 10:21:14.013 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code CONTROL_V1 and key 0 2020-06-05 10:21:14.014 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {CONTROL_V1 | 0, sid: 6c157ebc5101a885, pid: 6, [476 bytes]} 2020-06-05 10:21:14.014 DEBUG OpenVPNSession.sendAck():1204 - Send ack for received packetId 6 2020-06-05 10:21:14.016 DEBUG ControlChannel.writeAcks():217 - Control: Write ack packet {ACK_V1 | 0, sid: 82c34e425f62d809, acks: {[6], 6c157ebc5101a885}} 2020-06-05 10:21:14.016 DEBUG OpenVPNSession.handleControlPacket():840 - TLS.connect: Put received ciphertext (476 bytes) 2020-06-05 10:21:14.016 DEBUG OpenVPNSession.handleControlData():880 - Pulled plain control data (447 bytes) 2020-06-05 10:21:14.017 DEBUG OpenVPNSession.handleControlData():905 - Parsed control message (446 bytes) 2020-06-05 10:21:14.020 DEBUG OpenVPNSession.handleControlMessage():956 - Received PUSH_REPLY: "PUSH_REPLY,block-outside-dns,dhcp-option DNS 192.87.106.106,dhcp-option DNS 192.87.36.36,dhcp-option DNS 2001:610:1:800a:192:87:106:106,dhcp-option DNS 2001:610:3:200a:192:87:36:36,explicit-exit-notify 1,redirect-gateway def1 ipv6 block-local,tun-ipv6,route-gateway 145.90.228.1,topology subnet,ping 10,ping-restart 60,ifconfig-ipv6 2001:610:450:40::1019/112 2001:610:450:40::1,ifconfig 145.90.228.27 255.255.255.192,peer-id 19,cipher AES-256-GCM" 2020-06-05 10:21:14.020 DEBUG OpenVPNSession.setupEncryption():1086 - Set up encryption 2020-06-05 10:21:14.020 INFO OpenVPNSession.setupEncryption():1091 - Negotiated cipher: AES-256-GCM 2020-06-05 10:21:14.020 INFO OpenVPNSession.setupEncryption():1102 - Negotiated keep-alive interval: 10.0 seconds 2020-06-05 10:21:14.020 INFO OpenVPNSession.setupEncryption():1105 - Negotiated keep-alive timeout: 60.0 seconds 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():518 - Session did start 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():520 - Returned ifconfig parameters: 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():521 - Remote: 145.100.179.13 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():522 - IPv4: addr 145.90.228.27 netmask 255.255.255.192 gw 145.90.228.1 routes [] 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():523 - IPv6: addr 2001:610:450:40::1019/112 gw 2001:610:450:40::1 routes [] 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():525 - Gateway: ["blockLocal", "IPv4", "IPv6"] 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():530 - DNS: ["192.87.106.106", "192.87.36.36", "2001:610:1:800a:192:87:106:106", "2001:610:3:200a:192:87:36:36"] 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.sessionDidStart():537 - Search domains: not configured 2020-06-05 10:21:14.021 INFO OpenVPNTunnelProvider.bringNetworkUp():616 - Routing.IPv4: Setting default gateway to 145.90.228.1 2020-06-05 10:21:14.022 INFO OpenVPNTunnelProvider.bringNetworkUp():645 - Routing.IPv6: Setting default gateway to 2001:610:450:40::1 2020-06-05 10:21:14.022 INFO OpenVPNTunnelProvider.bringNetworkUp():677 - DNS: Using servers ["192.87.106.106", "192.87.36.36", "2001:610:1:800a:192:87:106:106", "2001:610:3:200a:192:87:36:36"] 2020-06-05 10:21:14.046 INFO OpenVPNTunnelProvider.bringNetworkUp():750 - Block local: Suppressing IPv4 route default/32 2020-06-05 10:21:14.046 INFO OpenVPNTunnelProvider.bringNetworkUp():750 - Block local: Suppressing IPv4 route default/32 2020-06-05 10:21:14.047 INFO OpenVPNTunnelProvider.bringNetworkUp():765 - Block local: Suppressing IPv6 route default/128 2020-06-05 10:21:14.047 INFO OpenVPNTunnelProvider.bringNetworkUp():765 - Block local: Suppressing IPv6 route default/128 2020-06-05 10:21:14.050 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:21:14.050 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: 6c157ebc5101a885, acks: {[6], 82c34e425f62d809}} 2020-06-05 10:21:14.051 DEBUG OpenVPNSession.sendAck():1231 - Ack successfully written to LINK for packetId 6 2020-06-05 10:21:14.053 DEBUG ControlChannelSerializer.deserialize():64 - Control: Try read packet with code ACK_V1 and key 0 2020-06-05 10:21:14.054 DEBUG ControlChannel.readInboundPacket():103 - Control: Read packet {ACK_V1 | 0, sid: 6c157ebc5101a885, acks: {[6], 82c34e425f62d809}} 2020-06-05 10:21:14.543 DEBUG OpenVPNTunnelProvider.reasserting():137 - Reasserting flag cleared 2020-06-05 10:21:14.544 INFO OpenVPNTunnelProvider.sessionDidStart():569 - Tunnel interface is now UP 2020-06-05 10:21:24.801 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:21:28.007 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:21:35.307 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:21:39.007 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:21:45.311 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:21:50.010 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:21:55.313 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:22:01.010 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:22:05.800 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:22:12.009 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:22:16.795 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:22:23.010 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:22:26.801 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:22:36.802 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:22:47.796 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:22:48.022 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:22:58.711 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:22:58.726 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:23:09.364 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:23:13.015 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:23:20.316 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:23:24.010 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:23:31.147 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:23:34.436 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing 2020-06-05 10:23:41.149 DEBUG OpenVPNSession.ping():563 - Send ping 2020-06-05 10:23:45.014 DEBUG SessionKey.decrypt():123 - Data: Received ping, do nothing