OpenVPN проблема с соединением

Обсуждение ПО и его настройки
Soul
Сообщения: 6
Зарегистрирован: 23 июл 2019, 07:25

Добрый день. Может кто-нибудь сможет помочь советом, буду очень признателен.
Ситуация, есть Микротик, на нем поднят OpenVPN сервер. Большинство клиентов конектится и работает без проблем, но у нескольких соединение никак не проходит. Конфиги везде одинаковы, везде стоит винда.

Настройки опенвпн на микротике: https://yadi.sk/i/gHgAs98iohiWDQ
 Конфиг клиента
client
resolv-retry infinite
nobind
remote 78.157.227.*** 12345
proto tcp
dev tun
ca ca.crt
cert Mikrotik.crt
key Mikrotik.key
float
cipher AES-128-CBC
keepalive 10 120
persist-key
persist-tun
verb 3
remote-cert-tls server
auth-user-pass pass.txt
auth-nocache
 Лог подключения клиента от restart до restart
Tue Jul 23 11:08:23 2019 us=982782 Connection reset, restarting [0]
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 PKCS#11: __pkcs11h_openssl_ex_data_free entered - parent=000000000058C780, ptr=0000000000000000, ad=000000000058C7D8, idx=1, argl=0, argp=0000000074D38E2F
Tue Jul 23 11:08:23 2019 us=982782 PKCS#11: __pkcs11h_openssl_ex_data_free entered - parent=00000000005981E0, ptr=0000000000000000, ad=0000000000598238, idx=1, argl=0, argp=0000000074D38E2F
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 TCP/UDP: Closing socket
Tue Jul 23 11:08:23 2019 us=982782 PID packet_id_free
Tue Jul 23 11:08:23 2019 us=982782 SIGUSR1[soft,connection-reset] received, process restarting
Tue Jul 23 11:08:23 2019 us=982782 Restart pause, 5 second(s)
Tue Jul 23 11:08:28 2019 us=982782 WE_INIT maxevents=4 flags=0x00000002
Tue Jul 23 11:08:28 2019 us=982782 WE_INIT maxevents=4 capacity=8
Tue Jul 23 11:08:28 2019 us=982782 Re-using SSL/TLS context
Tue Jul 23 11:08:28 2019 us=982782 TLS: tls_session_init: entry
Tue Jul 23 11:08:28 2019 us=982782 PID packet_id_init seq_backtrack=64 time_backtrack=15
Tue Jul 23 11:08:28 2019 us=982782 PID packet_id_init seq_backtrack=64 time_backtrack=15
Tue Jul 23 11:08:28 2019 us=982782 TLS: tls_session_init: new session object, sid=c64e9751 29cd1753
Tue Jul 23 11:08:28 2019 us=982782 TLS: tls_session_init: entry
Tue Jul 23 11:08:28 2019 us=982782 PID packet_id_init seq_backtrack=64 time_backtrack=15
Tue Jul 23 11:08:28 2019 us=982782 PID packet_id_init seq_backtrack=64 time_backtrack=15
Tue Jul 23 11:08:28 2019 us=982782 TLS: tls_session_init: new session object, sid=439f141d 98907823
Tue Jul 23 11:08:28 2019 us=982782 Control Channel MTU parms [ L:1623 D:1210 EF:40 EB:0 ET:0 EL:3 ]
Tue Jul 23 11:08:28 2019 us=982782 MTU DYNAMIC mtu=1450, flags=2, 1623 -> 1450
Tue Jul 23 11:08:28 2019 us=982782 RESOLVE_REMOTE flags=0x0101 phase=1 rrs=0 sig=-1 status=0
Tue Jul 23 11:08:28 2019 us=982782 Data Channel MTU parms [ L:1623 D:1450 EF:123 EB:406 ET:0 EL:3 ]
Tue Jul 23 11:08:28 2019 us=982782 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 56 bytes
Tue Jul 23 11:08:28 2019 us=982782 calc_options_string_link_mtu: link-mtu 1623 -> 1559
Tue Jul 23 11:08:28 2019 us=982782 crypto_adjust_frame_parameters: Adjusting frame parameters for crypto by 56 bytes
Tue Jul 23 11:08:28 2019 us=982782 calc_options_string_link_mtu: link-mtu 1623 -> 1559
Tue Jul 23 11:08:28 2019 us=982782 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_CLIENT,cipher AES-128-CBC,auth SHA1,keysize 128,key-method 2,tls-client'
Tue Jul 23 11:08:28 2019 us=982782 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1559,tun-mtu 1500,proto TCPv4_SERVER,cipher AES-128-CBC,auth SHA1,keysize 128,key-method 2,tls-server'
Tue Jul 23 11:08:28 2019 us=982782 STREAM: RESET
Tue Jul 23 11:08:28 2019 us=982782 STREAM: INIT maxlen=1626
Tue Jul 23 11:08:28 2019 us=982782 TCP/UDP: Preserving recently used remote address: [AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:28 2019 us=982782 Socket Buffers: R=[8192->8192] S=[8192->8192]
Tue Jul 23 11:08:28 2019 us=982782 Attempting to establish TCP connection with [AF_INET]78.157.227.***:12345 [nonblock]
Tue Jul 23 11:08:29 2019 us=982782 TCP connection established with [AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT link local: (not bound)
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT link remote: [AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TLS Warning: no data channel send key available: [key#0 state=S_INITIAL id=0 sid=00000000 00000000] [key#1 state=S_UNDEF id=0 sid=00000000 00000000] [key#2 state=S_UNDEF id=0 sid=00000000 00000000]
Tue Jul 23 11:08:29 2019 us=982782 SENT PING
Tue Jul 23 11:08:29 2019 us=982782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=0 state=S_INITIAL, mysid=c64e9751 29cd1753, stored-sid=00000000 00000000, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: chg=0 ks=S_INITIAL lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:29 2019 us=982782 ACK mark active outgoing ID 0
Tue Jul 23 11:08:29 2019 us=982782 TLS: Initial Handshake, sid=c64e9751 29cd1753
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_can_send active=1 current=1 : [1] 0
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_send ID 0 (size=4 to=2)
Tue Jul 23 11:08:29 2019 us=982782 Reliable -> TCP/UDP
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_send_timeout 2 [1] 0
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 RANDOM USEC=34361
Tue Jul 23 11:08:29 2019 us=982782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=982782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:29 2019 us=982782 STREAM: GET NEXT len=1626
Tue Jul 23 11:08:29 2019 us=982782 WIN32 I/O: Socket Receive immediate return [1626,16]
Tue Jul 23 11:08:29 2019 us=982782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 I/O WAIT T?|T?|SR1|SW0 [1/34361]
Tue Jul 23 11:08:29 2019 us=982782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:29 2019 us=982782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=982782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 WE_WAIT leave [2,1] rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 event_wait returned 2
Tue Jul 23 11:08:29 2019 us=982782 I/O WAIT status=0x0003
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT WRITE [14] to [AF_INET]78.157.227.***:12345: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 sid=c64e9751 29cd1753 [ ] pid=0 DATA
Tue Jul 23 11:08:29 2019 us=982782 STREAM: WRITE 14 offset=30
Tue Jul 23 11:08:29 2019 us=982782 WIN32 I/O: Socket Send immediate return [16,16]
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT write returned 16
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=c64e9751 29cd1753, stored-sid=00000000 00000000, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_can_send active=1 current=0 : [1] 0
Tue Jul 23 11:08:29 2019 us=982782 SSL state (connect): before SSL initialization
Tue Jul 23 11:08:29 2019 us=982782 SSL state (connect): SSLv3/TLS write client hello
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_send_timeout 2 [1] 0
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=982782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:29 2019 us=982782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 I/O WAIT T?|T?|SR1|Sw1 [1/34361]
Tue Jul 23 11:08:29 2019 us=982782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:29 2019 us=982782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=982782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 WE_WAIT leave [1,0] rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 event_wait returned 1
Tue Jul 23 11:08:29 2019 us=982782 I/O WAIT status=0x0001
Tue Jul 23 11:08:29 2019 us=982782 WIN32 I/O: Socket Completion non-queued success [16]
Tue Jul 23 11:08:29 2019 us=982782 STREAM: ADD length_added=16
Tue Jul 23 11:08:29 2019 us=982782 STREAM: ADD returned TRUE, buf_len=14, residual_len=0
Tue Jul 23 11:08:29 2019 us=982782 STREAM: GET FINAL len=14
Tue Jul 23 11:08:29 2019 us=982782 STREAM: RESET
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT read returned 14
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT READ [14] from [AF_INET]78.157.227.***:12345: P_CONTROL_HARD_RESET_SERVER_V2 kid=0 sid=6209e701 ce41f43f [ ] pid=0 DATA
Tue Jul 23 11:08:29 2019 us=982782 TLS: control channel, op=P_CONTROL_HARD_RESET_SERVER_V2, IP=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TLS: initial packet test, i=0 state=S_PRE_START, mysid=c64e9751 29cd1753, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=00000000 00000000, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TLS: initial packet test, i=1 state=S_INITIAL, mysid=439f141d 98907823, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 TLS: initial packet test, i=2 state=S_UNDEF, mysid=00000000 00000000, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 TLS: Initial packet from [AF_INET]78.157.227.***:12345, sid=6209e701 ce41f43f
Tue Jul 23 11:08:29 2019 us=982782 TLS: received control channel packet s#=0 sid=6209e701 ce41f43f
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_schedule_now
Tue Jul 23 11:08:29 2019 us=982782 ACK read ID 0 (buf->len=0)
Tue Jul 23 11:08:29 2019 us=982782 ACK RWBS rel->size=8 rel->packet_id=00000000 id=00000000 ret=1

Tue Jul 23 11:08:29 2019 us=982782 ACK mark active incoming ID 0
Tue Jul 23 11:08:29 2019 us=982782 ACK acknowledge ID 0 (ack->len=1)
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_can_send active=1 current=1 : [1] 0
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_send ID 0 (size=4 to=2)
Tue Jul 23 11:08:29 2019 us=982782 ACK write ID 0 (ack->len=1, n=1)
Tue Jul 23 11:08:29 2019 us=982782 Reliable -> TCP/UDP
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_send_timeout 2 [1] 0
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=982782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=982782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:29 2019 us=982782 STREAM: GET NEXT len=1626
Tue Jul 23 11:08:29 2019 us=982782 WIN32 I/O: Socket Receive queued [1626]
Tue Jul 23 11:08:29 2019 us=982782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:29 2019 us=982782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:29 2019 us=982782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=982782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=982782 event_wait returned 1
Tue Jul 23 11:08:29 2019 us=982782 I/O WAIT status=0x0002
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT WRITE [26] to [AF_INET]78.157.227.***:12345: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 sid=c64e9751 29cd1753 [ 0 sid=6209e701 ce41f43f ] pid=0 DATA
Tue Jul 23 11:08:29 2019 us=982782 STREAM: WRITE 26 offset=18
Tue Jul 23 11:08:29 2019 us=982782 WIN32 I/O: Socket Completion non-queued success [16]
Tue Jul 23 11:08:29 2019 us=982782 WIN32 I/O: Socket Send immediate return [28,28]
Tue Jul 23 11:08:29 2019 us=982782 TCP_CLIENT write returned 28
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_can_send active=1 current=0 : [1] 0
Tue Jul 23 11:08:29 2019 us=982782 Incoming Ciphertext -> TLS
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: chg=1 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_can_send active=1 current=0 : [1] 0
Tue Jul 23 11:08:29 2019 us=982782 ACK reliable_send_timeout 2 [1] 0
Tue Jul 23 11:08:29 2019 us=982782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:29 2019 us=983782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=983782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:29 2019 us=983782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=983782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:29 2019 us=983782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:29 2019 us=983782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:29 2019 us=983782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:29 2019 us=983782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:29 2019 us=983782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:30 2019 us=550782 WE_WAIT leave rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:30 2019 us=550782 event_wait returned 1
Tue Jul 23 11:08:30 2019 us=550782 I/O WAIT status=0x0001
Tue Jul 23 11:08:30 2019 us=550782 WIN32 I/O: Socket Completion success [24]
Tue Jul 23 11:08:30 2019 us=550782 STREAM: ADD length_added=24
Tue Jul 23 11:08:30 2019 us=550782 STREAM: ADD returned TRUE, buf_len=22, residual_len=0
Tue Jul 23 11:08:30 2019 us=550782 STREAM: GET FINAL len=22
Tue Jul 23 11:08:30 2019 us=550782 STREAM: RESET
Tue Jul 23 11:08:30 2019 us=550782 TCP_CLIENT read returned 22
Tue Jul 23 11:08:30 2019 us=550782 TCP_CLIENT READ [22] from [AF_INET]78.157.227.***:12345: P_ACK_V1 kid=0 sid=6209e701 ce41f43f [ 0 sid=c64e9751 29cd1753 ]
Tue Jul 23 11:08:30 2019 us=550782 TLS: control channel, op=P_ACK_V1, IP=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:30 2019 us=550782 TLS: initial packet test, i=0 state=S_PRE_START, mysid=c64e9751 29cd1753, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:30 2019 us=550782 TLS: found match, session[0], sid=6209e701 ce41f43f
Tue Jul 23 11:08:30 2019 us=550782 TLS: received control channel packet s#=0 sid=6209e701 ce41f43f
Tue Jul 23 11:08:30 2019 us=550782 ACK received for pid 0, deleting from send buffer
Tue Jul 23 11:08:30 2019 us=550782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:30 2019 us=550782 STATE S_START
Tue Jul 23 11:08:30 2019 us=550782 ACK reliable_can_send active=0 current=0 : [1]
Tue Jul 23 11:08:30 2019 us=550782 STATE S_SENT_KEY
Tue Jul 23 11:08:30 2019 us=550782 BIO read tls_read_ciphertext 160 bytes
Tue Jul 23 11:08:30 2019 us=550782 ACK mark active outgoing ID 1
Tue Jul 23 11:08:30 2019 us=550782 Outgoing Ciphertext -> Reliable
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:30 2019 us=550782 ACK reliable_can_send active=1 current=1 : [2] 1
Tue Jul 23 11:08:30 2019 us=550782 ACK reliable_send ID 1 (size=164 to=2)
Tue Jul 23 11:08:30 2019 us=550782 Reliable -> TCP/UDP
Tue Jul 23 11:08:30 2019 us=550782 ACK reliable_send_timeout 2 [2] 1
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:30 2019 us=550782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:30 2019 us=550782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:30 2019 us=550782 STREAM: GET NEXT len=1626
Tue Jul 23 11:08:30 2019 us=550782 WIN32 I/O: Socket Receive queued [1626]
Tue Jul 23 11:08:30 2019 us=550782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:30 2019 us=550782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:30 2019 us=550782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:30 2019 us=550782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:30 2019 us=550782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:30 2019 us=550782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:30 2019 us=550782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:30 2019 us=550782 event_wait returned 1
Tue Jul 23 11:08:30 2019 us=550782 I/O WAIT status=0x0002
Tue Jul 23 11:08:30 2019 us=550782 TCP_CLIENT WRITE [174] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=1 DATA 16030100 9b010000 970303b3 481a5c64 6de88e49 fb0ec2ef 828c7387 46d48a6[more...]
Tue Jul 23 11:08:30 2019 us=550782 STREAM: WRITE 174 offset=30
Tue Jul 23 11:08:30 2019 us=550782 WIN32 I/O: Socket Completion non-queued success [28]
Tue Jul 23 11:08:30 2019 us=550782 WIN32 I/O: Socket Send immediate return [176,176]
Tue Jul 23 11:08:30 2019 us=550782 TCP_CLIENT write returned 176
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:30 2019 us=550782 ACK reliable_can_send active=1 current=0 : [2] 1
Tue Jul 23 11:08:30 2019 us=550782 ACK reliable_send_timeout 2 [2] 1
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:30 2019 us=550782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:30 2019 us=550782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:30 2019 us=550782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:30 2019 us=550782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:30 2019 us=550782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:30 2019 us=550782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:30 2019 us=550782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:30 2019 us=550782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:31 2019 us=354782 WE_WAIT leave rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:31 2019 us=354782 event_wait returned 1
Tue Jul 23 11:08:31 2019 us=354782 I/O WAIT status=0x0001
Tue Jul 23 11:08:31 2019 us=354782 WIN32 I/O: Socket Completion success [24]
Tue Jul 23 11:08:31 2019 us=354782 STREAM: ADD length_added=24
Tue Jul 23 11:08:31 2019 us=354782 STREAM: ADD returned TRUE, buf_len=22, residual_len=0
Tue Jul 23 11:08:31 2019 us=354782 STREAM: GET FINAL len=22
Tue Jul 23 11:08:31 2019 us=354782 STREAM: RESET
Tue Jul 23 11:08:31 2019 us=354782 TCP_CLIENT read returned 22
Tue Jul 23 11:08:31 2019 us=354782 TCP_CLIENT READ [22] from [AF_INET]78.157.227.***:12345: P_ACK_V1 kid=0 sid=6209e701 ce41f43f [ 1 sid=c64e9751 29cd1753 ]
Tue Jul 23 11:08:31 2019 us=354782 TLS: control channel, op=P_ACK_V1, IP=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:31 2019 us=354782 TLS: initial packet test, i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:31 2019 us=354782 TLS: found match, session[0], sid=6209e701 ce41f43f
Tue Jul 23 11:08:31 2019 us=354782 TLS: received control channel packet s#=0 sid=6209e701 ce41f43f
Tue Jul 23 11:08:31 2019 us=354782 ACK received for pid 1, deleting from send buffer
Tue Jul 23 11:08:31 2019 us=354782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:31 2019 us=354782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:31 2019 us=354782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:31 2019 us=354782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:31 2019 us=354782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:31 2019 us=354782 TLS: tls_process: timeout set to 58
Tue Jul 23 11:08:31 2019 us=354782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:31 2019 us=354782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:31 2019 us=354782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:31 2019 us=354782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:31 2019 us=354782 STREAM: GET NEXT len=1626
Tue Jul 23 11:08:31 2019 us=354782 WIN32 I/O: Socket Receive queued [1626]
Tue Jul 23 11:08:31 2019 us=354782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:31 2019 us=354782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:31 2019 us=354782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:31 2019 us=354782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:31 2019 us=354782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=388782 event_wait returned 0
Tue Jul 23 11:08:32 2019 us=388782 I/O WAIT status=0x0020
Tue Jul 23 11:08:32 2019 us=388782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:32 2019 us=388782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:32 2019 us=388782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:32 2019 us=388782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:32 2019 us=388782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:32 2019 us=388782 TLS: tls_process: timeout set to 57
Tue Jul 23 11:08:32 2019 us=388782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:32 2019 us=388782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:32 2019 us=388782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:32 2019 us=388782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:32 2019 us=388782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=388782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:32 2019 us=388782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:32 2019 us=388782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:32 2019 us=388782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=998782 WE_WAIT leave rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=998782 event_wait returned 1
Tue Jul 23 11:08:32 2019 us=998782 I/O WAIT status=0x0001
Tue Jul 23 11:08:32 2019 us=998782 WIN32 I/O: Socket Completion success [1416]
Tue Jul 23 11:08:32 2019 us=998782 STREAM: ADD length_added=1416
Tue Jul 23 11:08:32 2019 us=998782 STREAM: ADD returned TRUE, buf_len=1414, residual_len=0
Tue Jul 23 11:08:32 2019 us=998782 STREAM: GET FINAL len=1414
Tue Jul 23 11:08:32 2019 us=998782 STREAM: RESET
Tue Jul 23 11:08:32 2019 us=998782 TCP_CLIENT read returned 1414
Tue Jul 23 11:08:32 2019 us=999782 TCP_CLIENT READ [1414] from [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=6209e701 ce41f43f [ ] pid=1 DATA 16030300 51020000 4d0303cd aea4bae6 47699739 1ceed21b 2bbd05d0 c64388d[more...]
Tue Jul 23 11:08:32 2019 us=999782 TLS: control channel, op=P_CONTROL_V1, IP=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:32 2019 us=999782 TLS: initial packet test, i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:32 2019 us=999782 TLS: found match, session[0], sid=6209e701 ce41f43f
Tue Jul 23 11:08:32 2019 us=999782 TLS: received control channel packet s#=0 sid=6209e701 ce41f43f
Tue Jul 23 11:08:32 2019 us=999782 ACK read ID 1 (buf->len=1400)
Tue Jul 23 11:08:32 2019 us=999782 ACK RWBS rel->size=8 rel->packet_id=00000001 id=00000001 ret=1

Tue Jul 23 11:08:32 2019 us=999782 ACK mark active incoming ID 1
Tue Jul 23 11:08:32 2019 us=999782 ACK acknowledge ID 1 (ack->len=1)
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:32 2019 us=999782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:32 2019 us=999782 BIO write tls_write_ciphertext 1400 bytes
Tue Jul 23 11:08:32 2019 us=999782 Incoming Ciphertext -> TLS
Tue Jul 23 11:08:32 2019 us=999782 SSL state (connect): SSLv3/TLS write client hello
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:32 2019 us=999782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:32 2019 us=999782 ACK write ID 1 (ack->len=1, n=1)
Tue Jul 23 11:08:32 2019 us=999782 Dedicated ACK -> TCP/UDP
Tue Jul 23 11:08:32 2019 us=999782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_process: timeout set to 57
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:32 2019 us=999782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:32 2019 us=999782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:32 2019 us=999782 STREAM: GET NEXT len=1626
Tue Jul 23 11:08:32 2019 us=999782 WIN32 I/O: Socket Receive queued [1626]
Tue Jul 23 11:08:32 2019 us=999782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=999782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:32 2019 us=999782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:32 2019 us=999782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:32 2019 us=999782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=999782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=999782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=999782 event_wait returned 1
Tue Jul 23 11:08:32 2019 us=999782 I/O WAIT status=0x0002
Tue Jul 23 11:08:32 2019 us=999782 TCP_CLIENT WRITE [22] to [AF_INET]78.157.227.***:12345: P_ACK_V1 kid=0 sid=c64e9751 29cd1753 [ 1 sid=6209e701 ce41f43f ]
Tue Jul 23 11:08:32 2019 us=999782 STREAM: WRITE 22 offset=35
Tue Jul 23 11:08:32 2019 us=999782 WIN32 I/O: Socket Completion non-queued success [176]
Tue Jul 23 11:08:32 2019 us=999782 WIN32 I/O: Socket Send immediate return [24,24]
Tue Jul 23 11:08:32 2019 us=999782 TCP_CLIENT write returned 24
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:32 2019 us=999782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:32 2019 us=999782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_process: timeout set to 57
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:32 2019 us=999782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:32 2019 us=999782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:32 2019 us=999782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:32 2019 us=999782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:32 2019 us=999782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:32 2019 us=999782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:32 2019 us=999782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:32 2019 us=999782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 WE_WAIT leave rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=29782 I/O WAIT status=0x0001
Tue Jul 23 11:08:33 2019 us=29782 WIN32 I/O: Socket Completion success [1626]
Tue Jul 23 11:08:33 2019 us=29782 STREAM: ADD length_added=1626
Tue Jul 23 11:08:33 2019 us=29782 STREAM: ADD returned TRUE, buf_len=1414, residual_len=210
Tue Jul 23 11:08:33 2019 us=29782 STREAM: GET FINAL len=1414
Tue Jul 23 11:08:33 2019 us=29782 STREAM: RESET
Tue Jul 23 11:08:33 2019 us=29782 TCP_CLIENT read returned 1414
Tue Jul 23 11:08:33 2019 us=29782 TCP_CLIENT READ [1414] from [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=6209e701 ce41f43f [ ] pid=2 DATA 0201003f 31552bf7 e48f0b15 d77348d4 ebd3a137 8b47843a 73dd2b66 dc5deb2[more...]
Tue Jul 23 11:08:33 2019 us=29782 TLS: control channel, op=P_CONTROL_V1, IP=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=29782 TLS: initial packet test, i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=29782 TLS: found match, session[0], sid=6209e701 ce41f43f
Tue Jul 23 11:08:33 2019 us=29782 TLS: received control channel packet s#=0 sid=6209e701 ce41f43f
Tue Jul 23 11:08:33 2019 us=29782 ACK read ID 2 (buf->len=1400)
Tue Jul 23 11:08:33 2019 us=29782 ACK RWBS rel->size=8 rel->packet_id=00000002 id=00000002 ret=1

Tue Jul 23 11:08:33 2019 us=29782 ACK mark active incoming ID 2
Tue Jul 23 11:08:33 2019 us=29782 ACK acknowledge ID 2 (ack->len=1)
Tue Jul 23 11:08:33 2019 us=29782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=29782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=29782 BIO write tls_write_ciphertext 1400 bytes
Tue Jul 23 11:08:33 2019 us=29782 Incoming Ciphertext -> TLS
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=29782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=29782 ACK write ID 2 (ack->len=1, n=1)
Tue Jul 23 11:08:33 2019 us=29782 Dedicated ACK -> TCP/UDP
Tue Jul 23 11:08:33 2019 us=29782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_process: timeout set to 56
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=29782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=29782 STREAM: ADD length_added=0
Tue Jul 23 11:08:33 2019 us=29782 STREAM: ADD returned FALSE (have=208 need=1310)
Tue Jul 23 11:08:33 2019 us=29782 STREAM: SET NEXT, buf=[534,208] next=[742,1102] len=1310 maxlen=1626
Tue Jul 23 11:08:33 2019 us=29782 STREAM: RESIDUAL FULLY FORMED [NO], len=0
Tue Jul 23 11:08:33 2019 us=29782 STREAM: SET NEXT, buf=[534,208] next=[742,1102] len=1310 maxlen=1626
Tue Jul 23 11:08:33 2019 us=29782 STREAM: GET NEXT len=1102
Tue Jul 23 11:08:33 2019 us=29782 WIN32 I/O: Socket Receive immediate return [1102,1094]
Tue Jul 23 11:08:33 2019 us=29782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 I/O WAIT T?|T?|SR1|SW1 [1/34361]
Tue Jul 23 11:08:33 2019 us=29782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:33 2019 us=29782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=29782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 WE_WAIT leave [2,1] rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 event_wait returned 2
Tue Jul 23 11:08:33 2019 us=29782 I/O WAIT status=0x0003
Tue Jul 23 11:08:33 2019 us=29782 TCP_CLIENT WRITE [22] to [AF_INET]78.157.227.***:12345: P_ACK_V1 kid=0 sid=c64e9751 29cd1753 [ 2 sid=6209e701 ce41f43f ]
Tue Jul 23 11:08:33 2019 us=29782 STREAM: WRITE 22 offset=35
Tue Jul 23 11:08:33 2019 us=29782 WIN32 I/O: Socket Completion non-queued success [24]
Tue Jul 23 11:08:33 2019 us=29782 WIN32 I/O: Socket Send immediate return [24,24]
Tue Jul 23 11:08:33 2019 us=29782 TCP_CLIENT write returned 24
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=29782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=29782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_process: timeout set to 56
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=29782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=29782 STREAM: SET NEXT, buf=[534,208] next=[742,1102] len=1310 maxlen=1626
Tue Jul 23 11:08:33 2019 us=29782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 I/O WAIT T?|T?|SR1|Sw1 [1/34361]
Tue Jul 23 11:08:33 2019 us=29782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:33 2019 us=29782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=29782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 WE_WAIT leave [1,0] rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=29782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=29782 I/O WAIT status=0x0001
Tue Jul 23 11:08:33 2019 us=29782 WIN32 I/O: Socket Completion non-queued success [1094]
Tue Jul 23 11:08:33 2019 us=29782 STREAM: ADD length_added=1094
Tue Jul 23 11:08:33 2019 us=29782 STREAM: ADD returned FALSE (have=1302 need=1310)
Tue Jul 23 11:08:33 2019 us=29782 STREAM: SET NEXT, buf=[534,1302] next=[1836,8] len=1310 maxlen=1626
Tue Jul 23 11:08:33 2019 us=29782 TCP_CLIENT read returned 0
Tue Jul 23 11:08:33 2019 us=29782 TCP_CLIENT READ [0] from [AF_INET]78.157.227.***:12345: DATA UNDEF len=0
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=29782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=29782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=29782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:33 2019 us=30782 TLS: tls_process: timeout set to 56
Tue Jul 23 11:08:33 2019 us=30782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=30782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=30782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=30782 STREAM: SET NEXT, buf=[534,1302] next=[1836,8] len=1310 maxlen=1626
Tue Jul 23 11:08:33 2019 us=30782 STREAM: GET NEXT len=8
Tue Jul 23 11:08:33 2019 us=30782 WIN32 I/O: Socket Receive queued [8]
Tue Jul 23 11:08:33 2019 us=30782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=30782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:33 2019 us=30782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:33 2019 us=30782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=30782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=35782 WE_WAIT leave rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=35782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=35782 I/O WAIT status=0x0001
Tue Jul 23 11:08:33 2019 us=35782 WIN32 I/O: Socket Completion success [8]
Tue Jul 23 11:08:33 2019 us=35782 STREAM: ADD length_added=8
Tue Jul 23 11:08:33 2019 us=35782 STREAM: ADD returned TRUE, buf_len=1310, residual_len=0
Tue Jul 23 11:08:33 2019 us=35782 STREAM: GET FINAL len=1310
Tue Jul 23 11:08:33 2019 us=35782 STREAM: RESET
Tue Jul 23 11:08:33 2019 us=35782 TCP_CLIENT read returned 1310
Tue Jul 23 11:08:33 2019 us=35782 TCP_CLIENT READ [1310] from [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=6209e701 ce41f43f [ ] pid=3 DATA 26d1374d 61b161e2 233b3520 71b9a796 a9d33884 5c15c940 0f0abf8f 4e810b8[more...]
Tue Jul 23 11:08:33 2019 us=35782 TLS: control channel, op=P_CONTROL_V1, IP=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=35782 TLS: initial packet test, i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=35782 TLS: found match, session[0], sid=6209e701 ce41f43f
Tue Jul 23 11:08:33 2019 us=35782 TLS: received control channel packet s#=0 sid=6209e701 ce41f43f
Tue Jul 23 11:08:33 2019 us=35782 ACK read ID 3 (buf->len=1296)
Tue Jul 23 11:08:33 2019 us=35782 ACK RWBS rel->size=8 rel->packet_id=00000003 id=00000003 ret=1

Tue Jul 23 11:08:33 2019 us=35782 ACK mark active incoming ID 3
Tue Jul 23 11:08:33 2019 us=35782 ACK acknowledge ID 3 (ack->len=1)
Tue Jul 23 11:08:33 2019 us=35782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=35782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=35782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=35782 BIO write tls_write_ciphertext 1296 bytes
Tue Jul 23 11:08:33 2019 us=35782 Incoming Ciphertext -> TLS
Tue Jul 23 11:08:33 2019 us=35782 SSL state (connect): SSLv3/TLS read server hello
Tue Jul 23 11:08:33 2019 us=35782 VERIFY OK: depth=1, C=RU, ST=Kam, L=Petropavlovsk, O=OpenVPN, OU=Kinex, CN=Kinex, name=Kinex, emailAddress=mail@host.domain
Tue Jul 23 11:08:33 2019 us=35782 VERIFY KU OK
Tue Jul 23 11:08:33 2019 us=35782 Validating certificate extended key usage
Tue Jul 23 11:08:33 2019 us=35782 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
Tue Jul 23 11:08:33 2019 us=35782 VERIFY EKU OK
Tue Jul 23 11:08:33 2019 us=35782 VERIFY OK: depth=0, C=RU, ST=Kam, L=Petropavlovsk, O=OpenVPN, OU=Kinex, CN=Kinex, name=Kinex, emailAddress=mail@host.domain
Tue Jul 23 11:08:33 2019 us=35782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=35782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=35782 ACK write ID 3 (ack->len=1, n=1)
Tue Jul 23 11:08:33 2019 us=35782 Dedicated ACK -> TCP/UDP
Tue Jul 23 11:08:33 2019 us=35782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:33 2019 us=35782 TLS: tls_process: timeout set to 56
Tue Jul 23 11:08:33 2019 us=35782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=35782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=35782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=35782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:33 2019 us=35782 STREAM: GET NEXT len=1626
Tue Jul 23 11:08:33 2019 us=35782 WIN32 I/O: Socket Receive immediate return [1626,651]
Tue Jul 23 11:08:33 2019 us=35782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=35782 I/O WAIT T?|T?|SR1|SW1 [1/34361]
Tue Jul 23 11:08:33 2019 us=35782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:33 2019 us=35782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=35782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=35782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=35782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=35782 WE_WAIT leave [2,1] rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=35782 event_wait returned 2
Tue Jul 23 11:08:33 2019 us=35782 I/O WAIT status=0x0003
Tue Jul 23 11:08:33 2019 us=35782 TCP_CLIENT WRITE [22] to [AF_INET]78.157.227.***:12345: P_ACK_V1 kid=0 sid=c64e9751 29cd1753 [ 3 sid=6209e701 ce41f43f ]
Tue Jul 23 11:08:33 2019 us=36782 STREAM: WRITE 22 offset=35
Tue Jul 23 11:08:33 2019 us=36782 WIN32 I/O: Socket Completion non-queued success [24]
Tue Jul 23 11:08:33 2019 us=36782 WIN32 I/O: Socket Send immediate return [24,24]
Tue Jul 23 11:08:33 2019 us=36782 TCP_CLIENT write returned 24
Tue Jul 23 11:08:33 2019 us=36782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=36782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=36782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=36782 ACK reliable_send_timeout 604800 [2]
Tue Jul 23 11:08:33 2019 us=36782 TLS: tls_process: timeout set to 56
Tue Jul 23 11:08:33 2019 us=36782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=36782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=36782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=36782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:33 2019 us=36782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=36782 I/O WAIT T?|T?|SR1|Sw1 [1/34361]
Tue Jul 23 11:08:33 2019 us=36782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:33 2019 us=36782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=36782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=36782 WE_WAIT leave [1,0] rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=36782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=36782 I/O WAIT status=0x0001
Tue Jul 23 11:08:33 2019 us=36782 WIN32 I/O: Socket Completion non-queued success [651]
Tue Jul 23 11:08:33 2019 us=36782 STREAM: ADD length_added=651
Tue Jul 23 11:08:33 2019 us=36782 STREAM: ADD returned TRUE, buf_len=649, residual_len=0
Tue Jul 23 11:08:33 2019 us=36782 STREAM: GET FINAL len=649
Tue Jul 23 11:08:33 2019 us=36782 STREAM: RESET
Tue Jul 23 11:08:33 2019 us=36782 TCP_CLIENT read returned 649
Tue Jul 23 11:08:33 2019 us=36782 TCP_CLIENT READ [649] from [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=6209e701 ce41f43f [ ] pid=4 DATA b3c62016 ecdfa65e ec9e11c9 632db41c 86d0acaa eba3dc24 9b7aafa0 37699d6[more...]
Tue Jul 23 11:08:33 2019 us=36782 TLS: control channel, op=P_CONTROL_V1, IP=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=36782 TLS: initial packet test, i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, rec-sid=6209e701 ce41f43f, rec-ip=[AF_INET]78.157.227.***:12345, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=36782 TLS: found match, session[0], sid=6209e701 ce41f43f
Tue Jul 23 11:08:33 2019 us=36782 TLS: received control channel packet s#=0 sid=6209e701 ce41f43f
Tue Jul 23 11:08:33 2019 us=36782 ACK read ID 4 (buf->len=635)
Tue Jul 23 11:08:33 2019 us=36782 ACK RWBS rel->size=8 rel->packet_id=00000004 id=00000004 ret=1

Tue Jul 23 11:08:33 2019 us=36782 ACK mark active incoming ID 4
Tue Jul 23 11:08:33 2019 us=36782 ACK acknowledge ID 4 (ack->len=1)
Tue Jul 23 11:08:33 2019 us=36782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=36782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=36782 ACK reliable_can_send active=0 current=0 : [2]
Tue Jul 23 11:08:33 2019 us=36782 BIO write tls_write_ciphertext 635 bytes
Tue Jul 23 11:08:33 2019 us=36782 Incoming Ciphertext -> TLS
Tue Jul 23 11:08:33 2019 us=36782 SSL state (connect): SSLv3/TLS read server certificate
Tue Jul 23 11:08:33 2019 us=36782 SSL state (connect): SSLv3/TLS read server key exchange
Tue Jul 23 11:08:33 2019 us=36782 SSL state (connect): SSLv3/TLS read server certificate request
Tue Jul 23 11:08:33 2019 us=36782 SSL state (connect): SSLv3/TLS read server done
Tue Jul 23 11:08:33 2019 us=36782 SSL state (connect): SSLv3/TLS write client certificate
Tue Jul 23 11:08:33 2019 us=40782 SSL state (connect): SSLv3/TLS write client key exchange
Tue Jul 23 11:08:33 2019 us=44782 SSL state (connect): SSLv3/TLS write certificate verify
Tue Jul 23 11:08:33 2019 us=44782 SSL state (connect): SSLv3/TLS write change cipher spec
Tue Jul 23 11:08:33 2019 us=45782 SSL state (connect): SSLv3/TLS write finished
Tue Jul 23 11:08:33 2019 us=45782 BIO read tls_read_ciphertext 1170 bytes
Tue Jul 23 11:08:33 2019 us=45782 ACK mark active outgoing ID 2
Tue Jul 23 11:08:33 2019 us=45782 Outgoing Ciphertext -> Reliable
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_can_send active=1 current=1 : [3] 2
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_send ID 2 (size=1174 to=2)
Tue Jul 23 11:08:33 2019 us=45782 ACK write ID 4 (ack->len=1, n=1)
Tue Jul 23 11:08:33 2019 us=45782 Reliable -> TCP/UDP
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_send_timeout 2 [3] 2
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=45782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=45782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:33 2019 us=45782 STREAM: GET NEXT len=1626
Tue Jul 23 11:08:33 2019 us=45782 WIN32 I/O: Socket Receive queued [1626]
Tue Jul 23 11:08:33 2019 us=45782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:33 2019 us=45782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:33 2019 us=45782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=45782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=45782 I/O WAIT status=0x0002
Tue Jul 23 11:08:33 2019 us=45782 TCP_CLIENT WRITE [1196] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ 4 sid=6209e701 ce41f43f ] pid=2 DATA 1603030d c30b000d bf000dbc 00070230 8206fe30 8204e6a0 03020102 02010b3[more...]
Tue Jul 23 11:08:33 2019 us=45782 STREAM: WRITE 1196 offset=18
Tue Jul 23 11:08:33 2019 us=45782 WIN32 I/O: Socket Completion non-queued success [24]
Tue Jul 23 11:08:33 2019 us=45782 WIN32 I/O: Socket Send immediate return [1198,1198]
Tue Jul 23 11:08:33 2019 us=45782 TCP_CLIENT write returned 1198
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_can_send active=1 current=0 : [3] 2
Tue Jul 23 11:08:33 2019 us=45782 BIO read tls_read_ciphertext 1170 bytes
Tue Jul 23 11:08:33 2019 us=45782 ACK mark active outgoing ID 3
Tue Jul 23 11:08:33 2019 us=45782 Outgoing Ciphertext -> Reliable
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_can_send active=2 current=1 : [4] 2 3
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_send ID 3 (size=1174 to=3)
Tue Jul 23 11:08:33 2019 us=45782 Reliable -> TCP/UDP
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_send_timeout 2 [4] 2 3
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=45782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=45782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:33 2019 us=45782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:33 2019 us=45782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:33 2019 us=45782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=45782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=45782 I/O WAIT status=0x0002
Tue Jul 23 11:08:33 2019 us=45782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=3 DATA 0c060355 04031305 4b696e65 78310e30 0c060355 04291305 4b696e65 78311f3[more...]
Tue Jul 23 11:08:33 2019 us=45782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:33 2019 us=45782 WIN32 I/O: Socket Completion non-queued success [1198]
Tue Jul 23 11:08:33 2019 us=45782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:33 2019 us=45782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_can_send active=2 current=0 : [4] 2 3
Tue Jul 23 11:08:33 2019 us=45782 BIO read tls_read_ciphertext 1170 bytes
Tue Jul 23 11:08:33 2019 us=45782 ACK mark active outgoing ID 4
Tue Jul 23 11:08:33 2019 us=45782 Outgoing Ciphertext -> Reliable
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_can_send active=3 current=1 : [5] 2 3 4
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_send ID 4 (size=1174 to=4)
Tue Jul 23 11:08:33 2019 us=45782 Reliable -> TCP/UDP
Tue Jul 23 11:08:33 2019 us=45782 ACK reliable_send_timeout 2 [5] 2 3 4
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=45782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=45782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=45782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:33 2019 us=45782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:33 2019 us=45782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:33 2019 us=45782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=45782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=45782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=46782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=46782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=46782 I/O WAIT status=0x0002
Tue Jul 23 11:08:33 2019 us=46782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=4 DATA ecd24651 5b85804e 8d05c1ad 6f918d37 e2132f69 908c0c4b 95eb4d08 088f561[more...]
Tue Jul 23 11:08:33 2019 us=46782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:33 2019 us=46782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:33 2019 us=46782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:33 2019 us=46782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=46782 ACK reliable_can_send active=3 current=0 : [5] 2 3 4
Tue Jul 23 11:08:33 2019 us=46782 BIO read tls_read_ciphertext 861 bytes
Tue Jul 23 11:08:33 2019 us=46782 ACK mark active outgoing ID 5
Tue Jul 23 11:08:33 2019 us=46782 Outgoing Ciphertext -> Reliable
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_process: chg=1 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=46782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:33 2019 us=46782 ACK reliable_send ID 5 (size=865 to=5)
Tue Jul 23 11:08:33 2019 us=46782 Reliable -> TCP/UDP
Tue Jul 23 11:08:33 2019 us=46782 ACK reliable_send_timeout 2 [6] 2 3 4 5
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=46782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=46782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:33 2019 us=46782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=46782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:33 2019 us=46782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:33 2019 us=46782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=46782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=46782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=46782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=46782 event_wait returned 1
Tue Jul 23 11:08:33 2019 us=46782 I/O WAIT status=0x0002
Tue Jul 23 11:08:33 2019 us=46782 TCP_CLIENT WRITE [875] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=5 DATA b541c301 e3825533 e77a2bac 7163c71e 7df01603 03010610 00010201 0015123[more...]
Tue Jul 23 11:08:33 2019 us=46782 STREAM: WRITE 875 offset=30
Tue Jul 23 11:08:33 2019 us=46782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:33 2019 us=46782 WIN32 I/O: Socket Send immediate return [877,877]
Tue Jul 23 11:08:33 2019 us=46782 TCP_CLIENT write returned 877
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:33 2019 us=46782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:33 2019 us=46782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:33 2019 us=46782 ACK reliable_send_timeout 2 [6] 2 3 4 5
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_process: timeout set to 2
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=46782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:33 2019 us=46782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=46782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:33 2019 us=46782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:33 2019 us=46782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:33 2019 us=46782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:33 2019 us=46782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:33 2019 us=46782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:34 2019 us=80782 event_wait returned 0
Tue Jul 23 11:08:34 2019 us=80782 I/O WAIT status=0x0020
Tue Jul 23 11:08:34 2019 us=80782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:34 2019 us=80782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:34 2019 us=80782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:34 2019 us=80782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:34 2019 us=80782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:34 2019 us=80782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:34 2019 us=80782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:34 2019 us=80782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:34 2019 us=80782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:34 2019 us=80782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:34 2019 us=80782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:34 2019 us=80782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:34 2019 us=80782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:34 2019 us=80782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:34 2019 us=80782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:34 2019 us=80782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:35 2019 us=114782 event_wait returned 0
Tue Jul 23 11:08:35 2019 us=114782 I/O WAIT status=0x0020
Tue Jul 23 11:08:35 2019 us=114782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:35 2019 us=114782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:35 2019 us=114782 ACK reliable_send ID 2 (size=1174 to=4)
Tue Jul 23 11:08:35 2019 us=114782 Reliable -> TCP/UDP
Tue Jul 23 11:08:35 2019 us=114782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:35 2019 us=114782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:35 2019 us=114782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:35 2019 us=114782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:35 2019 us=114782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:35 2019 us=114782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:35 2019 us=114782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:35 2019 us=114782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:35 2019 us=114782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:35 2019 us=114782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:35 2019 us=114782 event_wait returned 1
Tue Jul 23 11:08:35 2019 us=114782 I/O WAIT status=0x0002
Tue Jul 23 11:08:35 2019 us=114782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=2 DATA 1603030d c30b000d bf000dbc 00070230 8206fe30 8204e6a0 03020102 02010b3[more...]
Tue Jul 23 11:08:35 2019 us=114782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:35 2019 us=114782 WIN32 I/O: Socket Completion non-queued success [877]
Tue Jul 23 11:08:35 2019 us=114782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:35 2019 us=114782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:35 2019 us=114782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:35 2019 us=114782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:35 2019 us=114782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:35 2019 us=114782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:35 2019 us=114782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:35 2019 us=114782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:35 2019 us=114782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:35 2019 us=114782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:35 2019 us=114782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:35 2019 us=114782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:35 2019 us=114782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:36 2019 us=148782 event_wait returned 0
Tue Jul 23 11:08:36 2019 us=148782 I/O WAIT status=0x0020
Tue Jul 23 11:08:36 2019 us=148782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:36 2019 us=148782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:36 2019 us=148782 ACK reliable_send ID 3 (size=1174 to=4)
Tue Jul 23 11:08:36 2019 us=148782 Reliable -> TCP/UDP
Tue Jul 23 11:08:36 2019 us=148782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:36 2019 us=148782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:36 2019 us=148782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:36 2019 us=148782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:36 2019 us=148782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:36 2019 us=148782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:36 2019 us=148782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:36 2019 us=148782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:36 2019 us=148782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:36 2019 us=148782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:36 2019 us=148782 event_wait returned 1
Tue Jul 23 11:08:36 2019 us=148782 I/O WAIT status=0x0002
Tue Jul 23 11:08:36 2019 us=148782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=3 DATA 0c060355 04031305 4b696e65 78310e30 0c060355 04291305 4b696e65 78311f3[more...]
Tue Jul 23 11:08:36 2019 us=148782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:36 2019 us=148782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:36 2019 us=148782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:36 2019 us=148782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:36 2019 us=148782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:36 2019 us=148782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:36 2019 us=148782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:36 2019 us=148782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:36 2019 us=148782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:36 2019 us=148782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:36 2019 us=148782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:36 2019 us=148782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:36 2019 us=148782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:36 2019 us=148782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:36 2019 us=148782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:37 2019 us=182782 event_wait returned 0
Tue Jul 23 11:08:37 2019 us=182782 I/O WAIT status=0x0020
Tue Jul 23 11:08:37 2019 us=182782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:37 2019 us=182782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:37 2019 us=182782 ACK reliable_send ID 4 (size=1174 to=4)
Tue Jul 23 11:08:37 2019 us=182782 Reliable -> TCP/UDP
Tue Jul 23 11:08:37 2019 us=182782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:37 2019 us=182782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:37 2019 us=182782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:37 2019 us=182782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:37 2019 us=182782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:37 2019 us=182782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:37 2019 us=182782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:37 2019 us=182782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:37 2019 us=182782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:37 2019 us=182782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:37 2019 us=182782 event_wait returned 1
Tue Jul 23 11:08:37 2019 us=182782 I/O WAIT status=0x0002
Tue Jul 23 11:08:37 2019 us=182782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=4 DATA ecd24651 5b85804e 8d05c1ad 6f918d37 e2132f69 908c0c4b 95eb4d08 088f561[more...]
Tue Jul 23 11:08:37 2019 us=182782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:37 2019 us=182782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:37 2019 us=182782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:37 2019 us=182782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:37 2019 us=182782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:37 2019 us=182782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:37 2019 us=182782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:37 2019 us=182782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:37 2019 us=182782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:37 2019 us=182782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:37 2019 us=182782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:37 2019 us=182782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:37 2019 us=182782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:37 2019 us=182782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:37 2019 us=182782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:38 2019 us=216782 event_wait returned 0
Tue Jul 23 11:08:38 2019 us=216782 I/O WAIT status=0x0020
Tue Jul 23 11:08:38 2019 us=216782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:38 2019 us=216782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:38 2019 us=216782 ACK reliable_send ID 5 (size=865 to=4)
Tue Jul 23 11:08:38 2019 us=216782 Reliable -> TCP/UDP
Tue Jul 23 11:08:38 2019 us=216782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:38 2019 us=216782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:38 2019 us=216782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:38 2019 us=216782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:38 2019 us=216782 I/O WAIT T?|T?|SRQ|SW1 [1/34361]
Tue Jul 23 11:08:38 2019 us=216782 WE_WAIT enter n=3 to=1034
Tue Jul 23 11:08:38 2019 us=216782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:38 2019 us=216782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:38 2019 us=216782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:38 2019 us=216782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:38 2019 us=216782 event_wait returned 1
Tue Jul 23 11:08:38 2019 us=216782 I/O WAIT status=0x0002
Tue Jul 23 11:08:38 2019 us=216782 TCP_CLIENT WRITE [875] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=5 DATA b541c301 e3825533 e77a2bac 7163c71e 7df01603 03010610 00010201 0015123[more...]
Tue Jul 23 11:08:38 2019 us=216782 STREAM: WRITE 875 offset=30
Tue Jul 23 11:08:38 2019 us=216782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:38 2019 us=216782 WIN32 I/O: Socket Send immediate return [877,877]
Tue Jul 23 11:08:38 2019 us=216782 TCP_CLIENT write returned 877
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:38 2019 us=216782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:38 2019 us=216782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:38 2019 us=216782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:38 2019 us=216782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:38 2019 us=216782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:38 2019 us=216782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:38 2019 us=216782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:38 2019 us=216782 I/O WAIT T?|T?|SRQ|Sw1 [1/34361]
Tue Jul 23 11:08:38 2019 us=216782 WE_WAIT enter n=2 to=1034
Tue Jul 23 11:08:38 2019 us=216782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:38 2019 us=216782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:39 2019 us=250782 event_wait returned 0
Tue Jul 23 11:08:39 2019 us=250782 I/O WAIT status=0x0020
Tue Jul 23 11:08:39 2019 us=250782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:39 2019 us=250782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:39 2019 us=250782 ACK reliable_send ID 2 (size=1174 to=8)
Tue Jul 23 11:08:39 2019 us=250782 Reliable -> TCP/UDP
Tue Jul 23 11:08:39 2019 us=250782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:39 2019 us=250782 RANDOM USEC=66191
Tue Jul 23 11:08:39 2019 us=250782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:39 2019 us=250782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:39 2019 us=250782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:39 2019 us=250782 I/O WAIT T?|T?|SRQ|SW1 [1/66191]
Tue Jul 23 11:08:39 2019 us=250782 WE_WAIT enter n=3 to=1066
Tue Jul 23 11:08:39 2019 us=250782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:39 2019 us=250782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:39 2019 us=250782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:39 2019 us=250782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:39 2019 us=250782 event_wait returned 1
Tue Jul 23 11:08:39 2019 us=250782 I/O WAIT status=0x0002
Tue Jul 23 11:08:39 2019 us=250782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=2 DATA 1603030d c30b000d bf000dbc 00070230 8206fe30 8204e6a0 03020102 02010b3[more...]
Tue Jul 23 11:08:39 2019 us=250782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:39 2019 us=250782 WIN32 I/O: Socket Completion non-queued success [877]
Tue Jul 23 11:08:39 2019 us=250782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:39 2019 us=250782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:39 2019 us=250782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:39 2019 us=250782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:39 2019 us=250782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:39 2019 us=250782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:39 2019 us=250782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:39 2019 us=250782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:39 2019 us=250782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:39 2019 us=250782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:39 2019 us=250782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:39 2019 us=250782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:39 2019 us=250782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:40 2019 us=316782 event_wait returned 0
Tue Jul 23 11:08:40 2019 us=316782 I/O WAIT status=0x0020
Tue Jul 23 11:08:40 2019 us=316782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:40 2019 us=316782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:40 2019 us=316782 ACK reliable_send ID 3 (size=1174 to=8)
Tue Jul 23 11:08:40 2019 us=316782 Reliable -> TCP/UDP
Tue Jul 23 11:08:40 2019 us=316782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:40 2019 us=316782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:40 2019 us=316782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:40 2019 us=316782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:40 2019 us=316782 I/O WAIT T?|T?|SRQ|SW1 [1/66191]
Tue Jul 23 11:08:40 2019 us=316782 WE_WAIT enter n=3 to=1066
Tue Jul 23 11:08:40 2019 us=316782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:40 2019 us=316782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:40 2019 us=316782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:40 2019 us=316782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:40 2019 us=316782 event_wait returned 1
Tue Jul 23 11:08:40 2019 us=316782 I/O WAIT status=0x0002
Tue Jul 23 11:08:40 2019 us=316782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=3 DATA 0c060355 04031305 4b696e65 78310e30 0c060355 04291305 4b696e65 78311f3[more...]
Tue Jul 23 11:08:40 2019 us=316782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:40 2019 us=316782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:40 2019 us=316782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:40 2019 us=316782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:40 2019 us=316782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:40 2019 us=316782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:40 2019 us=316782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:40 2019 us=316782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:40 2019 us=316782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:40 2019 us=316782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:40 2019 us=316782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:40 2019 us=316782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:40 2019 us=316782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:40 2019 us=316782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:40 2019 us=316782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:41 2019 us=382782 event_wait returned 0
Tue Jul 23 11:08:41 2019 us=382782 I/O WAIT status=0x0020
Tue Jul 23 11:08:41 2019 us=382782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:41 2019 us=382782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:41 2019 us=382782 ACK reliable_send ID 4 (size=1174 to=8)
Tue Jul 23 11:08:41 2019 us=382782 Reliable -> TCP/UDP
Tue Jul 23 11:08:41 2019 us=382782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:41 2019 us=382782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:41 2019 us=382782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:41 2019 us=382782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:41 2019 us=382782 I/O WAIT T?|T?|SRQ|SW1 [1/66191]
Tue Jul 23 11:08:41 2019 us=382782 WE_WAIT enter n=3 to=1066
Tue Jul 23 11:08:41 2019 us=382782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:41 2019 us=382782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:41 2019 us=382782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:41 2019 us=382782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:41 2019 us=382782 event_wait returned 1
Tue Jul 23 11:08:41 2019 us=382782 I/O WAIT status=0x0002
Tue Jul 23 11:08:41 2019 us=382782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=4 DATA ecd24651 5b85804e 8d05c1ad 6f918d37 e2132f69 908c0c4b 95eb4d08 088f561[more...]
Tue Jul 23 11:08:41 2019 us=382782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:41 2019 us=382782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:41 2019 us=382782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:41 2019 us=382782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:41 2019 us=382782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:41 2019 us=382782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:41 2019 us=382782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:41 2019 us=382782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:41 2019 us=382782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:41 2019 us=382782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:41 2019 us=382782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:41 2019 us=382782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:41 2019 us=382782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:41 2019 us=382782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:41 2019 us=382782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:42 2019 us=448782 event_wait returned 0
Tue Jul 23 11:08:42 2019 us=448782 I/O WAIT status=0x0020
Tue Jul 23 11:08:42 2019 us=448782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:42 2019 us=448782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:42 2019 us=448782 ACK reliable_send ID 5 (size=865 to=8)
Tue Jul 23 11:08:42 2019 us=448782 Reliable -> TCP/UDP
Tue Jul 23 11:08:42 2019 us=448782 ACK reliable_send_timeout 5 [6] 2 3 4 5
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_process: timeout set to 5
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:42 2019 us=448782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:42 2019 us=448782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:42 2019 us=448782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:42 2019 us=448782 I/O WAIT T?|T?|SRQ|SW1 [1/66191]
Tue Jul 23 11:08:42 2019 us=448782 WE_WAIT enter n=3 to=1066
Tue Jul 23 11:08:42 2019 us=448782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:42 2019 us=448782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:42 2019 us=448782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:42 2019 us=448782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:42 2019 us=448782 event_wait returned 1
Tue Jul 23 11:08:42 2019 us=448782 I/O WAIT status=0x0002
Tue Jul 23 11:08:42 2019 us=448782 TCP_CLIENT WRITE [875] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=5 DATA b541c301 e3825533 e77a2bac 7163c71e 7df01603 03010610 00010201 0015123[more...]
Tue Jul 23 11:08:42 2019 us=448782 STREAM: WRITE 875 offset=30
Tue Jul 23 11:08:42 2019 us=448782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:42 2019 us=448782 WIN32 I/O: Socket Send immediate return [877,877]
Tue Jul 23 11:08:42 2019 us=448782 TCP_CLIENT write returned 877
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:42 2019 us=448782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:42 2019 us=448782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:42 2019 us=448782 ACK reliable_send_timeout 5 [6] 2 3 4 5
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_process: timeout set to 5
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:42 2019 us=448782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:42 2019 us=448782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:42 2019 us=448782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:42 2019 us=448782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:42 2019 us=448782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:42 2019 us=448782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:42 2019 us=448782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:42 2019 us=448782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:43 2019 us=514782 event_wait returned 0
Tue Jul 23 11:08:43 2019 us=514782 I/O WAIT status=0x0020
Tue Jul 23 11:08:43 2019 us=514782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:43 2019 us=514782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:43 2019 us=514782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:43 2019 us=514782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:43 2019 us=514782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:43 2019 us=514782 ACK reliable_send_timeout 4 [6] 2 3 4 5
Tue Jul 23 11:08:43 2019 us=514782 TLS: tls_process: timeout set to 4
Tue Jul 23 11:08:43 2019 us=514782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:43 2019 us=514782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:43 2019 us=514782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:43 2019 us=514782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:43 2019 us=514782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:43 2019 us=514782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:43 2019 us=514782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:43 2019 us=514782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:43 2019 us=514782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:44 2019 us=580782 event_wait returned 0
Tue Jul 23 11:08:44 2019 us=580782 I/O WAIT status=0x0020
Tue Jul 23 11:08:44 2019 us=580782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:44 2019 us=580782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:44 2019 us=580782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:44 2019 us=580782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:44 2019 us=580782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:44 2019 us=580782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:44 2019 us=580782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:44 2019 us=580782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:45 2019 us=646782 event_wait returned 0
Tue Jul 23 11:08:45 2019 us=646782 I/O WAIT status=0x0020
Tue Jul 23 11:08:45 2019 us=646782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:45 2019 us=646782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:45 2019 us=646782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:45 2019 us=646782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:45 2019 us=646782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:45 2019 us=646782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:45 2019 us=646782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:45 2019 us=646782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:46 2019 us=712782 event_wait returned 0
Tue Jul 23 11:08:46 2019 us=712782 I/O WAIT status=0x0020
Tue Jul 23 11:08:46 2019 us=712782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:46 2019 us=712782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:46 2019 us=712782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:46 2019 us=712782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:46 2019 us=712782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:46 2019 us=712782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:46 2019 us=712782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:46 2019 us=712782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:47 2019 us=778782 event_wait returned 0
Tue Jul 23 11:08:47 2019 us=778782 I/O WAIT status=0x0020
Tue Jul 23 11:08:47 2019 us=778782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:47 2019 us=778782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:47 2019 us=778782 ACK reliable_send ID 2 (size=1174 to=16)
Tue Jul 23 11:08:47 2019 us=778782 Reliable -> TCP/UDP
Tue Jul 23 11:08:47 2019 us=778782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:47 2019 us=778782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:47 2019 us=778782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:47 2019 us=778782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:47 2019 us=778782 I/O WAIT T?|T?|SRQ|SW1 [1/66191]
Tue Jul 23 11:08:47 2019 us=778782 WE_WAIT enter n=3 to=1066
Tue Jul 23 11:08:47 2019 us=778782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:47 2019 us=778782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:47 2019 us=778782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:47 2019 us=778782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:47 2019 us=778782 event_wait returned 1
Tue Jul 23 11:08:47 2019 us=778782 I/O WAIT status=0x0002
Tue Jul 23 11:08:47 2019 us=778782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=2 DATA 1603030d c30b000d bf000dbc 00070230 8206fe30 8204e6a0 03020102 02010b3[more...]
Tue Jul 23 11:08:47 2019 us=778782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:47 2019 us=778782 WIN32 I/O: Socket Completion non-queued success [877]
Tue Jul 23 11:08:47 2019 us=778782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:47 2019 us=778782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:47 2019 us=778782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:47 2019 us=778782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:47 2019 us=778782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:47 2019 us=778782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:47 2019 us=778782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:47 2019 us=778782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:47 2019 us=778782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:47 2019 us=778782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:47 2019 us=778782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:47 2019 us=778782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:47 2019 us=778782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:48 2019 us=844782 event_wait returned 0
Tue Jul 23 11:08:48 2019 us=844782 I/O WAIT status=0x0020
Tue Jul 23 11:08:48 2019 us=844782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:48 2019 us=844782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:48 2019 us=844782 ACK reliable_send ID 3 (size=1174 to=16)
Tue Jul 23 11:08:48 2019 us=844782 Reliable -> TCP/UDP
Tue Jul 23 11:08:48 2019 us=844782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:48 2019 us=844782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:48 2019 us=844782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:48 2019 us=844782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:48 2019 us=844782 I/O WAIT T?|T?|SRQ|SW1 [1/66191]
Tue Jul 23 11:08:48 2019 us=844782 WE_WAIT enter n=3 to=1066
Tue Jul 23 11:08:48 2019 us=844782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:48 2019 us=844782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:48 2019 us=844782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:48 2019 us=844782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:48 2019 us=844782 event_wait returned 1
Tue Jul 23 11:08:48 2019 us=844782 I/O WAIT status=0x0002
Tue Jul 23 11:08:48 2019 us=844782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=3 DATA 0c060355 04031305 4b696e65 78310e30 0c060355 04291305 4b696e65 78311f3[more...]
Tue Jul 23 11:08:48 2019 us=844782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:48 2019 us=844782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:48 2019 us=844782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:48 2019 us=844782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:48 2019 us=844782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:48 2019 us=844782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:48 2019 us=844782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:48 2019 us=844782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:48 2019 us=844782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:48 2019 us=844782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:48 2019 us=844782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:48 2019 us=844782 I/O WAIT T?|T?|SRQ|Sw1 [1/66191]
Tue Jul 23 11:08:48 2019 us=844782 WE_WAIT enter n=2 to=1066
Tue Jul 23 11:08:48 2019 us=844782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:48 2019 us=844782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:49 2019 us=910782 event_wait returned 0
Tue Jul 23 11:08:49 2019 us=910782 I/O WAIT status=0x0020
Tue Jul 23 11:08:49 2019 us=910782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:49 2019 us=910782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:49 2019 us=910782 ACK reliable_send ID 4 (size=1174 to=16)
Tue Jul 23 11:08:49 2019 us=910782 Reliable -> TCP/UDP
Tue Jul 23 11:08:49 2019 us=910782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:49 2019 us=910782 RANDOM USEC=75143
Tue Jul 23 11:08:49 2019 us=910782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:49 2019 us=910782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:49 2019 us=910782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:49 2019 us=910782 I/O WAIT T?|T?|SRQ|SW1 [1/75143]
Tue Jul 23 11:08:49 2019 us=910782 WE_WAIT enter n=3 to=1075
Tue Jul 23 11:08:49 2019 us=910782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:49 2019 us=910782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:49 2019 us=910782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:49 2019 us=910782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:49 2019 us=910782 event_wait returned 1
Tue Jul 23 11:08:49 2019 us=910782 I/O WAIT status=0x0002
Tue Jul 23 11:08:49 2019 us=910782 TCP_CLIENT WRITE [1184] to [AF_INET]78.157.227.***:12345: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=4 DATA ecd24651 5b85804e 8d05c1ad 6f918d37 e2132f69 908c0c4b 95eb4d08 088f561[more...]
Tue Jul 23 11:08:49 2019 us=910782 STREAM: WRITE 1184 offset=30
Tue Jul 23 11:08:49 2019 us=910782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:49 2019 us=910782 WIN32 I/O: Socket Send immediate return [1186,1186]
Tue Jul 23 11:08:49 2019 us=910782 TCP_CLIENT write returned 1186
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:49 2019 us=910782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:49 2019 us=910782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:49 2019 us=910782 ACK reliable_send_timeout 1 [6] 2 3 4 5
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_process: timeout set to 1
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:49 2019 us=910782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:49 2019 us=910782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:49 2019 us=910782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:49 2019 us=910782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:49 2019 us=910782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:49 2019 us=910782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:49 2019 us=910782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:49 2019 us=910782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:50 2019 us=985782 event_wait returned 0
Tue Jul 23 11:08:50 2019 us=985782 I/O WAIT status=0x0020
Tue Jul 23 11:08:50 2019 us=985782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.***:12345
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:50 2019 us=985782 ACK reliable_can_send active=4 current=1 : [6] 2 3 4 5
Tue Jul 23 11:08:50 2019 us=985782 ACK reliable_send ID 5 (size=865 to=16)
Tue Jul 23 11:08:50 2019 us=985782 Reliable -> TCP/UDP
Tue Jul 23 11:08:50 2019 us=985782 ACK reliable_send_timeout 13 [6] 2 3 4 5
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_process: timeout set to 13
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:50 2019 us=985782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:50 2019 us=985782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:50 2019 us=985782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0003 arg=0x4fb0a0
Tue Jul 23 11:08:50 2019 us=985782 I/O WAIT T?|T?|SRQ|SW1 [1/75143]
Tue Jul 23 11:08:50 2019 us=985782 WE_WAIT enter n=3 to=1075
Tue Jul 23 11:08:50 2019 us=985782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:50 2019 us=985782 [1] ev=0000000000000098 rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:50 2019 us=985782 [2] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:50 2019 us=985782 WE_WAIT leave [1,0] rwflags=0x0002 arg=0x4fb0a0
Tue Jul 23 11:08:50 2019 us=985782 event_wait returned 1
Tue Jul 23 11:08:50 2019 us=985782 I/O WAIT status=0x0002
Tue Jul 23 11:08:50 2019 us=985782 TCP_CLIENT WRITE [875] to [AF_INET]78.157.227.164:8640: P_CONTROL_V1 kid=0 sid=c64e9751 29cd1753 [ ] pid=5 DATA b541c301 e3825533 e77a2bac 7163c71e 7df01603 03010610 00010201 0015123[more...]
Tue Jul 23 11:08:50 2019 us=985782 STREAM: WRITE 875 offset=30
Tue Jul 23 11:08:50 2019 us=985782 WIN32 I/O: Socket Completion non-queued success [1186]
Tue Jul 23 11:08:50 2019 us=985782 WIN32 I/O: Socket Send immediate return [877,877]
Tue Jul 23 11:08:50 2019 us=985782 TCP_CLIENT write returned 877
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_multi_process: i=0 state=S_SENT_KEY, mysid=c64e9751 29cd1753, stored-sid=6209e701 ce41f43f, stored-ip=[AF_INET]78.157.227.164:8640
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_process: chg=0 ks=S_SENT_KEY lame=S_UNDEF to_link->len=0 wakeup=604800
Tue Jul 23 11:08:50 2019 us=985782 ACK reliable_can_send active=4 current=0 : [6] 2 3 4 5
Tue Jul 23 11:08:50 2019 us=985782 ACK output sequence broken: [6] 2 3 4 5
Tue Jul 23 11:08:50 2019 us=985782 ACK reliable_send_timeout 13 [6] 2 3 4 5
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_process: timeout set to 13
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=439f141d 98907823, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:50 2019 us=985782 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[AF_UNSPEC]
Tue Jul 23 11:08:50 2019 us=985782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:50 2019 us=985782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:50 2019 us=985782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:50 2019 us=985782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:50 2019 us=985782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:50 2019 us=985782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:50 2019 us=985782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:52 2019 us=60782 event_wait returned 0
Tue Jul 23 11:08:52 2019 us=60782 I/O WAIT status=0x0020
Tue Jul 23 11:08:52 2019 us=60782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:52 2019 us=60782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:52 2019 us=60782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:52 2019 us=60782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:52 2019 us=60782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:52 2019 us=60782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:52 2019 us=60782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:52 2019 us=60782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:53 2019 us=135782 event_wait returned 0
Tue Jul 23 11:08:53 2019 us=135782 I/O WAIT status=0x0020
Tue Jul 23 11:08:53 2019 us=135782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:53 2019 us=135782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:53 2019 us=135782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:53 2019 us=135782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:53 2019 us=135782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:53 2019 us=135782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:53 2019 us=135782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:53 2019 us=135782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:54 2019 us=210782 event_wait returned 0
Tue Jul 23 11:08:54 2019 us=210782 I/O WAIT status=0x0020
Tue Jul 23 11:08:54 2019 us=210782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:54 2019 us=210782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:54 2019 us=210782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:54 2019 us=210782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:54 2019 us=210782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:54 2019 us=210782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:54 2019 us=210782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:54 2019 us=210782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:55 2019 us=285782 event_wait returned 0
Tue Jul 23 11:08:55 2019 us=285782 I/O WAIT status=0x0020
Tue Jul 23 11:08:55 2019 us=285782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:55 2019 us=285782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:55 2019 us=285782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:55 2019 us=285782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:55 2019 us=285782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:55 2019 us=285782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:55 2019 us=285782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:55 2019 us=285782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:56 2019 us=360782 event_wait returned 0
Tue Jul 23 11:08:56 2019 us=360782 I/O WAIT status=0x0020
Tue Jul 23 11:08:56 2019 us=360782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:56 2019 us=360782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:56 2019 us=360782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:56 2019 us=360782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:56 2019 us=360782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:56 2019 us=360782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:56 2019 us=360782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:56 2019 us=360782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:57 2019 us=435782 event_wait returned 0
Tue Jul 23 11:08:57 2019 us=435782 I/O WAIT status=0x0020
Tue Jul 23 11:08:57 2019 us=435782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:57 2019 us=435782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:57 2019 us=435782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:57 2019 us=435782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:57 2019 us=435782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:57 2019 us=435782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:57 2019 us=435782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:57 2019 us=435782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:58 2019 us=510782 event_wait returned 0
Tue Jul 23 11:08:58 2019 us=510782 I/O WAIT status=0x0020
Tue Jul 23 11:08:58 2019 us=510782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:58 2019 us=510782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:58 2019 us=510782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:58 2019 us=510782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:58 2019 us=510782 I/O WAIT T?|T?|SRQ|Sw1 [1/75143]
Tue Jul 23 11:08:58 2019 us=510782 WE_WAIT enter n=2 to=1075
Tue Jul 23 11:08:58 2019 us=510782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:58 2019 us=510782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:59 2019 us=585782 event_wait returned 0
Tue Jul 23 11:08:59 2019 us=585782 I/O WAIT status=0x0020
Tue Jul 23 11:08:59 2019 us=585782 TIMER: coarse timer wakeup 1 seconds
Tue Jul 23 11:08:59 2019 us=585782 RANDOM USEC=254381
Tue Jul 23 11:08:59 2019 us=585782 WE_CTL n=0 ev=0000000000502D28 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:59 2019 us=585782 STREAM: SET NEXT, buf=[532,0] next=[532,1626] len=-1 maxlen=1626
Tue Jul 23 11:08:59 2019 us=585782 WE_CTL n=1 ev=000000000054BBA0 rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:08:59 2019 us=585782 I/O WAIT T?|T?|SRQ|Sw1 [1/254381]
Tue Jul 23 11:08:59 2019 us=585782 WE_WAIT enter n=2 to=1254
Tue Jul 23 11:08:59 2019 us=585782 [0] ev=0000000000000084 rwflags=0x0001 arg=0x4ba080
Tue Jul 23 11:08:59 2019 us=585782 [1] ev=000000000000009C rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:09:00 2019 us=649782 WE_WAIT leave rwflags=0x0001 arg=0x4fb0a0
Tue Jul 23 11:09:00 2019 us=649782 event_wait returned 1
Tue Jul 23 11:09:00 2019 us=649782 I/O WAIT status=0x0001
Tue Jul 23 11:09:00 2019 us=649782 WIN32 I/O: Socket Completion success [0]
Tue Jul 23 11:09:00 2019 us=649782 Connection reset, restarting [0]
Лог на микротике: https://yadi.sk/i/YtV51h3UnImt5Q

Сам сломал голову уже, грешу разве что на провайдеров, так как тех кто не может подключиться можно разделить по географическому признаку: 4 компа в одном поселке, 2 в другом и 2 компа в одном офисе в городе. Вопрос как узнать точно? И можно ли что-то с этим сделать?

И второй вопрос сразу, есть соединение где пинг ~1000, каждые 5-15 минут рвется связь и идет реконект, можно ли какими-то настройками попытаться увеличить стабильность? Пробовал менять keepalive, mtu но никакого эффекта не заметил.


bst-botsman
Сообщения: 189
Зарегистрирован: 13 окт 2018, 20:53
Откуда: Беларусь

в конфиге на клиенте замените на и будет вам счастье...


RB3011UiAS x 1
RB4011iGS+5HacQ2HnD x 3
951Ui-2nD x 2
hAP ac^2 x 24
CheckPoint 1590 x 1
Soul
Сообщения: 6
Зарегистрирован: 23 июл 2019, 07:25

К сожалению чуда не случилось. На компах которые не конектятся замена tun на tap ничего не меняет.

disconnected <remote peer uses tap encapsulation while we - tun>

Попробовал в настройках микротика заменить ip на ethernet с заменой tun на tap у работающего сейчас клиента - коннекта нет. Еще когда настраивал первоначально сеть, на tap не заводилось, на tun пошло нормально...


Аватара пользователя
podarok66
Модератор
Сообщения: 4361
Зарегистрирован: 11 фев 2012, 18:49
Откуда: МО

Да не, причём тут tap? Это создаёт ethernet-туннель, используется при создании моста. А tun работает на сетевом уровне. Как бы то, что надо. Вообще в Винде часто препятствует соединению фаерволл. Причём как родной виндовый, так и любой из установленных (например при установке антивирусов) . Проверьте, возможно именно это является проблемой.


Мануалы изучил и нигде не ошибся? Фаервол отключил? Очереди погасил? Витая пара проверена? ... Тогда Netinstal'ом железку прошей и настрой ее заново. Что, все равно не фурычит? Тогда к нам. Если не подскажем, хоть посочувствуем...
Soul
Сообщения: 6
Зарегистрирован: 23 июл 2019, 07:25

Брандмауэр отключен, антивири тоже отключал/сносил...
Может ли провайдер каким-то образом резать подключение?


Аватара пользователя
podarok66
Модератор
Сообщения: 4361
Зарегистрирован: 11 фев 2012, 18:49
Откуда: МО

Ну вообще это возможно теоретически, но в действительности подобное надо ещё найти. Насколько я помню, на что-то подобное жаловались по отношению к операторам сотовой связи. Можно попробовать перенастроить OVPN на какой-нибудь из "неотключаемых" портов. Я как-то в подобной ситуации юзал 445 порт, прокатывало.
По поводу отключения антивирей, это как правило не помогает. Только снос с последующей перезагрузкой обеспечит хоть какую-то уверенность. Мы как-то маккафи боролись, не понимая, что нам мешает построить туннель. Жуткая гадость, как мне кажется.


Мануалы изучил и нигде не ошибся? Фаервол отключил? Очереди погасил? Витая пара проверена? ... Тогда Netinstal'ом железку прошей и настрой ее заново. Что, все равно не фурычит? Тогда к нам. Если не подскажем, хоть посочувствуем...
Soul
Сообщения: 6
Зарегистрирован: 23 июл 2019, 07:25

Интернет там как раз спутниковая связь... Попробовал на другие порты покидать, 445, 443 - не помогает. Получается что и микротик видит попытку входящего соединения, аутентификация проходится, после чего соединение просто рвется и уходит на рестарт.
Антивирь на одном из компов снес полностью еще раньше, брандмауэр тоже отключаю на время тестов.

Ок, а если зайти с другой стороны, что можно попробовать вместо Овпн поднять? Так как в данном случае компы находятся очень далеко и физического доступа к ним нет, нужно стабильное соединение, умеющее самовосстанавливаться при частых потерях связи. Сейчас параллельно стоит еще Хамач, но он порой выпадает из сети и начинается геморрой...


Аватара пользователя
podarok66
Модератор
Сообщения: 4361
Зарегистрирован: 11 фев 2012, 18:49
Откуда: МО

Ну смотрите, я ещё с давних времён при настройке на Тике OpenVPN помню, что раньше у них tls вообще не работало и была оговорка об этом в Вики. Потом оговорку убрали, tls вроде как заработало, но я это протокол при настройке в конфигурацию и по сей день не включаю.
Дальше, если у вас там спутниковая связь, это пинги очень приличные. Это не может стать причиной?
И ещё, вы MTU не пробовали в туннеле поменьше делать? Просто для пробы. Может и в этом проблема...
Больше ничего во голову не приходит. Я даже ради интереса человеку из спутникового провадинга написал, спросил о блокировке туннелей. Специалист говорит, что по крайней мере у них нет борьбы с туннелями. С p2p есть и серьёзная, а с туннелями не наблюдается.
Предлагается так же временно поднять уровень логирования, пресловутый verb. Может покажет чего...


Мануалы изучил и нигде не ошибся? Фаервол отключил? Очереди погасил? Витая пара проверена? ... Тогда Netinstal'ом железку прошей и настрой ее заново. Что, все равно не фурычит? Тогда к нам. Если не подскажем, хоть посочувствуем...
Аватара пользователя
podarok66
Модератор
Сообщения: 4361
Зарегистрирован: 11 фев 2012, 18:49
Откуда: МО

Вот ещё подсказали, можно почитать. Как раз на верхнем уровне логирования можно увидеть.
https://forums.openvpn.net/viewtopic.php?t=25044
Почитайте, суть в том, что в tcp потери пакетов OVPN при авторизации рассматривает как атаку. И разрывает соединение. А спутниковый интернет - это, простите нестабильность, как правило. UDP Микротик не умеет. Если у вас логирование покажет аналогичную историю, то придётся менять тип туннеля, вероятнее всего.


Мануалы изучил и нигде не ошибся? Фаервол отключил? Очереди погасил? Витая пара проверена? ... Тогда Netinstal'ом железку прошей и настрой ее заново. Что, все равно не фурычит? Тогда к нам. Если не подскажем, хоть посочувствуем...
Soul
Сообщения: 6
Зарегистрирован: 23 июл 2019, 07:25

В общем с Ovpn так и не удалось завести. На потерю пакетов не похоже, с другой точки где пинг 1000+ работает на удивление стабильно. Логи в первом посте кидал, ничего конкретного сам с них понять не смог...

Попробовал поднять l2tp + ipsec, пришлось повозиться из-за NAT, но по итогу работает только одно соединение, при попытке подрубить второй комп первый вылетает. Убрал ipsec все ок. Но безопасность получается так себе... Может подскажете что можно еще придумать?

И еще такой вопрос. В openvpn если делать сервер на винде можно было настроить чтоб после конекта трафик между клиентами гулял напрямую а не весь шел через сервер. Микротик же все гонит через себя, можно ли на нем как-то сделать аналогичные настройки?


Ответить