[Varnish] #736: Migration to Cygwin plataform

Jorge Díaz jdzstz at gmail.com
Tue Aug 17 14:43:23 CEST 2010


I have attached cygwin changes in patch format for
r5110<http://varnish-cache.org/changeset/5110>.


I also have executed regression tests with
r5110<http://varnish-cache.org/changeset/5110>.
I continue having problems with:

*FAIL: ./tests/b00004.vtc
FAIL: ./tests/b00015.vtc
FAIL: ./tests/b00030.vtc
FAIL: ./tests/c00005.vtc
FAIL: ./tests/p00002.vtc
FAIL: ./tests/r00433.vtc
FAIL: ./tests/r00558.vtc
FAIL: ./tests/v00009.vtc
FAIL: ./tests/v00027.vtc*


Despite this problems, Varnish seems to work ok in cygwin and it has less
regression errors than Solaris platform.


About regression errors, test c00005.vtc is not working because IPv6
problems:

There is a IPv6 instruction "::" in VCL that it is not supported by Cygwin
in Windows XP:

	acl acl1 {
		! "localhost";
		"0.0.0.0" / 0;
		"::" / 0;
	}

**** v1   CLI RX| DNS lookup(::): hostname nor servname provided, or not known\n

Cygwin IPv6 might work in Windows Vista (but I don't have any)

 http://www.cygwin.com/cygwin-ug-net/ov-new1.7.html<http://www.cygwin.com/cygwin-ug-net/ov-new1.7.html>

IPv6 support. New APIs getaddrinfo, getnameinfo, freeaddrinfo, gai_strerror,
in6addr_any, in6addr_loopback. On IPv6-less systems, replacement functions
are available for IPv4. On systems with IPv6 enabled, the underlying
WinSock? functions are used. While I tried hard to get the functionality as
POSIXy as possible, keep in mind that a *fully* conformant implementation of
getaddrinfo and other stuff is only available starting with Windows
Vista/2008.



The rest of regression errors have two kind of problems:

   - bind(): Address already in use
   - Test timed out

I have filled all this information in ticket #736 (
http://varnish-cache.org/ticket/736)


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

> Hello,
>
> About my modifications for Cygwin support, I will prepare all modifications
> in patches format instead complete files.
>
> I will send you the patch at the end of August (before it is impossible to
> me)
>
>
> But I need some help in order to solve the problems:
> *
> Regression Tests:  *
>
> I have problems with 8 of 183 tests  there are two kind of problems:
>
>   - "bind(): Address already in use"
>   - "Test timed out"
> Do you know if some platform have similar problems or some common cause of
> this errors?
>
> I have executed same regression tests in Solaris 10, and the results are
> worse than Cygwin, Solaris has "20 of 183 tests failed" so if Solaris is
> level "B - Platforms we try not to break" we can consider Cygwin at its same
> level? or errors must be zero in order to add my modifications to
> subversion??
>
>
> *Autoconf tools (aka autocrap): *
>
> I am a newbie in autoconf world. I was able to make almost all
> modifications in configure.ac but I need some manual changes in
> Makefile.am:
>
>    - Only for libraries, we need to add "-no-undefined" parameter in
>    LDFLAGS
>    - Only for varnishd, we need to add "-Wl,-out-implib,libvarnishd.dll.a"
>    in LDFLAGS this changes only apply to Cygwin.
>    - In Cygwin, the libraries "libvcl" and "libvarnishapi" have a new
>    compilation-time dependence with libvarnish, I have to add LIBS=-lvarnish
>    and LDFLAGS='-L$(top_builddir)/lib/libvarnish  only for libvcl and
>    libvarnishapi.
>    - If platform is not cygwin, we do not add anything.
>
>
> I have apply the modifications defining some variables that in Cygwin have
> some value and in other platforms are blank. This variables are used in the
> specific Makefile.am.
>
> There is other way to apply modifications without changing the five
> Makefile.am and only changing configure.ac ???
>
>
> *Other questions:*
>
> Do you want me to reopen ticket #736 with changes or I must create a new
> ticket?
>
> About "supported platform" in varnish I think there is no page in wiki (
> http://varnish-cache.org/wiki) that speaks about diferences between Linux,
> FreeBSD, Solaris and MacOSX support.
> Maybe the only page about platforms is:
> http://varnish-cache.org/wiki/Installation  but only speaks about
> installation issues. In the future it will be necessary to add Cygwin at
> this page and speak about some debugging tricks of this platform (strace
> command or CYGWIN enviroment variable)
>
>
>
> Thank you,
>
> Jorge
>
>
>
>
> 2010/8/4 Varnish <varnish-bugs at varnish-cache.org>
>
>  #736: Migration to Cygwin plataform
>>
>> ----------------------+-----------------------------------------------------
>>  Reporter:  jdzst    |        Type:  enhancement
>>    Status:  closed   |    Priority:  normal
>>  Milestone:           |   Component:  build
>>   Version:           |    Severity:  normal
>> Resolution:  invalid  |    Keywords:  cygwin, windows
>>
>> ----------------------+-----------------------------------------------------
>> Changes (by phk):
>>
>>  * status:  new => closed
>>  * resolution:  => invalid
>>
>>
>> Comment:
>>
>>  Your ticket and work with cygwin caused me to ponder what we mean by
>>  "supported platform" in Varnish, and I wrote up my thoughts yesterday:
>>
>>  http://varnish-cache.org/browser/trunk/varnish-
>>  cache/doc/sphinx/phk/platforms.rst
>>
>>  CYGWIN is a Tier C platform, one we are willing to tolerate, if it does
>>  not cost us too much effort.
>>
>>  These changes do not look terribly intrusive.  (I don't understand why
>> you
>>  have to modify all the Makefile.am to add cygwin specific LD-flags, I
>>  thought autocrap did that for you ?)
>>
>>  On the other hand, you don't seem to have managed to get much
>>  functionality out of it yet, given that some of those failing tests are
>>  very basic functionality.
>>
>>  But keep at it, send us patches instead of complete files, once you get
>>  the test-cases to work, and we will give you a fair reading.
>>
>>  For now I will close this ticket.
>>
>> --
>> Ticket URL: <http://www.varnish-cache.org/ticket/736#comment:7>
>>  Varnish <http://varnish-cache.org/>
>> The Varnish HTTP Accelerator
>>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://www.varnish-cache.org/lists/pipermail/varnish-dev/attachments/20100817/dc6fc001/attachment-0003.html>
-------------- next part --------------
$ make check
make  check-TESTS
make[1]: Entering directory `/tmp/varnish-cache/bin/varnishtest'
#    top  TEST ././tests/a00000.vtc passed (0.051s)
PASS: ./tests/a00000.vtc
#    top  TEST ././tests/a00001.vtc passed (0.030s)
PASS: ./tests/a00001.vtc
#    top  TEST ././tests/a00002.vtc passed (0.032s)
PASS: ./tests/a00002.vtc
#    top  TEST ././tests/a00003.vtc passed (0.048s)
PASS: ./tests/a00003.vtc
#    top  TEST ././tests/a00004.vtc passed (0.441s)
PASS: ./tests/a00004.vtc
#    top  TEST ././tests/a00005.vtc passed (0.044s)
PASS: ./tests/a00005.vtc
#    top  TEST ././tests/a00006.vtc passed (0.032s)
PASS: ./tests/a00006.vtc
#    top  TEST ././tests/a00007.vtc passed (0.036s)
PASS: ./tests/a00007.vtc
#    top  TEST ././tests/a00008.vtc passed (1.859s)
PASS: ./tests/a00008.vtc
#    top  TEST ././tests/a00009.vtc passed (3.174s)
PASS: ./tests/a00009.vtc
#    top  TEST ././tests/a00010.vtc passed (0.041s)
PASS: ./tests/a00010.vtc
#    top  TEST ././tests/b00000.vtc passed (4.880s)
PASS: ./tests/b00000.vtc
#    top  TEST ././tests/b00001.vtc passed (7.123s)
PASS: ./tests/b00001.vtc
#    top  TEST ././tests/b00002.vtc passed (5.552s)
PASS: ./tests/b00002.vtc
#    top  TEST ././tests/b00003.vtc passed (5.247s)
PASS: ./tests/b00003.vtc
**** top  macro def tmpdir=/tmp/vtc.6172.0d09da2e
**** top  macro def bad_ip=10.255.255.255
*    top  TEST ././tests/b00004.vtc starting
***  top  test
*    top  TEST Torture Varnish with start/stop commands
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=4306
**** s1   macro def s1_sock=127.0.0.1:4306
*    s1   Listen on 127.0.0.1:4306
**   s1   Started on 127.0.0.1:4306
***  top  varnish
**   v1   Launch
***  v1   CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/vtc.6172.0d09da2e/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S /tm
p/vtc.6172.0d09da2e/v1/_S -M 127.0.0.1:4307 -P /tmp/vtc.6172.0d09da2e/v1/varnishd.pid -sfile,/tmp/vtc.6172.0d09da2e/v1,10M
***  v1   debug| storage_file: filename: /tmp/vtc.6172.0d09da2e/v1/varnish.G4SKf9 size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.6(0.230/5/3),i686,-sfile,-hcritbit\n
***  v1   debug| 200 193     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish HTTP accelerator CLI.\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| aajnxghzwqphcasohclllkhhxkbdkuom\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth a9e7214fb4e3375699e1c6deccd649c82b4f32339fdfa3356494af5da502845e\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish HTTP accelerator CLI.\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 "backend s1 { .host = \"127.0.0.1\"; .port = \"4306\"; }\n "
***  v1   CLI RX  200
**** v1   CLI RX| VCL compiled.
**** v1   CLI TX| vcl.use vcl1
***  v1   CLI RX  200
***  top  varnish
**   v1   Start
**** v1   CLI TX| start
***  v1   debug| child (2396) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   debug| Child (2396) said \n
***  v1   debug| Child (2396) said Child starts\n
***  v1   debug| Child (2396) said managed to mmap 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4313\n
**   v1   Listen on 127.0.0.1 4313
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4313
**** v1   macro def v1_sock=127.0.0.1:4313
***  top  varnish
**** v1   macro undef v1_addr
**** v1   macro undef v1_port
**** v1   macro undef v1_sock
**   v1   Stop
**** v1   CLI TX| stop
***  v1   CLI RX  200
**** v1   CLI TX| status
***  v1   debug| Stopping Child\n
***  v1   debug| Child (2396) said Child dies\n
***  v1   debug| Child (2396) died\n
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopping
***  v1   debug| Child cleanup complete\n
**** v1   CLI TX| status
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopped
***  top  varnish
**   v1   Start
**** v1   CLI TX| start
***  v1   debug| child (7284) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   debug| Child (7284) said \n
***  v1   debug| Child (7284) said Child starts\n
***  v1   debug| Child (7284) said managed to mmap 10485760 bytes of 10485760
***  v1   debug| \n
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4324\n
**   v1   Listen on 127.0.0.1 4324
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4324
**** v1   macro def v1_sock=127.0.0.1:4324
***  top  varnish
**** v1   macro undef v1_addr
**** v1   macro undef v1_port
**** v1   macro undef v1_sock
**   v1   Stop
**** v1   CLI TX| stop
***  v1   CLI RX  200
**** v1   CLI TX| status
***  v1   debug| Stopping Child\n
***  v1   debug| Child (7284) said Child dies\n
***  v1   debug| Child (7284) died\n
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopping
***  v1   debug| Child cleanup complete\n
**** v1   CLI TX| status
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopped
***  top  varnish
**   v1   Start
**** v1   CLI TX| start
***  v1   debug| child (5556) 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 (5556) said \n
***  v1   debug| Child (5556) said Child starts\n
***  v1   debug| Child (5556) said managed to mmap 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4325\n
**   v1   Listen on 127.0.0.1 4325
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4325
**** v1   macro def v1_sock=127.0.0.1:4325
***  top  varnish
**** v1   macro undef v1_addr
**** v1   macro undef v1_port
**** v1   macro undef v1_sock
**   v1   Stop
**** v1   CLI TX| stop
***  v1   CLI RX  200
**** v1   CLI TX| status
***  v1   debug| Stopping Child\n
***  v1   debug| Child (5556) said Child dies\n
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopping
***  v1   debug| Child (5556) died\n
***  v1   debug| Child cleanup complete\n
**** v1   CLI TX| status
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopped
***  top  varnish
**** v1   CLI TX| start
***  v1   debug| child (6748) Started\n
***  v1   CLI RX  200
**   v1   CLI 200 <start>
***  top  varnish
**** v1   CLI TX| start
***  v1   CLI RX  300
**** v1   CLI RX| Child in state running
**   v1   CLI 300 <start>
***  top  varnish
**** v1   CLI TX| start
***  v1   CLI RX  300
**** v1   CLI RX| Child in state running
**   v1   CLI 300 <start>
***  top  varnish
**** v1   CLI TX| stop
***  v1   CLI RX  200
**   v1   CLI 200 <stop>
***  top  varnish
**** v1   CLI TX| stop
***  v1   CLI RX  300
**** v1   CLI RX| Child in state stopping
**   v1   CLI 300 <stop>
***  top  varnish
**** v1   CLI TX| stop
***  v1   debug| Child (6748) said \n
***  v1   debug| Child (6748) said Child starts\n
***  v1   debug| Child (6748) said managed to mmap 10485760 bytes of 10485760\n
***  v1   debug| Stopping Child\n
***  v1   debug| Child (6748) said Child dies\n
***  v1   CLI RX  300
**** v1   CLI RX| Child in state stopping
**   v1   CLI 300 <stop>
***  top  varnish
**   v1   Stop
**** v1   CLI TX| stop
***  v1   debug| Child (6748) died\n
***  v1   CLI RX  300
**** v1   CLI RX| Child in state stopping
**** v1   CLI TX| status
***  v1   debug| Child cleanup complete\n
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopped
**   v1   Wait
**   v1   R 7852 Status: 0000
*    top  RESETTING after ././tests/b00004.vtc
**   s1   Waiting for server
*    top  Test timed out
*    top  TEST ././tests/b00004.vtc FAILED
FAIL: ./tests/b00004.vtc
#    top  TEST ././tests/b00005.vtc passed (6.364s)
PASS: ./tests/b00005.vtc
#    top  TEST ././tests/b00006.vtc passed (5.417s)
PASS: ./tests/b00006.vtc
#    top  TEST ././tests/b00007.vtc passed (4.839s)
PASS: ./tests/b00007.vtc
#    top  TEST ././tests/b00008.vtc passed (4.891s)
PASS: ./tests/b00008.vtc
#    top  TEST ././tests/b00009.vtc passed (6.030s)
PASS: ./tests/b00009.vtc
#    top  TEST ././tests/b00010.vtc passed (6.589s)
PASS: ./tests/b00010.vtc
#    top  TEST ././tests/b00011.vtc passed (5.152s)
PASS: ./tests/b00011.vtc
#    top  TEST ././tests/b00012.vtc passed (4.853s)
PASS: ./tests/b00012.vtc
#    top  TEST ././tests/b00013.vtc passed (4.699s)
PASS: ./tests/b00013.vtc
#    top  TEST ././tests/b00014.vtc passed (6.555s)
PASS: ./tests/b00014.vtc
bind(): Address already in use
Assert error in server_start(), vtc_server.c line 183:
  Condition(s->sock >= 0) not true.
  errno = 112 (Address already in use)
/bin/sh: line 5:  5876 Aborted                 (core dumped) ./varnishtest ${dir}$tst
FAIL: ./tests/b00015.vtc
#    top  TEST ././tests/b00016.vtc passed (8.942s)
PASS: ./tests/b00016.vtc
#    top  TEST ././tests/b00017.vtc passed (4.794s)
PASS: ./tests/b00017.vtc
#    top  TEST ././tests/b00018.vtc passed (4.666s)
PASS: ./tests/b00018.vtc
#    top  TEST ././tests/b00019.vtc passed (4.580s)
PASS: ./tests/b00019.vtc
#    top  TEST ././tests/b00020.vtc passed (0.006s)
PASS: ./tests/b00020.vtc
#    top  TEST ././tests/b00021.vtc passed (0.005s)
PASS: ./tests/b00021.vtc
#    top  TEST ././tests/b00022.vtc passed (0.005s)
PASS: ./tests/b00022.vtc
#    top  TEST ././tests/b00023.vtc passed (0.005s)
PASS: ./tests/b00023.vtc
#    top  TEST ././tests/b00024.vtc passed (0.005s)
PASS: ./tests/b00024.vtc
#    top  TEST ././tests/b00025.vtc passed (0.007s)
PASS: ./tests/b00025.vtc
#    top  TEST ././tests/b00026.vtc passed (0.005s)
PASS: ./tests/b00026.vtc
#    top  TEST ././tests/b00027.vtc passed (4.802s)
PASS: ./tests/b00027.vtc
#    top  TEST ././tests/b00028.vtc passed (4.715s)
PASS: ./tests/b00028.vtc
#    top  TEST ././tests/b00029.vtc passed (7.721s)
PASS: ./tests/b00029.vtc
**** top  macro def tmpdir=/tmp/vtc.7464.797707d4
**** top  macro def bad_ip=10.255.255.255
*    top  TEST ././tests/b00030.vtc starting
***  top  test
*    top  TEST Test formatting of timestamps
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=4484
**** s1   macro def s1_sock=127.0.0.1:4484
*    s1   Listen on 127.0.0.1:4484
***  top  varnish
**   s1   Started on 127.0.0.1:4484
**   v1   Launch
***  v1   CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/vtc.7464.797707d4/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S /tm
p/vtc.7464.797707d4/v1/_S -M 127.0.0.1:4485 -P /tmp/vtc.7464.797707d4/v1/varnishd.pid -sfile,/tmp/vtc.7464.797707d4/v1,10M
***  v1   debug| storage_file: filename: /tmp/vtc.7464.797707d4/v1/varnish.Zx5UKq size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.6(0.230/5/3),i686,-sfile,-hcritbit\n
***  v1   debug| 200 193     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish HTTP accelerator CLI.\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| vvxvsnmgkmkxjvtjsmicgimzhseyazdy\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 3d9aa8fc92306cf45b2e113742ae86ce22d2fd2691ce4c101eb9241667b0c39f\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish HTTP accelerator CLI.\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 "backend s1 { .host = \"127.0.0.1\"; .port = \"4484\"; }\n\n\tsub vcl_recv {\n\t\terror 200 req.grace;\n\t}\n\tsub vcl_error {
\n\t\tset obj.http.x-timestamp = now;\n\t}\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 (6932) 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 (6932) said \n
***  v1   debug| Child (6932) said Child starts\n
***  v1   debug| Child (6932) said managed to mmap 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4487\n
**   v1   Listen on 127.0.0.1 4487
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4487
**** v1   macro def v1_sock=127.0.0.1:4487
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1:4487
***  c1   connected fd 8
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
**** c1   rxhdr| HTTP/1.1 200 10.000\r\n
**** c1   rxhdr| Server: Varnish\r\n
**** c1   rxhdr| Retry-After: 0\r\n
**** c1   rxhdr| x-timestamp: Tue, 17 Aug 2010 11:41:09 GMT\r\n
**** c1   rxhdr| Content-Type: text/html; charset=utf-8\r\n
**** c1   rxhdr| Content-Length: 374\r\n
**** c1   rxhdr| Date: Tue, 17 Aug 2010 11:41:09 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] | 200
**** c1   http[ 2] | 10.000
**** c1   http[ 3] | Server: Varnish
**** c1   http[ 4] | Retry-After: 0
**** c1   http[ 5] | x-timestamp: Tue, 17 Aug 2010 11:41:09 GMT
**** c1   http[ 6] | Content-Type: text/html; charset=utf-8
**** c1   http[ 7] | Content-Length: 374
**** c1   http[ 8] | Date: Tue, 17 Aug 2010 11:41:09 GMT
**** c1   http[ 9] | X-Varnish: 1001
**** c1   http[10] | Age: 0
**** c1   http[11] | Via: 1.1 varnish
**** c1   http[12] | 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>200 10.000</title>\n
**** c1   body|   </head>\n
**** c1   body|   <body>\n
**** c1   body|     <h1>Error 200 10.000</h1>\n
**** c1   body|     <p>10.000</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 = 374
***  c1   expect
**** c1   EXPECT resp.msg (10.000) == 10.000 (10.000) match
***  c1   closing fd 8
**   c1   Ending
*    top  RESETTING after ././tests/b00030.vtc
**   s1   Waiting for server
*    top  Test timed out
*    top  TEST ././tests/b00030.vtc FAILED
FAIL: ./tests/b00030.vtc
#    top  TEST ././tests/b00031.vtc passed (5.220s)
PASS: ./tests/b00031.vtc
#    top  TEST ././tests/b00032.vtc passed (1.598s)
PASS: ./tests/b00032.vtc
#    top  TEST ././tests/b00033.vtc passed (5.076s)
PASS: ./tests/b00033.vtc
#    top  TEST ././tests/c00001.vtc passed (4.931s)
PASS: ./tests/c00001.vtc
#    top  TEST ././tests/c00002.vtc passed (4.729s)
PASS: ./tests/c00002.vtc
#    top  TEST ././tests/c00003.vtc passed (4.655s)
PASS: ./tests/c00003.vtc
#    top  TEST ././tests/c00004.vtc passed (4.746s)
PASS: ./tests/c00004.vtc
---- s1   HTTP rx failed (poll: No error)
---- v1   FAIL VCL does not compile
**** top  macro def tmpdir=/tmp/vtc.6600.039991f5
**** top  macro def bad_ip=10.255.255.255
*    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=4542
**** s1   macro def s1_sock=127.0.0.1:4542
*    s1   Listen on 127.0.0.1:4542
***  top  varnish
**   s1   Started on 127.0.0.1:4542
**   v1   Launch
***  v1   CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/vtc.6600.039991f5/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S /tm
p/vtc.6600.039991f5/v1/_S -M 127.0.0.1:4543 -P /tmp/vtc.6600.039991f5/v1/varnishd.pid -sfile,/tmp/vtc.6600.039991f5/v1,10M  -p vcl_trace=on
***  v1   debug| storage_file: filename: /tmp/vtc.6600.039991f5/v1/varnish.VtoRit size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.6(0.230/5/3),i686,-sfile,-hcritbit\n
***  v1   debug| 200 193     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish HTTP accelerator CLI.\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| cpuhvyeqlnzglpbwmrtfurtlhodxldpp\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 288b12d761f3ac6deb7eb970cadb2ff64a870a20ac3367b41e34ad1738e43752\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish HTTP accelerator CLI.\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 "backend s1 { .host = \"127.0.0.1\"; .port = \"4542\"; }\n\n\tacl acl1 {\n\t\t\"localhost\";\n\t}\n\n\tsub vcl_recv {\n\t\tif
(client.ip ~ acl1) {\n\t\t\tset req.url = \"/\";\n\t\t}\n\t}\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 (8024) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   debug| Child (8024) said \n
***  v1   debug| Child (8024) said Child starts\n
***  v1   debug| Child (8024) said managed to mmap 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4545\n
**   v1   Listen on 127.0.0.1 4545
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4545
**** v1   macro def v1_sock=127.0.0.1:4545
***  top  client
**   c1   Starting client
***  c1   Connect to 127.0.0.1:4545
***  c1   connected fd 8
***  c1   txreq
**** c1   txreq| GET foo HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
**   c1   Waiting for client
***  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: Tue, 17 Aug 2010 11:42: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: Tue, 17 Aug 2010 11:42: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 "backend s1 { .host = \"127.0.0.1\"; .port = \"4542\"; }\n\n\tacl acl1 {\n\t\t! \"localhost\";\n\t\t\"0.0.0.0\" / 0;\n\t\t\"::
\" / 0;\n\t}\n\n\tsub vcl_recv {\n\t\tif (client.ip ~ acl1) {\n\t\t\tset req.url = \"/\";\n\t\t}\n\t}\n"
---- s1   HTTP rx failed (poll: No error)
***  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 6 Pos 17)\n
**** v1   CLI RX|                 "::" / 0;\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 3460 Status: 0000
*    top  TEST ././tests/c00005.vtc FAILED
FAIL: ./tests/c00005.vtc
#    top  TEST ././tests/c00006.vtc passed (5.314s)
PASS: ./tests/c00006.vtc
#    top  TEST ././tests/c00007.vtc passed (5.240s)
PASS: ./tests/c00007.vtc
#    top  TEST ././tests/c00008.vtc passed (4.854s)
PASS: ./tests/c00008.vtc
#    top  TEST ././tests/c00009.vtc passed (4.593s)
PASS: ./tests/c00009.vtc
#    top  TEST ././tests/c00010.vtc passed (4.849s)
PASS: ./tests/c00010.vtc
#    top  TEST ././tests/c00011.vtc passed (4.674s)
PASS: ./tests/c00011.vtc
#    top  TEST ././tests/c00012.vtc passed (4.812s)
PASS: ./tests/c00012.vtc
#    top  TEST ././tests/c00013.vtc passed (5.496s)
PASS: ./tests/c00013.vtc
#    top  TEST ././tests/c00014.vtc passed (4.940s)
PASS: ./tests/c00014.vtc
#    top  TEST ././tests/c00015.vtc passed (6.183s)
PASS: ./tests/c00015.vtc
#    top  TEST ././tests/c00016.vtc passed (4.578s)
PASS: ./tests/c00016.vtc
#    top  TEST ././tests/c00017.vtc passed (5.927s)
PASS: ./tests/c00017.vtc
#    top  TEST ././tests/c00018.vtc passed (4.845s)
PASS: ./tests/c00018.vtc
#    top  TEST ././tests/c00019.vtc passed (5.042s)
PASS: ./tests/c00019.vtc
#    top  TEST ././tests/c00020.vtc passed (4.687s)
PASS: ./tests/c00020.vtc
#    top  TEST ././tests/c00021.vtc passed (5.189s)
PASS: ./tests/c00021.vtc
#    top  TEST ././tests/c00022.vtc passed (5.183s)
PASS: ./tests/c00022.vtc
#    top  TEST ././tests/c00023.vtc passed (4.744s)
PASS: ./tests/c00023.vtc
#    top  TEST ././tests/c00024.vtc passed (4.511s)
PASS: ./tests/c00024.vtc
#    top  TEST ././tests/c00025.vtc passed (4.585s)
PASS: ./tests/c00025.vtc
#    top  TEST ././tests/c00026.vtc passed (4.669s)
PASS: ./tests/c00026.vtc
#    top  TEST ././tests/c00027.vtc passed (4.643s)
PASS: ./tests/c00027.vtc
#    top  TEST ././tests/c00028.vtc passed (5.084s)
PASS: ./tests/c00028.vtc
#    top  TEST ././tests/c00029.vtc passed (9.914s)
PASS: ./tests/c00029.vtc
#    top  TEST ././tests/c00030.vtc passed (9.628s)
PASS: ./tests/c00030.vtc
#    top  TEST ././tests/c00031.vtc passed (4.464s)
PASS: ./tests/c00031.vtc
#    top  TEST ././tests/c00032.vtc passed (4.698s)
PASS: ./tests/c00032.vtc
#    top  TEST ././tests/c00033.vtc passed (4.604s)
PASS: ./tests/c00033.vtc
#    top  TEST ././tests/c00034.vtc passed (4.789s)
PASS: ./tests/c00034.vtc
#    top  TEST ././tests/c00035.vtc passed (8.770s)
PASS: ./tests/c00035.vtc
#    top  TEST ././tests/c00036.vtc passed (4.801s)
PASS: ./tests/c00036.vtc
#    top  TEST ././tests/e00000.vtc passed (4.486s)
PASS: ./tests/e00000.vtc
#    top  TEST ././tests/e00001.vtc passed (4.590s)
PASS: ./tests/e00001.vtc
#    top  TEST ././tests/e00002.vtc passed (3.897s)
PASS: ./tests/e00002.vtc
#    top  TEST ././tests/e00003.vtc passed (4.483s)
PASS: ./tests/e00003.vtc
#    top  TEST ././tests/e00004.vtc passed (4.846s)
PASS: ./tests/e00004.vtc
#    top  TEST ././tests/e00005.vtc passed (4.545s)
PASS: ./tests/e00005.vtc
#    top  TEST ././tests/e00006.vtc passed (4.645s)
PASS: ./tests/e00006.vtc
#    top  TEST ././tests/e00007.vtc passed (4.725s)
PASS: ./tests/e00007.vtc
#    top  TEST ././tests/e00008.vtc passed (4.740s)
PASS: ./tests/e00008.vtc
#    top  TEST ././tests/e00009.vtc passed (4.564s)
PASS: ./tests/e00009.vtc
#    top  TEST ././tests/e00010.vtc passed (4.728s)
PASS: ./tests/e00010.vtc
#    top  TEST ././tests/e00011.vtc passed (4.979s)
PASS: ./tests/e00011.vtc
#    top  TEST ././tests/e00012.vtc passed (4.703s)
PASS: ./tests/e00012.vtc
#    top  TEST ././tests/e00013.vtc passed (4.534s)
PASS: ./tests/e00013.vtc
#    top  TEST ././tests/e00014.vtc passed (4.593s)
PASS: ./tests/e00014.vtc
#    top  TEST ././tests/e00015.vtc passed (4.724s)
PASS: ./tests/e00015.vtc
#    top  TEST ././tests/e00016.vtc passed (5.503s)
PASS: ./tests/e00016.vtc
#    top  TEST ././tests/e00017.vtc passed (4.613s)
PASS: ./tests/e00017.vtc
#    top  TEST ././tests/e00018.vtc passed (4.650s)
PASS: ./tests/e00018.vtc
#    top  TEST ././tests/p00000.vtc passed (8.508s)
PASS: ./tests/p00000.vtc
#    top  TEST ././tests/p00001.vtc passed (15.804s)
PASS: ./tests/p00001.vtc
**** top  macro def tmpdir=/tmp/vtc.3516.0d138ca6
**** top  macro def bad_ip=10.255.255.255
*    top  TEST ././tests/p00002.vtc starting
***  top  test
*    top  TEST Ban a persistent object
***  top  shell
**** top  shell| rm -f /tmp/vtc.3516.0d138ca6/_.per[12]
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=4976
**** s1   macro def s1_sock=127.0.0.1:4976
*    s1   Listen on 127.0.0.1:4976
**   s1   Started on 127.0.0.1:4976
***  top  varnish
**   v1   Launch
***  v1   CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/vtc.3516.0d138ca6/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S /tm
p/vtc.3516.0d138ca6/v1/_S -M 127.0.0.1:4977 -P /tmp/vtc.3516.0d138ca6/v1/varnishd.pid -spersistent,/tmp/vtc.3516.0d138ca6/_.per2,10m  -pdiag_bitmap=0x20000 -pba
n_lurker_sleep=0
***  v1   debug| sizeof(struct smp_ident) = 112 = 0x70\n
***  v1   debug| sizeof(struct smp_sign) = 32 = 0x20\n
***  v1   debug| sizeof(struct smp_segptr) = 32 = 0x20\n
***  v1   debug| sizeof(struct smp_object) = 56 = 0x38\n
***  v1   debug| CHK(0x7d2a88 SILO 0x7ecf0000 <invalid>) = 1\n
***  v1   debug| min_nseg = 10, max_segl = 622585\n
***  v1   debug| max_nseg = 26212, min_segl = 237\n
***  v1   debug| aim_nseg = 511, aim_segl = 12183\n
***  v1   debug| aim_nobj = 155\n
***  v1   debug| free_reserve = 121830\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.6(0.230/5/3),i686,-spersistent,-hcritbit\n
***  v1   debug| 200 193     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish HTTP accelerator CLI.\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| vkhtlotcjzouujmxmtkrqqsyfmqxtrar\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth dd9dcd9ef536236da90edfe19b1265e6239897ced4ed3fe97002117351ee127c\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish HTTP accelerator CLI.\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 "backend s1 { .host = \"127.0.0.1\"; .port = \"4976\"; }\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 (5896) 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 (5896) said \n
***  v1   debug| Child (5896) said Child starts\n
***  v1   debug| Child (5896) said Silo completely loaded\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4979\n
**   v1   Listen on 127.0.0.1 4979
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4979
**** v1   macro def v1_sock=127.0.0.1:4979
***  top  client
**   c1   Starting client
***  c1   Connect to 127.0.0.1:4979
***  c1   connected fd 8
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
**   c1   Waiting for client
***  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   txresp
**** s1   txresp| HTTP/1.1 200 Ok\r\n
**** s1   txresp| Foo: foo\r\n
**** s1   txresp| Content-Length: 0\r\n
**** s1   txresp| \r\n
***  s1   shutting fd 9
**   s1   Ending
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Foo: foo\r\n
**** c1   rxhdr| Content-Length: 0\r\n
**** c1   rxhdr| Date: Tue, 17 Aug 2010 11:47:40 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] | Foo: foo
**** c1   http[ 4] | Content-Length: 0
**** c1   http[ 5] | Date: Tue, 17 Aug 2010 11:47:40 GMT
**** c1   http[ 6] | X-Varnish: 1001
**** c1   http[ 7] | Age: 0
**** c1   http[ 8] | Via: 1.1 varnish
**** c1   http[ 9] | Connection: keep-alive
**** c1   bodylen = 0
***  c1   expect
**** c1   EXPECT resp.status (200) == 200 (200) match
***  c1   expect
**** c1   EXPECT resp.http.X-Varnish (1001) == 1001 (1001) match
***  c1   expect
**** c1   EXPECT resp.http.foo (foo) == foo (foo) match
***  c1   closing fd 8
**   c1   Ending
***  top  varnish
**** v1   CLI TX| purge req.url == / && req.http.jam != session
***  v1   CLI RX  200
**   v1   CLI 200 <purge req.url == / && req.http.jam != session>
***  top  varnish
**** v1   macro undef v1_addr
**** v1   macro undef v1_port
**** v1   macro undef v1_sock
**   v1   Stop
**** v1   CLI TX| stop
***  v1   CLI RX  200
**** v1   CLI TX| status
***  v1   debug| Stopping Child\n
***  v1   debug| Child (5896) said Child dies
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopping
***  v1   debug| \n
***  v1   debug| Child (5896) died\n
***  v1   debug| Child cleanup complete\n
**** v1   CLI TX| status
***  v1   CLI RX  200
**** v1   CLI RX| Child in state stopped
***  top  server
**   s1   Waiting for server
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=4976
**** s1   macro def s1_sock=127.0.0.1:4976
*    s1   Listen on 127.0.0.1:4976
***  top  varnish
**   v1   Start
**** v1   CLI TX| start
**   s1   Started on 127.0.0.1:4976
***  v1   debug| child (4680) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   debug| Child (4680) said \n
***  v1   debug| Child (4680) said Child starts\n
***  v1   debug| Child (4680) said Dropped 0 segments to make free_reserve\n
***  v1   debug| Child (4680) said Silo completely loaded\n
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 4982\n
**   v1   Listen on 127.0.0.1 4982
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=4982
**** v1   macro def v1_sock=127.0.0.1:4982
***  top  varnish
**** v1   CLI TX| purge.list
***  v1   CLI RX  200
**** v1   CLI RX| 0x7e0b00 1282045662.237500     0G\t\n
**** v1   CLI RX| 0x7e0d28 1282045660.966500     0 \treq.url == / && req.http.jam != session\n
**** v1   CLI RX| 0x7e0ca8 1282045659.860500     1G\t\n
**   v1   CLI 200 <purge.list>
***  top  varnish
**   v1   as expected: n_purge (3) == 3
*    top  RESETTING after ././tests/p00002.vtc
**   s1   Waiting for server
*    top  Test timed out
*    top  TEST ././tests/p00002.vtc FAILED
FAIL: ./tests/p00002.vtc
#    top  TEST ././tests/p00003.vtc passed (10.591s)
PASS: ./tests/p00003.vtc
#    top  TEST ././tests/p00004.vtc passed (6.901s)
PASS: ./tests/p00004.vtc
#    top  TEST ././tests/p00005.vtc passed (13.355s)
PASS: ./tests/p00005.vtc
#    top  TEST ././tests/p00006.vtc passed (6.315s)
PASS: ./tests/p00006.vtc
#    top  TEST ././tests/r00102.vtc passed (4.751s)
PASS: ./tests/r00102.vtc
#    top  TEST ././tests/r00251.vtc passed (5.153s)
PASS: ./tests/r00251.vtc
#    top  TEST ././tests/r00255.vtc passed (5.023s)
PASS: ./tests/r00255.vtc
#    top  TEST ././tests/r00262.vtc passed (4.707s)
PASS: ./tests/r00262.vtc
#    top  TEST ././tests/r00263.vtc passed (5.821s)
PASS: ./tests/r00263.vtc
#    top  TEST ././tests/r00292.vtc passed (4.595s)
PASS: ./tests/r00292.vtc
#    top  TEST ././tests/r00306.vtc passed (4.511s)
PASS: ./tests/r00306.vtc
#    top  TEST ././tests/r00318.vtc passed (4.818s)
PASS: ./tests/r00318.vtc
#    top  TEST ././tests/r00325.vtc passed (4.609s)
PASS: ./tests/r00325.vtc
#    top  TEST ././tests/r00326.vtc passed (4.748s)
PASS: ./tests/r00326.vtc
#    top  TEST ././tests/r00345.vtc passed (5.725s)
PASS: ./tests/r00345.vtc
#    top  TEST ././tests/r00365.vtc passed (4.950s)
PASS: ./tests/r00365.vtc
#    top  TEST ././tests/r00386.vtc passed (4.827s)
PASS: ./tests/r00386.vtc
#    top  TEST ././tests/r00387.vtc passed (4.649s)
PASS: ./tests/r00387.vtc
#    top  TEST ././tests/r00400.vtc passed (4.606s)
PASS: ./tests/r00400.vtc
#    top  TEST ././tests/r00409.vtc passed (2.158s)
PASS: ./tests/r00409.vtc
#    top  TEST ././tests/r00412.vtc passed (4.932s)
PASS: ./tests/r00412.vtc
#    top  TEST ././tests/r00416.vtc passed (4.876s)
PASS: ./tests/r00416.vtc
#    top  TEST ././tests/r00425.vtc passed (5.232s)
PASS: ./tests/r00425.vtc
#    top  TEST ././tests/r00427.vtc passed (4.650s)
PASS: ./tests/r00427.vtc
**** top  macro def tmpdir=/tmp/vtc.4924.544d0a80
**** top  macro def bad_ip=10.255.255.255
*    top  TEST ././tests/r00433.vtc starting
***  top  test
*    top  TEST noidx
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=1192
**** s1   macro def s1_sock=127.0.0.1:1192
*    s1   Listen on 127.0.0.1:1192
***  top  server
**   s1   Started on 127.0.0.1:1192
**   s2   Starting server
**** s2   macro def s2_addr=127.0.0.1
**** s2   macro def s2_port=1193
**** s2   macro def s2_sock=127.0.0.1:1193
*    s2   Listen on 127.0.0.1:1193
**   s2   Started on 127.0.0.1:1193
***  top  varnish
**   v1   Launch
***  v1   CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/vtc.4924.544d0a80/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S /tm
p/vtc.4924.544d0a80/v1/_S -M 127.0.0.1:1194 -P /tmp/vtc.4924.544d0a80/v1/varnishd.pid -sfile,/tmp/vtc.4924.544d0a80/v1,10M
***  v1   debug| storage_file: filename: /tmp/vtc.4924.544d0a80/v1/varnish.Fxv3KN size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.6(0.230/5/3),i686,-sfile,-hcritbit\n
***  v1   debug| 200 193     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish HTTP accelerator CLI.\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 = 6
***  v1   CLI RX  107
**** v1   CLI RX| rfowxmvgcdvwyiwdishykumicdmlwniq\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth b86c21e8ab8e2dd315a3d93defec68122d5c933eb5120a926ef40930082b3f02\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish HTTP accelerator CLI.\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 "backend s1 { .host = \"127.0.0.1\"; .port = \"1192\"; }\nbackend s2 { .host = \"127.0.0.1\"; .port = \"1193\"; }\n\n\tsub vcl
_recv {\n\t\tif (req.url == \"/foo\") {\n\t\t\tset req.backend = s1;\n\t\t} else {\n\t\t\tset req.backend = s2;\n\t\t}\n\t}\n\n\tsub vcl_fetch {\n\t\tesi;\n\t}\
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 (4772) 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 (4772) said \n
***  v1   debug| Child (4772) said Child starts\n
***  v1   debug| Child (4772) said managed to mmap 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 1204\n
**   v1   Listen on 127.0.0.1 1204
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=1204
**** v1   macro def v1_sock=127.0.0.1:1204
***  top  varnish
**** v1   CLI TX| param.set esi_syntax 4
***  v1   CLI RX  200
**   v1   CLI 200 <param.set esi_syntax 4>
***  top  varnish
**** v1   CLI TX| param.set diag_bitmap 0x10000
***  v1   CLI RX  200
**   v1   CLI 200 <param.set diag_bitmap 0x10000>
***  top  varnish
**** v1   CLI TX| debug.fragfetch 32
***  v1   CLI RX  200
**   v1   CLI 200 <debug.fragfetch 32>
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1:1204
***  c1   connected fd 9
***  c1   txreq
**** c1   txreq| GET /foo HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s1   accepted fd 10
***  s1   rxreq
**** s1   rxhdr| GET /foo 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] | /foo
**** 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 (/foo) == /foo (/foo) match
***  s1   txresp
**** s1   txresp| HTTP/1.1 200 Ok\r\n
**** s1   txresp| Connection: close\r\n
**** s1   txresp| Content-Length: 0\r\n
**** s1   txresp| \r\n
***  s1   send
**** s1   send| \n
**** s1   send| <H>\n
**** s1   send| FOO{\n
**** s1   send| <esi:include src="/bar"/>\n
**** s1   send| }FOO\n
**** s1   send| <!-- blablablabablablablablablablablablabla >\n
**** s1   send| blablablablab -->\n
**** s1   send| The end.\n
***  s1   shutting fd 10
**   s1   Ending
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Content-Length: 0\r\n
**** c1   rxhdr| Date: Tue, 17 Aug 2010 11:50:39 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: 0
**** c1   http[ 4] | Date: Tue, 17 Aug 2010 11:50:39 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   bodylen = 0
***  c1   closing fd 9
**   c1   Ending
*    top  RESETTING after ././tests/r00433.vtc
**   s1   Waiting for server
**** s1   macro undef s1_addr
**** s1   macro undef s1_port
**** s1   macro undef s1_sock
**   s2   Waiting for server
*    top  Test timed out
*    top  TEST ././tests/r00433.vtc FAILED
FAIL: ./tests/r00433.vtc
#    top  TEST ././tests/r00444.vtc passed (5.236s)
PASS: ./tests/r00444.vtc
#    top  TEST ././tests/r00445.vtc passed (4.889s)
PASS: ./tests/r00445.vtc
#    top  TEST ././tests/r00466.vtc passed (5.179s)
PASS: ./tests/r00466.vtc
#    top  TEST ././tests/r00476.vtc passed (5.196s)
PASS: ./tests/r00476.vtc
#    top  TEST ././tests/r00494.vtc passed (4.865s)
PASS: ./tests/r00494.vtc
#    top  TEST ././tests/r00495.vtc passed (4.663s)
PASS: ./tests/r00495.vtc
#    top  TEST ././tests/r00498.vtc passed (5.338s)
PASS: ./tests/r00498.vtc
#    top  TEST ././tests/r00502.vtc passed (5.119s)
PASS: ./tests/r00502.vtc
#    top  TEST ././tests/r00506.vtc passed (4.963s)
PASS: ./tests/r00506.vtc
#    top  TEST ././tests/r00524.vtc passed (4.893s)
PASS: ./tests/r00524.vtc
#    top  TEST ././tests/r00549.vtc passed (4.567s)
PASS: ./tests/r00549.vtc
**** top  macro def tmpdir=/tmp/vtc.3992.0a9962d0
**** top  macro def bad_ip=10.255.255.255
*    top  TEST ././tests/r00558.vtc starting
***  top  test
*    top  TEST error from vcl_recv{} has no numeric code
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=1355
**** s1   macro def s1_sock=127.0.0.1:1355
*    s1   Listen on 127.0.0.1:1355
**   s1   Started on 127.0.0.1:1355
***  top  varnish
**   v1   Launch
***  v1   CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/vtc.3992.0a9962d0/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S /tm
p/vtc.3992.0a9962d0/v1/_S -M 127.0.0.1:1357 -P /tmp/vtc.3992.0a9962d0/v1/varnishd.pid -sfile,/tmp/vtc.3992.0a9962d0/v1,10M
***  v1   debug| storage_file: filename: /tmp/vtc.3992.0a9962d0/v1/varnish.0Jsca0 size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.6(0.230/5/3),i686,-sfile,-hcritbit\n
***  v1   debug| 200 193     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish HTTP accelerator CLI.\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| vfronguhqupffahmytdpasiisktadjny\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 16417b558335763e129c48c3a73e5c575924c4cba024e2ef0cf7f910ce17b9a2\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish HTTP accelerator CLI.\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 "backend s1 { .host = \"127.0.0.1\"; .port = \"1355\"; }\n\n\tsub vcl_recv {\n\t\treturn (error);\n\t}\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 (1396) Started\n
***  v1   CLI RX  200
**** v1   CLI TX| debug.xid 1000
***  v1   debug| Child (1396) said \n
***  v1   debug| Child (1396) said Child starts\n
***  v1   debug| Child (1396) said managed to mmap 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| XID is 1000
**** v1   CLI TX| debug.listen_address
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 1360\n
**   v1   Listen on 127.0.0.1 1360
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=1360
**** v1   macro def v1_sock=127.0.0.1:1360
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1:1360
***  c1   connected fd 8
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
**** c1   rxhdr| HTTP/1.1 501 Not Implemented\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: 401\r\n
**** c1   rxhdr| Date: Tue, 17 Aug 2010 11:52:13 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] | 501
**** c1   http[ 2] | Not Implemented
**** 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: 401
**** c1   http[ 7] | Date: Tue, 17 Aug 2010 11:52:13 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>501 Not Implemented</title>\n
**** c1   body|   </head>\n
**** c1   body|   <body>\n
**** c1   body|     <h1>Error 501 Not Implemented</h1>\n
**** c1   body|     <p>Not Implemented</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 = 401
***  c1   expect
**** c1   EXPECT resp.status (501) == 501 (501) match
***  c1   closing fd 8
**   c1   Ending
*    top  RESETTING after ././tests/r00558.vtc
**   s1   Waiting for server
*    top  Test timed out
*    top  TEST ././tests/r00558.vtc FAILED
FAIL: ./tests/r00558.vtc
#    top  TEST ././tests/r00561.vtc passed (5.334s)
PASS: ./tests/r00561.vtc
#    top  TEST ././tests/r00590.vtc passed (5.135s)
PASS: ./tests/r00590.vtc
#    top  TEST ././tests/r00612.vtc passed (5.063s)
PASS: ./tests/r00612.vtc
#    top  TEST ././tests/r00641.vtc passed (4.789s)
PASS: ./tests/r00641.vtc
#    top  TEST ././tests/r00655.vtc passed (1.920s)
PASS: ./tests/r00655.vtc
#    top  TEST ././tests/r00667.vtc passed (5.734s)
PASS: ./tests/r00667.vtc
#    top  TEST ././tests/r00679.vtc passed (4.717s)
PASS: ./tests/r00679.vtc
#    top  TEST ././tests/r00693.vtc passed (0.005s)
PASS: ./tests/r00693.vtc
#    top  TEST ././tests/r00694.vtc passed (9.393s)
PASS: ./tests/r00694.vtc
#    top  TEST ././tests/r00700.vtc passed (4.622s)
PASS: ./tests/r00700.vtc
#    top  TEST ././tests/r00702.vtc passed (4.533s)
PASS: ./tests/r00702.vtc
#    top  TEST ././tests/r00704.vtc passed (4.645s)
PASS: ./tests/r00704.vtc
#    top  TEST ././tests/r00722.vtc passed (6.086s)
PASS: ./tests/r00722.vtc
#    top  TEST ././tests/r00730.vtc passed (6.204s)
PASS: ./tests/r00730.vtc
#    top  TEST ././tests/r00733.vtc passed (4.998s)
PASS: ./tests/r00733.vtc
#    top  TEST ././tests/r00742.vtc passed (4.553s)
PASS: ./tests/r00742.vtc
#    top  TEST ././tests/s00000.vtc passed (7.754s)
PASS: ./tests/s00000.vtc
#    top  TEST ././tests/s00001.vtc passed (7.206s)
PASS: ./tests/s00001.vtc
#    top  TEST ././tests/s00002.vtc passed (12.084s)
PASS: ./tests/s00002.vtc
#    top  TEST ././tests/s00003.vtc passed (9.132s)
PASS: ./tests/s00003.vtc
#    top  TEST ././tests/v00000.vtc passed (6.609s)
PASS: ./tests/v00000.vtc
#    top  TEST ././tests/v00001.vtc passed (6.567s)
PASS: ./tests/v00001.vtc
#    top  TEST ././tests/v00002.vtc passed (11.835s)
PASS: ./tests/v00002.vtc
#    top  TEST ././tests/v00003.vtc passed (6.352s)
PASS: ./tests/v00003.vtc
#    top  TEST ././tests/v00004.vtc passed (13.915s)
PASS: ./tests/v00004.vtc
#    top  TEST ././tests/v00005.vtc passed (7.414s)
PASS: ./tests/v00005.vtc
#    top  TEST ././tests/v00006.vtc passed (8.633s)
PASS: ./tests/v00006.vtc
#    top  TEST ././tests/v00007.vtc passed (4.852s)
PASS: ./tests/v00007.vtc
#    top  TEST ././tests/v00008.vtc passed (6.404s)
PASS: ./tests/v00008.vtc
bind(): Address already in use
Assert error in server_start(), vtc_server.c line 183:
  Condition(s->sock >= 0) not true.
  errno = 112 (Address already in use)
/bin/sh: line 5:  5756 Aborted                 (core dumped) ./varnishtest ${dir}$tst
FAIL: ./tests/v00009.vtc
#    top  TEST ././tests/v00010.vtc passed (7.369s)
PASS: ./tests/v00010.vtc
#    top  TEST ././tests/v00011.vtc passed (4.926s)
PASS: ./tests/v00011.vtc
#    top  TEST ././tests/v00012.vtc passed (4.879s)
PASS: ./tests/v00012.vtc
#    top  TEST ././tests/v00013.vtc passed (4.765s)
PASS: ./tests/v00013.vtc
#    top  TEST ././tests/v00014.vtc passed (6.826s)
PASS: ./tests/v00014.vtc
#    top  TEST ././tests/v00015.vtc passed (4.956s)
PASS: ./tests/v00015.vtc
#    top  TEST ././tests/v00016.vtc passed (10.295s)
PASS: ./tests/v00016.vtc
#    top  TEST ././tests/v00017.vtc passed (23.938s)
PASS: ./tests/v00017.vtc
#    top  TEST ././tests/v00018.vtc passed (17.145s)
PASS: ./tests/v00018.vtc
#    top  TEST ././tests/v00019.vtc passed (7.523s)
PASS: ./tests/v00019.vtc
#    top  TEST ././tests/v00020.vtc passed (6.384s)
PASS: ./tests/v00020.vtc
#    top  TEST ././tests/v00021.vtc passed (3.205s)
PASS: ./tests/v00021.vtc
#    top  TEST ././tests/v00022.vtc passed (6.498s)
PASS: ./tests/v00022.vtc
#    top  TEST ././tests/v00023.vtc passed (5.535s)
PASS: ./tests/v00023.vtc
#    top  TEST ././tests/v00024.vtc passed (5.633s)
PASS: ./tests/v00024.vtc
#    top  TEST ././tests/v00025.vtc passed (5.006s)
PASS: ./tests/v00025.vtc
#    top  TEST ././tests/v00026.vtc passed (4.956s)
PASS: ./tests/v00026.vtc
**** top  macro def tmpdir=/tmp/vtc.7364.5c50472e
**** top  macro def bad_ip=10.255.255.255
*    top  TEST ././tests/v00027.vtc starting
***  top  test
*    top  TEST Check that backend named 'default' is the default
***  top  server
**   s1   Starting server
**** s1   macro def s1_addr=127.0.0.1
**** s1   macro def s1_port=1673
**** s1   macro def s1_sock=127.0.0.1:1673
*    s1   Listen on 127.0.0.1:1673
***  top  server
**   s1   Started on 127.0.0.1:1673
**   s2   Starting server
**** s2   macro def s2_addr=127.0.0.1
**** s2   macro def s2_port=1674
**** s2   macro def s2_sock=127.0.0.1:1674
*    s2   Listen on 127.0.0.1:1674
**   s2   Started on 127.0.0.1:1674
***  top  varnish
**   v1   Launch
***  v1   CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/vtc.7364.5c50472e/v1 -l 10m,1m,- -p auto_restart=off -p syslog_cli_traffic=off -a '127.0.0.1:0' -S /tm
p/vtc.7364.5c50472e/v1/_S -M 127.0.0.1:1675 -P /tmp/vtc.7364.5c50472e/v1/varnishd.pid -sfile,/tmp/vtc.7364.5c50472e/v1,10M
***  v1   debug| storage_file: filename: /tmp/vtc.7364.5c50472e/v1/varnish.Wq7cZk size 10 MB.\n
***  v1   debug| Platform: CYGWIN_NT-5.1,1.7.6(0.230/5/3),i686,-sfile,-hcritbit\n
***  v1   debug| 200 193     \n
***  v1   debug| -----------------------------\n
***  v1   debug| Varnish HTTP accelerator CLI.\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 = 6
***  v1   CLI RX  107
**** v1   CLI RX| jtkbwoymxpiwkclwqfjmakptdjjofivo\n
**** v1   CLI RX| \n
**** v1   CLI RX| Authentication required.\n
**** v1   CLI TX| auth 6703475ab8e73977f9c77b250bf0cd9f98ad5a07d8205fcc532eca9ff300d39d\n
***  v1   CLI RX  200
**** v1   CLI RX| -----------------------------\n
**** v1   CLI RX| Varnish HTTP accelerator CLI.\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 "\n\tbackend s1 {\n\t\t.host = \"127.0.0.1\"; \n\t\t.port = \"1673\";\n\t}\n\tbackend default {\n\t\t.host = \"127.0.0.1\";\n\
t\t.port = \"1674\";\n\t}\n\n\tsub vcl_recv {\n\t\tif (req.url != req.url) {\n\t\t\tset req.backend = s1;\n\t\t}\n\t}\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 (4624) 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 (4624) said \n
***  v1   debug| Child (4624) said Child starts\n
***  v1   debug| Child (4624) said managed to mmap 10485760 bytes of 10485760\n
***  v1   CLI RX  200
**** v1   CLI RX| 127.0.0.1 1677\n
**   v1   Listen on 127.0.0.1 1677
**** v1   macro def v1_addr=127.0.0.1
**** v1   macro def v1_port=1677
**** v1   macro def v1_sock=127.0.0.1:1677
***  top  client
**   c1   Starting client
**   c1   Waiting for client
***  c1   Connect to 127.0.0.1:1677
***  c1   connected fd 9
***  c1   txreq
**** c1   txreq| GET / HTTP/1.1\r\n
**** c1   txreq| \r\n
***  c1   rxresp
***  s2   accepted fd 10
***  s2   rxreq
**** s2   rxhdr| GET / HTTP/1.1\r\n
**** s2   rxhdr| X-Forwarded-For: 127.0.0.1\r\n
**** s2   rxhdr| X-Varnish: 1001\r\n
**** s2   rxhdr| Host: 127.0.0.1\r\n
**** s2   rxhdr| \r\n
**** s2   http[ 0] | GET
**** s2   http[ 1] | /
**** s2   http[ 2] | HTTP/1.1
**** s2   http[ 3] | X-Forwarded-For: 127.0.0.1
**** s2   http[ 4] | X-Varnish: 1001
**** 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: 52\r\n
**** s2   txresp| \r\n
**** s2   txresp| !"#$%&'()*+,-./0123456789:;<=>?@ABCDEFGHIJKLMNOPQRS\n
***  s2   shutting fd 10
**   s2   Ending
**** c1   rxhdr| HTTP/1.1 200 Ok\r\n
**** c1   rxhdr| Content-Length: 52\r\n
**** c1   rxhdr| Date: Tue, 17 Aug 2010 11:58:44 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: 52
**** c1   http[ 4] | Date: Tue, 17 Aug 2010 11:58:44 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| !"#$%&'()*+,-./0123456789:;<=>?@ABCDEFGHIJKLMNOPQRS\n
**** c1   bodylen = 52
***  c1   expect
**** c1   EXPECT resp.bodylen (52) == 52 (52) match
***  c1   closing fd 9
**   c1   Ending
*    top  RESETTING after ././tests/v00027.vtc
**   s1   Waiting for server
*    top  Test timed out
*    top  TEST ././tests/v00027.vtc FAILED
FAIL: ./tests/v00027.vtc
#    top  TEST ././tests/v00028.vtc passed (5.133s)
PASS: ./tests/v00028.vtc
==============================================
9 of 189 tests failed
Please report to varnish-dev at varnish-cache.org
==============================================
make[1]: *** [check-TESTS] Error 1
make[1]: Leaving directory `/tmp/varnish-cache/bin/varnishtest'
make: *** [check-am] Error 2
-------------- next part --------------
A non-text attachment was scrubbed...
Name: cygwin_changes_r_5110.patch
Type: application/octet-stream
Size: 7393 bytes
Desc: not available
URL: <https://www.varnish-cache.org/lists/pipermail/varnish-dev/attachments/20100817/dc6fc001/attachment-0003.obj>


More information about the varnish-dev mailing list