c00049

4e1699f

1 @ FreeBSD amd64 11.1-REL-p4 1.04 phk

*    top   0.0 TEST ../../../../bin/varnishtest/tests/c00049.vtc starting
[...]
*    top   0.0 TEST New ban-lurker test
[...]
**   s1    0.0 Starting server
**** s1    0.0 macro def s1_addr=10.0.0.205
**** s1    0.0 macro def s1_port=28145
**** s1    0.0 macro def s1_sock=10.0.0.205 28145
*    s1    0.0 Listen on 10.0.0.205 28145
**   top   0.0 === varnish v1 -vcl+backend {} -start
**   s1    0.0 Started on 10.0.0.205 28145
**   v1    0.0 Launch
***  v1    0.0 CMD: cd ${pwd} && exec varnishd  -d -n /root/VT/_vtest_tmp/vtc.56372.293cc9ef/v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p sigsegv_handler=on -p thread_pool_min=10 -p debug=+vtc_mode -a '127.0.0.1:0' -M '10.0.0.205 28146' -P /root/VT/_vtest_tmp/vtc.56372.293cc9ef/v1/varnishd.pid -p vmod_path=/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_std/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_debug/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_directors/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_purge/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_vtc/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_blob/.libs
***  v1    0.0 CMD: cd /root/VT/varnish-cache/varnish-trunk/_build/sub/bin/varnishtest && exec varnishd  -d -n /root/VT/_vtest_tmp/vtc.56372.293cc9ef/v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p sigsegv_handler=on -p thread_pool_min=10 -p debug=+vtc_mode -a '127.0.0.1:0' -M '10.0.0.205 28146' -P /root/VT/_vtest_tmp/vtc.56372.293cc9ef/v1/varnishd.pid -p vmod_path=/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_std/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_debug/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_directors/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_purge/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_vtc/.libs:/root/VT/varnish-cache/varnish-trunk/_build/sub/lib/libvmod_blob/.libs
***  v1    0.0 PID: 56388
**** v1    0.0 macro def v1_pid=56388
**** v1    0.0 macro def v1_name=/root/VT/_vtest_tmp/vtc.56372.293cc9ef/v1
***  v1    0.0 debug|Debug: Platform: FreeBSD,11.1-RELEASE-p4,amd64,-junix,-sdefault,-sdefault,-hcritbit
***  v1    0.0 debug|200 317
***  v1    0.0 debug|-----------------------------
***  v1    0.0 debug|Varnish Cache CLI 1.0
***  v1    0.0 debug|-----------------------------
***  v1    0.0 debug|FreeBSD,11.1-RELEASE-p4,amd64,-junix,-sdefault,-sdefault,-hcritbit
***  v1    0.0 debug|varnish-trunk revision 4e1699f6b0046d358c0d60d733a2b9479634d5d3
***  v1    0.0 debug|
***  v1    0.0 debug|Type 'help' for command list.
***  v1    0.0 debug|Type 'quit' to close CLI session.
***  v1    0.0 debug|Type 'start' to launch worker process.
***  v1    0.0 debug|
**** v1   20.0 CLIPOLL 0 0x0 0x0
---- v1   20.0 FAIL timeout waiting for CLI connection
*    top  20.0 RESETTING after ../../../../bin/varnishtest/tests/c00049.vtc
**   s1   20.0 Waiting for server (3/-1)
**** s1   20.0 macro undef s1_addr
**** s1   20.0 macro undef s1_port
**** s1   20.0 macro undef s1_sock
**   v1   20.0 Wait
**** v1   20.0 CLI TX|panic.clear
***  v1   34.3 CLI RX  400
**** v1   34.3 CLI RX|CLI communication error (hdr)
---- v1   34.3 Unexpected panic
*    top  34.3 failure during reset
#    top  TEST ../../../../bin/varnishtest/tests/c00049.vtc FAILED (34.317) exit=2
FAIL tests/c00049.vtc (exit status: 2)

Not true: bans_added (5) == 6 (6)

1 @ SunOS i86pc 5.11 1.04 64_gcc4.7 uplex

*    top   0.0 TEST ../../../bin/varnishtest/tests/c00049.vtc starting
[...]
*    top   0.0 TEST New ban-lurker test
[...]
**   v1    1.6 as expected: bans_completed (1) == 1
**   top   1.6 === varnish v1 -expect bans_req == 1
**   v1    1.6 as expected: bans_req (1) == 1
**   top   1.6 === varnish v1 -expect bans_obj == 4
**   v1    1.6 as expected: bans_obj (4) == 4
**   top   1.6 === varnish v1 -expect bans_added == 6
**** v1    1.7 vsl|          0 CLI             - Rd ban.list
**** v1    1.7 vsl|          0 CLI             - Wr 200 464 Present bans:
1512596738.089035     1 --O 5deb50   obj.http.foo == bar6
oc = 67b910
1512596738.077562     1 --O 5debb0   obj.http.foo == bar5
oc = 67b9d0
1512596738.066010     1 -R- 5dec10   req.http.kill == yes
oc = 67ba90
1512596738.05
**** v1    1.7 vsl|          0 Debug           - lurker: sleep = 49.620000
**** v1    3.5 vsl|          0 CLI             - Rd ping
**** v1    3.5 vsl|          0 CLI             - Wr 200 19 PONG 1512596740 1.0
**** v1    6.5 vsl|          0 CLI             - Rd ping
**** v1    6.5 vsl|          0 CLI             - Wr 200 19 PONG 1512596743 1.0
---- v1    6.6 Not true: bans_added (5) == 6 (6)
*    top   6.6 RESETTING after ../../../bin/varnishtest/tests/c00049.vtc
**   s1    6.6 Waiting for server (3/-1)
**** s1    6.6 macro undef s1_addr
**** s1    6.6 macro undef s1_port
**** s1    6.6 macro undef s1_sock
**   v1    6.6 Wait
**** v1    6.6 CLI TX|panic.clear
***  v1    6.6 CLI RX  300
**** v1    6.6 CLI RX|No panic to clear
***  v1    6.6 debug|Info: manager stopping child
***  v1    6.6 debug|Debug: Stopping Child
**** v1    6.7 vsl|          0 CLI             - EOF on CLI connection, worker stops
***  v1    7.6 debug|Info: Child (28571) ended
***  v1    7.6 debug|Info: Child (28571) said Child dies
***  v1    7.6 debug|Debug: Child cleanup complete
***  v1    7.6 debug|
***  v1    7.6 debug|Info:
***  v1    7.6 debug|manager dies
**** v1    7.6 STDOUT poll 0x10