**** dT 0.000
* top TEST ../../../vmod/tests/blob_b00013.vtc starting
**** top extmacro def pkg_version=trunk
**** top extmacro def pkg_branch=trunk
**** top extmacro def pwd=/sysroot/tmp/vtest.gcc/varnish-cache/varnish-trunk/_build/sub/vmod
**** top extmacro def date(...)
**** top extmacro def string(...)
**** top extmacro def localhost=127.0.0.1
**** top extmacro def bad_backend=127.0.0.1:39153
**** top extmacro def listen_addr=127.0.0.1:0
**** top extmacro def bad_ip=192.0.2.255
**** top extmacro def topbuild=/tmp/vtest.gcc/varnish-cache/varnish-trunk/_build/sub
**** top extmacro def topsrc=/tmp/vtest.gcc/varnish-cache/varnish-trunk/_build/sub/../..
**** top macro def testdir=/sysroot/tmp/vtest.gcc/varnish-cache/varnish-trunk/_build/sub/vmod/../../../vmod/tests
**** top macro def tmpdir=/tmp/vtest.gcc/_vtest_tmp/vtc.5067.06c1594b
** top === varnishtest "VMOD blob test transcode() n chars"
* top VTEST VMOD blob test transcode() n chars
** top === varnish v1 -vcl {
**** dT 0.036
** v1 Launch
*** v1 CMD: cd ${pwd} && exec varnishd -d -n /tmp/vtest.gcc/_vtest_tmp/vtc.5067.06c1594b/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 37833' -P /tmp/vtest.gcc/_vtest_tmp/vtc.5067.06c1594b/v1/varnishd.pid -p vmod_path=/tmp/vtest.gcc/varnish-cache/varnish-trunk/_build/sub/vmod/.libs
*** v1 CMD: cd /sysroot/tmp/vtest.gcc/varnish-cache/varnish-trunk/_build/sub/vmod && exec varnishd -d -n /tmp/vtest.gcc/_vtest_tmp/vtc.5067.06c1594b/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 37833' -P /tmp/vtest.gcc/_vtest_tmp/vtc.5067.06c1594b/v1/varnishd.pid -p vmod_path=/tmp/vtest.gcc/varnish-cache/varnish-trunk/_build/sub/vmod/.libs
**** dT 0.037
*** v1 PID: 5113
**** v1 macro def v1_pid=5113
**** v1 macro def v1_name=/tmp/vtest.gcc/_vtest_tmp/vtc.5067.06c1594b/v1
**** dT 0.125
*** v1 debug|Debug: Version: varnish-trunk revision 8bfc5948c5031d4ca83a8ae200977d14fa5f0b75
*** v1 debug|Debug: Platform: Linux,5.3.11-100.fc29.x86_64,x86_64,-jnone,-sdefault,-sdefault,-hcritbit
*** v1 debug|200 323
*** v1 debug|-----------------------------
*** v1 debug|Varnish Cache CLI 1.0
*** v1 debug|-----------------------------
*** v1 debug|Linux,5.3.11-100.fc29.x86_64,x86_64,-jnone,-sdefault,-sdefault,-hcritbit
*** v1 debug|varnish-trunk revision 8bfc5948c5031d4ca83a8ae200977d14fa5f0b75
*** v1 debug|
*** v1 debug|Type 'help' for command list.
*** v1 debug|Type 'quit' to close CLI session.
*** v1 debug|Type 'start' to launch worker process.
*** v1 debug|
**** dT 0.217
**** v1 CLIPOLL 1 0x1 0x0 0x0
*** v1 CLI connection fd = 5
*** v1 CLI RX 107
**** v1 CLI RX|gwrpgebeeqgwteoxnimdlpkflpqjbtcq
**** v1 CLI RX|
**** v1 CLI RX|Authentication required.
**** dT 0.218
**** v1 CLI TX|auth 4ce65b5b0dd18a8bd3fdb763b9872ec389a937147671efea324e5ef8b67be391
*** v1 CLI RX 200
**** v1 CLI RX|-----------------------------
**** v1 CLI RX|Varnish Cache CLI 1.0
**** v1 CLI RX|-----------------------------
**** v1 CLI RX|Linux,5.3.11-100.fc29.x86_64,x86_64,-jnone,-sdefault,-sdefault,-hcritbit
**** v1 CLI RX|varnish-trunk revision 8bfc5948c5031d4ca83a8ae200977d14fa5f0b75
**** v1 CLI RX|
**** v1 CLI RX|Type 'help' for command list.
**** v1 CLI RX|Type 'quit' to close CLI session.
**** v1 CLI RX|Type 'start' to launch worker process.
**** v1 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P
**** v1 CLI TX|vcl 4.1;
**** v1 CLI TX|
**** v1 CLI TX|\timport blob;
**** v1 CLI TX|\timport std;
**** v1 CLI TX|\tbackend b None;
**** v1 CLI TX|
**** v1 CLI TX|\tsub vcl_recv {
**** v1 CLI TX|\t return(synth(200));
**** v1 CLI TX|\t}
**** v1 CLI TX|
**** v1 CLI TX|\tsub vcl_synth {
**** v1 CLI TX|\t set req.http.foobar = "foo:bar:baz:quux";
**** v1 CLI TX|\t set req.http.hobbes =
**** v1 CLI TX|{"Man is distinguished, not only by his reason, but by this singular passion from other animals, which is a lust of the mind, that by a perseverance of delight in the continued and indefatigable generation of knowledge, exceeds the short vehemence of any carnal pleasure."};
**** v1 CLI TX|\t set req.http.hobbesb64 =
**** v1 CLI TX|{"TWFuIGlzIGRpc3Rpbmd1aXNoZWQsIG5vdCBvbmx5IGJ5IGhpcyByZWFzb24sIGJ1dCBieSB0aGlzIHNpbmd1bGFyIHBhc3Npb24gZnJvbSBvdGhlciBhbmltYWxzLCB3aGljaCBpcyBhIGx1c3Qgb2YgdGhlIG1pbmQsIHRoYXQgYnkgYSBwZXJzZXZlcmFuY2Ugb2YgZGVsaWdodCBpbiB0aGUgY29udGludWVkIGFuZCBpbmRlZmF0aWdhYmxlIGdlbmVyYXRpb24gb2Yga25vd2xlZGdlLCBleGNlZWRzIHRoZSBzaG9ydCB2ZWhlbWVuY2Ugb2YgYW55IGNhcm5hbCBwbGVhc3VyZS4="};
**** v1 CLI TX|\t set req.http.hexhobbes = "4d616e2069732064697374696e677569736865642c206e6f74206f6e6c792062792068697320726561736f6e2c2062757420627920746869732073696e67756c61722070617373696f6e2066726f6d206f7468657220616e696d616c732c2077686963682069732061206c757374206f6620746865206d696e642c20746861742062792061207065727365766572616e6365206f662064656c6967687420696e2074686520636f6e74696e75656420616e6420696e6465666174696761626c652067656e65726174696f6e206f66206b6e6f776c656467652c2065786365656473207468652073686f727420766568656d656e6365206f6620616e79206361726e616c20706c6561737572652e";
**** v1 CLI TX|\t set req.http.hexalldown =
**** v1 CLI TX|{"fffefdfcfbfaf9f8f7f6f5f4f3f2f1f0efeeedecebeae9e8e7e6e5e4e3e2e1e0dfdedddcdbdad9d8d7d6d5d4d3d2d1d0cfcecdcccbcac9c8c7c6c5c4c3c2c1c0bfbebdbcbbbab9b8b7b6b5b4b3b2b1b0afaeadacabaaa9a8a7a6a5a4a3a2a1a09f9e9d9c9b9a999897969594939291908f8e8d8c8b8a898887868584838281807f7e7d7c7b7a797877767574737271706f6e6d6c6b6a696867666564636261605f5e5d5c5b5a595857565554535251504f4e4d4c4b4a494847464544434241403f3e3d3c3b3a393837363534333231302f2e2d2c2b2a292827262524232221201f1e1d1c1b1a191817161514131211100f0e0d0c0b0a09080706050403020100"};
**** v1 CLI TX|\t set req.http.hexallup =
**** v1 CLI TX|{"000102030405060708090a0b0c0d0e0f101112131415161718191a1b1c1d1e1f202122232425262728292a2b2c2d2e2f303132333435363738393a3b3c3d3e3f404142434445464748494a4b4c4d4e4f505152535455565758595a5b5c5d5e5f606162636465666768696a6b6c6d6e6f707172737475767778797a7b7c7d7e7f808182838485868788898a8b8c8d8e8f909192939495969798999a9b9c9d9e9fa0a1a2a3a4a5a6a7a8a9aaabacadaeafb0b1b2b3b4b5b6b7b8b9babbbcbdbebfc0c1c2c3c4c5c6c7c8c9cacbcccdcecfd0d1d2d3d4d5d6d7d8d9dadbdcdddedfe0e1e2e3e4e5e6e7e8e9eaebecedeeeff0f1f2f3f4f5f6f7f8f9fafbfcfdfeff"};
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2id
**** v1 CLI TX|\t = blob.transcode(IDENTITY, IDENTITY, length=5,
**** v1 CLI TX|\t\t\t encoded="Hello world");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2b64
**** v1 CLI TX|\t = blob.transcode(IDENTITY, BASE64, length=5,
**** v1 CLI TX|\t\t\t encoded=req.http.hobbes);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2b64nopad
**** v1 CLI TX|\t = blob.transcode(IDENTITY, BASE64URLNOPAD, length=5,
**** v1 CLI TX|\t\t\t encoded=req.http.hobbes);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2hex
**** v1 CLI TX|\t = blob.transcode(IDENTITY, HEX, length=5, encoded=req.http.hobbes);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2hexuc
**** v1 CLI TX|\t = blob.transcode(IDENTITY, HEX, UPPER, 5, req.http.hobbes);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2hexlc
**** v1 CLI TX|\t = blob.transcode(IDENTITY, HEX, LOWER, 5, req.http.hobbes);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2url
**** v1 CLI TX|\t = blob.transcode(IDENTITY, URL, length=5, encoded=req.http.foobar);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2urluc
**** v1 CLI TX|\t = blob.transcode(IDENTITY, URL, UPPER, 5, req.http.foobar);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.id2urllc
**** v1 CLI TX|\t = blob.transcode(IDENTITY, URL, LOWER, 5, req.http.foobar);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b642id
**** v1 CLI TX|\t = blob.transcode(BASE64, IDENTITY, length=8,
**** v1 CLI TX|\t\t\t encoded=req.http.hobbesb64);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hex2id
**** v1 CLI TX|\t = blob.transcode(HEX, IDENTITY, length=12,
**** v1 CLI TX|\t\t\t encoded=req.http.hexhobbes);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexalldown2b64
**** v1 CLI TX|\t = blob.transcode(HEX, BASE64, length=12,
**** v1 CLI TX|\t\t\t encoded=req.http.hexalldown);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexalldown2b64url
**** v1 CLI TX|\t = blob.transcode(HEX, BASE64URL, length=12,
**** v1 CLI TX|\t\t\t encoded=req.http.hexalldown);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexalldown2b64nopad
**** v1 CLI TX|\t = blob.transcode(HEX, BASE64URLNOPAD, length=10,
**** v1 CLI TX|\t\t\t encoded=req.http.hexalldown);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexallup2b64
**** v1 CLI TX|\t = blob.transcode(HEX, BASE64, length=12, encoded=req.http.hexallup);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexallup2b64url
**** v1 CLI TX|\t = blob.transcode(HEX, BASE64URL, length=10,
**** v1 CLI TX|\t\t\t encoded=req.http.hexallup);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexallup2b64nopad
**** v1 CLI TX|\t = blob.transcode(HEX, BASE64URLNOPAD, length=10,
**** v1 CLI TX|\t\t\t encoded=req.http.hexallup);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexalldown2url
**** v1 CLI TX|\t = blob.transcode(HEX, URL, length=12, encoded=req.http.hexalldown);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexalldown2urluc
**** v1 CLI TX|\t = blob.transcode(HEX, URL, UPPER, 12, req.http.hexalldown);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexalldown2urllc
**** v1 CLI TX|\t = blob.transcode(HEX, URL, LOWER, 12, req.http.hexalldown);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexallup2url
**** v1 CLI TX|\t = blob.transcode(HEX, URL, length=12, encoded=req.http.hexallup);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexallup2urluc
**** v1 CLI TX|\t = blob.transcode(HEX, URL, UPPER, 12, req.http.hexallup);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexallup2urllc
**** v1 CLI TX|\t = blob.transcode(HEX, URL, LOWER, 12, req.http.hexallup);
**** v1 CLI TX|
**** v1 CLI TX|\t}
**** v1 CLI TX|
**** v1 CLI TX|%XJEIFLH|)Xspa8P
**** dT 0.328
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.430
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.532
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.633
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.735
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.835
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.936
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.037
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.138
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.240
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.341
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.442
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.543
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.645
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.747
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.849
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 1.950
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 2.052
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 2.155
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 2.256
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 2.360
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 2.462
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 2.563
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 2.578
*** v1 CLI RX 200
**** v1 CLI RX|VCL compiled.
**** v1 CLI TX|vcl.use vcl1
**** dT 2.579
*** v1 CLI RX 200
**** v1 CLI RX|VCL 'vcl1' now active
** v1 Start
**** v1 CLI TX|start
**** dT 2.600
*** v1 debug|Debug: Child (5508) Started
**** dT 2.685
*** v1 debug|Child launched OK
**** dT 2.692
*** v1 CLI RX 200
*** v1 wait-running
**** v1 CLI TX|status
*** v1 debug|Info: Child (5508) said Child starts
*** v1 CLI RX 200
**** v1 CLI RX|Child in state running
**** v1 CLI TX|debug.listen_address
**** dT 2.766
**** v1 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1684790570.992571/vgc.so 1auto
**** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1684790570.992571/vgc.so" as "vcl1"
**** v1 vsl| 0 CLI - Rd vcl.use "vcl1"
**** v1 vsl| 0 CLI - Wr 200 0
**** v1 vsl| 0 CLI - Rd start
**** v1 vsl| 0 Debug - sockopt: Setting SO_LINGER for a0=127.0.0.1:42645
**** v1 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:42645
**** v1 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:42645
**** v1 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:42645
**** v1 vsl| 0 Debug - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:42645
**** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPIDLE for a0=127.0.0.1:42645
**** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPCNT for a0=127.0.0.1:42645
**** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPINTVL for a0=127.0.0.1:42645
**** v1 vsl| 0 CLI - Wr 200 0
**** v1 vsl| 0 CLI - Rd debug.listen_address
**** dT 2.794
*** v1 CLI RX 200
**** v1 CLI RX|a0 127.0.0.1 42645
**** v1 CLI TX|debug.xid 1000
**** dT 2.797
*** v1 CLI RX 200
**** v1 CLI RX|XID is 1000 chunk 1
**** v1 CLI TX|debug.listen_address
**** dT 2.799
*** v1 CLI RX 200
**** v1 CLI RX|a0 127.0.0.1 42645
** v1 Listen on 127.0.0.1 42645
**** v1 macro def v1_addr=127.0.0.1
**** v1 macro def v1_port=42645
**** v1 macro def v1_sock=127.0.0.1:42645
**** v1 macro def v1_a0_addr=127.0.0.1
**** v1 macro def v1_a0_port=42645
**** v1 macro def v1_a0_sock=127.0.0.1:42645
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 2.822
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 15 from 127.0.0.1 54186 to 127.0.0.1:42645
** c1 === txreq
**** c1 txreq|GET / HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 2.830
**** c1 rxhdr|HTTP/1.1 200 OK\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:22:53 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1001\r
**** c1 rxhdr|id2id: Hello\r
**** c1 rxhdr|id2b64: TWFuIGk=\r
**** c1 rxhdr|id2b64nopad: TWFuIGk\r
**** c1 rxhdr|id2hex: 4d616e2069\r
**** c1 rxhdr|id2hexuc: 4D616E2069\r
**** c1 rxhdr|id2hexlc: 4d616e2069\r
**** c1 rxhdr|id2url: foo%3ab\r
**** c1 rxhdr|id2urluc: foo%3Ab\r
**** c1 rxhdr|id2urllc: foo%3ab\r
**** c1 rxhdr|b642id: Man is\r
**** c1 rxhdr|hex2id: Man is\r
**** c1 rxhdr|hexalldown2b64: //79/Pv6\r
**** c1 rxhdr|hexalldown2b64url: __79_Pv6\r
**** c1 rxhdr|hexalldown2b64nopad: __79_Ps\r
**** c1 rxhdr|hexallup2b64: AAECAwQF\r
**** c1 rxhdr|hexallup2b64url: AAECAwQ=\r
**** c1 rxhdr|hexallup2b64nopad: AAECAwQ\r
**** c1 rxhdr|hexalldown2url: %ff%fe%fd%fc%fb%fa\r
**** c1 rxhdr|hexalldown2urluc: %FF%FE%FD%FC%FB%FA\r
**** c1 rxhdr|hexalldown2urllc: %ff%fe%fd%fc%fb%fa\r
**** c1 rxhdr|hexallup2url: %00%01%02%03%04%05\r
**** c1 rxhdr|hexallup2urluc: %00%01%02%03%04%05\r
**** c1 rxhdr|hexallup2urllc: %00%01%02%03%04%05\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 227\r
**** c1 rxhdr|Connection: keep-alive\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 778
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |200
**** c1 http[ 2] |OK
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:22:53 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1001
**** c1 http[ 6] |id2id: Hello
**** c1 http[ 7] |id2b64: TWFuIGk=
**** c1 http[ 8] |id2b64nopad: TWFuIGk
**** c1 http[ 9] |id2hex: 4d616e2069
**** c1 http[10] |id2hexuc: 4D616E2069
**** c1 http[11] |id2hexlc: 4d616e2069
**** c1 http[12] |id2url: foo%3ab
**** c1 http[13] |id2urluc: foo%3Ab
**** c1 http[14] |id2urllc: foo%3ab
**** c1 http[15] |b642id: Man is
**** c1 http[16] |hex2id: Man is
**** c1 http[17] |hexalldown2b64: //79/Pv6
**** c1 http[18] |hexalldown2b64url: __79_Pv6
**** c1 http[19] |hexalldown2b64nopad: __79_Ps
**** c1 http[20] |hexallup2b64: AAECAwQF
**** c1 http[21] |hexallup2b64url: AAECAwQ=
**** c1 http[22] |hexallup2b64nopad: AAECAwQ
**** c1 http[23] |hexalldown2url: %ff%fe%fd%fc%fb%fa
**** c1 http[24] |hexalldown2urluc: %FF%FE%FD%FC%FB%FA
**** c1 http[25] |hexalldown2urllc: %ff%fe%fd%fc%fb%fa
**** c1 http[26] |hexallup2url: %00%01%02%03%04%05
**** c1 http[27] |hexallup2urluc: %00%01%02%03%04%05
**** c1 http[28] |hexallup2urllc: %00%01%02%03%04%05
**** c1 http[29] |Content-Type: text/html; charset=utf-8
**** c1 http[30] |Retry-After: 5
**** c1 http[31] |Content-Length: 227
**** c1 http[32] |Connection: keep-alive
**** dT 2.836
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 200 OK
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 200 OK
**** c1 c-l| OK
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1001
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 227
** c1 === expect resp.http.id2id == "Hello"
**** c1 EXPECT resp.http.id2id (Hello) == "Hello" match
** c1 === expect resp.http.id2b64 == "TWFuIGk="
**** c1 EXPECT resp.http.id2b64 (TWFuIGk=) == "TWFuIGk=" match
** c1 === expect resp.http.id2b64nopad == "TWFuIGk"
**** c1 EXPECT resp.http.id2b64nopad (TWFuIGk) == "TWFuIGk" match
** c1 === expect resp.http.id2hex == "4d616e2069"
**** c1 EXPECT resp.http.id2hex (4d616e2069) == "4d616e2069" match
** c1 === expect resp.http.id2hexuc == "4D616E2069"
**** c1 EXPECT resp.http.id2hexuc (4D616E2069) == "4D616E2069" match
** c1 === expect resp.http.id2hexlc == resp.http.id2hex
**** c1 EXPECT resp.http.id2hexlc (4d616e2069) == "4d616e2069" match
** c1 === expect resp.http.id2url == "foo%3ab"
**** c1 EXPECT resp.http.id2url (foo%3ab) == "foo%3ab" match
** c1 === expect resp.http.id2urluc == "foo%3Ab"
**** c1 EXPECT resp.http.id2urluc (foo%3Ab) == "foo%3Ab" match
** c1 === expect resp.http.id2urllc == resp.http.id2url
**** c1 EXPECT resp.http.id2urllc (foo%3ab) == "foo%3ab" match
** c1 === expect resp.http.b642id == "Man is"
**** c1 EXPECT resp.http.b642id (Man is) == "Man is" match
** c1 === expect resp.http.hex2id == "Man is"
**** c1 EXPECT resp.http.hex2id (Man is) == "Man is" match
** c1 === expect resp.http.hexalldown2b64 == "//79/Pv6"
**** c1 EXPECT resp.http.hexalldown2b64 (//79/Pv6) == "//79/Pv6" match
** c1 === expect resp.http.hexalldown2b64url == "__79_Pv6"
**** c1 EXPECT resp.http.hexalldown2b64url (__79_Pv6) == "__79_Pv6" match
** c1 === expect resp.http.hexalldown2b64nopad == "__79_Ps"
**** c1 EXPECT resp.http.hexalldown2b64nopad (__79_Ps) == "__79_Ps" match
** c1 === expect resp.http.hexallup2b64 == "AAECAwQF"
**** c1 EXPECT resp.http.hexallup2b64 (AAECAwQF) == "AAECAwQF" match
** c1 === expect resp.http.hexallup2b64url == "AAECAwQ="
**** c1 EXPECT resp.http.hexallup2b64url (AAECAwQ=) == "AAECAwQ=" match
** c1 === expect resp.http.hexallup2b64nopad == "AAECAwQ"
**** c1 EXPECT resp.http.hexallup2b64nopad (AAECAwQ) == "AAECAwQ" match
** c1 === expect resp.http.hexalldown2url == "%ff%fe%fd%fc%fb%fa"
**** c1 EXPECT resp.http.hexalldown2url (%ff%fe%fd%fc%fb%fa) == "%ff%fe%fd%fc%fb%fa" match
** c1 === expect resp.http.hexalldown2urluc == "%FF%FE%FD%FC%FB%FA"
**** c1 EXPECT resp.http.hexalldown2urluc (%FF%FE%FD%FC%FB%FA) == "%FF%FE%FD%FC%FB%FA" match
** c1 === expect resp.http.hexalldown2urllc == resp.http.hexalldown2ur...
**** c1 EXPECT resp.http.hexalldown2urllc (%ff%fe%fd%fc%fb%fa) == "%ff%fe%fd%fc%fb%fa" match
** c1 === expect resp.http.hexallup2url == "%00%01%02%03%04%05"
**** c1 EXPECT resp.http.hexallup2url (%00%01%02%03%04%05) == "%00%01%02%03%04%05" match
** c1 === expect resp.http.hexallup2urllc == resp.http.hexallup2url
**** c1 EXPECT resp.http.hexallup2urllc (%00%01%02%03%04%05) == "%00%01%02%03%04%05" match
** c1 === expect resp.http.hexallup2urllc == resp.http.hexallup2url
**** c1 EXPECT resp.http.hexallup2urllc (%00%01%02%03%04%05) == "%00%01%02%03%04%05" match
*** c1 closing fd 15
** c1 Ending
** top === varnish v1 -vcl {
**** v1 CLI TX|vcl.inline vcl2 << %XJEIFLH|)Xspa8P
**** v1 CLI TX|vcl 4.1;
**** v1 CLI TX|
**** v1 CLI TX|\timport blob;
**** v1 CLI TX|\timport std;
**** v1 CLI TX|\tbackend b None;
**** v1 CLI TX|
**** v1 CLI TX|\tsub vcl_recv {
**** v1 CLI TX|\t return(synth(200));
**** v1 CLI TX|\t}
**** v1 CLI TX|
**** v1 CLI TX|\tsub vcl_synth {
**** v1 CLI TX|\t set req.http.b64all =
**** v1 CLI TX|{"AAAABBBBCCCCDDDDEEEEFFFFGGGGHHHHIIIIJJJJKKKKLLLLMMMMNNNNOOOOPPPPQQQQRRRRSSSSTTTTUUUUVVVVWWWWXXXXYYYYZZZZaaaabbbbccccddddeeeeffffgggghhhhiiiijjjjkkkkllllmmmmnnnnooooppppqqqqrrrrssssttttuuuuvvvvwwwwxxxxyyyyzzzz0000111122223333444455556666777788889999++++////"};
**** v1 CLI TX|\t set req.http.b64allurl =
**** v1 CLI TX|{"AAAABBBBCCCCDDDDEEEEFFFFGGGGHHHHIIIIJJJJKKKKLLLLMMMMNNNNOOOOPPPPQQQQRRRRSSSSTTTTUUUUVVVVWWWWXXXXYYYYZZZZaaaabbbbccccddddeeeeffffgggghhhhiiiijjjjkkkkllllmmmmnnnnooooppppqqqqrrrrssssttttuuuuvvvvwwwwxxxxyyyyzzzz0000111122223333444455556666777788889999----____"};
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64all2hex
**** v1 CLI TX|\t = blob.transcode(BASE64, HEX, length=8, encoded=req.http.b64all);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64all2hexuc
**** v1 CLI TX|\t = blob.transcode(BASE64, HEX, UPPER, 8, req.http.b64all);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64all2hexlc
**** v1 CLI TX|\t = blob.transcode(BASE64, HEX, LOWER, 8, req.http.b64all);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64allurl2hex
**** v1 CLI TX|\t = blob.transcode(BASE64URL, HEX, length=8,
**** v1 CLI TX|\t\t\t encoded=req.http.b64allurl);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64allurl2hexuc
**** v1 CLI TX|\t = blob.transcode(BASE64URL, HEX, UPPER, 8, req.http.b64allurl);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64allurl2hexlc
**** v1 CLI TX|\t = blob.transcode(BASE64URL, HEX, LOWER, 8, req.http.b64allurl);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64all2url
**** v1 CLI TX|\t = blob.transcode(BASE64, URL, length=8, encoded=req.http.b64all);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64all2urluc
**** v1 CLI TX|\t = blob.transcode(BASE64, URL, UPPER, 8, req.http.b64all);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64all2urllc
**** v1 CLI TX|\t = blob.transcode(BASE64, URL, LOWER, 8, req.http.b64all);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64allurl2url
**** v1 CLI TX|\t = blob.transcode(BASE64URL, URL, length=8,
**** v1 CLI TX|\t\t\t encoded=req.http.b64allurl);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64allurl2urluc
**** v1 CLI TX|\t = blob.transcode(BASE64URL, URL, UPPER, 8, req.http.b64allurl);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64allurl2urllc
**** v1 CLI TX|\t = blob.transcode(BASE64URL, URL, LOWER, 8, req.http.b64allurl);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexuc2hex
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, length=10, encoded="0123456789ABCDEF");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexuc2hexuc
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, UPPER, 10, "0123456789ABCDEF");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexlc2hex
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, length=10, encoded="0123456789abcdef");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexlc2hexlc
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, LOWER, 10, "0123456789abcdef");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexuc2hexlc
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, LOWER, 9, "0123456789ABCDEF");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexlc2hexuc
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, UPPER, 9, "0123456789abcdef");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexmix2hex
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, length=13, encoded="0123456789abcDEF");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexmix2hexuc
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, UPPER, 15, "0123456789ABCdef");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.hexmix2hexlc
**** v1 CLI TX|\t = blob.transcode(HEX, HEX, LOWER, 13, "0123456789abcDEF");
**** v1 CLI TX|
**** v1 CLI TX|\t set req.http.hexpart1 = "01234567";
**** v1 CLI TX|\t set req.http.hexpart2 = "89abcdef";
**** v1 CLI TX|\t set resp.http.hexparam
**** v1 CLI TX|\t = blob.transcode(encoded="" + req.http.unset + ""
**** v1 CLI TX|\t\t\t\t + req.http.unset + "" + req.http.hexpart1
**** v1 CLI TX|\t\t\t\t + "" + req.http.unset + "" + req.http.unset
**** v1 CLI TX|\t\t\t\t + req.http.hexpart2, decoding=HEX,
**** v1 CLI TX|\t\t\t\t encoding=HEX, length=10, case=UPPER);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b642b64
**** v1 CLI TX|\t = blob.transcode(BASE64, BASE64, length=36, encoded=
**** v1 CLI TX|\t\t\t\t "ABCDEFGHIJKLMNOPQRSTUVWXYZabcdef"
**** v1 CLI TX|\t\t\t\t + "ghijklmnopqrstuvwxyz0123456789+/");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64url2b64url =
**** v1 CLI TX|\t blob.transcode(BASE64URL, BASE64URL, length=34, encoded=
**** v1 CLI TX|\t\t\t\t "ABCDEFGHIJKLMNOPQRSTUVWXYZabcdef"
**** v1 CLI TX|\t\t\t\t + "ghijklmnopqrstuvwxyz0123456789-_");
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.b64urlnopad2b64urlnopad =
**** v1 CLI TX|\t blob.transcode(BASE64URLNOPAD, BASE64URLNOPAD, length=34, encoded=
**** v1 CLI TX|\t\t\t\t "ABCDEFGHIJKLMNOPQRSTUVWXYZabcdef"
**** v1 CLI TX|\t\t\t\t + "ghijklmnopqrstuvwxyz0123456789-_");
**** v1 CLI TX|
**** v1 CLI TX|\t}
**** v1 CLI TX|
**** v1 CLI TX|%XJEIFLH|)Xspa8P
**** dT 2.869
**** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 42645
**** v1 vsl| 0 CLI - Rd debug.xid 1000
**** v1 vsl| 0 CLI - Wr 200 19 XID is 1000 chunk 1
**** v1 vsl| 0 CLI - Rd debug.listen_address
**** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 42645
**** v1 vsl| 1000 Begin c sess 0 HTTP/1
**** v1 vsl| 1000 SessOpen c 127.0.0.1 54186 a0 127.0.0.1 42645 1684790573.595465 23
**** v1 vsl| 1000 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1000 Link c req 1001 rxreq
**** v1 vsl| 1001 Begin c req 1000 rxreq
**** v1 vsl| 1001 Timestamp c Start: 1684790573.595545 0.000000 0.000000
**** v1 vsl| 1001 Timestamp c Req: 1684790573.595545 0.000000 0.000000
**** v1 vsl| 1001 VCL_use c vcl1
**** v1 vsl| 1001 ReqStart c 127.0.0.1 54186 a0
**** v1 vsl| 1001 ReqMethod c GET
**** v1 vsl| 1001 ReqURL c /
**** v1 vsl| 1001 ReqProtocol c HTTP/1.1
**** v1 vsl| 1001 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1001 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1001 VCL_call c RECV
**** v1 vsl| 1001 VCL_return c synth
**** v1 vsl| 1001 VCL_call c HASH
**** v1 vsl| 1001 VCL_return c lookup
**** v1 vsl| 1001 RespProtocol c HTTP/1.1
**** v1 vsl| 1001 RespStatus c 200
**** v1 vsl| 1001 RespReason c OK
**** v1 vsl| 1001 RespHeader c Date: Mon, 22 May 2023 21:22:53 GMT
**** v1 vsl| 1001 RespHeader c Server: Varnish
**** v1 vsl| 1001 RespHeader c X-Varnish: 1001
**** v1 vsl| 1001 VCL_call c SYNTH
**** v1 vsl| 1001 ReqHeader c foobar: foo:bar:baz:quux
**** v1 vsl| 1001 ReqHeader c hobbes: Man is distinguished, not only by his reason, but by this singular passion from other animals, which is a lust of the mind, that by a perseverance of delight in the continued and indefatigable generation of knowledge, exceeds the short vehemence
**** v1 vsl| 1001 ReqHeader c hobbesb64: TWFuIGlzIGRpc3Rpbmd1aXNoZWQsIG5vdCBvbmx5IGJ5IGhpcyByZWFzb24sIGJ1dCBieSB0aGlzIHNpbmd1bGFyIHBhc3Npb24gZnJvbSBvdGhlciBhbmltYWxzLCB3aGljaCBpcyBhIGx1c3Qgb2YgdGhlIG1pbmQsIHRoYXQgYnkgYSBwZXJzZXZlcmFuY2Ugb2YgZGVsaWdodCBpbiB0aGUgY29udGludWVkIGFuZCBpbmR
**** v1 vsl| 1001 ReqHeader c hexhobbes: 4d616e2069732064697374696e677569736865642c206e6f74206f6e6c792062792068697320726561736f6e2c2062757420627920746869732073696e67756c61722070617373696f6e2066726f6d206f7468657220616e696d616c732c2077686963682069732061206c757374206f6620746865206d696e6
**** v1 vsl| 1001 ReqHeader c hexalldown: fffefdfcfbfaf9f8f7f6f5f4f3f2f1f0efeeedecebeae9e8e7e6e5e4e3e2e1e0dfdedddcdbdad9d8d7d6d5d4d3d2d1d0cfcecdcccbcac9c8c7c6c5c4c3c2c1c0bfbebdbcbbbab9b8b7b6b5b4b3b2b1b0afaeadacabaaa9a8a7a6a5a4a3a2a1a09f9e9d9c9b9a999897969594939291908f8e8d8c8b8a898887
**** v1 vsl| 1001 ReqHeader c hexallup: 000102030405060708090a0b0c0d0e0f101112131415161718191a1b1c1d1e1f202122232425262728292a2b2c2d2e2f303132333435363738393a3b3c3d3e3f404142434445464748494a4b4c4d4e4f505152535455565758595a5b5c5d5e5f606162636465666768696a6b6c6d6e6f70717273747576777879
**** v1 vsl| 1001 RespHeader c id2id: Hello
**** v1 vsl| 1001 RespHeader c id2b64: TWFuIGk=
**** v1 vsl| 1001 RespHeader c id2b64nopad: TWFuIGk
**** v1 vsl| 1001 RespHeader c id2hex: 4d616e2069
**** v1 vsl| 1001 RespHeader c id2hexuc: 4D616E2069
**** v1 vsl| 1001 RespHeader c id2hexlc: 4d616e2069
**** v1 vsl| 1001 RespHeader c id2url: foo%3ab
**** v1 vsl| 1001 RespHeader c id2urluc: foo%3Ab
**** v1 vsl| 1001 RespHeader c id2urllc: foo%3ab
**** v1 vsl| 1001 RespHeader c b642id: Man is
**** v1 vsl| 1001 RespHeader c hex2id: Man is
**** v1 vsl| 1001 RespHeader c hexalldown2b64: //79/Pv6
**** v1 vsl| 1001 RespHeader c hexalldown2b64url: __79_Pv6
**** v1 vsl| 1001 RespHeader c hexalldown2b64nopad: __79_Ps
**** v1 vsl| 1001 RespHeader c hexallup2b64: AAECAwQF
**** v1 vsl| 1001 RespHeader c hexallup2b64url: AAECAwQ=
**** v1 vsl| 1001 RespHeader c hexallup2b64nopad: AAECAwQ
**** v1 vsl| 1001 RespHeader c hexalldown2url: %ff%fe%fd%fc%fb%fa
**** v1 vsl| 1001 RespHeader c hexalldown2urluc: %FF%FE%FD%FC%FB%FA
**** v1 vsl| 1001 RespHeader c hexalldown2urllc: %ff%fe%fd%fc%fb%fa
**** v1 vsl| 1001 RespHeader c hexallup2url: %00%01%02%03%04%05
**** v1 vsl| 1001 RespHeader c hexallup2urluc: %00%01%02%03%04%05
**** v1 vsl| 1001 RespHeader c hexallup2urllc: %00%01%02%03%04%05
**** v1 vsl| 1001 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1001 RespHeader c Retry-After: 5
**** v1 vsl| 1001 VCL_return c deliver
**** v1 vsl| 1001 Timestamp c Process: 1684790573.595878 0.000333 0.000333
**** v1 vsl| 1001 RespHeader c Content-Length: 227
**** v1 vsl| 1001 Storage c malloc Transient
**** v1 vsl| 1001 Filters c
**** v1 vsl| 1001 RespHeader c Connection: keep-alive
**** v1 vsl| 1001 Timestamp c Resp: 1684790573.595997 0.000452 0.000119
**** v1 vsl| 1001 ReqAcct c 35 0 35 778 227 1005
**** v1 vsl| 1001 End c
**** v1 vsl| 1000 SessClose c REM_CLOSE 0.012
**** v1 vsl| 1000 End c
**** dT 5.030
*** v1 CLI RX 200
**** v1 CLI TX|vcl.use vcl2
**** dT 5.032
*** v1 CLI RX 200
**** v1 CLI RX|VCL 'vcl2' now active
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 5.044
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 15 from 127.0.0.1 54252 to 127.0.0.1:42645
** c1 === txreq
**** c1 txreq|GET / HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 5.052
**** c1 rxhdr|HTTP/1.1 200 OK\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:22:55 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1003\r
**** c1 rxhdr|b64all2hex: 000000041041\r
**** c1 rxhdr|b64all2hexuc: 000000041041\r
**** c1 rxhdr|b64all2hexlc: 000000041041\r
**** c1 rxhdr|b64allurl2hex: 000000041041\r
**** c1 rxhdr|b64allurl2hexuc: 000000041041\r
**** c1 rxhdr|b64allurl2hexlc: 000000041041\r
**** c1 rxhdr|b64all2url: %00%00%00%04%10A\r
**** c1 rxhdr|b64all2urluc: %00%00%00%04%10A\r
**** c1 rxhdr|b64all2urllc: %00%00%00%04%10A\r
**** c1 rxhdr|b64allurl2url: %00%00%00%04%10A\r
**** c1 rxhdr|b64allurl2urluc: %00%00%00%04%10A\r
**** c1 rxhdr|b64allurl2urllc: %00%00%00%04%10A\r
**** c1 rxhdr|hexuc2hex: 0123456789\r
**** c1 rxhdr|hexuc2hexuc: 0123456789\r
**** c1 rxhdr|hexlc2hex: 0123456789\r
**** c1 rxhdr|hexlc2hexlc: 0123456789\r
**** c1 rxhdr|hexuc2hexlc: 0012345678\r
**** c1 rxhdr|hexlc2hexuc: 0012345678\r
**** c1 rxhdr|hexmix2hex: 00123456789abc\r
**** c1 rxhdr|hexmix2hexuc: 00123456789ABCDE\r
**** c1 rxhdr|hexmix2hexlc: 00123456789abc\r
**** c1 rxhdr|hexparam: 0123456789\r
**** c1 rxhdr|b642b64: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefghij\r
**** c1 rxhdr|b64url2b64url: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg==\r
**** c1 rxhdr|b64urlnopad2b64urlnopad: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 227\r
**** c1 rxhdr|Connection: keep-alive\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 980
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |200
**** c1 http[ 2] |OK
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:22:55 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1003
**** c1 http[ 6] |b64all2hex: 000000041041
**** c1 http[ 7] |b64all2hexuc: 000000041041
**** c1 http[ 8] |b64all2hexlc: 000000041041
**** c1 http[ 9] |b64allurl2hex: 000000041041
**** c1 http[10] |b64allurl2hexuc: 000000041041
**** c1 http[11] |b64allurl2hexlc: 000000041041
**** c1 http[12] |b64all2url: %00%00%00%04%10A
**** c1 http[13] |b64all2urluc: %00%00%00%04%10A
**** c1 http[14] |b64all2urllc: %00%00%00%04%10A
**** c1 http[15] |b64allurl2url: %00%00%00%04%10A
**** c1 http[16] |b64allurl2urluc: %00%00%00%04%10A
**** c1 http[17] |b64allurl2urllc: %00%00%00%04%10A
**** c1 http[18] |hexuc2hex: 0123456789
**** c1 http[19] |hexuc2hexuc: 0123456789
**** c1 http[20] |hexlc2hex: 0123456789
**** c1 http[21] |hexlc2hexlc: 0123456789
**** c1 http[22] |hexuc2hexlc: 0012345678
**** c1 http[23] |hexlc2hexuc: 0012345678
**** c1 http[24] |hexmix2hex: 00123456789abc
**** c1 http[25] |hexmix2hexuc: 00123456789ABCDE
**** c1 http[26] |hexmix2hexlc: 00123456789abc
**** c1 http[27] |hexparam: 0123456789
**** c1 http[28] |b642b64: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefghij
**** c1 http[29] |b64url2b64url: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg==
**** c1 http[30] |b64urlnopad2b64urlnopad: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg
**** c1 http[31] |Content-Type: text/html; charset=utf-8
**** c1 http[32] |Retry-After: 5
**** c1 http[33] |Content-Length: 227
**** c1 http[34] |Connection: keep-alive
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 200 OK
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 200 OK
**** c1 c-l| OK
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1003
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 227
** c1 === expect resp.http.b64all2hex == "000000041041"
**** c1 EXPECT resp.http.b64all2hex (000000041041) == "000000041041" match
** c1 === expect resp.http.b64all2hexuc == resp.http.b64all2hex
**** c1 EXPECT resp.http.b64all2hexuc (000000041041) == "000000041041" match
** c1 === expect resp.http.b64all2hexlc == resp.http.b64all2hex
**** c1 EXPECT resp.http.b64all2hexlc (000000041041) == "000000041041" match
** c1 === expect resp.http.b64allurl2hex == "000000041041"
**** c1 EXPECT resp.http.b64allurl2hex (000000041041) == "000000041041" match
** c1 === expect resp.http.b64allurl2hexuc == resp.http.b64allurl2hex
**** c1 EXPECT resp.http.b64allurl2hexuc (000000041041) == "000000041041" match
** c1 === expect resp.http.b64allurl2hexlc == resp.http.b64allurl2hex
**** c1 EXPECT resp.http.b64allurl2hexlc (000000041041) == "000000041041" match
** c1 === expect resp.http.b64all2url == "%00%00%00%04%10A"
**** c1 EXPECT resp.http.b64all2url (%00%00%00%04%10A) == "%00%00%00%04%10A" match
** c1 === expect resp.http.b64all2urluc == resp.http.b64all2url
**** c1 EXPECT resp.http.b64all2urluc (%00%00%00%04%10A) == "%00%00%00%04%10A" match
** c1 === expect resp.http.b64all2urllc == resp.http.b64all2url
**** c1 EXPECT resp.http.b64all2urllc (%00%00%00%04%10A) == "%00%00%00%04%10A" match
** c1 === expect resp.http.b64allurl2url == "%00%00%00%04%10A"
**** c1 EXPECT resp.http.b64allurl2url (%00%00%00%04%10A) == "%00%00%00%04%10A" match
** c1 === expect resp.http.b64allurl2urluc == resp.http.b64allurl2url
**** c1 EXPECT resp.http.b64allurl2urluc (%00%00%00%04%10A) == "%00%00%00%04%10A" match
** c1 === expect resp.http.b64allurl2urllc == resp.http.b64allurl2url
**** c1 EXPECT resp.http.b64allurl2urllc (%00%00%00%04%10A) == "%00%00%00%04%10A" match
** c1 === expect resp.http.hexuc2hex == "0123456789"
**** c1 EXPECT resp.http.hexuc2hex (0123456789) == "0123456789" match
** c1 === expect resp.http.hexlc2hex == resp.http.hexuc2hex
**** c1 EXPECT resp.http.hexlc2hex (0123456789) == "0123456789" match
** c1 === expect resp.http.hexlc2hexlc == resp.http.hexuc2hex
**** c1 EXPECT resp.http.hexlc2hexlc (0123456789) == "0123456789" match
** c1 === expect resp.http.hexuc2hexlc == "0012345678"
**** c1 EXPECT resp.http.hexuc2hexlc (0012345678) == "0012345678" match
** c1 === expect resp.http.hexlc2hexuc == resp.http.hexuc2hexlc
**** c1 EXPECT resp.http.hexlc2hexuc (0012345678) == "0012345678" match
** c1 === expect resp.http.hexmix2hex == "00123456789abc"
**** c1 EXPECT resp.http.hexmix2hex (00123456789abc) == "00123456789abc" match
** c1 === expect resp.http.hexmix2hexuc == "00123456789ABCDE"
**** c1 EXPECT resp.http.hexmix2hexuc (00123456789ABCDE) == "00123456789ABCDE" match
** c1 === expect resp.http.hexmix2hexlc == resp.http.hexmix2hex
**** c1 EXPECT resp.http.hexmix2hexlc (00123456789abc) == "00123456789abc" match
** c1 === expect resp.http.hexparam == "0123456789"
**** c1 EXPECT resp.http.hexparam (0123456789) == "0123456789" match
** c1 === expect resp.http.b642b64 == "ABCDEFGHIJKLMNOPQRSTUVWXYZabcde...
**** c1 EXPECT resp.http.b642b64 (ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefghij) == "ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefghij" match
** c1 === expect resp.http.b64url2b64url == "ABCDEFGHIJKLMNOPQRSTUVWXY...
**** c1 EXPECT resp.http.b64url2b64url (ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg==) == "ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg==" match
** c1 === expect resp.http.b64urlnopad2b64urlnopad == "ABCDEFGHIJKLMNO...
**** c1 EXPECT resp.http.b64urlnopad2b64urlnopad (ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg) == "ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg" match
*** c1 closing fd 15
** c1 Ending
**** dT 5.053
** top === varnish v1 -vcl {
**** v1 CLI TX|vcl.inline vcl3 << %XJEIFLH|)Xspa8P
**** v1 CLI TX|vcl 4.1;
**** v1 CLI TX|
**** v1 CLI TX|\timport blob;
**** v1 CLI TX|\timport std;
**** v1 CLI TX|\tbackend b None;
**** v1 CLI TX|
**** v1 CLI TX|\tsub vcl_recv {
**** v1 CLI TX|\t return(synth(200));
**** v1 CLI TX|\t}
**** v1 CLI TX|
**** v1 CLI TX|\tsub vcl_synth {
**** v1 CLI TX|\t set req.http.urlhobbeslc = "Man%20is%20distinguished%2c%20not%20only%20by%20his%20reason%2c%20but%20by%20this%20singular%20passion%20from%20other%20animals%2c%20which%20is%20a%20lust%20of%20the%20mind%2c%20that%20by%20a%20perseverance%20of%20delight%20in%20the%20continued%20and%20indefatigable%20generation%20of%20knowledge%2c%20exceeds%20the%20short%20vehemence%20of%20any%20carnal%20pleasure.";
**** v1 CLI TX|\t set req.http.urlhobbesuc = "Man%20is%20distinguished%2C%20not%20only%20by%20his%20reason%2C%20but%20by%20this%20singular%20passion%20from%20other%20animals%2C%20which%20is%20a%20lust%20of%20the%20mind%2C%20that%20by%20a%20perseverance%20of%20delight%20in%20the%20continued%20and%20indefatigable%20generation%20of%20knowledge%2C%20exceeds%20the%20short%20vehemence%20of%20any%20carnal%20pleasure.";
**** v1 CLI TX|\t set req.http.urlallupuc = "%00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ%5B%5C%5D%5E_%60abcdefghijklmnopqrstuvwxyz%7B%7C%7D~%7F%80%81%82%83%84%85%86%87%88%89%8A%8B%8C%8D%8E%8F%90%91%92%93%94%95%96%97%98%99%9A%9B%9C%9D%9E%9F%A0%A1%A2%A3%A4%A5%A6%A7%A8%A9%AA%AB%AC%AD%AE%AF%B0%B1%B2%B3%B4%B5%B6%B7%B8%B9%BA%BB%BC%BD%BE%BF%C0%C1%C2%C3%C4%C5%C6%C7%C8%C9%CA%CB%CC%CD%CE%CF%D0%D1%D2%D3%D4%D5%D6%D7%D8%D9%DA%DB%DC%DD%DE%DF%E0%E1%E2%E3%E4%E5%E6%E7%E8%E9%EA%EB%EC%ED%EE%EF%F0%F1%F2%F3%F4%F5%F6%F7%F8%F9%FA%FB%FC%FD%FE%FF";
**** v1 CLI TX|\t set req.http.urlalluplc = "%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ%5b%5c%5d%5e_%60abcdefghijklmnopqrstuvwxyz%7b%7c%7d~%7f%80%81%82%83%84%85%86%87%88%89%8a%8b%8c%8d%8e%8f%90%91%92%93%94%95%96%97%98%99%9a%9b%9c%9d%9e%9f%a0%a1%a2%a3%a4%a5%a6%a7%a8%a9%aa%ab%ac%ad%ae%af%b0%b1%b2%b3%b4%b5%b6%b7%b8%b9%ba%bb%bc%bd%be%bf%c0%c1%c2%c3%c4%c5%c6%c7%c8%c9%ca%cb%cc%cd%ce%cf%d0%d1%d2%d3%d4%d5%d6%d7%d8%d9%da%db%dc%dd%de%df%e0%e1%e2%e3%e4%e5%e6%e7%e8%e9%ea%eb%ec%ed%ee%ef%f0%f1%f2%f3%f4%f5%f6%f7%f8%f9%fa%fb%fc%fd%fe%ff";
**** v1 CLI TX|\t set req.http.urlalldownuc = "%FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba%60_%5E%5D%5C%5BZYXWVUTSRQPONMLKJIHGFEDCBA%40%3F%3E%3D%3C%3B%3A9876543210%2F.-%2C%2B%2A%29%28%27%26%25%24%23%22%21%20%1F%1E%1D%1C%1B%1A%19%18%17%16%15%14%13%12%11%10%0F%0E%0D%0C%0B%0A%09%08%07%06%05%04%03%02%01%00";
**** v1 CLI TX|\t set req.http.urlalldownlc = "%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba%60_%5e%5d%5c%5bZYXWVUTSRQPONMLKJIHGFEDCBA%40%3f%3e%3d%3c%3b%3a9876543210%2f.-%2c%2b%2a%29%28%27%26%25%24%23%22%21%20%1f%1e%1d%1c%1b%1a%19%18%17%16%15%14%13%12%11%10%0f%0e%0d%0c%0b%0a%09%08%07%06%05%04%03%02%01%00";
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urluc2id
**** v1 CLI TX|\t = blob.transcode(URL, IDENTITY, length=27,
**** v1 CLI TX|\t\t\t encoded=req.http.urlhobbesuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urllc2id
**** v1 CLI TX|\t = blob.transcode(URL, IDENTITY, length=63,
**** v1 CLI TX|\t\t\t encoded=req.http.urlhobbeslc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownuc2b64
**** v1 CLI TX|\t = blob.transcode(URL, BASE64, length=18,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownuc2b64url
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URL, length=15,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownuc2b64nopad
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URLNOPAD, length=15,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownlc2b64
**** v1 CLI TX|\t = blob.transcode(URL, BASE64, length=18,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownlc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownlc2b64url
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URL, length=15,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownlc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownlc2b64nopad
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URLNOPAD, length=15,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownlc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlallupuc2b64
**** v1 CLI TX|\t = blob.transcode(URL, BASE64, length=36,
**** v1 CLI TX|\t\t\t encoded=req.http.urlallupuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlallupuc2b64url
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URL, length=33,
**** v1 CLI TX|\t\t\t encoded=req.http.urlallupuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlallupuc2b64nopad
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URLNOPAD, length=33,
**** v1 CLI TX|\t\t\t encoded=req.http.urlallupuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalluplc2b64
**** v1 CLI TX|\t = blob.transcode(URL, BASE64, length=36,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalluplc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalluplc2b64url
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URL, length=33,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalluplc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalluplc2b64nopad
**** v1 CLI TX|\t = blob.transcode(URL, BASE64URLNOPAD, length=33,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalluplc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownuc2url
**** v1 CLI TX|\t = blob.transcode(URL, URL, length=423,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownuc2urluc
**** v1 CLI TX|\t = blob.transcode(URL, URL, UPPER, 423, req.http.urlalldownuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownuc2urllc
**** v1 CLI TX|\t = blob.transcode(URL, URL, LOWER, 423, req.http.urlalldownuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownlc2url
**** v1 CLI TX|\t = blob.transcode(URL, URL, length=423,
**** v1 CLI TX|\t\t\t encoded=req.http.urlalldownlc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownlc2urluc
**** v1 CLI TX|\t = blob.transcode(URL, URL, UPPER, 423, req.http.urlalldownlc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalldownlc2urllc
**** v1 CLI TX|\t = blob.transcode(URL, URL, LOWER, 423, req.http.urlalldownlc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlallupuc2url
**** v1 CLI TX|\t = blob.transcode(URL, URL, length=197, encoded=req.http.urlallupuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlallupuc2urluc
**** v1 CLI TX|\t = blob.transcode(URL, URL, UPPER, 197, req.http.urlallupuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlallupuc2urllc
**** v1 CLI TX|\t = blob.transcode(URL, URL, LOWER, 197, req.http.urlallupuc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalluplc2url
**** v1 CLI TX|\t = blob.transcode(URL, URL, length=197, encoded=req.http.urlalluplc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalluplc2urluc
**** v1 CLI TX|\t = blob.transcode(URL, URL, UPPER, 197, req.http.urlalluplc);
**** v1 CLI TX|
**** v1 CLI TX|\t set resp.http.urlalluplc2urllc
**** v1 CLI TX|\t = blob.transcode(URL, URL, LOWER, 197, req.http.urlalluplc);
**** v1 CLI TX|
**** v1 CLI TX|\t }
**** v1 CLI TX|
**** v1 CLI TX|%XJEIFLH|)Xspa8P
**** dT 5.097
**** v1 vsl| 0 CLI - Rd vcl.load vcl2 vcl_vcl2.1684790573.608374/vgc.so 1auto
**** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl2.1684790573.608374/vgc.so" as "vcl2"
**** v1 vsl| 0 CLI - Rd vcl.use vcl2
**** v1 vsl| 0 CLI - Wr 200 0
**** v1 vsl| 1002 Begin c sess 0 HTTP/1
**** v1 vsl| 1002 SessOpen c 127.0.0.1 54252 a0 127.0.0.1 42645 1684790575.815643 24
**** v1 vsl| 1002 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1002 Link c req 1003 rxreq
**** v1 vsl| 1003 Begin c req 1002 rxreq
**** v1 vsl| 1003 Timestamp c Start: 1684790575.815696 0.000000 0.000000
**** v1 vsl| 1003 Timestamp c Req: 1684790575.815696 0.000000 0.000000
**** v1 vsl| 1003 VCL_use c vcl2
**** v1 vsl| 1003 ReqStart c 127.0.0.1 54252 a0
**** v1 vsl| 1003 ReqMethod c GET
**** v1 vsl| 1003 ReqURL c /
**** v1 vsl| 1003 ReqProtocol c HTTP/1.1
**** v1 vsl| 1003 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1003 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1003 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1003 VCL_call c RECV
**** v1 vsl| 1003 VCL_return c synth
**** v1 vsl| 1003 VCL_call c HASH
**** v1 vsl| 1003 VCL_return c lookup
**** v1 vsl| 1003 RespProtocol c HTTP/1.1
**** v1 vsl| 1003 RespStatus c 200
**** v1 vsl| 1003 RespReason c OK
**** v1 vsl| 1003 RespHeader c Date: Mon, 22 May 2023 21:22:55 GMT
**** v1 vsl| 1003 RespHeader c Server: Varnish
**** v1 vsl| 1003 RespHeader c X-Varnish: 1003
**** v1 vsl| 1003 VCL_call c SYNTH
**** v1 vsl| 1003 ReqHeader c b64all: AAAABBBBCCCCDDDDEEEEFFFFGGGGHHHHIIIIJJJJKKKKLLLLMMMMNNNNOOOOPPPPQQQQRRRRSSSSTTTTUUUUVVVVWWWWXXXXYYYYZZZZaaaabbbbccccddddeeeeffffgggghhhhiiiijjjjkkkkllllmmmmnnnnooooppppqqqqrrrrssssttttuuuuvvvvwwwwxxxxyyyyzzzz00001111222233334444555566667777888899
**** v1 vsl| 1003 ReqHeader c b64allurl: AAAABBBBCCCCDDDDEEEEFFFFGGGGHHHHIIIIJJJJKKKKLLLLMMMMNNNNOOOOPPPPQQQQRRRRSSSSTTTTUUUUVVVVWWWWXXXXYYYYZZZZaaaabbbbccccddddeeeeffffgggghhhhiiiijjjjkkkkllllmmmmnnnnooooppppqqqqrrrrssssttttuuuuvvvvwwwwxxxxyyyyzzzz00001111222233334444555566667777888
**** v1 vsl| 1003 RespHeader c b64all2hex: 000000041041
**** v1 vsl| 1003 RespHeader c b64all2hexuc: 000000041041
**** v1 vsl| 1003 RespHeader c b64all2hexlc: 000000041041
**** v1 vsl| 1003 RespHeader c b64allurl2hex: 000000041041
**** v1 vsl| 1003 RespHeader c b64allurl2hexuc: 000000041041
**** v1 vsl| 1003 RespHeader c b64allurl2hexlc: 000000041041
**** v1 vsl| 1003 RespHeader c b64all2url: %00%00%00%04%10A
**** v1 vsl| 1003 RespHeader c b64all2urluc: %00%00%00%04%10A
**** v1 vsl| 1003 RespHeader c b64all2urllc: %00%00%00%04%10A
**** v1 vsl| 1003 RespHeader c b64allurl2url: %00%00%00%04%10A
**** v1 vsl| 1003 RespHeader c b64allurl2urluc: %00%00%00%04%10A
**** v1 vsl| 1003 RespHeader c b64allurl2urllc: %00%00%00%04%10A
**** v1 vsl| 1003 RespHeader c hexuc2hex: 0123456789
**** v1 vsl| 1003 RespHeader c hexuc2hexuc: 0123456789
**** v1 vsl| 1003 RespHeader c hexlc2hex: 0123456789
**** v1 vsl| 1003 RespHeader c hexlc2hexlc: 0123456789
**** v1 vsl| 1003 RespHeader c hexuc2hexlc: 0012345678
**** v1 vsl| 1003 RespHeader c hexlc2hexuc: 0012345678
**** v1 vsl| 1003 RespHeader c hexmix2hex: 00123456789abc
**** v1 vsl| 1003 RespHeader c hexmix2hexuc: 00123456789ABCDE
**** v1 vsl| 1003 RespHeader c hexmix2hexlc: 00123456789abc
**** v1 vsl| 1003 ReqHeader c hexpart1: 01234567
**** v1 vsl| 1003 ReqHeader c hexpart2: 89abcdef
**** v1 vsl| 1003 RespHeader c hexparam: 0123456789
**** v1 vsl| 1003 RespHeader c b642b64: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefghij
**** v1 vsl| 1003 RespHeader c b64url2b64url: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg==
**** v1 vsl| 1003 RespHeader c b64urlnopad2b64urlnopad: ABCDEFGHIJKLMNOPQRSTUVWXYZabcdefgg
**** v1 vsl| 1003 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1003 RespHeader c Retry-After: 5
**** v1 vsl| 1003 VCL_return c deliver
**** v1 vsl| 1003 Timestamp c Process: 1684790575.815885 0.000188 0.000188
**** v1 vsl| 1003 RespHeader c Content-Length: 227
**** v1 vsl| 1003 Storage c malloc Transient
**** v1 vsl| 1003 Filters c
**** v1 vsl| 1003 RespHeader c Connection: keep-alive
**** v1 vsl| 1003 Timestamp c Resp: 1684790575.815989 0.000293 0.000104
**** v1 vsl| 1003 ReqAcct c 35 0 35 980 227 1207
**** v1 vsl| 1003 End c
**** v1 vsl| 1002 SessClose c REM_CLOSE 0.009
**** v1 vsl| 1002 End c
**** dT 7.064
*** v1 CLI RX 200
**** v1 CLI TX|vcl.use vcl3
**** dT 7.071
*** v1 CLI RX 200
**** v1 CLI RX|VCL 'vcl3' now active
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 7.082
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 15 from 127.0.0.1 54276 to 127.0.0.1:42645
** c1 === txreq
**** c1 txreq|GET / HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 7.137
**** c1 rxhdr|HTTP/1.1 200 OK\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:22:57 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1005\r
**** c1 rxhdr|urluc2id: Man is distinguished,\r
**** c1 rxhdr|urllc2id: Man is distinguished, not only by his reason,\r
**** c1 rxhdr|urlalldownuc2b64: //79/Pv6\r
**** c1 rxhdr|urlalldownuc2b64url: __79_Ps=\r
**** c1 rxhdr|urlalldownuc2b64nopad: __79_Ps\r
**** c1 rxhdr|urlalldownlc2b64: //79/Pv6\r
**** c1 rxhdr|urlalldownlc2b64url: __79_Ps=\r
**** c1 rxhdr|urlalldownlc2b64nopad: __79_Ps\r
**** c1 rxhdr|urlallupuc2b64: AAECAwQFBgcICQoL\r
**** c1 rxhdr|urlallupuc2b64url: AAECAwQFBgcICQo=\r
**** c1 rxhdr|urlallupuc2b64nopad: AAECAwQFBgcICQo\r
**** c1 rxhdr|urlalluplc2b64: AAECAwQFBgcICQoL\r
**** c1 rxhdr|urlalluplc2b64url: AAECAwQFBgcICQo=\r
**** c1 rxhdr|urlalluplc2b64nopad: AAECAwQFBgcICQo\r
**** c1 rxhdr|urlalldownuc2url: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba\r
**** c1 rxhdr|urlalldownuc2urluc: %FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba\r
**** c1 rxhdr|urlalldownuc2urllc: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba\r
**** c1 rxhdr|urlalldownlc2url: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba\r
**** c1 rxhdr|urlalldownlc2urluc: %FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba\r
**** c1 rxhdr|urlalldownlc2urllc: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba\r
**** c1 rxhdr|urlallupuc2url: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ\r
**** c1 rxhdr|urlallupuc2urluc: %00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ\r
**** c1 rxhdr|urlallupuc2urllc: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ\r
**** c1 rxhdr|urlalluplc2url: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ\r
**** c1 rxhdr|urlalluplc2urluc: %00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ\r
**** c1 rxhdr|urlalluplc2urllc: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 227\r
**** c1 rxhdr|Connection: keep-alive\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 4645
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |200
**** c1 http[ 2] |OK
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:22:57 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1005
**** c1 http[ 6] |urluc2id: Man is distinguished,
**** c1 http[ 7] |urllc2id: Man is distinguished, not only by his reason,
**** c1 http[ 8] |urlalldownuc2b64: //79/Pv6
**** c1 http[ 9] |urlalldownuc2b64url: __79_Ps=
**** c1 http[10] |urlalldownuc2b64nopad: __79_Ps
**** c1 http[11] |urlalldownlc2b64: //79/Pv6
**** c1 http[12] |urlalldownlc2b64url: __79_Ps=
**** c1 http[13] |urlalldownlc2b64nopad: __79_Ps
**** c1 http[14] |urlallupuc2b64: AAECAwQFBgcICQoL
**** c1 http[15] |urlallupuc2b64url: AAECAwQFBgcICQo=
**** c1 http[16] |urlallupuc2b64nopad: AAECAwQFBgcICQo
**** c1 http[17] |urlalluplc2b64: AAECAwQFBgcICQoL
**** c1 http[18] |urlalluplc2b64url: AAECAwQFBgcICQo=
**** c1 http[19] |urlalluplc2b64nopad: AAECAwQFBgcICQo
**** c1 http[20] |urlalldownuc2url: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba
**** c1 http[21] |urlalldownuc2urluc: %FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba
**** c1 http[22] |urlalldownuc2urllc: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba
**** c1 http[23] |urlalldownlc2url: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba
**** c1 http[24] |urlalldownlc2urluc: %FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba
**** c1 http[25] |urlalldownlc2urllc: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba
**** c1 http[26] |urlallupuc2url: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** c1 http[27] |urlallupuc2urluc: %00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** c1 http[28] |urlallupuc2urllc: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** c1 http[29] |urlalluplc2url: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** c1 http[30] |urlalluplc2urluc: %00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** c1 http[31] |urlalluplc2urllc: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** c1 http[32] |Content-Type: text/html; charset=utf-8
**** c1 http[33] |Retry-After: 5
**** c1 http[34] |Content-Length: 227
**** c1 http[35] |Connection: keep-alive
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 200 OK
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 200 OK
**** c1 c-l| OK
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1005
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 227
** c1 === expect resp.http.urluc2id == "Man is distinguished,"
**** c1 EXPECT resp.http.urluc2id (Man is distinguished,) == "Man is distinguished," match
** c1 === expect resp.http.urllc2id == "Man is distinguished, not only...
**** c1 EXPECT resp.http.urllc2id (Man is distinguished, not only by his reason,) == "Man is distinguished, not only by his reason," match
** c1 === expect resp.http.urlalldownuc2b64 == "//79/Pv6"
**** c1 EXPECT resp.http.urlalldownuc2b64 (//79/Pv6) == "//79/Pv6" match
** c1 === expect resp.http.urlalldownuc2b64url == "__79_Ps="
**** c1 EXPECT resp.http.urlalldownuc2b64url (__79_Ps=) == "__79_Ps=" match
** c1 === expect resp.http.urlalldownuc2b64nopad == "__79_Ps"
**** c1 EXPECT resp.http.urlalldownuc2b64nopad (__79_Ps) == "__79_Ps" match
** c1 === expect resp.http.urlalldownlc2b64 == "//79/Pv6"
**** c1 EXPECT resp.http.urlalldownlc2b64 (//79/Pv6) == "//79/Pv6" match
** c1 === expect resp.http.urlalldownlc2b64url == "__79_Ps="
**** c1 EXPECT resp.http.urlalldownlc2b64url (__79_Ps=) == "__79_Ps=" match
** c1 === expect resp.http.urlalldownlc2b64nopad == "__79_Ps"
**** c1 EXPECT resp.http.urlalldownlc2b64nopad (__79_Ps) == "__79_Ps" match
** c1 === expect resp.http.urlallupuc2b64 == "AAECAwQFBgcICQoL"
**** c1 EXPECT resp.http.urlallupuc2b64 (AAECAwQFBgcICQoL) == "AAECAwQFBgcICQoL" match
** c1 === expect resp.http.urlallupuc2b64url == "AAECAwQFBgcICQo="
**** c1 EXPECT resp.http.urlallupuc2b64url (AAECAwQFBgcICQo=) == "AAECAwQFBgcICQo=" match
** c1 === expect resp.http.urlallupuc2b64nopad == "AAECAwQFBgcICQo"
**** c1 EXPECT resp.http.urlallupuc2b64nopad (AAECAwQFBgcICQo) == "AAECAwQFBgcICQo" match
** c1 === expect resp.http.urlalluplc2b64 == "AAECAwQFBgcICQoL"
**** c1 EXPECT resp.http.urlalluplc2b64 (AAECAwQFBgcICQoL) == "AAECAwQFBgcICQoL" match
** c1 === expect resp.http.urlalluplc2b64url == "AAECAwQFBgcICQo="
**** c1 EXPECT resp.http.urlalluplc2b64url (AAECAwQFBgcICQo=) == "AAECAwQFBgcICQo=" match
** c1 === expect resp.http.urlalluplc2b64nopad == "AAECAwQFBgcICQo"
**** c1 EXPECT resp.http.urlalluplc2b64nopad (AAECAwQFBgcICQo) == "AAECAwQFBgcICQo" match
** c1 === expect resp.http.urlalldownuc2url == "%ff%fe%fd%fc%fb%fa%f9%...
**** c1 EXPECT resp.http.urlalldownuc2url (%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba) == "%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba" match
** c1 === expect resp.http.urlalldownuc2urluc == "%FF%FE%FD%FC%FB%FA%F...
**** c1 EXPECT resp.http.urlalldownuc2urluc (%FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba) == "%FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba" match
** c1 === expect resp.http.urlalldownuc2urllc == resp.http.urlalldownu...
**** c1 EXPECT resp.http.urlalldownuc2urllc (%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba) == "%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba" match
** c1 === expect resp.http.urlalldownlc2url == "%ff%fe%fd%fc%fb%fa%f9%...
**** c1 EXPECT resp.http.urlalldownlc2url (%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba) == "%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba" match
** c1 === expect resp.http.urlalldownlc2urluc == "%FF%FE%FD%FC%FB%FA%F...
**** c1 EXPECT resp.http.urlalldownlc2urluc (%FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba) == "%FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0%AF%AE%AD%AC%AB%AA%A9%A8%A7%A6%A5%A4%A3%A2%A1%A0%9F%9E%9D%9C%9B%9A%99%98%97%96%95%94%93%92%91%90%8F%8E%8D%8C%8B%8A%89%88%87%86%85%84%83%82%81%80%7F~%7D%7C%7Bzyxwvutsrqponmlkjihgfedcba" match
** c1 === expect resp.http.urlalldownlc2urllc == resp.http.urlalldownl...
**** c1 EXPECT resp.http.urlalldownlc2urllc (%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba) == "%ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0%af%ae%ad%ac%ab%aa%a9%a8%a7%a6%a5%a4%a3%a2%a1%a0%9f%9e%9d%9c%9b%9a%99%98%97%96%95%94%93%92%91%90%8f%8e%8d%8c%8b%8a%89%88%87%86%85%84%83%82%81%80%7f~%7d%7c%7bzyxwvutsrqponmlkjihgfedcba" match
** c1 === expect resp.http.urlallupuc2url == "%00%01%02%03%04%05%06%07...
**** c1 EXPECT resp.http.urlallupuc2url (%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ) == "%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ" match
** c1 === expect resp.http.urlalluplc2url == "%00%01%02%03%04%05%06%07...
**** c1 EXPECT resp.http.urlalluplc2url (%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ) == "%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ" match
** c1 === expect resp.http.urlallupuc2urluc == "%00%01%02%03%04%05%06%...
**** c1 EXPECT resp.http.urlallupuc2urluc (%00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ) == "%00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ" match
** c1 === expect resp.http.urlalluplc2urluc == "%00%01%02%03%04%05%06%...
**** c1 EXPECT resp.http.urlalluplc2urluc (%00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ) == "%00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ" match
** c1 === expect resp.http.urlallupuc2urllc == resp.http.urlallupuc2ur...
**** c1 EXPECT resp.http.urlallupuc2urllc (%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ) == "%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ" match
** c1 === expect resp.http.urlalluplc2urllc == resp.http.urlalluplc2ur...
**** c1 EXPECT resp.http.urlalluplc2urllc (%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ) == "%00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ" match
*** c1 closing fd 15
** c1 Ending
** top === server s1 -repeat 11 -keepalive {
** s1 Starting server
**** s1 macro def s1_addr=127.0.0.1
**** s1 macro def s1_port=36349
**** s1 macro def s1_sock=127.0.0.1:36349
* s1 Listen on 127.0.0.1:36349
** top === varnish v1 -vcl+backend {
**** v1 CLI TX|vcl.inline vcl4 << %XJEIFLH|)Xspa8P
**** v1 CLI TX|vcl 4.1;
**** v1 CLI TX|backend s1 { .host = "127.0.0.1"; .port = "36349"; }
**** v1 CLI TX|
**** v1 CLI TX|
**** v1 CLI TX|\timport blob;
**** v1 CLI TX|
**** v1 CLI TX|\tsub vcl_deliver {
**** v1 CLI TX|\t\tset req.http.foo = "AAA=";
**** v1 CLI TX|\t\tif (req.url == "/1") {
**** v1 CLI TX|\t\t\tset resp.http.good
**** v1 CLI TX|\t\t\t = blob.transcode(URL, IDENTITY, length=3,
**** v1 CLI TX|\t\t\t\t\t encoded="%2c%q");
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/2") {
**** v1 CLI TX|\t\t\tset resp.http.good
**** v1 CLI TX|\t\t\t = blob.transcode(URL, IDENTITY, length=3,
**** v1 CLI TX|\t\t\t\t\t encoded="%3a%2q");
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/3") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(HEX, IDENTITY, length=8,
**** v1 CLI TX|\t\t\t\t\t encoded="0x123456");
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/4") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(BASE64, IDENTITY, length=4,
**** v1 CLI TX|\t\t\t\t\t encoded="-_-_" + req.http.foo);
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/5") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(BASE64URL, IDENTITY, length=4,
**** v1 CLI TX|\t\t\t\t\t encoded="+/+/" + req.http.foo);
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/6") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(BASE64URLNOPAD, IDENTITY, length=8,
**** v1 CLI TX|\t\t\t\t\t encoded="TWFu" + req.http.foo);
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/7") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(BASE64, BASE64, length=4,
**** v1 CLI TX|\t\t\t\t\t encoded="_-_-" + req.http.foo);
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/8") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(BASE64URL, BASE64URL, length=4,
**** v1 CLI TX|\t\t\t\t\t encoded="/+/+" + req.http.foo);
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/9") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(BASE64URLNOPAD,
**** v1 CLI TX|\t\t\t\t\t BASE64URLNOPAD, length=8,
**** v1 CLI TX|\t\t\t\t\t encoded="Zm9v" + req.http.foo);
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/10") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(URL, IDENTITY, length=1,
**** v1 CLI TX|\t\t\t\t\t encoded="%20");
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t\telsif (req.url == "/11") {
**** v1 CLI TX|\t\t\tset resp.http.bad
**** v1 CLI TX|\t\t\t = blob.transcode(URL, IDENTITY, length=2,
**** v1 CLI TX|\t\t\t\t\t encoded="%20");
**** v1 CLI TX|\t\t}
**** v1 CLI TX|\t}
**** v1 CLI TX|
**** v1 CLI TX|%XJEIFLH|)Xspa8P
**** dT 7.147
** s1 Started on 127.0.0.1:36349 (11 iterations using keepalive)
**** dT 7.162
**** v1 vsl| 0 CLI - Rd vcl.load vcl3 vcl_vcl3.1684790575.824992/vgc.so 1auto
**** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl3.1684790575.824992/vgc.so" as "vcl3"
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790577 1.0
**** v1 vsl| 0 CLI - Rd vcl.use vcl3
**** v1 vsl| 0 CLI - Wr 200 0
**** v1 vsl| 1004 Begin c sess 0 HTTP/1
**** v1 vsl| 1004 SessOpen c 127.0.0.1 54276 a0 127.0.0.1 42645 1684790577.853626 25
**** v1 vsl| 1004 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1004 Link c req 1005 rxreq
**** v1 vsl| 1005 Begin c req 1004 rxreq
**** v1 vsl| 1005 Timestamp c Start: 1684790577.853693 0.000000 0.000000
**** v1 vsl| 1005 Timestamp c Req: 1684790577.853693 0.000000 0.000000
**** v1 vsl| 1005 VCL_use c vcl3
**** v1 vsl| 1005 ReqStart c 127.0.0.1 54276 a0
**** v1 vsl| 1005 ReqMethod c GET
**** v1 vsl| 1005 ReqURL c /
**** v1 vsl| 1005 ReqProtocol c HTTP/1.1
**** v1 vsl| 1005 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1005 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1005 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1005 VCL_call c RECV
**** v1 vsl| 1005 VCL_return c synth
**** v1 vsl| 1005 VCL_call c HASH
**** v1 vsl| 1005 VCL_return c lookup
**** v1 vsl| 1005 RespProtocol c HTTP/1.1
**** v1 vsl| 1005 RespStatus c 200
**** v1 vsl| 1005 RespReason c OK
**** v1 vsl| 1005 RespHeader c Date: Mon, 22 May 2023 21:22:57 GMT
**** v1 vsl| 1005 RespHeader c Server: Varnish
**** v1 vsl| 1005 RespHeader c X-Varnish: 1005
**** v1 vsl| 1005 VCL_call c SYNTH
**** v1 vsl| 1005 ReqHeader c urlhobbeslc: Man%20is%20distinguished%2c%20not%20only%20by%20his%20reason%2c%20but%20by%20this%20singular%20passion%20from%20other%20animals%2c%20which%20is%20a%20lust%20of%20the%20mind%2c%20that%20by%20a%20perseverance%20of%20delight%20in%20the%20contin
**** v1 vsl| 1005 ReqHeader c urlhobbesuc: Man%20is%20distinguished%2C%20not%20only%20by%20his%20reason%2C%20but%20by%20this%20singular%20passion%20from%20other%20animals%2C%20which%20is%20a%20lust%20of%20the%20mind%2C%20that%20by%20a%20perseverance%20of%20delight%20in%20the%20contin
**** v1 vsl| 1005 ReqHeader c urlallupuc: %00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ%5B%5C%5D%5E_%60abcdefghijklmnopqrstuvwxyz%7B
**** v1 vsl| 1005 ReqHeader c urlalluplc: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ%5b%5c%5d%5e_%60abcdefghijklmnopqrstuvwxyz%7b
**** v1 vsl| 1005 ReqHeader c urlalldownuc: %FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2%B1%B0
**** v1 vsl| 1005 ReqHeader c urlalldownlc: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b1%b0
**** v1 vsl| 1005 RespHeader c urluc2id: Man is distinguished,
**** v1 vsl| 1005 RespHeader c urllc2id: Man is distinguished, not only by his reason,
**** v1 vsl| 1005 RespHeader c urlalldownuc2b64: //79/Pv6
**** v1 vsl| 1005 RespHeader c urlalldownuc2b64url: __79_Ps=
**** v1 vsl| 1005 RespHeader c urlalldownuc2b64nopad: __79_Ps
**** v1 vsl| 1005 RespHeader c urlalldownlc2b64: //79/Pv6
**** v1 vsl| 1005 RespHeader c urlalldownlc2b64url: __79_Ps=
**** v1 vsl| 1005 RespHeader c urlalldownlc2b64nopad: __79_Ps
**** v1 vsl| 1005 RespHeader c urlallupuc2b64: AAECAwQFBgcICQoL
**** v1 vsl| 1005 RespHeader c urlallupuc2b64url: AAECAwQFBgcICQo=
**** v1 vsl| 1005 RespHeader c urlallupuc2b64nopad: AAECAwQFBgcICQo
**** v1 vsl| 1005 RespHeader c urlalluplc2b64: AAECAwQFBgcICQoL
**** v1 vsl| 1005 RespHeader c urlalluplc2b64url: AAECAwQFBgcICQo=
**** v1 vsl| 1005 RespHeader c urlalluplc2b64nopad: AAECAwQFBgcICQo
**** v1 vsl| 1005 RespHeader c urlalldownuc2url: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b
**** v1 vsl| 1005 RespHeader c urlalldownuc2urluc: %FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2
**** v1 vsl| 1005 RespHeader c urlalldownuc2urllc: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2
**** v1 vsl| 1005 RespHeader c urlalldownlc2url: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2%b
**** v1 vsl| 1005 RespHeader c urlalldownlc2urluc: %FF%FE%FD%FC%FB%FA%F9%F8%F7%F6%F5%F4%F3%F2%F1%F0%EF%EE%ED%EC%EB%EA%E9%E8%E7%E6%E5%E4%E3%E2%E1%E0%DF%DE%DD%DC%DB%DA%D9%D8%D7%D6%D5%D4%D3%D2%D1%D0%CF%CE%CD%CC%CB%CA%C9%C8%C7%C6%C5%C4%C3%C2%C1%C0%BF%BE%BD%BC%BB%BA%B9%B8%B7%B6%B5%B4%B3%B2
**** v1 vsl| 1005 RespHeader c urlalldownlc2urllc: %ff%fe%fd%fc%fb%fa%f9%f8%f7%f6%f5%f4%f3%f2%f1%f0%ef%ee%ed%ec%eb%ea%e9%e8%e7%e6%e5%e4%e3%e2%e1%e0%df%de%dd%dc%db%da%d9%d8%d7%d6%d5%d4%d3%d2%d1%d0%cf%ce%cd%cc%cb%ca%c9%c8%c7%c6%c5%c4%c3%c2%c1%c0%bf%be%bd%bc%bb%ba%b9%b8%b7%b6%b5%b4%b3%b2
**** v1 vsl| 1005 RespHeader c urlallupuc2url: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** v1 vsl| 1005 RespHeader c urlallupuc2urluc: %00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** v1 vsl| 1005 RespHeader c urlallupuc2urllc: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** v1 vsl| 1005 RespHeader c urlalluplc2url: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** v1 vsl| 1005 RespHeader c urlalluplc2urluc: %00%01%02%03%04%05%06%07%08%09%0A%0B%0C%0D%0E%0F%10%11%12%13%14%15%16%17%18%19%1A%1B%1C%1D%1E%1F%20%21%22%23%24%25%26%27%28%29%2A%2B%2C-.%2F0123456789%3A%3B%3C%3D%3E%3F%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** v1 vsl| 1005 RespHeader c urlalluplc2urllc: %00%01%02%03%04%05%06%07%08%09%0a%0b%0c%0d%0e%0f%10%11%12%13%14%15%16%17%18%19%1a%1b%1c%1d%1e%1f%20%21%22%23%24%25%26%27%28%29%2a%2b%2c-.%2f0123456789%3a%3b%3c%3d%3e%3f%40ABCDEFGHIJKLMNOPQRSTUVWXYZ
**** v1 vsl| 1005 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1005 RespHeader c Retry-After: 5
**** v1 vsl| 1005 VCL_return c deliver
**** v1 vsl| 1005 Timestamp c Process: 1684790577.853924 0.000231 0.000231
**** v1 vsl| 1005 RespHeader c Content-Length: 227
**** v1 vsl| 1005 Storage c malloc Transient
**** v1 vsl| 1005 Filters c
**** v1 vsl| 1005 RespHeader c Connection: keep-alive
**** v1 vsl| 1005 Timestamp c Resp: 1684790577.854014 0.000321 0.000090
**** v1 vsl| 1005 ReqAcct c 35 0 35 4645 227 4872
**** v1 vsl| 1005 End c
**** v1 vsl| 1004 SessClose c REM_CLOSE 0.056
**** v1 vsl| 1004 End c
**** dT 9.181
*** v1 CLI RX 200
**** v1 CLI TX|vcl.use vcl4
**** dT 9.197
*** v1 CLI RX 200
**** v1 CLI RX|VCL 'vcl4' now active
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54332 to 127.0.0.1:42645
** c1 === txreq -url /1
**** c1 txreq|GET /1 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.203
*** s1 accepted fd 16 127.0.0.1 51016
** s1 === rxreq
**** dT 9.204
**** s1 rxhdr|GET /1 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1008\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/1
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1008
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:22:59 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.207
**** v1 vsl| 0 CLI - Rd vcl.load vcl4 vcl_vcl4.1684790577.908941/vgc.so 1auto
**** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl4.1684790577.908941/vgc.so" as "vcl4"
**** v1 vsl| 0 CLI - Rd vcl.use vcl4
**** v1 vsl| 0 CLI - Wr 200 0
**** v1 vsl| 1006 Begin c sess 0 HTTP/1
**** v1 vsl| 1006 SessOpen c 127.0.0.1 54332 a0 127.0.0.1 42645 1684790579.969381 23
**** v1 vsl| 1006 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1006 Link c req 1007 rxreq
**** dT 9.225
**** c1 rxhdr|HTTP/1.1 200 OK\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:22:59 GMT\r
**** c1 rxhdr|Content-Length: 0\r
**** c1 rxhdr|X-Varnish: 1007\r
**** c1 rxhdr|Age: 0\r
**** c1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** c1 rxhdr|Accept-Ranges: bytes\r
**** c1 rxhdr|good: ,\r
**** c1 rxhdr|Connection: keep-alive\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 184
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |200
**** c1 http[ 2] |OK
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:22:59 GMT
**** c1 http[ 4] |Content-Length: 0
**** c1 http[ 5] |X-Varnish: 1007
**** c1 http[ 6] |Age: 0
**** c1 http[ 7] |Via: 1.1 v1 (Varnish/trunk)
**** c1 http[ 8] |Accept-Ranges: bytes
**** c1 http[ 9] |good: ,
**** c1 http[10] |Connection: keep-alive
**** c1 bodylen = 0
** c1 === expect resp.status == 200
**** c1 EXPECT resp.status (200) == "200" match
** c1 === expect resp.http.good == ","
**** c1 EXPECT resp.http.good (,) == "," match
** c1 === txreq -url /2
**** dT 9.226
**** c1 txreq|GET /2 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.230
**** s1 rxhdr|GET /2 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1010\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/2
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1010
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.245
**** c1 rxhdr|HTTP/1.1 200 OK\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Content-Length: 0\r
**** c1 rxhdr|X-Varnish: 1009\r
**** c1 rxhdr|Age: 0\r
**** c1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** c1 rxhdr|Accept-Ranges: bytes\r
**** c1 rxhdr|good: :\r
**** c1 rxhdr|Connection: keep-alive\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 184
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |200
**** c1 http[ 2] |OK
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Content-Length: 0
**** c1 http[ 5] |X-Varnish: 1009
**** c1 http[ 6] |Age: 0
**** c1 http[ 7] |Via: 1.1 v1 (Varnish/trunk)
**** c1 http[ 8] |Accept-Ranges: bytes
**** c1 http[ 9] |good: :
**** c1 http[10] |Connection: keep-alive
**** c1 bodylen = 0
** c1 === expect resp.status == 200
**** c1 EXPECT resp.status (200) == "200" match
** c1 === expect resp.http.good == ":"
**** c1 EXPECT resp.http.good (:) == ":" match
** c1 === txreq -url /3
**** c1 txreq|GET /3 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.249
**** s1 rxhdr|GET /3 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1012\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/3
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1012
**** s1 bodylen = 0
** s1 === txresp
**** dT 9.250
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.265
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1011\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1011
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1011
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.274
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54336 to 127.0.0.1:42645
**** dT 9.279
** c1 === txreq -url /4
**** c1 txreq|GET /4 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.283
**** s1 rxhdr|GET /4 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1015\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/4
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1015
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.300
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1014\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1014
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1014
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.312
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54338 to 127.0.0.1:42645
** c1 === txreq -url /5
**** c1 txreq|GET /5 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** v1 vsl| 1008 Begin b bereq 1007 fetch
**** v1 vsl| 1008 VCL_use b vcl4
**** v1 vsl| 1008 Timestamp b Start: 1684790579.969601 0.000000 0.000000
**** v1 vsl| 1008 BereqMethod b GET
**** v1 vsl| 1008 BereqURL b /1
**** v1 vsl| 1008 BereqProtocol b HTTP/1.1
**** v1 vsl| 1008 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1008 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1008 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1008 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1008 BereqHeader b X-Varnish: 1008
**** v1 vsl| 1008 VCL_call b BACKEND_FETCH
**** v1 vsl| 1008 VCL_return b fetch
**** v1 vsl| 1008 Timestamp b Fetch: 1684790579.969621 0.000020 0.000020
**** v1 vsl| 1008 Timestamp b Connected: 1684790579.969813 0.000211 0.000191
**** v1 vsl| 1008 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 connect
**** v1 vsl| 1008 Timestamp b Bereq: 1684790579.969854 0.000252 0.000041
**** v1 vsl| 1008 BerespProtocol b HTTP/1.1
**** v1 vsl| 1008 BerespStatus b 200
**** v1 vsl| 1008 BerespReason b OK
**** v1 vsl| 1008 BerespHeader b Date: Mon, 22 May 2023 21:22:59 GMT
**** v1 vsl| 1008 BerespHeader b Content-Length: 0
**** v1 vsl| 1008 Timestamp b Beresp: 1684790579.978980 0.009378 0.009125
**** v1 vsl| 1008 TTL b RFC 120 10 0 1684790580 1684790580 1684790579 0 0 cacheable
**** v1 vsl| 1008 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1008 VCL_return b deliver
**** v1 vsl| 1008 Timestamp b Process: 1684790579.979068 0.009467 0.000088
**** v1 vsl| 1008 Filters b
**** v1 vsl| 1008 Storage b malloc s0
**** v1 vsl| 1008 Fetch_Body b 0 none -
**** v1 vsl| 1008 BackendClose b 26 s1 recycle
**** v1 vsl| 1008 Timestamp b BerespBody: 1684790579.990799 0.021198 0.011730
**** v1 vsl| 1008 Length b 0
**** v1 vsl| 1008 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1008 End b
**** v1 vsl| 1007 Begin c req 1006 rxreq
**** v1 vsl| 1007 Timestamp c Start: 1684790579.969429 0.000000 0.000000
**** v1 vsl| 1007 Timestamp c Req: 1684790579.969429 0.000000 0.000000
**** v1 vsl| 1007 VCL_use c vcl4
**** v1 vsl| 1007 ReqStart c 127.0.0.1 54332 a0
**** v1 vsl| 1007 ReqMethod c GET
**** v1 vsl| 1007 ReqURL c /1
**** v1 vsl| 1007 ReqProtocol c HTTP/1.1
**** v1 vsl| 1007 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1007 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1007 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1007 VCL_call c RECV
**** v1 vsl| 1007 VCL_return c hash
**** v1 vsl| 1007 VCL_call c HASH
**** v1 vsl| 1007 VCL_return c lookup
**** v1 vsl| 1007 VCL_call c MISS
**** v1 vsl| 1007 VCL_return c fetch
**** v1 vsl| 1007 Link c bereq 1008 fetch
**** v1 vsl| 1007 Timestamp c Fetch: 1684790579.990910 0.021480 0.021480
**** v1 vsl| 1007 RespProtocol c HTTP/1.1
**** v1 vsl| 1007 RespStatus c 200
**** v1 vsl| 1007 RespReason c OK
**** v1 vsl| 1007 RespHeader c Date: Mon, 22 May 2023 21:22:59 GMT
**** v1 vsl| 1007 RespHeader c Content-Length: 0
**** v1 vsl| 1007 RespHeader c X-Varnish: 1007
**** v1 vsl| 1007 RespHeader c Age: 0
**** v1 vsl| 1007 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1007 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1007 VCL_call c DELIVER
**** v1 vsl| 1007 ReqHeader c foo: AAA=
**** v1 vsl| 1007 RespHeader c good: ,
**** v1 vsl| 1007 VCL_return c deliver
**** v1 vsl| 1007 Timestamp c Process: 1684790579.990963 0.021533 0.000052
**** v1 vsl| 1007 Filters c
**** v1 vsl| 1007 RespHeader c Connection: keep-alive
**** v1 vsl| 1007 Timestamp c Resp: 1684790579.991059 0.021629 0.000096
**** v1 vsl| 1007 ReqAcct c 36 0 36 184 0 184
**** v1 vsl| 1007 End c
**** v1 vsl| 1006 Link c req 1009 rxreq
**** v1 vsl| 1010 Begin b bereq 1009 fetch
**** v1 vsl| 1010 VCL_use b vcl4
**** v1 vsl| 1010 Timestamp b Start: 1684790579.999213 0.000000 0.000000
**** v1 vsl| 1010 BereqMethod b GET
**** v1 vsl| 1010 BereqURL b /2
**** v1 vsl| 1010 BereqProtocol b HTTP/1.1
**** v1 vsl| 1010 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1010 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1010 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1010 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1010 BereqHeader b X-Varnish: 1010
**** v1 vsl| 1010 VCL_call b BACKEND_FETCH
**** v1 vsl| 1010 VCL_return b fetch
**** v1 vsl| 1010 Timestamp b Fetch: 1684790579.999237 0.000023 0.000023
**** v1 vsl| 1010 Timestamp b Connected: 1684790579.999243 0.000029 0.000005
**** v1 vsl| 1010 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1010 Timestamp b Bereq: 1684790579.999366 0.000153 0.000123
**** v1 vsl| 1010 BerespProtocol b HTTP/1.1
**** v1 vsl| 1010 BerespStatus b 200
**** v1 vsl| 1010 BerespReason b OK
**** v1 vsl| 1010 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1010 BerespHeader b Content-Length: 0
**** v1 vsl| 1010 Timestamp b Beresp: 1684790580.001808 0.002595 0.002441
**** v1 vsl| 1010 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1010 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1010 VCL_return b deliver
**** v1 vsl| 1010 Timestamp b Process: 1684790580.001839 0.002626 0.000031
**** v1 vsl| 1010 Filters b
**** v1 vsl| 1010 Storage b malloc s0
**** v1 vsl| 1010 Fetch_Body b 0 none -
**** v1 vsl| 1010 BackendClose b 26 s1 recycle
**** v1 vsl| 1010 Timestamp b BerespBody: 1684790580.013229 0.014015 0.011389
**** v1 vsl| 1010 Length b 0
**** v1 vsl| 1010 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1010 End b
**** v1 vsl| 1009 Begin c req 1006 rxreq
**** v1 vsl| 1009 Timestamp c Start: 1684790579.998633 0.000000 0.000000
**** v1 vsl| 1009 Timestamp c Req: 1684790579.998633 0.000000 0.000000
**** v1 vsl| 1009 VCL_use c vcl4
**** v1 vsl| 1009 ReqStart c 127.0.0.1 54332 a0
**** v1 vsl| 1009 ReqMethod c GET
**** v1 vsl| 1009 ReqURL c /2
**** v1 vsl| 1009 ReqProtocol c HTTP/1.1
**** v1 vsl| 1009 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1009 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1009 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1009 VCL_call c RECV
**** v1 vsl| 1009 VCL_return c hash
**** v1 vsl| 1009 VCL_call c HASH
**** v1 vsl| 1009 VCL_return c lookup
**** v1 vsl| 1009 VCL_call c MISS
**** v1 vsl| 1009 VCL_return c fetch
**** v1 vsl| 1009 Link c bereq 1010 fetch
**** v1 vsl| 1009 Timestamp c Fetch: 1684790580.013283 0.014649 0.014649
**** v1 vsl| 1009 RespProtocol c HTTP/1.1
**** v1 vsl| 1009 RespStatus c 200
**** v1 vsl| 1009 RespReason c OK
**** v1 vsl| 1009 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1009 RespHeader c Content-Length: 0
**** v1 vsl| 1009 RespHeader c X-Varnish: 1009
**** v1 vsl| 1009 RespHeader c Age: 0
**** v1 vsl| 1009 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1009 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1009 VCL_call c DELIVER
**** v1 vsl| 1009 ReqHeader c foo: AAA=
**** v1 vsl| 1009 RespHeader c good: :
**** v1 vsl| 1009 VCL_return c deliver
**** v1 vsl| 1009 Timestamp c Process: 1684790580.013322 0.014689 0.000039
**** v1 vsl| 1009 Filters c
**** v1 vsl| 1009 RespHeader c Connection: keep-alive
**** v1 vsl| 1009 Timestamp c Resp: 1684790580.013448 0.014815 0.000125
**** v1 vsl| 1009 ReqAcct c 36 0 36 184 0 184
**** v1 vsl| 1009 End c
**** v1 vsl| 1006 Link c req 1011 rxreq
**** v1 vsl| 1012 Begin b bereq 1011 fetch
**** v1 vsl| 1012 VCL_use b vcl4
**** v1 vsl| 1012 Timestamp b Start: 1684790580.019676 0.000000 0.000000
**** v1 vsl| 1012 BereqMethod b GET
**** v1 vsl| 1012 BereqURL b /3
**** v1 vsl| 1012 BereqProtocol b HTTP/1.1
**** v1 vsl| 1012 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1012 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1012 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1012 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1012 BereqHeader b X-Varnish: 1012
**** v1 vsl| 1012 VCL_call b BACKEND_FETCH
**** v1 vsl| 1012 VCL_return b fetch
**** v1 vsl| 1012 Timestamp b Fetch: 1684790580.019695 0.000018 0.000018
**** v1 vsl| 1012 Timestamp b Connected: 1684790580.019700 0.000024 0.000005
**** v1 vsl| 1012 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1012 Timestamp b Bereq: 1684790580.019792 0.000115 0.000091
**** v1 vsl| 1012 BerespProtocol b HTTP/1.1
**** v1 vsl| 1012 BerespStatus b 200
**** v1 vsl| 1012 BerespReason b OK
**** v1 vsl| 1012 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1012 BerespHeader b Content-Length: 0
**** v1 vsl| 1012 Timestamp b Beresp: 1684790580.021405 0.001729 0.001613
**** v1 vsl| 1012 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1012 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1012 VCL_return b deliver
**** v1 vsl| 1012 Timestamp b Process: 1684790580.021434 0.001758 0.000028
**** v1 vsl| 1012 Filters b
**** v1 vsl| 1012 Storage b malloc s0
**** v1 vsl| 1012 Fetch_Body b 0 none -
**** v1 vsl| 1012 BackendClose b 26 s1 recycle
**** v1 vsl| 1012 Timestamp b BerespBody: 1684790580.034817 0.015140 0.013382
**** v1 vsl| 1012 Length b 0
**** v1 vsl| 1012 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1012 End b
**** v1 vsl| 1011 Begin c req 1006 rxreq
**** v1 vsl| 1011 Timestamp c Start: 1684790580.019582 0.000000 0.000000
**** v1 vsl| 1011 Timestamp c Req: 1684790580.019582 0.000000 0.000000
**** v1 vsl| 1011 VCL_use c vcl4
**** v1 vsl| 1011 ReqStart c 127.0.0.1 54332 a0
**** v1 vsl| 1011 ReqMethod c GET
**** v1 vsl| 1011 ReqURL c /3
**** v1 vsl| 1011 ReqProtocol c HTTP/1.1
**** v1 vsl| 1011 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1011 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1011 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1011 VCL_call c RECV
**** v1 vsl| 1011 VCL_return c hash
**** v1 vsl| 1011 VCL_call c HASH
**** v1 vsl| 1011 VCL_return c lookup
**** v1 vsl| 1011 VCL_call c MISS
**** v1 vsl| 1011 VCL_return c fetch
**** v1 vsl| 1011 Link c bereq 1012 fetch
**** v1 vsl| 1011 Timestamp c Fetch: 1684790580.034867 0.015285 0.015285
**** v1 vsl| 1011 RespProtocol c HTTP/1.1
**** v1 vsl| 1011 RespStatus c 200
**** v1 vsl| 1011 RespReason c OK
**** v1 vsl| 1011 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1011 RespHeader c Content-Length: 0
**** v1 vsl| 1011 RespHeader c X-Varnish: 1011
**** v1 vsl| 1011 RespHeader c Age: 0
**** v1 vsl| 1011 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1011 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1011 VCL_call c DELIVER
**** v1 vsl| 1011 ReqHeader c foo: AAA=
**** v1 vsl| 1011 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "0x123456"
**** v1 vsl| 1011 RespHeader c bad:
**** v1 vsl| 1011 VCL_return c fail
**** v1 vsl| 1011 Timestamp c Process: 1684790580.034905 0.015323 0.000038
**** v1 vsl| 1011 RespProtocol c HTTP/1.1
**** v1 vsl| 1011 RespStatus c 503
**** v1 vsl| 1011 RespReason c VCL failed
**** v1 vsl| 1011 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1011 RespHeader c Server: Varnish
**** v1 vsl| 1011 RespHeader c X-Varnish: 1011
**** v1 vsl| 1011 VCL_call c SYNTH
**** v1 vsl| 1011 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1011 RespHeader c Retry-After: 5
**** v1 vsl| 1011 VCL_return c deliver
**** v1 vsl| 1011 Timestamp c Process: 1684790580.034926 0.015344 0.000020
**** v1 vsl| 1011 RespHeader c Content-Length: 251
**** v1 vsl| 1011 Storage c malloc Transient
**** v1 vsl| 1011 Filters c
**** v1 vsl| 1011 RespHeader c Connection: close
**** v1 vsl| 1011 Timestamp c Resp: 1684790580.035032 0.015450 0.000105
**** v1 vsl| 1011 ReqAcct c 36 0 36 194 251 445
**** v1 vsl| 1011 End c
**** v1 vsl| 1006 SessClose c VCL_FAILURE 0.066
**** v1 vsl| 1006 End c
**** v1 vsl| 1013 Begin c sess 0 HTTP/1
**** v1 vsl| 1013 SessOpen c 127.0.0.1 54336 a0 127.0.0.1 42645 1684790580.046599 24
**** v1 vsl| 1013 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1013 Link c req 1014 rxreq
**** v1 vsl| 1015 Begin b bereq 1014 fetch
**** v1 vsl| 1015 VCL_use b vcl4
**** v1 vsl| 1015 Timestamp b Start: 1684790580.051439 0.000000 0.000000
**** v1 vsl| 1015 BereqMethod b GET
**** v1 vsl| 1015 BereqURL b /4
**** v1 vsl| 1015 BereqProtocol b HTTP/1.1
**** v1 vsl| 1015 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1015 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1015 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1015 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1015 BereqHeader b X-Varnish: 1015
**** v1 vsl| 1015 VCL_call b BACKEND_FETCH
**** v1 vsl| 1015 VCL_return b fetch
**** v1 vsl| 1015 Timestamp b Fetch: 1684790580.051459 0.000020 0.000020
**** v1 vsl| 1015 Timestamp b Connected: 1684790580.051470 0.000031 0.000011
**** v1 vsl| 1015 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1015 Timestamp b Bereq: 1684790580.051591 0.000152 0.000120
**** v1 vsl| 1015 BerespProtocol b HTTP/1.1
**** v1 vsl| 1015 BerespStatus b 200
**** v1 vsl| 1015 BerespReason b OK
**** v1 vsl| 1015 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1015 BerespHeader b Content-Length: 0
**** v1 vsl| 1015 Timestamp b Beresp: 1684790580.056227 0.004788 0.004636
**** v1 vsl| 1015 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1015 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1015 VCL_return b deliver
**** v1 vsl| 1015 Timestamp b Process: 1684790580.056356 0.004917 0.000128
**** v1 vsl| 1015 Filters b
**** v1 vsl| 1015 Storage b malloc s0
**** v1 vsl| 1015 Fetch_Body b 0 none -
**** v1 vsl| 1015 BackendClose b 26 s1 recycle
**** v1 vsl| 1015 Timestamp b BerespBody: 1684790580.068908 0.017469 0.012552
**** v1 vsl| 1015 Length b 0
**** v1 vsl| 1015 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1015 End b
**** v1 vsl| 1014 Begin c req 1013 rxreq
**** v1 vsl| 1014 Timestamp c Start: 1684790580.051269 0.000000 0.000000
**** v1 vsl| 1014 Timestamp c Req: 1684790580.051269 0.000000 0.000000
**** v1 vsl| 1014 VCL_use c vcl4
**** v1 vsl| 1014 ReqStart c 127.0.0.1 54336 a0
**** v1 vsl| 1014 ReqMethod c GET
**** v1 vsl| 1014 ReqURL c /4
**** v1 vsl| 1014 ReqProtocol c HTTP/1.1
**** v1 vsl| 1014 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1014 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1014 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1014 VCL_call c RECV
**** v1 vsl| 1014 VCL_return c hash
**** v1 vsl| 1014 VCL_call c HASH
**** v1 vsl| 1014 VCL_return c lookup
**** v1 vsl| 1014 VCL_call c MISS
**** v1 vsl| 1014 VCL_return c fetch
**** v1 vsl| 1014 Link c bereq 1015 fetch
**** v1 vsl| 1014 Timestamp c Fetch: 1684790580.068960 0.017691 0.017691
**** v1 vsl| 1014 RespProtocol c HTTP/1.1
**** v1 vsl| 1014 RespStatus c 200
**** v1 vsl| 1014 RespReason c OK
**** v1 vsl| 1014 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1014 RespHeader c Content-Length: 0
**** v1 vsl| 1014 RespHeader c X-Varnish: 1014
**** v1 vsl| 1014 RespHeader c Age: 0
**** v1 vsl| 1014 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1014 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1014 VCL_call c DELIVER
**** v1 vsl| 1014 ReqHeader c foo: AAA=
**** v1 vsl| 1014 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "-_-_"
**** v1 vsl| 1014 RespHeader c bad:
**** v1 vsl| 1014 VCL_return c fail
**** v1 vsl| 1014 Timestamp c Process: 1684790580.069001 0.017732 0.000041
**** v1 vsl| 1014 RespProtocol c HTTP/1.1
**** v1 vsl| 1014 RespStatus c 503
**** v1 vsl| 1014 RespReason c VCL failed
**** v1 vsl| 1014 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1014 RespHeader c Server: Varnish
**** v1 vsl| 1014 RespHeader c X-Varnish: 1014
**** v1 vsl| 1014 VCL_call c SYNTH
**** v1 vsl| 1014 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1014 RespHeader c Retry-After: 5
**** v1 vsl| 1014 VCL_return c deliver
**** v1 vsl| 1014 Timestamp c Process: 1684790580.069023 0.017754 0.000021
**** v1 vsl| 1014 RespHeader c Content-Length: 251
**** v1 vsl| 1014 Storage c malloc Transient
**** v1 vsl| 1014 Filters c
**** v1 vsl| 1014 RespHeader c Connection: close
**** v1 vsl| 1014 Timestamp c Resp: 1684790580.069136 0.017867 0.000113
**** v1 vsl| 1014 ReqAcct c 36 0 36 194 251 445
**** v1 vsl| 1014 End c
**** v1 vsl| 1013 SessClose c VCL_FAILURE 0.023
**** v1 vsl| 1013 End c
**** dT 9.313
**** s1 rxhdr|GET /5 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1018\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/5
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1018
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.328
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1017\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1017
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1017
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.334
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54340 to 127.0.0.1:42645
** c1 === txreq -url /6
**** c1 txreq|GET /6 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.338
**** s1 rxhdr|GET /6 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1021\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/6
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1021
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.352
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1020\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1020
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1020
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.361
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54342 to 127.0.0.1:42645
** c1 === txreq -url /7
**** c1 txreq|GET /7 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.362
**** s1 rxhdr|GET /7 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1024\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/7
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1024
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.376
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1023\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1023
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1023
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.384
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54344 to 127.0.0.1:42645
** c1 === txreq -url /8
**** c1 txreq|GET /8 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.389
**** s1 rxhdr|GET /8 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1027\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/8
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1027
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.425
**** v1 vsl| 1016 Begin c sess 0 HTTP/1
**** v1 vsl| 1016 SessOpen c 127.0.0.1 54338 a0 127.0.0.1 42645 1684790580.084033 25
**** v1 vsl| 1016 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1016 Link c req 1017 rxreq
**** v1 vsl| 1018 Begin b bereq 1017 fetch
**** v1 vsl| 1018 VCL_use b vcl4
**** v1 vsl| 1018 Timestamp b Start: 1684790580.084174 0.000000 0.000000
**** v1 vsl| 1018 BereqMethod b GET
**** v1 vsl| 1018 BereqURL b /5
**** v1 vsl| 1018 BereqProtocol b HTTP/1.1
**** v1 vsl| 1018 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1018 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1018 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1018 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1018 BereqHeader b X-Varnish: 1018
**** v1 vsl| 1018 VCL_call b BACKEND_FETCH
**** v1 vsl| 1018 VCL_return b fetch
**** v1 vsl| 1018 Timestamp b Fetch: 1684790580.084193 0.000018 0.000018
**** v1 vsl| 1018 Timestamp b Connected: 1684790580.084198 0.000024 0.000005
**** v1 vsl| 1018 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1018 Timestamp b Bereq: 1684790580.084288 0.000113 0.000089
**** v1 vsl| 1018 BerespProtocol b HTTP/1.1
**** v1 vsl| 1018 BerespStatus b 200
**** v1 vsl| 1018 BerespReason b OK
**** v1 vsl| 1018 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1018 BerespHeader b Content-Length: 0
**** v1 vsl| 1018 Timestamp b Beresp: 1684790580.086200 0.002026 0.001912
**** v1 vsl| 1018 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1018 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1018 VCL_return b deliver
**** v1 vsl| 1018 Timestamp b Process: 1684790580.086233 0.002059 0.000033
**** v1 vsl| 1018 Filters b
**** v1 vsl| 1018 Storage b malloc s0
**** v1 vsl| 1018 Fetch_Body b 0 none -
**** v1 vsl| 1018 BackendClose b 26 s1 recycle
**** v1 vsl| 1018 Timestamp b BerespBody: 1684790580.098907 0.014733 0.012673
**** v1 vsl| 1018 Length b 0
**** v1 vsl| 1018 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1018 End b
**** v1 vsl| 1017 Begin c req 1016 rxreq
**** v1 vsl| 1017 Timestamp c Start: 1684790580.084086 0.000000 0.000000
**** v1 vsl| 1017 Timestamp c Req: 1684790580.084086 0.000000 0.000000
**** v1 vsl| 1017 VCL_use c vcl4
**** v1 vsl| 1017 ReqStart c 127.0.0.1 54338 a0
**** v1 vsl| 1017 ReqMethod c GET
**** v1 vsl| 1017 ReqURL c /5
**** v1 vsl| 1017 ReqProtocol c HTTP/1.1
**** v1 vsl| 1017 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1017 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1017 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1017 VCL_call c RECV
**** v1 vsl| 1017 VCL_return c hash
**** v1 vsl| 1017 VCL_call c HASH
**** v1 vsl| 1017 VCL_return c lookup
**** v1 vsl| 1017 VCL_call c MISS
**** v1 vsl| 1017 VCL_return c fetch
**** v1 vsl| 1017 Link c bereq 1018 fetch
**** v1 vsl| 1017 Timestamp c Fetch: 1684790580.098999 0.014913 0.014913
**** v1 vsl| 1017 RespProtocol c HTTP/1.1
**** v1 vsl| 1017 RespStatus c 200
**** v1 vsl| 1017 RespReason c OK
**** v1 vsl| 1017 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1017 RespHeader c Content-Length: 0
**** v1 vsl| 1017 RespHeader c X-Varnish: 1017
**** v1 vsl| 1017 RespHeader c Age: 0
**** v1 vsl| 1017 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1017 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1017 VCL_call c DELIVER
**** v1 vsl| 1017 ReqHeader c foo: AAA=
**** v1 vsl| 1017 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "+/+/"
**** v1 vsl| 1017 RespHeader c bad:
**** v1 vsl| 1017 VCL_return c fail
**** v1 vsl| 1017 Timestamp c Process: 1684790580.099041 0.014954 0.000041
**** v1 vsl| 1017 RespProtocol c HTTP/1.1
**** v1 vsl| 1017 RespStatus c 503
**** v1 vsl| 1017 RespReason c VCL failed
**** v1 vsl| 1017 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1017 RespHeader c Server: Varnish
**** v1 vsl| 1017 RespHeader c X-Varnish: 1017
**** v1 vsl| 1017 VCL_call c SYNTH
**** v1 vsl| 1017 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1017 RespHeader c Retry-After: 5
**** v1 vsl| 1017 VCL_return c deliver
**** v1 vsl| 1017 Timestamp c Process: 1684790580.099062 0.014975 0.000021
**** v1 vsl| 1017 RespHeader c Content-Length: 251
**** v1 vsl| 1017 Storage c malloc Transient
**** v1 vsl| 1017 Filters c
**** v1 vsl| 1017 RespHeader c Connection: close
**** v1 vsl| 1017 Timestamp c Resp: 1684790580.099173 0.015087 0.000111
**** v1 vsl| 1017 ReqAcct c 36 0 36 194 251 445
**** v1 vsl| 1017 End c
**** v1 vsl| 1016 SessClose c VCL_FAILURE 0.015
**** v1 vsl| 1016 End c
**** v1 vsl| 1019 Begin c sess 0 HTTP/1
**** v1 vsl| 1019 SessOpen c 127.0.0.1 54340 a0 127.0.0.1 42645 1684790580.108677 23
**** v1 vsl| 1019 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1019 Link c req 1020 rxreq
**** v1 vsl| 1021 Begin b bereq 1020 fetch
**** v1 vsl| 1021 VCL_use b vcl4
**** v1 vsl| 1021 Timestamp b Start: 1684790580.108825 0.000000 0.000000
**** v1 vsl| 1021 BereqMethod b GET
**** v1 vsl| 1021 BereqURL b /6
**** v1 vsl| 1021 BereqProtocol b HTTP/1.1
**** v1 vsl| 1021 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1021 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1021 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1021 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1021 BereqHeader b X-Varnish: 1021
**** v1 vsl| 1021 VCL_call b BACKEND_FETCH
**** v1 vsl| 1021 VCL_return b fetch
**** v1 vsl| 1021 Timestamp b Fetch: 1684790580.108844 0.000019 0.000019
**** v1 vsl| 1021 Timestamp b Connected: 1684790580.108850 0.000025 0.000006
**** v1 vsl| 1021 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1021 Timestamp b Bereq: 1684790580.108944 0.000118 0.000093
**** v1 vsl| 1021 BerespProtocol b HTTP/1.1
**** v1 vsl| 1021 BerespStatus b 200
**** v1 vsl| 1021 BerespReason b OK
**** v1 vsl| 1021 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1021 BerespHeader b Content-Length: 0
**** v1 vsl| 1021 Timestamp b Beresp: 1684790580.111724 0.002899 0.002780
**** v1 vsl| 1021 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1021 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1021 VCL_return b deliver
**** v1 vsl| 1021 Timestamp b Process: 1684790580.111752 0.002926 0.000027
**** v1 vsl| 1021 Filters b
**** v1 vsl| 1021 Storage b malloc s0
**** v1 vsl| 1021 Fetch_Body b 0 none -
**** v1 vsl| 1021 BackendClose b 26 s1 recycle
**** v1 vsl| 1021 Timestamp b BerespBody: 1684790580.122685 0.013860 0.010933
**** v1 vsl| 1021 Length b 0
**** v1 vsl| 1021 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1021 End b
**** v1 vsl| 1020 Begin c req 1019 rxreq
**** v1 vsl| 1020 Timestamp c Start: 1684790580.108730 0.000000 0.000000
**** v1 vsl| 1020 Timestamp c Req: 1684790580.108730 0.000000 0.000000
**** v1 vsl| 1020 VCL_use c vcl4
**** v1 vsl| 1020 ReqStart c 127.0.0.1 54340 a0
**** v1 vsl| 1020 ReqMethod c GET
**** v1 vsl| 1020 ReqURL c /6
**** v1 vsl| 1020 ReqProtocol c HTTP/1.1
**** v1 vsl| 1020 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1020 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1020 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1020 VCL_call c RECV
**** v1 vsl| 1020 VCL_return c hash
**** v1 vsl| 1020 VCL_call c HASH
**** v1 vsl| 1020 VCL_return c lookup
**** v1 vsl| 1020 VCL_call c MISS
**** v1 vsl| 1020 VCL_return c fetch
**** v1 vsl| 1020 Link c bereq 1021 fetch
**** v1 vsl| 1020 Timestamp c Fetch: 1684790580.122743 0.014012 0.014012
**** v1 vsl| 1020 RespProtocol c HTTP/1.1
**** v1 vsl| 1020 RespStatus c 200
**** v1 vsl| 1020 RespReason c OK
**** v1 vsl| 1020 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1020 RespHeader c Content-Length: 0
**** v1 vsl| 1020 RespHeader c X-Varnish: 1020
**** v1 vsl| 1020 RespHeader c Age: 0
**** v1 vsl| 1020 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1020 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1020 VCL_call c DELIVER
**** v1 vsl| 1020 ReqHeader c foo: AAA=
**** v1 vsl| 1020 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "TWFu"
**** v1 vsl| 1020 RespHeader c bad:
**** v1 vsl| 1020 VCL_return c fail
**** v1 vsl| 1020 Timestamp c Process: 1684790580.122785 0.014054 0.000042
**** v1 vsl| 1020 RespProtocol c HTTP/1.1
**** v1 vsl| 1020 RespStatus c 503
**** v1 vsl| 1020 RespReason c VCL failed
**** v1 vsl| 1020 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1020 RespHeader c Server: Varnish
**** v1 vsl| 1020 RespHeader c X-Varnish: 1020
**** v1 vsl| 1020 VCL_call c SYNTH
**** v1 vsl| 1020 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1020 RespHeader c Retry-After: 5
**** v1 vsl| 1020 VCL_return c deliver
**** v1 vsl| 1020 Timestamp c Process: 1684790580.122807 0.014076 0.000022
**** v1 vsl| 1020 RespHeader c Content-Length: 251
**** v1 vsl| 1020 Storage c malloc Transient
**** v1 vsl| 1020 Filters c
**** v1 vsl| 1020 RespHeader c Connection: close
**** v1 vsl| 1020 Timestamp c Resp: 1684790580.122908 0.014178 0.000101
**** v1 vsl| 1020 ReqAcct c 36 0 36 194 251 445
**** v1 vsl| 1020 End c
**** v1 vsl| 1019 SessClose c VCL_FAILURE 0.014
**** v1 vsl| 1019 End c
**** v1 vsl| 1022 Begin c sess 0 HTTP/1
**** v1 vsl| 1022 SessOpen c 127.0.0.1 54342 a0 127.0.0.1 42645 1684790580.132941 24
**** v1 vsl| 1022 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1022 Link c req 1023 rxreq
**** v1 vsl| 1024 Begin b bereq 1023 fetch
**** v1 vsl| 1024 VCL_use b vcl4
**** v1 vsl| 1024 Timestamp b Start: 1684790580.133066 0.000000 0.000000
**** v1 vsl| 1024 BereqMethod b GET
**** v1 vsl| 1024 BereqURL b /7
**** v1 vsl| 1024 BereqProtocol b HTTP/1.1
**** v1 vsl| 1024 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1024 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1024 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1024 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1024 BereqHeader b X-Varnish: 1024
**** v1 vsl| 1024 VCL_call b BACKEND_FETCH
**** v1 vsl| 1024 VCL_return b fetch
**** v1 vsl| 1024 Timestamp b Fetch: 1684790580.133086 0.000019 0.000019
**** v1 vsl| 1024 Timestamp b Connected: 1684790580.133092 0.000025 0.000005
**** v1 vsl| 1024 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1024 Timestamp b Bereq: 1684790580.133153 0.000086 0.000061
**** v1 vsl| 1024 BerespProtocol b HTTP/1.1
**** v1 vsl| 1024 BerespStatus b 200
**** v1 vsl| 1024 BerespReason b OK
**** v1 vsl| 1024 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1024 BerespHeader b Content-Length: 0
**** v1 vsl| 1024 Timestamp b Beresp: 1684790580.135681 0.002615 0.002528
**** v1 vsl| 1024 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1024 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1024 VCL_return b deliver
**** v1 vsl| 1024 Timestamp b Process: 1684790580.135709 0.002642 0.000027
**** v1 vsl| 1024 Filters b
**** v1 vsl| 1024 Storage b malloc s0
**** v1 vsl| 1024 Fetch_Body b 0 none -
**** v1 vsl| 1024 BackendClose b 26 s1 recycle
**** v1 vsl| 1024 Timestamp b BerespBody: 1684790580.146695 0.013628 0.010985
**** v1 vsl| 1024 Length b 0
**** v1 vsl| 1024 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1024 End b
**** v1 vsl| 1023 Begin c req 1022 rxreq
**** v1 vsl| 1023 Timestamp c Start: 1684790580.132985 0.000000 0.000000
**** v1 vsl| 1023 Timestamp c Req: 1684790580.132985 0.000000 0.000000
**** v1 vsl| 1023 VCL_use c vcl4
**** v1 vsl| 1023 ReqStart c 127.0.0.1 54342 a0
**** v1 vsl| 1023 ReqMethod c GET
**** v1 vsl| 1023 ReqURL c /7
**** v1 vsl| 1023 ReqProtocol c HTTP/1.1
**** v1 vsl| 1023 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1023 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1023 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1023 VCL_call c RECV
**** v1 vsl| 1023 VCL_return c hash
**** v1 vsl| 1023 VCL_call c HASH
**** v1 vsl| 1023 VCL_return c lookup
**** v1 vsl| 1023 VCL_call c MISS
**** v1 vsl| 1023 VCL_return c fetch
**** v1 vsl| 1023 Link c bereq 1024 fetch
**** v1 vsl| 1023 Timestamp c Fetch: 1684790580.146755 0.013770 0.013770
**** v1 vsl| 1023 RespProtocol c HTTP/1.1
**** v1 vsl| 1023 RespStatus c 200
**** v1 vsl| 1023 RespReason c OK
**** v1 vsl| 1023 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1023 RespHeader c Content-Length: 0
**** v1 vsl| 1023 RespHeader c X-Varnish: 1023
**** v1 vsl| 1023 RespHeader c Age: 0
**** v1 vsl| 1023 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1023 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1023 VCL_call c DELIVER
**** v1 vsl| 1023 ReqHeader c foo: AAA=
**** v1 vsl| 1023 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "_-_-"
**** v1 vsl| 1023 RespHeader c bad:
**** v1 vsl| 1023 VCL_return c fail
**** v1 vsl| 1023 Timestamp c Process: 1684790580.146798 0.013813 0.000043
**** v1 vsl| 1023 RespProtocol c HTTP/1.1
**** v1 vsl| 1023 RespStatus c 503
**** v1 vsl| 1023 RespReason c VCL failed
**** v1 vsl| 1023 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1023 RespHeader c Server: Varnish
**** v1 vsl| 1023 RespHeader c X-Varnish: 1023
**** v1 vsl| 1023 VCL_call c SYNTH
**** v1 vsl| 1023 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1023 RespHeader c Retry-After: 5
**** v1 vsl| 1023 VCL_return c deliver
**** v1 vsl| 1023 Timestamp c Process: 1684790580.146822 0.013837 0.000023
**** v1 vsl| 1023 RespHeader c Content-Length: 251
**** v1 vsl| 1023 Storage c malloc Transient
**** v1 vsl| 1023 Filters c
**** v1 vsl| 1023 RespHeader c Connection: close
**** v1 vsl| 1023 Timestamp c Resp: 1684790580.146918 0.013933 0.000095
**** v1 vsl| 1023 ReqAcct c 36 0 36 194 251 445
**** v1 vsl| 1023 End c
**** v1 vsl| 1022 SessClose c VCL_FAILURE 0.014
**** v1 vsl| 1022 End c
**** v1 vsl| 1025 Begin c sess 0 HTTP/1
**** v1 vsl| 1025 SessOpen c 127.0.0.1 54344 a0 127.0.0.1 42645 1684790580.159680 25
**** v1 vsl| 1025 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1025 Link c req 1026 rxreq
**** v1 vsl| 1027 Begin b bereq 1026 fetch
**** v1 vsl| 1027 VCL_use b vcl4
**** v1 vsl| 1027 Timestamp b Start: 1684790580.159823 0.000000 0.000000
**** v1 vsl| 1027 BereqMethod b GET
**** v1 vsl| 1027 BereqURL b /8
**** v1 vsl| 1027 BereqProtocol b HTTP/1.1
**** v1 vsl| 1027 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1027 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1027 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1027 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1027 BereqHeader b X-Varnish: 1027
**** v1 vsl| 1027 VCL_call b BACKEND_FETCH
**** v1 vsl| 1027 VCL_return b fetch
**** v1 vsl| 1027 Timestamp b Fetch: 1684790580.159843 0.000019 0.000019
**** v1 vsl| 1027 Timestamp b Connected: 1684790580.159849 0.000025 0.000005
**** v1 vsl| 1027 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1027 Timestamp b Bereq: 1684790580.159922 0.000098 0.000073
**** v1 vsl| 1027 BerespProtocol b HTTP/1.1
**** v1 vsl| 1027 BerespStatus b 200
**** v1 vsl| 1027 BerespReason b OK
**** v1 vsl| 1027 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1027 BerespHeader b Content-Length: 0
**** v1 vsl| 1027 Timestamp b Beresp: 1684790580.161700 0.001876 0.001778
**** v1 vsl| 1027 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1027 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1027 VCL_return b deliver
**** v1 vsl| 1027 Timestamp b Process: 1684790580.161726 0.001902 0.000025
**** v1 vsl| 1027 Filters b
**** v1 vsl| 1027 Storage b malloc s0
**** v1 vsl| 1027 Fetch_Body b 0 none -
**** v1 vsl| 1027 BackendClose b 26 s1 recycle
**** v1 vsl| 1027 Timestamp b BerespBody: 1684790580.173719 0.013895 0.011992
**** v1 vsl| 1027 Length b 0
**** v1 vsl| 1027 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1027 End b
**** dT 9.428
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1026\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1026
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** dT 9.429
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1026
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.435
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54348 to 127.0.0.1:42645
** c1 === txreq -url /9
**** c1 txreq|GET /9 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.441
**** s1 rxhdr|GET /9 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1030\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 133
**** s1 http[ 0] |GET
**** s1 http[ 1] |/9
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1030
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.461
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1029\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1029
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1029
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.465
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
**** dT 9.466
*** c1 connected fd 17 from 127.0.0.1 54350 to 127.0.0.1:42645
** c1 === txreq -url /10
**** c1 txreq|GET /10 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.468
**** s1 rxhdr|GET /10 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1033\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 134
**** s1 http[ 0] |GET
**** s1 http[ 1] |/10
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1033
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
** s1 === rxreq
**** dT 9.487
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1032\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1032
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1032
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
**** dT 9.493
** c1 Started on 127.0.0.1:42645 (1 iterations)
*** c1 Connect to 127.0.0.1:42645
*** c1 connected fd 17 from 127.0.0.1 54352 to 127.0.0.1:42645
** c1 === txreq -url /11
**** c1 txreq|GET /11 HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 9.498
**** s1 rxhdr|GET /11 HTTP/1.1\r
**** s1 rxhdr|Host: 127.0.0.1\r
**** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** s1 rxhdr|Accept-Encoding: gzip\r
**** s1 rxhdr|X-Varnish: 1036\r
**** s1 rxhdr|\r
**** s1 rxhdrlen = 134
**** s1 http[ 0] |GET
**** s1 http[ 1] |/11
**** s1 http[ 2] |HTTP/1.1
**** s1 http[ 3] |Host: 127.0.0.1
**** s1 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 http[ 5] |Via: 1.1 v1 (Varnish/trunk)
**** s1 http[ 6] |Accept-Encoding: gzip
**** s1 http[ 7] |X-Varnish: 1036
**** s1 bodylen = 0
** s1 === txresp
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** s1 txresp|Content-Length: 0\r
**** s1 txresp|\r
*** s1 shutting fd 16
** s1 Ending
**** dT 9.512
**** c1 rxhdr|HTTP/1.1 503 VCL failed\r
**** c1 rxhdr|Date: Mon, 22 May 2023 21:23:00 GMT\r
**** c1 rxhdr|Server: Varnish\r
**** c1 rxhdr|X-Varnish: 1035\r
**** c1 rxhdr|Content-Type: text/html; charset=utf-8\r
**** c1 rxhdr|Retry-After: 5\r
**** c1 rxhdr|Content-Length: 251\r
**** c1 rxhdr|Connection: close\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 194
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |503
**** c1 http[ 2] |VCL failed
**** c1 http[ 3] |Date: Mon, 22 May 2023 21:23:00 GMT
**** c1 http[ 4] |Server: Varnish
**** c1 http[ 5] |X-Varnish: 1035
**** c1 http[ 6] |Content-Type: text/html; charset=utf-8
**** c1 http[ 7] |Retry-After: 5
**** c1 http[ 8] |Content-Length: 251
**** c1 http[ 9] |Connection: close
**** c1 c-l|
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| 503 VCL failed
**** c1 c-l|
**** c1 c-l|
**** c1 c-l| Error 503 VCL failed
**** c1 c-l| VCL failed
**** c1 c-l| Guru Meditation:
**** c1 c-l| XID: 1035
**** c1 c-l|
**** c1 c-l| Varnish cache server
**** c1 c-l|
**** c1 c-l|
**** c1 bodylen = 251
** c1 === expect resp.status == 503
**** c1 EXPECT resp.status (503) == "503" match
** c1 === expect resp.reason == "VCL failed"
**** c1 EXPECT resp.reason (VCL failed) == "VCL failed" match
** c1 === expect resp.http.bad ==
**** c1 EXPECT resp.http.bad () == "" match
*** c1 closing fd 17
** c1 Ending
**** dT 9.513
** top === logexpect l1 -v v1 -d 1 -g vxid -q "VCL_Error" {
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 === expect * * VCL_Error {^vmod blob error: cannot decode, illeg...
** l1 Waiting for logexp
**** dT 9.519
**** l1 begin|
**** l1 qry | VCL_Error
*** l1 test | expect * * VCL_Error ^vmod blob error: cannot decode, illegal encoding beginning with \"0x123456\"$
**** l1 match| 1011 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "0x123456"
*** l1 test | expect * * VCL_Error ^vmod blob error: cannot decode, illegal encoding beginning with \"-_-_\"$
**** dT 9.520
**** l1 match| 1014 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "-_-_"
*** l1 test | expect * * VCL_Error ^vmod blob error: cannot decode, illegal encoding beginning with \"\\+/\\+/\"$
**** l1 match| 1017 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "+/+/"
*** l1 test | expect * * VCL_Error ^vmod blob error: cannot decode, illegal encoding beginning with \"TWFu\"$
**** l1 match| 1020 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "TWFu"
*** l1 test | expect * * VCL_Error ^vmod blob error: cannot decode, illegal encoding beginning with \"_-_-\"$
**** l1 match| 1023 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "_-_-"
*** l1 test | expect * * VCL_Error ^vmod blob error: cannot decode, illegal encoding beginning with \"/\\+/\\+\"$
**** l1 match| 1026 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "/+/+"
*** l1 test | expect * * VCL_Error ^vmod blob error: cannot decode, illegal encoding beginning with \"Zm9v\"$
**** dT 9.532
**** v1 vsl| 1028 Begin c sess 0 HTTP/1
**** v1 vsl| 1028 SessOpen c 127.0.0.1 54348 a0 127.0.0.1 42645 1684790580.207607 23
**** v1 vsl| 1028 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1028 Link c req 1029 rxreq
**** v1 vsl| 1030 Begin b bereq 1029 fetch
**** v1 vsl| 1030 VCL_use b vcl4
**** v1 vsl| 1030 Timestamp b Start: 1684790580.207750 0.000000 0.000000
**** v1 vsl| 1030 BereqMethod b GET
**** v1 vsl| 1030 BereqURL b /9
**** v1 vsl| 1030 BereqProtocol b HTTP/1.1
**** v1 vsl| 1030 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1030 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1030 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1030 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1030 BereqHeader b X-Varnish: 1030
**** v1 vsl| 1030 VCL_call b BACKEND_FETCH
**** v1 vsl| 1030 VCL_return b fetch
**** v1 vsl| 1030 Timestamp b Fetch: 1684790580.207769 0.000018 0.000018
**** v1 vsl| 1030 Timestamp b Connected: 1684790580.207775 0.000024 0.000005
**** v1 vsl| 1030 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1030 Timestamp b Bereq: 1684790580.207829 0.000078 0.000054
**** v1 vsl| 1030 BerespProtocol b HTTP/1.1
**** v1 vsl| 1030 BerespStatus b 200
**** v1 vsl| 1030 BerespReason b OK
**** v1 vsl| 1030 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1030 BerespHeader b Content-Length: 0
**** v1 vsl| 1030 Timestamp b Beresp: 1684790580.214020 0.006270 0.006191
**** v1 vsl| 1030 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1030 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1030 VCL_return b deliver
**** v1 vsl| 1030 Timestamp b Process: 1684790580.214047 0.006296 0.000026
**** v1 vsl| 1030 Filters b
**** v1 vsl| 1030 Storage b malloc s0
**** v1 vsl| 1030 Fetch_Body b 0 none -
**** v1 vsl| 1030 BackendClose b 26 s1 recycle
**** v1 vsl| 1030 Timestamp b BerespBody: 1684790580.229313 0.021563 0.015266
**** v1 vsl| 1030 Length b 0
**** v1 vsl| 1030 BereqAcct b 133 0 133 75 0 75
**** v1 vsl| 1030 End b
**** v1 vsl| 1029 Begin c req 1028 rxreq
**** v1 vsl| 1029 Timestamp c Start: 1684790580.207667 0.000000 0.000000
**** v1 vsl| 1029 Timestamp c Req: 1684790580.207667 0.000000 0.000000
**** v1 vsl| 1029 VCL_use c vcl4
**** v1 vsl| 1029 ReqStart c 127.0.0.1 54348 a0
**** v1 vsl| 1029 ReqMethod c GET
**** v1 vsl| 1029 ReqURL c /9
**** v1 vsl| 1029 ReqProtocol c HTTP/1.1
**** v1 vsl| 1029 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1029 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1029 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1029 VCL_call c RECV
**** v1 vsl| 1029 VCL_return c hash
**** v1 vsl| 1029 VCL_call c HASH
**** v1 vsl| 1029 VCL_return c lookup
**** v1 vsl| 1029 VCL_call c MISS
**** v1 vsl| 1029 VCL_return c fetch
**** v1 vsl| 1029 Link c bereq 1030 fetch
**** v1 vsl| 1029 Timestamp c Fetch: 1684790580.229375 0.021708 0.021708
**** v1 vsl| 1029 RespProtocol c HTTP/1.1
**** v1 vsl| 1029 RespStatus c 200
**** v1 vsl| 1029 RespReason c OK
**** v1 vsl| 1029 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1029 RespHeader c Content-Length: 0
**** v1 vsl| 1029 RespHeader c X-Varnish: 1029
**** v1 vsl| 1029 RespHeader c Age: 0
**** v1 vsl| 1029 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1029 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1029 VCL_call c DELIVER
**** v1 vsl| 1029 ReqHeader c foo: AAA=
**** v1 vsl| 1029 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "Zm9v"
**** v1 vsl| 1029 RespHeader c bad:
**** v1 vsl| 1029 VCL_return c fail
**** v1 vsl| 1029 Timestamp c Process: 1684790580.229413 0.021746 0.000037
**** v1 vsl| 1029 RespProtocol c HTTP/1.1
**** v1 vsl| 1029 RespStatus c 503
**** v1 vsl| 1029 RespReason c VCL failed
**** v1 vsl| 1029 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1029 RespHeader c Server: Varnish
**** v1 vsl| 1029 RespHeader c X-Varnish: 1029
**** v1 vsl| 1029 VCL_call c SYNTH
**** v1 vsl| 1029 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1029 RespHeader c Retry-After: 5
**** v1 vsl| 1029 VCL_return c deliver
**** v1 vsl| 1029 Timestamp c Process: 1684790580.229434 0.021766 0.000020
**** v1 vsl| 1029 RespHeader c Content-Length: 251
**** v1 vsl| 1029 Storage c malloc Transient
**** v1 vsl| 1029 Filters c
**** v1 vsl| 1029 RespHeader c Connection: close
**** v1 vsl| 1029 Timestamp c Resp: 1684790580.229564 0.021897 0.000130
**** v1 vsl| 1029 ReqAcct c 36 0 36 194 251 445
**** v1 vsl| 1029 End c
**** v1 vsl| 1028 SessClose c VCL_FAILURE 0.022
**** v1 vsl| 1028 End c
**** v1 vsl| 1031 Begin c sess 0 HTTP/1
**** v1 vsl| 1031 SessOpen c 127.0.0.1 54350 a0 127.0.0.1 42645 1684790580.239223 24
**** v1 vsl| 1031 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1031 Link c req 1032 rxreq
**** v1 vsl| 1033 Begin b bereq 1032 fetch
**** v1 vsl| 1033 VCL_use b vcl4
**** v1 vsl| 1033 Timestamp b Start: 1684790580.239388 0.000000 0.000000
**** v1 vsl| 1033 BereqMethod b GET
**** v1 vsl| 1033 BereqURL b /10
**** v1 vsl| 1033 BereqProtocol b HTTP/1.1
**** v1 vsl| 1033 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1033 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1033 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1033 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1033 BereqHeader b X-Varnish: 1033
**** v1 vsl| 1033 VCL_call b BACKEND_FETCH
**** v1 vsl| 1033 VCL_return b fetch
**** v1 vsl| 1033 Timestamp b Fetch: 1684790580.239407 0.000018 0.000018
**** v1 vsl| 1033 Timestamp b Connected: 1684790580.239416 0.000028 0.000009
**** v1 vsl| 1033 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1033 Timestamp b Bereq: 1684790580.239541 0.000153 0.000124
**** v1 vsl| 1033 BerespProtocol b HTTP/1.1
**** v1 vsl| 1033 BerespStatus b 200
**** v1 vsl| 1033 BerespReason b OK
**** v1 vsl| 1033 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1033 BerespHeader b Content-Length: 0
**** v1 vsl| 1033 Timestamp b Beresp: 1684790580.244023 0.004635 0.004482
**** v1 vsl| 1033 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1033 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1033 VCL_return b deliver
**** v1 vsl| 1033 Timestamp b Process: 1684790580.244104 0.004715 0.000080
**** v1 vsl| 1033 Filters b
**** v1 vsl| 1033 Storage b malloc s0
**** v1 vsl| 1033 Fetch_Body b 0 none -
**** v1 vsl| 1033 BackendClose b 26 s1 recycle
**** v1 vsl| 1033 Timestamp b BerespBody: 1684790580.257551 0.018163 0.013447
**** v1 vsl| 1033 Length b 0
**** v1 vsl| 1033 BereqAcct b 134 0 134 75 0 75
**** v1 vsl| 1033 End b
**** v1 vsl| 1032 Begin c req 1031 rxreq
**** v1 vsl| 1032 Timestamp c Start: 1684790580.239280 0.000000 0.000000
**** v1 vsl| 1032 Timestamp c Req: 1684790580.239280 0.000000 0.000000
**** v1 vsl| 1032 VCL_use c vcl4
**** v1 vsl| 1032 ReqStart c 127.0.0.1 54350 a0
**** v1 vsl| 1032 ReqMethod c GET
**** v1 vsl| 1032 ReqURL c /10
**** v1 vsl| 1032 ReqProtocol c HTTP/1.1
**** v1 vsl| 1032 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1032 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1032 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1032 VCL_call c RECV
**** v1 vsl| 1032 VCL_return c hash
**** v1 vsl| 1032 VCL_call c HASH
**** v1 vsl| 1032 VCL_return c lookup
**** v1 vsl| 1032 VCL_call c MISS
**** v1 vsl| 1032 VCL_return c fetch
**** v1 vsl| 1032 Link c bereq 1033 fetch
**** v1 vsl| 1032 Timestamp c Fetch: 1684790580.257602 0.018322 0.018322
**** v1 vsl| 1032 RespProtocol c HTTP/1.1
**** v1 vsl| 1032 RespStatus c 200
**** v1 vsl| 1032 RespReason c OK
**** v1 vsl| 1032 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1032 RespHeader c Content-Length: 0
**** v1 vsl| 1032 RespHeader c X-Varnish: 1032
**** v1 vsl| 1032 RespHeader c Age: 0
**** v1 vsl| 1032 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1032 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1032 VCL_call c DELIVER
**** v1 vsl| 1032 ReqHeader c foo: AAA=
**** v1 vsl| 1032 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "%20"
**** v1 vsl| 1032 RespHeader c bad:
**** v1 vsl| 1032 VCL_return c fail
**** v1 vsl| 1032 Timestamp c Process: 1684790580.257652 0.018372 0.000049
**** v1 vsl| 1032 RespProtocol c HTTP/1.1
**** v1 vsl| 1032 RespStatus c 503
**** v1 vsl| 1032 RespReason c VCL failed
**** v1 vsl| 1032 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1032 RespHeader c Server: Varnish
**** v1 vsl| 1032 RespHeader c X-Varnish: 1032
**** v1 vsl| 1032 VCL_call c SYNTH
**** v1 vsl| 1032 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1032 RespHeader c Retry-After: 5
**** v1 vsl| 1032 VCL_return c deliver
**** v1 vsl| 1032 Timestamp c Process: 1684790580.257711 0.018431 0.000059
**** v1 vsl| 1032 RespHeader c Content-Length: 251
**** v1 vsl| 1032 Storage c malloc Transient
**** v1 vsl| 1032 Filters c
**** v1 vsl| 1032 RespHeader c Connection: close
**** v1 vsl| 1032 Timestamp c Resp: 1684790580.257813 0.018533 0.000101
**** v1 vsl| 1032 ReqAcct c 37 0 37 194 251 445
**** v1 vsl| 1032 End c
**** v1 vsl| 1031 SessClose c VCL_FAILURE 0.019
**** v1 vsl| 1031 End c
**** v1 vsl| 1034 Begin c sess 0 HTTP/1
**** v1 vsl| 1034 SessOpen c 127.0.0.1 54352 a0 127.0.0.1 42645 1684790580.265993 27
**** v1 vsl| 1034 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Debug c sockopt: SO_KEEPALIVE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:42645
**** v1 vsl| 1034 Link c req 1035 rxreq
**** v1 vsl| 1026 Begin c req 1025 rxreq
**** v1 vsl| 1026 Timestamp c Start: 1684790580.159736 0.000000 0.000000
**** v1 vsl| 1026 Timestamp c Req: 1684790580.159736 0.000000 0.000000
**** v1 vsl| 1026 VCL_use c vcl4
**** v1 vsl| 1026 ReqStart c 127.0.0.1 54344 a0
**** v1 vsl| 1026 ReqMethod c GET
**** v1 vsl| 1026 ReqURL c /8
**** v1 vsl| 1026 ReqProtocol c HTTP/1.1
**** v1 vsl| 1026 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1026 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1026 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1026 VCL_call c RECV
**** v1 vsl| 1026 VCL_return c hash
**** v1 vsl| 1026 VCL_call c HASH
**** v1 vsl| 1026 VCL_return c lookup
**** v1 vsl| 1026 VCL_call c MISS
**** v1 vsl| 1026 VCL_return c fetch
**** v1 vsl| 1026 Link c bereq 1027 fetch
**** v1 vsl| 1026 Timestamp c Fetch: 1684790580.173802 0.014065 0.014065
**** v1 vsl| 1026 RespProtocol c HTTP/1.1
**** v1 vsl| 1026 RespStatus c 200
**** v1 vsl| 1026 RespReason c OK
**** v1 vsl| 1026 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1026 RespHeader c Content-Length: 0
**** v1 vsl| 1026 RespHeader c X-Varnish: 1026
**** v1 vsl| 1026 RespHeader c Age: 0
**** v1 vsl| 1026 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1026 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1026 VCL_call c DELIVER
**** v1 vsl| 1026 ReqHeader c foo: AAA=
**** v1 vsl| 1026 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "/+/+"
**** v1 vsl| 1026 RespHeader c bad:
**** v1 vsl| 1026 VCL_return c fail
**** v1 vsl| 1026 Timestamp c Process: 1684790580.173845 0.014109 0.000043
**** v1 vsl| 1026 RespProtocol c HTTP/1.1
**** v1 vsl| 1026 RespStatus c 503
**** v1 vsl| 1026 RespReason c VCL failed
**** v1 vsl| 1026 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1026 RespHeader c Server: Varnish
**** v1 vsl| 1026 RespHeader c X-Varnish: 1026
**** dT 9.533
**** v1 vsl| 1026 VCL_call c SYNTH
**** v1 vsl| 1026 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1026 RespHeader c Retry-After: 5
**** v1 vsl| 1026 VCL_return c deliver
**** v1 vsl| 1026 Timestamp c Process: 1684790580.173869 0.014132 0.000023
**** v1 vsl| 1026 RespHeader c Content-Length: 251
**** v1 vsl| 1026 Storage c malloc Transient
**** v1 vsl| 1026 Filters c
**** v1 vsl| 1026 RespHeader c Connection: close
**** v1 vsl| 1026 Timestamp c Resp: 1684790580.271666 0.111930 0.097797
**** v1 vsl| 1026 ReqAcct c 36 0 36 194 251 445
**** v1 vsl| 1026 End c
**** v1 vsl| 1025 SessClose c VCL_FAILURE 0.112
**** v1 vsl| 1025 End c
**** v1 vsl| 1036 Begin b bereq 1035 fetch
**** v1 vsl| 1036 VCL_use b vcl4
**** v1 vsl| 1036 Timestamp b Start: 1684790580.266102 0.000000 0.000000
**** v1 vsl| 1036 BereqMethod b GET
**** v1 vsl| 1036 BereqURL b /11
**** v1 vsl| 1036 BereqProtocol b HTTP/1.1
**** v1 vsl| 1036 BereqHeader b Host: 127.0.0.1
**** v1 vsl| 1036 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1036 BereqHeader b Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1036 BereqHeader b Accept-Encoding: gzip
**** v1 vsl| 1036 BereqHeader b X-Varnish: 1036
**** v1 vsl| 1036 VCL_call b BACKEND_FETCH
**** v1 vsl| 1036 VCL_return b fetch
**** v1 vsl| 1036 Timestamp b Fetch: 1684790580.266119 0.000016 0.000016
**** v1 vsl| 1036 Timestamp b Connected: 1684790580.266124 0.000021 0.000005
**** v1 vsl| 1036 BackendOpen b 26 s1 127.0.0.1 36349 127.0.0.1 51016 reuse
**** v1 vsl| 1036 Timestamp b Bereq: 1684790580.266204 0.000102 0.000080
**** v1 vsl| 1036 BerespProtocol b HTTP/1.1
**** v1 vsl| 1036 BerespStatus b 200
**** v1 vsl| 1036 BerespReason b OK
**** v1 vsl| 1036 BerespHeader b Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1036 BerespHeader b Content-Length: 0
**** v1 vsl| 1036 Timestamp b Beresp: 1684790580.270789 0.004686 0.004584
**** v1 vsl| 1036 TTL b RFC 120 10 0 1684790580 1684790580 1684790580 0 0 cacheable
**** v1 vsl| 1036 VCL_call b BACKEND_RESPONSE
**** v1 vsl| 1036 VCL_return b deliver
**** v1 vsl| 1036 Timestamp b Process: 1684790580.270814 0.004711 0.000025
**** v1 vsl| 1036 Filters b
**** v1 vsl| 1036 Storage b malloc s0
**** v1 vsl| 1036 Fetch_Body b 0 none -
**** v1 vsl| 1036 BackendClose b 26 s1 recycle
**** v1 vsl| 1036 Timestamp b BerespBody: 1684790580.283264 0.017161 0.012450
**** v1 vsl| 1036 Length b 0
**** v1 vsl| 1036 BereqAcct b 134 0 134 75 0 75
**** v1 vsl| 1036 End b
**** v1 vsl| 1035 Begin c req 1034 rxreq
**** v1 vsl| 1035 Timestamp c Start: 1684790580.266032 0.000000 0.000000
**** v1 vsl| 1035 Timestamp c Req: 1684790580.266032 0.000000 0.000000
**** v1 vsl| 1035 VCL_use c vcl4
**** v1 vsl| 1035 ReqStart c 127.0.0.1 54352 a0
**** v1 vsl| 1035 ReqMethod c GET
**** v1 vsl| 1035 ReqURL c /11
**** v1 vsl| 1035 ReqProtocol c HTTP/1.1
**** v1 vsl| 1035 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1035 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1035 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1035 VCL_call c RECV
**** v1 vsl| 1035 VCL_return c hash
**** v1 vsl| 1035 VCL_call c HASH
**** v1 vsl| 1035 VCL_return c lookup
**** v1 vsl| 1035 VCL_call c MISS
**** v1 vsl| 1035 VCL_return c fetch
**** v1 vsl| 1035 Link c bereq 1036 fetch
**** v1 vsl| 1035 Timestamp c Fetch: 1684790580.283310 0.017277 0.017277
**** v1 vsl| 1035 RespProtocol c HTTP/1.1
**** v1 vsl| 1035 RespStatus c 200
**** v1 vsl| 1035 RespReason c OK
**** v1 vsl| 1035 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1035 RespHeader c Content-Length: 0
**** v1 vsl| 1035 RespHeader c X-Varnish: 1035
**** v1 vsl| 1035 RespHeader c Age: 0
**** v1 vsl| 1035 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1035 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1035 VCL_call c DELIVER
**** v1 vsl| 1035 ReqHeader c foo: AAA=
**** v1 vsl| 1035 VCL_Error c vmod blob error: cannot decode, illegal encoding beginning with "%20"
**** v1 vsl| 1035 RespHeader c bad:
**** v1 vsl| 1035 VCL_return c fail
**** v1 vsl| 1035 Timestamp c Process: 1684790580.283341 0.017308 0.000030
**** v1 vsl| 1035 RespProtocol c HTTP/1.1
**** v1 vsl| 1035 RespStatus c 503
**** v1 vsl| 1035 RespReason c VCL failed
**** v1 vsl| 1035 RespHeader c Date: Mon, 22 May 2023 21:23:00 GMT
**** v1 vsl| 1035 RespHeader c Server: Varnish
**** v1 vsl| 1035 RespHeader c X-Varnish: 1035
**** v1 vsl| 1035 VCL_call c SYNTH
**** v1 vsl| 1035 RespHeader c Content-Type: text/html; charset=utf-8
**** v1 vsl| 1035 RespHeader c Retry-After: 5
**** v1 vsl| 1035 VCL_return c deliver
**** v1 vsl| 1035 Timestamp c Process: 1684790580.283360 0.017327 0.000019
**** v1 vsl| 1035 RespHeader c Content-Length: 251
**** v1 vsl| 1035 Storage c malloc Transient
**** v1 vsl| 1035 Filters c
**** v1 vsl| 1035 RespHeader c Connection: close
**** v1 vsl| 1035 Timestamp c Resp: 1684790580.283482 0.017449 0.000121
**** v1 vsl| 1035 ReqAcct c 37 0 37 194 251 445
**** v1 vsl| 1035 End c
**** v1 vsl| 1034 SessClose c VCL_FAILURE 0.018
**** v1 vsl| 1034 End c
**** dT 10.156
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790580 1.0
**** dT 13.126
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790583 1.0
**** dT 16.171
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790586 1.0
**** dT 19.103
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790589 1.0
**** dT 22.169
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790592 1.0
**** dT 25.102
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790595 1.0
**** dT 28.179
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790598 1.0
**** dT 31.141
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790601 1.0
**** dT 34.196
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790604 1.0
**** dT 37.122
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790607 1.0
**** dT 40.179
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790610 1.0
**** dT 43.170
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790613 1.0
**** dT 46.231
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790616 1.0
**** dT 49.220
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790619 1.0
**** dT 52.160
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790622 1.0
**** dT 55.199
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790625 1.0
**** dT 58.182
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1684790628 1.0
# top TEST ../../../vmod/tests/blob_b00013.vtc TIMED OUT (kill -9)
# top TEST ../../../vmod/tests/blob_b00013.vtc FAILED (60.106) signal=9
FAIL tests/blob_b00013.vtc (exit status: 2)