Two varnishtest failures on Solaris
Theo Schlossnagle
jesus at omniti.com
Wed Aug 13 21:26:07 CEST 2008
I am getting two failures in the test suite using varnishtest on
Solaris. 8091 with the Solaris patch applied: http://lethargy.org/~jesus/misc/varnish-solaris-trunk-3091.diff
Two failing tests are c00015 and v00006
; ./varnishtest -v tests/c00015.vtc
# TEST tests/c00015.vtc starting
# TEST Test switching VCLs
## s1 Starting server
### s1 listen on 127.0.0.1:9080 (fd 3)
## v1 Launch
### v1 CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/__v1 -a
'127.0.0.1:9081' -T 127.0.0.1:9001
## s1 Started on 127.0.0.1:9080
### v1 opening CLI connection
#### v1 debug| storage_file: filename: ./varnish.egaGks (unlinked)
size 100 MB.\n
#### v1 debug| Using old SHMFILE\n
#### v1 debug| Notice: locking SHMFILE in core failed: Not owner
#### v1 debug| \n
#### v1 debug| Debugging mode, enter "start" to start child\n
### v1 CLI connection fd = 7
#### v1 CLI TX| vcl.inline vcl1 "backend s1 { .host =
\"127.0.0.1\"; .port = \"9080\"; }\n \n"
#### v1 CLI RX| VCL compiled.
### v1 CLI STATUS 200
#### v1 CLI TX| vcl.use vcl1
### v1 CLI STATUS 200
## v1 Start
#### v1 CLI TX| start
#### v1 debug| child (
#### v1 debug| 9319) Started\n
### v1 CLI STATUS 200
#### v1 debug| Child (9319) said Closed fds: 3 5 7 8 11 12 14 15\n
#### v1 CLI TX| debug.xid 1000
#### v1 debug| Child (9319) said Child starts\n
#### v1 debug| Child (9319) said managed to mmap 105201664 bytes of
105201664\n
#### v1 debug| Child (9319) said Ready\n
#### v1 CLI RX| XID is 1000\n
### v1 CLI STATUS 200
#### v1 CLI TX| vcl.inline vcl2 "backend s1 { .host =
\"127.0.0.1\"; .port = \"9080\"; }\n\n\tsub vcl_recv {\n\t\tpass;\n\t}
\n"
#### v1 CLI RX| VCL compiled.
### v1 CLI STATUS 200
#### v1 CLI TX| vcl.use vcl2
### v1 CLI STATUS 200
#### v1 CLI TX| vcl.list
#### v1 CLI RX| available 0 vcl1\n
#### v1 CLI RX| active 0 vcl2\n
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.list>
#### v1 CLI TX| vcl.use vcl1
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.use vcl1>
## c1 Starting client
#### v1 CLI TX| vcl.use vcl2
## c1 Started
### c1 Connect to 127.0.0.1:9081
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.use vcl2>
## c2 Starting client
#### v1 CLI TX| vcl.use vcl1
## c2 Started
### c2 Connect to 127.0.0.1:9081
### c1 Connected to 127.0.0.1:9081 fd is 12
#### c1 txreq| GET /foo HTTP/1.1\r\n
#### c1 txreq| \r\n
### c1 rxresp
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.use vcl1>
## c3 Starting client
#### v1 CLI TX| vcl.show vcl2
### c2 Connected to 127.0.0.1:9081 fd is 13
#### c2 txreq| GET /foo HTTP/1.1\r\n
#### c2 txreq| \r\n
### c2 rxresp
## c3 Started
### c3 Connect to 127.0.0.1:9081
### c3 Connected to 127.0.0.1:9081 fd is 14
#### c3 txreq| GET /foo HTTP/1.1\r\n
#### c3 txreq| \r\n
### c3 rxresp
#### v1 CLI RX| backend s1 { .host = "127.0.0.1"; .port = "9080"; }\n
#### v1 CLI RX| \n
#### v1 CLI RX| \tsub vcl_recv {\n
#### v1 CLI RX| \t\tpass;\n
#### v1 CLI RX| \t}\n
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.show vcl2>
#### v1 CLI TX| vcl.discard vcl2
#### v1 debug| unlink ./vcl.hndxcCNb.so\n
### v1 CLI STATUS 200
### s1 Accepted socket fd is 11
## v1 CLI 200 <vcl.discard vcl2>
#### v1 CLI TX| vcl.list
### s1 rxreq
#### v1 CLI RX| active 1 vcl1\n
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.list>
# RESETTING after tests/c00015.vtc
## s1 Waiting for server
#### s1 rxhdr| GET /foo HTTP/1.1\r\n
#### s1 rxhdr| X-Varnish: 1001\r\n
#### s1 rxhdr| X-Forwarded-For: 127.0.0.1\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-Varnish: 1001
#### s1 http[ 4] | X-Forwarded-For: 127.0.0.1
#### s1 http[ 5] | Host: 127.0.0.1
#### s1 EXPECT req.url (/foo) == /foo (/foo) match
#### s1 txresp| HTTP/1.1 200 Ok\r\n
#### s1 txresp| Content-Length: 6\r\n
#### s1 txresp| \r\n
#### s1 txresp| foobar\r\n
### s1 rxreq
#### c2 rxhdr| HTTP/1.1 200 Ok\r\n
#### c2 rxhdr| Content-Length: 6\r\n
#### c2 rxhdr| Date: Wed, 13 Aug 2008 19:21:13 GMT\r\n
#### c2 rxhdr| X-Varnish: 1001\r\n
#### c2 rxhdr| Age: 0\r\n
#### c2 rxhdr| Via: 1.1 varnish\r\n
#### c2 rxhdr| Connection: keep-alive\r\n
#### c2 rxhdr| \r\n
#### c2 http[ 0] | HTTP/1.1
#### c2 http[ 1] | 200
#### c2 http[ 2] | Ok
#### c2 http[ 3] | Content-Length: 6
#### c2 http[ 4] | Date: Wed, 13 Aug 2008 19:21:13 GMT
#### c2 http[ 5] | X-Varnish: 1001
#### c2 http[ 6] | Age: 0
#### c2 http[ 7] | Via: 1.1 varnish
#### c2 http[ 8] | Connection: keep-alive
#### c2 body| foobar
#### c2 EXPECT resp.status (200) == 200 (200) match
---- c2 EXPECT resp.http.content-length (6) == 7 (7) failed
; ./varnishtest -v tests/v00006.vtc
# TEST tests/v00006.vtc starting
# TEST VCL: Test backend retirement
## s1 Starting server
### s1 listen on 127.0.0.1:9080 (fd 3)
## v1 Launch
### v1 CMD: cd ../varnishd && ./varnishd -d -d -n /tmp/__v1 -a
'127.0.0.1:9081' -T 127.0.0.1:9001 -p thread_pools=1 -w1,1,300
## s1 Started on 127.0.0.1:9080
### v1 opening CLI connection
#### v1 debug| storage_file: filename: ./varnish.2jaqEs (unlinked)
size 100 MB.\n
#### v1 debug| Using old SHMFILE\n
#### v1 debug| Notice: locking SHMFILE in core failed:
#### v1 debug| Not owner\n
#### v1 debug| Debugging mode, enter "start" to start child\n
### v1 CLI connection fd = 7
#### v1 CLI TX| vcl.inline vcl1 "\n\tbackend b1 {\n\t\t.host =
\"localhost\";\n\t\t.port = \"9080\";\n\t}\n"
#### v1 CLI RX| VCL compiled.
### v1 CLI STATUS 200
#### v1 CLI TX| vcl.use vcl1
### v1 CLI STATUS 200
## v1 Start
#### v1 CLI TX| start
#### v1 debug| child (
#### v1 debug| 9477) Started\n
#### v1 debug| Child (9477) said Closed fds: 3 5 7 8 11 12 14 15\n
### v1 CLI STATUS 200
#### v1 CLI TX| debug.xid 1000
#### v1 debug| Child (9477) said Child starts\n
#### v1 debug| Child (
#### v1 debug| 9477
#### v1 debug| ) said managed to mmap 105172992 bytes of 105172992\n
#### v1 debug| Child (9477) said
#### v1 debug| Ready\n
#### v1 CLI RX| XID is 1000\n
### v1 CLI STATUS 200
## c1 Starting client
## s1 Waiting for server
## c1 Started
### c1 Connect to 127.0.0.1:9081
### c1 Connected to 127.0.0.1:9081 fd is 12
#### c1 txreq| GET / HTTP/1.1\r\n
#### c1 txreq| \r\n
### c1 rxresp
### s1 Accepted socket fd is 11
### s1 rxreq
#### s1 rxhdr| GET / HTTP/1.1\r\n
#### s1 rxhdr| X-Varnish: 1001\r\n
#### s1 rxhdr| X-Forwarded-For: 127.0.0.1\r\n
#### s1 rxhdr| Host: localhost\r\n
#### s1 rxhdr| \r\n
#### s1 http[ 0] | GET
#### s1 http[ 1] | /
#### s1 http[ 2] | HTTP/1.1
#### s1 http[ 3] | X-Varnish: 1001
#### s1 http[ 4] | X-Forwarded-For: 127.0.0.1
#### s1 http[ 5] | Host: localhost
#### s1 txresp| HTTP/1.1 200 Ok\r\n
#### s1 txresp| \r\n
### s1 shutting fd 11
## s1 Ending
## c1 Waiting for client
#### c1 rxhdr| HTTP/1.1 200 Ok\r\n
#### c1 rxhdr| Content-Length: 0\r\n
#### c1 rxhdr| Date: Wed, 13 Aug 2008 19:25: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] | Content-Length: 0
#### c1 http[ 4] | Date: Wed, 13 Aug 2008 19:25:40 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 Closing fd 12
## c1 Ending
## v1 as expected: n_backend (1) == 1
## v1 as expected: n_vcl_avail (1) == 1
## v1 as expected: n_vcl_discard (0) == 0
## s2 Starting server
### s2 listen on 127.0.0.1:9180 (fd 3)
## s2 Started on 127.0.0.1:9180
#### v1 CLI TX| vcl.inline vcl2 "\n\tbackend b2 {\n\t\t.host =
\"localhost\";\n\t\t.port = \"9180\";\n\t}\n"
#### v1 CLI RX| VCL compiled.
### v1 CLI STATUS 200
#### v1 CLI TX| vcl.use vcl2
### v1 CLI STATUS 200
## v1 as expected: n_backend (2) == 2
## v1 as expected: n_vcl_avail (2) == 2
## v1 as expected: n_vcl_discard (0) == 0
#### v1 CLI TX| debug.backend
#### v1 CLI RX| 4ff790 b1 1\n
#### v1 CLI RX| 4ff850 b2 1\n
### v1 CLI STATUS 200
## v1 CLI 200 <debug.backend>
#### v1 CLI TX| vcl.list
#### v1 CLI RX| available 1 vcl1\n
#### v1 CLI RX| active 0 vcl2\n
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.list>
#### v1 CLI TX| vcl.discard vcl1
#### v1 debug| unlink ./vcl.ORk8t3RP.so\n
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.discard vcl1>
## v1 as expected: n_backend (2) == 2
## v1 as expected: n_vcl_avail (1) == 1
## v1 as expected: n_vcl_discard (1) == 1
## c1 Starting client
#### v1 CLI TX| debug.backend
## c1 Started
### c1 Connect to 127.0.0.1:9081
#### v1 CLI RX| 4ff790 b1 1\n
#### v1 CLI RX| 4ff850 b2 1\n
### v1 CLI STATUS 200
## v1 CLI 200 <debug.backend>
#### v1 CLI TX| vcl.list
#### v1 CLI RX| discarded 1 vcl1\n
#### v1 CLI RX| active 0 vcl2\n
### v1 CLI STATUS 200
## v1 CLI 200 <vcl.list>
---- v1 Not true: n_backend (2) == 1 (1)
--
Theo Schlossnagle
Esoteric Curio -- http://lethargy.org/
OmniTI Computer Consulting, Inc. -- http://omniti.com/
More information about the varnish-dev
mailing list