You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@trafficserver.apache.org by je...@ci.trafficserver.apache.org on 2015/10/21 17:26:09 UTC

Build failed in Jenkins: tsqa-master #936

See <https://ci.trafficserver.apache.org/job/tsqa-master/936/changes>

Changes:

[James Peach] TS-3975: ESI plugin missing TSPluginRegister

------------------------------------------
[...truncated 497 lines...]
Verify that we get 504s from origins that return a partial_response ... ok
Verify that we get 502s from origins that reset_after_accept, once any bytes are sent to origin we assume we cannot re-dispatch ... ok
INFO 2015-10-21 15:17:17,067 - Environment prefix is /tmp/tsqa.env.59B2o4
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-21 15:19:00,614 - Environment prefix is /tmp/tsqa.env.eRqMjH
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-21 15:19:31,063 - Starting build (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-21 15:20:24,443 - Build completed (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-21 15:20:24,511 - Environment prefix is /tmp/tsqa.env.iTcsdX
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-21 15:20:27,919 - Environment prefix is /tmp/tsqa.env.IGtQBz
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [21/Oct/2015 15:20:31] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-21 15:20:31,330 - Environment prefix is /tmp/tsqa.env.sTTEkI
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-21 15:20:44,850 - Environment prefix is /tmp/tsqa.env.rXefLD
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:48] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:20:48,315 - Environment prefix is /tmp/tsqa.env.deweC1
INFO 2015-10-21 15:20:48,318 - map / http://127.0.0.1:35676/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-21 15:20:51,545 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:20:51 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:20:51,545 - head request with case(TE) costs 0.001953 seconds while the timout is 5.000000 seconds.
INFO 2015-10-21 15:20:51,547 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:20:51 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:20:51,547 - head request with case(CL) costs 0.001587 seconds while the timout is 5.000000 seconds.
INFO 2015-10-21 15:20:51,566 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:20:51 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:20:51,566 - head request with case() costs 0.019163 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-21 15:20:51,752 - Environment prefix is /tmp/tsqa.env.Podrxx
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-21 15:20:55,205 - Environment prefix is /tmp/tsqa.env.Cu6glN
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-21 15:21:00,640 - Environment prefix is /tmp/tsqa.env.YIsNqI
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-21 15:21:10,153 - Environment prefix is /tmp/tsqa.env.sbX4XC
SKIP: 
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.sbX4XC
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-10-21 15:21:10,244 - Environment prefix is /tmp/tsqa.env.hlUNXR
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.hlUNXR
--------------------- >> end captured logging << ---------------------
INFO 2015-10-21 15:21:10,352 - Environment prefix is /tmp/tsqa.env.T5Aykv
test_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:21:13,871 - Environment prefix is /tmp/tsqa.env.vqFd75
test_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:21:17,424 - Environment prefix is /tmp/tsqa.env.m2mxSH
test_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:21:20,995 - Environment prefix is /tmp/tsqa.env.TrH2ZC
test_error_path (test_keepalive.TestKeepAliveInHTTP) ... ok
Ensure that sending a request with a body doesn't break the keepalive session ... ok
test_working_path (test_keepalive.TestKeepAliveInHTTP) ... 127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:24] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:21:24,423 - Environment prefix is /tmp/tsqa.env.1p0LOQ
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-21 15:21:30,840 - Environment prefix is /tmp/tsqa.env.R4WsAb
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-21 15:21:37,281 - Environment prefix is /tmp/tsqa.env.1qlpAg
Test that the origin does in fact support keepalive via http. ... ok
Tests that keepalive works through ATS to origin via http. ... ok
Tests that origin does not timeout using keepalive via http. ... ok
Tests that keepalive timeout is honored through ATS to origin via http. ... ok
INFO 2015-10-21 15:21:58,771 - Environment prefix is /tmp/tsqa.env.F7JoRl
Test that the origin does in fact support keepalive via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
Tests that origin does not timeout using keepalive via https. ... ok
Tests that keepalive timeout is honored through ATS to origin via https. ... ok
INFO 2015-10-21 15:22:20,273 - Environment prefix is /tmp/tsqa.env.fFLRxR
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-21 15:22:23,748 - Environment prefix is /tmp/tsqa.env.SXXsiP
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-21 15:22:27,177 - Environment prefix is /tmp/tsqa.env.4MlHBE
INFO 2015-10-21 15:22:27,179 - socket_server_port = 56664
INFO 2015-10-21 15:22:27,179 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-21 15:22:30,441 - Sending data back to the client: af66bca4cdf04a0da6d2552de30c0a43
INFO 2015-10-21 15:22:30,442 - af66bca4cdf04a0da6d2552de30c0a43
INFO 2015-10-21 15:22:35,454 - Sending data back to the client: af66bca4cdf04a0da6d2552de30c0a43
INFO 2015-10-21 15:22:35,461 - af66bca4cdf04a0da6d2552de30c0a43
ok
INFO 2015-10-21 15:22:35,648 - Environment prefix is /tmp/tsqa.env.eGX74K
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:38] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-21 15:22:39,123 - Environment prefix is /tmp/tsqa.env.cKqcPc
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-21 15:25:13,187 - Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
SKIP: Error 1 running: ['<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/configure',> '--prefix=/', '--enable-ccache', '--enable-experimental-plugins', '--enable-example-plugins', '--enable-test-tools', '--enable-linux-native-aio', '--disable-dependency-tracking']
configure: error: Linux native AIO requires libaio.h

