Closed krizhanovsky closed 1 year ago
Also I noticed that tempesta is sending TLS alert after client has sent FIN (192.168.56.1 is a client, and 192.168.56.16 is a VM running tempesta-fw)
I still can reproduce the problem with h2load -n 1 -c 1 -t 1 https://tempesta-tech.com
on Tempesta dc284c1d2d79564bce0a2969451f5b05ce30cf1a and the kernel as of May 14. In dmesg Tempesta logs:
[ 8586.951096] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 8586.954244] [tempesta fw] HTTP/2 connection is closed by client with error code: 9, ID of last processed stream: 0
h2load output:
$ h2load -n 1 -c 1 -t 1 https://tempesta-tech.com
starting benchmark...
spawning thread #0: 1 total client(s). 1 total requests
TLS Protocol: TLSv1.2
Cipher: ECDHE-ECDSA-AES128-GCM-SHA256
Server Temp Key: ECDH P-256 256 bits
Application protocol: h2
progress: 100% done
finished in 1.43s, 0.70 req/s, 17.85KB/s
requests: 1 total, 1 started, 1 done, 1 succeeded, 0 failed, 0 errored, 0 timeout
status codes: 1 2xx, 0 3xx, 0 4xx, 0 5xx
traffic: 25.61KB (26223) total, 216B (216) headers (space savings 20.00%), 25.26KB (25865) data
min max mean sd +/- sd
time for request: 1.02s 1.02s 1.02s 0us 100.00%
time for connect: 409.54ms 409.54ms 409.54ms 0us 100.00%
time to 1st byte: 1.04s 1.04s 1.04s 0us 100.00%
req/s : 0.70 0.70 0.70 0.00 100.00%
$ h2load -n 1 -c 1 -t 1 https://tempesta-tech.com
starting benchmark...
spawning thread #0: 1 total client(s). 1 total requests
TLS Protocol: TLSv1.2
Cipher: ECDHE-ECDSA-AES128-GCM-SHA256
Server Temp Key: ECDH P-256 256 bits
Application protocol: h2
finished in 628.35ms, 0.00 req/s, 11.27KB/s
requests: 1 total, 1 started, 0 done, 0 succeeded, 1 failed, 1 errored, 0 timeout
status codes: 1 2xx, 0 3xx, 0 4xx, 0 5xx
traffic: 7.08KB (7249) total, 0B (0) headers (space savings 100.00%), 0B (0) data
min max mean sd +/- sd
time for request: 0us 0us 0us 0us 0.00%
time for connect: 392.73ms 392.73ms 392.73ms 0us 100.00%
time to 1st byte: 0us 0us 0us 0us 0.00%
req/s : 0.00 0.00 0.00 0.00 100.00%
Note that the first request on just started Tempesta succeeds, while the 2nd for the cached response fails, so probably the issue is linked with the web cache for HTTP/2 clients.
I also can reproduce it with curl
:
$ curl -v -k --http2 https://tempesta-tech.com/
* Trying 192.168.100.4:443...
* Connected to tempesta-tech.com (192.168.100.4) port 443 (#0)
* ALPN, offering h2
* ALPN, offering http/1.1
* TLSv1.0 (OUT), TLS header, Certificate Status (22):
* TLSv1.3 (OUT), TLS handshake, Client hello (1):
* TLSv1.2 (IN), TLS header, Certificate Status (22):
* TLSv1.3 (IN), TLS handshake, Server hello (2):
* TLSv1.2 (IN), TLS header, Certificate Status (22):
* TLSv1.2 (IN), TLS handshake, Certificate (11):
* TLSv1.2 (IN), TLS header, Certificate Status (22):
* TLSv1.2 (IN), TLS handshake, Server key exchange (12):
* TLSv1.2 (IN), TLS header, Certificate Status (22):
* TLSv1.2 (IN), TLS handshake, Server finished (14):
* TLSv1.2 (OUT), TLS header, Certificate Status (22):
* TLSv1.2 (OUT), TLS handshake, Client key exchange (16):
* TLSv1.2 (OUT), TLS header, Finished (20):
* TLSv1.2 (OUT), TLS change cipher, Change cipher spec (1):
* TLSv1.2 (OUT), TLS header, Certificate Status (22):
* TLSv1.2 (OUT), TLS handshake, Finished (20):
* TLSv1.2 (IN), TLS header, Finished (20):
* TLSv1.2 (IN), TLS header, Certificate Status (22):
* TLSv1.2 (IN), TLS handshake, Finished (20):
* SSL connection using TLSv1.2 / ECDHE-ECDSA-AES128-GCM-SHA256
* ALPN, server accepted to use h2
* Server certificate:
* subject: CN=localhost
* start date: Jun 28 16:46:40 2022 GMT
* expire date: Jun 28 16:46:40 2023 GMT
* issuer: CN=localhost
* SSL certificate verify result: self-signed certificate (18), continuing anyway.
* Using HTTP2, server supports multiplexing
* Connection state changed (HTTP/2 confirmed)
* Copying HTTP/2 data in stream buffer to connection buffer after upgrade: len=0
* TLSv1.2 (OUT), TLS header, Supplemental data (23):
* TLSv1.2 (OUT), TLS header, Supplemental data (23):
* TLSv1.2 (OUT), TLS header, Supplemental data (23):
* Using Stream ID: 1 (easy handle 0x563543bc3e90)
* TLSv1.2 (OUT), TLS header, Supplemental data (23):
> GET / HTTP/2
> Host: tempesta-tech.com
> user-agent: curl/7.81.0
> accept: */*
>
* TLSv1.2 (IN), TLS header, Supplemental data (23):
* Connection state changed (MAX_CONCURRENT_STREAMS == 4294967295)!
* TLSv1.2 (OUT), TLS header, Supplemental data (23):
* TLSv1.2 (IN), TLS header, Supplemental data (23):
* TLSv1.2 (IN), TLS header, Supplemental data (23):
* TLSv1.2 (IN), TLS header, Supplemental data (23):
* TLSv1.2 (OUT), TLS header, Supplemental data (23):
* Empty reply from server
* Closing connection 0
* TLSv1.2 (OUT), TLS header, Unknown (21):
* TLSv1.2 (OUT), TLS alert, close notify (256):
curl: (52) Empty reply from server
Tempesta log for this request (compiled as # DEBUG=1 DBG_TLS=3 DBG_HTTP=3 DBG_HTTP_PARSER=3 DBG_HTTP_FRAME=1 DBG_HTTP_SESS=1 DBG_HTTP_STREAM=1 DBG_SS=3 make -j
):
[13023.993462] [tempesta fw] client was found in tdb
[13023.995458] [tempesta fw] [1]: ss_tcp_state_change: sk=000000004a3e83a1 state=Established
[13023.997881] [tempesta fw] client was found in tdb
[13023.999784] [tempesta fw] tfw_tls_conn_init: conn=[00000000ae2a04ec]
[13024.001391] [tempesta fw] tfw_http_conn_init: conn=[00000000ae2a04ec]
[13024.002102] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13024.002903] [tempesta tls] ttls_recv: tls= pK-error len=62 read=0
[13024.003592] [tempesta tls] input rec: type=22 ver=3:1 msglen=512 read=5 xfrm_ready=0
[13024.004370] [tempesta tls] handshake message: msglen=512 type=1 hslen=508 read=9
[13024.005077] [tempesta tls] handshake message 22 on state 0
[13024.005689] [tempesta tls] server state: 0
[13024.006202] [tempesta tls] enter TLS Server Handshake FSM at state 0x0(TTLS_CLIENT_HELLO)
[13024.006977] [tempesta tls] enter TLS ClientHello FSM at state 0x0(TTLS_CH_HS_VER)
[13024.007706] [tempesta tls] enter TLS ClientHello FSM at state 0x1(TTLS_CH_HS_RND)
[13024.008443] [tempesta tls] dump 'ClientHello: random bytes ' (ptr=(einval), 32 bytes):
[13024.009203] [tempesta tls] 00000000: fc e6 97 17 d3 1e be b4 c9 21 de 5d 83 fa 89 95 .........!.]....
[13024.010052] [tempesta tls] 00000010: 0e de 8c fe a1 fc df 4a 31 16 e7 6a 0b 75 8e d9 .......J1..j.u..
[13024.010898] [tempesta tls] enter TLS ClientHello FSM at state 0x2(TTLS_CH_HS_SLEN)
[13024.011630] [tempesta tls] ClientHello: Session ID length 32
[13024.012457] [tempesta tls] enter TLS ClientHello FSM at state 0x3(TTLS_CH_HS_SESS)
[13024.013226] [tempesta tls] Finish TLS ClientHello FSM at state 0x3, ret=-1
[13024.014284] [tempesta tls] update checksum on buf pK-error len=57, hash=2
[13024.015010] [tempesta tls] dump 'hash buf ' (ptr=(einval), 57 bytes):
[13024.015725] [tempesta tls] 00000000: 01 00 01 fc 03 03 fc e6 97 17 d3 1e be b4 c9 21 ...............!
[13024.016606] [tempesta tls] 00000010: de 5d 83 fa 89 95 0e de 8c fe a1 fc df 4a 31 16 .]...........J1.
[13024.017456] [tempesta tls] 00000020: e7 6a 0b 75 8e d9 20 e7 70 cc f8 e3 45 9a 70 e7 .j.u.. .p...E.p.
[13024.018336] [tempesta tls] 00000030: 95 0a d2 ea 78 ac 05 4a 2e ....x..J.
[13024.019230] [tempesta tls] ttls_recv: tls= pK-error len=455 read=0
[13024.020002] [tempesta tls] handshake message 22 on state 3
[13024.020744] [tempesta tls] server state: 3
[13024.021301] [tempesta tls] enter TLS Server Handshake FSM at state 0x0(TTLS_CLIENT_HELLO)
[13024.022375] [tempesta tls] enter TLS ClientHello FSM at state 0x3(TTLS_CH_HS_SESS)
[13024.023127] [tempesta tls] dump 'ClientHello: session id ' (ptr=(einval), 32 bytes):
[13024.023870] [tempesta tls] 00000000: e7 70 cc f8 e3 45 9a 70 e7 95 0a d2 ea 78 ac 05 .p...E.p.....x..
[13024.024724] [tempesta tls] 00000010: 4a 2e 7c 76 55 2e bf 11 90 55 18 e1 7c c4 e1 19 J.|vU....U..|...
[13024.025568] [tempesta tls] enter TLS ClientHello FSM at state 0x4(TTLS_CH_HS_CSLEN)
[13024.026308] [tempesta tls] ClientHello: cipher suites length 62
[13024.026940] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.027662] [tempesta tls] ClientHello: cipher suite #0: 0x1302
[13024.028298] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.029018] [tempesta tls] ClientHello: cipher suite #1: 0x1303
[13024.030041] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.030817] [tempesta tls] ClientHello: cipher suite #2: 0x1301
[13024.031454] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.032348] [tempesta tls] ClientHello: cipher suite #3: 0xc02c
[13024.032985] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.033704] [tempesta tls] ClientHello: cipher suite #4: 0xc030
[13024.034333] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.035057] [tempesta tls] ClientHello: cipher suite #5: 0x9f
[13024.035681] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.036402] [tempesta tls] ClientHello: cipher suite #6: 0xcca9
[13024.037034] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.037752] [tempesta tls] ClientHello: cipher suite #7: 0xcca8
[13024.038382] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.039102] [tempesta tls] ClientHello: cipher suite #8: 0xccaa
[13024.039733] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.040454] [tempesta tls] ClientHello: cipher suite #9: 0xc02b
[13024.041084] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.041825] [tempesta tls] ClientHello: cipher suite #10: 0xc02f
[13024.042464] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.043181] [tempesta tls] ClientHello: cipher suite #11: 0x9e
[13024.043808] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.044531] [tempesta tls] ClientHello: cipher suite #12: 0xc024
[13024.045165] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.046265] [tempesta tls] ClientHello: cipher suite #13: 0xc028
[13024.046904] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.047641] [tempesta tls] ClientHello: cipher suite #14: 0x6b
[13024.048331] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.049142] [tempesta tls] ClientHello: cipher suite #15: 0xc023
[13024.049862] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.050671] [tempesta tls] ClientHello: cipher suite #16: 0xc027
[13024.051315] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.052222] [tempesta tls] ClientHello: cipher suite #17: 0x67
[13024.052916] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.053635] [tempesta tls] ClientHello: cipher suite #18: 0xc00a
[13024.054267] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.054986] [tempesta tls] ClientHello: cipher suite #19: 0xc014
[13024.055615] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.056319] [tempesta tls] ClientHello: cipher suite #20: 0x39
[13024.056899] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.057565] [tempesta tls] ClientHello: cipher suite #21: 0xc009
[13024.058154] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.058820] [tempesta tls] ClientHello: cipher suite #22: 0xc013
[13024.059421] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.060086] [tempesta tls] ClientHello: cipher suite #23: 0x33
[13024.060677] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.061344] [tempesta tls] ClientHello: cipher suite #24: 0x9d
[13024.062495] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.063171] [tempesta tls] ClientHello: cipher suite #25: 0x9c
[13024.063797] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.064488] [tempesta tls] ClientHello: cipher suite #26: 0x3d
[13024.065063] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.065723] [tempesta tls] ClientHello: cipher suite #27: 0x3c
[13024.066309] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.066970] [tempesta tls] ClientHello: cipher suite #28: 0x35
[13024.067544] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.068232] [tempesta tls] ClientHello: cipher suite #29: 0x2f
[13024.068810] [tempesta tls] enter TLS ClientHello FSM at state 0x5(TTLS_CH_HS_CS)
[13024.069478] [tempesta tls] ClientHello: cipher suite #30: 0xff
[13024.070054] [tempesta tls] received EMPTY_RENEGOTIATION_INFO_SCSV
[13024.070638] [tempesta tls] enter TLS ClientHello FSM at state 0x7(TTLS_CH_HS_COMPN)
[13024.071315] [tempesta tls] ClientHello: compression algorithms length 1
[13024.072042] [tempesta tls] enter TLS ClientHello FSM at state 0x8(TTLS_CH_HS_COMP)
[13024.072735] [tempesta tls] saw NULL compression
[13024.073236] [tempesta tls] enter TLS ClientHello FSM at state 0x9(TTLS_CH_HS_EXTLEN)
[13024.073915] [tempesta tls] ClientHello: extensions length 373
[13024.074492] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.075164] [tempesta tls] ClientHello: read extension 0x0...
[13024.075735] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.076413] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.077073] [tempesta tls] ClientHello: read 22 bytes for ext 0
[13024.078035] [tempesta tls] found ServerName extension
[13024.078593] [tempesta fw] tfw_tls_sni: server name 'tempesta-tech.com'
[13024.079298] [tempesta fw] found SAN/CN 'tempesta-tech.com' for SNI 'tempesta-tech.com' and vhost 'tempesta-tech.com'
[13024.080243] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.081017] [tempesta tls] ClientHello: read extension 0xb...
[13024.081683] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.082616] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.083286] [tempesta tls] ClientHello: read 4 bytes for ext 11
[13024.083868] [tempesta tls] found supported point formats extension
[13024.084452] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.085144] [tempesta tls] ClientHello: read extension 0xa...
[13024.085752] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.086461] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.087158] [tempesta tls] ClientHello: read 22 bytes for ext 10
[13024.087751] [tempesta tls] found supported elliptic curves extension
[13024.088348] [tempesta tls] try curve id 0x1d from the client
[13024.088916] [tempesta tls] try curve id 0x17 from the client
[13024.089489] [tempesta tls] set curve secp256r1
[13024.089976] [tempesta tls] try curve id 0x1e from the client
[13024.090529] [tempesta tls] try curve id 0x19 from the client
[13024.091085] [tempesta tls] try curve id 0x18 from the client
[13024.091630] [tempesta tls] try curve id 0x100 from the client
[13024.092328] [tempesta tls] try curve id 0x101 from the client
[13024.092876] [tempesta tls] try curve id 0x102 from the client
[13024.093417] [tempesta tls] try curve id 0x103 from the client
[13024.094304] [tempesta tls] try curve id 0x104 from the client
[13024.094863] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.095521] [tempesta tls] ClientHello: read extension 0x3374...
[13024.096116] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.096756] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.097378] [tempesta tls] ClientHello: read 0 bytes for ext 13172
[13024.097940] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.098565] [tempesta tls] ClientHello: read extension 0x10...
[13024.099098] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.099724] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.100344] [tempesta tls] ClientHello: read 14 bytes for ext 16
[13024.100882] [tempesta tls] found alpn extension
[13024.101319] [tempesta tls] match client ALPN h2 (len=2) against our h2
[13024.101934] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.102570] [tempesta tls] ClientHello: read extension 0x16...
[13024.103099] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.103719] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.104336] [tempesta tls] ClientHello: read 0 bytes for ext 22
[13024.104864] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.105481] [tempesta tls] ClientHello: read extension 0x17...
[13024.106004] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.106634] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.107245] [tempesta tls] ClientHello: read 0 bytes for ext 23
[13024.107787] [tempesta tls] found extended master secret extension
[13024.108336] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.108955] [tempesta tls] ClientHello: read extension 0x31...
[13024.109496] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.110667] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.111423] [tempesta tls] ClientHello: read 0 bytes for ext 49
[13024.112194] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.112915] [tempesta tls] ClientHello: read extension 0xd...
[13024.113475] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.114121] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.114724] [tempesta tls] ClientHello: read 42 bytes for ext 13
[13024.115248] [tempesta tls] found signature_algorithms extension
[13024.115775] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 7
[13024.116426] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 8
[13024.117119] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 9
[13024.117816] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 10
[13024.118514] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 11
[13024.119169] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 4
[13024.119803] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 5
[13024.120436] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 6
[13024.121065] [tempesta tls] ClientHello: signature_algorithm ext: unknown hash alg encoding 3
[13024.121699] [tempesta tls] ClientHello: signature_algorithm ext: unknown hash alg encoding 3
[13024.122437] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 2
[13024.123070] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 2
[13024.123700] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 2
[13024.124332] [tempesta tls] ClientHello: signature_algorithm ext: unknown sig alg encoding 2
[13024.124961] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.125577] [tempesta tls] ClientHello: read extension 0x2b...
[13024.126382] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.127000] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.127675] [tempesta tls] ClientHello: read 5 bytes for ext 43
[13024.128238] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.128848] [tempesta tls] ClientHello: read extension 0x2d...
[13024.129367] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.129972] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.130565] [tempesta tls] ClientHello: read 2 bytes for ext 45
[13024.131076] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.131677] [tempesta tls] ClientHello: read extension 0x33...
[13024.132299] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.132914] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.133507] [tempesta tls] ClientHello: read 38 bytes for ext 51
[13024.134024] [tempesta tls] enter TLS ClientHello FSM at state 0xa(TTLS_CH_HS_EXT)
[13024.134625] [tempesta tls] ClientHello: read extension 0x15...
[13024.135131] [tempesta tls] enter TLS ClientHello FSM at state 0xb(TTLS_CH_HS_EXS)
[13024.135732] [tempesta tls] enter TLS ClientHello FSM at state 0xc(TTLS_CH_HS_EX)
[13024.136334] [tempesta tls] ClientHello: read 172 bytes for ext 21
[13024.136859] [tempesta tls] Finish TLS ClientHello FSM at state 0xc, ret=0
[13024.137420] [tempesta tls] ClientHello: process ticket
[13024.137871] [tempesta tls] ClientHello: signature_algorithm ext: choose hash 1 for sig RSA
[13024.137872] [tempesta tls] ClientHello: signature_algorithm ext: choose hash 1 for sig ECDSA
[13024.138502] [tempesta tls] trying ciphersuite: TLS-ECDHE-ECDSA-WITH-AES-128-GCM-SHA256
[13024.139747] [tempesta tls] ciphersuite requires certificate
[13024.140309] [tempesta tls] selected ciphersuite: TLS-ECDHE-ECDSA-WITH-AES-128-GCM-SHA256
[13024.141102] [tempesta tls] client hello v3, signature_algorithm ext: 5
[13024.141110] [tempesta tls] update checksum on buf pK-error len=455, hash=1
[13024.143554] [tempesta tls] dump 'hash buf ' (ptr=(einval), 455 bytes):
[13024.144155] [tempesta tls] 00000000: 7c 76 55 2e bf 11 90 55 18 e1 7c c4 e1 19 00 3e |vU....U..|....>
[13024.144961] [tempesta tls] 00000010: 13 02 13 03 13 01 c0 2c c0 30 00 9f cc a9 cc a8 .......,.0......
[13024.145707] [tempesta tls] 00000020: cc aa c0 2b c0 2f 00 9e c0 24 c0 28 00 6b c0 23 ...+./...$.(.k.#
[13024.146430] [tempesta tls] 00000030: c0 27 00 67 c0 0a c0 14 00 39 c0 09 c0 13 00 33 .'.g.....9.....3
[13024.147162] [tempesta tls] 00000040: 00 9d 00 9c 00 3d 00 3c 00 35 00 2f 00 ff 01 00 .....=.<.5./....
[13024.147886] [tempesta tls] 00000050: 01 75 00 00 00 16 00 14 00 00 11 74 65 6d 70 65 .u.........tempe
[13024.148626] [tempesta tls] 00000060: 73 74 61 2d 74 65 63 68 2e 63 6f 6d 00 0b 00 04 sta-tech.com....
[13024.149356] [tempesta tls] 00000070: 03 00 01 02 00 0a 00 16 00 14 00 1d 00 17 00 1e ................
[13024.150091] [tempesta tls] 00000080: 00 19 00 18 01 00 01 01 01 02 01 03 01 04 33 74 ..............3t
[13024.150829] [tempesta tls] 00000090: 00 00 00 10 00 0e 00 0c 02 68 32 08 68 74 74 70 .........h2.http
[13024.151622] [tempesta tls] 000000a0: 2f 31 2e 31 00 16 00 00 00 17 00 00 00 31 00 00 /1.1.........1..
[13024.152547] [tempesta tls] 000000b0: 00 0d 00 2a 00 28 04 03 05 03 06 03 08 07 08 08 ...*.(..........
[13024.153292] [tempesta tls] 000000c0: 08 09 08 0a 08 0b 08 04 08 05 08 06 04 01 05 01 ................
[13024.154039] [tempesta tls] 000000d0: 06 01 03 03 03 01 03 02 04 02 05 02 06 02 00 2b ...............+
[13024.154791] [tempesta tls] 000000e0: 00 05 04 03 04 03 03 00 2d 00 02 01 01 00 33 00 ........-.....3.
[13024.155542] [tempesta tls] 000000f0: 26 00 24 00 1d 00 20 24 a5 88 b7 17 84 f9 65 57 &.$... $......eW
[13024.156346] [tempesta tls] 00000100: 36 cf 99 99 1d 25 06 36 c7 c3 2f 7d 10 f0 55 0b 6....%.6../}..U.
[13024.157136] [tempesta tls] 00000110: f4 e5 9b 19 a8 91 29 00 15 00 ac 00 00 00 00 00 ......).........
[13024.158368] [tempesta tls] 00000120: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.159255] [tempesta tls] 00000130: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.160060] [tempesta tls] 00000140: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.160921] [tempesta tls] 00000150: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.161819] [tempesta tls] 00000160: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.162685] [tempesta tls] 00000170: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.163469] [tempesta tls] 00000180: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.164219] [tempesta tls] 00000190: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.164960] [tempesta tls] 000001a0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.165694] [tempesta tls] 000001b0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13024.166461] [tempesta tls] 000001c0: 00 00 00 00 00 00 00 .......
[13024.167199] [tempesta tls] enter TLS Server Handshake FSM at state 0x1000000(TTLS_SERVER_HELLO)
[13024.167935] [tempesta tls] enter TLS Server Handshake (ServerHello) FSM at state 0x1000000(TTLS_SERVER_HELLO)
[13024.168749] [tempesta tls] server hello, chosen version 3:3, buf= pK-error
[13024.169397] [tempesta tls] dump 'server hello, random bytes ' (ptr=(einval), 32 bytes):
[13024.170095] [tempesta tls] 00000000: 00 00 00 09 55 55 55 55 55 55 55 55 55 55 55 55 ....UUUUUUUUUUUU
[13024.170882] [tempesta tls] 00000010: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.171689] [tempesta tls] ServerHello: session id len 32
[13024.172392] [tempesta tls] dump 'ServerHello: session id ' (ptr=(einval), 32 bytes):
[13024.173168] [tempesta tls] 00000000: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.174359] [tempesta tls] 00000010: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.175177] [tempesta tls] ServerHello: no session has been resumed
[13024.175787] [tempesta tls] ServerHello: chosen ciphersuite: TLS-ECDHE-ECDSA-WITH-AES-128-GCM-SHA256
[13024.176559] [tempesta tls] ServerHello: adding empty renegotiation_info extension
[13024.177216] [tempesta tls] ServerHello: adding extended master secret extension
[13024.177869] [tempesta tls] ServerHello: supported_point_formats extension
[13024.178490] [tempesta tls] ServerHello: adding alpn extension
[13024.179050] [tempesta tls] ServerHello: total extension length: 24
[13024.179629] [tempesta tls] dump 'Write handshake header' (ptr=(einval), 4 bytes):
[13024.180305] [tempesta tls] 00000000: 02 00 00 60 ...`
[13024.181032] [tempesta tls] dump 'ServerHello: write message' (ptr=(einval), 100 bytes):
[13024.181748] [tempesta tls] 00000000: 02 00 00 60 03 03 00 00 00 09 55 55 55 55 55 55 ...`......UUUUUU
[13024.182674] [tempesta tls] 00000010: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.183464] [tempesta tls] 00000020: 55 55 55 55 55 55 20 55 55 55 55 55 55 55 55 55 UUUUUU UUUUUUUUU
[13024.184253] [tempesta tls] 00000030: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.185039] [tempesta tls] 00000040: 55 55 55 55 55 55 55 c0 2b 00 00 18 ff 01 00 01 UUUUUUU.+.......
[13024.185820] [tempesta tls] 00000050: 00 00 17 00 00 00 0b 00 02 01 00 00 10 00 05 00 ................
[13024.186602] [tempesta tls] 00000060: 03 02 68 32 ..h2
[13024.187324] [tempesta tls] write record: type=22 len=100 hslen=0 sgt= pK-error/1 sg_i=0 ready=0
[13024.188079] [tempesta tls] update checksum on buf pK-error len=100, hash=1
[13024.188744] [tempesta tls] dump 'hash buf ' (ptr=(einval), 100 bytes):
[13024.189359] [tempesta tls] 00000000: 02 00 00 60 03 03 00 00 00 09 55 55 55 55 55 55 ...`......UUUUUU
[13024.190457] [tempesta tls] 00000010: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.191261] [tempesta tls] 00000020: 55 55 55 55 55 55 20 55 55 55 55 55 55 55 55 55 UUUUUU UUUUUUUUU
[13024.192239] [tempesta tls] 00000030: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.193140] [tempesta tls] 00000040: 55 55 55 55 55 55 55 c0 2b 00 00 18 ff 01 00 01 UUUUUUU.+.......
[13024.193931] [tempesta tls] 00000050: 00 00 17 00 00 00 0b 00 02 01 00 00 10 00 05 00 ................
[13024.194717] [tempesta tls] 00000060: 03 02 68 32 ..h2
[13024.195442] [tempesta tls] use record hdr: type=22 ver=3:3 hdr_len=100
[13024.196063] [tempesta tls] enter TLS Server Handshake (ServerHello) FSM at state 0x2000000(TTLS_SERVER_CERTIFICATE)
[13024.196928] [tempesta tls] add cert page pK-error,len=444 seg=2
[13024.197628] [tempesta tls] dump 'Write handshake header' (ptr=(einval), 4 bytes):
[13024.198360] [tempesta tls] 00000000: 0b 00 01 bf ....
[13024.199121] [tempesta tls] write record: type=22 len=451 hslen=0 sgt= pK-error/3 sg_i=1 ready=0
[13024.199881] [tempesta tls] update checksum on buf pK-error len=7, hash=1
[13024.200699] [tempesta tls] dump 'hash buf ' (ptr=(einval), 7 bytes):
[13024.201318] [tempesta tls] 00000000: 0b 00 01 bf 00 01 bc .......
[13024.202242] [tempesta tls] update checksum on buf pK-error len=444, hash=1
[13024.203004] [tempesta tls] dump 'hash buf ' (ptr=(einval), 444 bytes):
[13024.203717] [tempesta tls] 00000000: 00 01 b9 30 82 01 b5 30 82 01 5a a0 03 02 01 02 ...0...0..Z.....
[13024.204578] [tempesta tls] 00000010: 02 14 71 15 56 af 01 55 2d c5 28 ce 63 43 18 ac ..q.V..U-.(.cC..
[13024.205391] [tempesta tls] 00000020: 51 ee 39 06 d0 12 30 0a 06 08 2a 86 48 ce 3d 04 Q.9...0...*.H.=.
[13024.206559] [tempesta tls] 00000030: 03 02 30 14 31 12 30 10 06 03 55 04 03 0c 09 6c ..0.1.0...U....l
[13024.207372] [tempesta tls] 00000040: 6f 63 61 6c 68 6f 73 74 30 1e 17 0d 32 32 30 36 ocalhost0...2206
[13024.208225] [tempesta tls] 00000050: 32 38 31 36 34 36 34 30 5a 17 0d 32 33 30 36 32 28164640Z..23062
[13024.209088] [tempesta tls] 00000060: 38 31 36 34 36 34 30 5a 30 14 31 12 30 10 06 03 8164640Z0.1.0...
[13024.209920] [tempesta tls] 00000070: 55 04 03 0c 09 6c 6f 63 61 6c 68 6f 73 74 30 59 U....localhost0Y
[13024.210701] [tempesta tls] 00000080: 30 13 06 07 2a 86 48 ce 3d 02 01 06 08 2a 86 48 0...*.H.=....*.H
[13024.211484] [tempesta tls] 00000090: ce 3d 03 01 07 03 42 00 04 0b f3 8d 08 5a ea dc .=....B......Z..
[13024.212410] [tempesta tls] 000000a0: 94 47 76 01 3a 7a 7e c7 e8 6a 53 12 69 86 73 af .Gv.:z~..jS.i.s.
[13024.213197] [tempesta tls] 000000b0: af 02 72 43 78 90 fd 0f f1 3f 87 37 34 9d a9 80 ..rCx....?.74...
[13024.213979] [tempesta tls] 000000c0: 46 55 f8 d1 a6 50 d0 fd 01 21 dd 99 92 e3 70 11 FU...P...!....p.
[13024.214765] [tempesta tls] 000000d0: cd 60 c5 ac cc d0 8b 8e 60 a3 81 89 30 81 86 30 .`......`...0..0
[13024.215550] [tempesta tls] 000000e0: 1d 06 03 55 1d 0e 04 16 04 14 78 4c 98 bb 64 e4 ...U......xL..d.
[13024.216340] [tempesta tls] 000000f0: b1 fd 1a 31 d7 fd 91 fa 55 01 16 a1 82 b9 30 1f ...1....U.....0.
[13024.217164] [tempesta tls] 00000100: 06 03 55 1d 23 04 18 30 16 80 14 78 4c 98 bb 64 ..U.#..0...xL..d
[13024.217997] [tempesta tls] 00000110: e4 b1 fd 1a 31 d7 fd 91 fa 55 01 16 a1 82 b9 30 ....1....U.....0
[13024.218966] [tempesta tls] 00000120: 0f 06 03 55 1d 13 01 01 ff 04 05 30 03 01 01 ff ...U.......0....
[13024.219850] [tempesta tls] 00000130: 30 33 06 03 55 1d 11 04 2c 30 2a 82 09 6c 6f 63 03..U...,0*..loc
[13024.220669] [tempesta tls] 00000140: 61 6c 68 6f 73 74 82 0b 2a 2e 6c 6f 63 61 6c 68 alhost..*.localh
[13024.221462] [tempesta tls] 00000150: 6f 73 74 82 06 73 33 2e 6c 61 6e 82 08 2a 2e 73 ost..s3.lan..*.s
[13024.222707] [tempesta tls] 00000160: 33 2e 6c 61 6e 30 0a 06 08 2a 86 48 ce 3d 04 03 3.lan0...*.H.=..
[13024.223522] [tempesta tls] 00000170: 02 03 49 00 30 46 02 21 00 e8 f9 d1 0c 74 58 22 ..I.0F.!.....tX"
[13024.224408] [tempesta tls] 00000180: 1c 75 4d 31 36 8b d7 f9 65 bf b1 cc 94 ef 94 40 .uM16...e......@
[13024.225215] [tempesta tls] 00000190: 25 c1 af f1 3d 58 a0 81 e2 02 21 00 af fd 68 86 %...=X....!...h.
[13024.226016] [tempesta tls] 000001a0: 44 30 81 92 e5 11 71 65 6a 9d 18 25 55 f5 ca 3f D0....qej..%U..?
[13024.226823] [tempesta tls] 000001b0: 42 43 92 83 0b ce 5a 62 b8 bf 97 e1 BC....Zb....
[13024.227610] [tempesta tls] use record hdr: type=22 ver=3:3 hdr_len=451
[13024.228251] [tempesta tls] enter TLS Server Handshake (ServerHello) FSM at state 0x3000000(TTLS_SERVER_KEY_EXCHANGE)
[13024.229197] [tempesta tls] ECDHE curve: secp256r1
[13024.229905] [tempesta tls] ECDH server key exchange EC point
[13024.230577] [tempesta tls] pick sign:hash algorithms 4:2 for signing
[13024.231314] [tempesta tls] dump 'parameters hash' (ptr=(einval), 48 bytes):
[13024.232127] [tempesta tls] 00000000: dc fd 64 6d 7b f1 c2 ec 9d dc 89 b3 91 a8 85 bb ..dm{...........
[13024.233079] [tempesta tls] 00000010: 0e f4 89 aa f3 3f 40 e2 f5 f3 84 2d 44 b7 fe a2 .....?@....-D...
[13024.233960] [tempesta tls] 00000020: d6 45 d7 49 d5 be 7e 6d 6c 2a ad c5 0e 4d 4b ff .E.I..~ml*...MK.
[13024.234805] [tempesta tls] dump 'my signature' (ptr=(einval), 70 bytes):
[13024.235456] [tempesta tls] 00000000: 30 44 02 20 57 e9 77 f6 db 7e 33 c3 fe 7a cf 28 0D. W.w..~3..z.(
[13024.236279] [tempesta tls] 00000010: 42 ed 98 70 09 ca f5 6d 45 86 82 fc a4 47 b7 d3 B..p...mE....G..
[13024.237097] [tempesta tls] 00000020: d7 62 ab 34 02 20 09 1f b1 d0 b2 05 9a 45 c7 e2 .b.4. .......E..
[13024.238312] [tempesta tls] 00000030: 9f 59 c4 2e c7 71 26 24 ec 4c 30 95 e7 37 10 3a .Y...q&$.L0..7.:
[13024.239130] [tempesta tls] 00000040: 6d e2 84 b0 5c 9c m...\.
[13024.239963] [tempesta tls] dump 'Write handshake header' (ptr=(einval), 4 bytes):
[13024.240707] [tempesta tls] 00000000: 0c 00 00 8f ....
[13024.241470] [tempesta tls] write record: type=22 len=147 hslen=0 sgt= pK-error/4 sg_i=3 ready=0
[13024.242407] [tempesta tls] update checksum on buf pK-error len=147, hash=1
[13024.243120] [tempesta tls] dump 'hash buf ' (ptr=(einval), 147 bytes):
[13024.243824] [tempesta tls] 00000000: 0c 00 00 8f 03 00 17 41 04 57 e9 77 f6 db 7e 33 .......A.W.w..~3
[13024.244737] [tempesta tls] 00000010: c3 fe 7a cf 28 42 ed 98 70 09 ca f5 6d 45 86 82 ..z.(B..p...mE..
[13024.245602] [tempesta tls] 00000020: fc a4 47 b7 d3 d7 62 ab 34 c5 ab 37 70 ba 57 3b ..G...b.4..7p.W;
[13024.246409] [tempesta tls] 00000030: df f5 41 40 65 64 0f fb 5b 34 6d fa 84 de c4 db ..A@ed..[4m.....
[13024.247241] [tempesta tls] 00000040: 4d 68 e5 f5 9c c4 71 c2 ec 05 03 00 46 30 44 02 Mh....q.....F0D.
[13024.248092] [tempesta tls] 00000050: 20 57 e9 77 f6 db 7e 33 c3 fe 7a cf 28 42 ed 98 W.w..~3..z.(B..
[13024.248956] [tempesta tls] 00000060: 70 09 ca f5 6d 45 86 82 fc a4 47 b7 d3 d7 62 ab p...mE....G...b.
[13024.249820] [tempesta tls] 00000070: 34 02 20 09 1f b1 d0 b2 05 9a 45 c7 e2 9f 59 c4 4. .......E...Y.
[13024.250679] [tempesta tls] 00000080: 2e c7 71 26 24 ec 4c 30 95 e7 37 10 3a 6d e2 84 ..q&$.L0..7.:m..
[13024.251539] [tempesta tls] 00000090: b0 5c 9c .\.
[13024.252480] [tempesta tls] use record hdr: type=22 ver=3:3 hdr_len=147
[13024.253165] [tempesta tls] enter TLS Server Handshake (ServerHello) FSM at state 0x5000000(TTLS_SERVER_HELLO_DONE)
[13024.254435] [tempesta tls] sending ServerHelloDone
[13024.254980] [tempesta tls] dump 'Write handshake header' (ptr=(einval), 4 bytes):
[13024.255725] [tempesta tls] 00000000: 0e 00 00 00 ....
[13024.256568] [tempesta tls] write record: type=22 len=4 hslen=0 sgt= pK-error/5 sg_i=4 ready=0
[13024.257412] [tempesta tls] update checksum on buf pK-error len=4, hash=1
[13024.258216] [tempesta tls] dump 'hash buf ' (ptr=(einval), 4 bytes):
[13024.258883] [tempesta tls] 00000000: 0e 00 00 00 ....
[13024.259651] [tempesta tls] use record hdr: type=22 ver=3:3 hdr_len=4
[13024.260308] [tempesta fw] TLS 5 bytes +5 segments (4 bytes, last msgtype 0x16) are to be sent on conn= pK-error/sk_write_xmit= pK-error ready=0
[13024.261648] [tempesta fw] fill skb frag 0 by pK-error,len=100,flags=0 in skb= pK-error,len=105
[13024.262713] [tempesta fw] fill skb frag 1 by pK-error,len=12,flags=0 in skb= pK-error,len=117
[13024.263647] [tempesta fw] fill skb frag 2 by pK-error,len=444,flags=0 in skb= pK-error,len=561
[13024.264745] [tempesta fw] fill skb frag 3 by pK-error,len=152,flags=0 in skb= pK-error,len=713
[13024.265666] [tempesta fw] fill skb frag 4 by pK-error,len=9,flags=2 in skb= pK-error,len=722
[13024.266573] [tempesta fw] [1]: ss_send: sk=000000004a3e83a1 (cpu=1) state=Established
[13024.267351] [tempesta fw] tfw_tls_connection_recv: parsed=517 skb->len=517
[13024.268923] [tempesta fw] [1]: ss_do_send: sk= pK-error queue_empty=1 send_head= pK-error sk_state=1 mss=1448 size=31856
[13024.272982] [tempesta fw] [1]: ss_do_send: entail sk= pK-error skb= pK-error data_len=717 len=722 truesize=1613 mark=0 tls_type=0
[13024.274614] [tempesta fw] [1]: ss_do_send: sk=000000004a3e83a1 send_head=0000000005eccd1a sk_state=1 flags=0
[13024.276629] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13024.277437] [tempesta tls] ttls_recv: tls= pK-error len=62 read=0
[13024.278122] [tempesta tls] input rec: type=22 ver=3:3 msglen=70 read=5 xfrm_ready=0
[13024.278859] [tempesta tls] handshake message: msglen=70 type=16 hslen=66 read=9
[13024.279558] [tempesta tls] handshake message 22 on state 7000000
[13024.280217] [tempesta tls] server state: 7000000
[13024.280763] [tempesta tls] enter TLS Server Handshake FSM at state 0x7000000(TTLS_CLIENT_KEY_EXCHANGE)
[13024.281652] [tempesta tls] update checksum on buf pK-error len=57, hash=1
[13024.282523] [tempesta tls] dump 'hash buf ' (ptr=(einval), 57 bytes):
[13024.283228] [tempesta tls] 00000000: 10 00 00 42 41 04 10 1d db 61 14 5b 18 ac 0f 7a ...BA....a.[...z
[13024.284111] [tempesta tls] 00000010: 41 52 cc e8 0c cb b2 03 f7 d7 36 ac 38 42 81 78 AR........6.8B.x
[13024.285032] [tempesta tls] 00000020: b2 bb 9b 1a a8 b1 09 91 73 a6 d9 ba 58 c3 1c a4 ........s...X...
[13024.285914] [tempesta tls] 00000030: e3 20 43 94 cc bc 2c 42 87 . C...,B.
[13024.287122] [tempesta tls] ttls_recv: tls= pK-error len=64 read=0
[13024.288018] [tempesta tls] handshake message 22 on state 7000000
[13024.288741] [tempesta tls] server state: 7000000
[13024.289341] [tempesta tls] enter TLS Server Handshake FSM at state 0x7000000(TTLS_CLIENT_KEY_EXCHANGE)
[13024.290229] [tempesta tls] update checksum on buf pK-error len=13, hash=1
[13024.290988] [tempesta tls] dump 'hash buf ' (ptr=(einval), 13 bytes):
[13024.291693] [tempesta tls] 00000000: 2a 88 b0 a4 fa 45 c5 ea f7 97 45 4e 13 *....E....EN.
[13024.292844] ECDH client key exchange EC point00000000: b1 a8 1a 9b bb b2 78 81 42 38 ac 36 d7 f7 03 b2 ......x.B8.6....
[13024.294012] ECDH client key exchange EC point00000010: cb 0c e8 cc 52 41 7a 0f ac 18 5b 14 61 db 1d 10 ....RAz...[.a...
[13024.295107] ECDH client key exchange EC point00000020: 13 4e 45 97 f7 ea c5 45 fa a4 b0 88 2a 87 42 2c .NE....E....*.B,
[13024.296135] ECDH client key exchange EC point00000030: bc cc 94 43 20 e3 a4 1c c3 58 ba d9 a6 73 91 09 ...C ....X...s..
[13024.297182] [tempesta tls] ECDH client key exchange
[13024.297790] [tempesta tls] dump 'premaster secret' (ptr=(einval), 32 bytes):
[13024.298501] [tempesta tls] 00000000: 16 f4 9c 33 eb 32 54 73 4b 5d a9 04 3c 56 ec 50 ...3.2TsK]..<V.P
[13024.299353] [tempesta tls] 00000010: 87 b1 83 e5 5c e2 d6 3e 96 e0 f6 17 11 a5 27 d5 ....\..>......'.
[13024.300201] [tempesta tls] dump 'calculated verify sha256 result' (ptr=(einval), 32 bytes):
[13024.300979] [tempesta tls] 00000000: a9 02 4d e6 a9 e6 bf 9d 35 ec b5 f8 fc 8c 6f 14 ..M.....5.....o.
[13024.301860] [tempesta tls] 00000010: 11 43 1f 60 78 bf cc 72 9e 6f bd 28 0d 96 44 db .C.`x..r.o.(..D.
[13024.303087] [tempesta tls] ciphersuite = TLS-ECDHE-ECDSA-WITH-AES-128-GCM-SHA256
[13024.303806] [tempesta tls] dump 'master secret' (ptr=(einval), 48 bytes):
[13024.304670] [tempesta tls] 00000000: 0b 51 72 96 6f a4 84 31 c1 7c 7d 6b f1 7d fd de .Qr.o..1.|}k.}..
[13024.305589] [tempesta tls] 00000010: 93 6f fb 9b 9a 5e fb bc 9b ee 71 b2 59 1e 1a d0 .o...^....q.Y...
[13024.306480] [tempesta tls] 00000020: 6f ad bf a6 11 35 f2 8d ed 9d 37 c3 af 8a 3e 73 o....5....7...>s
[13024.307364] [tempesta tls] dump 'random bytes' (ptr=(einval), 64 bytes):
[13024.308083] [tempesta tls] 00000000: 00 00 00 09 55 55 55 55 55 55 55 55 55 55 55 55 ....UUUUUUUUUUUU
[13024.308986] [tempesta tls] 00000010: 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 55 UUUUUUUUUUUUUUUU
[13024.309907] [tempesta tls] 00000020: fc e6 97 17 d3 1e be b4 c9 21 de 5d 83 fa 89 95 .........!.]....
[13024.310807] [tempesta tls] 00000030: 0e de 8c fe a1 fc df 4a 31 16 e7 6a 0b 75 8e d9 .......J1..j.u..
[13024.311655] [tempesta tls] dump 'key block' (ptr=(einval), 256 bytes):
[13024.312512] [tempesta tls] 00000000: 12 d7 a2 63 77 29 48 ae fd 96 37 8d 67 0f df 73 ...cw)H...7.g..s
[13024.313363] [tempesta tls] 00000010: 99 22 22 1b 5a ba a3 96 74 e3 68 6d be d6 bb 0e ."".Z...t.hm....
[13024.314191] [tempesta tls] 00000020: ab dc 2e 71 ca 8b e2 74 c6 71 8e 1e 35 15 88 1e ...q...t.q..5...
[13024.315022] [tempesta tls] 00000030: c0 aa 27 43 8e 4a cd c3 64 01 9e 40 01 58 bf 07 ..'C.J..d..@.X..
[13024.315844] [tempesta tls] 00000040: 33 45 f5 ef 9f 55 15 71 9c 2f b7 e5 b2 d3 ab d8 3E...U.q./......
[13024.316672] [tempesta tls] 00000050: aa b7 1a 85 26 dc ac 84 97 cb 35 92 2c a7 29 14 ....&.....5.,.).
[13024.317487] [tempesta tls] 00000060: 81 75 f3 bd cc 33 d2 ef 12 e9 7b de 68 d9 f1 30 .u...3....{.h..0
[13024.318301] [tempesta tls] 00000070: 3e 7a a6 c7 b9 b9 46 97 0a 4f 08 5f 5c 51 07 1e >z....F..O._\Q..
[13024.319401] [tempesta tls] 00000080: 60 66 d3 3c 64 19 df 1a 3e 13 e8 34 72 0e cc 01 `f.<d...>..4r...
[13024.320412] [tempesta tls] 00000090: 02 90 e1 19 91 1d 7d b9 b8 f0 48 59 e4 fa ee f2 ......}...HY....
[13024.321310] [tempesta tls] 000000a0: 96 e1 42 77 d5 90 2b 48 2f 69 e3 df 07 70 8d 16 ..Bw..+H/i...p..
[13024.322309] [tempesta tls] 000000b0: 78 30 1f bc d9 bb b3 fc 13 34 09 6b d9 60 10 15 x0.......4.k.`..
[13024.323201] [tempesta tls] 000000c0: c1 2d 15 5c d4 3c bf 30 d5 28 4a 05 01 a6 a6 20 .-.\.<.0.(J....
[13024.324199] [tempesta tls] 000000d0: 9a e9 c5 51 1f 3b f2 2f 29 eb 51 66 7e d6 b7 ad ...Q.;./).Qf~...
[13024.325112] [tempesta tls] 000000e0: c1 9e 02 a2 da f7 0b ac f0 fd b6 33 e4 9c d6 7e ...........3...~
[13024.326167] [tempesta tls] 000000f0: b0 15 9e a5 c9 6b 7f 98 3c 73 7d 39 80 83 ea 39 .....k..<s}9...9
[13024.327016] [tempesta tls] keylen=16 minlen=24 ivlen=12 maclen=0 mac_key_len=0
[13024.327695] [tempesta tls] dump 'derive keys: IV_enc fixed' (ptr=(einval), 4 bytes):
[13024.328488] [tempesta tls] 00000000: ca 8b e2 74 ...t
[13024.329258] [tempesta tls] dump 'derive keys: key_enc' (ptr=(einval), 16 bytes):
[13024.329956] [tempesta tls] 00000000: 99 22 22 1b 5a ba a3 96 74 e3 68 6d be d6 bb 0e ."".Z...t.hm....
[13024.330772] [tempesta tls] dump 'derive keys: IV_dec fixed' (ptr=(einval), 4 bytes):
[13024.331492] [tempesta tls] 00000000: ab dc 2e 71 ...q
[13024.332417] [tempesta tls] dump 'derive keys: key_dec' (ptr=(einval), 16 bytes):
[13024.333117] [tempesta tls] 00000000: 12 d7 a2 63 77 29 48 ae fd 96 37 8d 67 0f df 73 ...cw)H...7.g..s
[13024.333945] [tempesta tls] skip parse certificate verify
[13024.334509] [tempesta fw] tfw_tls_connection_recv: parsed=75 skb->len=126
[13024.335605] [tempesta tls] ttls_recv: tls= pK-error len=51 read=0
[13024.336397] [tempesta tls] input rec: type=20 ver=3:3 msglen=1 read=5 xfrm_ready=0
[13024.337522] [tempesta tls] change cipher spec message: msglen=1 type=1 hslen=0 read=6
[13024.338354] [tempesta tls] handshake message 20 on state 9000000
[13024.338976] [tempesta tls] server state: 9000000
[13024.339505] [tempesta tls] enter TLS Server Handshake FSM at state 0x9000000(TTLS_CLIENT_CHANGE_CIPHER_SPEC)
[13024.340352] [tempesta fw] tfw_tls_connection_recv: parsed=6 skb->len=51
[13024.341004] [tempesta tls] ttls_recv: tls= pK-error len=45 read=0
[13024.341657] [tempesta tls] input rec: type=22 ver=3:3 msglen=40 read=5 xfrm_ready=1
[13024.342520] [tempesta tls] handshake message 22 on state a000000
[13024.343132] [tempesta tls] server state: a000000
[13024.343646] [tempesta tls] enter TLS Server Handshake FSM at state 0xa000000(TTLS_CLIENT_FINISHED)
[13024.344433] [tempesta tls] ttls_parse_finished: msglen=40(rlen=0 len=32)
[13024.345076] [tempesta tls] dump 'Client finished msg body' (ptr=(einval), 32 bytes):
[13024.345788] [tempesta tls] 00000000: f8 4b f7 57 c2 9f d6 a0 23 1d fe 18 76 4e 4d 1b .K.W....#...vNM.
[13024.346597] [tempesta tls] 00000010: 16 26 28 6a 73 6b ef 89 e6 63 2b 91 10 3e e4 98 .&(jsk...c+..>..
[13024.347403] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=40 chunks=1 eiv_len=8
[13024.348247] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=32 sgn=2
[13024.349449] [tempesta tls] use record hdr: type=22 ver=3:3 hdr_len=16
[13024.350132] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.351277] [tempesta tls] 00000000: 00 00 00 00 00 00 00 00 16 03 03 00 10 .............
[13024.352352] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.353054] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 cd ...q.d.X....
[13024.354020] [tempesta tls] decrypt: AAD|msg|TAG (sgn=2 sglist= pK-error len=45):
[13024.354944] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.355598] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.356444] [tempesta tls] 00000000: 00 00 00 00 00 00 00 00 16 03 03 00 10 .............
[13024.357320] [tempesta tls] => segment 1, ptr= pK-error len=32
[13024.358085] [tempesta tls] dump 'data' (ptr=(einval), 32 bytes):
[13024.358829] [tempesta tls] 00000000: f8 4b f7 57 c2 9f d6 a0 23 1d fe 18 76 4e 4d 1b .K.W....#...vNM.
[13024.359667] [tempesta tls] 00000010: 16 26 28 6a 73 6b ef 89 e6 63 2b 91 10 3e e4 98 .&(jsk...c+..>..
[13024.360649] [tempesta tls] raw buffer after decryption (sgn=1 sglist= pK-error len=16):
[13024.361461] [tempesta tls] => segment 0, ptr= pK-error len=32
[13024.362289] [tempesta tls] dump 'data' (ptr=(einval), 16 bytes):
[13024.362934] [tempesta tls] 00000000: 14 00 00 0c a5 f6 57 9b d4 97 e3 52 24 60 b6 9e ......W....R$`..
[13024.363760] [tempesta tls] dump 'finished sha256 state' (ptr=(einval), 32 bytes):
[13024.364493] [tempesta tls] 00000000: de 21 f7 e3 57 00 25 86 4e 65 d7 1c a7 75 21 88 .!..W.%.Ne...u!.
[13024.365321] [tempesta tls] 00000010: bb 41 e6 15 bb 7e b3 e3 e8 e2 ca dc 9b 40 f0 19 .A...~.......@..
[13024.366152] [tempesta tls] dump 'calc finished sha256 result' (ptr=(einval), 12 bytes):
[13024.367274] [tempesta tls] 00000000: a5 f6 57 9b d4 97 e3 52 24 60 b6 9e ..W....R$`..
[13024.368088] [tempesta tls] update checksum on buf pK-error len=16, hash=1
[13024.369028] [tempesta tls] dump 'hash buf ' (ptr=(einval), 16 bytes):
[13024.369728] [tempesta tls] 00000000: 14 00 00 0c a5 f6 57 9b d4 97 e3 52 24 60 b6 9e ......W....R$`..
[13024.370555] [tempesta tls] enter TLS Server Handshake FSM at state 0xb000000(TTLS_SERVER_CHANGE_CIPHER_SPEC)
[13024.371402] [tempesta tls] enter TLS Server Handshake (Finish) FSM at state 0xb000000(TTLS_SERVER_CHANGE_CIPHER_SPEC)
[13024.372472] [tempesta tls] write record: type=20 len=1 hslen=1 sgt= pK-error/0 sg_i=0 ready=0
[13024.373265] [tempesta tls] use record hdr: type=20 ver=3:3 hdr_len=1
[13024.373922] [tempesta tls] enter TLS Server Handshake (Finish) FSM at state 0xc000000(TTLS_SERVER_FINISHED)
[13024.374768] [tempesta tls] dump 'Write handshake header' (ptr=(einval), 4 bytes):
[13024.375490] [tempesta tls] 00000000: 14 00 00 0c ....
[13024.376290] [tempesta tls] dump 'finished sha256 state' (ptr=(einval), 32 bytes):
[13024.377013] [tempesta tls] 00000000: de 21 f7 e3 57 00 25 86 4e 65 d7 1c a7 75 21 88 .!..W.%.Ne...u!.
[13024.377849] [tempesta tls] 00000010: bb 41 e6 15 bb 7e b3 e3 e8 e2 ca dc 9b 40 f0 19 .A...~.......@..
[13024.378694] [tempesta tls] dump 'calc finished sha256 result' (ptr=(einval), 12 bytes):
[13024.379446] [tempesta tls] 00000000: d3 74 5b 61 80 3e b1 6d 60 01 e3 02 .t[a.>.m`...
[13024.380272] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.380929] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 00 ...t........
[13024.381747] [tempesta tls] use record hdr: type=22 ver=3:3 hdr_len=16
[13024.382581] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.383496] [tempesta tls] 00000000: 00 00 00 00 00 00 00 00 16 03 03 00 10 .............
[13024.384412] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=16
[13024.385943] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=1 sglist= pK-error len=45):
[13024.386868] [tempesta tls] => segment 0, ptr= pK-error len=45
[13024.387562] [tempesta tls] dump 'data' (ptr=(einval), 45 bytes):
[13024.388251] [tempesta tls] 00000000: 00 00 00 00 00 00 00 00 16 03 03 00 10 14 00 00 ................
[13024.389102] [tempesta tls] 00000010: 0c d3 74 5b 61 80 3e b1 6d 60 01 e3 02 9f ff ff ..t[a.>.m`......
[13024.389951] [tempesta tls] 00000020: e9 2d 51 67 d8 0b 00 00 4e 00 00 00 00 .-Qg....N....
[13024.390774] [tempesta tls] encrypted buf (first 64 bytes) (sgn=1 sglist= pK-error len=45):
[13024.391581] [tempesta tls] => segment 0, ptr= pK-error len=45
[13024.392447] [tempesta tls] dump 'data' (ptr=(einval), 45 bytes):
[13024.393087] [tempesta tls] 00000000: 00 00 00 00 00 00 00 00 16 03 03 00 10 89 0f 25 ...............%
[13024.393921] [tempesta tls] 00000010: b2 99 35 23 bc 6b bb d7 8e a2 80 dd 98 9c 02 c3 ..5#.k..........
[13024.394754] [tempesta tls] 00000020: a4 cf de 4b 91 54 26 d1 49 8b 30 6b d0 ...K.T&.I.0k.
[13024.395573] [tempesta tls] write record hdr from AAD: type=22 ver=3:3 hdr_len=40
[13024.396309] [tempesta tls] Finish TLS Server Handshake (Finish) FSM at state 0xc000000, ret=0
[13024.397095] [tempesta fw] TLS 6 bytes +1 segments (40 bytes, last msgtype 0x16) are to be sent on conn= pK-error/sk_write_xmit= pK-error ready=1
[13024.398443] [tempesta fw] fill skb frag 0 by pK-error,len=45,flags=2 in skb= pK-error,len=51
[13024.399685] [tempesta fw] [1]: ss_send: sk=000000004a3e83a1 (cpu=1) state=Established
[13024.400463] [tempesta tls] enter TLS Server Handshake FSM at state 0xd000000(TTLS_HANDSHAKE_WRAPUP)
[13024.401461] [tempesta tls] enter TLS Server Handshake FSM at state 0xe000000(TTLS_HANDSHAKE_OVER)
[13024.402465] [tempesta tls] Finish TLS Server Handshake FSM at state 0xe000000, ret=0
[13024.403210] [tempesta fw] tfw_tls_connection_recv: parsed=45 skb->len=45
[13024.404687] [tempesta fw] [1]: ss_do_send: sk= pK-error queue_empty=1 send_head= pK-error sk_state=1 mss=1448 size=31856
[13024.405961] [tempesta fw] [1]: ss_do_send: entail sk= pK-error skb= pK-error data_len=45 len=51 truesize=941 mark=0 tls_type=0
[13024.407266] [tempesta fw] [1]: ss_do_send: sk=000000004a3e83a1 send_head=0000000055f471a6 sk_state=1 flags=0
[13024.408559] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13024.409348] [tempesta tls] ttls_recv: tls= pK-error len=53 read=0
[13024.410058] [tempesta tls] input rec: type=23 ver=3:3 msglen=48 read=5 xfrm_ready=1
[13024.410812] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=48 chunks=1 eiv_len=8
[13024.411693] [tempesta tls] build req sglist: skb= pK-error next= pK-error len=53 off=13
[13024.412719] [tempesta tls] build req sglist (sgn=1 sglist= pK-error len=40):
[13024.413521] [tempesta tls] => segment 0, ptr= pK-error len=40
[13024.414237] [tempesta tls] dump 'data' (ptr=(einval), 40 bytes):
[13024.415237] [tempesta tls] 00000000: 05 ac 40 f3 7d b1 53 e2 0f a2 47 e5 3d 35 8e 6a ..@.}.S...G.=5.j
[13024.416411] [tempesta tls] 00000010: 89 c2 87 ce a5 2a 0d aa 2a 22 e2 c2 58 f1 a1 d8 .....*..*"..X...
[13024.417442] [tempesta tls] 00000020: 1c d9 7e 7f 04 24 2a 9d ..~..$*.
[13024.418502] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=0 sgn=2
[13024.419785] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=24
[13024.420519] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.421337] [tempesta tls] 00000000: 00 00 00 00 00 00 00 01 17 03 03 00 18 .............
[13024.422483] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.423296] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 ce ...q.d.X....
[13024.424208] [tempesta tls] decrypt: AAD|msg|TAG (sgn=2 sglist= pK-error len=53):
[13024.425007] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.425682] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.426347] [tempesta tls] 00000000: 00 00 00 00 00 00 00 01 17 03 03 00 18 .............
[13024.427174] [tempesta tls] => segment 1, ptr= pK-error len=40
[13024.427843] [tempesta tls] dump 'data' (ptr=(einval), 40 bytes):
[13024.428506] [tempesta tls] 00000000: 05 ac 40 f3 7d b1 53 e2 0f a2 47 e5 3d 35 8e 6a ..@.}.S...G.=5.j
[13024.429350] [tempesta tls] 00000010: 89 c2 87 ce a5 2a 0d aa 2a 22 e2 c2 58 f1 a1 d8 .....*..*"..X...
[13024.430192] [tempesta tls] 00000020: 1c d9 7e 7f 04 24 2a 9d ..~..$*.
[13024.431351] [tempesta tls] raw buffer after decryption (sgn=1 sglist= pK-error len=24):
[13024.432327] [tempesta tls] => segment 0, ptr= pK-error len=40
[13024.433006] [tempesta tls] dump 'data' (ptr=(einval), 24 bytes):
[13024.433677] [tempesta tls] 00000000: 50 52 49 20 2a 20 48 54 54 50 2f 32 2e 30 0d 0a PRI * HTTP/2.0..
[13024.434546] [tempesta tls] 00000010: 0d 0a 53 4d 0d 0a 0d 0a ..SM....
[13024.435354] [tempesta fw] tfw_tls_connection_recv: parsed=53 skb->len=53
[13024.436050] [tempesta fw] ss_skb_chop_head_tail: head=0xd trail=0x10 skb= pK-error (head= pK-error data= pK-error tail= pK-error end= pK-error len=53 data_len=0 nr_frags=0)
[13024.437695] [tempesta fw] TLS 21 bytes (45 bytes, type 0x17) are to be sent on conn= pK-error/sk_write_xmit= pK-error ready=1
[13024.438967] [tempesta fw] [1]: ss_send: sk=000000004a3e83a1 (cpu=1) state=Established
[13024.439723] [tempesta fw] TLS 13 bytes (45 bytes, type 0x17) are to be sent on conn= pK-error/sk_write_xmit= pK-error ready=1
[13024.441022] [tempesta fw] [1]: ss_send: sk=000000004a3e83a1 (cpu=1) state=Established
[13024.441842] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13024.442632] [tempesta tls] ttls_recv: tls= pK-error len=56 read=0
[13024.443333] [tempesta tls] input rec: type=23 ver=3:3 msglen=51 read=5 xfrm_ready=1
[13024.444084] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=51 chunks=1 eiv_len=8
[13024.444994] [tempesta tls] build req sglist: skb= pK-error next= pK-error len=56 off=13
[13024.445993] [tempesta tls] build req sglist (sgn=1 sglist= pK-error len=43):
[13024.447335] [tempesta tls] => segment 0, ptr= pK-error len=43
[13024.448143] [tempesta tls] dump 'data' (ptr=(einval), 43 bytes):
[13024.448987] [tempesta tls] 00000000: 47 97 50 90 0a a1 9a 73 48 2c ed 7e 13 a6 76 b9 G.P....sH,.~..v.
[13024.450065] [tempesta tls] 00000010: bb 20 e4 e2 7f be 15 fe cd 87 f3 3c 70 9b 7e e0 . .........<p.~.
[13024.451101] [tempesta tls] 00000020: 21 74 6c 2e 3b 42 c0 0b 8b b0 2d !tl.;B....-
[13024.452061] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=0 sgn=2
[13024.453325] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=27
[13024.454007] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.454784] [tempesta tls] 00000000: 00 00 00 00 00 00 00 02 17 03 03 00 1b .............
[13024.455626] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.456309] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 cf ...q.d.X....
[13024.457143] [tempesta tls] decrypt: AAD|msg|TAG (sgn=2 sglist= pK-error len=56):
[13024.457906] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.458577] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.459252] [tempesta tls] 00000000: 00 00 00 00 00 00 00 02 17 03 03 00 1b .............
[13024.460093] [tempesta tls] => segment 1, ptr= pK-error len=43
[13024.460783] [tempesta tls] dump 'data' (ptr=(einval), 43 bytes):
[13024.461430] [tempesta tls] 00000000: 47 97 50 90 0a a1 9a 73 48 2c ed 7e 13 a6 76 b9 G.P....sH,.~..v.
[13024.462450] [tempesta tls] 00000010: bb 20 e4 e2 7f be 15 fe cd 87 f3 3c 70 9b 7e e0 . .........<p.~.
[13024.463606] [tempesta tls] 00000020: 21 74 6c 2e 3b 42 c0 0b 8b b0 2d !tl.;B....-
[13024.464455] [tempesta tls] raw buffer after decryption (sgn=1 sglist= pK-error len=27):
[13024.465258] [tempesta tls] => segment 0, ptr= pK-error len=43
[13024.465952] [tempesta tls] dump 'data' (ptr=(einval), 27 bytes):
[13024.466641] [tempesta tls] 00000000: 00 00 12 04 00 00 00 00 00 00 03 00 00 00 64 00 ..............d.
[13024.467495] [tempesta tls] 00000010: 04 02 00 00 00 00 02 00 00 00 00 ...........
[13024.468329] [tempesta fw] tfw_tls_connection_recv: parsed=56 skb->len=56
[13024.469019] [tempesta fw] ss_skb_chop_head_tail: head=0xd trail=0x10 skb= pK-error (head= pK-error data= pK-error tail= pK-error end= pK-error len=56 data_len=0 nr_frags=0)
[13024.470660] [tempesta fw] TLS 9 bytes (45 bytes, type 0x17) are to be sent on conn= pK-error/sk_write_xmit= pK-error ready=1
[13024.472050] [tempesta fw] [1]: ss_send: sk=000000004a3e83a1 (cpu=1) state=Established
[13024.472860] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13024.473649] [tempesta tls] ttls_recv: tls= pK-error len=42 read=0
[13024.474357] [tempesta tls] input rec: type=23 ver=3:3 msglen=37 read=5 xfrm_ready=1
[13024.475114] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=37 chunks=1 eiv_len=8
[13024.476008] [tempesta tls] build req sglist: skb= pK-error next= pK-error len=42 off=13
[13024.476887] [tempesta tls] build req sglist (sgn=1 sglist= pK-error len=29):
[13024.477743] [tempesta tls] => segment 0, ptr= pK-error len=29
[13024.478370] [tempesta tls] dump 'data' (ptr=(einval), 29 bytes):
[13024.479458] [tempesta tls] 00000000: e7 15 d8 df 1c 32 86 0a 78 d4 96 c6 b2 f6 64 9c .....2..x.....d.
[13024.480345] [tempesta tls] 00000010: 64 91 11 bb 4c 69 5d 60 8b d6 dd 5e 1f d...Li]`...^.
[13024.481330] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=0 sgn=2
[13024.483263] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=13
[13024.484015] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.484802] [tempesta tls] 00000000: 00 00 00 00 00 00 00 03 17 03 03 00 0d .............
[13024.485619] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.486277] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 d0 ...q.d.X....
[13024.487090] [tempesta tls] decrypt: AAD|msg|TAG (sgn=2 sglist= pK-error len=42):
[13024.487842] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.488522] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.489156] [tempesta tls] 00000000: 00 00 00 00 00 00 00 03 17 03 03 00 0d .............
[13024.490012] [tempesta tls] => segment 1, ptr= pK-error len=29
[13024.490782] [tempesta tls] dump 'data' (ptr=(einval), 29 bytes):
[13024.491484] [tempesta tls] 00000000: e7 15 d8 df 1c 32 86 0a 78 d4 96 c6 b2 f6 64 9c .....2..x.....d.
[13024.492488] [tempesta tls] 00000010: 64 91 11 bb 4c 69 5d 60 8b d6 dd 5e 1f d...Li]`...^.
[13024.493289] [tempesta tls] raw buffer after decryption (sgn=1 sglist= pK-error len=13):
[13024.494033] [tempesta tls] => segment 0, ptr= pK-error len=29
[13024.494675] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.495400] [tempesta tls] 00000000: 00 00 04 08 00 00 00 00 00 01 ff 00 01 .............
[13024.496173] [tempesta fw] tfw_tls_connection_recv: parsed=42 skb->len=42
[13024.496817] [tempesta fw] ss_skb_chop_head_tail: head=0xd trail=0x10 skb= pK-error (head= pK-error data= pK-error tail= pK-error end= pK-error len=42 data_len=0 nr_frags=0)
[13024.498578] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13024.499354] [tempesta tls] ttls_recv: tls= pK-error len=62 read=0
[13024.500048] [tempesta tls] input rec: type=23 ver=3:3 msglen=65 read=5 xfrm_ready=1
[13024.500778] [tempesta tls] ttls_recv: tls= pK-error len=8 read=0
[13024.501423] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=65 chunks=2 eiv_len=8
[13024.502418] [tempesta tls] build req sglist: skb= pK-error next= pK-error len=70 off=13
[13024.503227] [tempesta tls] build req sglist (sgn=2 sglist= pK-error len=57):
[13024.503962] [tempesta tls] => segment 0, ptr= pK-error len=49
[13024.504629] [tempesta tls] dump 'data' (ptr=(einval), 49 bytes):
[13024.505241] [tempesta tls] 00000000: 7b 9f e1 2b e1 09 f7 ec eb 12 32 b4 f4 bc f3 e1 {..+......2.....
[13024.506054] [tempesta tls] 00000010: 39 61 be c4 1d 42 69 1f af bc 51 3b 9b 83 64 9a 9a...Bi...Q;..d.
[13024.506876] [tempesta tls] 00000020: 2c 41 27 17 a0 e6 6d 44 98 8d 11 b4 8e 7d 43 98 ,A'...mD.....}C.
[13024.508021] [tempesta tls] 00000030: 8f .
[13024.508790] [tempesta tls] => segment 1, ptr= pK-error len=8
[13024.509629] [tempesta tls] dump 'data' (ptr=(einval), 8 bytes):
[13024.510291] [tempesta tls] 00000000: 96 85 46 9c 68 48 ac ae ..F.hH..
[13024.511722] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=0 sgn=3
[13024.513323] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=41
[13024.514173] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.514985] [tempesta tls] 00000000: 00 00 00 00 00 00 00 04 17 03 03 00 29 ............)
[13024.515768] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.516403] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 d1 ...q.d.X....
[13024.517210] [tempesta tls] decrypt: AAD|msg|TAG (sgn=3 sglist= pK-error len=70):
[13024.517963] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.518586] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.519185] [tempesta tls] 00000000: 00 00 00 00 00 00 00 04 17 03 03 00 29 ............)
[13024.519971] [tempesta tls] => segment 1, ptr= pK-error len=49
[13024.520594] [tempesta tls] dump 'data' (ptr=(einval), 49 bytes):
[13024.521180] [tempesta tls] 00000000: 7b 9f e1 2b e1 09 f7 ec eb 12 32 b4 f4 bc f3 e1 {..+......2.....
[13024.522068] [tempesta tls] 00000010: 39 61 be c4 1d 42 69 1f af bc 51 3b 9b 83 64 9a 9a...Bi...Q;..d.
[13024.522874] [tempesta tls] 00000020: 2c 41 27 17 a0 e6 6d 44 98 8d 11 b4 8e 7d 43 98 ,A'...mD.....}C.
[13024.523658] [tempesta tls] 00000030: 8f .
[13024.524392] [tempesta tls] => segment 2, ptr= pK-error len=8
[13024.525000] [tempesta tls] dump 'data' (ptr=(einval), 8 bytes):
[13024.525612] [tempesta tls] 00000000: 96 85 46 9c 68 48 ac ae ..F.hH..
[13024.526405] [tempesta tls] raw buffer after decryption (sgn=2 sglist= pK-error len=41):
[13024.527583] [tempesta tls] => segment 0, ptr= pK-error len=49
[13024.528205] [tempesta tls] dump 'data' (ptr=(einval), 41 bytes):
[13024.528792] [tempesta tls] 00000000: 00 00 20 01 05 00 00 00 01 82 84 87 41 8c 49 69 .. .........A.Ii
[13024.529562] [tempesta tls] 00000010: ac a8 48 d6 49 49 3a e4 3d 3f 7a 88 25 b6 50 c3 ..H.II:.=?z.%.P.
[13024.530519] [tempesta tls] 00000020: ab bc 15 c1 53 03 2a 2f 2a ....S.*/*
[13024.531422] [tempesta fw] tfw_tls_connection_recv: parsed=70 skb->len=70
[13024.532452] [tempesta fw] ss_skb_chop_head_tail: head=0xd trail=0x10 skb= pK-error (head= pK-error data= pK-error tail= pK-error end= pK-error len=70 data_len=8 nr_frags=1)
[13024.534020] [tempesta fw] [1]: __split_pgfrag_del_w_frag: skb [000000003bba28a9] i [0] off [0] len [8] fragsize [8]
[13024.534864] [tempesta fw] ss_skb_chop_head_tail: head=0x9 trail=0x0 skb= pK-error (head= pK-error data= pK-error tail= pK-error end= pK-error len=41 data_len=0 nr_frags=0)
[13024.536496] [tempesta fw] Link new msg 00000000617964aa with connection 00000000ae2a04ec
[13024.537188] [tempesta fw] Add skb pK-error to message pK-error
[13024.537968] [tempesta fw] Received 32 client data bytes on conn=00000000ae2a04ec msg=00000000617964aa
[13024.538880] [tempesta fw] store header w/ ptr=0000000053197fa6 len=10 eolen=0 flags=2 id=0
[13024.539889] [tempesta fw] store header w/ ptr=000000009230114f len=6 eolen=0 flags=2 id=3
[13024.540747] [tempesta fw] store header w/ ptr=00000000de1bde4d len=12 eolen=0 flags=2 id=1
[13024.541578] [tempesta fw] tfw_h2_parse_req_hdr: fin=1, len=17, data=tempesta-tech.com, req=[00000000617964aa]
[13024.542651] [tempesta fw] enter FSM at state pK-error
[13024.543788] [tempesta fw] parser at Req_HdrPsAuthorityV: c=0x74(t), p_off=0
[13024.544465] [tempesta fw] enter FSM at state pK-error
[13024.545040] [tempesta fw] parser at Req_I_A_Start: c=0x74(t), p_off=0
[13024.545660] [tempesta fw] parser at Req_I_A: c=0x74(t), p_off=0
[13024.546543] [tempesta fw] parser at Req_I_A: c=0x65(e), p_off=1
[13024.547526] [tempesta fw] parser at Req_I_A: c=0x6d(m), p_off=2
[13024.548338] [tempesta fw] parser at Req_I_A: c=0x70(p), p_off=3
[13024.548970] [tempesta fw] parser at Req_I_A: c=0x65(e), p_off=4
[13024.549605] [tempesta fw] parser at Req_I_A: c=0x73(s), p_off=5
[13024.550214] [tempesta fw] parser at Req_I_A: c=0x74(t), p_off=6
[13024.550818] [tempesta fw] parser at Req_I_A: c=0x61(a), p_off=7
[13024.551418] [tempesta fw] parser at Req_I_A: c=0x2d(-), p_off=8
[13024.552205] [tempesta fw] parser at Req_I_A: c=0x74(t), p_off=9
[13024.552801] [tempesta fw] parser at Req_I_A: c=0x65(e), p_off=10
[13024.553398] [tempesta fw] parser at Req_I_A: c=0x63(c), p_off=11
[13024.553986] [tempesta fw] parser at Req_I_A: c=0x68(h), p_off=12
[13024.554568] [tempesta fw] parser at Req_I_A: c=0x2e(.), p_off=13
[13024.555146] [tempesta fw] parser at Req_I_A: c=0x63(c), p_off=14
[13024.555715] [tempesta fw] parser at Req_I_A: c=0x6f(o), p_off=15
[13024.556264] [tempesta fw] parser at Req_I_A: c=0x6d(m), p_off=16
[13024.556803] [tempesta fw] store field chunk len=17 data= pK-error(t) field=< pK-error,0x0,10, pK-error>
[13024.557805] [tempesta fw] parser: add chunk flags: 136
[13024.558295] [tempesta fw] tfw_h2_parse_req_hdr: parse header value, __h2_req_parse_authority: ret=0 data_len=17 hid=2
[13024.559474] [tempesta fw] tfw_h2_parse_req_hdr: complete header, state=Req_HdrPsAuthorityV, _hdr_tag=2, c=0x74, p='tempesta-tech.co', len=17, off=0
[13024.560615] [tempesta fw] store header w/ ptr=0000000001fb5ff8 len=27 eolen=0 flags=2 id=2
[13024.561321] [tempesta fw] tfw_h2_parse_req_hdr: fin=1, len=11, data=curl/7.81.0, req=[00000000617964aa]
[13024.562299] [tempesta fw] enter FSM at state pK-error
[13024.562884] [tempesta fw] parser at Req_HdrUser_AgentV: c=0x63(c), p_off=0
[13024.563553] [tempesta fw] enter FSM at state pK-error
[13024.564109] [tempesta fw] parser at Req_I_UserAgent: c=0x63(c), p_off=0
[13024.564745] [tempesta fw] tfw_h2_parse_req_hdr: parse header value, __h2_req_parse_user_agent: ret=0 data_len=11 hid=7
[13024.565611] [tempesta fw] store field chunk len=11 data= pK-error(c) field=< pK-error,0x0,10, pK-error>
[13024.566728] [tempesta fw] parser: add chunk flags: 128
[13024.567242] [tempesta fw] tfw_h2_parse_req_hdr: complete header, state=Req_HdrUser_AgentV, _hdr_tag=7, c=0x63, p='curl/7.81.0', len=11, off=0
[13024.568374] [tempesta fw] store header w/ ptr=00000000390a89a7 len=21 eolen=0 flags=2 id=7
[13024.569078] [tempesta fw] tfw_h2_parse_req_hdr: fin=1, len=3, data=*/*, req=[00000000617964aa]
[13024.569773] [tempesta fw] enter FSM at state pK-error
[13024.570415] [tempesta fw] parser at Req_HdrAcceptV: c=0x2a(*), p_off=0
[13024.571060] [tempesta fw] enter FSM at state pK-error
[13024.571664] [tempesta fw] parser at Req_I_WSAccept: c=0x2a(*), p_off=0
[13024.572540] [tempesta fw] parser at Req_I_Accept: c=0x2a(*), p_off=0
[13024.573185] [tempesta fw] parser at Req_I_AfterStar: c=0x2f(/), p_off=1
[13024.573824] [tempesta fw] parser at Req_I_StarSlashStar: c=0x2a(*), p_off=2
[13024.574474] [tempesta fw] tfw_h2_parse_req_hdr: parse header value, __h2_req_parse_accept: ret=0 data_len=3 hid=20
[13024.575480] [tempesta fw] store field chunk len=3 data= pK-error(*) field=< pK-error,0x0,6, pK-error>
[13024.576496] [tempesta fw] parser: add chunk flags: 128
[13024.576995] [tempesta fw] tfw_h2_parse_req_hdr: complete header, state=Req_HdrAcceptV, _hdr_tag=20, c=0x2a, p='*/*', len=3, off=0
[13024.578084] [tempesta fw] store header w/ ptr=00000000538086eb len=9 eolen=0 flags=2 id=20
[13024.578954] [tempesta fw] Request parsed: len=32 next= pK-error parsed=32 msg_len=32 ver=4 res=-1
[13024.579753] [tempesta fw] frang: check request for client 192.168.100.1, acc=0000000050f3e025
[13024.580502] [tempesta fw] frang: check incomplete request headers for client 192.168.100.1, acc=0000000050f3e025
[13024.581391] [tempesta fw] frang: check incomplete request body for client 192.168.100.1, acc=0000000050f3e025
[13024.582500] [tempesta fw] frang: checks done for client 192.168.100.1
[13024.583167] [tempesta fw] TFW_HTTP_FSM_REQ_MSG return code 0
[13024.583756] [tempesta fw] message expanded by new skb [00000000716bb5dd]
[13024.584407] [tempesta fw] store field chunk len=2 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.585517] [tempesta fw] store field chunk len=2 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.586693] [tempesta fw] store field chunk len=2 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.587949] [tempesta fw] store field chunk len=2 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.589295] [tempesta fw] store field chunk len=2 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.590685] [tempesta fw] store field chunk len=1 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.592006] [tempesta fw] store field chunk len=1 data= pK-error(x) field=< pK-error,0x0,1, pK-error>
[13024.593243] [tempesta fw] store field chunk len=12 data= pK-error(x) field=< pK-error,0x0,0, pK-error>
[13024.594748] [tempesta fw] store field chunk len=2 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.596076] [tempesta fw] store field chunk len=2 data= pK-error(.) field=< pK-error,0x0,0, pK-error>
[13024.597428] [tempesta fw] store field chunk len=2 data= pK-error(') field=< pK-error,0x0,0, pK-error>
[13024.598897] [tempesta fw] tfw_http_req_cache_cb: req = 00000000617964aa, resp = 00000000bedf569d
[13024.599844] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "curl/7.81.0"
[13024.600953] [tempesta fw] TLS 0 bytes (45 bytes, type 0x17) are to be sent on conn= pK-error/sk_write_xmit= pK-error ready=1
[13024.602727] [tempesta fw] [1]: ss_send: sk=000000004a3e83a1 (cpu=1) state=Established
[13024.603564] [tempesta fw] Free msg=00000000bedf569d
[13024.604265] [tempesta fw] Free msg=00000000617964aa
[13024.605660] [tempesta fw] [1]: ss_do_send: sk= pK-error queue_empty=1 send_head= pK-error sk_state=1 mss=1448 size=31856
[13024.607010] [tempesta fw] [1]: ss_do_send: entail sk= pK-error skb= pK-error data_len=0 len=21 truesize=896 mark=0 tls_type=17
[13024.608429] [tempesta fw] [1]: ss_do_send: sk=000000004a3e83a1 send_head=0000000005eccd1a sk_state=1 flags=1708
[13024.609631] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813853 snd_nxt=1467813853 limit=1414) skb= pK-error(len=21 data_len=0 type=23 frags=0 headlen=21 seq=1467813853:1467813874)
[13024.611975] [tempesta fw] skb_to_sgvec (1 segs) from skb pK-error (50 bytes, 1 segs), done_frags=0 ret=1
[13024.613136] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.613920] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 01 ...t........
[13024.614929] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=21
[13024.615825] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.616823] [tempesta tls] 00000000: 00 00 00 00 00 00 00 01 17 03 03 00 15 .............
[13024.617721] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=21
[13024.619249] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=1 sglist= pK-error len=50):
[13024.620283] [tempesta tls] => segment 0, ptr= pK-error len=50
[13024.621039] [tempesta tls] dump 'data' (ptr=(einval), 50 bytes):
[13024.621754] [tempesta tls] 00000000: 00 00 00 00 00 00 00 01 17 03 03 00 15 00 00 0c ................
[13024.622888] [tempesta tls] 00000010: 04 00 00 00 00 00 00 01 00 00 10 00 00 04 7f ff ................
[13024.623814] [tempesta tls] 00000020: ff ff 35 e8 7e 00 00 00 00 02 00 00 00 00 00 00 ..5.~...........
[13024.624713] [tempesta tls] 00000030: 00 00 ..
[13024.625509] [tempesta tls] encrypted buf (first 64 bytes) (sgn=1 sglist= pK-error len=50):
[13024.626508] [tempesta tls] => segment 0, ptr= pK-error len=50
[13024.627329] [tempesta tls] dump 'data' (ptr=(einval), 50 bytes):
[13024.628051] [tempesta tls] 00000000: 00 00 00 00 00 00 00 01 17 03 03 00 15 47 02 a9 .............G..
[13024.629012] [tempesta tls] 00000010: ea e2 4e 75 d8 3c bf 2a b9 84 90 f2 03 87 1c 65 ..Nu.<.*.......e
[13024.629884] [tempesta tls] 00000020: 0c d1 a9 aa 01 da 26 8c 8f f1 71 49 29 f9 64 f1 ......&...qI).d.
[13024.630913] [tempesta tls] 00000030: a4 b1 ..
[13024.631872] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=45
[13024.632835] [tempesta fw] [1]: ss_do_send: sk= pK-error queue_empty=1 send_head= pK-error sk_state=1 mss=1448 size=31856
[13024.634659] [tempesta fw] [1]: ss_do_send: entail sk= pK-error skb= pK-error data_len=0 len=13 truesize=896 mark=0 tls_type=17
[13024.635998] [tempesta fw] [1]: ss_do_send: sk=000000004a3e83a1 send_head=000000004380a0d8 sk_state=1 flags=1708
[13024.636956] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813853 snd_nxt=1467813903 limit=1414) skb= pK-error(len=13 data_len=0 type=23 frags=0 headlen=13 seq=1467813903:1467813916)
[13024.638831] [tempesta fw] skb_to_sgvec (1 segs) from skb pK-error (42 bytes, 1 segs), done_frags=0 ret=1
[13024.639804] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.640493] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 02 ...t........
[13024.641315] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=13
[13024.642120] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.643107] [tempesta tls] 00000000: 00 00 00 00 00 00 00 02 17 03 03 00 0d .............
[13024.644001] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=13
[13024.645383] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=1 sglist= pK-error len=42):
[13024.646307] [tempesta tls] => segment 0, ptr= pK-error len=42
[13024.647011] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13024.647699] [tempesta tls] 00000000: 00 00 00 00 00 00 00 02 17 03 03 00 0d 00 00 04 ................
[13024.648750] [tempesta tls] 00000010: 08 00 00 00 00 00 7f ff 00 00 00 00 00 00 00 00 ................
[13024.650050] [tempesta tls] 00000020: 00 00 00 00 00 00 00 00 00 00 ..........
[13024.651014] [tempesta tls] encrypted buf (first 64 bytes) (sgn=1 sglist= pK-error len=42):
[13024.651951] [tempesta tls] => segment 0, ptr= pK-error len=42
[13024.652661] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13024.653338] [tempesta tls] 00000000: 00 00 00 00 00 00 00 02 17 03 03 00 0d b1 3a b6 ..............:.
[13024.654191] [tempesta tls] 00000010: e4 c9 89 d1 3f 2b fe 1c e7 57 fe f8 83 ea 23 f5 ....?+...W....#.
[13024.655369] [tempesta tls] 00000020: e6 82 3e 8a dd 32 7f da 84 2b ..>..2...+
[13024.656204] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=37
[13024.656964] [tempesta fw] [1]: ss_do_send: sk= pK-error queue_empty=1 send_head= pK-error sk_state=1 mss=1448 size=31856
[13024.658277] [tempesta fw] [1]: ss_do_send: entail sk= pK-error skb= pK-error data_len=0 len=9 truesize=896 mark=0 tls_type=17
[13024.659833] [tempesta fw] [1]: ss_do_send: sk=000000004a3e83a1 send_head=000000004e0eca8a sk_state=1 flags=1708
[13024.660908] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813853 snd_nxt=1467813945 limit=1414) skb= pK-error(len=9 data_len=0 type=23 frags=0 headlen=9 seq=1467813945:1467813954)
[13024.662913] [tempesta fw] skb_to_sgvec (1 segs) from skb pK-error (38 bytes, 1 segs), done_frags=0 ret=1
[13024.663851] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.664626] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 03 ...t........
[13024.665573] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=9
[13024.666308] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.667150] [tempesta tls] 00000000: 00 00 00 00 00 00 00 03 17 03 03 00 09 .............
[13024.667997] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=9
[13024.669360] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=1 sglist= pK-error len=38):
[13024.670284] [tempesta tls] => segment 0, ptr= pK-error len=38
[13024.671352] [tempesta tls] dump 'data' (ptr=(einval), 38 bytes):
[13024.672256] [tempesta tls] 00000000: 00 00 00 00 00 00 00 03 17 03 03 00 09 00 00 00 ................
[13024.673151] [tempesta tls] 00000010: 04 01 00 00 00 00 27 e7 fb d0 27 e7 fb 00 00 00 ......'...'.....
[13024.674100] [tempesta tls] 00000020: 00 11 00 00 04 c3 ......
[13024.675262] [tempesta tls] encrypted buf (first 64 bytes) (sgn=1 sglist= pK-error len=38):
[13024.676334] [tempesta tls] => segment 0, ptr= pK-error len=38
[13024.677054] [tempesta tls] dump 'data' (ptr=(einval), 38 bytes):
[13024.677753] [tempesta tls] 00000000: 00 00 00 00 00 00 00 03 17 03 03 00 09 a0 0b 3d ...............=
[13024.678619] [tempesta tls] 00000010: 6a bf c0 92 37 7f 72 18 7b 1f 98 19 22 0d 13 be j...7.r.{..."...
[13024.679506] [tempesta tls] 00000020: fe d2 3e 69 27 3d ..>i'=
[13024.680380] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=33
[13024.681115] [tempesta fw] [1]: ss_do_send: sk= pK-error queue_empty=1 send_head= pK-error sk_state=1 mss=1448 size=31856
[13024.682698] [tempesta fw] [1]: ss_do_send: entail sk= pK-error skb= pK-error data_len=25865 len=26205 truesize=29961 mark=0 tls_type=17
[13024.684046] [tempesta fw] [1]: ss_do_send: sk=000000004a3e83a1 send_head=00000000716bb5dd sk_state=1 flags=1708
[13024.684941] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=26205 data_len=25865 truesize=29961 nr_frags=7
[13024.686742] [tempesta fw] [1]: __split_linear_data: skb [00000000716bb5dd] pspt [000000005f73cbf2] len [9] tail_len [260]
[13024.688065] [tempesta fw] [1]: __skb_fragment: out: res [000000006bfa2d94], skb [00000000716bb5dd]: head [000000001bb913c3] data [0000000072ffb813] tail [000000005f73cbf2] end [0000000066432394] len [26214] data_len [26134] truesize [29970] nr_frags [9]
[13024.690312] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813853 snd_nxt=1467813983 limit=7206) skb= pK-error(len=7206 data_len=7126 type=23 frags=4 headlen=80 seq=1467813983:1467821189)
[13024.692447] [tempesta fw] skb_to_sgvec (6 segs) from skb pK-error (7235 bytes, 6 segs), done_frags=0 ret=6
[13024.693517] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.694225] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 04 ...t........
[13024.695125] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=7206
[13024.695855] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.696694] [tempesta tls] 00000000: 00 00 00 00 00 00 00 04 17 03 03 1c 26 ............&
[13024.697569] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=7206
[13024.699051] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=6 sglist= pK-error len=256):
[13024.700033] [tempesta tls] => segment 0, ptr= pK-error len=93
[13024.700791] [tempesta tls] dump 'data' (ptr=(einval), 93 bytes):
[13024.701526] [tempesta tls] 00000000: 00 00 00 00 00 00 00 04 17 03 03 1c 26 00 00 47 ............&..G
[13024.702634] [tempesta tls] 00000010: 01 04 00 00 00 01 88 05 32 63 6f 6e 74 65 6e 74 ........2content
[13024.703723] [tempesta tls] 00000020: 2d 6c 65 6e 67 74 68 32 32 35 38 36 35 09 74 63 -length225865.tc
[13024.704604] [tempesta tls] 00000030: 6f 6e 74 65 6e 74 2d 74 79 70 65 74 74 65 78 74 ontent-typettext
[13024.705478] [tempesta tls] 00000040: 2f 68 74 6d 6c 0f 22 65 74 61 67 22 22 36 33 37 /html."etag""637
[13024.706367] [tempesta tls] 00000050: 32 39 33 62 61 2d 36 35 30 39 22 1d 53 293ba-6509".S
[13024.707384] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.708090] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.708804] [tempesta tls] 00000000: 00 1b cd 00 00 00 00 00 01 .........
[13024.709662] [tempesta tls] => segment 2, ptr= pK-error len=260
[13024.710369] [tempesta tls] dump 'data' (ptr=(einval), 154 bytes):
[13024.711054] [tempesta tls] 00000000: 64 61 74 65 53 53 75 6e 2c 20 31 34 20 4d 61 79 dateSSun, 14 May
[13024.712041] [tempesta tls] 00000010: 20 32 30 32 33 20 31 37 3a 32 31 3a 30 35 20 47 2023 17:21:05 G
[13024.712949] [tempesta tls] 00000020: 4d 54 1d 4d 6c 61 73 74 2d 6d 6f 64 69 66 69 65 MT.Mlast-modifie
[13024.713829] [tempesta tls] 00000030: 64 4d 4d 6f 6e 2c 20 31 34 20 4e 6f 76 20 32 30 dMMon, 14 Nov 20
[13024.714710] [tempesta tls] 00000040: 32 32 20 31 39 3a 31 35 3a 30 36 20 47 4d 54 0c 22 19:15:06 GMT.
[13024.715598] [tempesta tls] 00000050: 78 78 2d 63 72 61 73 68 2d 31 33 37 37 00 05 62 xx-crash-1377..b
[13024.716495] [tempesta tls] 00000060: 61 63 63 65 70 74 2d 72 61 6e 67 65 73 62 62 79 accept-rangesbby
[13024.717375] [tempesta tls] 00000070: 74 65 73 15 54 73 65 72 76 65 72 54 54 65 6d 70 tes.TserverTTemp
[13024.718256] [tempesta tls] 00000080: 65 73 74 61 20 46 57 2f 70 72 65 2d 30 2e 37 2e esta FW/pre-0.7.
[13024.719440] [tempesta tls] 00000090: 30 27 32 76 69 61 32 32 2e 30 0'2via22.0
[13024.720333] [tempesta tls] encrypted buf (first 64 bytes) (sgn=6 sglist= pK-error len=64):
[13024.721352] [tempesta tls] => segment 0, ptr= pK-error len=93
[13024.722237] [tempesta tls] dump 'data' (ptr=(einval), 64 bytes):
[13024.722991] [tempesta tls] 00000000: 00 00 00 00 00 00 00 04 17 03 03 1c 26 d4 36 38 ............&.68
[13024.724119] [tempesta tls] 00000010: d9 8b 0b 96 3f 24 30 fa 85 20 18 18 fd 1a 03 45 ....?$0.. .....E
[13024.725152] [tempesta tls] 00000020: cc 96 4e 71 c8 b6 7c 5e b9 d2 b3 7e 3a 12 66 fb ..Nq..|^...~:.f.
[13024.726050] [tempesta tls] 00000030: 89 49 75 72 1a 0e c4 36 01 9e 6e a7 2d 21 b5 f4 .Iur...6..n.-!..
[13024.727019] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=7230
[13024.728852] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=19008 data_len=19008 truesize=19904 nr_frags=6
[13024.730712] [tempesta fw] [1]: __skb_fragment: out: res [000000008bddd2fa], skb [00000000c888aa13]: head [00000000a7a79ae4] data [00000000203aefb9] tail [00000000203aefb9] end [00000000af367d93] len [19017] data_len [19017] truesize [19913] nr_frags [7]
[13024.733386] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813903 snd_nxt=1467821218 limit=2862) skb= pK-error(len=2862 data_len=2862 type=23 frags=3 headlen=0 seq=1467821218:1467824080)
[13024.735450] [tempesta fw] skb_to_sgvec (5 segs) from skb pK-error (2891 bytes, 5 segs), done_frags=0 ret=5
[13024.736385] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.737061] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 05 ...t........
[13024.737901] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=2862
[13024.738595] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.739563] [tempesta tls] 00000000: 00 00 00 00 00 00 00 05 17 03 03 0b 2e .............
[13024.740468] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=2862
[13024.741926] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=5 sglist= pK-error len=256):
[13024.742858] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.743537] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.744228] [tempesta tls] 00000000: 00 00 00 00 00 00 00 05 17 03 03 0b 2e .............
[13024.745094] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.745803] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.746489] [tempesta tls] 00000000: 00 0b 25 00 00 00 00 00 01 ..%......
[13024.747318] [tempesta tls] => segment 2, ptr= pK-error len=786
[13024.748003] [tempesta tls] dump 'data' (ptr=(einval), 234 bytes):
[13024.748680] [tempesta tls] 00000000: 31 20 70 79 2d 30 20 6d 79 2d 30 22 20 61 72 69 1 py-0 my-0" ari
[13024.749541] [tempesta tls] 00000010: 61 2d 6c 61 62 65 6c 6c 65 64 62 79 3d 22 53 65 a-labelledby="Se
[13024.750402] [tempesta tls] 00000020: 72 76 69 63 65 73 4d 65 6e 75 4c 69 6e 6b 22 3e rvicesMenuLink">
[13024.751572] [tempesta tls] 00000030: 20 3c 61 20 63 6c 61 73 73 3d 22 64 72 6f 70 64 <a class="dropd
[13024.752618] [tempesta tls] 00000040: 6f 77 6e 2d 69 74 65 6d 22 20 68 72 65 66 3d 22 own-item" href="
[13024.753521] [tempesta tls] 00000050: 2f 64 65 76 65 6c 6f 70 6d 65 6e 74 2d 73 65 72 /development-ser
[13024.754423] [tempesta tls] 00000060: 76 69 63 65 73 23 63 75 73 74 6f 6d 22 3e 3c 68 vices#custom"><h
[13024.755537] [tempesta tls] 00000070: 31 3e 53 6f 66 74 77 61 72 65 20 64 65 76 65 6c 1>Software devel
[13024.756887] [tempesta tls] 00000080: 6f 70 6d 65 6e 74 3c 2f 68 31 3e 3c 2f 61 3e 20 opment</h1></a>
[13024.757924] [tempesta tls] 00000090: 3c 61 20 63 6c 61 73 73 3d 22 64 72 6f 70 64 6f <a class="dropdo
[13024.758794] [tempesta tls] 000000a0: 77 6e 2d 69 74 65 6d 22 20 68 72 65 66 3d 22 2f wn-item" href="/
[13024.759670] [tempesta tls] 000000b0: 64 65 76 65 6c 6f 70 6d 65 6e 74 2d 73 65 72 76 development-serv
[13024.760585] [tempesta tls] 000000c0: 69 63 65 73 23 68 70 22 3e 3c 68 32 3e 48 69 67 ices#hp"><h2>Hig
[13024.761488] [tempesta tls] 000000d0: 68 20 70 65 72 66 6f 72 6d 61 6e 63 65 3c 2f 68 h performance</h
[13024.762543] [tempesta tls] 000000e0: 32 3e 3c 2f 61 3e 20 3c 61 20 2></a> <a
[13024.763373] [tempesta tls] encrypted buf (first 64 bytes) (sgn=5 sglist= pK-error len=64):
[13024.764165] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.764873] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.765565] [tempesta tls] 00000000: 00 00 00 00 00 00 00 05 17 03 03 0b 2e .............
[13024.766416] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.767470] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.768091] [tempesta tls] 00000000: cc 8f d2 1e 36 89 d7 c6 fc ....6....
[13024.768922] [tempesta tls] => segment 2, ptr= pK-error len=786
[13024.769566] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13024.770183] [tempesta tls] 00000000: a2 fd 49 88 ec ea 2f c1 de 4d 59 63 84 af 31 87 ..I.../..MYc..1.
[13024.771026] [tempesta tls] 00000010: 13 8a 62 79 99 53 32 38 e0 d4 dc 66 e6 2d e7 49 ..by.S28...f.-.I
[13024.772090] [tempesta tls] 00000020: 62 f0 06 eb 67 75 86 70 85 e0 b...gu.p..
[13024.772999] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=2886
[13024.773740] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=16155 data_len=16155 truesize=17051 nr_frags=5
[13024.775772] [tempesta fw] [1]: __skb_fragment: out: res [0000000034413cb0], skb [0000000022e5d565]: head [00000000d1d009dc] data [0000000099ef62b3] tail [0000000099ef62b3] end [000000000137345d] len [16164] data_len [16164] truesize [17060] nr_frags [6]
[13024.777792] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813903 snd_nxt=1467824109 limit=2862) skb= pK-error(len=2862 data_len=2862 type=23 frags=3 headlen=0 seq=1467824109:1467826971)
[13024.779440] [tempesta fw] skb_to_sgvec (5 segs) from skb pK-error (2891 bytes, 5 segs), done_frags=0 ret=5
[13024.780316] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.780985] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 06 ...t........
[13024.782004] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=2862
[13024.783103] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.783852] [tempesta tls] 00000000: 00 00 00 00 00 00 00 06 17 03 03 0b 2e .............
[13024.784678] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=2862
[13024.786056] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=5 sglist= pK-error len=256):
[13024.786934] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.787751] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.788450] [tempesta tls] 00000000: 00 00 00 00 00 00 00 06 17 03 03 0b 2e .............
[13024.789275] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.789945] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.790613] [tempesta tls] 00000000: 00 0b 25 00 00 00 00 00 01 ..%......
[13024.791406] [tempesta tls] => segment 2, ptr= pK-error len=2013
[13024.792280] [tempesta tls] dump 'data' (ptr=(einval), 234 bytes):
[13024.792982] [tempesta tls] 00000000: 2e 37 30 37 6c 2d 32 2e 36 34 36 20 32 2e 36 34 .707l-2.646 2.64
[13024.793815] [tempesta tls] 00000010: 37 61 2e 35 2e 35 20 30 20 30 20 31 2d 2e 37 30 7a.5.5 0 0 1-.70
[13024.794664] [tempesta tls] 00000020: 38 2d 2e 37 30 38 4c 37 2e 32 39 33 20 38 20 34 8-.708L7.293 8 4
[13024.795485] [tempesta tls] 00000030: 2e 36 34 36 20 35 2e 33 35 34 61 2e 35 2e 35 20 .646 5.354a.5.5
[13024.796335] [tempesta tls] 00000040: 30 20 30 20 31 20 30 2d 2e 37 30 38 7a 22 2f 3e 0 0 1 0-.708z"/>
[13024.797158] [tempesta tls] 00000050: 3c 2f 73 76 67 3e 20 3c 2f 62 75 74 74 6f 6e 3e </svg> </button>
[13024.797978] [tempesta tls] 00000060: 20 3c 2f 64 69 76 3e 3c 64 69 76 20 63 6c 61 73 </div><div clas
[13024.799231] [tempesta tls] 00000070: 73 3d 22 6d 6f 64 61 6c 2d 62 6f 64 79 22 3e 3c s="modal-body"><
[13024.800119] [tempesta tls] 00000080: 64 69 76 20 63 6c 61 73 73 3d 22 65 6d 62 65 64 div class="embed
[13024.800958] [tempesta tls] 00000090: 2d 72 65 73 70 6f 6e 73 69 76 65 20 65 6d 62 65 -responsive embe
[13024.801798] [tempesta tls] 000000a0: 64 2d 72 65 73 70 6f 6e 73 69 76 65 2d 31 36 62 d-responsive-16b
[13024.802634] [tempesta tls] 000000b0: 79 39 22 3e 3c 69 66 72 61 6d 65 20 63 6c 61 73 y9"><iframe clas
[13024.803653] [tempesta tls] 000000c0: 73 3d 22 65 6d 62 65 64 2d 72 65 73 70 6f 6e 73 s="embed-respons
[13024.804580] [tempesta tls] 000000d0: 69 76 65 2d 69 74 65 6d 20 74 74 2d 76 69 64 65 ive-item tt-vide
[13024.805434] [tempesta tls] 000000e0: 6f 22 20 73 72 63 3d 22 68 74 o" src="ht
[13024.806252] [tempesta tls] encrypted buf (first 64 bytes) (sgn=5 sglist= pK-error len=64):
[13024.807043] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.807720] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.808372] [tempesta tls] 00000000: 00 00 00 00 00 00 00 06 17 03 03 0b 2e .............
[13024.809191] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.809857] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.810515] [tempesta tls] 00000000: 83 80 c3 d5 07 01 a4 aa 0a .........
[13024.811334] [tempesta tls] => segment 2, ptr= pK-error len=2013
[13024.812224] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13024.812881] [tempesta tls] 00000000: 3e 1c 0c cb 77 81 74 30 61 39 4d c4 03 63 00 20 >...w.t0a9M..c.
[13024.813728] [tempesta tls] 00000010: 60 6d 0c 84 0a 3e 42 e6 ff 98 bf bd 59 94 91 43 `m...>B.....Y..C
[13024.814578] [tempesta tls] 00000020: 5b a6 24 70 2a bf 34 09 31 9e [.$p*.4.1.
[13024.815772] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=2886
[13024.816575] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13024.817300] [tempesta tls] ttls_recv: tls= pK-error len=38 read=0
[13024.817937] [tempesta tls] input rec: type=23 ver=3:3 msglen=33 read=5 xfrm_ready=1
[13024.818651] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=33 chunks=1 eiv_len=8
[13024.819561] [tempesta tls] build req sglist: skb= pK-error next= pK-error len=38 off=13
[13024.820945] [tempesta tls] build req sglist (sgn=1 sglist= pK-error len=25):
[13024.822054] [tempesta tls] => segment 0, ptr= pK-error len=25
[13024.822729] [tempesta tls] dump 'data' (ptr=(einval), 25 bytes):
[13024.823376] [tempesta tls] 00000000: b6 d3 68 0f 97 b8 72 3c bb 1c 25 2f 06 95 c2 f7 ..h...r<..%/....
[13024.824196] [tempesta tls] 00000010: c0 2d 35 db f4 b3 d8 07 69 .-5.....i
[13024.824950] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=0 sgn=2
[13024.826175] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=9
[13024.826779] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.827599] [tempesta tls] 00000000: 00 00 00 00 00 00 00 05 17 03 03 00 09 .............
[13024.828405] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.829025] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 d2 ...q.d.X....
[13024.829800] [tempesta tls] decrypt: AAD|msg|TAG (sgn=2 sglist= pK-error len=38):
[13024.830523] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.831518] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.832309] [tempesta tls] 00000000: 00 00 00 00 00 00 00 05 17 03 03 00 09 .............
[13024.833099] [tempesta tls] => segment 1, ptr= pK-error len=25
[13024.833706] [tempesta tls] dump 'data' (ptr=(einval), 25 bytes):
[13024.834327] [tempesta tls] 00000000: b6 d3 68 0f 97 b8 72 3c bb 1c 25 2f 06 95 c2 f7 ..h...r<..%/....
[13024.835107] [tempesta tls] 00000010: c0 2d 35 db f4 b3 d8 07 69 .-5.....i
[13024.836068] [tempesta tls] raw buffer after decryption (sgn=1 sglist= pK-error len=9):
[13024.836923] [tempesta tls] => segment 0, ptr= pK-error len=25
[13024.837573] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.838199] [tempesta tls] 00000000: 00 00 00 04 01 00 00 00 00 .........
[13024.838970] [tempesta fw] tfw_tls_connection_recv: parsed=38 skb->len=38
[13024.839638] [tempesta fw] ss_skb_chop_head_tail: head=0xd trail=0x10 skb= pK-error (head= pK-error data= pK-error tail= pK-error end= pK-error len=38 data_len=0 nr_frags=0)
[13024.841241] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=13302 data_len=13302 truesize=14198 nr_frags=4
[13024.843294] [tempesta fw] [1]: __skb_fragment: out: res [00000000b3ee87b3], skb [000000007008bb41]: head [0000000005eccd1a] data [00000000b7cc4ca3] tail [00000000b7cc4ca3] end [000000008beba3e4] len [13311] data_len [13311] truesize [14207] nr_frags [5]
[13024.845422] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813983 snd_nxt=1467827000 limit=2862) skb= pK-error(len=2862 data_len=2862 type=23 frags=2 headlen=0 seq=1467827000:1467829862)
[13024.847140] [tempesta fw] skb_to_sgvec (4 segs) from skb pK-error (2891 bytes, 4 segs), done_frags=0 ret=4
[13024.848054] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.848754] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 07 ...t........
[13024.849602] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=2862
[13024.850314] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.851122] [tempesta tls] 00000000: 00 00 00 00 00 00 00 07 17 03 03 0b 2e .............
[13024.852276] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=2862
[13024.853806] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=4 sglist= pK-error len=256):
[13024.854740] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.855440] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.856138] [tempesta tls] 00000000: 00 00 00 00 00 00 00 07 17 03 03 0b 2e .............
[13024.857004] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.857697] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.858368] [tempesta tls] 00000000: 00 0b 25 00 00 00 00 00 01 ..%......
[13024.859210] [tempesta tls] => segment 2, ptr= pK-error len=2853
[13024.859917] [tempesta tls] dump 'data' (ptr=(einval), 234 bytes):
[13024.860607] [tempesta tls] 00000000: 73 3d 27 66 69 72 73 74 2d 6c 65 74 74 65 72 27 s='first-letter'
[13024.861483] [tempesta tls] 00000010: 3e 4c 3c 2f 73 70 61 6e 3e 6f 61 64 20 62 61 6c >L</span>oad bal
[13024.862563] [tempesta tls] 00000020: 61 6e 63 69 6e 67 3c 2f 61 3e 20 3c 2f 68 32 3e ancing</a> </h2>
[13024.863903] [tempesta tls] 00000030: 3c 70 3e 20 54 65 6d 70 65 73 74 61 20 46 57 20 <p> Tempesta FW
[13024.864813] [tempesta tls] 00000040: 75 73 65 73 20 6d 61 63 68 69 6e 65 20 6c 65 61 uses machine lea
[13024.865712] [tempesta tls] 00000050: 72 6e 69 6e 67 20 74 6f 20 64 79 6e 61 6d 69 63 rning to dynamic
[13024.866601] [tempesta tls] 00000060: 61 6c 6c 79 20 6c 65 61 72 6e 20 61 6e 64 20 70 ally learn and p
[13024.867510] [tempesta tls] 00000070: 72 65 64 69 63 74 20 63 68 61 6e 67 65 73 20 69 redict changes i
[13024.868439] [tempesta tls] 00000080: 6e 20 74 68 65 20 70 65 72 66 6f 72 6d 61 6e 63 n the performanc
[13024.869408] [tempesta tls] 00000090: 65 20 61 6e 64 20 74 68 65 20 61 76 61 69 6c 61 e and the availa
[13024.870287] [tempesta tls] 000000a0: 62 69 6c 69 74 79 20 6f 66 20 65 61 63 68 20 6f bility of each o
[13024.871140] [tempesta tls] 000000b0: 66 20 79 6f 75 72 20 62 61 63 6b 65 6e 64 20 73 f your backend s
[13024.872167] [tempesta tls] 000000c0: 65 72 76 65 72 73 2e 20 54 68 65 72 65 20 69 73 ervers. There is
[13024.873028] [tempesta tls] 000000d0: 20 6e 6f 20 6e 65 65 64 20 74 6f 20 63 6f 6e 66 no need to conf
[13024.873876] [tempesta tls] 000000e0: 69 67 75 72 65 20 61 6e 64 20 igure and
[13024.874698] [tempesta tls] encrypted buf (first 64 bytes) (sgn=4 sglist= pK-error len=64):
[13024.875514] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.876218] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.876880] [tempesta tls] 00000000: 00 00 00 00 00 00 00 07 17 03 03 0b 2e .............
[13024.877766] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.878460] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.879504] [tempesta tls] 00000000: 52 d3 ab b0 40 3e d5 63 54 R...@>.cT
[13024.880336] [tempesta tls] => segment 2, ptr= pK-error len=2853
[13024.881025] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13024.881676] [tempesta tls] 00000000: f0 6e 11 46 de 5d 07 a2 a6 74 c5 fc 8e ff ce e8 .n.F.]...t......
[13024.882711] [tempesta tls] 00000010: 51 c2 b0 2a ec a8 c4 91 01 c1 d2 12 bd 72 bd f5 Q..*.........r..
[13024.883556] [tempesta tls] 00000020: ba b4 bc 49 39 76 36 93 64 05 ...I9v6.d.
[13024.884418] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=2886
[13024.885187] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=10449 data_len=10449 truesize=11345 nr_frags=4
[13024.886938] [tempesta fw] [1]: __skb_fragment: out: res [00000000d745a64e], skb [000000004380a0d8]: head [000000003df8b024] data [0000000085691510] tail [0000000085691510] end [00000000518bb653] len [10458] data_len [10458] truesize [11354] nr_frags [5]
[13024.888998] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467813983 snd_nxt=1467829891 limit=2862) skb= pK-error(len=2862 data_len=2862 type=23 frags=3 headlen=0 seq=1467829891:1467832753)
[13024.890602] [tempesta fw] skb_to_sgvec (5 segs) from skb pK-error (2891 bytes, 5 segs), done_frags=0 ret=5
[13024.891487] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.892317] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 08 ...t........
[13024.893163] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=2862
[13024.893834] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.894594] [tempesta tls] 00000000: 00 00 00 00 00 00 00 08 17 03 03 0b 2e .............
[13024.895665] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=2862
[13024.897010] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=5 sglist= pK-error len=256):
[13024.897899] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.898570] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.899225] [tempesta tls] 00000000: 00 00 00 00 00 00 00 08 17 03 03 0b 2e .............
[13024.900056] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.900888] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.901569] [tempesta tls] 00000000: 00 0b 25 00 00 00 00 00 01 ..%......
[13024.902554] [tempesta tls] => segment 2, ptr= pK-error len=387
[13024.903226] [tempesta tls] dump 'data' (ptr=(einval), 234 bytes):
[13024.903876] [tempesta tls] 00000000: 48 54 54 50 20 70 61 72 73 65 72 3c 2f 61 3e 2e HTTP parser</a>.
[13024.904739] [tempesta tls] 00000010: 20 54 65 6d 70 65 73 74 61 20 46 57 20 75 73 65 Tempesta FW use
[13024.905590] [tempesta tls] 00000020: 73 20 74 68 65 20 66 75 6c 6c 20 70 6f 77 65 72 s the full power
[13024.906432] [tempesta tls] 00000030: 20 6f 66 20 6d 6f 64 65 72 6e 20 78 38 36 2d 36 of modern x86-6
[13024.907270] [tempesta tls] 00000040: 34 20 69 6e 73 74 72 75 63 74 69 6f 6e 20 73 65 4 instruction se
[13024.908123] [tempesta tls] 00000050: 74 20 61 6c 6f 6e 67 20 77 69 74 68 20 74 68 65 t along with the
[13024.909005] [tempesta tls] 00000060: 20 6e 65 77 20 61 6c 67 6f 72 69 74 68 6d 73 20 new algorithms
[13024.909864] [tempesta tls] 00000070: 66 6f 72 20 66 61 73 74 20 3c 61 20 68 72 65 66 for fast <a href
[13024.910720] [tempesta tls] 00000080: 3d 22 68 74 74 70 73 3a 2f 2f 6e 61 74 73 79 73 ="https://natsys
[13024.911695] [tempesta tls] 00000090: 2d 6c 61 62 2e 62 6c 6f 67 73 70 6f 74 2e 63 6f -lab.blogspot.co
[13024.912747] [tempesta tls] 000000a0: 6d 2f 32 30 31 36 2f 31 30 2f 68 74 74 70 2d 73 m/2016/10/http-s
[13024.913609] [tempesta tls] 000000b0: 74 72 69 6e 67 73 2d 70 72 6f 63 65 73 73 69 6e trings-processin
[13024.914459] [tempesta tls] 000000c0: 67 2d 75 73 69 6e 67 2d 63 2d 73 73 65 34 32 2e g-using-c-sse42.
[13024.915327] [tempesta tls] 000000d0: 68 74 6d 6c 22 3e 48 54 54 50 20 73 74 72 69 6e html">HTTP strin
[13024.916179] [tempesta tls] 000000e0: 67 73 20 70 72 6f 63 65 73 73 gs process
[13024.917186] [tempesta tls] encrypted buf (first 64 bytes) (sgn=5 sglist= pK-error len=64):
[13024.918035] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.918709] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.919357] [tempesta tls] 00000000: 00 00 00 00 00 00 00 08 17 03 03 0b 2e .............
[13024.920198] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.920876] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.921530] [tempesta tls] 00000000: 41 6d 33 db 91 27 43 59 c5 Am3..'CY.
[13024.922532] [tempesta tls] => segment 2, ptr= pK-error len=387
[13024.923249] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13024.923910] [tempesta tls] 00000000: b4 b6 78 2f 59 6d a2 00 37 4f 70 ce 41 6d 85 ec ..x/Ym..7Op.Am..
[13024.924771] [tempesta tls] 00000010: 13 2c 86 77 2b e0 b2 1c 6d bf f7 e5 ab ae 27 98 .,.w+...m.....'.
[13024.925614] [tempesta tls] 00000020: 57 d5 43 08 f1 5e 8a a9 8b ba W.C..^....
[13024.926429] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=2886
[13024.927504] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=7596 data_len=7596 truesize=8492 nr_frags=3
[13024.929255] [tempesta fw] [1]: __skb_fragment: out: res [00000000c98d48bd], skb [000000006aea0290]: head [00000000fe911058] data [000000005003f5e5] tail [000000005003f5e5] end [00000000552ebcee] len [7605] data_len [7605] truesize [8501] nr_frags [4]
[13024.931415] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467821218 snd_nxt=1467832782 limit=2862) skb= pK-error(len=2862 data_len=2862 type=23 frags=3 headlen=0 seq=1467832782:1467835644)
[13024.933604] [tempesta fw] skb_to_sgvec (5 segs) from skb pK-error (2891 bytes, 5 segs), done_frags=0 ret=5
[13024.934597] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.935303] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 09 ...t........
[13024.936189] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=2862
[13024.936921] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.937734] [tempesta tls] 00000000: 00 00 00 00 00 00 00 09 17 03 03 0b 2e .............
[13024.938612] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=2862
[13024.940107] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=5 sglist= pK-error len=256):
[13024.941076] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.941816] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.942540] [tempesta tls] 00000000: 00 00 00 00 00 00 00 09 17 03 03 0b 2e .............
[13024.943717] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.944455] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.945155] [tempesta tls] 00000000: 00 0b 25 00 00 00 00 00 01 ..%......
[13024.946034] [tempesta tls] => segment 2, ptr= pK-error len=1614
[13024.946753] [tempesta tls] dump 'data' (ptr=(einval), 234 bytes):
[13024.947413] [tempesta tls] 00000000: 20 63 61 6e 20 75 73 65 20 73 74 61 6e 64 61 72 can use standar
[13024.948283] [tempesta tls] 00000010: 64 20 4c 69 6e 75 78 20 74 6f 6f 6c 73 20 6c 69 d Linux tools li
[13024.949304] [tempesta tls] 00000020: 6b 65 20 49 50 54 61 62 6c 65 73 2c 20 74 63 2c ke IPTables, tc,
[13024.950200] [tempesta tls] 00000030: 20 4c 56 53 2c 20 61 6e 64 20 74 63 70 64 75 6d LVS, and tcpdum
[13024.951060] [tempesta tls] 00000040: 70 20 74 6f 20 6d 61 6e 61 67 65 20 48 54 54 50 p to manage HTTP
[13024.952007] [tempesta tls] 00000050: 20 74 72 61 66 66 69 63 20 77 69 74 68 6f 75 74 traffic without
[13024.952873] [tempesta tls] 00000060: 20 6d 61 6b 69 6e 67 20 6d 61 6e 79 20 64 61 74 making many dat
[13024.953737] [tempesta tls] 00000070: 61 20 63 6f 70 69 65 73 2e 20 3c 2f 70 3e 3c 70 a copies. </p><p
[13024.954595] [tempesta tls] 00000080: 20 63 6c 61 73 73 3d 22 74 74 2d 74 78 74 2d 63 class="tt-txt-c
[13024.955448] [tempesta tls] 00000090: 6f 6c 6c 61 70 73 65 64 22 3e 20 4f 75 72 20 3c ollapsed"> Our <
[13024.956328] [tempesta tls] 000000a0: 61 20 68 72 65 66 3d 22 68 74 74 70 73 3a 2f 2f a href="https://
[13024.957187] [tempesta tls] 000000b0: 77 77 77 2e 6e 65 74 64 65 76 63 6f 6e 66 2e 6f www.netdevconf.o
[13024.958045] [tempesta tls] 000000c0: 72 67 2f 32 2e 31 2f 73 65 73 73 69 6f 6e 2e 68 rg/2.1/session.h
[13024.959214] [tempesta tls] 000000d0: 74 6d 6c 3f 6b 72 69 7a 68 61 6e 6f 76 73 6b 79 tml?krizhanovsky
[13024.960068] [tempesta tls] 000000e0: 22 3e 4e 65 74 64 65 76 20 32 ">Netdev 2
[13024.960900] [tempesta tls] encrypted buf (first 64 bytes) (sgn=5 sglist= pK-error len=64):
[13024.961715] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.962559] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.963216] [tempesta tls] 00000000: 00 00 00 00 00 00 00 09 17 03 03 0b 2e .............
[13024.964056] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.964803] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.965810] [tempesta tls] 00000000: 55 73 aa 54 94 d0 54 92 df Us.T..T..
[13024.966762] [tempesta tls] => segment 2, ptr= pK-error len=1614
[13024.967449] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13024.968103] [tempesta tls] 00000000: 31 8f 8a cc 25 68 4d d1 e4 a4 7d 8b 45 06 9f d4 1...%hM...}.E...
[13024.968974] [tempesta tls] 00000010: 84 70 63 d6 66 ea 7a 3a 84 08 af df 75 52 0f 20 .pc.f.z:....uR.
[13024.969822] [tempesta tls] 00000020: e2 d5 24 21 c5 08 c4 9b c6 96 ..$!......
[13024.970663] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=2886
[13024.971410] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=4743 data_len=4743 truesize=5639 nr_frags=2
[13024.973474] [tempesta fw] [1]: __skb_fragment: out: res [000000007a4acda3], skb [00000000a51e93e6]: head [00000000d1ff7965] data [00000000c47f77b6] tail [00000000c47f77b6] end [00000000b83a2d4f] len [4752] data_len [4752] truesize [5648] nr_frags [3]
[13024.976098] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467821218 snd_nxt=1467835673 limit=2862) skb= pK-error(len=2862 data_len=2862 type=23 frags=3 headlen=0 seq=1467835673:1467838535)
[13024.977773] [tempesta fw] skb_to_sgvec (5 segs) from skb pK-error (2891 bytes, 5 segs), done_frags=0 ret=5
[13024.978671] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13024.979337] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 0a ...t........
[13024.980172] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=2862
[13024.980912] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13024.981774] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0a 17 03 03 0b 2e .............
[13024.982775] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=2862
[13024.984095] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=5 sglist= pK-error len=256):
[13024.985028] [tempesta tls] => segment 0, ptr= pK-error len=13
[13024.985740] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13024.986411] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0a 17 03 03 0b 2e .............
[13024.987300] [tempesta tls] => segment 1, ptr= pK-error len=9
[13024.987972] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13024.988633] [tempesta tls] 00000000: 00 0b 25 00 00 00 00 00 01 ..%......
[13024.989451] [tempesta tls] => segment 2, ptr= pK-error len=2841
[13024.990133] [tempesta tls] dump 'data' (ptr=(einval), 234 bytes):
[13024.991179] [tempesta tls] 00000000: 75 72 63 65 73 2e 68 74 6d 6c 22 3e 73 6f 75 72 urces.html">sour
[13024.992255] [tempesta tls] 00000010: 63 65 73 3c 2f 61 3e 20 6f 72 20 3c 61 20 68 72 ces</a> or <a hr
[13024.993130] [tempesta tls] 00000020: 65 66 3d 22 68 74 74 70 73 3a 2f 2f 74 65 6d 70 ef="https://temp
[13024.993982] [tempesta tls] 00000030: 65 73 74 61 2d 66 77 2e 72 65 61 64 74 68 65 64 esta-fw.readthed
[13024.994833] [tempesta tls] 00000040: 6f 63 73 2e 69 6f 2f 65 6e 2f 6c 61 74 65 73 74 ocs.io/en/latest
[13024.995688] [tempesta tls] 00000050: 2f 49 6e 73 74 61 6c 6c 2d 66 72 6f 6d 2d 70 61 /Install-from-pa
[13024.996596] [tempesta tls] 00000060: 63 6b 61 67 65 73 2e 68 74 6d 6c 22 3e 70 72 65 ckages.html">pre
[13024.997627] [tempesta tls] 00000070: 62 75 69 6c 74 20 70 61 63 6b 61 67 65 73 3c 2f built packages</
[13024.998519] [tempesta tls] 00000080: 61 3e 2e 20 53 79 73 74 65 6d 20 72 65 71 75 69 a>. System requi
[13024.999373] [tempesta tls] 00000090: 72 65 6d 65 6e 74 73 20 63 61 6e 20 62 65 20 66 rements can be f
[13025.000257] [tempesta tls] 000000a0: 6f 75 6e 64 20 6f 6e 20 6f 75 72 20 3c 61 20 68 ound on our <a h
[13025.001134] [tempesta tls] 000000b0: 72 65 66 3d 22 68 74 74 70 73 3a 2f 2f 74 65 6d ref="https://tem
[13025.002164] [tempesta tls] 000000c0: 70 65 73 74 61 2d 66 77 2e 72 65 61 64 74 68 65 pesta-fw.readthe
[13025.003048] [tempesta tls] 000000d0: 64 6f 63 73 2e 69 6f 2f 65 6e 2f 6c 61 74 65 73 docs.io/en/lates
[13025.003910] [tempesta tls] 000000e0: 74 2f 52 65 71 75 69 72 65 6d t/Requirem
[13025.004764] [tempesta tls] encrypted buf (first 64 bytes) (sgn=5 sglist= pK-error len=64):
[13025.005640] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.006325] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.007762] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0a 17 03 03 0b 2e .............
[13025.008575] [tempesta tls] => segment 1, ptr= pK-error len=9
[13025.009212] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13025.009822] [tempesta tls] 00000000: 4d a7 b1 f3 bf 24 2f 93 40 M....$/.@
[13025.010597] [tempesta tls] => segment 2, ptr= pK-error len=2841
[13025.011251] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13025.012008] [tempesta tls] 00000000: 7b 1d 38 22 5f 65 f7 5a 59 47 87 58 7a ae 23 3d {.8"_e.ZYG.Xz.#=
[13025.012875] [tempesta tls] 00000010: 92 82 d0 42 67 ec 3b bc e0 42 49 75 02 74 10 77 ...Bg.;..BIu.t.w
[13025.013856] [tempesta tls] 00000020: 7d 55 e9 4d 08 ae 08 21 06 74 }U.M...!.t
[13025.014656] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=2886
[13025.015371] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=1890 data_len=1890 truesize=2786 nr_frags=1
[13025.017068] [tempesta fw] [1]: __skb_fragment: out: res [00000000cef70071], skb [00000000716bb5dd]: head [0000000072ffb813] data [0000000043d07260] tail [0000000043d07260] end [000000009c018084] len [1899] data_len [1899] truesize [2795] nr_frags [2]
[13025.019043] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467821218 snd_nxt=1467838564 limit=1414) skb= pK-error(len=1414 data_len=1414 type=23 frags=2 headlen=0 seq=1467838564:1467839978)
[13025.020648] [tempesta fw] skb_to_sgvec (4 segs) from skb pK-error (1443 bytes, 4 segs), done_frags=0 ret=4
[13025.021501] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13025.022355] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 0b ...t........
[13025.023567] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=1414
[13025.024256] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13025.025007] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0b 17 03 03 05 86 .............
[13025.025827] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=1414
[13025.027271] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=4 sglist= pK-error len=256):
[13025.028164] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.028817] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.029639] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0b 17 03 03 05 86 .............
[13025.030521] [tempesta tls] => segment 1, ptr= pK-error len=9
[13025.031172] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13025.031822] [tempesta tls] 00000000: 00 05 7d 00 00 00 00 00 01 ..}......
[13025.032668] [tempesta tls] => segment 2, ptr= pK-error len=1405
[13025.033357] [tempesta tls] dump 'data' (ptr=(einval), 234 bytes):
[13025.033990] [tempesta tls] 00000000: 6d 67 22 20 73 72 63 3d 22 2f 69 6d 67 2f 66 61 mg" src="/img/fa
[13025.034821] [tempesta tls] 00000010: 63 65 62 6f 6f 6b 2e 73 76 67 22 20 6f 6e 6d 6f cebook.svg" onmo
[13025.035678] [tempesta tls] 00000020: 75 73 65 6f 76 65 72 3d 22 74 68 69 73 2e 73 72 useover="this.sr
[13025.036598] [tempesta tls] 00000030: 63 3d 27 2f 69 6d 67 2f 66 61 63 65 62 6f 6f 6b c='/img/facebook
[13025.037469] [tempesta tls] 00000040: 5f 6c 67 2e 73 76 67 27 3b 22 20 6f 6e 6d 6f 75 _lg.svg';" onmou
[13025.038320] [tempesta tls] 00000050: 73 65 6f 75 74 3d 22 74 68 69 73 2e 73 72 63 3d seout="this.src=
[13025.039474] [tempesta tls] 00000060: 27 2f 69 6d 67 2f 66 61 63 65 62 6f 6f 6b 2e 73 '/img/facebook.s
[13025.040307] [tempesta tls] 00000070: 76 67 27 3b 22 20 74 69 74 6c 65 3d 22 46 6f 6c vg';" title="Fol
[13025.041124] [tempesta tls] 00000080: 6c 6f 77 20 75 73 20 6f 6e 20 46 61 63 65 62 6f low us on Facebo
[13025.042095] [tempesta tls] 00000090: 6f 6b 22 3e 3c 2f 61 3e 20 3c 61 20 68 72 65 66 ok"></a> <a href
[13025.043028] [tempesta tls] 000000a0: 3d 22 68 74 74 70 73 3a 2f 2f 67 69 74 68 75 62 ="https://github
[13025.043956] [tempesta tls] 000000b0: 2e 63 6f 6d 2f 74 65 6d 70 65 73 74 61 2d 74 65 .com/tempesta-te
[13025.044873] [tempesta tls] 000000c0: 63 68 22 3e 3c 69 6d 67 20 63 6c 61 73 73 3d 22 ch"><img class="
[13025.045951] [tempesta tls] 000000d0: 73 6d 5f 6c 69 6d 67 22 20 73 72 63 3d 22 2f 69 sm_limg" src="/i
[13025.046878] [tempesta tls] 000000e0: 6d 67 2f 67 69 74 68 75 62 2e mg/github.
[13025.047706] [tempesta tls] encrypted buf (first 64 bytes) (sgn=4 sglist= pK-error len=64):
[13025.048536] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.049204] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.049852] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0b 17 03 03 05 86 .............
[13025.050681] [tempesta tls] => segment 1, ptr= pK-error len=9
[13025.051345] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13025.052152] [tempesta tls] 00000000: ab 2b ea 12 e4 7d 1e ed 71 .+...}..q
[13025.052998] [tempesta tls] => segment 2, ptr= pK-error len=1405
[13025.053680] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13025.054332] [tempesta tls] 00000000: 66 ff c8 b8 7e 4f 02 05 48 63 2c 55 48 f3 28 f2 f...~O..Hc,UH.(.
[13025.055476] [tempesta tls] 00000010: 02 47 c7 89 57 eb ec 9e 17 66 b9 59 6b c3 00 6e .G..W....f.Yk..n
[13025.056320] [tempesta tls] 00000020: 12 46 e4 94 84 d6 31 b8 8a 62 .F....1..b
[13025.057121] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=1438
[13025.057888] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13025.058644] [tempesta tls] ttls_recv: tls= pK-error len=46 read=0
[13025.059309] [tempesta tls] input rec: type=23 ver=3:3 msglen=41 read=5 xfrm_ready=1
[13025.060026] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=41 chunks=1 eiv_len=8
[13025.060876] [tempesta tls] build req sglist: skb= pK-error next= pK-error len=46 off=13
[13025.061742] [tempesta tls] build req sglist (sgn=1 sglist= pK-error len=33):
[13025.062804] [tempesta tls] => segment 0, ptr= pK-error len=33
[13025.063503] [tempesta tls] dump 'data' (ptr=(einval), 33 bytes):
[13025.064346] [tempesta tls] 00000000: 21 3a 11 ba ff e4 8b 8a fc 0c 90 db 10 35 91 c3 !:...........5..
[13025.065317] [tempesta tls] 00000010: d9 8f 1d f4 dd 10 54 31 e3 cd 26 38 5a 0f 26 bb ......T1..&8Z.&.
[13025.066276] [tempesta tls] 00000020: 35 5
[13025.067082] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=0 sgn=2
[13025.068351] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=17
[13025.069045] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13025.069855] [tempesta tls] 00000000: 00 00 00 00 00 00 00 06 17 03 03 00 11 .............
[13025.070723] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13025.071508] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 d3 ...q.d.X....
[13025.072508] [tempesta tls] decrypt: AAD|msg|TAG (sgn=2 sglist= pK-error len=46):
[13025.073272] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.073909] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.074522] [tempesta tls] 00000000: 00 00 00 00 00 00 00 06 17 03 03 00 11 .............
[13025.075324] [tempesta tls] => segment 1, ptr= pK-error len=33
[13025.075980] [tempesta tls] dump 'data' (ptr=(einval), 33 bytes):
[13025.076626] [tempesta tls] 00000000: 21 3a 11 ba ff e4 8b 8a fc 0c 90 db 10 35 91 c3 !:...........5..
[13025.077435] [tempesta tls] 00000010: d9 8f 1d f4 dd 10 54 31 e3 cd 26 38 5a 0f 26 bb ......T1..&8Z.&.
[13025.078392] [tempesta tls] 00000020: 35 5
[13025.079157] [tempesta tls] raw buffer after decryption (sgn=1 sglist= pK-error len=17):
[13025.079922] [tempesta tls] => segment 0, ptr= pK-error len=33
[13025.080575] [tempesta tls] dump 'data' (ptr=(einval), 17 bytes):
[13025.081190] [tempesta tls] 00000000: 00 00 08 07 00 00 00 00 00 00 00 00 00 00 00 00 ................
[13025.082144] [tempesta tls] 00000010: 09 .
[13025.082885] [tempesta fw] tfw_tls_connection_recv: parsed=46 skb->len=46
[13025.083540] [tempesta fw] ss_skb_chop_head_tail: head=0xd trail=0x10 skb= pK-error (head= pK-error data= pK-error tail= pK-error end= pK-error len=46 data_len=0 nr_frags=0)
[13025.085113] [tempesta fw] HTTP/2 connection is closed by client with error code: 9, ID of last processed stream: 0
[13025.085976] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Established
[13025.087001] [tempesta tls] ttls_recv: tls= pK-error len=31 read=0
[13025.087668] [tempesta tls] input rec: type=21 ver=3:3 msglen=26 read=5 xfrm_ready=1
[13025.088404] [tempesta tls] decrypt input record from network: hdr= pK-error msglen=26 chunks=1 eiv_len=8
[13025.089259] [tempesta tls] build req sglist: skb= pK-error next= pK-error len=31 off=13
[13025.090076] [tempesta tls] build req sglist (sgn=1 sglist= pK-error len=18):
[13025.090804] [tempesta tls] => segment 0, ptr= pK-error len=18
[13025.091459] [tempesta tls] dump 'data' (ptr=(einval), 18 bytes):
[13025.092263] [tempesta tls] 00000000: 9a 8d 3a e1 c7 cd bc 07 6c 2b 71 11 ef c0 00 dc ..:.....l+q.....
[13025.093100] [tempesta tls] 00000010: 01 a2 ..
[13025.093960] [tempesta tls] ttls_crypto_req_sglist: skb= pK-error buf= pK-error sg= pK-error off=0 len=0 sgn=2
[13025.095299] [tempesta tls] use record hdr: type=21 ver=3:3 hdr_len=2
[13025.095961] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13025.096750] [tempesta tls] 00000000: 00 00 00 00 00 00 00 07 15 03 03 00 02 .............
[13025.097587] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13025.098257] [tempesta tls] 00000000: ab dc 2e 71 fa 64 95 58 ed c4 f5 d4 ...q.d.X....
[13025.099241] [tempesta tls] decrypt: AAD|msg|TAG (sgn=2 sglist= pK-error len=31):
[13025.100020] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.100697] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.101336] [tempesta tls] 00000000: 00 00 00 00 00 00 00 07 15 03 03 00 02 .............
[13025.102343] [tempesta tls] => segment 1, ptr= pK-error len=18
[13025.103353] [tempesta tls] dump 'data' (ptr=(einval), 18 bytes):
[13025.103990] [tempesta tls] 00000000: 9a 8d 3a e1 c7 cd bc 07 6c 2b 71 11 ef c0 00 dc ..:.....l+q.....
[13025.104833] [tempesta tls] 00000010: 01 a2 ..
[13025.105595] [tempesta tls] raw buffer after decryption (sgn=1 sglist= pK-error len=2):
[13025.106369] [tempesta tls] => segment 0, ptr= pK-error len=18
[13025.107021] [tempesta tls] dump 'data' (ptr=(einval), 2 bytes):
[13025.107644] [tempesta tls] 00000000: 01 00 ..
[13025.108425] [tempesta tls] got an alert message, type=1:0
[13025.108997] [tempesta tls] is a close notify message
[13025.109559] [tempesta tls] write close notify
[13025.110131] [tempesta tls] send alert level=1 message=0
[13025.111046] [tempesta tls] write record: type=21 len=2 hslen=2 sgt= pK-error/0 sg_i=0 ready=1
[13025.112329] [tempesta fw] TLS 2 bytes +0 segments (2 bytes, last msgtype 0x15) are to be sent on conn= pK-error/sk_write_xmit= pK-error ready=1
[13025.113863] [tempesta fw] [1]: ss_send: sk=000000004a3e83a1 (cpu=1) state=Established
[13025.114611] [tempesta fw] [1]: Processing error: sk= pK-error r=-3
[13025.115299] [tempesta fw] [1]: ss_tcp_state_change: sk=000000004a3e83a1 state=Close Wait
[13025.116050] [tempesta fw] Received data FIN on sk=000000004a3e83a1, cpu=1
[13025.116737] [tempesta fw] [1]: Peer connection closing
[13025.117311] [tempesta fw] [1]: ss_tcp_data_ready: sk=000000004a3e83a1 state=Close Wait
[13025.118884] [tempesta fw] [1]: ss_do_send: sk= pK-error queue_empty=0 send_head= pK-error sk_state=8 mss=1448 size=31856
[13025.120130] [tempesta fw] [1]: ss_do_send: entail sk= pK-error skb= pK-error data_len=0 len=2 truesize=896 mark=0 tls_type=15
[13025.121405] [tempesta fw] [1]: ss_do_send: sk=000000004a3e83a1 send_head=000000002eaae227 sk_state=8 flags=1508
[13025.122438] [tempesta fw] [1]: __skb_fragment: len=9 pspt= pK-error skb= pK-error head= pK-error data= pK-error tail= pK-error end= pK-error len=485 data_len=485 truesize=1381 nr_frags=1
[13025.124144] [tempesta fw] [1]: __skb_fragment: out: res [000000009484d7ed], skb [000000002eaae227]: head [000000009e9620a6] data [00000000836911bf] tail [00000000836911bf] end [000000002b93f7df] len [494] data_len [494] truesize [1390] nr_frags [2]
[13025.126380] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467821218 snd_nxt=1467840007 limit=234) skb= pK-error(len=234 data_len=234 type=23 frags=2 headlen=0 seq=1467840007:1467840241)
[13025.128426] [tempesta fw] skb_to_sgvec (4 segs) from skb pK-error (263 bytes, 4 segs), done_frags=0 ret=4
[13025.129402] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13025.130129] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 0c ...t........
[13025.131108] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=234
[13025.131932] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13025.132787] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0c 17 03 03 00 ea .............
[13025.133647] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=234
[13025.135404] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=4 sglist= pK-error len=256):
[13025.136352] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.137049] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.137728] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0c 17 03 03 00 ea .............
[13025.138598] [tempesta tls] => segment 1, ptr= pK-error len=9
[13025.139314] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13025.139984] [tempesta tls] 00000000: 00 00 e1 00 01 00 00 00 01 .........
[13025.140873] [tempesta tls] => segment 2, ptr= pK-error len=225
[13025.141607] [tempesta tls] dump 'data' (ptr=(einval), 225 bytes):
[13025.142524] [tempesta tls] 00000000: 29 64 6f 63 75 6d 65 6e 74 2e 77 72 69 74 65 28 )document.write(
[13025.143523] [tempesta tls] 00000010: 27 3c 73 63 72 69 70 74 20 73 72 63 3d 22 2f 6a '<script src="/j
[13025.144424] [tempesta tls] 00000020: 73 2f 62 6f 6f 74 73 74 72 61 70 2e 6d 69 6e 2e s/bootstrap.min.
[13025.145305] [tempesta tls] 00000030: 6a 73 22 3e 3c 5c 2f 73 63 72 69 70 74 3e 27 29 js"><\/script>')
[13025.146178] [tempesta tls] 00000040: 3b 3c 2f 73 63 72 69 70 74 3e 3c 73 63 72 69 70 ;</script><scrip
[13025.147054] [tempesta tls] 00000050: 74 20 73 72 63 3d 22 2f 6a 73 2f 70 72 69 73 6d t src="/js/prism
[13025.147930] [tempesta tls] 00000060: 2e 6d 69 6e 2e 6a 73 22 3e 3c 2f 73 63 72 69 70 .min.js"></scrip
[13025.148818] [tempesta tls] 00000070: 74 3e 3c 73 63 72 69 70 74 20 74 79 70 65 3d 22 t><script type="
[13025.149704] [tempesta tls] 00000080: 74 65 78 74 2f 6a 61 76 61 73 63 72 69 70 74 22 text/javascript"
[13025.150604] [tempesta tls] 00000090: 20 73 72 63 3d 22 68 74 74 70 73 3a 2f 2f 61 73 src="https://as
[13025.151618] [tempesta tls] 000000a0: 73 65 74 73 2e 63 61 6c 65 6e 64 6c 79 2e 63 6f sets.calendly.co
[13025.152704] [tempesta tls] 000000b0: 6d 2f 61 73 73 65 74 73 2f 65 78 74 65 72 6e 61 m/assets/externa
[13025.153585] [tempesta tls] 000000c0: 6c 2f 77 69 64 67 65 74 2e 6a 73 22 3e 3c 2f 73 l/widget.js"></s
[13025.154457] [tempesta tls] 000000d0: 63 72 69 70 74 3e 3c 73 63 72 69 70 74 20 74 79 cript><script ty
[13025.155366] [tempesta tls] 000000e0: 70 p
[13025.156355] [tempesta tls] => segment 3, ptr= pK-error len=16
[13025.157061] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13025.157864] [tempesta tls] 00000000: 00 01 00 00 00 00 ad de 22 ........"
[13025.158922] [tempesta tls] encrypted buf (first 64 bytes) (sgn=4 sglist= pK-error len=64):
[13025.159872] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.160592] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.161258] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0c 17 03 03 00 ea .............
[13025.162313] [tempesta tls] => segment 1, ptr= pK-error len=9
[13025.162987] [tempesta tls] dump 'data' (ptr=(einval), 9 bytes):
[13025.163636] [tempesta tls] 00000000: ec 61 d7 f3 ef e7 00 09 56 .a......V
[13025.164463] [tempesta tls] => segment 2, ptr= pK-error len=225
[13025.165133] [tempesta tls] dump 'data' (ptr=(einval), 42 bytes):
[13025.165742] [tempesta tls] 00000000: 37 5b a3 1a de a1 c4 c3 9a 79 71 c7 21 27 49 4a 7[.......yq.!'IJ
[13025.166559] [tempesta tls] 00000010: e6 83 fe 35 0b cd 8c 3d 30 95 47 99 6e 48 a0 0a ...5...=0.G.nH..
[13025.167534] [tempesta tls] 00000020: 3f f9 4d c8 9d 7a 37 c4 7e 64 ?.M..z7.~d
[13025.168325] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=258
[13025.169013] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467821218 snd_nxt=1467840270 limit=1414) skb= pK-error(len=260 data_len=260 type=23 frags=1 headlen=0 seq=1467840270:1467840530)
[13025.171073] [tempesta fw] next skb ( pK-error) in write queue: len=2 frags=0/1 type=21 seq=1467840501:1467840503
[13025.172028] [tempesta fw] skb_to_sgvec (3 segs) from skb pK-error (289 bytes, 3 segs), done_frags=0 ret=3
[13025.172885] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13025.173515] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 0d ...t........
[13025.174337] [tempesta tls] use record hdr: type=23 ver=3:3 hdr_len=260
[13025.174993] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13025.175791] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0d 17 03 03 01 04 .............
[13025.176779] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=260
[13025.178226] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=3 sglist= pK-error len=256):
[13025.179117] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.179784] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.180431] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0d 17 03 03 01 04 .............
[13025.181251] [tempesta tls] => segment 1, ptr= pK-error len=260
[13025.182036] [tempesta tls] dump 'data' (ptr=(einval), 243 bytes):
[13025.183036] [tempesta tls] 00000000: 65 3d 22 74 65 78 74 2f 6a 61 76 61 73 63 72 69 e="text/javascri
[13025.183867] [tempesta tls] 00000010: 70 74 22 20 73 72 63 3d 22 68 74 74 70 73 3a 2f pt" src="https:/
[13025.184712] [tempesta tls] 00000020: 2f 77 69 64 67 65 74 2e 63 6c 75 74 63 68 2e 63 /widget.clutch.c
[13025.185615] [tempesta tls] 00000030: 6f 2f 73 74 61 74 69 63 2f 6a 73 2f 77 69 64 67 o/static/js/widg
[13025.186594] [tempesta tls] 00000040: 65 74 2e 6a 73 22 3e 3c 2f 73 63 72 69 70 74 3e et.js"></script>
[13025.187462] [tempesta tls] 00000050: 3c 73 63 72 69 70 74 3e 69 66 28 24 28 22 2e 63 <script>if($(".c
[13025.188410] [tempesta tls] 00000060: 68 61 72 74 22 29 2e 6c 65 6e 67 74 68 29 64 6f hart").length)do
[13025.189246] [tempesta tls] 00000070: 63 75 6d 65 6e 74 2e 77 72 69 74 65 28 27 3c 73 cument.write('<s
[13025.190097] [tempesta tls] 00000080: 63 72 69 70 74 20 73 72 63 3d 22 2f 6a 73 2f 68 cript src="/js/h
[13025.191134] [tempesta tls] 00000090: 69 67 68 63 68 61 72 74 73 2e 6d 69 6e 2e 6a 73 ighcharts.min.js
[13025.192257] [tempesta tls] 000000a0: 22 3e 3c 5c 2f 73 63 72 69 70 74 3e 27 29 3b 3c "><\/script>');<
[13025.193117] [tempesta tls] 000000b0: 2f 73 63 72 69 70 74 3e 3c 73 63 72 69 70 74 20 /script><script
[13025.193956] [tempesta tls] 000000c0: 73 72 63 3d 22 2f 6a 73 2f 6d 61 69 6e 2e 6d 69 src="/js/main.mi
[13025.194828] [tempesta tls] 000000d0: 6e 2e 6a 73 22 20 74 79 70 65 3d 22 74 65 78 74 n.js" type="text
[13025.195702] [tempesta tls] 000000e0: 2f 6a 61 76 61 73 63 72 69 70 74 22 3e 3c 2f 73 /javascript"></s
[13025.196594] [tempesta tls] 000000f0: 63 72 69 cri
[13025.197427] [tempesta tls] encrypted buf (first 64 bytes) (sgn=3 sglist= pK-error len=64):
[13025.198282] [tempesta tls] => segment 0, ptr= pK-error len=13
[13025.199335] [tempesta tls] dump 'data' (ptr=(einval), 13 bytes):
[13025.200011] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0d 17 03 03 01 04 .............
[13025.200892] [tempesta tls] => segment 1, ptr= pK-error len=260
[13025.201605] [tempesta tls] dump 'data' (ptr=(einval), 51 bytes):
[13025.202462] [tempesta tls] 00000000: 4b d1 73 44 32 8f 27 b9 aa d9 0a 18 4b ab 34 07 K.sD2.'.....K.4.
[13025.203354] [tempesta tls] 00000010: 06 21 56 4c 9e 99 76 42 df fa 43 2e aa 7d b3 ac .!VL..vB..C..}..
[13025.204198] [tempesta tls] 00000020: c2 35 1b 8f 7c 06 0a f8 2b 73 94 68 33 c5 cb 66 .5..|...+s.h3..f
[13025.205035] [tempesta tls] 00000030: 63 84 fd c..
[13025.205808] [tempesta tls] write record hdr from AAD: type=23 ver=3:3 hdr_len=284
[13025.206544] [tempesta fw] tfw_tls_encrypt: sk= pK-error(snd_una=1467821218 snd_nxt=1467840559 limit=1414) skb= pK-error(len=2 data_len=0 type=21 frags=0 headlen=2 seq=1467840559:1467840561)
[13025.208313] [tempesta fw] skb_to_sgvec (1 segs) from skb pK-error (31 bytes, 1 segs), done_frags=0 ret=1
[13025.209273] [tempesta tls] dump 'IV used' (ptr=(einval), 12 bytes):
[13025.209938] [tempesta tls] 00000000: ca 8b e2 74 00 00 00 00 00 00 00 0e ...t........
[13025.210761] [tempesta tls] use record hdr: type=21 ver=3:3 hdr_len=2
[13025.211420] [tempesta tls] dump 'additional data used for AEAD' (ptr=(einval), 13 bytes):
[13025.212360] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0e 15 03 03 00 02 .............
[13025.213182] [tempesta tls] AES-128-GCM encryption: tfm= pK-error(req->tfm= pK-error req= pK-error) reqsize=88 key_len=16 data_len=2
[13025.214512] [tempesta tls] plaintext buf for encryption (first 256 bytes) (sgn=1 sglist= pK-error len=31):
[13025.215670] [tempesta tls] => segment 0, ptr= pK-error len=31
[13025.216398] [tempesta tls] dump 'data' (ptr=(einval), 31 bytes):
[13025.217046] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0e 15 03 03 00 02 01 00 63 ...............c
[13025.217876] [tempesta tls] 00000010: 27 80 7c 0f 5b dc 11 ec 4c c1 64 1d 6c de db '.|.[...L.d.l..
[13025.218715] [tempesta tls] encrypted buf (first 64 bytes) (sgn=1 sglist= pK-error len=31):
[13025.219526] [tempesta tls] => segment 0, ptr= pK-error len=31
[13025.220258] [tempesta tls] dump 'data' (ptr=(einval), 31 bytes):
[13025.220900] [tempesta tls] 00000000: 00 00 00 00 00 00 00 0e 15 03 03 00 02 27 ad 84 .............'..
[13025.221730] [tempesta tls] 00000010: 93 1b aa 11 91 1c 3d 83 f4 ac ae ee 17 a3 4d ......=.......M
[13025.222728] [tempesta tls] write record hdr from AAD: type=21 ver=3:3 hdr_len=26
[13025.223623] [tempesta fw] [1]: Close socket 000000004a3e83a1 (Close Wait): account=1 refcnt=7
[13025.224465] [tempesta fw] tfw_http_conn_drop: conn=[00000000ae2a04ec]
Note that Tempesta is trying to send response with many small (why?) chunks after it reports failed request with 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "curl/7.81.0"
Probably, there is issue with HTTP/2 headers encoding, at least it seems wireshark can't decode them: I'm attaching the pcap file and the TLS session key 1849.pcap.txt key-1849.txt I think it's safe to ignore TCP retransmits as they are probably caused by highly verbose debugging output in the VM's softirq.
Once the configuration has caching and resp_hdr_set
directive it could be linked with #1831 .
However, there are 3 issues to resolve:
I confirm that with #1831 the problem with curl
and h2load -n 1 -c 1 -t 1 https://tempesta-tech.com
has gone. The regular h2load
benchmark works much better, but there are only 87% of successful requests and the log still has many 0 code response codes:
$ taskset --cpu-list 1,2,4,6 h2load -n 10000 -c 128 -t 4 https://tempesta-tech.com
starting benchmark...
spawning thread #0: 32 total client(s). 2500 total requests
spawning thread #1: 32 total client(s). 2500 total requests
spawning thread #2: 32 total client(s). 2500 total requests
spawning thread #3: 32 total client(s). 2500 total requests
TLS Protocol: TLSv1.2
Cipher: ECDHE-ECDSA-AES128-GCM-SHA256
Server Temp Key: ECDH P-256 256 bits
Application protocol: h2
progress: 10% done
progress: 20% done
progress: 30% done
progress: 40% done
progress: 50% done
progress: 60% done
progress: 70% done
progress: 80% done
progress: 90% done
finished in 6.29s, 1394.00 req/s, 34.94MB/s
requests: 10000 total, 8817 started, 8780 done, 8771 succeeded, 1229 failed, 1229 errored, 0 timeout
status codes: 8808 2xx, 0 3xx, 0 4xx, 0 5xx
traffic: 219.85MB (230531606) total, 1.97MB (2061033) headers (space savings 23.78%), 217.14MB (227689848) data
min max mean sd +/- sd
time for request: 389us 275.29ms 71.16ms 37.83ms 77.36%
time for connect: 9.13ms 105.48ms 52.62ms 30.37ms 72.66%
time to 1st byte: 23.24ms 152.20ms 92.73ms 38.84ms 61.72%
req/s : 0.00 16.70 13.55 2.22 68.75%
The partial dmesg
log:
[ 1311.353696] [tempesta fw] Tempesta FW is ready
[ 1333.513358] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 200 25865 "-" "h2load nghttp2/1.43.0"
[ 1333.515343] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 200 25865 "-" "h2load nghttp2/1.43.0"
[ 1333.516670] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 200 25865 "-" "h2load nghttp2/1.43.0"
[ 1333.518304] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.522209] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.523020] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.524334] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.526852] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.527911] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.529402] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.530643] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.531421] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.532416] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.533343] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.534374] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.535351] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
....
[ 1333.971017] [tempesta fw] HTTP/2 connection is closed by client with error code: 6, ID of last processed stream: 0
[ 1333.971743] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.973231] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.974045] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
[ 1333.974765] [tempesta fw] 192.168.100.1 "tempesta-tech.com" "GET / HTTP/2.0" 0 0 "-" "h2load nghttp2/1.43.0"
....
I tried to run
h2load
against Tempesta FW master as of 5f240736693e2280f868808656ffa220e424c2ad running with the configNginx with our static website is running on
192.168.100.4:8000
.Tempesta FW runs in a 2 CPU VM with the Nginx backend and I have 4 more CPUs on the host to run the benchmark. With (I have
192.168.100.4 tempesta-tech.com
in my/etc/host
) I haveI dmesg I see some 200 response codes and about x10 more 0 (i.e. a response wasn't received):
Besides the response errors itself, the problem is that the errors aren't traced in the log at all.