v00051

afb5c06

Failed to open 127.0.0.1 62606: (null)

1 @ SunOS 5.11 i86pc 1.04 32_sun12.4 uplex

*    top   0.0 TEST ../../../bin/varnishtest/tests/v00051.vtc starting
[...]
*    top   0.0 TEST Test VCL failures
[...]
**   top   0.3 === logexpect l1 -wait
**   l1    0.3 Waiting for logexp
**** l1    0.3 match|       1001 VCL_call        c RECV
***  l1    0.3 expecting| expect 0 1001 VCL_Error Forced failure
**** l1    0.3 match|       1001 VCL_Error       c Forced failure
***  l1    0.3 expecting| expect 0 1001 VCL_return fail
**** l1    0.3 match|       1001 VCL_return      c fail
**** l1    0.3 end|
**   top   0.3 === logexpect l1 -v v1 -g raw {
**   l1    0.3 === expect * 1003	VCL_call	"RECV"
**   l1    0.3 === expect 0 1003	VCL_Error	"Forced failure"
**   l1    0.3 === expect 0 1003	VCL_return	"fail"
**   l1    0.3 === expect * 1003	VCL_call	"SYNTH"
**   l1    0.3 === expect 0 1003	VCL_return	"restart"
**   top   0.3 === client c1 {
**   c1    0.3 Starting client
**** l1    0.3 begin|
***  l1    0.3 expecting| expect * 1003 VCL_call RECV
**   c1    0.3 Waiting for client
***  c1    0.3 Connect to 127.0.0.1 62606
---- c1    0.3 Failed to open 127.0.0.1 62606: (null)
*    top   0.3 RESETTING after ../../../bin/varnishtest/tests/v00051.vtc
**   s1    0.3 Waiting for server (3/-1)
**** s1    0.3 macro undef s1_addr
**** s1    0.3 macro undef s1_port
**** s1    0.3 macro undef s1_sock
**   v1    0.3 Wait
***  v1    0.3 debug|Debug: Stopping Child
**** v1    0.4 vsl|       1000 Begin           c sess 0 HTTP/1
**** v1    0.4 vsl|       1000 SessOpen        c 127.0.0.1 50791 127.0.0.1:62606 127.0.0.1 62606 1498469210.306805 16
**** v1    0.4 vsl|       1000 Link            c req 1001 rxreq
**** v1    0.4 vsl|       1001 Begin           c req 1000 rxreq
**** v1    0.4 vsl|       1001 Timestamp       c Start: 1498469210.306966 0.000000 0.000000
**** v1    0.4 vsl|       1001 Timestamp       c Req: 1498469210.306966 0.000000 0.000000
**** v1    0.4 vsl|       1001 ReqStart        c 127.0.0.1 50791
**** v1    0.4 vsl|       1001 ReqMethod       c GET
**** v1    0.4 vsl|       1001 ReqURL          c /
**** v1    0.4 vsl|       1001 ReqProtocol     c HTTP/1.1
**** v1    0.4 vsl|       1001 ReqHeader       c X-Forwarded-For: 127.0.0.1
**** v1    0.4 vsl|       1001 VCL_call        c RECV

66d1732

Failed to open 127.0.0.1 43859: (null)

1 @ SunOS 5.11 i86pc 1.04 32_sun12.4 uplex

*    top   0.0 TEST ../../../bin/varnishtest/tests/v00051.vtc starting
[...]
*    top   0.0 TEST Test VCL failures
[...]
**** v1    0.5 CLI RX|Message from VCC-compiler:
**** v1    0.5 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.5 CLI RX|Message from C-compiler:
**** v1    0.5 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.5 CLI RX|Message from dlopen:
**** v1    0.5 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.5 CLI RX|VCL compiled.
**** v1    0.5 CLI TX|vcl.use vcl3
***  v1    0.5 CLI RX  200
**** v1    0.5 CLI RX|VCL 'vcl3' now active
**   top   0.5 === logexpect l1 -v v1 -g raw {
**   l1    0.5 === expect * 1009	VCL_call	"HASH"
**   l1    0.5 === expect 0 1009	VCL_Error	"Forced failure"
**   l1    0.5 === expect 0 1009	VCL_return	"fail"
**   top   0.5 === client c1 {
**   c1    0.5 Starting client
**** l1    0.5 begin|
***  l1    0.5 expecting| expect * 1009 VCL_call HASH
**   c1    0.5 Waiting for client
***  c1    0.5 Connect to 127.0.0.1 43859
---- c1    0.5 Failed to open 127.0.0.1 43859: (null)
*    top   0.5 RESETTING after ../../../bin/varnishtest/tests/v00051.vtc
**   s1    0.5 Waiting for server (3/-1)
**** s1    0.5 macro undef s1_addr
**** s1    0.5 macro undef s1_port
**** s1    0.5 macro undef s1_sock
**   v1    0.5 Wait
***  v1    0.5 debug|Debug: Stopping Child
**** v1    0.6 vsl|          0 CLI             - Rd vcl.load vcl3 vcl_vcl3.1497703199.324391603/vgc.so 1auto
**** v1    0.6 vsl|          0 Debug           - vcl3: VCL_EVENT_WARM
**** v1    0.6 vsl|          0 CLI             - Wr 200 55 Loaded "vcl_vcl3.1497703199.324391603/vgc.so" as "vcl3"
**** v1    0.6 vsl|          0 CLI             - Rd vcl.use vcl3
**** v1    0.6 vsl|          0 CLI             - Wr 200 0
**** v1    0.6 vsl|          0 CLI             - EOF on CLI connection, worker stops
***  v1    1.5 debug|Info: Child (2135) ended
---- l1    1.5 bad| dispatch failed (-2)
***  v1    1.6 debug|Info: Child (2135) said Child dies
***  v1    1.6 debug|Debug: Child cleanup complete
***  v1    1.6 debug|
**** v1    1.6 STDOUT poll 0x10

Failed to open 127.0.0.1 35645: (null)

1 @ SunOS 5.11 i86pc 1.04 64_sun12.4 uplex

*    top   0.0 TEST ../../../bin/varnishtest/tests/v00051.vtc starting
[...]
*    top   0.0 TEST Test VCL failures
[...]
**** v1    0.6 CLI RX|Message from VCC-compiler:
**** v1    0.6 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.6 CLI RX|Message from C-compiler:
**** v1    0.6 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.6 CLI RX|Message from dlopen:
**** v1    0.6 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.6 CLI RX|VCL compiled.
**** v1    0.6 CLI TX|vcl.use vcl3
***  v1    0.6 CLI RX  200
**** v1    0.6 CLI RX|VCL 'vcl3' now active
**   top   0.6 === logexpect l1 -v v1 -g raw {
**   l1    0.6 === expect * 1009	VCL_call	"HASH"
**   l1    0.6 === expect 0 1009	VCL_Error	"Forced failure"
**   l1    0.6 === expect 0 1009	VCL_return	"fail"
**   top   0.6 === client c1 {
**   c1    0.6 Starting client
**** l1    0.6 begin|
***  l1    0.6 expecting| expect * 1009 VCL_call HASH
**   c1    0.6 Waiting for client
***  c1    0.6 Connect to 127.0.0.1 35645
---- c1    0.6 Failed to open 127.0.0.1 35645: (null)
*    top   0.6 RESETTING after ../../../bin/varnishtest/tests/v00051.vtc
**   s1    0.6 Waiting for server (3/-1)
**** s1    0.6 macro undef s1_addr
**** s1    0.6 macro undef s1_port
**** s1    0.6 macro undef s1_sock
**   v1    0.6 Wait
***  v1    0.6 debug|Debug: Stopping Child
**** v1    0.6 vsl|          0 CLI             - Rd vcl.load vcl3 vcl_vcl3.1497809384.257101774/vgc.so 1auto
**** v1    0.6 vsl|          0 Debug           - vcl3: VCL_EVENT_WARM
**** v1    0.6 vsl|          0 CLI             - Wr 200 55 Loaded "vcl_vcl3.1497809384.257101774/vgc.so" as "vcl3"
**** v1    0.6 vsl|          0 CLI             - Rd vcl.use vcl3
**** v1    0.6 vsl|          0 CLI             - Wr 200 0
**** v1    0.6 vsl|          0 CLI             - EOF on CLI connection, worker stops
***  v1    1.6 debug|Info: Child (49574) ended
---- l1    1.6 bad| dispatch failed (-2)
***  v1    1.6 debug|Info: Child (49574) said Child dies
***  v1    1.6 debug|Debug:
***  v1    1.6 debug| Child cleanup complete
**** v1    1.6 STDOUT poll 0x10

b262392

Failed to open 127.0.0.1 42113: (null)

1 @ SunOS 5.11 i86pc 1.04 32_sun12.4 uplex

*    top   0.0 TEST ../../../bin/varnishtest/tests/v00051.vtc starting
[...]
*    top   0.0 TEST Test VCL failures
[...]
**** v1    0.5 CLI RX|Message from VCC-compiler:
**** v1    0.5 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.5 CLI RX|Message from C-compiler:
**** v1    0.5 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.5 CLI RX|Message from dlopen:
**** v1    0.5 CLI RX|Security: Privilege proc_setid missing, will not change uid/gid
**** v1    0.5 CLI RX|VCL compiled.
**** v1    0.5 CLI TX|vcl.use vcl3
***  v1    0.5 CLI RX  200
**** v1    0.5 CLI RX|VCL 'vcl3' now active
**   top   0.5 === logexpect l1 -v v1 -g raw {
**   l1    0.5 === expect * 1009	VCL_call	"HASH"
**   l1    0.5 === expect 0 1009	VCL_Error	"Forced failure"
**   l1    0.5 === expect 0 1009	VCL_return	"fail"
**   top   0.5 === client c1 {
**   c1    0.5 Starting client
**** l1    0.5 begin|
***  l1    0.5 expecting| expect * 1009 VCL_call HASH
**   c1    0.5 Waiting for client
***  c1    0.5 Connect to 127.0.0.1 42113
---- c1    0.5 Failed to open 127.0.0.1 42113: (null)
*    top   0.5 RESETTING after ../../../bin/varnishtest/tests/v00051.vtc
**   s1    0.5 Waiting for server (3/-1)
**** s1    0.5 macro undef s1_addr
**** s1    0.5 macro undef s1_port
**** s1    0.5 macro undef s1_sock
**   v1    0.5 Wait
***  v1    0.5 debug|Debug: Stopping Child
**** v1    0.6 vsl|          0 CLI             - Rd vcl.load vcl3 vcl_vcl3.1497401390.830409288/vgc.so 1auto
**** v1    0.6 vsl|          0 Debug           - vcl3: VCL_EVENT_WARM
**** v1    0.6 vsl|          0 CLI             - Wr 200 55 Loaded "vcl_vcl3.1497401390.830409288/vgc.so" as "vcl3"
**** v1    0.6 vsl|          0 CLI             - Rd vcl.use vcl3
**** v1    0.6 vsl|          0 CLI             - Wr 200 0
**** v1    0.6 vsl|          0 CLI             - EOF on CLI connection, worker stops
***  v1    1.5 debug|Info: Child (28185) ended
---- l1    1.5 bad| dispatch failed (-2)
***  v1    1.5 debug|Info: Child (28185) said Child dies
***  v1    1.5 debug|Debug: Child cleanup complete
***  v1    1.5 debug|
**** v1    1.5 STDOUT poll 0x10