Skip to content

Instantly share code, notes, and snippets.

@mgcrea
Created June 1, 2017 15:54
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save mgcrea/f6e40b9be671ee357cd5d3c722b3ecdc to your computer and use it in GitHub Desktop.
Save mgcrea/f6e40b9be671ee357cd5d3c722b3ecdc to your computer and use it in GitHub Desktop.
Thu Jun 1 15:53:39 2017 us=978835 groupname = 'nogroup'
Thu Jun 1 15:53:39 2017 us=978841 chroot_dir = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=978848 cd_dir = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=978854 writepid = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=978861 up_script = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=978868 down_script = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=978874 down_pre = DISABLED
Thu Jun 1 15:53:39 2017 us=978881 up_restart = DISABLED
Thu Jun 1 15:53:39 2017 us=978887 up_delay = DISABLED
Thu Jun 1 15:53:39 2017 us=978894 daemon = DISABLED
Thu Jun 1 15:53:39 2017 us=978900 inetd = 0
Thu Jun 1 15:53:39 2017 us=978907 log = ENABLED
Thu Jun 1 15:53:39 2017 us=978913 suppress_timestamps = DISABLED
Thu Jun 1 15:53:39 2017 us=978920 machine_readable_output = DISABLED
Thu Jun 1 15:53:39 2017 us=978926 nice = 0
Thu Jun 1 15:53:39 2017 us=978933 verbosity = 8
Thu Jun 1 15:53:39 2017 us=978939 mute = 0
Thu Jun 1 15:53:39 2017 us=978946 gremlin = 0
Thu Jun 1 15:53:39 2017 us=978952 status_file = 'status.log'
Thu Jun 1 15:53:39 2017 us=978959 status_file_version = 1
Thu Jun 1 15:53:39 2017 us=978966 status_file_update_freq = 5
Thu Jun 1 15:53:39 2017 us=978972 occ = ENABLED
Thu Jun 1 15:53:39 2017 us=978978 rcvbuf = 0
Thu Jun 1 15:53:39 2017 us=978985 sndbuf = 0
Thu Jun 1 15:53:39 2017 us=978991 mark = 0
Thu Jun 1 15:53:39 2017 us=978998 sockflags = 0
Thu Jun 1 15:53:39 2017 us=979004 fast_io = DISABLED
Thu Jun 1 15:53:39 2017 us=979010 comp.alg = 2
Thu Jun 1 15:53:39 2017 us=979017 comp.flags = 1
Thu Jun 1 15:53:39 2017 us=979023 route_script = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979030 route_default_gateway = '10.1.0.2'
Thu Jun 1 15:53:39 2017 us=979037 route_default_metric = 0
Thu Jun 1 15:53:39 2017 us=979043 route_noexec = DISABLED
Thu Jun 1 15:53:39 2017 us=979050 route_delay = 0
Thu Jun 1 15:53:39 2017 us=979056 route_delay_window = 30
Thu Jun 1 15:53:39 2017 us=979063 route_delay_defined = DISABLED
Thu Jun 1 15:53:39 2017 us=979069 route_nopull = DISABLED
Thu Jun 1 15:53:39 2017 us=979076 route_gateway_via_dhcp = DISABLED
Thu Jun 1 15:53:39 2017 us=979082 allow_pull_fqdn = DISABLED
Thu Jun 1 15:53:39 2017 us=979089 management_addr = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979095 management_port = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979101 management_user_pass = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979108 management_log_history_cache = 250
Thu Jun 1 15:53:39 2017 us=979115 management_echo_buffer_size = 100
Thu Jun 1 15:53:39 2017 us=979121 management_write_peer_info_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979128 management_client_user = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979135 management_client_group = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979141 management_flags = 0
Thu Jun 1 15:53:39 2017 us=979147 shared_secret_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979154 key_direction = 1
Thu Jun 1 15:53:39 2017 us=979160 ciphername = 'AES-256-CBC'
Thu Jun 1 15:53:39 2017 us=979167 ncp_enabled = ENABLED
Thu Jun 1 15:53:39 2017 us=979173 ncp_ciphers = 'AES-256-GCM:AES-128-GCM'
Thu Jun 1 15:53:39 2017 us=979180 authname = 'SHA1'
Thu Jun 1 15:53:39 2017 us=979186 prng_hash = 'SHA1'
Thu Jun 1 15:53:39 2017 us=979192 prng_nonce_secret_len = 16
Thu Jun 1 15:53:39 2017 us=979199 keysize = 0
Thu Jun 1 15:53:39 2017 us=979205 engine = DISABLED
Thu Jun 1 15:53:39 2017 us=979212 replay = ENABLED
Thu Jun 1 15:53:39 2017 us=979218 mute_replay_warnings = DISABLED
Thu Jun 1 15:53:39 2017 us=979224 replay_window = 64
Thu Jun 1 15:53:39 2017 us=979231 replay_time = 15
Thu Jun 1 15:53:39 2017 us=979237 packet_id_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979244 use_iv = ENABLED
Thu Jun 1 15:53:39 2017 us=979250 test_crypto = DISABLED
Thu Jun 1 15:53:39 2017 us=979257 tls_server = ENABLED
Thu Jun 1 15:53:39 2017 us=979263 tls_client = DISABLED
Thu Jun 1 15:53:39 2017 us=979274 key_method = 2
Thu Jun 1 15:53:39 2017 us=979281 ca_file = 'pki/ca.crt'
Thu Jun 1 15:53:39 2017 us=979287 ca_path = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979294 dh_file = 'pki/dh.pem'
Thu Jun 1 15:53:39 2017 us=979300 cert_file = 'pki/issued/server@prod.crt'
Thu Jun 1 15:53:39 2017 us=979307 extra_certs_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979314 priv_key_file = 'pki/private/server@prod.key'
Thu Jun 1 15:53:39 2017 us=979320 pkcs12_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979326 cipher_list = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979333 tls_verify = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979339 tls_export_cert = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979346 verify_x509_type = 0
Thu Jun 1 15:53:39 2017 us=979352 verify_x509_name = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979359 crl_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979365 ns_cert_type = 0
Thu Jun 1 15:53:39 2017 us=979371 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979378 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979384 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979390 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979397 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979403 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979409 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979416 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979422 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979428 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979435 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979441 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979447 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979453 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979460 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979466 remote_cert_ku[i] = 0
Thu Jun 1 15:53:39 2017 us=979473 remote_cert_eku = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979479 ssl_flags = 0
Thu Jun 1 15:53:39 2017 us=979490 tls_timeout = 2
Thu Jun 1 15:53:39 2017 us=979501 renegotiate_bytes = -1
Thu Jun 1 15:53:39 2017 us=979508 renegotiate_packets = 0
Thu Jun 1 15:53:39 2017 us=979515 renegotiate_seconds = 3600
Thu Jun 1 15:53:39 2017 us=979522 handshake_window = 60
Thu Jun 1 15:53:39 2017 us=979528 transition_window = 3600
Thu Jun 1 15:53:39 2017 us=979534 single_session = DISABLED
Thu Jun 1 15:53:39 2017 us=979541 push_peer_info = DISABLED
Thu Jun 1 15:53:39 2017 us=979547 tls_exit = DISABLED
Thu Jun 1 15:53:39 2017 us=979553 tls_auth_file = 'pki/ta.key'
Thu Jun 1 15:53:39 2017 us=979560 tls_crypt_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979573 server_network = 10.1.0.0
Thu Jun 1 15:53:39 2017 us=979582 server_netmask = 255.255.0.0
Thu Jun 1 15:53:39 2017 us=979592 server_network_ipv6 = ::
Thu Jun 1 15:53:39 2017 us=979599 server_netbits_ipv6 = 0
Thu Jun 1 15:53:39 2017 us=979607 server_bridge_ip = 0.0.0.0
Thu Jun 1 15:53:39 2017 us=979614 server_bridge_netmask = 0.0.0.0
Thu Jun 1 15:53:39 2017 us=979622 server_bridge_pool_start = 0.0.0.0
Thu Jun 1 15:53:39 2017 us=979630 server_bridge_pool_end = 0.0.0.0
Thu Jun 1 15:53:39 2017 us=979637 push_entry = 'route-gateway 10.1.0.1'
Thu Jun 1 15:53:39 2017 us=979643 push_entry = 'topology subnet'
Thu Jun 1 15:53:39 2017 us=979650 push_entry = 'ping 10'
Thu Jun 1 15:53:39 2017 us=979656 push_entry = 'ping-restart 120'
Thu Jun 1 15:53:39 2017 us=979663 ifconfig_pool_defined = ENABLED
Thu Jun 1 15:53:39 2017 us=979671 ifconfig_pool_start = 10.1.0.2
Thu Jun 1 15:53:39 2017 us=979679 ifconfig_pool_end = 10.1.255.253
Thu Jun 1 15:53:39 2017 us=979686 ifconfig_pool_netmask = 255.255.0.0
Thu Jun 1 15:53:39 2017 us=979693 ifconfig_pool_persist_filename = 'ipp.txt'
Thu Jun 1 15:53:39 2017 us=979700 ifconfig_pool_persist_refresh_freq = 600
Thu Jun 1 15:53:39 2017 us=979707 ifconfig_ipv6_pool_defined = DISABLED
Thu Jun 1 15:53:39 2017 us=979716 ifconfig_ipv6_pool_base = ::
Thu Jun 1 15:53:39 2017 us=979723 ifconfig_ipv6_pool_netbits = 0
Thu Jun 1 15:53:39 2017 us=979733 n_bcast_buf = 256
Thu Jun 1 15:53:39 2017 us=979741 tcp_queue_limit = 64
Thu Jun 1 15:53:39 2017 us=979747 real_hash_size = 256
Thu Jun 1 15:53:39 2017 us=979754 virtual_hash_size = 256
Thu Jun 1 15:53:39 2017 us=979761 client_connect_script = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979767 learn_address_script = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979774 client_disconnect_script = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979781 client_config_dir = '/etc/openvpn/ccd'
Thu Jun 1 15:53:39 2017 us=979787 ccd_exclusive = DISABLED
Thu Jun 1 15:53:39 2017 us=979794 tmp_dir = '/tmp'
Thu Jun 1 15:53:39 2017 us=979800 push_ifconfig_defined = DISABLED
Thu Jun 1 15:53:39 2017 us=979808 push_ifconfig_local = 0.0.0.0
Thu Jun 1 15:53:39 2017 us=979816 push_ifconfig_remote_netmask = 0.0.0.0
Thu Jun 1 15:53:39 2017 us=979823 push_ifconfig_ipv6_defined = DISABLED
Thu Jun 1 15:53:39 2017 us=979832 push_ifconfig_ipv6_local = ::/0
Thu Jun 1 15:53:39 2017 us=979841 push_ifconfig_ipv6_remote = ::
Thu Jun 1 15:53:39 2017 us=979861 enable_c2c = ENABLED
Thu Jun 1 15:53:39 2017 us=979867 duplicate_cn = ENABLED
Thu Jun 1 15:53:39 2017 us=979874 cf_max = 0
Thu Jun 1 15:53:39 2017 us=979881 cf_per = 0
Thu Jun 1 15:53:39 2017 us=979888 max_clients = 1024
Thu Jun 1 15:53:39 2017 us=979895 max_routes_per_client = 256
Thu Jun 1 15:53:39 2017 us=979902 auth_user_pass_verify_script = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979909 auth_user_pass_verify_script_via_file = DISABLED
Thu Jun 1 15:53:39 2017 us=979915 auth_token_generate = DISABLED
Thu Jun 1 15:53:39 2017 us=979922 auth_token_lifetime = 0
Thu Jun 1 15:53:39 2017 us=979929 port_share_host = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979936 port_share_port = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979942 client = DISABLED
Thu Jun 1 15:53:39 2017 us=979949 pull = DISABLED
Thu Jun 1 15:53:39 2017 us=979956 auth_user_pass_file = '[UNDEF]'
Thu Jun 1 15:53:39 2017 us=979964 OpenVPN 2.4.2 x86_64-alpine-linux-musl [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on May 12 2017
Thu Jun 1 15:53:39 2017 us=979973 library versions: LibreSSL 2.5.4, LZO 2.10
Thu Jun 1 15:53:39 2017 us=980021 WARNING: using --duplicate-cn and --client-config-dir together is probably not what you want
Thu Jun 1 15:53:39 2017 us=980028 WARNING: --ifconfig-pool-persist will not work with --duplicate-cn
Thu Jun 1 15:53:39 2017 us=980325 Diffie-Hellman initialized with 2048 bit key
Thu Jun 1 15:53:39 2017 us=980735 PRNG init md=SHA1 size=36
Thu Jun 1 15:53:39 2017 us=980829 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Thu Jun 1 15:53:39 2017 us=980846 Outgoing Control Channel Authentication: HMAC KEY: 4397d960 c27092a1 df3edde6 c1cc8539 58375815
Thu Jun 1 15:53:39 2017 us=980853 Outgoing Control Channel Authentication: HMAC size=20 block_size=20
Thu Jun 1 15:53:39 2017 us=980862 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Thu Jun 1 15:53:39 2017 us=980876 Incoming Control Channel Authentication: HMAC KEY: 6ec25f35 91167b10 7f0841d0 4a660152 6c12c0c7
Thu Jun 1 15:53:39 2017 us=980882 Incoming Control Channel Authentication: HMAC size=20 block_size=20
Thu Jun 1 15:53:39 2017 us=980890 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 28 bytes
Thu Jun 1 15:53:39 2017 us=980902 TLS-Auth MTU parms [ L:1624 D:1182 EF:68 EB:0 ET:0 EL:3 ]
Thu Jun 1 15:53:39 2017 us=980909 MTU DYNAMIC mtu=1450, flags=2, 1624 -> 1450
Thu Jun 1 15:53:39 2017 us=981344 TUN/TAP device tun0 opened
Thu Jun 1 15:53:39 2017 us=981363 TUN/TAP TX queue length set to 100
Thu Jun 1 15:53:39 2017 us=981377 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Thu Jun 1 15:53:39 2017 us=981397 /sbin/ip link set dev tun0 up mtu 1500
Thu Jun 1 15:53:39 2017 us=982316 /sbin/ip addr add dev tun0 10.1.0.1/16 broadcast 10.1.255.255
Thu Jun 1 15:53:39 2017 us=982948 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ]
Thu Jun 1 15:53:39 2017 us=983023 Could not determine IPv4/IPv6 protocol. Using AF_INET
Thu Jun 1 15:53:39 2017 us=983046 Socket Buffers: R=[87380->87380] S=[16384->16384]
Thu Jun 1 15:53:39 2017 us=983063 Listening for incoming TCP connection on [AF_INET][undef]:443
Thu Jun 1 15:53:39 2017 us=983076 TCPv4_SERVER link local (bound): [AF_INET][undef]:443
Thu Jun 1 15:53:39 2017 us=983084 TCPv4_SERVER link remote: [AF_UNSPEC]
Thu Jun 1 15:53:39 2017 us=983096 GID set to nogroup
Thu Jun 1 15:53:39 2017 us=983108 UID set to nobody
Thu Jun 1 15:53:39 2017 us=983118 MULTI: multi_init called, r=256 v=256
Thu Jun 1 15:53:39 2017 us=984171 IFCONFIG POOL: base=10.1.0.2 size=65532, ipv6=0
Thu Jun 1 15:53:39 2017 us=984191 IFCONFIG POOL LIST
Thu Jun 1 15:53:39 2017 us=984316 EP_INIT maxevents=1028 flags=0x00000000
Thu Jun 1 15:53:39 2017 us=984342 MULTI: TCP INIT maxclients=1024 maxevents=1028
Thu Jun 1 15:53:39 2017 us=984369 Initialization Sequence Completed
Thu Jun 1 15:53:39 2017 us=984377 SCHEDULE: schedule_find_least NULL
Thu Jun 1 15:53:39 2017 us=984385 EP_CTL fd=6 rwflags=0x0001 ev=0x00000001 arg=0x00000001
Thu Jun 1 15:53:39 2017 us=984394 EP_CTL fd=5 rwflags=0x0001 ev=0x00000001 arg=0x00000002
Thu Jun 1 15:53:49 2017 us=994447 MULTI: REAP range 0 -> 16
Thu Jun 1 15:53:49 2017 us=994988 MULTI TCP: multi_tcp_action a=TA_TIMEOUT p=0
Thu Jun 1 15:53:49 2017 us=995016 MULTI TCP: multi_tcp_dispatch a=TA_TIMEOUT mi=0x00000000
Thu Jun 1 15:53:49 2017 us=995034 MULTI TCP: multi_tcp_post TA_TIMEOUT -> TA_UNDEF
Thu Jun 1 15:53:49 2017 us=995053 SCHEDULE: schedule_find_least NULL
Thu Jun 1 15:53:52 2017 us=586832 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x00000001
Thu Jun 1 15:53:52 2017 us=586913 MULTI: REAP range 16 -> 32
Thu Jun 1 15:53:52 2017 us=586937 MULTI: multi_create_instance called
Thu Jun 1 15:53:52 2017 us=587012 PO_INIT maxevents=4 flags=0x00000002
Thu Jun 1 15:53:52 2017 us=587036 Re-using SSL/TLS context
Thu Jun 1 15:53:52 2017 us=587060 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 28 bytes
Thu Jun 1 15:53:52 2017 us=587091 LZO compression initializing
Thu Jun 1 15:53:52 2017 us=587161 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:52 2017 us=587324 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:52 2017 us=587354 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:52 2017 us=587448 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:52 2017 us=587492 Control Channel MTU parms [ L:1624 D:1182 EF:68 EB:0 ET:0 EL:3 ]
Thu Jun 1 15:53:52 2017 us=587541 MTU DYNAMIC mtu=1450, flags=2, 1624 -> 1450
Thu Jun 1 15:53:52 2017 us=587565 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ]
Thu Jun 1 15:53:52 2017 us=587598 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 56 bytes
Thu Jun 1 15:53:52 2017 us=587616 calc_options_string_link_mtu: link-mtu 1624 -> 1560
Thu Jun 1 15:53:52 2017 us=587662 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 56 bytes
Thu Jun 1 15:53:52 2017 us=587679 calc_options_string_link_mtu: link-mtu 1624 -> 1560
Thu Jun 1 15:53:52 2017 us=587709 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1560,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,keydir 0,cipher AES-256-CBC,auth SHA1,keysize 256,tls-auth,key-method 2,tls-server'
Thu Jun 1 15:53:52 2017 us=587727 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1560,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,keydir 1,cipher AES-256-CBC,auth SHA1,keysize 256,tls-auth,key-method 2,tls-client'
Thu Jun 1 15:53:52 2017 us=587818 TCP connection established with [AF_INET]90.63.221.168:55940
Thu Jun 1 15:53:52 2017 us=587841 TCP_SERVER link local: (not bound)
Thu Jun 1 15:53:52 2017 us=587863 TCP_SERVER link remote: [AF_INET]90.63.221.168:55940
Thu Jun 1 15:53:52 2017 us=587905 90.63.221.168:55940 SENT PING
Thu Jun 1 15:53:52 2017 us=587924 90.63.221.168:55940 TIMER: coarse timer wakeup 1 seconds
Thu Jun 1 15:53:52 2017 us=587972 90.63.221.168:55940 ACK mark active outgoing ID 0
Thu Jun 1 15:53:52 2017 us=587994 90.63.221.168:55940 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:52 2017 us=588070 90.63.221.168:55940 SSL state (accept): before/accept initialization
Thu Jun 1 15:53:52 2017 us=588099 90.63.221.168:55940 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:52 2017 us=588130 90.63.221.168:55940 ACK reliable_send_timeout 0 [1] 0
Thu Jun 1 15:53:52 2017 us=588155 90.63.221.168:55940 RANDOM USEC=20323
Thu Jun 1 15:53:52 2017 us=588179 90.63.221.168:55940 SCHEDULE: schedule_add_modify wakeup=[Thu Jun 1 15:53:53 2017 us=608492] pri=0
Thu Jun 1 15:53:52 2017 us=588201 90.63.221.168:55940 MULTI TCP: instance added: 90.63.221.168:55940
Thu Jun 1 15:53:52 2017 us=588218 90.63.221.168:55940 MULTI TCP: multi_tcp_action a=TA_INITIAL p=0
Thu Jun 1 15:53:52 2017 us=588234 90.63.221.168:55940 MULTI TCP: multi_tcp_dispatch a=TA_INITIAL mi=0x5618349706a0
Thu Jun 1 15:53:52 2017 us=588252 90.63.221.168:55940 EP_CTL fd=8 rwflags=0x0001 ev=0x00000001 arg=0x5618349706a0
Thu Jun 1 15:53:52 2017 us=588278 90.63.221.168:55940 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:52 2017 us=588299 90.63.221.168:55940 ACK reliable_send_timeout 0 [1] 0
Thu Jun 1 15:53:52 2017 us=588318 90.63.221.168:55940 MULTI TCP: multi_tcp_post TA_INITIAL -> TA_UNDEF
Thu Jun 1 15:53:52 2017 us=588340 90.63.221.168:55940 SCHEDULE: schedule_find_least wakeup=[Thu Jun 1 15:53:53 2017 us=608492] pri=1536058304
Thu Jun 1 15:53:53 2017 us=579497 90.63.221.168:55940 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=579569 90.63.221.168:55940 MULTI: REAP range 32 -> 48
Thu Jun 1 15:53:53 2017 us=579594 90.63.221.168:55940 MULTI TCP: multi_tcp_action a=TA_SOCKET_READ p=0
Thu Jun 1 15:53:53 2017 us=579625 90.63.221.168:55940 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_READ mi=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=579684 90.63.221.168:55940 TCP_SERVER READ [42] from [AF_INET]90.63.221.168:55940: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 pid=[ #1 ] [ ] pid=0 DATA len=0
Thu Jun 1 15:53:53 2017 us=579718 90.63.221.168:55940 TLS: Initial packet from [AF_INET]90.63.221.168:55940, sid=831be81b 9f2fc0ac
Thu Jun 1 15:53:53 2017 us=579778 90.63.221.168:55940 PID_TEST [0] [TLS_WRAP-0] [] 0:0 1496332433:1 t=1496332433[0] r=[0,64,15,0,1] sl=[0,0,64,528]
Thu Jun 1 15:53:53 2017 us=579798 90.63.221.168:55940 ACK reliable_schedule_now
Thu Jun 1 15:53:53 2017 us=579817 90.63.221.168:55940 ACK read ID 0 (buf->len=0)
Thu Jun 1 15:53:53 2017 us=579835 90.63.221.168:55940 ACK RWBS rel->size=8 rel->packet_id=00000000 id=00000000 ret=1
Thu Jun 1 15:53:53 2017 us=579852 90.63.221.168:55940 ACK mark active incoming ID 0
Thu Jun 1 15:53:53 2017 us=579868 90.63.221.168:55940 ACK acknowledge ID 0 (ack->len=1)
Thu Jun 1 15:53:53 2017 us=579892 90.63.221.168:55940 TIMER: coarse timer wakeup 1 seconds
Thu Jun 1 15:53:53 2017 us=579921 90.63.221.168:55940 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:53 2017 us=579938 90.63.221.168:55940 ACK reliable_send ID 0 (size=4 to=2)
Thu Jun 1 15:53:53 2017 us=579969 90.63.221.168:55940 ACK write ID 0 (ack->len=1, n=1)
Thu Jun 1 15:53:53 2017 us=579992 90.63.221.168:55940 ACK reliable_send_timeout 2 [1] 0
Thu Jun 1 15:53:53 2017 us=580016 90.63.221.168:55940 SCHEDULE: schedule_add_modify wakeup=[Thu Jun 1 15:53:54 2017 us=608676] pri=1536058304
Thu Jun 1 15:53:53 2017 us=580033 MULTI TCP: multi_tcp_post TA_SOCKET_READ -> TA_SOCKET_WRITE
Thu Jun 1 15:53:53 2017 us=580047 MULTI TCP: multi_tcp_action a=TA_SOCKET_WRITE p=1
Thu Jun 1 15:53:53 2017 us=580062 MULTI TCP: multi_tcp_wait_lite a=TA_SOCKET_WRITE mi=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=580077 PO_CTL rwflags=0x0002 ev=8 arg=0x5618333f71b8
Thu Jun 1 15:53:53 2017 us=580091 PO_CTL rwflags=0x0001 ev=5 arg=0x5618333f7068
Thu Jun 1 15:53:53 2017 us=580113 I/O WAIT TR|Tw|Sr|SW [0/0]
Thu Jun 1 15:53:53 2017 us=580134 PO_WAIT[0,0] fd=8 rev=0x00000004 rwflags=0x0002 arg=0x5618333f71b8
Thu Jun 1 15:53:53 2017 us=580164 I/O WAIT status=0x0002
Thu Jun 1 15:53:53 2017 us=580179 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_WRITE mi=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=580209 90.63.221.168:55940 TCP_SERVER WRITE [54] to [AF_INET]90.63.221.168:55940: P_CONTROL_HARD_RESET_SERVER_V2 kid=0 pid=[ #1 ] [ 0 ] pid=0 DATA len=0
Thu Jun 1 15:53:53 2017 us=580273 90.63.221.168:55940 ACK reliable_can_send active=1 current=0 : [1] 0
Thu Jun 1 15:53:53 2017 us=580311 90.63.221.168:55940 ACK reliable_can_send active=1 current=0 : [1] 0
Thu Jun 1 15:53:53 2017 us=580330 90.63.221.168:55940 ACK reliable_send_timeout 2 [1] 0
Thu Jun 1 15:53:53 2017 us=580347 MULTI TCP: multi_tcp_post TA_SOCKET_WRITE -> TA_UNDEF
Thu Jun 1 15:53:53 2017 us=580366 SCHEDULE: schedule_find_least wakeup=[Thu Jun 1 15:53:54 2017 us=608676] pri=1198907045
Thu Jun 1 15:53:53 2017 us=589007 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=589045 MULTI TCP: multi_tcp_action a=TA_SOCKET_READ p=0
Thu Jun 1 15:53:53 2017 us=589061 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_READ mi=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=589098 90.63.221.168:55940 TCP_SERVER READ [50] from [AF_INET]90.63.221.168:55940: P_ACK_V1 kid=0 pid=[ #2 ] [ 0 ]
Thu Jun 1 15:53:53 2017 us=589135 90.63.221.168:55940 PID_TEST [0] [TLS_WRAP-0] [0] 1496332433:1 1496332433:2 t=1496332433[0] r=[0,64,15,0,1] sl=[63,1,64,528]
Thu Jun 1 15:53:53 2017 us=589152 90.63.221.168:55940 ACK received for pid 0, deleting from send buffer
Thu Jun 1 15:53:53 2017 us=589176 90.63.221.168:55940 STATE S_START
Thu Jun 1 15:53:53 2017 us=589192 90.63.221.168:55940 ACK reliable_can_send active=0 current=0 : [1]
Thu Jun 1 15:53:53 2017 us=589214 90.63.221.168:55940 ACK reliable_can_send active=0 current=0 : [1]
Thu Jun 1 15:53:53 2017 us=589233 90.63.221.168:55940 ACK reliable_send_timeout 604800 [1]
Thu Jun 1 15:53:53 2017 us=589251 MULTI TCP: multi_tcp_post TA_SOCKET_READ -> TA_UNDEF
Thu Jun 1 15:53:53 2017 us=637377 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=637406 MULTI TCP: multi_tcp_action a=TA_SOCKET_READ p=0
Thu Jun 1 15:53:53 2017 us=637417 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_READ mi=0x5618349706a0
Thu Jun 1 15:53:53 2017 us=637457 90.63.221.168:55940 TCP_SERVER READ [166] from [AF_INET]90.63.221.168:55940: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=1 DATA len=124
Thu Jun 1 15:53:53 2017 us=637480 90.63.221.168:55940 PID_TEST [0] [TLS_WRAP-0] [00] 1496332433:2 1496332433:3 t=1496332433[0] r=[0,64,15,0,1] sl=[62,2,64,528]
Thu Jun 1 15:53:53 2017 us=637490 90.63.221.168:55940 ACK read ID 1 (buf->len=124)
Thu Jun 1 15:53:53 2017 us=637499 90.63.221.168:55940 ACK RWBS rel->size=8 rel->packet_id=00000001 id=00000001 ret=1
Thu Jun 1 15:53:53 2017 us=637508 90.63.221.168:55940 ACK mark active incoming ID 1
Thu Jun 1 15:53:53 2017 us=637516 90.63.221.168:55940 ACK acknowledge ID 1 (ack->len=1)
Thu Jun 1 15:53:53 2017 us=637529 90.63.221.168:55940 ACK reliable_can_send active=0 current=0 : [1]
Thu Jun 1 15:53:53 2017 us=637540 90.63.221.168:55940 BIO write tls_write_ciphertext 124 bytes
Thu Jun 1 15:53:53 2017 us=637620 90.63.221.168:55940 SSL alert (write): fatal: handshake failure
Thu Jun 1 15:53:53 2017 us=637633 90.63.221.168:55940 TLS error: The server has no TLS ciphersuites in common with the client. Your --tls-cipher setting might be too restrictive.
Thu Jun 1 15:53:53 2017 us=637652 90.63.221.168:55940 OpenSSL: error:140270C1:SSL routines:ACCEPT_SR_CLNT_HELLO_C:no shared cipher
Thu Jun 1 15:53:53 2017 us=637661 90.63.221.168:55940 TLS_ERROR: BIO read tls_read_plaintext error
Thu Jun 1 15:53:53 2017 us=637669 90.63.221.168:55940 TLS Error: TLS object -> incoming plaintext read error
Thu Jun 1 15:53:53 2017 us=637678 90.63.221.168:55940 TLS Error: TLS handshake failed
Thu Jun 1 15:53:53 2017 us=637685 90.63.221.168:55940 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637716 90.63.221.168:55940 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637726 90.63.221.168:55940 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637746 90.63.221.168:55940 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:53 2017 us=637791 90.63.221.168:55940 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:53 2017 us=637803 90.63.221.168:55940 Fatal TLS error (check_tls_errors_co), restarting
Thu Jun 1 15:53:53 2017 us=637813 90.63.221.168:55940 SIGUSR1[soft,tls-error] received, client-instance restarting
Thu Jun 1 15:53:53 2017 us=637821 MULTI: multi_close_instance called
Thu Jun 1 15:53:53 2017 us=637832 EP_DEL ev=8
Thu Jun 1 15:53:53 2017 us=637869 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637884 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637893 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637900 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637914 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637922 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637930 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637937 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=637946 TCP/UDP: Closing socket
Thu Jun 1 15:53:53 2017 us=637985 PID packet_id_free
Thu Jun 1 15:53:53 2017 us=638001 MULTI TCP: multi_tcp_post TA_SOCKET_READ -> TA_UNDEF
Thu Jun 1 15:53:53 2017 us=638010 SCHEDULE: schedule_find_least NULL
Thu Jun 1 15:53:58 2017 us=656241 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x00000001
Thu Jun 1 15:53:58 2017 us=656309 MULTI: REAP range 48 -> 64
Thu Jun 1 15:53:58 2017 us=656417 MULTI: multi_create_instance called
Thu Jun 1 15:53:58 2017 us=656476 PO_INIT maxevents=4 flags=0x00000002
Thu Jun 1 15:53:58 2017 us=656493 Re-using SSL/TLS context
Thu Jun 1 15:53:58 2017 us=656510 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 28 bytes
Thu Jun 1 15:53:58 2017 us=656524 LZO compression initializing
Thu Jun 1 15:53:58 2017 us=656573 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:58 2017 us=656658 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:58 2017 us=656683 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:58 2017 us=656734 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:58 2017 us=656756 Control Channel MTU parms [ L:1624 D:1182 EF:68 EB:0 ET:0 EL:3 ]
Thu Jun 1 15:53:58 2017 us=656782 MTU DYNAMIC mtu=1450, flags=2, 1624 -> 1450
Thu Jun 1 15:53:58 2017 us=656800 Data Channel MTU parms [ L:1624 D:1450 EF:124 EB:406 ET:0 EL:3 ]
Thu Jun 1 15:53:58 2017 us=656826 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 56 bytes
Thu Jun 1 15:53:58 2017 us=656840 calc_options_string_link_mtu: link-mtu 1624 -> 1560
Thu Jun 1 15:53:58 2017 us=656877 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 56 bytes
Thu Jun 1 15:53:58 2017 us=656890 calc_options_string_link_mtu: link-mtu 1624 -> 1560
Thu Jun 1 15:53:58 2017 us=656915 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1560,tun-mtu 1500,proto TCPv4_SERVER,comp-lzo,keydir 0,cipher AES-256-CBC,auth SHA1,keysize 256,tls-auth,key-method 2,tls-server'
Thu Jun 1 15:53:58 2017 us=656929 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1560,tun-mtu 1500,proto TCPv4_CLIENT,comp-lzo,keydir 1,cipher AES-256-CBC,auth SHA1,keysize 256,tls-auth,key-method 2,tls-client'
Thu Jun 1 15:53:58 2017 us=657001 TCP connection established with [AF_INET]90.63.221.168:55944
Thu Jun 1 15:53:58 2017 us=657018 TCP_SERVER link local: (not bound)
Thu Jun 1 15:53:58 2017 us=657035 TCP_SERVER link remote: [AF_INET]90.63.221.168:55944
Thu Jun 1 15:53:58 2017 us=657062 90.63.221.168:55944 SENT PING
Thu Jun 1 15:53:58 2017 us=657075 90.63.221.168:55944 TIMER: coarse timer wakeup 1 seconds
Thu Jun 1 15:53:58 2017 us=657095 90.63.221.168:55944 ACK mark active outgoing ID 0
Thu Jun 1 15:53:58 2017 us=657111 90.63.221.168:55944 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:58 2017 us=657148 90.63.221.168:55944 SSL state (accept): before/accept initialization
Thu Jun 1 15:53:58 2017 us=657170 90.63.221.168:55944 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:58 2017 us=657204 90.63.221.168:55944 ACK reliable_send_timeout 0 [1] 0
Thu Jun 1 15:53:58 2017 us=657223 90.63.221.168:55944 RANDOM USEC=124682
Thu Jun 1 15:53:58 2017 us=657243 90.63.221.168:55944 SCHEDULE: schedule_add_modify wakeup=[Thu Jun 1 15:53:59 2017 us=781917] pri=0
Thu Jun 1 15:53:58 2017 us=657262 90.63.221.168:55944 MULTI TCP: instance added: 90.63.221.168:55944
Thu Jun 1 15:53:58 2017 us=657275 90.63.221.168:55944 MULTI TCP: multi_tcp_action a=TA_INITIAL p=0
Thu Jun 1 15:53:58 2017 us=657288 90.63.221.168:55944 MULTI TCP: multi_tcp_dispatch a=TA_INITIAL mi=0x56183498b060
Thu Jun 1 15:53:58 2017 us=657303 90.63.221.168:55944 EP_CTL fd=8 rwflags=0x0001 ev=0x00000001 arg=0x56183498b060
Thu Jun 1 15:53:58 2017 us=657325 90.63.221.168:55944 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:58 2017 us=657343 90.63.221.168:55944 ACK reliable_send_timeout 0 [1] 0
Thu Jun 1 15:53:58 2017 us=657358 90.63.221.168:55944 MULTI TCP: multi_tcp_post TA_INITIAL -> TA_UNDEF
Thu Jun 1 15:53:58 2017 us=657376 90.63.221.168:55944 SCHEDULE: schedule_find_least wakeup=[Thu Jun 1 15:53:59 2017 us=781917] pri=1525764588
Thu Jun 1 15:53:59 2017 us=649438 90.63.221.168:55944 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x56183498b060
Thu Jun 1 15:53:59 2017 us=649516 90.63.221.168:55944 MULTI: REAP range 64 -> 80
Thu Jun 1 15:53:59 2017 us=649542 90.63.221.168:55944 MULTI TCP: multi_tcp_action a=TA_SOCKET_READ p=0
Thu Jun 1 15:53:59 2017 us=649558 90.63.221.168:55944 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_READ mi=0x56183498b060
Thu Jun 1 15:53:59 2017 us=649633 90.63.221.168:55944 TCP_SERVER READ [42] from [AF_INET]90.63.221.168:55944: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 pid=[ #1 ] [ ] pid=0 DATA len=0
Thu Jun 1 15:53:59 2017 us=649669 90.63.221.168:55944 TLS: Initial packet from [AF_INET]90.63.221.168:55944, sid=841928a8 d753d8bd
Thu Jun 1 15:53:59 2017 us=649716 90.63.221.168:55944 PID_TEST [0] [TLS_WRAP-0] [] 0:0 1496332439:1 t=1496332439[0] r=[0,64,15,0,1] sl=[0,0,64,528]
Thu Jun 1 15:53:59 2017 us=649736 90.63.221.168:55944 ACK reliable_schedule_now
Thu Jun 1 15:53:59 2017 us=649754 90.63.221.168:55944 ACK read ID 0 (buf->len=0)
Thu Jun 1 15:53:59 2017 us=649772 90.63.221.168:55944 ACK RWBS rel->size=8 rel->packet_id=00000000 id=00000000 ret=1
Thu Jun 1 15:53:59 2017 us=649788 90.63.221.168:55944 ACK mark active incoming ID 0
Thu Jun 1 15:53:59 2017 us=649804 90.63.221.168:55944 ACK acknowledge ID 0 (ack->len=1)
Thu Jun 1 15:53:59 2017 us=649826 90.63.221.168:55944 TIMER: coarse timer wakeup 1 seconds
Thu Jun 1 15:53:59 2017 us=649856 90.63.221.168:55944 ACK reliable_can_send active=1 current=1 : [1] 0
Thu Jun 1 15:53:59 2017 us=649874 90.63.221.168:55944 ACK reliable_send ID 0 (size=4 to=2)
Thu Jun 1 15:53:59 2017 us=649891 90.63.221.168:55944 ACK write ID 0 (ack->len=1, n=1)
Thu Jun 1 15:53:59 2017 us=649917 90.63.221.168:55944 ACK reliable_send_timeout 2 [1] 0
Thu Jun 1 15:53:59 2017 us=649943 90.63.221.168:55944 SCHEDULE: schedule_add_modify wakeup=[Thu Jun 1 15:54:00 2017 us=782069] pri=1525764588
Thu Jun 1 15:53:59 2017 us=649962 MULTI TCP: multi_tcp_post TA_SOCKET_READ -> TA_SOCKET_WRITE
Thu Jun 1 15:53:59 2017 us=649979 MULTI TCP: multi_tcp_action a=TA_SOCKET_WRITE p=1
Thu Jun 1 15:53:59 2017 us=649995 MULTI TCP: multi_tcp_wait_lite a=TA_SOCKET_WRITE mi=0x56183498b060
Thu Jun 1 15:53:59 2017 us=650013 PO_CTL rwflags=0x0002 ev=8 arg=0x5618333f71b8
Thu Jun 1 15:53:59 2017 us=650045 PO_CTL rwflags=0x0001 ev=5 arg=0x5618333f7068
Thu Jun 1 15:53:59 2017 us=650068 I/O WAIT TR|Tw|Sr|SW [0/0]
Thu Jun 1 15:53:59 2017 us=650092 PO_WAIT[0,0] fd=8 rev=0x00000004 rwflags=0x0002 arg=0x5618333f71b8
Thu Jun 1 15:53:59 2017 us=650107 I/O WAIT status=0x0002
Thu Jun 1 15:53:59 2017 us=650122 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_WRITE mi=0x56183498b060
Thu Jun 1 15:53:59 2017 us=650155 90.63.221.168:55944 TCP_SERVER WRITE [54] to [AF_INET]90.63.221.168:55944: P_CONTROL_HARD_RESET_SERVER_V2 kid=0 pid=[ #1 ] [ 0 ] pid=0 DATA len=0
Thu Jun 1 15:53:59 2017 us=650268 90.63.221.168:55944 ACK reliable_can_send active=1 current=0 : [1] 0
Thu Jun 1 15:53:59 2017 us=650313 90.63.221.168:55944 ACK reliable_can_send active=1 current=0 : [1] 0
Thu Jun 1 15:53:59 2017 us=650333 90.63.221.168:55944 ACK reliable_send_timeout 2 [1] 0
Thu Jun 1 15:53:59 2017 us=650351 MULTI TCP: multi_tcp_post TA_SOCKET_WRITE -> TA_UNDEF
Thu Jun 1 15:53:59 2017 us=650372 SCHEDULE: schedule_find_least wakeup=[Thu Jun 1 15:54:00 2017 us=782069] pri=1545977271
Thu Jun 1 15:53:59 2017 us=659224 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x56183498b060
Thu Jun 1 15:53:59 2017 us=659273 MULTI TCP: multi_tcp_action a=TA_SOCKET_READ p=0
Thu Jun 1 15:53:59 2017 us=659292 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_READ mi=0x56183498b060
Thu Jun 1 15:53:59 2017 us=659350 90.63.221.168:55944 TCP_SERVER READ [50] from [AF_INET]90.63.221.168:55944: P_ACK_V1 kid=0 pid=[ #2 ] [ 0 ]
Thu Jun 1 15:53:59 2017 us=659389 90.63.221.168:55944 PID_TEST [0] [TLS_WRAP-0] [0] 1496332439:1 1496332439:2 t=1496332439[0] r=[0,64,15,0,1] sl=[63,1,64,528]
Thu Jun 1 15:53:59 2017 us=659408 90.63.221.168:55944 ACK received for pid 0, deleting from send buffer
Thu Jun 1 15:53:59 2017 us=659430 90.63.221.168:55944 STATE S_START
Thu Jun 1 15:53:59 2017 us=659448 90.63.221.168:55944 ACK reliable_can_send active=0 current=0 : [1]
Thu Jun 1 15:53:59 2017 us=659472 90.63.221.168:55944 ACK reliable_can_send active=0 current=0 : [1]
Thu Jun 1 15:53:59 2017 us=659492 90.63.221.168:55944 ACK reliable_send_timeout 604800 [1]
Thu Jun 1 15:53:59 2017 us=659511 MULTI TCP: multi_tcp_post TA_SOCKET_READ -> TA_UNDEF
Thu Jun 1 15:53:59 2017 us=709651 EP_WAIT[0] rwflags=0x0001 ev=0x00000001 arg=0x56183498b060
Thu Jun 1 15:53:59 2017 us=709707 MULTI TCP: multi_tcp_action a=TA_SOCKET_READ p=0
Thu Jun 1 15:53:59 2017 us=709721 MULTI TCP: multi_tcp_dispatch a=TA_SOCKET_READ mi=0x56183498b060
Thu Jun 1 15:53:59 2017 us=709771 90.63.221.168:55944 TCP_SERVER READ [166] from [AF_INET]90.63.221.168:55944: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=1 DATA len=124
Thu Jun 1 15:53:59 2017 us=709814 90.63.221.168:55944 PID_TEST [0] [TLS_WRAP-0] [00] 1496332439:2 1496332439:3 t=1496332439[0] r=[0,64,15,0,1] sl=[62,2,64,528]
Thu Jun 1 15:53:59 2017 us=709834 90.63.221.168:55944 ACK read ID 1 (buf->len=124)
Thu Jun 1 15:53:59 2017 us=709852 90.63.221.168:55944 ACK RWBS rel->size=8 rel->packet_id=00000001 id=00000001 ret=1
Thu Jun 1 15:53:59 2017 us=709883 90.63.221.168:55944 ACK mark active incoming ID 1
Thu Jun 1 15:53:59 2017 us=709895 90.63.221.168:55944 ACK acknowledge ID 1 (ack->len=1)
Thu Jun 1 15:53:59 2017 us=709914 90.63.221.168:55944 ACK reliable_can_send active=0 current=0 : [1]
Thu Jun 1 15:53:59 2017 us=709931 90.63.221.168:55944 BIO write tls_write_ciphertext 124 bytes
Thu Jun 1 15:53:59 2017 us=710036 90.63.221.168:55944 SSL alert (write): fatal: handshake failure
Thu Jun 1 15:53:59 2017 us=710060 90.63.221.168:55944 TLS error: The server has no TLS ciphersuites in common with the client. Your --tls-cipher setting might be too restrictive.
Thu Jun 1 15:53:59 2017 us=710090 90.63.221.168:55944 OpenSSL: error:140270C1:SSL routines:ACCEPT_SR_CLNT_HELLO_C:no shared cipher
Thu Jun 1 15:53:59 2017 us=710106 90.63.221.168:55944 TLS_ERROR: BIO read tls_read_plaintext error
Thu Jun 1 15:53:59 2017 us=710123 90.63.221.168:55944 TLS Error: TLS object -> incoming plaintext read error
Thu Jun 1 15:53:59 2017 us=710139 90.63.221.168:55944 TLS Error: TLS handshake failed
Thu Jun 1 15:53:59 2017 us=710154 90.63.221.168:55944 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710200 90.63.221.168:55944 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710218 90.63.221.168:55944 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710269 90.63.221.168:55944 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:59 2017 us=710352 90.63.221.168:55944 PID packet_id_init seq_backtrack=64 time_backtrack=15
Thu Jun 1 15:53:59 2017 us=710368 90.63.221.168:55944 Fatal TLS error (check_tls_errors_co), restarting
Thu Jun 1 15:53:59 2017 us=710382 90.63.221.168:55944 SIGUSR1[soft,tls-error] received, client-instance restarting
Thu Jun 1 15:53:59 2017 us=710404 MULTI: multi_close_instance called
Thu Jun 1 15:53:59 2017 us=710418 EP_DEL ev=8
Thu Jun 1 15:53:59 2017 us=710472 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710510 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710522 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710533 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710551 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710563 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710574 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710584 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710596 TCP/UDP: Closing socket
Thu Jun 1 15:53:59 2017 us=710651 PID packet_id_free
Thu Jun 1 15:53:59 2017 us=710673 MULTI TCP: multi_tcp_post TA_SOCKET_READ -> TA_UNDEF
Thu Jun 1 15:53:59 2017 us=710686 SCHEDULE: schedule_find_least NULL
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment