**** dT 0.000
* top TEST ../../../../bin/varnishtest/tests/u00009.vtc starting
**** top extmacro def pkg_version=trunk
**** top extmacro def pkg_branch=trunk
**** top extmacro def pwd=/Users/bsdphk/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:57530
**** top extmacro def listen_addr=127.0.0.1:0
**** top extmacro def bad_ip=192.0.2.255
**** top extmacro def topbuild=/Users/bsdphk/VT/varnish-cache/varnish-trunk/_build/sub
**** top extmacro def topsrc=/Users/bsdphk/VT/varnish-cache/varnish-trunk/_build/sub/../..
**** top macro def testdir=/Users/bsdphk/VT/varnish-cache/varnish-trunk/_build/sub/bin/varnishtest/../../../../bin/varnishtest/tests
**** top macro def tmpdir=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187
**** top macro def vtcid=vtc.93078.38b96187
** top === varnishtest "trivial run of varnishhist in curses mode"
* top VTEST trivial run of varnishhist in curses mode
** top === server s1 {
** s1 Starting server
**** s1 macro def s1_addr=127.0.0.1
**** s1 macro def s1_port=57531
**** s1 macro def s1_sock=127.0.0.1:57531
* s1 Listen on 127.0.0.1:57531
** top === varnish v1 -vcl+backend {} -start
** s1 Started on 127.0.0.1:57531 (1 iterations)
**** dT 0.011
** v1 Launch
*** v1 CMD: cd ${pwd} && exec varnishd -d -n /Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/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 57532' -P /Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/v1/varnishd.pid -p vmod_path=/Users/bsdphk/VT/varnish-cache/varnish-trunk/_build/sub/vmod/.libs
*** v1 CMD: cd /Users/bsdphk/VT/varnish-cache/varnish-trunk/_build/sub/bin/varnishtest && exec varnishd -d -n /Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/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 57532' -P /Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/v1/varnishd.pid -p vmod_path=/Users/bsdphk/VT/varnish-cache/varnish-trunk/_build/sub/vmod/.libs
*** v1 PID: 93096
**** v1 macro def v1_pid=93096
**** v1 macro def v1_name=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/v1
**** dT 0.041
*** v1 debug|Debug: Version: varnish-trunk revision 41833f2bed22a2e569f2137dddcc52b0cc0a4537
*** v1 debug|Debug: Platform: Darwin,24.5.0,arm64,-jnone,-sdefault,-sdefault,-hcritbit
*** v1 debug|200 307
*** v1 debug|-----------------------------
*** v1 debug|Varnish Cache CLI 1.0
*** v1 debug|-----------------------------
*** v1 debug|Darwin,24.5.0,arm64,-jnone,-sdefault,-sdefault,-hcritbit
*** v1 debug|varnish-trunk revision 41833f2bed22a2e569f2137dddcc52b0cc0a4537
*** 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.137
**** v1 CLIPOLL 1 0x1 0x0 0x0
*** v1 CLI connection fd = 6
**** dT 0.138
*** v1 CLI RX 107
**** v1 CLI RX|kwxkbhkrlyxbkrmzdopfgauodjafnynw
**** v1 CLI RX|
**** v1 CLI RX|Authentication required.
**** v1 CLI TX|auth 43c9b708d78b11eca3816bffca760558261d9ea7170b7f838dc0706cc1d1e733
*** v1 CLI RX 200
**** v1 CLI RX|-----------------------------
**** v1 CLI RX|Varnish Cache CLI 1.0
**** v1 CLI RX|-----------------------------
**** v1 CLI RX|Darwin,24.5.0,arm64,-jnone,-sdefault,-sdefault,-hcritbit
**** v1 CLI RX|varnish-trunk revision 41833f2bed22a2e569f2137dddcc52b0cc0a4537
**** 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|backend s1 { .host = "127.0.0.1"; .port = "57531"; }
**** v1 CLI TX|
**** v1 CLI TX|
**** v1 CLI TX|%XJEIFLH|)Xspa8P
**** dT 0.239
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.339
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.440
*** v1 vsl|No VSL chunk found (child not started ?)
**** dT 0.453
*** v1 CLI RX 200
**** v1 CLI RX|VCL compiled.
**** v1 CLI TX|vcl.use vcl1
*** v1 CLI RX 200
**** v1 CLI RX|VCL 'vcl1' now active
** v1 Start
**** v1 CLI TX|start
**** dT 0.459
*** v1 debug|Debug: Child (93106) Started
**** dT 0.477
*** v1 debug|Child launched OK
**** dT 0.478
*** v1 debug|Info: Child (93106) said Child starts
*** v1 CLI RX 200
*** v1 wait-running
**** v1 CLI TX|status
*** v1 CLI RX 200
**** v1 CLI RX|Child in state running
**** v1 CLI TX|debug.listen_address
*** v1 CLI RX 200
**** v1 CLI RX|a0 127.0.0.1 57534
**** v1 CLI TX|debug.xid 1000
*** v1 CLI RX 200
**** v1 CLI RX|XID is 1000 chunk 1
**** v1 CLI TX|debug.listen_address
*** v1 CLI RX 200
**** v1 CLI RX|a0 127.0.0.1 57534
** v1 Listen on 127.0.0.1 57534
**** v1 macro def v1_addr=127.0.0.1
**** v1 macro def v1_port=57534
**** v1 macro def v1_sock=127.0.0.1:57534
**** v1 macro def v1_a0_addr=127.0.0.1
**** v1 macro def v1_a0_port=57534
**** v1 macro def v1_a0_sock=127.0.0.1:57534
**** dT 0.550
**** v1 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1759324173.525781/vgc.so 1auto
**** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1759324173.525781/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:57534
**** v1 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPALIVE for a0=127.0.0.1:57534
**** v1 vsl| 0 CLI - Wr 200 0
**** v1 vsl| 0 CLI - Rd debug.listen_address
**** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 57534
**** 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 57534
**** dT 0.580
** top === process p1 -dump {varnishhist -n ${v1_name}} -start
**** dT 0.606
**** p1 CMD: varnishhist -n /Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/v1
**** dT 0.607
*** p1 PID: 93116
**** p1 macro def p1_pid=93116
**** p1 macro def p1_dir=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p1
**** p1 macro def p1_out=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p1/term
**** p1 macro def p1_err=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p1/stderr
**** dT 0.608
** top === process p2 -dump {varnishhist -n ${v1_name} -P b:BereqAcct::...
**** dT 0.624
**** p2 CMD: varnishhist -n /Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/v1 -P b:BereqAcct::5:-1:1
*** p2 PID: 93127
**** p2 macro def p2_pid=93127
**** p2 macro def p2_dir=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p2
**** p2 macro def p2_out=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p2/term
**** p2 macro def p2_err=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p2/stderr
**** dT 0.625
** top === process p3 -dump {VARNISH_DEFAULT_N="${v1_name}" varnishhist...
**** dT 0.638
**** p3 CMD: VARNISH_DEFAULT_N="/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/v1" varnishhist -P BerespBodytime -B 2
**** dT 0.639
*** p3 PID: 93145
**** p3 macro def p3_pid=93145
**** p3 macro def p3_dir=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p3
**** p3 macro def p3_out=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p3/term
**** p3 macro def p3_err=/Users/bsdphk/VT/_vtest_tmp/vtc.93078.38b96187/p3/stderr
** top === process p1 -expect-text 24 0 {1e2}
**** dT 0.643
**** p1 stdout|\x1b[?1049h\x1b[1;24r\x1b(B\x1b[m\x1b[4l\x1b[?7h\x1b[?25l
**** dT 0.644
**** p1 stdout|\x1b[H\x1b[2J1:1, n = 0, d = 1\x1b[78Gv1\r\x1b[3d20_\r\x1b[8d15_\r\x1b[13d10_\r\x1b[18d5_\r\x1b[23d+-------+-------+-------+-------+-------+-------+-------+-------+-------\r\x1b[24d|1e-6 |1e-5 |1e-4 |1e-3 |1e-2 |1e-1 |1e0 |1e1 |1e2\x1b[3;4H
**** dT 0.650
**** p1 found expected text at 24,66: '1e2'
** top === process p2 -expect-text 24 0 {1e-1}
**** dT 0.657
**** p2 stdout|\x1b[?1049h\x1b[1;24r\x1b(B\x1b[m\x1b[4l\x1b[?7h\x1b[?25l
**** p2 stdout|\x1b[H\x1b[2J1:1, n = 0, d = 1\x1b[78Gv1\r\x1b[3d20_\r\x1b[8d15_\r\x1b[13d10_\r\x1b[18d5_\r\x1b[23d+---------------------------------------+---------------------------------------\x1b[24;1H|1e-1\x1b[24;41H|1e0\x1b[3;4H
**** dT 0.660
**** p2 found expected text at 24,2: '1e-1'
** top === process p3 -expect-text 24 0 {1e2}
**** dT 0.668
**** p3 stdout|\x1b[?1049h\x1b[1;24r\x1b(B\x1b[m\x1b[4l\x1b[?7h\x1b[?25l
**** p3 stdout|\x1b[H\x1b[2J1:1, n = 0, d = 1\x1b[78Gv1\r\x1b[3d20_\r\x1b[8d15_\r\x1b[13d10_\r\x1b[18d5_\r\x1b[23d+-------+-------+-------+-------+-------+-------+-------+-------+-------\r\x1b[24d|1e-6 |1e-5 |1e-4 |1e-3 |1e-2 |1e-1 |1e0 |1e1 |1e2\x1b[3;4H
**** dT 0.672
**** p3 found expected text at 24,66: '1e2'
** top === delay 1
*** top delaying 1 second(s)
**** dT 1.489
**** v1 vsl| 0 Debug - sockopt: Not setting unmodified SO_LINGER for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Not setting unmodified SO_KEEPALIVE for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Not setting unmodified TCP_NODELAY for a0=127.0.0.1:57534
**** v1 vsl| 0 Debug - sockopt: Not setting unmodified TCP_KEEPALIVE for a0=127.0.0.1:57534
**** dT 1.672
** top === client c1 {
**** dT 1.673
** c1 Starting client
** c1 Started on 127.0.0.1:57534 (1 iterations)
*** c1 Connect to 127.0.0.1:57534
** c1 Waiting for client
*** c1 connected fd 28 from 127.0.0.1 57540 to 127.0.0.1:57534
** c1 === txreq
**** c1 txreq|GET / HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|User-Agent: c1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 1.674
*** s1 accepted fd 29 127.0.0.1 57541
** s1 === rxreq
**** s1 rxhdr|GET / 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 = 148
**** s1 http[ 0] |GET
**** s1 http[ 1] |/
**** 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 -bodylen 32
**** s1 txresp|HTTP/1.1 200 OK\r
**** s1 txresp|Date: Wed, 01 Oct 2025 13:09:35 GMT\r
**** s1 txresp|Server: s1\r
**** s1 txresp|Content-Length: 32\r
**** s1 txresp|\r
**** s1 txresp|!"#$%&'()*+,-./0123456789:;<=>?
*** s1 shutting fd 29 (server run)
** s1 Ending
**** c1 rxhdr|HTTP/1.1 200 OK\r
**** c1 rxhdr|Date: Wed, 01 Oct 2025 13:09:35 GMT\r
**** c1 rxhdr|Server: s1\r
**** c1 rxhdr|Content-Length: 32\r
**** c1 rxhdr|X-Varnish: 1001\r
**** c1 rxhdr|Age: 0\r
**** c1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** c1 rxhdr|Accept-Ranges: bytes\r
**** c1 rxhdr|Connection: keep-alive\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 188
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |200
**** c1 http[ 2] |OK
**** c1 http[ 3] |Date: Wed, 01 Oct 2025 13:09:35 GMT
**** c1 http[ 4] |Server: s1
**** c1 http[ 5] |Content-Length: 32
**** c1 http[ 6] |X-Varnish: 1001
**** c1 http[ 7] |Age: 0
**** c1 http[ 8] |Via: 1.1 v1 (Varnish/trunk)
**** c1 http[ 9] |Accept-Ranges: bytes
**** c1 http[10] |Connection: keep-alive
**** c1 c-l|!"#$%&'()*+,-./0123456789:;<=>?
**** c1 bodylen = 32
*** c1 closing fd 28
** c1 Ending
** top === varnish v1 -vsl_catchup
**** dT 1.692
**** v1 vsl| 1000 Begin c sess 0 HTTP/1
**** v1 vsl| 1000 SessOpen c 127.0.0.1 57540 a0 127.0.0.1 57534 1759324175.060925 22
**** v1 vsl| 1000 Debug c sockopt: Test confirmed SO_KEEPALIVE non heredity for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Test confirmed SO_SNDTIMEO non heredity for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Test confirmed SO_RCVTIMEO non heredity for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Test confirmed TCP_NODELAY non heredity for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Test confirmed TCP_KEEPALIVE non heredity for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Setting TCP_NODELAY for a0=127.0.0.1:57534
**** v1 vsl| 1000 Debug c sockopt: Setting TCP_KEEPALIVE for a0=127.0.0.1:57534
**** v1 vsl| 1000 Link c req 1001 rxreq
**** v1 vsl| 1002 Begin b bereq 1001 fetch
**** v1 vsl| 1002 VCL_use b vcl1
**** v1 vsl| 1002 Timestamp b Start: 1759324175.061070 0.000000 0.000000
**** v1 vsl| 1002 BereqMethod b GET
**** v1 vsl| 1002 BereqURL b /
**** 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: 1759324175.061085 0.000015 0.000015
**** v1 vsl| 1002 Timestamp b Connected: 1759324175.061167 0.000097 0.000082
**** v1 vsl| 1002 BackendOpen b 23 s1 127.0.0.1 57531 127.0.0.1 57541 connect
**** v1 vsl| 1002 Timestamp b Bereq: 1759324175.061187 0.000117 0.000020
**** 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 Date: Wed, 01 Oct 2025 13:09:35 GMT
**** v1 vsl| 1002 BerespHeader b Server: s1
**** v1 vsl| 1002 BerespHeader b Content-Length: 32
**** v1 vsl| 1002 Timestamp b Beresp: 1759324175.061653 0.000582 0.000465
**** v1 vsl| 1002 TTL b RFC 120 10 0 1759324175 1759324175 1759324175 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: 1759324175.061669 0.000599 0.000016
**** v1 vsl| 1002 Filters b
**** v1 vsl| 1002 Storage b malloc s0
**** v1 vsl| 1002 Fetch_Body b 3 length stream
**** v1 vsl| 1002 BackendClose b 23 s1 recycle
**** v1 vsl| 1002 Timestamp b BerespBody: 1759324175.071963 0.010893 0.010293
**** v1 vsl| 1002 Length b 32
**** v1 vsl| 1002 BereqAcct b 148 0 148 88 32 120
**** v1 vsl| 1002 End b
**** v1 vsl| 1001 Begin c req 1000 rxreq
**** v1 vsl| 1001 Timestamp c Start: 1759324175.060986 0.000000 0.000000
**** v1 vsl| 1001 Timestamp c Req: 1759324175.060986 0.000000 0.000000
**** v1 vsl| 1001 VCL_use c vcl1
**** v1 vsl| 1001 ReqStart c 127.0.0.1 57540 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 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| 1001 Link c bereq 1002 fetch
**** v1 vsl| 1001 Timestamp c Fetch: 1759324175.061699 0.000712 0.000712
**** 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: Wed, 01 Oct 2025 13:09:35 GMT
**** v1 vsl| 1001 RespHeader c Server: s1
**** v1 vsl| 1001 RespHeader c Content-Length: 32
**** v1 vsl| 1001 RespHeader c X-Varnish: 1001
**** v1 vsl| 1001 RespHeader c Age: 0
**** v1 vsl| 1001 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1001 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1001 VCL_call c DELIVER
**** v1 vsl| 1001 VCL_return c deliver
**** v1 vsl| 1001 Timestamp c Process: 1759324175.061724 0.000737 0.000025
**** v1 vsl| 1001 Filters c
**** v1 vsl| 1001 RespHeader c Connection: keep-alive
**** v1 vsl| 1001 Timestamp c Resp: 1759324175.072006 0.011019 0.010282
**** v1 vsl| 1001 ReqAcct c 51 0 51 188 32 220
**** v1 vsl| 1001 End c
**** v1 vsl| 1000 SessClose c REM_CLOSE 0.011
**** v1 vsl| 1000 End c
**** dT 1.776
** top === process p1 -expect-text 22 0 {#}
**** dT 2.651
**** p1 stdout|\x1b[1;10H1\x1b[22;23H#
**** dT 2.658
**** p2 stdout|\x1b[1;10H1\x1b[22;80H#\x1b[23;1H
**** dT 2.679
**** p3 stdout|\x1b[1;10H1\x1b[1;19H@ Wed, 01 Oct 2025 13:09:35 GMT x 2\x1b[22;33H#
**** dT 3.058
**** p1 found expected text at 22,23: '#'
** top === process p2 -expect-text 22 80 {#}
**** p2 found expected text at 22,80: '#'
** top === client c1 {
** c1 Starting client
** c1 Waiting for client
** c1 Started on 127.0.0.1:57534 (1 iterations)
*** c1 Connect to 127.0.0.1:57534
*** c1 connected fd 28 from 127.0.0.1 57550 to 127.0.0.1:57534
**** dT 3.059
** c1 === txreq
**** c1 txreq|GET / HTTP/1.1\r
**** c1 txreq|Host: 127.0.0.1\r
**** c1 txreq|User-Agent: c1\r
**** c1 txreq|\r
** c1 === rxresp
**** dT 3.061
**** c1 rxhdr|HTTP/1.1 200 OK\r
**** c1 rxhdr|Date: Wed, 01 Oct 2025 13:09:35 GMT\r
**** c1 rxhdr|Server: s1\r
**** c1 rxhdr|Content-Length: 32\r
**** c1 rxhdr|X-Varnish: 1004 1002\r
**** c1 rxhdr|Age: 1\r
**** c1 rxhdr|Via: 1.1 v1 (Varnish/trunk)\r
**** c1 rxhdr|Accept-Ranges: bytes\r
**** c1 rxhdr|Connection: keep-alive\r
**** c1 rxhdr|\r
**** c1 rxhdrlen = 193
**** c1 http[ 0] |HTTP/1.1
**** c1 http[ 1] |200
**** c1 http[ 2] |OK
**** c1 http[ 3] |Date: Wed, 01 Oct 2025 13:09:35 GMT
**** c1 http[ 4] |Server: s1
**** c1 http[ 5] |Content-Length: 32
**** c1 http[ 6] |X-Varnish: 1004 1002
**** c1 http[ 7] |Age: 1
**** c1 http[ 8] |Via: 1.1 v1 (Varnish/trunk)
**** c1 http[ 9] |Accept-Ranges: bytes
**** c1 http[10] |Connection: keep-alive
**** c1 c-l|!"#$%&'()*+,-./0123456789:;<=>?
**** c1 bodylen = 32
*** c1 closing fd 28
** c1 Ending
** top === varnish v1 -vsl_catchup
**** dT 3.149
**** v1 vsl| 1003 Begin c sess 0 HTTP/1
**** v1 vsl| 1003 SessOpen c 127.0.0.1 57550 a0 127.0.0.1 57534 1759324176.446577 22
**** v1 vsl| 1003 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:57534
**** v1 vsl| 1003 Debug c sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:57534
**** v1 vsl| 1003 Debug c sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 1003 Debug c sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:57534
**** v1 vsl| 1003 Debug c sockopt: Setting TCP_NODELAY for a0=127.0.0.1:57534
**** v1 vsl| 1003 Debug c sockopt: Setting TCP_KEEPALIVE for a0=127.0.0.1:57534
**** v1 vsl| 1003 Link c req 1004 rxreq
**** v1 vsl| 1004 Begin c req 1003 rxreq
**** v1 vsl| 1004 Timestamp c Start: 1759324176.447068 0.000000 0.000000
**** v1 vsl| 1004 Timestamp c Req: 1759324176.447068 0.000000 0.000000
**** v1 vsl| 1004 VCL_use c vcl1
**** v1 vsl| 1004 ReqStart c 127.0.0.1 57550 a0
**** v1 vsl| 1004 ReqMethod c GET
**** v1 vsl| 1004 ReqURL c /
**** v1 vsl| 1004 ReqProtocol c HTTP/1.1
**** v1 vsl| 1004 ReqHeader c Host: 127.0.0.1
**** v1 vsl| 1004 ReqHeader c User-Agent: c1
**** v1 vsl| 1004 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 vsl| 1004 ReqHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1004 VCL_call c RECV
**** v1 vsl| 1004 VCL_return c hash
**** v1 vsl| 1004 VCL_call c HASH
**** v1 vsl| 1004 VCL_return c lookup
**** v1 vsl| 1004 Hit c 1002 118.614585 10.000000 0.000000
**** v1 vsl| 1004 VCL_call c HIT
**** v1 vsl| 1004 VCL_return c deliver
**** v1 vsl| 1004 RespProtocol c HTTP/1.1
**** v1 vsl| 1004 RespStatus c 200
**** v1 vsl| 1004 RespReason c OK
**** v1 vsl| 1004 RespHeader c Date: Wed, 01 Oct 2025 13:09:35 GMT
**** v1 vsl| 1004 RespHeader c Server: s1
**** v1 vsl| 1004 RespHeader c Content-Length: 32
**** v1 vsl| 1004 RespHeader c X-Varnish: 1004 1002
**** v1 vsl| 1004 RespHeader c Age: 1
**** v1 vsl| 1004 RespHeader c Via: 1.1 v1 (Varnish/trunk)
**** v1 vsl| 1004 RespHeader c Accept-Ranges: bytes
**** v1 vsl| 1004 VCL_call c DELIVER
**** v1 vsl| 1004 VCL_return c deliver
**** v1 vsl| 1004 Timestamp c Process: 1759324176.447673 0.000605 0.000605
**** v1 vsl| 1004 Filters c
**** v1 vsl| 1004 RespHeader c Connection: keep-alive
**** v1 vsl| 1004 Timestamp c Resp: 1759324176.447861 0.000792 0.000187
**** v1 vsl| 1004 ReqAcct c 51 0 51 193 32 225
**** v1 vsl| 1004 End c
**** v1 vsl| 1003 SessClose c REM_CLOSE 0.002
**** v1 vsl| 1003 End c
**** dT 3.163
** top === process p1 -expect-text 22 0 { |}
**** dT 3.583
**** v1 vsl| 0 CLI - Rd ping
**** dT 3.584
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324176 1.0
**** dT 3.661
**** p1 stdout|\x1b[1;10H2\x1b[21;23H|
**** dT 6.508
**** v1 vsl| 0 CLI - Rd ping
**** dT 6.509
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324179 1.0
**** dT 9.489
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324182 1.0
**** dT 12.522
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324185 1.0
**** dT 15.493
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324188 1.0
**** dT 18.516
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324191 1.0
**** dT 21.494
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324194 1.0
**** dT 24.584
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324197 1.0
**** dT 27.542
**** v1 vsl| 0 CLI - Rd ping
**** dT 27.543
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324200 1.0
**** dT 30.589
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324203 1.0
**** dT 33.527
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324206 1.0
**** dT 36.600
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324209 1.0
**** dT 39.592
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324212 1.0
**** dT 42.571
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324215 1.0
**** dT 45.566
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324218 1.0
**** dT 48.539
**** v1 vsl| 0 CLI - Rd ping
**** dT 48.540
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324221 1.0
**** dT 51.552
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324224 1.0
**** dT 54.539
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324227 1.0
**** dT 57.557
**** v1 vsl| 0 CLI - Rd ping
**** v1 vsl| 0 CLI - Wr 200 19 PONG 1759324230 1.0
# top TEST ../../../../bin/varnishtest/tests/u00009.vtc TIMED OUT (kill -9)
# top TEST ../../../../bin/varnishtest/tests/u00009.vtc FAILED (60.004) signal=9
FAIL tests/u00009.vtc (exit status: 2)
Henceforth, whatever our philosopher says about Matter will apply to extension and to extension alone. It cannot be apprehended by sight, nor by hearing, nor by smell, nor by taste, for it is neither colour, nor sound, nor odour, nor juice. Neither can it be touched, for it is not a body, but it becomes corporeal on being blended with sensible qualities. And, in a later essay, he describes it as receiving all things and letting them depart again without retaining the slightest trace of their presence.483 Why then, it may be asked, if Plotinus meant extension, could he not say so at once, and save us all this trouble in hunting out his meaning? There were very good reasons why he should not. In the first place, he wished to express himself, so far as possible, in Aristotelian phraseology, and this was incompatible with the reduction of Matter to extension. In the next place, the idea of an infinite void had been already appropriated by the Epicureans, to whose system he was bitterly opposed. And, finally, the extension of ordinary327 experience had not the absolute generality which was needed in order to bring Matter into relation with that ultimate abstraction whence, like everything else, it has now to be derived. That the millionaire was genuine, ¡°in person and not a caricature,¡± as Dick put it, was evident. Both the nurse, his relative, and his wife, were chatting with him as Jeff delivered the heavy packed ball made up of the gum. 233 "I guess not," said Landor, tolerantly, as he turned[Pg 106] his horse over to his orderly; "but, anyway," he added to Ellton, "we had a picnic¡ªof a sort." Si, unable to think of anything better, went with him. The train had stopped on a switch, and seemed likely to rust fast to the rails, from the way other trains were going by in both directions. The bridge gang, under charge of a burly, red-faced young Englishman, was in the rear car, with their tools, equipments, bedding and cooking utensils. THE DEACON HAS SOME EXPERIENCES WITH THE QUADRUPED. "You are not within a mile of the truth. I know it. Look here: I believe that is Gen. Rosecrans's own cow. She's gone, and I got an order to look around for her. I've never seen her, but from the description given me I believe that's she. Who brought her here?" "Deacon, these brothers and sisters who have come here with me to-night are, like myself, deeply interested in the moral condition of the army, where we all have sons or kinsmen. Now, can't you sit right there and tell us of your observations and experiences, as a Christian man and father, from day to day, of every day that you were down there? Tell us everything, just as it happened each day, that we may be able to judge for ourselves." HAS AN ENCOUNTER WITH THE PROVOST-MARSHAL. "Wonder which one o' them is the 200th Injianny's?" said Si to Shorty. "And your mother, and Harry?" The daughter must be the girl who was talking to him now. She sat on a little stool by the fire, and had brought out some sewing. "Over at Grandturzel¡ªcan't see wot's burning from here. Git buckets and come!" These things, however, gave little concern to the worthy who commanded the Kentish division. Tyler, though an excellent blacksmith, possessed few of the qualities requisite for forming a good general. Provided there was no very sensible diminution in the number of his followers, he cared not a straw for the score or two who, after quarrelling, or perhaps fighting, withdrew in such disgust that they vowed rather to pay the full tax for ever than submit to the insolence of the rebels. One man could fight as well as another, reasoned he; and, provided he was obeyed, what mattered it by whom. Dick went and Tom came¡ªit was sure to be all one in the end. But this burst of indignation soon passed away, and upon the suggestion of the prudent Sir Robert Hailes, he sent an evasive answer, with a command that the Commons should attend him at Windsor on the Sunday following. That it was a stratagem to gain entrance to the Tower, was the opinion of several, but, after much discussion, it was decided that the man should be admitted, and that the monk should be exhibited merely to intimidate the rebels, until the result of this promised communication should be known. HoMEŮͬÐÔÁµcbcb
ENTER NUMBET 0017
tiban4.com.cn
xuer7.net.cn
wwwcqzk.com.cn
jiele1.com.cn
www.manxu7.net.cn
www.rimao6.com.cn
ymtang.com.cn
www.20-00.com.cn
jumao5.net.cn
baore7.com.cn