See <https://ci.trafficserver.apache.org/job/tsqa-master/963/>
------------------------------------------ [...truncated 517 lines...] 127.0.0.1 - - [29/Oct/2015 22:07:15] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:15] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:15] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:15] "GET / HTTP/1.1" 200 5 ok INFO 2015-10-29 22:07:15,613 - Environment prefix is /tmp/tsqa.env.5aqbwf INFO 2015-10-29 22:07:15,616 - map / http://127.0.0.1:43709/ test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-29 22:07:18,873 - HTTP/1.1 200 OK Server: ATS/6.1.0 Vary: Accept-Encoding Date: Thu, 29 Oct 2015 22:07:18 GMT Age: 0 Connection: close INFO 2015-10-29 22:07:18,874 - head request with case(TE) costs 0.016334 seconds while the timout is 5.000000 seconds. INFO 2015-10-29 22:07:18,892 - HTTP/1.1 200 OK Server: ATS/6.1.0 Content-Length: 123 Vary: Accept-Encoding Date: Thu, 29 Oct 2015 22:07:18 GMT Age: 0 Connection: close INFO 2015-10-29 22:07:18,892 - head request with case(CL) costs 0.018365 seconds while the timout is 5.000000 seconds. INFO 2015-10-29 22:07:18,914 - HTTP/1.1 200 OK Server: ATS/6.1.0 Vary: Accept-Encoding Date: Thu, 29 Oct 2015 22:07:18 GMT Age: 0 Connection: close INFO 2015-10-29 22:07:18,914 - head request with case() costs 0.021862 seconds while the timout is 5.000000 seconds. ok INFO 2015-10-29 22:07:19,101 - Environment prefix is /tmp/tsqa.env.cEmSEq test_working (test_hostdb.TestHostDBBadResolvConf) ... ok INFO 2015-10-29 22:07:22,553 - Environment prefix is /tmp/tsqa.env._p0z8R test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok INFO 2015-10-29 22:07:28,095 - Environment prefix is /tmp/tsqa.env.Z4jVQW Test basic fnctionality of hosts files ... ok Test that changes to hosts file get loaded within host_file.interval ... ok INFO 2015-10-29 22:07:37,593 - Environment prefix is /tmp/tsqa.env.o4MPmc SKIP: -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.o4MPmc --------------------- >> 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-29 22:07:37,672 - Environment prefix is /tmp/tsqa.env.lmwXs0 SKIP: Cannot find h2spec. skipping test. -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.lmwXs0 --------------------- >> end captured logging << --------------------- INFO 2015-10-29 22:07:37,767 - Environment prefix is /tmp/tsqa.env.3tpTpx 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-29 22:07:41,395 - Environment prefix is /tmp/tsqa.env.EURCIn 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-29 22:07:45,051 - Environment prefix is /tmp/tsqa.env.JX9q2v 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-29 22:07:48,738 - Environment prefix is /tmp/tsqa.env.SNbdAS 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 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:07:52] "GET /exists/ HTTP/1.1" 200 5 ok INFO 2015-10-29 22:07:53,079 - Environment prefix is /tmp/tsqa.env.mQp0Me Tests that origin_min_keep_alive_connections is honored via http. ... ok INFO 2015-10-29 22:07:59,580 - Environment prefix is /tmp/tsqa.env.7o_cUw Tests that origin_min_keep_alive_connections is honored via https. ... ok INFO 2015-10-29 22:08:06,143 - Environment prefix is /tmp/tsqa.env.jOpv5P 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-29 22:08:27,708 - Environment prefix is /tmp/tsqa.env.w7FsbK 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-29 22:08:49,322 - Environment prefix is /tmp/tsqa.env.RywnlK ERROR INFO 2015-10-29 22:08:54,545 - Environment prefix is /tmp/tsqa.env.KNdKBN 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-29 22:08:58,018 - Environment prefix is /tmp/tsqa.env.Lhnn1N INFO 2015-10-29 22:08:58,019 - socket_server_port = 41851 INFO 2015-10-29 22:08:58,020 - starting the socket server test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-29 22:09:01,374 - Sending data back to the client: 31a4c4fc872e4b16b0dc6a0034b5c76a INFO 2015-10-29 22:09:01,387 - 31a4c4fc872e4b16b0dc6a0034b5c76a INFO 2015-10-29 22:09:06,394 - Sending data back to the client: 31a4c4fc872e4b16b0dc6a0034b5c76a INFO 2015-10-29 22:09:06,394 - 31a4c4fc872e4b16b0dc6a0034b5c76a ok INFO 2015-10-29 22:09:06,585 - Environment prefix is /tmp/tsqa.env.FhWVVd test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [29/Oct/2015 22:09:09] "GET /redirect/9 HTTP/1.1" 302 247 127.0.0.1 - - [29/Oct/2015 22:09:09] "GET /relative-redirect/8 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:09] "GET /relative-redirect/7 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:09] "GET /relative-redirect/6 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:09] "GET /relative-redirect/5 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:09] "GET /relative-redirect/4 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:09] "GET /relative-redirect/3 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/2 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/1 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /get HTTP/1.1" 200 391 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /redirect/10 HTTP/1.1" 302 247 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/9 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/8 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/7 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/6 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/5 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/4 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/3 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/2 HTTP/1.1" 302 0 127.0.0.1 - - [29/Oct/2015 22:09:10] "GET /relative-redirect/1 HTTP/1.1" 302 0 ok INFO 2015-10-29 22:09:10,302 - Environment prefix is /tmp/tsqa.env.FuU4C1 test_regressions (test_regressions.TestRegressions) ... ok INFO 2015-10-29 22:11:48,275 - 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-29 22:11:58,191 - Environment prefix is /tmp/tsqa.env.Pco_g8 test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [29/Oct/2015 22:12:01] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:12:01] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:12:01] "GET / HTTP/1.1" 200 5 ok INFO 2015-10-29 22:12:01,844 - Environment prefix is /tmp/tsqa.env.CuDHwm test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [29/Oct/2015 22:12:05] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:12:05] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [29/Oct/2015 22:12:05] "GET / HTTP/1.1" 200 5 ok SKIP: Skipping spdy/2 tests INFO 2015-10-29 22:12:05,398 - Environment prefix is /tmp/tsqa.env.RYJPGE INFO 2015-10-29 22:12:05,400 - spdycat path = /usr/local/bin/spdycat INFO 2015-10-29 22:12:05,401 - spdy server port = 56676 INFO 2015-10-29 22:12:05,401 - http server port = 36710 Test that the origin does in fact support spdy 3 ... INFO 2015-10-29 22:12:08,742 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56676/', '-nv', '--spdy3'] ok Test that non spdy port won't advertise spdy ... INFO 2015-10-29 22:12:09,331 - full args = ['/usr/local/bin/spdycat', 'https://localhost:36710/', '-nv', '--spdy3'] Fatal: EOF reqnum=1, completed=0 Some requests were not processed. total=1, processed=0 ok INFO 2015-10-29 22:12:09,539 - Environment prefix is /tmp/tsqa.env.ZF_NNB INFO 2015-10-29 22:12:09,541 - spdycat path = /usr/local/bin/spdycat INFO 2015-10-29 22:12:09,541 - spdy server port = 34484 INFO 2015-10-29 22:12:09,541 - http server port = 33273 Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-29 22:12:12,790 - full args = ['/usr/local/bin/spdycat', 'https://localhost:34484/', '-nv', '--spdy3-1'] ok Test that non spdy port won't advertise spdy ... INFO 2015-10-29 22:12:14,597 - full args = ['/usr/local/bin/spdycat', 'https://localhost:33273/', '-nv', '--spdy3-1'] Fatal: EOF reqnum=1, completed=0 Some requests were not processed. total=1, processed=0 ok INFO 2015-10-29 22:12:14,817 - Environment prefix is /tmp/tsqa.env.Mq4MNI 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=51968): Read timed out. -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.b7pkFN test_chunked: INFO: sending data back to the client test_chunked: INFO: Client disconnected --------------------- >> end captured logging << --------------------- ====================================================================== ERROR: test suite for <class 'test_keepalive.TestKeepAlive_Authorization_no_private'> ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/nose/suite.py";,> line 209, in run self.setUp() File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/nose/suite.py";,> line 292, in setUp self.setupContext(ancestor) File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/nose/suite.py";,> line 315, in setupContext try_run(context, names) File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/nose/util.py";,> line 471, in try_run return func() File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/tsqa/test_cases.py";,> line 86, in setUpClass cls.environment.start() File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/tsqa/environment.py";,> line 450, in start self.__exec_cop() File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/tsqa/environment.py";,> line 297, in __exec_cop tsqa.utils.poll_interfaces(self.hostports) File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/virtualenv/lib/python2.7/site-packages/tsqa/utils.py";,> line 73, in poll_interfaces reduce(lambda x, y: str(x) + ',' + str(y), hostports))) Exception: Timeout waiting for interfaces: ('127.0.0.1', 60835) -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.RywnlK --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml> ---------------------------------------------------------------------- Ran 81 tests in 978.355s FAILED (SKIP=8, errors=2) 1 make: *** [test] Error 1 Build step 'Execute shell' marked build as failure Recording test results
