Migration to Cygwin plataform

Jorge Díaz jdzstz at gmail.com
Fri Dec 17 03:54:55 CET 2010


Hello,

I have updated my version of varnish for cygwin. It is based on subversion
trunk (r5646 <http://varnish-cache.org/trac/changeset/5646>)

More information about Cygwin modifications are in Ticket 736:
http://varnish-cache.org/trac/ticket/736

The new improvements are:

   - *Better compilation of VCL archives* (in the past they were compiled
   using objects from varnish compilation directory)
   - *Fixed regresion tests:* varnishtest program server_thread function in
   vtc_server.c, after "fd = accept(s->sock, addr, &l);" If socket returned
   is wrong, it is not used.
   - *Fixed regresion tests:* varnishtest program is blocked in some tests.
   Test is executed succesfully  but varnishtest program is blocked when it
   stops server thread, so varnishtest timeouts and FAILS.
      - Server thread is blocked in TCP accept, waiting a
      request (server_thread function in vtc_server.c file) and main
varnishtest
      is blocked in pthread_join (server_wait function in vtc_server.c file)
      waiting server thread to end.
      - In linux, pthread_join unblocks thread from its TCP accept but in
      Cygwin it does not.
      - The solution is to send a signal using pthread_kill (only in
      cygwin). The signal unblocks thread from its TCP accept.

*I have tested varnish cache in cygwin against one apache server and it
works fine. The patch applied in a Solaris and Linux server works properly.*

After this changes, the result of regression test are: 9 tests failed, 202
tests passed


*Failed tests:*

*c00005.vtc "Test simple ACL"*

   - error IPv6 [DNS lookup(::): hostname nor servname provided, or not
   known\n]
   - CYGWIN does not support IPv6 in Windows XP. Maybe it works in newer
   versions

*s00002.vtc "Check grace with sick backends"*

   - "Write failed: Bad file descriptor"
   - UNKNOWN ERROR

*b00015.vtc "Check synthetic error page caching"  and  v00009.vtc "Test
round robin director" *

   - bind(): Address already in use  [Assert error in server_start(),
   vtc_server.c line 183: Condition(s->sock >= 0) not true.]
   - UNKNOWN ERROR: test server is started two times, the second time it
   says that port it is in use

*VMOD regresion tests:  m00000.vtc, m00001.vtc, m00002.vtc, m00003.vtc and
m00004.vtc *

   - CYGWIN does not find new VMOD shared libraries
   - A fix is need in order to load shared libraries of VMOD

LIST OF FAILED TESTS:

#     top  TEST tests/b00015.vtc FAILED (7.039)
#     top  TEST tests/c00005.vtc FAILED (7.766)
#     top  TEST tests/m00000.vtc FAILED (3.131)
#     top  TEST tests/m00001.vtc FAILED (3.007)
#     top  TEST tests/m00002.vtc FAILED (2.830)
#     top  TEST tests/m00003.vtc FAILED (2.894)
#     top  TEST tests/m00004.vtc FAILED (3.279)
#     top  TEST tests/s00002.vtc FAILED (9.977)
#     top  TEST tests/v00009.vtc FAILED (5.509)





2010/7/28 Jorge Díaz <jdzstz at gmail.com>


> I have apply all my changes to svn trunk version of varnish.
> I attach it to email. Can I commit myself to subversion?
>
> With varnish trunk version I have executed regression tests and this is the
> result:
>
>
> 8 of 183 tests failed
>
> They are:
>
> FAIL: ./tests/b00004.vtc
> FAIL: ./tests/b00015.vtc
> FAIL: ./tests/b00030.vtc
> FAIL: ./tests/c00005.vtc
> FAIL: ./tests/p00002.vtc
> FAIL: ./tests/r00558.vtc
> FAIL: ./tests/v00009.vtc
> FAIL: ./tests/v00027.vtc
>
> I also attach regression test logs to email.
>
> Some of that error are [ *    top  Test timed out ]  Do you know some issue
> with timeout in regression tests?
>
>
> 2010/7/21 Jorge Díaz <jdzstz at gmail.com>
>
>
>> After one small change in configure.ac (I have added file
>> "varnishd-cache_vrt_re.o" to VCC_C command) the VCL compilation problem has
>> disappear and now regression tests problems are only 9:
>>  *9 of 174 tests failed*
>>
>>
>> I attach the new version.
>>
>> I continue having problems of "bind(): Address already in use"
>>
>> *Which ports does regression tests need to be free?? perhaps I have to
>> stop some software of my machine *
>>
>>  Assert error in server_start(), vtc_server.c line 181:
>>   Condition(s->sock >= 0) not true.
>>   errno = 112 (Address already in use)
>>
>> /bin/sh: line 5:  3376 Aborted                 (core dumped) ./varnishtest
>> ${dir}$tst
>> FAIL: ./tests/v00014.vtc
>>
>> *I also need somebody to test script modifications in Linux. I have
>> tested in my Solaris enviroment and it is ok.*
>>
>> Thank you.
>>
>>  2010/7/21 Jorge Díaz <jdzstz at gmail.com>
>>
>>
>>> Hello,
>>>
>>> After some problems launching regression tests, I have changed VCC_CC
>>> definition in configure.ac for Cygwin platform, and now cc_command
>>> parameter is not needed for varnishd.
>>>
>>> Now, I am able to execute all regression tests, with some errors.
>>>
>>>
>>>
>>> I have executed the tests and this is the result:
>>>
>>> *14 of 174 tests failed*
>>>
>>>
>>> I have some problems with in-use ports:
>>>
>>>
>>> bind(): Address already in use
>>> Assert error in server_start(), vtc_server.c line 181:
>>> Condition(s->sock >= 0) not true.
>>> errno = 112 (Address already in use)
>>> /bin/sh: line 5: 5836 Aborted (core dumped) ./varnishtest
>>>
>>> *Which ports does regression tests need to be free?? perhaps I have to
>>> stop some software of my machine *
>>>
>>>
>>>
>>> I have also detected some problems with VCL compilation for complex
>>> configuration files:
>>>
>>> #### v1   CLI RX| /tmp/ccA54nFN.o:vcl.hfK6_VaS.c:(.text+0x59): undefined reference to `_VRT_re_match'\n
>>> #### v1 CLI RX| /tmp/ccA54nFN.o:vcl.hfK6_VaS.c:(.text+0xc0): undefined reference to `_VRT_re_match'\n
>>> #### v1 CLI RX| /tmp/ccA54nFN.o:vcl.hfK6_VaS.c:(.text+0x628): undefined reference to `_VRT_re_init'\n
>>> #### v1 CLI RX| /tmp/ccA54nFN.o:vcl.hfK6_VaS.c:(.text+0x63c): undefined reference to `_VRT_re_init'\n
>>> #### v1 CLI RX| /tmp/ccA54nFN.o:vcl.hfK6_VaS.c:(.text+0x667): undefined reference to `_VRT_re_fini'\n
>>> #### v1 CLI RX| /tmp/ccA54nFN.o:vcl.hfK6_VaS.c:(.text+0x674): undefined reference to `_VRT_re_fini'\n
>>>
>>>
>>> I think I have to add some dependencies to VCC_CC.
>>>
>>> The final results are:
>>>
>>>
>>>     - Solaris - Varnish 2.1.2 release : 20 of 174 tests failed
>>>
>>>    - Solaris - Varnish 2.1.2 + conditional cygwin modifications : 20 of
>>>    174 tests failed
>>>
>>>    - Cygwin - Varnish 2.1.2 + conditional cygwin modifications : 14 of
>>>    174 tests failed
>>>
>>> I attach to the email and Trac ticket last version of my modifications.
>>>
>>>
>>>
>>>
>>>
>>>  2010/7/21 Poul-Henning Kamp <phk at phk.freebsd.dk>
>>>
>>>
>>>> In message <
>>>> AANLkTinVE1zQvFBRIcTCEyNz-SKg5J2GFq1SK0cgr6hU at mail.gmail.com>, =?IS
>>>>
>>>> O-8859-1?Q?Jorge_D=EDaz?= writes:
>>>>
>>>>
>>>> >But I have to change it and recompile all Varnish, or is there any
>>>> parameter
>>>> >for regression tests like varnishd?
>>>>
>>>>
>>>> You have to compile it in from the start.
>>>>
>>>> The regression test assume that you have a functioning varnishd binary.
>>>>
>>>> --
>>>>
>>>>  Poul-Henning Kamp       | UNIX since Zilog Zeus 3.20
>>>> phk at FreeBSD.ORG         | TCP/IP since RFC 956
>>>> FreeBSD committer       | BSD since 4.3-tahoe
>>>> Never attribute to malice what can adequately be explained by
>>>> incompetence.
>>>>
>>>>
>>>
>>>
>>
>>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://www.varnish-cache.org/lists/pipermail/varnish-dev/attachments/20101217/96d5594e/attachment-0003.html>
-------------- next part --------------
$ varnishtest -j 1 -k tests/*.vtc
#     top  TEST tests/a00000.vtc passed (0.114)
#     top  TEST tests/a00001.vtc passed (0.079)
#     top  TEST tests/a00002.vtc passed (0.076)
#     top  TEST tests/a00003.vtc passed (0.074)
#     top  TEST tests/a00004.vtc passed (0.098)
#     top  TEST tests/a00005.vtc passed (0.077)
#     top  TEST tests/a00006.vtc passed (0.073)
#     top  TEST tests/a00007.vtc passed (0.076)
#     top  TEST tests/a00008.vtc passed (1.972)
#     top  TEST tests/a00009.vtc passed (3.325)
#     top  TEST tests/a00010.vtc passed (0.078)
#     top  TEST tests/b00000.vtc passed (5.260)
#     top  TEST tests/b00001.vtc passed (5.373)
#     top  TEST tests/b00002.vtc passed (5.146)
#     top  TEST tests/b00003.vtc passed (5.129)
#     top  TEST tests/b00004.vtc passed (9.165)
#     top  TEST tests/b00005.vtc passed (5.637)
#     top  TEST tests/b00006.vtc passed (9.031)
#     top  TEST tests/b00007.vtc passed (5.323)
#     top  TEST tests/b00008.vtc passed (5.042)
#     top  TEST tests/b00009.vtc passed (4.803)
#     top  TEST tests/b00010.vtc passed (4.779)
#     top  TEST tests/b00011.vtc passed (4.572)
#     top  TEST tests/b00012.vtc passed (4.732)
#     top  TEST tests/b00013.vtc passed (4.834)
#     top  TEST tests/b00014.vtc passed (6.404)
######## tests/b00015.vtc ########
bind(): Address already in use
Assert error in server_start(), vtc_server.c line 202:
  Condition(s->sock >= 0) not true.
  errno = 112 (Address already in use)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.2dbf747d
*    top  TEST tests/b00015.vtc starting
***  top  test
*    top  TEST Check synthetic error page caching
***  top  varnish
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.2dbf747d/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.2dbf747d/v1/_S -M '127.0.0.1 2977' -P /tmp/vtc.2740.2dbf747d/v1/varnishd.pid -sfile,/tmp/vtc.2740.2dbf747d/v1,10M
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.2dbf747d/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.2dbf747d/v1/_S -M '127.0.0.1 2977' -P /tmp/vtc.2740.2dbf747d/v1/varnishd.pid -sfile,/tmp/vtc.2740.2dbf747d/
v1,10M
***  v1   PID: 7344
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.2dbf747d/v1/varnish.jE4WU6 size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 4
***  v1   CLI RX  107
**** v1   CLI RX| ehdjcqmjskelrnqjcbnpohwmoxpvqquw\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 2151afd270367d0a7e40ef6c46cfc7c7964a0f66991d029ada2bdb42439aebb1\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX|  \n
**** v1   CLI TX| \tbackend foo {\n
**** v1   CLI TX| \t\t.host = "10.255.255.255"; .port = "9080";\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  200
**** v1   CLI RX| VCL compiled.
**** v1   CLI TX| vcl.use vcl1
***  v1   CLI RX  200
**   v1   Start
**** v1   CLI TX| start
***  v1   debug| child (1532) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   debug| Child (1532) said \n
***  v1   debug| Child (1532) said Child starts\n
***  v1   debug| Child (1532) said SMF.s0 mmap'ed 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 2979\n
**   v1   Listen on 127.0.0.1 2979
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=2979
**** v1   macro def v1_sock=127.0.0.1 2979
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1 2979
***  c1   connected fd 7 from 127.0.0.1 2980 to 127.0.0.1 2979
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
**** c1   rxhdr| HTTP/1.1 503 Service Unavailable\r\n
**** c1   rxhdr| Server: Varnish\r\n
**** c1   rxhdr| Retry-After: 0\r\n
**** c1   rxhdr| Content-Type: text/html; charset=utf-8\r\n
**** c1   rxhdr| Content-Length: 413\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:24:23 GMT\r\n
**** c1   rxhdr| X-Varnish: 1001\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: close\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 503
**** c1   http[ 2] | Service Unavailable
**** c1   http[ 3] | Server: Varnish
**** c1   http[ 4] | Retry-After: 0
**** c1   http[ 5] | Content-Type: text/html; charset=utf-8
**** c1   http[ 6] | Content-Length: 413
**** c1   http[ 7] | Date: Thu, 16 Dec 2010 23:24:23 GMT
**** c1   http[ 8] | X-Varnish: 1001
**** c1   http[ 9] | Age: 0
**** c1   http[10] | Via: 1.1 varnish
**** c1   http[11] | Connection: close
**** c1   body| \n
**** c1   body| <?xml version="1.0" encoding="utf-8"?>\n
**** c1   body| <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Strict//EN"\n
**** c1   body|  "http://www.w3.org/TR/xhtml1/DTD/xhtml1-strict.dtd">\n
**** c1   body| <html>\n
**** c1   body|   <head>\n
**** c1   body|     <title>503 Service Unavailable</title>\n
**** c1   body|   </head>\n
**** c1   body|   <body>\n
**** c1   body|     <h1>Error 503 Service Unavailable</h1>\n
**** c1   body|     <p>Service Unavailable</p>\n
**** c1   body|     <h3>Guru Meditation:</h3>\n
**** c1   body|     <p>XID: 1001</p>\n
**** c1   body|     <hr>\n
**** c1   body|     <p>Varnish cache server</p>\n
**** c1   body|   </body>\n
**** c1   body| </html>\n
**** c1   bodylen = 413
***  c1   expect
**** c1   EXPECT resp.status (503) == 503 (503) match
***  c1   expect
**** c1   EXPECT resp.http.X-varnish (1001) == 1001 (1001) match
***  c1   closing fd 7
**   c1   Ending
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1 2979
***  c1   connected fd 7 from 127.0.0.1 2982 to 127.0.0.1 2979
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
**** c1   rxhdr| HTTP/1.1 503 Service Unavailable\r\n
**** c1   rxhdr| Server: Varnish\r\n
**** c1   rxhdr| Retry-After: 0\r\n
**** c1   rxhdr| Content-Type: text/html; charset=utf-8\r\n
**** c1   rxhdr| Content-Length: 413\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:24:23 GMT\r\n
**** c1   rxhdr| X-Varnish: 1002\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: close\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 503
**** c1   http[ 2] | Service Unavailable
**** c1   http[ 3] | Server: Varnish
**** c1   http[ 4] | Retry-After: 0
**** c1   http[ 5] | Content-Type: text/html; charset=utf-8
**** c1   http[ 6] | Content-Length: 413
**** c1   http[ 7] | Date: Thu, 16 Dec 2010 23:24:23 GMT
**** c1   http[ 8] | X-Varnish: 1002
**** c1   http[ 9] | Age: 0
**** c1   http[10] | Via: 1.1 varnish
**** c1   http[11] | Connection: close
**** c1   body| \n
**** c1   body| <?xml version="1.0" encoding="utf-8"?>\n
**** c1   body| <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Strict//EN"\n
**** c1   body|  "http://www.w3.org/TR/xhtml1/DTD/xhtml1-strict.dtd">\n
**** c1   body| <html>\n
**** c1   body|   <head>\n
**** c1   body|     <title>503 Service Unavailable</title>\n
**** c1   body|   </head>\n
**** c1   body|   <body>\n
**** c1   body|     <h1>Error 503 Service Unavailable</h1>\n
**** c1   body|     <p>Service Unavailable</p>\n
**** c1   body|     <h3>Guru Meditation:</h3>\n
**** c1   body|     <p>XID: 1002</p>\n
**** c1   body|     <hr>\n
**** c1   body|     <p>Varnish cache server</p>\n
**** c1   body|   </body>\n
**** c1   body| </html>\n
**** c1   bodylen = 413
***  c1   expect
**** c1   EXPECT resp.status (503) == 503 (503) match
***  c1   expect
**** c1   EXPECT resp.http.X-varnish (1002) == 1002 (1002) match
***  c1   closing fd 7
**   c1   Ending
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=2984
**** s1   macro def s1_sock=127.0.0.1 2984
*    s1   Listen on 127.0.0.1 2984
***  top  varnish
**   s1   Started on 127.0.0.1 2984
**** v1   CLI TX| vcl.inline vcl2 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "2984"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX|  \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  200
**** v1   CLI RX| VCL compiled.
**** v1   CLI TX| vcl.use vcl2
***  v1   CLI RX  200
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1 2979
***  c1   connected fd 8 from 127.0.0.1 2985 to 127.0.0.1 2979
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s1   accepted fd 9
***  s1   rxreq
**** s1   rxhdr| GET / HTTP/1.1\r\n
**** s1   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s1   rxhdr| X-Varnish: 1003\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s1   http[ 4] | X-Varnish: 1003
**** s1   http[ 5] | Host: 127.0.0.1
**** s1   bodylen = 0
***  s1   txresp
**** s1   txresp| HTTP/1.1 302 Ok\r\n
**** s1   txresp| Content-Length: 0\r\n
**** s1   txresp| \r\n
***  s1   shutting fd 9
**   s1   Ending
**** c1   rxhdr| HTTP/1.1 302 Ok\r\n
**** c1   rxhdr| Content-Length: 0\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:24:24 GMT\r\n
**** c1   rxhdr| X-Varnish: 1003\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 302
**** c1   http[ 2] | Ok
**** c1   http[ 3] | Content-Length: 0
**** c1   http[ 4] | Date: Thu, 16 Dec 2010 23:24:24 GMT
**** c1   http[ 5] | X-Varnish: 1003
**** c1   http[ 6] | Age: 0
**** c1   http[ 7] | Via: 1.1 varnish
**** c1   http[ 8] | Connection: keep-alive
**** c1   bodylen = 0
***  c1   expect
**** c1   EXPECT resp.status (302) == 302 (302) match
***  c1   expect
**** c1   EXPECT resp.http.X-varnish (1003) == 1003 (1003) match
***  c1   closing fd 8
**   c1   Ending
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1 2979
***  c1   connected fd 8 from 127.0.0.1 2987 to 127.0.0.1 2979
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
**** c1   rxhdr| HTTP/1.1 302 Ok\r\n
**** c1   rxhdr| Content-Length: 0\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:24:24 GMT\r\n
**** c1   rxhdr| X-Varnish: 1004 1003\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 302
**** c1   http[ 2] | Ok
**** c1   http[ 3] | Content-Length: 0
**** c1   http[ 4] | Date: Thu, 16 Dec 2010 23:24:24 GMT
**** c1   http[ 5] | X-Varnish: 1004 1003
**** c1   http[ 6] | Age: 0
**** c1   http[ 7] | Via: 1.1 varnish
**** c1   http[ 8] | Connection: keep-alive
**** c1   bodylen = 0
***  c1   expect
**** c1   EXPECT resp.status (302) == 302 (302) match
***  c1   expect
**** c1   EXPECT resp.http.X-varnish (1004 1003) == 1004 1003 (1004 1003) match
***  c1   closing fd 8
**   c1   Ending
***  top  server
**   s1   Waiting for server
**   s1   Starting server

#     top  TEST tests/b00015.vtc FAILED (7.039)
#     top  TEST tests/b00016.vtc passed (7.840)
#     top  TEST tests/b00017.vtc passed (4.717)
#     top  TEST tests/b00018.vtc passed (4.760)
#     top  TEST tests/b00019.vtc passed (4.728)
#     top  TEST tests/b00020.vtc passed (0.040)
#     top  TEST tests/b00021.vtc passed (0.048)
#     top  TEST tests/b00022.vtc passed (0.040)
#     top  TEST tests/b00023.vtc passed (0.040)
#     top  TEST tests/b00024.vtc passed (0.042)
#     top  TEST tests/b00025.vtc passed (0.044)
#     top  TEST tests/b00026.vtc passed (0.042)
#     top  TEST tests/b00027.vtc passed (4.990)
#     top  TEST tests/b00028.vtc passed (4.815)
#     top  TEST tests/b00029.vtc passed (7.423)
#     top  TEST tests/b00030.vtc passed (5.113)
#     top  TEST tests/b00031.vtc passed (5.215)
#     top  TEST tests/b00032.vtc passed (1.813)
#     top  TEST tests/b00033.vtc passed (5.225)
#     top  TEST tests/c00001.vtc passed (5.087)
#     top  TEST tests/c00002.vtc passed (5.099)
#     top  TEST tests/c00003.vtc passed (4.685)
#     top  TEST tests/c00004.vtc passed (5.407)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.6bcdc30c
*    top  TEST tests/c00005.vtc starting
***  top  test
*    top  TEST Test simple ACL
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=3075
**** s1   macro def s1_sock=127.0.0.1 3075
*    s1   Listen on 127.0.0.1 3075
**   s1   Started on 127.0.0.1 3075
***  top  varnish
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.6bcdc30c/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.6bcdc30c/v1/_S -M '127.0.0.1 3076' -P /tmp/vtc.2740.6bcdc30c/v1/varnishd.pid -sfile,/tmp/vtc.2740.6bcdc30c/v1,10M  -p vcl_trace=on
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.6bcdc30c/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.6bcdc30c/v1/_S -M '127.0.0.1 3076' -P /tmp/vtc.2740.6bcdc30c/v1/varnishd.pid -sfile,/tmp/vtc.2740.6bcdc30c/
v1,10M  -p vcl_trace=on
***  v1   PID: 9088
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.6bcdc30c/v1/varnish.OPTwcp size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 5
***  v1   CLI RX  107
**** v1   CLI RX| wcizeobkdybemlstzjwkosqkvqjqhjbg\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth dbcbe79e9b49dd19cddb16a353923001bb06aa612e9c9e2ad7eb7b65200d747f\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "3075"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \tacl acl1 {\n
**** v1   CLI TX| \t\t"localhost";\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_recv {\n
**** v1   CLI TX| \t\tif (client.ip ~ acl1) {\n
**** v1   CLI TX| \t\t\tset req.url = "/";\n
**** v1   CLI TX| \t\t}\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  200
**** v1   CLI RX| VCL compiled.
**** v1   CLI TX| vcl.use vcl1
***  v1   CLI RX  200
**   v1   Start
**** v1   CLI TX| start
***  v1   debug| child (1556) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   debug| Child (1556) said \n
***  v1   debug| Child (1556) said Child starts\n
***  v1   debug| Child (1556) said SMF.s0 mmap'ed 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 3078\n
**   v1   Listen on 127.0.0.1 3078
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=3078
**** v1   macro def v1_sock=127.0.0.1 3078
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1 3078
***  c1   connected fd 8 from 127.0.0.1 3079 to 127.0.0.1 3078
***  c1   txreq
**** c1   txreq| GET foo HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s1   accepted fd 9
***  s1   rxreq
**** s1   rxhdr| GET / HTTP/1.1\r\n
**** s1   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s1   rxhdr| X-Varnish: 1001\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s1   http[ 4] | X-Varnish: 1001
**** s1   http[ 5] | Host: 127.0.0.1
**** s1   bodylen = 0
***  s1   expect
**** s1   EXPECT req.url (/) == / (/) match
***  s1   txresp
**** s1   txresp| HTTP/1.1 200 Ok\r\n
**** s1   txresp| Content-Length: 5\r\n
**** s1   txresp| \r\n
**** s1   txresp| 1111\n
***  s1   rxreq
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Content-Length: 5\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:26:16 GMT\r\n
**** c1   rxhdr| X-Varnish: 1001\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 200
**** c1   http[ 2] | Ok
**** c1   http[ 3] | Content-Length: 5
**** c1   http[ 4] | Date: Thu, 16 Dec 2010 23:26:16 GMT
**** c1   http[ 5] | X-Varnish: 1001
**** c1   http[ 6] | Age: 0
**** c1   http[ 7] | Via: 1.1 varnish
**** c1   http[ 8] | Connection: keep-alive
**** c1   body| 1111\n
**** c1   bodylen = 5
***  c1   expect
**** c1   EXPECT resp.status (200) == 200 (200) match
***  c1   closing fd 8
**   c1   Ending
***  top  varnish
**** v1   CLI TX| vcl.inline vcl2 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "3075"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \tacl acl1 {\n
**** v1   CLI TX| \t\t! "localhost";\n
**** v1   CLI TX| \t\t"0.0.0.0" / 0;\n
**** v1   CLI TX| \t\t"::" / 0;\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_recv {\n
**** v1   CLI TX| \t\tif (client.ip ~ acl1) {\n
**** v1   CLI TX| \t\t\tset req.url = "/";\n
**** v1   CLI TX| \t\t}\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  106
**** v1   CLI RX| Message from VCC-compiler:\n
**** v1   CLI RX| DNS lookup(::): hostname nor servname provided, or not known\n
**** v1   CLI RX| ('input' Line 7 Pos 17)\n
**** v1   CLI RX|                 "::" / 0;\n
**** v1   CLI RX| ----------------####-----\n
**** v1   CLI RX| \n
**** v1   CLI RX| Running VCC-compiler failed, exit 1\n
**** v1   CLI RX| \n
**** v1   CLI RX| VCL compilation failed
---- v1   FAIL VCL does not compile
*    top  RESETTING after tests/c00005.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   v1   Wait
**   v1   R 9088 Status: 0000
*    top  TEST tests/c00005.vtc FAILED

#     top  TEST tests/c00005.vtc FAILED (7.766)
#     top  TEST tests/c00006.vtc passed (4.925)
#     top  TEST tests/c00007.vtc passed (4.818)
#     top  TEST tests/c00008.vtc passed (5.095)
#     top  TEST tests/c00009.vtc passed (4.951)
#     top  TEST tests/c00010.vtc passed (4.790)
#     top  TEST tests/c00011.vtc passed (4.864)
#     top  TEST tests/c00012.vtc passed (4.815)
#     top  TEST tests/c00013.vtc passed (5.401)
#     top  TEST tests/c00014.vtc passed (5.013)
#     top  TEST tests/c00015.vtc passed (6.793)
#     top  TEST tests/c00016.vtc passed (5.012)
#     top  TEST tests/c00017.vtc passed (6.248)
#     top  TEST tests/c00018.vtc passed (5.070)
#     top  TEST tests/c00019.vtc passed (4.850)
#     top  TEST tests/c00020.vtc passed (5.041)
#     top  TEST tests/c00021.vtc passed (5.062)
#     top  TEST tests/c00022.vtc passed (5.327)
#     top  TEST tests/c00023.vtc passed (5.033)
#     top  TEST tests/c00024.vtc passed (4.904)
#     top  TEST tests/c00025.vtc passed (4.863)
#     top  TEST tests/c00026.vtc passed (5.073)
#     top  TEST tests/c00027.vtc passed (4.770)
#     top  TEST tests/c00028.vtc passed (4.945)
#     top  TEST tests/c00029.vtc passed (6.902)
#     top  TEST tests/c00030.vtc passed (6.880)
#     top  TEST tests/c00031.vtc passed (4.901)
#     top  TEST tests/c00032.vtc passed (4.832)
#     top  TEST tests/c00033.vtc passed (5.019)
#     top  TEST tests/c00034.vtc passed (4.869)
#     top  TEST tests/c00035.vtc passed (9.478)
#     top  TEST tests/c00036.vtc passed (4.923)
#     top  TEST tests/c00037.vtc passed (4.934)
#     top  TEST tests/c00038.vtc passed (5.952)
#     top  TEST tests/e00000.vtc passed (4.934)
#     top  TEST tests/e00001.vtc passed (4.711)
#     top  TEST tests/e00002.vtc passed (4.716)
#     top  TEST tests/e00003.vtc passed (4.972)
#     top  TEST tests/e00004.vtc passed (4.867)
#     top  TEST tests/e00005.vtc passed (4.823)
#     top  TEST tests/e00006.vtc passed (5.109)
#     top  TEST tests/e00007.vtc passed (4.868)
#     top  TEST tests/e00008.vtc passed (4.897)
#     top  TEST tests/e00009.vtc passed (4.748)
#     top  TEST tests/e00010.vtc passed (4.756)
#     top  TEST tests/e00011.vtc passed (4.620)
#     top  TEST tests/e00012.vtc passed (4.844)
#     top  TEST tests/e00013.vtc passed (4.724)
#     top  TEST tests/e00014.vtc passed (4.812)
#     top  TEST tests/e00015.vtc passed (4.877)
#     top  TEST tests/e00016.vtc passed (5.116)
#     top  TEST tests/e00017.vtc passed (5.284)
#     top  TEST tests/e00018.vtc passed (4.933)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.7822482b
*    top  TEST tests/m00000.vtc starting
***  top  test
*    top  TEST Test std vmod
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=3472
**** s1   macro def s1_sock=127.0.0.1 3472
*    s1   Listen on 127.0.0.1 3472
***  top  varnish
**   s1   Started on 127.0.0.1 3472
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.7822482b/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.7822482b/v1/_S -M '127.0.0.1 3473' -P /tmp/vtc.2740.7822482b/v1/varnishd.pid -sfile,/tmp/vtc.2740.7822482b/v1,10M
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.7822482b/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.7822482b/v1/_S -M '127.0.0.1 3473' -P /tmp/vtc.2740.7822482b/v1/varnishd.pid -sfile,/tmp/vtc.2740.7822482b/
v1,10M
***  v1   PID: 5976
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.7822482b/v1/varnish.AWZ1aG size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 5
***  v1   CLI RX  107
**** v1   CLI RX| fzakshhrigoisjoywxyowyabjcrnenel\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 6a77a169caae35c0951851ecc15e54167316aeefb61d92f8b6ed1eb7a0536fb3\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "3472"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \timport std from "/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1" ;\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_deliver {\n
**** v1   CLI TX| \t\tset resp.http.foo = std.toupper(resp.http.foo);\n
**** v1   CLI TX| \t\tset resp.http.bar = std.tolower(resp.http.bar);\n
**** v1   CLI TX| \t\tstd.log("VCL initiated log");\n
**** v1   CLI TX| \t\tstd.syslog(8 + 7, "Somebody runs varnishtest");\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  106
**** v1   CLI RX| Message from VCC-compiler:\n
**** v1   CLI RX| Could not load module std\n
**** v1   CLI RX| \t/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1\n
**** v1   CLI RX| \tNo such file or directory\n
**** v1   CLI RX| ('input' Line 4 Pos 16)\n
**** v1   CLI RX|         import std from "/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1" ;\n
**** v1   CLI RX| ---------------###-----------------------------------------------------------------------------------------\n
**** v1   CLI RX| \n
**** v1   CLI RX| Running VCC-compiler failed, exit 1\n
**** v1   CLI RX| \n
**** v1   CLI RX| VCL compilation failed
---- v1   FAIL VCL does not compile
*    top  RESETTING after tests/m00000.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   v1   Wait
**   v1   R 5976 Status: 0000
*    top  TEST tests/m00000.vtc FAILED

#     top  TEST tests/m00000.vtc FAILED (3.131)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.2c777dc9
*    top  TEST tests/m00001.vtc starting
***  top  test
*    top  TEST Test std vmod
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=3475
**** s1   macro def s1_sock=127.0.0.1 3475
*    s1   Listen on 127.0.0.1 3475
***  top  varnish
**   s1   Started on 127.0.0.1 3475
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.2c777dc9/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.2c777dc9/v1/_S -M '127.0.0.1 3476' -P /tmp/vtc.2740.2c777dc9/v1/varnishd.pid -sfile,/tmp/vtc.2740.2c777dc9/v1,10M  -pthread_pools=1
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.2c777dc9/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.2c777dc9/v1/_S -M '127.0.0.1 3476' -P /tmp/vtc.2740.2c777dc9/v1/varnishd.pid -sfile,/tmp/vtc.2740.2c777dc9/
v1,10M  -pthread_pools=1
***  v1   PID: 10032
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.2c777dc9/v1/varnish.6dNLBL size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 5
***  v1   CLI RX  107
**** v1   CLI RX| vgiwcdomiojdnzxkwgavrkclopfcswdp\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth a6ce7a59ee9411eeff7bd2582a76521b09bfdb5c9a1ef689dbe951fa90156366\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "3475"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \timport std from "/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1" ;\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_deliver {\n
**** v1   CLI TX| \t\tset resp.http.foo = std.toupper(resp.http.foo);\n
**** v1   CLI TX| \t\tset resp.http.bar = std.tolower(resp.http.bar);\n
**** v1   CLI TX| \t\tstd.set_ip_tos(32);\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  106
**** v1   CLI RX| Message from VCC-compiler:\n
**** v1   CLI RX| Could not load module std\n
**** v1   CLI RX| \t/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1\n
**** v1   CLI RX| \tNo such file or directory\n
**** v1   CLI RX| ('input' Line 4 Pos 16)\n
**** v1   CLI RX|         import std from "/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1" ;\n
**** v1   CLI RX| ---------------###-----------------------------------------------------------------------------------------\n
**** v1   CLI RX| \n
**** v1   CLI RX| Running VCC-compiler failed, exit 1\n
**** v1   CLI RX| \n
**** v1   CLI RX| VCL compilation failed
---- v1   FAIL VCL does not compile
*    top  RESETTING after tests/m00001.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   v1   Wait
**   v1   R 10032 Status: 0000
*    top  TEST tests/m00001.vtc FAILED

#     top  TEST tests/m00001.vtc FAILED (3.007)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.10360551
*    top  TEST tests/m00002.vtc starting
***  top  test
*    top  TEST Test std.random
***  top  random
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=3478
**** s1   macro def s1_sock=127.0.0.1 3478
*    s1   Listen on 127.0.0.1 3478
***  top  varnish
**   s1   Started on 127.0.0.1 3478
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.10360551/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.10360551/v1/_S -M '127.0.0.1 3479' -P /tmp/vtc.2740.10360551/v1/varnishd.pid -sfile,/tmp/vtc.2740.10360551/v1,10M
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.10360551/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.10360551/v1/_S -M '127.0.0.1 3479' -P /tmp/vtc.2740.10360551/v1/varnishd.pid -sfile,/tmp/vtc.2740.10360551/
v1,10M
***  v1   PID: 6180
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.10360551/v1/varnish.r8PbAk size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 5
***  v1   CLI RX  107
**** v1   CLI RX| fbuznvzgtoelykzjmpnphiqpgipusbfx\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 633e16d8a0eb95ede742575affc3ed349a88c3a722810264e0102aaaaca9fda8\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "3478"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \timport std from "/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1" ;\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_fetch {\n
**** v1   CLI TX| \t\tset beresp.http.rnd1 = std.random(0,1);\n
**** v1   CLI TX| \t\tset beresp.http.rnd2 = std.random(0,10);\n
**** v1   CLI TX| \t\tset beresp.http.rnd3 = std.random(8,10);\n
**** v1   CLI TX| \t\tset beresp.http.rnd4 = std.random(99,100);\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  106
**** v1   CLI RX| Message from VCC-compiler:\n
**** v1   CLI RX| Could not load module std\n
**** v1   CLI RX| \t/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1\n
**** v1   CLI RX| \tNo such file or directory\n
**** v1   CLI RX| ('input' Line 4 Pos 16)\n
**** v1   CLI RX|         import std from "/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/libvmod_std.so.1" ;\n
**** v1   CLI RX| ---------------###-----------------------------------------------------------------------------------------\n
**** v1   CLI RX| \n
**** v1   CLI RX| Running VCC-compiler failed, exit 1\n
**** v1   CLI RX| \n
**** v1   CLI RX| VCL compilation failed
---- v1   FAIL VCL does not compile
*    top  RESETTING after tests/m00002.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   v1   Wait
**   v1   R 6180 Status: 0000
*    top  TEST tests/m00002.vtc FAILED

#     top  TEST tests/m00002.vtc FAILED (2.830)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.777fb593
*    top  TEST tests/m00003.vtc starting
***  top  test
*    top  TEST Test vmod_dir param
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=3481
**** s1   macro def s1_sock=127.0.0.1 3481
*    s1   Listen on 127.0.0.1 3481
***  top  varnish
**   s1   Started on 127.0.0.1 3481
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.777fb593/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.777fb593/v1/_S -M '127.0.0.1 3482' -P /tmp/vtc.2740.777fb593/v1/varnishd.pid -sfile,/tmp/vtc.2740.777fb593/v1,10M  -pthread_pools=1 -pvm
od_dir=/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.777fb593/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.777fb593/v1/_S -M '127.0.0.1 3482' -P /tmp/vtc.2740.777fb593/v1/varnishd.pid -sfile,/tmp/vtc.2740.777fb593/
v1,10M  -pthread_pools=1 -pvmod_dir=/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/
***  v1   PID: 6956
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.777fb593/v1/varnish.NTWDEz size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 5
***  v1   CLI RX  107
**** v1   CLI RX| eexjdmnnfwemjgddqtyqakhudfeghgpl\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 2d65b8156b5440985a2efbc5b3b9be8b4d5ffbe48dcf6e3ca262ad24455a756b\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "3481"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \timport std;\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_deliver {\n
**** v1   CLI TX| \t\tset resp.http.foo = std.toupper(resp.http.foo);\n
**** v1   CLI TX| \t\tset resp.http.bar = std.tolower(resp.http.bar);\n
**** v1   CLI TX| \t\tstd.set_ip_tos(32);\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  106
**** v1   CLI RX| Message from VCC-compiler:\n
**** v1   CLI RX| Could not load module std\n
**** v1   CLI RX| \t/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs//libvmod_std.so.1\n
**** v1   CLI RX| \tNo such file or directory\n
**** v1   CLI RX| ('input' Line 4 Pos 16)\n
**** v1   CLI RX|         import std;\n
**** v1   CLI RX| ---------------###-\n
**** v1   CLI RX| \n
**** v1   CLI RX| Running VCC-compiler failed, exit 1\n
**** v1   CLI RX| \n
**** v1   CLI RX| VCL compilation failed
---- v1   FAIL VCL does not compile
*    top  RESETTING after tests/m00003.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   v1   Wait
**   v1   R 6956 Status: 0000
*    top  TEST tests/m00003.vtc FAILED

#     top  TEST tests/m00003.vtc FAILED (2.894)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.1f08c086
*    top  TEST tests/m00004.vtc starting
***  top  test
*    top  TEST Test fileread for std VMOD
***  top  shell
**** top  shell| \n
**** top  shell| \techo -n "File One" > "/tmp/vtc.2740.1f08c086/m00004_file_one"\n
**** top  shell| \techo -n "File Two" > "/tmp/vtc.2740.1f08c086/m00004_file_two"\n
**** top  shell| \techo -n "File Three" > "/tmp/vtc.2740.1f08c086/m00004_file_three"\n
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=3484
**** s1   macro def s1_sock=127.0.0.1 3484
*    s1   Listen on 127.0.0.1 3484
***  top  varnish
**   s1   Started on 127.0.0.1 3484
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.1f08c086/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.1f08c086/v1/_S -M '127.0.0.1 3485' -P /tmp/vtc.2740.1f08c086/v1/varnishd.pid -sfile,/tmp/vtc.2740.1f08c086/v1,10M  -pvmod_dir=/tmp/varni
sh-cache/bin/varnishtest/../../lib/libvmod_std/.libs/
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.1f08c086/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.1f08c086/v1/_S -M '127.0.0.1 3485' -P /tmp/vtc.2740.1f08c086/v1/varnishd.pid -sfile,/tmp/vtc.2740.1f08c086/
v1,10M  -pvmod_dir=/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs/
***  v1   PID: 6384
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.1f08c086/v1/varnish.qpoBjc size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 5
***  v1   CLI RX  107
**** v1   CLI RX| mebpjxpiumzjkgtewbqudzlbeiibxewj\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 57359eb974c4a078475555f9edc3ed795613214ab990f7220885295f4c6e8d2b\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "3484"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \timport std;\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_deliver {\n
**** v1   CLI TX| \t\tif (req.url == "/one") {\n
**** v1   CLI TX| \t\t\tset resp.http.one = std.fileread("/tmp/vtc.2740.1f08c086/m00004_file_one");\n
**** v1   CLI TX| \t\t} else if (req.url == "/two") {\n
**** v1   CLI TX| \t\t\tset resp.http.two = std.fileread("/tmp/vtc.2740.1f08c086/m00004_file_two");\n
**** v1   CLI TX| \t\t} else if (req.url == "/three") {\n
**** v1   CLI TX| \t\t\tset resp.http.three = std.fileread("/tmp/vtc.2740.1f08c086/m00004_file_three");\n
**** v1   CLI TX| \t\t}\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  106
**** v1   CLI RX| Message from VCC-compiler:\n
**** v1   CLI RX| Could not load module std\n
**** v1   CLI RX| \t/tmp/varnish-cache/bin/varnishtest/../../lib/libvmod_std/.libs//libvmod_std.so.1\n
**** v1   CLI RX| \tNo such file or directory\n
**** v1   CLI RX| ('input' Line 4 Pos 16)\n
**** v1   CLI RX|         import std;\n
**** v1   CLI RX| ---------------###-\n
**** v1   CLI RX| \n
**** v1   CLI RX| Running VCC-compiler failed, exit 1\n
**** v1   CLI RX| \n
**** v1   CLI RX| VCL compilation failed
---- v1   FAIL VCL does not compile
*    top  RESETTING after tests/m00004.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   v1   Wait
**   v1   R 6384 Status: 0000
*    top  TEST tests/m00004.vtc FAILED

#     top  TEST tests/m00004.vtc FAILED (3.279)
#     top  TEST tests/p00000.vtc passed (9.264)
#     top  TEST tests/p00001.vtc passed (13.800)
#     top  TEST tests/p00002.vtc passed (6.478)
#     top  TEST tests/p00003.vtc passed (8.139)
#     top  TEST tests/p00004.vtc passed (7.356)
#     top  TEST tests/p00005.vtc passed (14.348)
#     top  TEST tests/p00006.vtc passed (6.718)
#     top  TEST tests/r00102.vtc passed (5.010)
#     top  TEST tests/r00251.vtc passed (5.270)
#     top  TEST tests/r00255.vtc passed (4.769)
#     top  TEST tests/r00262.vtc passed (4.867)
#     top  TEST tests/r00263.vtc passed (4.953)
#     top  TEST tests/r00292.vtc passed (5.007)
#     top  TEST tests/r00306.vtc passed (5.255)
#     top  TEST tests/r00310.vtc passed (2.369)
#     top  TEST tests/r00318.vtc passed (4.737)
#     top  TEST tests/r00325.vtc passed (4.655)
#     top  TEST tests/r00326.vtc passed (4.679)
#     top  TEST tests/r00345.vtc passed (6.326)
#     top  TEST tests/r00365.vtc passed (4.966)
#     top  TEST tests/r00386.vtc passed (5.253)
#     top  TEST tests/r00387.vtc passed (4.632)
#     top  TEST tests/r00400.vtc passed (4.680)
#     top  TEST tests/r00409.vtc passed (1.788)
#     top  TEST tests/r00411.vtc passed (4.813)
#     top  TEST tests/r00412.vtc passed (4.674)
#     top  TEST tests/r00416.vtc passed (4.792)
#     top  TEST tests/r00425.vtc passed (4.759)
#     top  TEST tests/r00427.vtc passed (4.713)
#     top  TEST tests/r00433.vtc passed (4.610)
#     top  TEST tests/r00444.vtc passed (4.682)
#     top  TEST tests/r00445.vtc passed (4.717)
#     top  TEST tests/r00466.vtc passed (5.328)
#     top  TEST tests/r00476.vtc passed (4.568)
#     top  TEST tests/r00494.vtc passed (4.681)
#     top  TEST tests/r00495.vtc passed (4.879)
#     top  TEST tests/r00498.vtc passed (4.980)
#     top  TEST tests/r00502.vtc passed (5.251)
#     top  TEST tests/r00506.vtc passed (5.211)
#     top  TEST tests/r00524.vtc passed (5.168)
#     top  TEST tests/r00549.vtc passed (4.751)
#     top  TEST tests/r00558.vtc passed (4.607)
#     top  TEST tests/r00561.vtc passed (5.100)
#     top  TEST tests/r00590.vtc passed (4.621)
#     top  TEST tests/r00612.vtc passed (4.884)
#     top  TEST tests/r00641.vtc passed (4.730)
#     top  TEST tests/r00655.vtc passed (1.747)
#     top  TEST tests/r00667.vtc passed (4.769)
#     top  TEST tests/r00679.vtc passed (4.835)
#     top  TEST tests/r00686.vtc passed (4.553)
#     top  TEST tests/r00693.vtc passed (0.040)
#     top  TEST tests/r00694.vtc passed (9.991)
#     top  TEST tests/r00700.vtc passed (5.026)
#     top  TEST tests/r00702.vtc passed (4.843)
#     top  TEST tests/r00704.vtc passed (4.746)
#     top  TEST tests/r00722.vtc passed (6.577)
#     top  TEST tests/r00730.vtc passed (6.643)
#     top  TEST tests/r00733.vtc passed (4.483)
#     top  TEST tests/r00742.vtc passed (4.556)
#     top  TEST tests/r00763.vtc passed (4.952)
#     top  TEST tests/r00769.vtc passed (4.868)
#     top  TEST tests/r00776.vtc passed (4.870)
#     top  TEST tests/r00781.vtc passed (4.985)
#     top  TEST tests/r00789.vtc passed (4.928)
#     top  TEST tests/r00795.vtc passed (6.071)
#     top  TEST tests/r00801.vtc passed (4.863)
#     top  TEST tests/r00803.vtc passed (4.838)
#     top  TEST tests/r00806.vtc passed (4.834)
#     top  TEST tests/s00000.vtc passed (7.811)
#     top  TEST tests/s00001.vtc passed (5.972)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.2dfcd6ae
*    top  TEST tests/s00002.vtc starting
***  top  test
*    top  TEST Check grace with sick backends
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=3931
**** s1   macro def s1_sock=127.0.0.1 3931
*    s1   Listen on 127.0.0.1 3931
***  top  varnish
**   s1   Started on 127.0.0.1 3931
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.2dfcd6ae/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.2dfcd6ae/v1/_S -M '127.0.0.1 3932' -P /tmp/vtc.2740.2dfcd6ae/v1/varnishd.pid -sfile,/tmp/vtc.2740.2dfcd6ae/v1,10M
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.2dfcd6ae/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.2dfcd6ae/v1/_S -M '127.0.0.1 3932' -P /tmp/vtc.2740.2dfcd6ae/v1/varnishd.pid -sfile,/tmp/vtc.2740.2dfcd6ae/
v1,10M
***  v1   PID: 8496
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.2dfcd6ae/v1/varnish.Md0jpl size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 5
***  v1   CLI RX  107
**** v1   CLI RX| miyiwxssgwcyvvdveylgqxuzpggeyoen\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 57b44995311e3b82eaa77a57c6eaa2d76062e68a7fbfd317f52cfe6c3a9894d9\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tbackend b { \n
**** v1   CLI TX| \t\t.host = "127.0.0.1"; \n
**** v1   CLI TX| \t\t.port = "3931"; \n
**** v1   CLI TX| \t\t.probe = { \n
**** v1   CLI TX| \t\t\t.url = "/"; \n
**** v1   CLI TX| \t\t\t.timeout = 30ms; \n
**** v1   CLI TX| \t\t\t.interval = 1s; \n
**** v1   CLI TX| \t\t\t.window = 2; \n
**** v1   CLI TX| \t\t\t.threshold = 1; \n
**** v1   CLI TX| \t\t\t.initial = 0;\n
**** v1   CLI TX| \t\t\t} \n
**** v1   CLI TX| \t\t}\n
**** v1   CLI TX| \tsub vcl_fetch { \n
**** v1   CLI TX| \t\tset beresp.ttl = 1s; \n
**** v1   CLI TX| \t\tset beresp.grace = 1m; \n
**** v1   CLI TX| \t\tset beresp.cacheable = true; \n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  200
**** v1   CLI RX| VCL compiled.
**** v1   CLI TX| vcl.use vcl1
***  v1   CLI RX  200
**   v1   Start
**** v1   CLI TX| start
***  v1   debug| child (2516) Started\n
***  s1   accepted fd 8
***  s1   rxreq
**** s1   rxhdr| GET / HTTP/1.1\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| Connection: close\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | Host: 127.0.0.1
**** s1   http[ 4] | Connection: close
**** s1   bodylen = 0
***  s1   expect
**** s1   EXPECT req.url (/) == / (/) match
***  s1   txresp
**** s1   txresp| HTTP/1.0 200 Ok\r\n
**** s1   txresp| nbr: 1\r\n
**** s1   txresp| Content-Length: 2\r\n
**** s1   txresp| \r\n
**** s1   txresp| hi
***  s1   accept
**** s1   Accepting
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   debug| Child (2516) said \n
***  v1   debug| Child (2516) said Child starts\n
***  v1   debug| Child (2516) said SMF.s0 mmap'ed 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 3934\n
**   v1   Listen on 127.0.0.1 3934
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=3934
**** v1   macro def v1_sock=127.0.0.1 3934
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1 3934
***  c1   connected fd 8 from 127.0.0.1 3936 to 127.0.0.1 3934
***  c1   sema
**** c1   Sema(r1) wait 1 of 2
***  s1   Accepted socket fd is 9
***  s1   rxreq
**** s1   rxhdr| GET / HTTP/1.1\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| Connection: close\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | Host: 127.0.0.1
**** s1   http[ 4] | Connection: close
**** s1   bodylen = 0
***  s1   expect
**** s1   EXPECT req.url (/) == / (/) match
***  s1   txresp
**** s1   txresp| HTTP/1.0 200 Ok\r\n
**** s1   txresp| nbr: 2\r\n
**** s1   txresp| Content-Length: 2\r\n
**** s1   txresp| \r\n
**** s1   txresp| hi
***  s1   sema
**** s1   Sema(r1) wake 2
***  s1   accept
***  c1   txreq
**** s1   Accepting
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s1   Accepted socket fd is 9
***  s1   rxreq
**** s1   rxhdr| GET / HTTP/1.1\r\n
**** s1   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s1   rxhdr| X-Varnish: 1001\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s1   http[ 4] | X-Varnish: 1001
**** s1   http[ 5] | Host: 127.0.0.1
**** s1   bodylen = 0
***  s1   expect
**** s1   EXPECT req.url (/) == / (/) match
***  s1   txresp
**** s1   txresp| HTTP/1.0 200 Ok\r\n
**** s1   txresp| nbr: 3\r\n
**** s1   txresp| foo: bar\r\n
**** s1   txresp| Content-Length: 2\r\n
**** s1   txresp| \r\n
**** s1   txresp| hi
***  s1   accept
**** s1   Accepting
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| nbr: 3\r\n
**** c1   rxhdr| foo: bar\r\n
**** c1   rxhdr| Content-Length: 2\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:38:08 GMT\r\n
**** c1   rxhdr| X-Varnish: 1001\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 200
**** c1   http[ 2] | Ok
**** c1   http[ 3] | nbr: 3
**** c1   http[ 4] | foo: bar
**** c1   http[ 5] | Content-Length: 2
**** c1   http[ 6] | Date: Thu, 16 Dec 2010 23:38:08 GMT
**** c1   http[ 7] | X-Varnish: 1001
**** c1   http[ 8] | Age: 0
**** c1   http[ 9] | Via: 1.1 varnish
**** c1   http[10] | Connection: keep-alive
**** c1   body| hi
**** c1   bodylen = 2
***  c1   expect
**** c1   EXPECT resp.http.foo (bar) == bar (bar) match
***  c1   expect
**** c1   EXPECT resp.status (200) == 200 (200) match
***  c1   closing fd 8
**   c1   Ending
***  top  client
**   c2   Starting client
**   c2   Waiting for client
***  c2   Connect to 127.0.0.1 3934
***  c2   connected fd 8 from 127.0.0.1 3939 to 127.0.0.1 3934
***  c2   sema
**** c2   Sema(r1) wait 1 of 2
***  s1   Accepted socket fd is 9
***  s1   rxreq
**** s1   rxhdr| GET / HTTP/1.1\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| Connection: close\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | Host: 127.0.0.1
**** s1   http[ 4] | Connection: close
**** s1   bodylen = 0
***  s1   expect
**** s1   EXPECT req.url (/) == / (/) match
***  s1   txresp
**** s1   txresp| HTTP/1.0 400 Ok\r\n
**** s1   txresp| nbr: 4\r\n
**** s1   txresp| Content-Length: 2\r\n
**** s1   txresp| \r\n
**** s1   txresp| hi
***  s1   accept
**** s1   Accepting
***  s1   Accepted socket fd is 9
***  s1   accept
**** s1   Accepting
***  s1   Accepted socket fd is 9
***  s1   rxreq
**** s1   rxhdr| GET / HTTP/1.1\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| Connection: close\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | Host: 127.0.0.1
**** s1   http[ 4] | Connection: close
**** s1   bodylen = 0
***  s1   expect
**** s1   EXPECT req.url (/) == / (/) match
***  s1   txresp
**** s1   txresp| HTTP/1.0 400 Ok\r\n
**** s1   txresp| nbr: 5\r\n
**** s1   txresp| Content-Length: 2\r\n
**** s1   txresp| \r\n
**** s1   txresp| hi
***  s1   accept
**** s1   Accepting
***  s1   Accepted socket fd is 9
***  s1   sema
**** s1   Sema(r1) wake 2
***  c2   txreq
***  s1   shutting fd 8
**** c2   txreq| GET / HTTP/1.1\r\n
**** c2   txreq| \r\n
---- c2   Write failed: Broken pipe
**   s1   Ending
*    top  RESETTING after tests/s00002.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   v1   Wait
**   v1   R 8496 Status: 0000
*    top  TEST tests/s00002.vtc FAILED

#     top  TEST tests/s00002.vtc FAILED (9.977)
#     top  TEST tests/s00003.vtc passed (9.195)
#     top  TEST tests/v00000.vtc passed (5.008)
#     top  TEST tests/v00001.vtc passed (4.871)
#     top  TEST tests/v00002.vtc passed (10.923)
#     top  TEST tests/v00003.vtc passed (4.029)
#     top  TEST tests/v00004.vtc passed (12.762)
#     top  TEST tests/v00005.vtc passed (7.266)
#     top  TEST tests/v00006.vtc passed (8.550)
#     top  TEST tests/v00007.vtc passed (6.264)
#     top  TEST tests/v00008.vtc passed (7.821)
######## tests/v00009.vtc ########
bind(): Address already in use
Assert error in server_start(), vtc_server.c line 202:
  Condition(s->sock >= 0) not true.
  errno = 112 (Address already in use)
**** top  macro def topbuild=/tmp/varnish-cache/bin/varnishtest/../..
**** top  macro def bad_ip=10.255.255.255
**** top  macro def tmpdir=/tmp/vtc.2740.5685a27f
*    top  TEST tests/v00009.vtc starting
***  top  test
*    top  TEST Test round robin director
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=4009
**** s1   macro def s1_sock=127.0.0.1 4009
*    s1   Listen on 127.0.0.1 4009
***  top  server
**   s2   Starting server
**   s1   Started on 127.0.0.1 4009
**** s2   macro def s2_addr=127.0.0.1
**** s2   macro def s2_port=4010
**** s2   macro def s2_sock=127.0.0.1 4010
*    s2   Listen on 127.0.0.1 4010
***  top  server
**   s3   Starting server
**   s2   Started on 127.0.0.1 4010
**** s3   macro def s3_addr=127.0.0.1
**** s3   macro def s3_port=4011
**** s3   macro def s3_sock=127.0.0.1 4011
*    s3   Listen on 127.0.0.1 4011
**   s3   Started on 127.0.0.1 4011
***  top  server
**   s4   Starting server
**** s4   macro def s4_addr=127.0.0.1
**** s4   macro def s4_port=4012
**** s4   macro def s4_sock=127.0.0.1 4012
*    s4   Listen on 127.0.0.1 4012
***  top  varnish
**   s4   Started on 127.0.0.1 4012
**   v1   Launch
***  v1   CMD: cd ${topbuild}/bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.5685a27f/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.
0.1:0' -S /tmp/vtc.2740.5685a27f/v1/_S -M '127.0.0.1 4013' -P /tmp/vtc.2740.5685a27f/v1/varnishd.pid -sfile,/tmp/vtc.2740.5685a27f/v1,10M
***  v1   CMD: cd /tmp/varnish-cache/bin/varnishtest/../../bin/varnishd && ./varnishd -d -d -n /tmp/vtc.2740.5685a27f/v1 -l 10m,1m,- -p auto_restart=off -p sysl
og_cli_traffic=off -a '127.0.0.1:0' -S /tmp/vtc.2740.5685a27f/v1/_S -M '127.0.0.1 4013' -P /tmp/vtc.2740.5685a27f/v1/varnishd.pid -sfile,/tmp/vtc.2740.5685a27f/
v1,10M
***  v1   PID: 4064
***  v1   debug| SMF.s0: filename: /tmp/vtc.2740.5685a27f/v1/varnish.jrsEKq size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| 200 248     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish Cache CLI 1.0\n
***  v1   debug| -----------------------------\n
***  v1   debug| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
***  v1   debug| \n
***  v1   debug| Type 'help' for command list.\n
***  v1   debug| Type 'quit' to close CLI session.\n
***  v1   debug| Type 'start' to launch worker process.\n
***  v1   debug| \n
***  v1   CLI connection fd = 8
***  v1   CLI RX  107
**** v1   CLI RX| xvmczwigorejrghiolkqgzkkmlowgjfd\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 1e21eee869e52c982712c2edcaf4540cca81daf7b2d0264577d266b90f3d1159\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish Cache CLI 1.0\n
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| CYGWIN_NT-5.1,1.7.7(0.230/5/3),i686,-sfile,-smalloc,-hcritbit\n
**** v1   CLI RX| \n
**** v1   CLI RX| Type 'help' for command list.\n
**** v1   CLI RX| Type 'quit' to close CLI session.\n
**** v1   CLI RX| Type 'start' to launch worker process.\n
**** v1   CLI TX| vcl.inline vcl1 << %XJEIFLH|)Xspa8P\n
**** v1   CLI TX| backend s1 { .host = "127.0.0.1"; .port = "4009"; }\n
**** v1   CLI TX| backend s2 { .host = "127.0.0.1"; .port = "4010"; }\n
**** v1   CLI TX| backend s3 { .host = "127.0.0.1"; .port = "4011"; }\n
**** v1   CLI TX| backend s4 { .host = "127.0.0.1"; .port = "4012"; }\n
**** v1   CLI TX| \n
**** v1   CLI TX| \n
**** v1   CLI TX| \tdirector batman round-robin {\n
**** v1   CLI TX| \t\t{ .backend = s1; }\n
**** v1   CLI TX| \t\t{ .backend = s2; }\n
**** v1   CLI TX| \t\t{ .backend = s3; }\n
**** v1   CLI TX| \t\t{ .backend = s4; }\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| \tsub vcl_recv {\n
**** v1   CLI TX| \t\tset req.backend = batman;\n
**** v1   CLI TX| \t}\n
**** v1   CLI TX| \n
**** v1   CLI TX| %XJEIFLH|)Xspa8P\n
***  v1   CLI RX  200
**** v1   CLI RX| VCL compiled.
**** v1   CLI TX| vcl.use vcl1
***  v1   CLI RX  200
**   v1   Start
**** v1   CLI TX| start
***  v1   debug| child (9560) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   debug| Child (9560) said \n
***  v1   debug| Child (9560) said Child starts\n
***  v1   debug| Child (9560) said SMF.s0 mmap'ed 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4015\n
**   v1   Listen on 127.0.0.1 4015
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4015
**** v1   macro def v1_sock=127.0.0.1 4015
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1 4015
***  c1   connected fd 11 from 127.0.0.1 4016 to 127.0.0.1 4015
***  c1   timeout
***  c1   txreq
**** c1   txreq| GET /foo1 HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s1   accepted fd 12
***  s1   rxreq
**** s1   rxhdr| GET /foo1 HTTP/1.1\r\n
**** s1   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s1   rxhdr| X-Varnish: 1001\r\n
**** s1   rxhdr| Host: 127.0.0.1\r\n
**** s1   rxhdr| \r\n
**** s1   http[ 0] | GET
**** s1   http[ 1] | /foo1
**** s1   http[ 2] | HTTP/1.1
**** s1   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s1   http[ 4] | X-Varnish: 1001
**** s1   http[ 5] | Host: 127.0.0.1
**** s1   bodylen = 0
***  s1   txresp
**** s1   txresp| HTTP/1.1 200 Ok\r\n
**** s1   txresp| Content-Length: 1\r\n
**** s1   txresp| \r\n
**** s1   txresp| 1
***  s1   shutting fd 12
**   s1   Ending
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Content-Length: 1\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:39:48 GMT\r\n
**** c1   rxhdr| X-Varnish: 1001\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 200
**** c1   http[ 2] | Ok
**** c1   http[ 3] | Content-Length: 1
**** c1   http[ 4] | Date: Thu, 16 Dec 2010 23:39:48 GMT
**** c1   http[ 5] | X-Varnish: 1001
**** c1   http[ 6] | Age: 0
**** c1   http[ 7] | Via: 1.1 varnish
**** c1   http[ 8] | Connection: keep-alive
**** c1   body| 1
**** c1   bodylen = 1
***  c1   expect
**** c1   EXPECT resp.http.content-length (1) == 1 (1) match
***  c1   txreq
**** c1   txreq| GET /foo2 HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s2   accepted fd 12
***  s2   rxreq
**** s2   rxhdr| GET /foo2 HTTP/1.1\r\n
**** s2   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s2   rxhdr| X-Varnish: 1002\r\n
**** s2   rxhdr| Host: 127.0.0.1\r\n
**** s2   rxhdr| \r\n
**** s2   http[ 0] | GET
**** s2   http[ 1] | /foo2
**** s2   http[ 2] | HTTP/1.1
**** s2   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s2   http[ 4] | X-Varnish: 1002
**** s2   http[ 5] | Host: 127.0.0.1
**** s2   bodylen = 0
***  s2   txresp
**** s2   txresp| HTTP/1.1 200 Ok\r\n
**** s2   txresp| Content-Length: 2\r\n
**** s2   txresp| \r\n
**** s2   txresp| 22
***  s2   shutting fd 12
**   s2   Ending
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Content-Length: 2\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:39:48 GMT\r\n
**** c1   rxhdr| X-Varnish: 1002\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 200
**** c1   http[ 2] | Ok
**** c1   http[ 3] | Content-Length: 2
**** c1   http[ 4] | Date: Thu, 16 Dec 2010 23:39:48 GMT
**** c1   http[ 5] | X-Varnish: 1002
**** c1   http[ 6] | Age: 0
**** c1   http[ 7] | Via: 1.1 varnish
**** c1   http[ 8] | Connection: keep-alive
**** c1   body| 22
**** c1   bodylen = 2
***  c1   expect
**** c1   EXPECT resp.http.content-length (2) == 2 (2) match
***  c1   txreq
**** c1   txreq| GET /foo3 HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s3   accepted fd 12
***  s3   rxreq
**** s3   rxhdr| GET /foo3 HTTP/1.1\r\n
**** s3   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s3   rxhdr| X-Varnish: 1003\r\n
**** s3   rxhdr| Host: 127.0.0.1\r\n
**** s3   rxhdr| \r\n
**** s3   http[ 0] | GET
**** s3   http[ 1] | /foo3
**** s3   http[ 2] | HTTP/1.1
**** s3   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s3   http[ 4] | X-Varnish: 1003
**** s3   http[ 5] | Host: 127.0.0.1
**** s3   bodylen = 0
***  s3   txresp
**** s3   txresp| HTTP/1.1 200 Ok\r\n
**** s3   txresp| Content-Length: 3\r\n
**** s3   txresp| \r\n
**** s3   txresp| 333
***  s3   shutting fd 12
**   s3   Ending
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Content-Length: 3\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:39:48 GMT\r\n
**** c1   rxhdr| X-Varnish: 1003\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 200
**** c1   http[ 2] | Ok
**** c1   http[ 3] | Content-Length: 3
**** c1   http[ 4] | Date: Thu, 16 Dec 2010 23:39:48 GMT
**** c1   http[ 5] | X-Varnish: 1003
**** c1   http[ 6] | Age: 0
**** c1   http[ 7] | Via: 1.1 varnish
**** c1   http[ 8] | Connection: keep-alive
**** c1   body| 333
**** c1   bodylen = 3
***  c1   expect
**** c1   EXPECT resp.http.content-length (3) == 3 (3) match
***  c1   txreq
**** c1   txreq| GET /foo4 HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s4   accepted fd 12
***  s4   rxreq
**** s4   rxhdr| GET /foo4 HTTP/1.1\r\n
**** s4   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s4   rxhdr| X-Varnish: 1004\r\n
**** s4   rxhdr| Host: 127.0.0.1\r\n
**** s4   rxhdr| \r\n
**** s4   http[ 0] | GET
**** s4   http[ 1] | /foo4
**** s4   http[ 2] | HTTP/1.1
**** s4   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s4   http[ 4] | X-Varnish: 1004
**** s4   http[ 5] | Host: 127.0.0.1
**** s4   bodylen = 0
***  s4   txresp
**** s4   txresp| HTTP/1.1 200 Ok\r\n
**** s4   txresp| Content-Length: 4\r\n
**** s4   txresp| \r\n
**** s4   txresp| 4444
***  s4   shutting fd 12
**   s4   Ending
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Content-Length: 4\r\n
**** c1   rxhdr| Date: Thu, 16 Dec 2010 23:39:48 GMT\r\n
**** c1   rxhdr| X-Varnish: 1004\r\n
**** c1   rxhdr| Age: 0\r\n
**** c1   rxhdr| Via: 1.1 varnish\r\n
**** c1   rxhdr| Connection: keep-alive\r\n
**** c1   rxhdr| \r\n
**** c1   http[ 0] | HTTP/1.1
**** c1   http[ 1] | 200
**** c1   http[ 2] | Ok
**** c1   http[ 3] | Content-Length: 4
**** c1   http[ 4] | Date: Thu, 16 Dec 2010 23:39:48 GMT
**** c1   http[ 5] | X-Varnish: 1004
**** c1   http[ 6] | Age: 0
**** c1   http[ 7] | Via: 1.1 varnish
**** c1   http[ 8] | Connection: keep-alive
**** c1   body| 4444
**** c1   bodylen = 4
***  c1   expect
**** c1   EXPECT resp.http.content-length (4) == 4 (4) match
***  c1   closing fd 11
**   c1   Ending
***  top  server
**   s1   Waiting for server
**   s1   Starting server

#     top  TEST tests/v00009.vtc FAILED (5.509)
#     top  TEST tests/v00010.vtc passed (7.236)
#     top  TEST tests/v00011.vtc passed (7.090)
#     top  TEST tests/v00012.vtc passed (5.854)
#     top  TEST tests/v00013.vtc passed (6.147)
#     top  TEST tests/v00014.vtc passed (6.255)
#     top  TEST tests/v00015.vtc passed (5.072)
#     top  TEST tests/v00016.vtc passed (11.246)
#     top  TEST tests/v00017.vtc passed (21.663)
#     top  TEST tests/v00018.vtc passed (17.301)
#     top  TEST tests/v00019.vtc passed (5.764)
#     top  TEST tests/v00020.vtc passed (5.600)
#     top  TEST tests/v00021.vtc passed (2.544)
#     top  TEST tests/v00022.vtc passed (5.300)
#     top  TEST tests/v00023.vtc passed (4.490)
#     top  TEST tests/v00024.vtc passed (4.802)
#     top  TEST tests/v00025.vtc passed (4.682)
#     top  TEST tests/v00026.vtc passed (4.816)
#     top  TEST tests/v00027.vtc passed (4.534)
#     top  TEST tests/v00028.vtc passed (4.660)
#     top  TEST tests/v00029.vtc passed (9.065)
#     top  TEST tests/v00030.vtc passed (3.889)
#     top  TEST tests/v00031.vtc passed (3.456)
9 tests failed, 202 tests passed
-------------- next part --------------
A non-text attachment was scrubbed...
Name: cygwin_changes_r_5646.patch
Type: application/octet-stream
Size: 9109 bytes
Desc: not available
URL: <https://www.varnish-cache.org/lists/pipermail/varnish-dev/attachments/20101217/96d5594e/attachment-0003.obj>


More information about the varnish-dev mailing list