-------------------- >> begin captured logging << --------------------
tsqa.environment: INFO: Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
--------------------- >> end captured logging << ---------------------
INFO 2015-10-21 15:25:22,772 - Environment prefix is /tmp/tsqa.env.fKOp9X
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [21/Oct/2015 15:25:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:26] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:25:26,257 - Environment prefix is /tmp/tsqa.env.Pm1ruu
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [21/Oct/2015 15:25:29] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:29] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:29] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-21 15:25:29,765 - Environment prefix is /tmp/tsqa.env.OY6RRe
INFO 2015-10-21 15:25:29,767 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-21 15:25:29,767 - spdy server port = 59154
INFO 2015-10-21 15:25:29,767 - http server port = 47871
Test that the origin does in fact support spdy 3 ... INFO 2015-10-21 15:25:32,996 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59154/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-21 15:25:34,167 - full args = ['/usr/local/bin/spdycat', 'https://localhost:47871/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-21 15:25:34,367 - Environment prefix is /tmp/tsqa.env.W_cmNw
INFO 2015-10-21 15:25:34,369 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-21 15:25:34,370 - spdy server port = 43707
INFO 2015-10-21 15:25:34,370 - http server port = 58789
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-21 15:25:37,599 - full args = ['/usr/local/bin/spdycat', 'https://localhost:43707/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-21 15:25:38,717 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58789/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-21 15:25:38,926 - Environment prefix is /tmp/tsqa.env.YJkHdR
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok

======================================================================
ERROR: test_chunked_bad_close (test_chunked.TestChunked)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_chunked.py",> line 198, in test_chunked_bad_close
    requests.get(url, proxies=self.proxies, timeout=2)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/api.py",> line 69, in get
    return request('get', url, params=params, **kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/api.py",> line 50, in request
    response = session.request(method=method, url=url, **kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/sessions.py",> line 468, in request
    resp = self.send(prep, **send_kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/sessions.py",> line 608, in send
    r.content
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/models.py",> line 734, in content
    self._content = bytes().join(self.iter_content(CONTENT_CHUNK_SIZE)) or bytes()
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/models.py",> line 664, in generate
    raise ConnectionError(e)
ConnectionError: HTTPConnectionPool(host='127.0.0.1', port=45122): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.ufXwaW
test_chunked: INFO: sending data back to the client
test_chunked: INFO: Client disconnected
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 936.503s

FAILED (SKIP=8, errors=1)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results

Build failed in Jenkins: tsqa-master #938

Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/938/changes>

Changes:

[Leif Hedstrom] TS-2427 Makes the debug header configurable

------------------------------------------
[...truncated 492 lines...]
Verify that we get 504s from origins that return a partial_response ... ok
Verify that we get 502s from origins that reset_after_accept, once any bytes are sent to origin we assume we cannot re-dispatch ... ok
INFO 2015-10-21 15:34:24,731 - Environment prefix is /tmp/tsqa.env.hg5Phr
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-21 15:36:08,281 - Environment prefix is /tmp/tsqa.env.z87x7w
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-21 15:36:38,958 - Starting build (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-21 15:37:29,746 - Build completed (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-21 15:37:29,819 - Environment prefix is /tmp/tsqa.env.Fj9N8v
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-21 15:37:33,240 - Environment prefix is /tmp/tsqa.env.zdxMYa
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [21/Oct/2015 15:37:36] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-21 15:37:36,657 - Environment prefix is /tmp/tsqa.env.DueZ39
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-21 15:37:50,156 - Environment prefix is /tmp/tsqa.env.6TEbJc
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:37:53] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:37:53,617 - Environment prefix is /tmp/tsqa.env.KpzMYI
INFO 2015-10-21 15:37:53,619 - map / http://127.0.0.1:47735/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-21 15:37:56,847 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:37:56 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:37:56,848 - head request with case(TE) costs 0.002695 seconds while the timout is 5.000000 seconds.
INFO 2015-10-21 15:37:56,849 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:37:56 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:37:56,849 - head request with case(CL) costs 0.001273 seconds while the timout is 5.000000 seconds.
INFO 2015-10-21 15:37:56,868 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:37:56 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:37:56,869 - head request with case() costs 0.019355 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-21 15:37:57,054 - Environment prefix is /tmp/tsqa.env.0vb7MD
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-21 15:38:00,506 - Environment prefix is /tmp/tsqa.env.mIVHtb
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-21 15:38:05,948 - Environment prefix is /tmp/tsqa.env.UtXzTK
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-21 15:38:15,451 - Environment prefix is /tmp/tsqa.env.Ab8FBZ
SKIP: 
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Ab8FBZ
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-10-21 15:38:15,539 - Environment prefix is /tmp/tsqa.env.sBS8wd
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.sBS8wd
--------------------- >> end captured logging << ---------------------
INFO 2015-10-21 15:38:15,644 - Environment prefix is /tmp/tsqa.env.9H03y_
test_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:38:19,172 - Environment prefix is /tmp/tsqa.env.oJVBxx
test_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:38:22,733 - Environment prefix is /tmp/tsqa.env.gHLxz4
test_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:38:26,385 - Environment prefix is /tmp/tsqa.env.Vbl97z
test_error_path (test_keepalive.TestKeepAliveInHTTP) ... ok
Ensure that sending a request with a body doesn't break the keepalive session ... ok
test_working_path (test_keepalive.TestKeepAliveInHTTP) ... 127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:38:29] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:38:29,843 - Environment prefix is /tmp/tsqa.env.eTDZ1A
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-21 15:38:36,260 - Environment prefix is /tmp/tsqa.env.LpP7pV
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-21 15:38:42,695 - Environment prefix is /tmp/tsqa.env.U0LUge
Test that the origin does in fact support keepalive via http. ... ok
Tests that keepalive works through ATS to origin via http. ... ok
Tests that origin does not timeout using keepalive via http. ... ok
Tests that keepalive timeout is honored through ATS to origin via http. ... ok
INFO 2015-10-21 15:39:04,178 - Environment prefix is /tmp/tsqa.env.R28PDR
Test that the origin does in fact support keepalive via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
Tests that origin does not timeout using keepalive via https. ... ok
Tests that keepalive timeout is honored through ATS to origin via https. ... ok
INFO 2015-10-21 15:39:25,670 - Environment prefix is /tmp/tsqa.env.9yxjiB
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-21 15:39:29,132 - Environment prefix is /tmp/tsqa.env.bbIYlV
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-21 15:39:32,556 - Environment prefix is /tmp/tsqa.env.5ez7ba
INFO 2015-10-21 15:39:32,558 - socket_server_port = 39443
INFO 2015-10-21 15:39:32,558 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-21 15:39:35,823 - Sending data back to the client: 2dd90af3a314400597958ec6593fc604
INFO 2015-10-21 15:39:35,823 - 2dd90af3a314400597958ec6593fc604
INFO 2015-10-21 15:39:40,837 - Sending data back to the client: 2dd90af3a314400597958ec6593fc604
INFO 2015-10-21 15:39:40,845 - 2dd90af3a314400597958ec6593fc604
ok
INFO 2015-10-21 15:39:41,032 - Environment prefix is /tmp/tsqa.env.XVRSqK
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:39:44] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-21 15:39:44,490 - Environment prefix is /tmp/tsqa.env.YWaP72
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-21 15:42:18,554 - Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
SKIP: Error 1 running: ['<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/configure',> '--prefix=/', '--enable-ccache', '--enable-experimental-plugins', '--enable-example-plugins', '--enable-test-tools', '--enable-linux-native-aio', '--disable-dependency-tracking']
configure: error: Linux native AIO requires libaio.h

-------------------- >> begin captured logging << --------------------
tsqa.environment: INFO: Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
--------------------- >> end captured logging << ---------------------
INFO 2015-10-21 15:42:27,971 - Environment prefix is /tmp/tsqa.env.VN_mhN
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [21/Oct/2015 15:42:31] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:42:31] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:42:31] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:42:31,434 - Environment prefix is /tmp/tsqa.env.8Y44Ct
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [21/Oct/2015 15:42:34] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:42:34] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:42:34] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-21 15:42:34,913 - Environment prefix is /tmp/tsqa.env.xr61O9
INFO 2015-10-21 15:42:34,915 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-21 15:42:34,915 - spdy server port = 40589
INFO 2015-10-21 15:42:34,915 - http server port = 58763
Test that the origin does in fact support spdy 3 ... INFO 2015-10-21 15:42:38,149 - full args = ['/usr/local/bin/spdycat', 'https://localhost:40589/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-21 15:42:39,253 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58763/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-21 15:42:39,461 - Environment prefix is /tmp/tsqa.env.hdy0C3
INFO 2015-10-21 15:42:39,463 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-21 15:42:39,463 - spdy server port = 47496
INFO 2015-10-21 15:42:39,463 - http server port = 43342
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-21 15:42:42,690 - full args = ['/usr/local/bin/spdycat', 'https://localhost:47496/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-21 15:42:43,851 - full args = ['/usr/local/bin/spdycat', 'https://localhost:43342/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-21 15:42:44,056 - Environment prefix is /tmp/tsqa.env.cTZrjh
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok

======================================================================
ERROR: test_chunked_bad_close (test_chunked.TestChunked)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_chunked.py",> line 198, in test_chunked_bad_close
    requests.get(url, proxies=self.proxies, timeout=2)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/api.py",> line 69, in get
    return request('get', url, params=params, **kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/api.py",> line 50, in request
    response = session.request(method=method, url=url, **kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/sessions.py",> line 468, in request
    resp = self.send(prep, **send_kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/sessions.py",> line 608, in send
    r.content
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/models.py",> line 734, in content
    self._content = bytes().join(self.iter_content(CONTENT_CHUNK_SIZE)) or bytes()
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/models.py",> line 664, in generate
    raise ConnectionError(e)
ConnectionError: HTTPConnectionPool(host='127.0.0.1', port=34695): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.bUm9Q0
test_chunked: INFO: sending data back to the client
test_chunked: INFO: Client disconnected
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 921.255s

FAILED (SKIP=8, errors=1)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results

Build failed in Jenkins: tsqa-master #937

Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/937/changes>

Changes:

[James Peach] TS-3975: ESI plugin missing TSPluginRegister

------------------------------------------
[...truncated 491 lines...]
Verify that we get 502s from origins that bind + listen ... ok
Verify that we get 504s from origins that return a partial_response ... ok
Verify that we get 502s from origins that reset_after_accept, once any bytes are sent to origin we assume we cannot re-dispatch ... ok
INFO 2015-10-21 15:17:16,246 - Environment prefix is /tmp/tsqa.env.YJq46l
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-21 15:18:59,801 - Environment prefix is /tmp/tsqa.env.UsROC6
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-21 15:19:32,053 - Starting build (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-21 15:20:29,246 - Build completed (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-21 15:20:29,308 - Environment prefix is /tmp/tsqa.env.xg4oxc
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-21 15:20:32,820 - Environment prefix is /tmp/tsqa.env.pzrb4S
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [21/Oct/2015 15:20:36] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-21 15:20:36,256 - Environment prefix is /tmp/tsqa.env.4aGHYM
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-21 15:20:49,834 - Environment prefix is /tmp/tsqa.env.zULoAK
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:20:53] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:20:53,316 - Environment prefix is /tmp/tsqa.env.OEvK_X
INFO 2015-10-21 15:20:53,319 - map / http://127.0.0.1:56647/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-21 15:20:56,561 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:20:56 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:20:56,561 - head request with case(TE) costs 0.008692 seconds while the timout is 5.000000 seconds.
INFO 2015-10-21 15:20:56,562 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:20:56 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:20:56,562 - head request with case(CL) costs 0.001217 seconds while the timout is 5.000000 seconds.
INFO 2015-10-21 15:20:56,563 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 21 Oct 2015 15:20:56 GMT
Age: 0
Connection: close


INFO 2015-10-21 15:20:56,563 - head request with case() costs 0.001098 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-21 15:20:56,747 - Environment prefix is /tmp/tsqa.env.3__xSF
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-21 15:21:00,243 - Environment prefix is /tmp/tsqa.env._QMCl2
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-21 15:21:05,778 - Environment prefix is /tmp/tsqa.env.wKGrCh
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-21 15:21:15,367 - Environment prefix is /tmp/tsqa.env.VrlxgN
SKIP: 
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.VrlxgN
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-10-21 15:21:15,459 - Environment prefix is /tmp/tsqa.env.x3gYAL
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.x3gYAL
--------------------- >> end captured logging << ---------------------
INFO 2015-10-21 15:21:15,568 - Environment prefix is /tmp/tsqa.env.wwThXi
test_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:21:19,307 - Environment prefix is /tmp/tsqa.env.e1_WZx
test_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:21:22,874 - Environment prefix is /tmp/tsqa.env.A2oqlJ
test_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-21 15:21:26,450 - Environment prefix is /tmp/tsqa.env.tYCHVR
test_error_path (test_keepalive.TestKeepAliveInHTTP) ... ok
Ensure that sending a request with a body doesn't break the keepalive session ... ok
test_working_path (test_keepalive.TestKeepAliveInHTTP) ... 127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:21:29] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:21:29,930 - Environment prefix is /tmp/tsqa.env.OnBzzj
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-21 15:21:36,393 - Environment prefix is /tmp/tsqa.env.qexu0w
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-21 15:21:42,873 - Environment prefix is /tmp/tsqa.env.94CJqc
Test that the origin does in fact support keepalive via http. ... ok
Tests that keepalive works through ATS to origin via http. ... ok
Tests that origin does not timeout using keepalive via http. ... ok
Tests that keepalive timeout is honored through ATS to origin via http. ... ok
INFO 2015-10-21 15:22:04,402 - Environment prefix is /tmp/tsqa.env.nDtUyK
Test that the origin does in fact support keepalive via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
Tests that origin does not timeout using keepalive via https. ... ok
Tests that keepalive timeout is honored through ATS to origin via https. ... ok
INFO 2015-10-21 15:22:25,953 - Environment prefix is /tmp/tsqa.env.AoS7tJ
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-21 15:22:29,465 - Environment prefix is /tmp/tsqa.env.tOOxdZ
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-21 15:22:32,989 - Environment prefix is /tmp/tsqa.env.GAcSgU
INFO 2015-10-21 15:22:32,991 - socket_server_port = 53934
INFO 2015-10-21 15:22:32,991 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-21 15:22:36,333 - Sending data back to the client: 03b04cbda21c493c86e279da166ed099
INFO 2015-10-21 15:22:36,334 - 03b04cbda21c493c86e279da166ed099
INFO 2015-10-21 15:22:41,339 - Sending data back to the client: 03b04cbda21c493c86e279da166ed099
INFO 2015-10-21 15:22:41,339 - 03b04cbda21c493c86e279da166ed099
ok
INFO 2015-10-21 15:22:41,526 - Environment prefix is /tmp/tsqa.env.eNTpOe
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [21/Oct/2015 15:22:44] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-21 15:22:45,003 - Environment prefix is /tmp/tsqa.env.PWnW_3
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-21 15:25:20,629 - Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
SKIP: Error 1 running: ['<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/configure',> '--prefix=/', '--enable-ccache', '--enable-experimental-plugins', '--enable-example-plugins', '--enable-test-tools', '--enable-linux-native-aio', '--disable-dependency-tracking']
configure: error: Linux native AIO requires libaio.h

-------------------- >> begin captured logging << --------------------
tsqa.environment: INFO: Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
--------------------- >> end captured logging << ---------------------
INFO 2015-10-21 15:25:30,679 - Environment prefix is /tmp/tsqa.env.gKoP1w
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [21/Oct/2015 15:25:33] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:33] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:33] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-21 15:25:34,143 - Environment prefix is /tmp/tsqa.env.8vaIcD
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [21/Oct/2015 15:25:37] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:37] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [21/Oct/2015 15:25:37] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-21 15:25:37,704 - Environment prefix is /tmp/tsqa.env.AufXg9
INFO 2015-10-21 15:25:37,706 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-21 15:25:37,706 - spdy server port = 34739
INFO 2015-10-21 15:25:37,706 - http server port = 35901
Test that the origin does in fact support spdy 3 ... INFO 2015-10-21 15:25:40,939 - full args = ['/usr/local/bin/spdycat', 'https://localhost:34739/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-21 15:25:41,485 - full args = ['/usr/local/bin/spdycat', 'https://localhost:35901/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-21 15:25:41,682 - Environment prefix is /tmp/tsqa.env.s2asll
INFO 2015-10-21 15:25:41,684 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-21 15:25:41,684 - spdy server port = 53473
INFO 2015-10-21 15:25:41,684 - http server port = 58908
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-21 15:25:44,915 - full args = ['/usr/local/bin/spdycat', 'https://localhost:53473/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-21 15:25:45,492 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58908/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-21 15:25:45,700 - Environment prefix is /tmp/tsqa.env.xV0GId
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok

======================================================================
ERROR: test_chunked_bad_close (test_chunked.TestChunked)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_chunked.py",> line 198, in test_chunked_bad_close
    requests.get(url, proxies=self.proxies, timeout=2)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/api.py",> line 69, in get
    return request('get', url, params=params, **kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/api.py",> line 50, in request
    response = session.request(method=method, url=url, **kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/sessions.py",> line 468, in request
    resp = self.send(prep, **send_kwargs)
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/sessions.py",> line 608, in send
    r.content
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/models.py",> line 734, in content
    self._content = bytes().join(self.iter_content(CONTENT_CHUNK_SIZE)) or bytes()
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/requests/models.py",> line 664, in generate
    raise ConnectionError(e)
ConnectionError: HTTPConnectionPool(host='127.0.0.1', port=45258): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.ToARNm
test_chunked: INFO: sending data back to the client
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 958.077s

FAILED (SKIP=8, errors=1)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results