**** dT    0.000
*    top   TEST ../../../../bin/vinyltest/tests/c00030.vtc starting
**** top   extmacro def pkg_version=trunk
**** top   extmacro def pkg_branch=trunk
**** top   extmacro def pwd=/root/VT/vinyl-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest
**** 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:59095
**** 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/vinyl-cache/vinyl-cache-trunk/_build/sub
**** top   extmacro def topsrc=/root/VT/vinyl-cache/vinyl-cache-trunk/_build/sub/../..
**** top   macro def testdir=/root/VT/vinyl-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/../../../../bin/vinyltest/tests
**** top   macro def tmpdir=/root/VT/_vtest_tmp/vtc.16017.3e0402f9
**** top   macro def vtcid=vtc.16017.3e0402f9
**** dT    0.001
**   top   === vtest "debug storage"
*    top   VTEST debug storage
**   top   === shell -err -expect {Error: Only one -sdebug instance support...
**** top   shell_cmd|set -e ;exec 2>&1 ; vinyld -b none -a /root/VT/_vtest_tmp/vtc.16017.3e0402f9/vtc.sock -n /root/VT/_vtest_tmp/vtc.16017.3e0402f9/v1 -sdebug -sdebug
**** dT    4.460
**** top   shell_out|Error: Child failed on launch 
**** top   shell_out|Error: Child (16818) said Child starts
**** top   shell_out|Error: Child (16818) said -sdebug init delay 0.000000s
**** top   shell_out|Error: Child (16818) said -sdebug open delay in init 0.000000s
**** top   shell_out|Error: Child (16818) said Error: Only one -sdebug instance supported
**** top   shell_out|Error: Child (16818) said (-? gives usage)
**** top   shell_out|Error: Child (16818) died status=2
**** top   shell_status = 0x0002
**** top   shell_expect found
**   top   === shell -err -expect {Error: -sdebug conflicting options} \
**** top   shell_cmd|set -e ;exec 2>&1 ; vinyld -b none -a /root/VT/_vtest_tmp/vtc.16017.3e0402f9/vtc.sock -n /root/VT/_vtest_tmp/vtc.16017.3e0402f9/v1 -sdebug,lessspace,maxspace=1KB
**** dT    6.903
**** top   shell_out|Error: Child failed on launch 
**** top   shell_out|Error: Child (17089) said Child starts
**** top   shell_out|Error: Child (17089) said Error: -sdebug conflicting options
**** top   shell_out|Error: Child (17089) said (-? gives usage)
**** top   shell_out|Error: Child (17089) died status=2
**** top   shell_status = 0x0002
**** top   shell_expect found
**   top   === shell -err -expect {Error: Unknown BYTES} \
**** top   shell_cmd|set -e ;exec 2>&1 ; vinyld -b none -a /root/VT/_vtest_tmp/vtc.16017.3e0402f9/vtc.sock -n /root/VT/_vtest_tmp/vtc.16017.3e0402f9/v1 -sdebug,maxspace=1DJT
**** dT    8.860
**** top   shell_out|Error: Child failed on launch 
**** top   shell_out|Error: Child (17502) said Child starts
**** top   shell_out|Error: Child (17502) said Error: Unknown BYTES unit of measurement ([KMGTP][B])
**** top   shell_out|Error: Child (17502) said (-? gives usage)
**** top   shell_out|Error: Child (17502) died status=2
**** top   shell_status = 0x0002
**** top   shell_expect found
**   top   === barrier b1 cond 2
**   top   === barrier b2 cond 2
**   top   === server s1 {
**   s1    Starting server
**** s1    macro def s1_addr=127.0.0.1
**** dT    8.861
**** s1    macro def s1_port=49217
**** s1    macro def s1_sock=127.0.0.1:49217
*    s1    Listen on 127.0.0.1:49217
**   top   === vinyl v1 -arg "-sTransient=debug,maxspace=1KB" -vcl+backend ...
**   s1    Started on 127.0.0.1:49217 (1 iterations)
**** dT    8.868
**   v1    Launch
***  v1    CMD: cd ${pwd} && exec vinyld  -d -n /root/VT/_vtest_tmp/vtc.16017.3e0402f9/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 14951' -P /root/VT/_vtest_tmp/vtc.16017.3e0402f9/v1/vinyld.pid -p vmod_path=/root/VT/vinyl-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:  -sTransient=debug,maxspace=1KB
***  v1    CMD: cd /root/VT/vinyl-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest && exec vinyld  -d -n /root/VT/_vtest_tmp/vtc.16017.3e0402f9/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 14951' -P /root/VT/_vtest_tmp/vtc.16017.3e0402f9/v1/vinyld.pid -p vmod_path=/root/VT/vinyl-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:  -sTransient=debug,maxspace=1KB
**** dT    8.869
***  v1    PID: 17512
**** v1    macro def v1_pid=17512
**** v1    macro def v1_name=/root/VT/_vtest_tmp/vtc.16017.3e0402f9/v1
**** dT    8.884
***  v1    debug|Error: vinyld is already running (pid=17168) (pidfile=/root/VT/_vtest_tmp/vtc.16017.3e0402f9/v1/_.pid)
**** dT    9.023
***  v1    debug|(-? gives usage)
**** v1    STDOUT EOF
**** v1    CLIPOLL 1 0x0 0x11 0x0
---- v1    FAIL debug pipe closed
*    top   RESETTING after ../../../../bin/vinyltest/tests/c00030.vtc
**** dT    9.024
**   s1    Waiting for server (3/-1)
*    top   TEST ../../../../bin/vinyltest/tests/c00030.vtc FAILED
#    top  TEST ../../../../bin/vinyltest/tests/c00030.vtc FAILED (9.053) exit=2
FAIL tests/c00030.vtc (exit status: 2)