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/29 23:12:44 UTC
Build failed in Jenkins: tsqa-master #963
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
Build failed in Jenkins: tsqa-master #964
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/964/changes>
Changes:
[Bryan Call] TS-3984: CID 1328817: Resource leaks (CTOR_DTOR_LEAK) in multiplexer plugin
------------------------------------------
[...truncated 495 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-29 22:20:42,117 - Environment prefix is /tmp/tsqa.env.Lli_Jp
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-29 22:22:25,764 - Environment prefix is /tmp/tsqa.env.e8lSxs
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-29 22:22:55,699 - 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-29 22:23:46,019 - 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-29 22:23:46,081 - Environment prefix is /tmp/tsqa.env.yaIYVU
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-29 22:23:49,478 - Environment prefix is /tmp/tsqa.env.2DLLpb
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [29/Oct/2015 22:23:52] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-29 22:23:52,993 - Environment prefix is /tmp/tsqa.env.OJdihR
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-29 22:24:06,472 - Environment prefix is /tmp/tsqa.env.4WPbwn
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:09] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-29 22:24:10,015 - Environment prefix is /tmp/tsqa.env.FEzbPi
INFO 2015-10-29 22:24:10,018 - map / http://127.0.0.1:60351/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-29 22:24:13,354 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 29 Oct 2015 22:24:13 GMT
Age: 0
Connection: close
INFO 2015-10-29 22:24:13,354 - head request with case(TE) costs 0.002179 seconds while the timout is 5.000000 seconds.
INFO 2015-10-29 22:24:13,365 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 29 Oct 2015 22:24:13 GMT
Age: 0
Connection: close
INFO 2015-10-29 22:24:13,365 - head request with case(CL) costs 0.010533 seconds while the timout is 5.000000 seconds.
INFO 2015-10-29 22:24:13,376 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 29 Oct 2015 22:24:13 GMT
Age: 0
Connection: close
INFO 2015-10-29 22:24:13,376 - head request with case() costs 0.010835 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-29 22:24:13,557 - Environment prefix is /tmp/tsqa.env.LfXgdC
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-29 22:24:17,096 - Environment prefix is /tmp/tsqa.env.Ll1YFs
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-29 22:24:22,590 - Environment prefix is /tmp/tsqa.env.i61A6y
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:24:32,178 - Environment prefix is /tmp/tsqa.env.NzRr4k
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.NzRr4k
--------------------- >> 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:24:32,259 - Environment prefix is /tmp/tsqa.env.OOj3qJ
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.OOj3qJ
--------------------- >> end captured logging << ---------------------
INFO 2015-10-29 22:24:32,361 - Environment prefix is /tmp/tsqa.env.JXK7aG
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:24:35,861 - Environment prefix is /tmp/tsqa.env.YcYNrw
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:24:39,425 - Environment prefix is /tmp/tsqa.env.jCo_IP
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:24:43,065 - Environment prefix is /tmp/tsqa.env.R0XADT
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:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:24:46] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-29 22:24:46,605 - Environment prefix is /tmp/tsqa.env.IC0hoM
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-29 22:24:53,337 - Environment prefix is /tmp/tsqa.env.v0UL4w
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-29 22:24:59,787 - Environment prefix is /tmp/tsqa.env.AVDAd1
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:25:21,314 - Environment prefix is /tmp/tsqa.env.MZ0nLt
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:25:42,890 - Environment prefix is /tmp/tsqa.env.RS4TKT
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:25:48,716 - Environment prefix is /tmp/tsqa.env.tw2617
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:25:52,174 - Environment prefix is /tmp/tsqa.env.XWsoRI
INFO 2015-10-29 22:25:52,175 - socket_server_port = 48435
INFO 2015-10-29 22:25:52,176 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-29 22:25:55,434 - Sending data back to the client: 743ebee749d340dbb054e7a6df8a5289
INFO 2015-10-29 22:25:55,439 - 743ebee749d340dbb054e7a6df8a5289
INFO 2015-10-29 22:26:00,445 - Sending data back to the client: 743ebee749d340dbb054e7a6df8a5289
INFO 2015-10-29 22:26:00,446 - 743ebee749d340dbb054e7a6df8a5289
ok
INFO 2015-10-29 22:26:00,622 - Environment prefix is /tmp/tsqa.env.R00bnP
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [29/Oct/2015 22:26:03] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-29 22:26:04,081 - Environment prefix is /tmp/tsqa.env.Fy2FZJ
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-29 22:28:37,741 - 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:28:46,609 - Environment prefix is /tmp/tsqa.env.N9hzy2
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [29/Oct/2015 22:28:49] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:28:49] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:28:49] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-29 22:28:50,031 - Environment prefix is /tmp/tsqa.env.P43qsM
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [29/Oct/2015 22:28:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:28:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [29/Oct/2015 22:28:53] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-29 22:28:53,463 - Environment prefix is /tmp/tsqa.env.K2Rnxt
INFO 2015-10-29 22:28:53,465 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-29 22:28:53,465 - spdy server port = 53311
INFO 2015-10-29 22:28:53,465 - http server port = 60157
Test that the origin does in fact support spdy 3 ... INFO 2015-10-29 22:28:56,688 - full args = ['/usr/local/bin/spdycat', 'https://localhost:53311/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-29 22:28:58,209 - full args = ['/usr/local/bin/spdycat', 'https://localhost:60157/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-29 22:28:58,409 - Environment prefix is /tmp/tsqa.env.6ptztJ
INFO 2015-10-29 22:28:58,411 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-29 22:28:58,411 - spdy server port = 52654
INFO 2015-10-29 22:28:58,411 - http server port = 36214
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-29 22:29:01,639 - full args = ['/usr/local/bin/spdycat', 'https://localhost:52654/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-29 22:29:02,661 - full args = ['/usr/local/bin/spdycat', 'https://localhost:36214/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-29 22:29:02,857 - Environment prefix is /tmp/tsqa.env.jro9n8
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=41371): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.eO2o7M
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 916.787s
FAILED (SKIP=8, errors=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results