**** dT    0.005
*    top   TEST ../../../../bin/varnishtest/tests/e00019.vtc starting
**** top   extmacro def pkg_version=trunk
**** top   extmacro def pkg_branch=trunk
**** top   extmacro def pwd=/root/VT/varnish-cache/varnish-trunk/_build/sub/bin/varnishtest
**** 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:21154
**** top   extmacro def listen_addr=127.0.0.1:0
**** top   extmacro def bad_ip=192.0.2.255
**** top   extmacro def topbuild=/root/VT/varnish-cache/varnish-trunk/_build/sub
**** top   extmacro def topsrc=/root/VT/varnish-cache/varnish-trunk/_build/sub/../..
**** dT    0.006
**** top   macro def testdir=/root/VT/varnish-cache/varnish-trunk/_build/sub/bin/varnishtest/../../../../bin/varnishtest/tests
**** top   macro def tmpdir=/root/VT/_vtest_tmp/vtc.34473.05492b37
**** dT    0.013
**** top   macro def vtcid=vtc.34473.05492b37
**** dT    0.016
**   top   === varnishtest "Push corners in new ESI parser"
*    top   VTEST Push corners in new ESI parser
**** dT    0.017
**   top   === server s1 {
**   s1    Starting server
**** s1    macro def s1_addr=127.0.0.1
**** s1    macro def s1_port=55316
**** s1    macro def s1_sock=127.0.0.1:55316
*    s1    Listen on 127.0.0.1:55316
**** dT    0.018
**   top   === server s2 {
**   s2    Starting server
**** s2    macro def s2_addr=127.0.0.1
**** s2    macro def s2_port=13189
**** s2    macro def s2_sock=127.0.0.1:13189
*    s2    Listen on 127.0.0.1:13189
**   top   === varnish v1 -vcl+backend {
**** dT    0.023
**   s1    Started on 127.0.0.1:55316 (1 iterations)
**** dT    0.026
**   s2    Started on 127.0.0.1:13189 (1 iterations)
**** dT    0.076
**   v1    Launch
**** dT    0.077
***  v1    CMD: cd ${pwd} && exec varnishd  -d -n /root/VT/_vtest_tmp/vtc.34473.05492b37/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,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 27343' -P /root/VT/_vtest_tmp/vtc.34473.05492b37/v1/varnishd.pid -p vmod_path=/root/VT/varnish-cache/varnish-trunk/_build/sub/vmod/.libs 
***  v1    CMD: cd /root/VT/varnish-cache/varnish-trunk/_build/sub/bin/varnishtest && exec varnishd  -d -n /root/VT/_vtest_tmp/vtc.34473.05492b37/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,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 27343' -P /root/VT/_vtest_tmp/vtc.34473.05492b37/v1/varnishd.pid -p vmod_path=/root/VT/varnish-cache/varnish-trunk/_build/sub/vmod/.libs 
**** dT    0.080
***  v1    PID: 34489
**** dT    0.081
**** v1    macro def v1_pid=34489
**** v1    macro def v1_name=/root/VT/_vtest_tmp/vtc.34473.05492b37/v1
**** dT    0.273
***  v1    debug|Debug: Version: varnish-trunk revision 67bc0aee4b0531350217e438886b8730c6805c16
**** dT    0.276
***  v1    debug|Debug: Platform: FreeBSD,13.5-RELEASE,arm,-jnone,-sdefault,-sdefault,-hcritbit
**** dT    0.280
***  v1    debug|200 312     
***  v1    debug|-----------------------------
***  v1    debug|Varnish Cache CLI 1.0
***  v1    debug|-----------------------------
***  v1    debug|FreeBSD,13.5-RELEASE,arm,-jnone,-sdefault,-sdefault,-hcritbit
***  v1    debug|varnish-trunk revision 67bc0aee4b0531350217e438886b8730c6805c16
***  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.351
**** v1    CLIPOLL 1 0x1 0x0 0x0
***  v1    CLI connection fd = 8
**** dT    0.353
***  v1    CLI RX  107
**** v1    CLI RX|pkhhgptzxhebryrhgqcsjggsstfnbuds
**** v1    CLI RX|
**** v1    CLI RX|Authentication required.
**** dT    0.356
**** v1    CLI TX|auth b3f5f5e6cb54f2238134d6bbbec9c2b6151779265b6ffc83caf82e216aad5e37
**** dT    0.359
***  v1    CLI RX  200
**** dT    0.360
**** v1    CLI RX|-----------------------------
**** v1    CLI RX|Varnish Cache CLI 1.0
**** v1    CLI RX|-----------------------------
**** v1    CLI RX|FreeBSD,13.5-RELEASE,arm,-jnone,-sdefault,-sdefault,-hcritbit
**** v1    CLI RX|varnish-trunk revision 67bc0aee4b0531350217e438886b8730c6805c16
**** 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.
**** dT    0.361
**** v1    CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P
**** v1    CLI TX|vcl 4.1;
**** v1    CLI TX|backend s1 { .host = "127.0.0.1"; .port = "55316"; }
**** v1    CLI TX|backend s2 { .host = "127.0.0.1"; .port = "13189"; }
**** v1    CLI TX|
**** v1    CLI TX|
**** v1    CLI TX|\tsub vcl_backend_fetch {
**** v1    CLI TX|\t\tif (bereq.url != "bar") {
**** v1    CLI TX|\t\t\tset bereq.backend = s2;
**** v1    CLI TX|\t\t}
**** v1    CLI TX|\t}
**** v1    CLI TX|
**** v1    CLI TX|\tsub vcl_backend_response {
**** v1    CLI TX|\t\tif (bereq.url == "bar") {
**** v1    CLI TX|\t\t\tset beresp.do_esi = true;
**** v1    CLI TX|\t\t}
**** v1    CLI TX|\t}
**** v1    CLI TX|
**** v1    CLI TX|%XJEIFLH|)Xspa8P
**** dT    0.468
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    0.571
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    0.673
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    0.775
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    0.878
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    0.981
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.084
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.186
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.289
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.392
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.495
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.605
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.708
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.810
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    1.912
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.015
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.117
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.219
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.322
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.425
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.527
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.630
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.732
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.835
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    2.937
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.039
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.141
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.244
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.346
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.449
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.554
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.688
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.790
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.892
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    3.994
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.095
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.227
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.328
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.430
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.532
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.633
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.735
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.839
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    4.940
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.041
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.143
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.245
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.347
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.449
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.551
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.652
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.754
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.856
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    5.958
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.060
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.162
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.264
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.378
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.479
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.583
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.684
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.698
***  v1    CLI RX  200
**** v1    CLI RX|VCL compiled.
**** v1    CLI TX|vcl.use vcl1
**** dT    6.739
***  v1    CLI RX  200
**** v1    CLI RX|VCL 'vcl1' now active
**   v1    Start
**** v1    CLI TX|start
**** dT    6.787
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.861
***  v1    debug|Debug: Child (34498) Started
**** dT    6.888
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    6.991
***  v1    vsl|No VSL chunk found (child not started ?)
**** dT    7.820
***  v1    debug|Child launched OK
**** dT    7.860
***  v1    CLI RX  200
***  v1    wait-running
**** v1    CLI TX|status
**** dT    7.867
***  v1    debug|Info: Child (34498) said Child starts
**** dT    7.900
***  v1    CLI RX  200
**** v1    CLI RX|Child in state running
**** v1    CLI TX|debug.listen_address
**** dT    7.917
**** v1    vsl|          0 CLI             - Rd vcl.load "vcl1" vcl_vcl1.1750476229.032166/vgc.so 1auto
**** v1    vsl|          0 CLI             - Wr 200 52 Loaded "vcl_vcl1.1750476229.032166/vgc.so" as "vcl1"
**** v1    vsl|          0 CLI             - Rd vcl.use "vcl1"
**** dT    7.918
**** 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:30624
**** v1    vsl|          0 Debug           - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:30624
**** dT    7.919
**** v1    vsl|          0 Debug           - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:30624
**** dT    7.920
**** v1    vsl|          0 Debug           - sockopt: Setting TCP_KEEPIDLE for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Setting TCP_KEEPCNT for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Setting TCP_KEEPINTVL for a0=127.0.0.1:30624
**** dT    7.921
**** v1    vsl|          0 Error           - Kernel filtering: sock=3, errno=2 No such file or directory
**** v1    vsl|          0 CLI             - Wr 200 0 
**** dT    7.944
***  v1    CLI RX  200
**** v1    CLI RX|a0 127.0.0.1 30624
**** v1    CLI TX|debug.xid 1000
**** dT    8.006
***  v1    CLI RX  200
**** v1    CLI RX|XID is 1000 chunk 1
**** v1    CLI TX|debug.listen_address
**** dT    8.024
**** v1    vsl|          0 CLI             - Rd debug.listen_address 
**** dT    8.025
**** v1    vsl|          0 CLI             - Wr 200 19 a0 127.0.0.1 30624

**** v1    vsl|          0 CLI             - Rd debug.xid 1000 
**** dT    8.026
**** v1    vsl|          0 CLI             - Wr 200 19 XID is 1000 chunk 1
**** dT    8.048
***  v1    CLI RX  200
**** v1    CLI RX|a0 127.0.0.1 30624
**   v1    Listen on 127.0.0.1 30624
**** v1    macro def v1_addr=127.0.0.1
**** v1    macro def v1_port=30624
**** v1    macro def v1_sock=127.0.0.1:30624
**** v1    macro def v1_a0_addr=127.0.0.1
**** v1    macro def v1_a0_port=30624
**** v1    macro def v1_a0_sock=127.0.0.1:30624
**   top   === varnish v1 -cliok "param.set debug +esi_chop"
**** v1    CLI TX|param.set debug +esi_chop
**** dT    8.092
***  v1    CLI RX  200
**   v1    CLI 200 <param.set debug +esi_chop>
**   top   === varnish v1 -cliok "param.set debug +syncvsl"
**** v1    CLI TX|param.set debug +syncvsl
**** dT    8.131
**** v1    vsl|          0 CLI             - Rd debug.listen_address 
**** v1    vsl|          0 CLI             - Wr 200 19 a0 127.0.0.1 30624

**** dT    8.135
***  v1    CLI RX  200
**   v1    CLI 200 <param.set debug +syncvsl>
**   top   === logexpect l1 -v v1 -g vxid -q "vxid == 1002" {
**** dT    8.138
**   l1    === expect * * Fetch_Body
**   l1    === expect 0 = ESI_xmlerror {^ERR after 3 ESI 1.0 </esi:comment>...
**** dT    8.139
**   l1    === expect 0 = ESI_xmlerror {^ERR after 27 XML 1.0 '>' does not ...
**   l1    === expect 0 = ESI_xmlerror {^ERR after 43 ESI 1.0 <esi:comment>...
**   l1    === expect 0 = ESI_xmlerror {^WARN after 107 ESI 1.0 <esi:includ...
**** dT    8.140
**   l1    === expect 0 = ESI_xmlerror {^ERR after 130 ESI 1.0 <esi:bogus> ...
**   l1    === expect 0 = ESI_xmlerror {^ERR after 131837 VEP ended inside ...
**   l1    === expect 0 = BackendClose
**** dT    8.141
**   top   === client c1 {
**** dT    8.142
**   c1    Starting client
**   c1    Waiting for client
**** l1    begin|
**** l1    qry  | vxid == 1002
***  l1    test | expect * * Fetch_Body 
**** dT    8.143
**   c1    Started on 127.0.0.1:30624 (1 iterations)
***  c1    Connect to 127.0.0.1:30624
**** dT    8.144
***  c1    connected fd 23 from 127.0.0.1 45627 to 127.0.0.1:30624
**   c1    === txreq  -url bar
**** dT    8.145
**** c1    txreq|GET bar HTTP/1.1\r
**** c1    txreq|Host: 127.0.0.1\r
**** c1    txreq|User-Agent: c1\r
**** c1    txreq|\r
**   c1    === rxresp
**** dT    8.171
***  s1    accepted fd 5 127.0.0.1 41789
**** dT    8.172
**   s1    === rxreq
**** dT    8.175
**** s1    rxhdr|GET bar HTTP/1.1\r
**** s1    rxhdr|Host: 127.0.0.1\r
**** s1    rxhdr|User-Agent: c1\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: 1002\r
**** s1    rxhdr|\r
**** s1    rxhdrlen = 150
**** s1    http[ 0] |GET
**** s1    http[ 1] |bar
**** s1    http[ 2] |HTTP/1.1
**** s1    http[ 3] |Host: 127.0.0.1
**** s1    http[ 4] |User-Agent: c1
**** s1    http[ 5] |X-Forwarded-For: 127.0.0.1
**** s1    http[ 6] |Via: 1.1 v1 (Varnish/trunk)
**** s1    http[ 7] |Accept-Encoding: gzip
**** s1    http[ 8] |X-Varnish: 1002
**** s1    bodylen = 0
**   s1    === txresp -nolen -hdr "Transfer-encoding: chunked"
**** dT    8.176
**** s1    txresp|HTTP/1.1 200 OK\r
**** s1    txresp|Transfer-encoding: chunked\r
**** s1    txresp|Date: Sat, 21 Jun 2025 03:23:56 GMT\r
**** s1    txresp|Server: s1\r
**** s1    txresp|\r
**** dT    8.177
**   s1    === chunked {<1></esi:comment foo><1>}
**** s1    chunked|18\r
**** s1    chunked|<1></esi:comment foo><1>\r
**   s1    === chunked {<2><esi:comment / ><esi:comment doo><2>}
**** s1    chunked|27\r
**** s1    chunked|<2><esi:comment / ><esi:comment doo><2>\r
**   s1    === chunked {<3><esi:remove foo="bar"></esi:remove><3>}
**** s1    chunked|29\r
**** s1    chunked|<3><esi:remove foo="bar"></esi:remove><3>\r
**   s1    === chunked {<4><esi:include src="foo"><esi:incl><4>}
**** s1    chunked|27\r
**** s1    chunked|<4><esi:include src="foo"><esi:incl><4>\r
**   s1    === chunked {<H1><esi:remove>}
**** s1    chunked|10\r
**** s1    chunked|<H1><esi:remove>\r
**   s1    === chunkedlen 256
**** s1    chunked|100\r
**** s1    chunked|0123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567\r
**** dT    8.178
**   s1    === chunked {</esi:remove></H1>}
**** s1    chunked|12\r
**** s1    chunked|</esi:remove></H1>\r
**   s1    === chunked {<H2><esi:remove>}
**** s1    chunked|10\r
**** s1    chunked|<H2><esi:remove>\r
**   s1    === chunkedlen 65536
**** dT    8.181
**** s1    chunked|10000\r
**** s1    chunked|0123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670
**** s1    chunked| [...] (57353)
**** dT    8.182
**   s1    === chunked {</esi:remove></H2>}
**** s1    chunked|12\r
**** s1    chunked|</esi:remove></H2>\r
**   s1    === chunked {<esi:comment/>}
**** s1    chunked|e\r
**** s1    chunked|<esi:comment/>\r
**   s1    === chunkedlen 256
**** dT    8.183
**** s1    chunked|100\r
**** s1    chunked|0123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567\r
**   s1    === chunked {<esi:comment/>}
**** s1    chunked|e\r
**** s1    chunked|<esi:comment/>\r
**   s1    === chunkedlen 65536
**** dT    8.185
**** s1    chunked|10000\r
**** s1    chunked|0123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670123456701234567012345670
**** s1    chunked| [...] (57353)
**** dT    8.240
**** v1    vsl|       1000 Begin           c sess 0 HTTP/1
**** v1    vsl|       1000 SessOpen        c 127.0.0.1 45627 a0 127.0.0.1 30624 1750476236.785873 20
**** v1    vsl|       1000 Debug           c sockopt: Test confirmed SO_KEEPALIVE non heredity for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: Test confirmed SO_SNDTIMEO non heredity for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: Test confirmed SO_RCVTIMEO non heredity for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: Test confirmed TCP_NODELAY non heredity for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:30624
**** dT    8.241
**** v1    vsl|       1000 Debug           c sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: Setting TCP_NODELAY for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:30624
**** v1    vsl|       1000 Debug           c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:30624
**** v1    vsl|       1001 Begin           c req 1000 rxreq
**** v1    vsl|       1000 Link            c req 1001 rxreq
**** v1    vsl|       1001 Timestamp       c Start: 1750476236.797705 0.000000 0.000000
**** v1    vsl|       1001 Timestamp       c Req: 1750476236.797705 0.000000 0.000000
**** v1    vsl|       1001 VCL_use         c vcl1
**** v1    vsl|       1001 ReqStart        c 127.0.0.1 45627 a0
**** v1    vsl|       1001 ReqMethod       c GET
**** v1    vsl|       1001 ReqURL          c bar
**** v1    vsl|       1001 ReqProtocol     c HTTP/1.1
**** v1    vsl|       1001 ReqHeader       c Host: 127.0.0.1
**** v1    vsl|       1001 ReqHeader       c User-Agent: c1
**** 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 hash
**** v1    vsl|       1001 VCL_call        c HASH
**** v1    vsl|       1001 VCL_return      c lookup
**** v1    vsl|       1001 VCL_call        c MISS
**** v1    vsl|       1001 VCL_return      c fetch
**** v1    vsl|       1002 Begin           b bereq 1001 fetch
**** v1    vsl|       1002 VCL_use         b vcl1
**** v1    vsl|       1001 Link            c bereq 1002 fetch
**** v1    vsl|       1002 Timestamp       b Start: 1750476236.801888 0.000000 0.000000
**** v1    vsl|       1002 BereqMethod     b GET
**** v1    vsl|       1002 BereqURL        b bar
**** v1    vsl|       1002 BereqProtocol   b HTTP/1.1
**** v1    vsl|       1002 BereqHeader     b Host: 127.0.0.1
**** v1    vsl|       1002 BereqHeader     b User-Agent: c1
**** v1    vsl|       1002 BereqHeader     b X-Forwarded-For: 127.0.0.1
**** v1    vsl|       1002 BereqHeader     b Via: 1.1 v1 (Varnish/trunk)
**** v1    vsl|       1002 BereqHeader     b Accept-Encoding: gzip
**** v1    vsl|       1002 BereqHeader     b X-Varnish: 1002
**** v1    vsl|       1002 VCL_call        b BACKEND_FETCH
**** v1    vsl|       1002 VCL_return      b fetch
**** v1    vsl|       1002 Timestamp       b Fetch: 1750476236.802177 0.000288 0.000288
**** v1    vsl|       1002 Timestamp       b Connected: 1750476236.803138 0.001249 0.000961
**** v1    vsl|       1002 BackendOpen     b 23 s1 127.0.0.1 55316 127.0.0.1 41789 connect
**** v1    vsl|       1002 Timestamp       b Bereq: 1750476236.819312 0.017424 0.016174
**** v1    vsl|       1002 BerespProtocol  b HTTP/1.1
**** v1    vsl|       1002 BerespStatus    b 200
**** v1    vsl|       1002 BerespReason    b OK
**** v1    vsl|       1002 BerespHeader    b Transfer-encoding: chunked
**** v1    vsl|       1002 BerespHeader    b Date: Sat, 21 Jun 2025 03:23:56 GMT
**** v1    vsl|       1002 BerespHeader    b Server: s1
**** v1    vsl|       1002 Timestamp       b Beresp: 1750476236.819820 0.017931 0.000507
**** v1    vsl|       1002 TTL             b RFC 120 10 0 1750476237 1750476237 1750476236 0 0 cacheable
**** v1    vsl|       1002 VCL_call        b BACKEND_RESPONSE
**** v1    vsl|       1002 VCL_return      b deliver
**** v1    vsl|       1002 Debug           b Missing content-range header or unknown range unit
**** v1    vsl|       1002 Timestamp       b Process: 1750476236.820368 0.018480 0.000548
**** v1    vsl|       1002 Filters         b  esi
**** dT    8.242
**** v1    vsl|       1002 Storage         b malloc s0
**** v1    vsl|       1002 Fetch_Body      b 2 chunked -
**** v1    vsl|       1002 ESI_xmlerror    b ERR after 3 ESI 1.0 </esi:comment> illegal end-tag
**** v1    vsl|       1002 ESI_xmlerror    b ERR after 27 XML 1.0 '>' does not follow '/' in tag
**** v1    vsl|       1002 ESI_xmlerror    b ERR after 43 ESI 1.0 <esi:comment> needs final '/'
**** v1    vsl|       1002 ESI_xmlerror    b WARN after 107 ESI 1.0 <esi:include> lacks final '/'
**** v1    vsl|       1002 ESI_xmlerror    b ERR after 130 ESI 1.0 <esi:bogus> element
**** dT    8.264
**   s1    === chunked {<esi:comment/>}
**** s1    chunked|e\r
**** s1    chunked|<esi:comment/>\r
**   s1    === chunked {<!--e}
**** s1    chunked|5\r
**** s1    chunked|<!--e\r
**   s1    === delay .4
***  s1    delaying 0.4 second(s)
**** dT    8.666
**   s1    === chunked {nd:comment>}
**** s1    chunked|b\r
**** s1    chunked|nd:comment>\r
**   s1    === chunkedlen 0
**** s1    chunked|0\r
**** s1    chunked|\r
***  s1    shutting fd 5 (server run)
**   s1    Ending
**** dT    8.970
**** v1    vsl|          0 Debug           - sockopt: Not setting unmodified SO_LINGER for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Not setting unmodified SO_KEEPALIVE for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Not setting unmodified TCP_NODELAY for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Not setting unmodified TCP_KEEPIDLE for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Not setting unmodified TCP_KEEPCNT for a0=127.0.0.1:30624
**** v1    vsl|          0 Debug           - sockopt: Not setting unmodified TCP_KEEPINTVL for a0=127.0.0.1:30624
**** dT    10.847
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476239 1.0
**** dT    13.838
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476242 1.0
**** dT    16.845
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476245 1.0
**** dT    19.854
**** v1    vsl|          0 CLI             - Rd ping
**** dT    19.855
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476248 1.0
**** dT    22.854
**** v1    vsl|          0 CLI             - Rd ping
**** dT    22.855
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476251 1.0
**** dT    25.857
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476254 1.0
**** dT    28.863
**** v1    vsl|          0 CLI             - Rd ping
**** dT    28.864
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476257 1.0
**** dT    31.895
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476260 1.0
**** dT    34.920
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476263 1.0
**** dT    37.933
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476266 1.0
**** dT    40.924
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476269 1.0
**** dT    43.935
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476272 1.0
**** dT    46.934
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476275 1.0
**** dT    49.943
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476278 1.0
**** dT    52.984
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476281 1.0
**** dT    55.984
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476284 1.0
**** dT    58.985
**** v1    vsl|          0 CLI             - Rd ping
**** dT    58.986
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476287 1.0
**** dT    61.895
**** v1    vsl|          0 CLI             - Rd ping
**** dT    61.896
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476290 1.0
**** dT    65.000
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476293 1.0
**** dT    68.003
**** v1    vsl|          0 CLI             - Rd ping
**** v1    vsl|          0 CLI             - Wr 200 19 PONG 1750476296 1.0
**** dT    68.146
---- c1    HTTP rx timeout (fd:23 60.000s)
**** dT    68.148
*    top   Aborting execution, test failed
*    top   RESETTING after ../../../../bin/varnishtest/tests/e00019.vtc
**   l1    Waiting for logexp
**** dT    68.149
**   s1    Waiting for server (3/-1)
**** dT    68.150
**   s2    Waiting for server (4/-1)
**   v1    Wait
**** v1    CLI TX|panic.show
**** dT    68.191
***  v1    CLI RX  300
**** v1    CLI RX|Child has not panicked or panic has been cleared
**** dT    68.195
***  v1    debug|Info: manager stopping child
***  v1    debug|Debug: Stopping Child
**** dT    68.208
**** v1    vsl|          0 CLI             - EOF on CLI connection, worker stops
**** dT    68.295
***  v1    debug|Info: Child (34498) said Child dies
**** dT    68.297
***  v1    debug|Info: Child (34498) ended
**** dT    68.302
***  v1    debug|Debug: Child cleanup complete
**** dT    68.310
***  v1    debug|Info: manager dies
**** dT    68.325
**** v1    STDOUT EOF
**** dT    68.327
**   v1    WAIT4 pid=34489 status=0x0000 (user 8.832817 sys 3.835631)
**** dT    68.328
*    top   TEST ../../../../bin/varnishtest/tests/e00019.vtc FAILED
#    top  TEST ../../../../bin/varnishtest/tests/e00019.vtc FAILED (68.379) exit=2
FAIL tests/e00019.vtc (exit status: 2)