r01818

9e1e097

HTTP rx timeout (fd:18 30000 ms)

1 @ SunOS i86pc 5.11 1.04 32_gcc4.7 uplex

*    top   0.0 TEST ../../../bin/varnishtest/tests/r01818.vtc starting
[...]
*    top   0.0 VTEST #1818: verify that grace works for hit_for_pass objects
[...]
**** v1    3.8 vsl|          0 CLI             - Rd ping
**** v1    3.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951005 1.0
**** v1    6.8 vsl|          0 CLI             - Rd ping
**** v1    6.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951008 1.0
**** v1    9.8 vsl|          0 CLI             - Rd ping
**** v1    9.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951011 1.0
**** v1   12.8 vsl|          0 CLI             - Rd ping
**** v1   12.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951014 1.0
**** v1   15.8 vsl|          0 CLI             - Rd ping
**** v1   15.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951017 1.0
**** v1   18.8 vsl|          0 CLI             - Rd ping
**** v1   18.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951020 1.0
**** v1   21.8 vsl|          0 CLI             - Rd ping
**** v1   21.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951023 1.0
**** v1   24.8 vsl|          0 CLI             - Rd ping
**** v1   24.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951026 1.0
**** v1   27.8 vsl|          0 CLI             - Rd ping
**** v1   27.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951029 1.0
**** v1   30.8 vsl|          0 CLI             - Rd ping
**** v1   30.8 vsl|          0 CLI             - Wr 200 19 PONG 1554951032 1.0
---- c1   31.2 HTTP rx timeout (fd:18 30000 ms)
**   s1   31.2 Waiting for server (3/-1)
**   s2   31.2 Waiting for server (4/-1)
**   v1   31.2 Wait
**** v1   31.2 CLI TX|panic.clear
***  v1   31.2 CLI RX  300
**** v1   31.2 CLI RX|No panic to clear
***  v1   31.2 debug|Info: manager stopping child
***  v1   31.2 debug|Debug: Stopping Child
**** v1   31.3 vsl|       1005 FetchError      b HTC eof (-1)
**** v1   31.3 vsl|       1005 BackendClose    b 19 s1
**** v1   31.3 vsl|       1005 Timestamp       b Beresp: 1554951032.927547 29.999895 29.978143
**** v1   31.3 vsl|       1005 Timestamp       b Error: 1554951032.927562 29.999909 0.000015
**** v1   31.3 vsl|       1005 BerespProtocol  b HTTP/1.1
**** v1   31.3 vsl|       1005 BerespStatus    b 503
**** v1   31.3 vsl|       1005 BerespReason    b Service Unavailable
**** v1   31.3 vsl|       1005 BerespReason    b Backend fetch failed
**** v1   31.3 vsl|       1005 BerespHeader    b Date: Thu, 11 Apr 2019 02:50:32 GMT
**** v1   31.3 vsl|       1005 BerespHeader    b Server: Varnish
**** v1   31.3 vsl|       1005 VCL_call        b BACKEND_ERROR

HTTP rx timeout (fd:19 30000 ms)

1 @ SunOS i86pc 5.11 1.04 32_gcc4.7 uplex

*    top   0.0 TEST ../../../bin/varnishtest/tests/r01818.vtc starting
[...]
*    top   0.0 VTEST #1818: verify that grace works for hit_for_pass objects
[...]
**** v1    3.9 vsl|          0 CLI             - Rd ping
**** v1    3.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294804 1.0
**** v1    6.9 vsl|          0 CLI             - Rd ping
**** v1    6.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294807 1.0
**** v1    9.9 vsl|          0 CLI             - Rd ping
**** v1    9.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294810 1.0
**** v1   12.9 vsl|          0 CLI             - Rd ping
**** v1   12.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294813 1.0
**** v1   15.9 vsl|          0 CLI             - Rd ping
**** v1   15.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294816 1.0
**** v1   18.9 vsl|          0 CLI             - Rd ping
**** v1   18.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294819 1.0
**** v1   21.9 vsl|          0 CLI             - Rd ping
**** v1   21.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294822 1.0
**** v1   24.9 vsl|          0 CLI             - Rd ping
**** v1   24.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294825 1.0
**** v1   27.9 vsl|          0 CLI             - Rd ping
**** v1   27.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294828 1.0
**** v1   30.9 vsl|          0 CLI             - Rd ping
**** v1   30.9 vsl|          0 CLI             - Wr 200 19 PONG 1555294831 1.0
---- c1   31.2 HTTP rx timeout (fd:19 30000 ms)
**   s1   31.2 Waiting for server (3/-1)
**   s2   31.2 Waiting for server (4/-1)
**   v1   31.2 Wait
**** v1   31.2 CLI TX|panic.clear
***  v1   31.2 CLI RX  300
**** v1   31.2 CLI RX|No panic to clear
***  v1   31.2 debug|Info: manager stopping child
***  v1   31.2 debug|Debug: Stopping Child
**** v1   31.3 vsl|       1005 FetchError      b HTC eof (-1)
**** v1   31.3 vsl|       1005 BackendClose    b 20 s1
**** v1   31.3 vsl|       1005 Timestamp       b Beresp: 1555294832.239844 29.999842 29.959199
**** v1   31.3 vsl|       1005 Timestamp       b Error: 1555294832.239852 29.999849 0.000008
**** v1   31.3 vsl|       1005 BerespProtocol  b HTTP/1.1
**** v1   31.3 vsl|       1005 BerespStatus    b 503
**** v1   31.3 vsl|       1005 BerespReason    b Service Unavailable
**** v1   31.3 vsl|       1005 BerespReason    b Backend fetch failed
**** v1   31.3 vsl|       1005 BerespHeader    b Date: Mon, 15 Apr 2019 02:20:32 GMT
**** v1   31.3 vsl|       1005 BerespHeader    b Server: Varnish
**** v1   31.3 vsl|       1005 VCL_call        b BACKEND_ERROR

