[Varnish] #960: Test suite not working on a single cpu host on linux

Varnish varnish-bugs at varnish-cache.org
Wed Jul 13 16:23:58 CEST 2011


#960: Test suite not working on a single cpu host on linux
---------------------+------------------------------------------------------
 Reporter:  pmialon  |        Type:  defect
   Status:  new      |    Priority:  normal
Milestone:           |   Component:  build 
  Version:  3.0.0    |    Severity:  normal
 Keywords:           |  
---------------------+------------------------------------------------------
 the following command will fail with a single CPU (KVM) under debian
 squeeze amd64 using latest git source.
 {{{
 ./varnishtest -i -j3 ./tests/*.vtc
 [...]
 #     top  TEST ./tests/c00005.vtc passed (1.508)
 **** top   0.0 macro def varnishd=../varnishd/varnishd
 **** top   0.0 macro def pwd=/root/varnish-cache/bin/varnishtest
 **** top   0.0 macro def topbuild=/root/varnish-
 cache/bin/varnishtest/../..
 **** top   0.0 macro def bad_ip=10.255.255.255
 **** top   0.0 macro def tmpdir=/tmp/vtc.16778.497ee3c7
 *    top   0.0 TEST ./tests/c00002.vtc starting
 ***  top   0.0 varnishtest
 *    top   0.0 TEST Check that all thread pools all get started and get
 minimum threads
 ***  top   0.0 server
 **   s1    0.0 Starting server
 **** s1    0.0 macro def s1_addr=127.0.0.1
 **** s1    0.0 macro def s1_port=32617
 **** s1    0.0 macro def s1_sock=127.0.0.1 32617
 *    s1    0.0 Listen on 127.0.0.1 32617
 ***  top   0.0 varnish
 **   s1    0.0 Started on 127.0.0.1 32617
 ***  top   0.0 varnish
 **   v1    0.0 Launch
 ***  v1    0.0 CMD: cd ${pwd} && ${varnishd} -d -d -n
 /tmp/vtc.16778.497ee3c7/v1 -l 10m,1m,- -p auto_restart=off -p
 syslog_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.16778.497ee3c7/v1/_S
 -M '127.0.0.1 33876' -P /tmp/vtc.16778.497ee3c7/v1/varnishd.pid
 -sfile,/tmp/vtc.16778.497ee3c7/v1,10M  -p thread_pool_min=2 -p
 thread_pool_max=8 -p thread_pools=4 -p thread_pool_purge_delay=10
 ***  v1    0.0 CMD: cd /root/varnish-cache/bin/varnishtest &&
 ../varnishd/varnishd -d -d -n /tmp/vtc.16778.497ee3c7/v1 -l 10m,1m,- -p
 auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S
 /tmp/vtc.16778.497ee3c7/v1/_S -M '127.0.0.1 33876' -P
 /tmp/vtc.16778.497ee3c7/v1/varnishd.pid
 -sfile,/tmp/vtc.16778.497ee3c7/v1,10M  -p thread_pool_min=2 -p
 thread_pool_max=8 -p thread_pools=4 -p thread_pool_purge_delay=10
 ***  v1    0.0 PID: 19068
 ***  v1    0.4 debug| SMF.s0: filename:
 /tmp/vtc.16778.497ee3c7/v1/varnish.0miJ86 size 10 MB.\n
 ***  v1    0.4 debug| Platform:
 Linux,2.6.32-5-amd64,x86_64,-sfile,-smalloc,-hcritbit\n
 ***  v1    0.4 debug| 200 240     \n
 ***  v1    0.4 debug| -----------------------------\n
 ***  v1    0.4 debug| Varnish Cache CLI 1.0\n
 ***  v1    0.4 debug| -----------------------------\n
 ***  v1    0.4 debug|
 Linux,2.6.32-5-amd64,x86_64,-sfile,-smalloc,-hcritbit\n
 ***  v1    0.4 debug| \n
 ***  v1    0.4 debug| Type 'help' for command list.\n
 ***  v1    0.4 debug| Type 'quit' to close CLI session.\n
 ***  v1    0.4 debug| Type 'start' to launch worker process.\n
 ***  v1    0.4 debug| \n
 **** v1    0.5 CLIPOLL 1 0x1 0x0
 ***  v1    0.5 CLI connection fd = 6
 ***  v1    0.5 CLI RX  107
 **** v1    0.5 CLI RX| jqvtgditfsvwtpgqgetgzowufuvulqaw\n
 **** v1    0.5 CLI RX| \n
 **** v1    0.5 CLI RX| Authentication required.\n
 **** v1    0.5 CLI TX| auth
 1898c9f143fe0f2f1de712e99618a8147342f62ca0bc43bd617d5049ca5a0f48\n
 ***  v1    0.5 CLI RX  200
 **** v1    0.5 CLI RX| -----------------------------\n
 **** v1    0.5 CLI RX| Varnish Cache CLI 1.0\n
 **** v1    0.5 CLI RX| -----------------------------\n
 **** v1    0.5 CLI RX|
 Linux,2.6.32-5-amd64,x86_64,-sfile,-smalloc,-hcritbit\n
 **** v1    0.5 CLI RX| \n
 **** v1    0.5 CLI RX| Type 'help' for command list.\n
 **** v1    0.5 CLI RX| Type 'quit' to close CLI session.\n
 **** v1    0.5 CLI RX| Type 'start' to launch worker process.\n
 **** v1    0.5 CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
 **** v1    0.5 CLI TX| backend s1 { .host = "127.0.0.1"; .port = "32617";
 }\n
 **** v1    0.5 CLI TX| \n
 **** v1    0.5 CLI TX| \n
 **** v1    0.5 CLI TX| %XJEIFLH|)Xspa8P\n
 ***  v1    1.0 CLI RX  200
 **** v1    1.0 CLI RX| VCL compiled.
 **** v1    1.0 CLI TX| vcl.use vcl1
 ***  v1    1.0 CLI RX  200
 **   v1    1.0 Start
 **** v1    1.0 CLI TX| start
 ***  v1    1.0 debug| child (19137) Started\n
 ***  v1    1.0 CLI RX  200
 **** v1    1.0 CLI TX| debug.xid 1000
 ***  v1    1.0 debug| Child (19137) said Child starts\n
 ***  v1    1.0 debug| Child (19137) said SMF.s0 mmap'ed 10485760 bytes of
 10485760\n
 ***  v1    1.1 CLI RX  200
 **** v1    1.1 CLI RX| XID is 1000
 **** v1    1.1 CLI TX| debug.listen_address
 ***  v1    1.1 CLI RX  200
 **** v1    1.1 CLI RX| 127.0.0.1 42597\n
 **   v1    1.1 Listen on 127.0.0.1 42597
 **** v1    1.1 macro def v1_addr=127.0.0.1
 **** v1    1.1 macro def v1_port=42597
 **** v1    1.1 macro def v1_sock=127.0.0.1 42597
 ***  top   1.1 client
 **   c1    1.1 Starting client
 **   c1    1.1 Waiting for client
 ***  c1    1.1 Connect to 127.0.0.1 42597
 ***  c1    1.1 connected fd 9 from 127.0.0.1 60805 to 127.0.0.1 42597
 ***  c1    1.1 txreq
 **** c1    1.1 txreq| GET / HTTP/1.1\r\n
 **** c1    1.1 txreq| \r\n
 ***  s1    1.1 accepted fd 4
 ***  s1    1.1 rxreq
 **** s1    1.1 rxhdr| GET / HTTP/1.1\r\n
 **** s1    1.1 rxhdr| X-Forwarded-For: 127.0.0.1\r\n
 **** s1    1.1 rxhdr| X-Varnish: 1001\r\n
 **** s1    1.1 rxhdr| Accept-Encoding: gzip\r\n
 **** s1    1.1 rxhdr| Host: 127.0.0.1\r\n
 **** s1    1.1 rxhdr| \r\n
 **** s1    1.1 http[ 0] | GET
 **** s1    1.1 http[ 1] | /
 **** s1    1.1 http[ 2] | HTTP/1.1
 **** s1    1.1 http[ 3] | X-Forwarded-For: 127.0.0.1
 **** s1    1.1 http[ 4] | X-Varnish: 1001
 **** s1    1.1 http[ 5] | Accept-Encoding: gzip
 **** s1    1.1 http[ 6] | Host: 127.0.0.1
 **** s1    1.1 bodylen = 0
 ***  s1    1.1 txresp
 **** s1    1.1 txresp| HTTP/1.1 200 Ok\r\n
 **** s1    1.1 txresp| Connection: close\r\n
 **** s1    1.1 txresp| Content-Length: 7\r\n
 **** s1    1.1 txresp| \r\n
 **** s1    1.1 txresp| 012345\n
 ***  s1    1.1 shutting fd 4
 **   s1    1.1 Ending
 ***  c1    1.1 rxresp
 **** c1    1.1 rxhdr| HTTP/1.1 200 Ok\r\n
 **** c1    1.1 rxhdr| Content-Length: 7\r\n
 **** c1    1.1 rxhdr| Accept-Ranges: bytes\r\n
 **** c1    1.1 rxhdr| Date: Wed, 13 Jul 2011 14:22:52 GMT\r\n
 **** c1    1.1 rxhdr| X-Varnish: 1001\r\n
 **** c1    1.1 rxhdr| Age: 0\r\n
 **** c1    1.1 rxhdr| Via: 1.1 varnish\r\n
 **** c1    1.1 rxhdr| Connection: keep-alive\r\n
 **** c1    1.1 rxhdr| \r\n
 **** c1    1.1 http[ 0] | HTTP/1.1
 **** c1    1.1 http[ 1] | 200
 **** c1    1.1 http[ 2] | Ok
 **** c1    1.1 http[ 3] | Content-Length: 7
 **** c1    1.1 http[ 4] | Accept-Ranges: bytes
 **** c1    1.1 http[ 5] | Date: Wed, 13 Jul 2011 14:22:52 GMT
 **** c1    1.1 http[ 6] | X-Varnish: 1001
 **** c1    1.1 http[ 7] | Age: 0
 **** c1    1.1 http[ 8] | Via: 1.1 varnish
 **** c1    1.1 http[ 9] | Connection: keep-alive
 **** c1    1.1 body| 012345\n
 **** c1    1.1 bodylen = 7
 ***  c1    1.1 expect
 **** c1    1.1 EXPECT resp.status (200) == 200 (200) match
 ***  c1    1.1 closing fd 9
 **   c1    1.1 Ending
 ***  top   1.1 varnish
 ---- v1    2.1 Not true: n_wrk (14) == 8 (8)
 *    top   2.1 RESETTING after ./tests/c00002.vtc
 **   s1    2.1 Waiting for server
 **** s1    2.1 macro undef s1_addr
 **** s1    2.1 macro undef s1_port
 **** s1    2.1 macro undef s1_sock
 **   v1    3.1 Wait
 **   v1    3.1 R 19068 Status: 0000
 *    top   3.1 TEST ./tests/c00002.vtc FAILED

 #     top  TEST ./tests/c00002.vtc FAILED (3.112)

 }}}

 but if we launch :

 {{{ ./varnishtest -i ./tests/*.vtc }}}


 The suite test pass.

-- 
Ticket URL: <http://varnish-cache.org/trac/ticket/960>
Varnish <http://varnish-cache.org/>
The Varnish HTTP Accelerator




More information about the varnish-bugs mailing list