HTTP rx timeout (fd:20 30000 ms)

1 @ Linux x86_64 4.20.13 1.04 gcc uplex

*    top   0.0 TEST ../../../../bin/varnishtest/tests/r01818.vtc starting
[...]
*    top   0.0 VTEST #1818: verify that grace works for hit_for_pass objects
[...]
**** v1    3.5 vsl|          0 CLI             - Rd ping
**** v1    3.5 vsl|          0 CLI             - Wr 200 19 PONG 1554937054 1.0
**** v1    6.5 vsl|          0 CLI             - Rd ping
**** v1    6.5 vsl|          0 CLI             - Wr 200 19 PONG 1554937057 1.0
**** v1    9.6 vsl|          0 CLI             - Rd ping
**** v1    9.6 vsl|          0 CLI             - Wr 200 19 PONG 1554937060 1.0
**** v1   12.5 vsl|          0 CLI             - Rd ping
**** v1   12.5 vsl|          0 CLI             - Wr 200 19 PONG 1554937063 1.0
**** v1   15.6 vsl|          0 CLI             - Rd ping
**** v1   15.6 vsl|          0 CLI             - Wr 200 19 PONG 1554937066 1.0
**** v1   18.5 vsl|          0 CLI             - Rd ping
**** v1   18.5 vsl|          0 CLI             - Wr 200 19 PONG 1554937069 1.0
**** v1   21.5 vsl|          0 CLI             - Rd ping
**** v1   21.5 vsl|          0 CLI             - Wr 200 19 PONG 1554937072 1.0
**** v1   24.6 vsl|          0 CLI             - Rd ping
**** v1   24.6 vsl|          0 CLI             - Wr 200 19 PONG 1554937075 1.0
**** v1   27.5 vsl|          0 CLI             - Rd ping
**** v1   27.5 vsl|          0 CLI             - Wr 200 19 PONG 1554937078 1.0
**** v1   30.5 vsl|          0 CLI             - Rd ping
**** v1   30.5 vsl|          0 CLI             - Wr 200 19 PONG 1554937081 1.0
---- c1   31.1 HTTP rx timeout (fd:20 30000 ms)
**   s1   31.1 Waiting for server (4/-1)
**   s2   31.1 Waiting for server (5/-1)
**   v1   31.1 Wait
**** v1   31.1 CLI TX|panic.clear
**** v1   31.1 vsl|       1005 FetchError      b HTC eof (-1)
**** v1   31.1 vsl|       1005 BackendClose    b 24 s1
**** v1   31.1 vsl|       1005 Timestamp       b Beresp: 1554937082.199050 30.100071 30.086009
**** v1   31.1 vsl|       1005 Timestamp       b Error: 1554937082.199058 30.100079 0.000008
**** v1   31.1 vsl|       1005 BerespProtocol  b HTTP/1.1
**** v1   31.1 vsl|       1005 BerespStatus    b 503
**** v1   31.1 vsl|       1005 BerespReason    b Service Unavailable
**** v1   31.1 vsl|       1005 BerespReason    b Backend fetch failed
**** v1   31.1 vsl|       1005 BerespHeader    b Date: Wed, 10 Apr 2019 22:58:02 GMT
**** v1   31.1 vsl|       1005 BerespHeader    b Server: Varnish
**** v1   31.1 vsl|       1005 VCL_call        b BACKEND_ERROR
**** v1   31.1 vsl|       1005 BerespHeader    b Content-Type: text/html; charset=utf-8
**** v1   31.1 vsl|       1005 BerespHeader    b Retry-After: 5
**** v1   31.1 vsl|       1005 VCL_return      b deliver
**** v1   31.1 vsl|       1005 Storage         b malloc Transient