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/14 07:00:33 UTC
Build failed in Jenkins: tsqa-master #931
See <https://ci.trafficserver.apache.org/job/tsqa-master/931/changes>
Changes:
[James Peach] TS-3968: remove dead ink_auth_api code
------------------------------------------
[...truncated 505 lines...]
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-14 04:54:50,952 - Environment prefix is /tmp/tsqa.env.Oe0qI3
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [14/Oct/2015 04:54:54] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-14 04:54:54,415 - Environment prefix is /tmp/tsqa.env.dAgCrX
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-14 04:55:07,985 - Environment prefix is /tmp/tsqa.env.YhhJuO
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:11] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:55:11,517 - Environment prefix is /tmp/tsqa.env.rlcj64
INFO 2015-10-14 04:55:11,520 - map / http://127.0.0.1:37452/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-14 04:55:14,753 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:55:14 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:55:14,753 - head request with case(TE) costs 0.004434 seconds while the timout is 5.000000 seconds.
INFO 2015-10-14 04:55:14,754 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:55:14 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:55:14,755 - head request with case(CL) costs 0.001394 seconds while the timout is 5.000000 seconds.
INFO 2015-10-14 04:55:14,756 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:55:14 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:55:14,756 - head request with case() costs 0.001146 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-14 04:55:14,944 - Environment prefix is /tmp/tsqa.env.HQxoRS
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-14 04:55:18,409 - Environment prefix is /tmp/tsqa.env.prxbRH
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-14 04:55:23,863 - Environment prefix is /tmp/tsqa.env.4s8Bnv
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-14 04:55:33,365 - Environment prefix is /tmp/tsqa.env.Bye7HV
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Bye7HV
--------------------- >> 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-14 04:55:33,459 - Environment prefix is /tmp/tsqa.env.PdIuwZ
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.PdIuwZ
--------------------- >> end captured logging << ---------------------
INFO 2015-10-14 04:55:33,567 - Environment prefix is /tmp/tsqa.env.uTXUZU
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-14 04:55:37,096 - Environment prefix is /tmp/tsqa.env.LhKoo1
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-14 04:55:40,768 - Environment prefix is /tmp/tsqa.env.rlfBso
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-14 04:55:44,436 - Environment prefix is /tmp/tsqa.env._aJF0Y
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 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:55:47] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:55:47,896 - Environment prefix is /tmp/tsqa.env.SxgCUs
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-14 04:55:54,327 - Environment prefix is /tmp/tsqa.env.wwu5Ad
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-14 04:56:00,760 - Environment prefix is /tmp/tsqa.env.5Panif
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-14 04:56:22,255 - Environment prefix is /tmp/tsqa.env.Ha8tv9
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-14 04:56:43,788 - Environment prefix is /tmp/tsqa.env.4QxkS0
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-14 04:56:47,284 - Environment prefix is /tmp/tsqa.env._zvuBL
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-14 04:56:50,779 - Environment prefix is /tmp/tsqa.env.F5oPFb
INFO 2015-10-14 04:56:50,781 - socket_server_port = 43627
INFO 2015-10-14 04:56:50,781 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-14 04:56:54,051 - Sending data back to the client: 38db7bd41ad14e3f8938f6250436b7f6
INFO 2015-10-14 04:56:54,054 - 38db7bd41ad14e3f8938f6250436b7f6
INFO 2015-10-14 04:56:59,064 - Sending data back to the client: 38db7bd41ad14e3f8938f6250436b7f6
INFO 2015-10-14 04:56:59,064 - 38db7bd41ad14e3f8938f6250436b7f6
ok
INFO 2015-10-14 04:56:59,253 - Environment prefix is /tmp/tsqa.env.PCuXtk
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:57:02] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-14 04:57:02,843 - Environment prefix is /tmp/tsqa.env.0QD3pO
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-14 04:59:37,150 - 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-14 04:59:47,129 - Environment prefix is /tmp/tsqa.env.Yq2cKY
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [14/Oct/2015 04:59:50] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:59:50] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:59:50] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:59:50,632 - Environment prefix is /tmp/tsqa.env.wtfgzY
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [14/Oct/2015 04:59:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:59:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:59:53] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-14 04:59:54,143 - Environment prefix is /tmp/tsqa.env.Yi6PJw
INFO 2015-10-14 04:59:54,145 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-14 04:59:54,145 - spdy server port = 50671
INFO 2015-10-14 04:59:54,145 - http server port = 49170
Test that the origin does in fact support spdy 3 ... INFO 2015-10-14 04:59:57,375 - full args = ['/usr/local/bin/spdycat', 'https://localhost:50671/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-14 04:59:58,507 - full args = ['/usr/local/bin/spdycat', 'https://localhost:49170/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-14 04:59:58,714 - Environment prefix is /tmp/tsqa.env.BmlRoE
INFO 2015-10-14 04:59:58,716 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-14 04:59:58,716 - spdy server port = 33318
INFO 2015-10-14 04:59:58,716 - http server port = 33139
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-14 05:00:01,952 - full args = ['/usr/local/bin/spdycat', 'https://localhost:33318/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-14 05:00:02,991 - full args = ['/usr/local/bin/spdycat', 'https://localhost:33139/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-14 05:00:03,206 - Environment prefix is /tmp/tsqa.env.RTUZ92
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=51228): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.qjNVZj
test_chunked: INFO: sending data back to the client
--------------------- >> end captured logging << ---------------------
======================================================================
FAIL: test_log_field (test_custom_log.TestCustomLogField)
----------------------------------------------------------------------
Traceback (most recent call last):
File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_custom_log.py",> line 70, in test_log_field
self.assertEqual(line, expected_line)
AssertionError: '127.0.0.1 7F000001\n' != '127.223.171.44 7FDFAB2C\n'
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.gyiQ6E
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 835.751s
FAILED (SKIP=8, errors=1, failures=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
Build failed in Jenkins: tsqa-master #936
Posted by je...@ci.trafficserver.apache.org.
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 #935
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/935/>
------------------------------------------
[...truncated 493 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-17 07:24:56,909 - Environment prefix is /tmp/tsqa.env.RNKXji
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-17 07:26:40,449 - Environment prefix is /tmp/tsqa.env.6d3DUx
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-17 07:27:11,471 - 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-17 07:28:03,957 - 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-17 07:28:04,021 - Environment prefix is /tmp/tsqa.env.96wF3X
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-17 07:28:07,426 - Environment prefix is /tmp/tsqa.env.9u5iWl
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [17/Oct/2015 07:28:10] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-17 07:28:10,850 - Environment prefix is /tmp/tsqa.env.nrMRNj
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-17 07:28:24,409 - Environment prefix is /tmp/tsqa.env.8zLcRJ
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:27] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-17 07:28:27,949 - Environment prefix is /tmp/tsqa.env.L6LSar
INFO 2015-10-17 07:28:27,951 - map / http://127.0.0.1:37180/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-17 07:28:31,179 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sat, 17 Oct 2015 07:28:31 GMT
Age: 0
Connection: close
INFO 2015-10-17 07:28:31,180 - head request with case(TE) costs 0.002122 seconds while the timout is 5.000000 seconds.
INFO 2015-10-17 07:28:31,187 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Sat, 17 Oct 2015 07:28:31 GMT
Age: 0
Connection: close
INFO 2015-10-17 07:28:31,187 - head request with case(CL) costs 0.007418 seconds while the timout is 5.000000 seconds.
INFO 2015-10-17 07:28:31,214 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sat, 17 Oct 2015 07:28:31 GMT
Age: 0
Connection: close
INFO 2015-10-17 07:28:31,214 - head request with case() costs 0.026429 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-17 07:28:31,401 - Environment prefix is /tmp/tsqa.env.uaR0_1
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-17 07:28:34,878 - Environment prefix is /tmp/tsqa.env.4sOuj7
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-17 07:28:40,308 - Environment prefix is /tmp/tsqa.env.ed4dJG
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-17 07:28:49,817 - Environment prefix is /tmp/tsqa.env.z15RoB
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.z15RoB
--------------------- >> 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-17 07:28:49,896 - Environment prefix is /tmp/tsqa.env.n3DD9Y
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.n3DD9Y
--------------------- >> end captured logging << ---------------------
INFO 2015-10-17 07:28:49,993 - Environment prefix is /tmp/tsqa.env.0z_NMt
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-17 07:28:53,512 - Environment prefix is /tmp/tsqa.env.cOX0c2
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-17 07:28:57,158 - Environment prefix is /tmp/tsqa.env.MYxxlh
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-17 07:29:00,808 - Environment prefix is /tmp/tsqa.env.GjWH6J
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 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:29:04] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-17 07:29:04,240 - Environment prefix is /tmp/tsqa.env.r30EmP
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-17 07:29:10,722 - Environment prefix is /tmp/tsqa.env.6y0ah_
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-17 07:29:17,149 - Environment prefix is /tmp/tsqa.env.CABc1L
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-17 07:29:38,726 - Environment prefix is /tmp/tsqa.env.TE4Vjp
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-17 07:30:00,309 - Environment prefix is /tmp/tsqa.env.yjFnMj
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-17 07:30:03,764 - Environment prefix is /tmp/tsqa.env.UULNLe
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-17 07:30:07,245 - Environment prefix is /tmp/tsqa.env.911gBO
INFO 2015-10-17 07:30:07,247 - socket_server_port = 50765
INFO 2015-10-17 07:30:07,247 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-17 07:30:10,582 - Sending data back to the client: 4b5eedd395ed493a8dbc2a44be041cfe
INFO 2015-10-17 07:30:10,583 - 4b5eedd395ed493a8dbc2a44be041cfe
INFO 2015-10-17 07:30:15,587 - Sending data back to the client: 4b5eedd395ed493a8dbc2a44be041cfe
INFO 2015-10-17 07:30:15,588 - 4b5eedd395ed493a8dbc2a44be041cfe
ok
INFO 2015-10-17 07:30:15,767 - Environment prefix is /tmp/tsqa.env.lDolDK
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:30:19] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-17 07:30:19,264 - Environment prefix is /tmp/tsqa.env.Wj8Ws4
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-17 07:32:52,901 - 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-17 07:33:02,419 - Environment prefix is /tmp/tsqa.env.4TYpnm
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [17/Oct/2015 07:33:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:33:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:33:05] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-17 07:33:05,894 - Environment prefix is /tmp/tsqa.env.Dna1h_
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [17/Oct/2015 07:33:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:33:09] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:33:09] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-17 07:33:09,436 - Environment prefix is /tmp/tsqa.env.0GRyFB
INFO 2015-10-17 07:33:09,438 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-17 07:33:09,438 - spdy server port = 32889
INFO 2015-10-17 07:33:09,438 - http server port = 36928
Test that the origin does in fact support spdy 3 ... INFO 2015-10-17 07:33:12,665 - full args = ['/usr/local/bin/spdycat', 'https://localhost:32889/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-17 07:33:13,093 - full args = ['/usr/local/bin/spdycat', 'https://localhost:36928/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-17 07:33:13,291 - Environment prefix is /tmp/tsqa.env.Zz70Xi
INFO 2015-10-17 07:33:13,293 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-17 07:33:13,294 - spdy server port = 40966
INFO 2015-10-17 07:33:13,294 - http server port = 45128
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-17 07:33:16,527 - full args = ['/usr/local/bin/spdycat', 'https://localhost:40966/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-17 07:33:16,884 - full args = ['/usr/local/bin/spdycat', 'https://localhost:45128/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-17 07:33:17,081 - Environment prefix is /tmp/tsqa.env.1iYOD9
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=33992): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.V9o_B2
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 931.865s
FAILED (SKIP=8, errors=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Build failed in Jenkins: tsqa-master #934
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/934/changes>
Changes:
[kichan] TS-3972: support getting incoming port in ts_lua
------------------------------------------
[...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-17 07:24:33,688 - Environment prefix is /tmp/tsqa.env.phGT0V
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-17 07:26:17,246 - Environment prefix is /tmp/tsqa.env.JPr5b6
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-17 07:26:48,104 - 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-17 07:27:39,287 - 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-17 07:27:39,359 - Environment prefix is /tmp/tsqa.env.rrRKgk
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-17 07:27:42,769 - Environment prefix is /tmp/tsqa.env.pxfz19
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [17/Oct/2015 07:27:46] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-17 07:27:46,298 - Environment prefix is /tmp/tsqa.env.QnLjp1
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-17 07:27:59,792 - Environment prefix is /tmp/tsqa.env.1nNqtp
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:03] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-17 07:28:03,293 - Environment prefix is /tmp/tsqa.env.3hSxYy
INFO 2015-10-17 07:28:03,296 - map / http://127.0.0.1:55994/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-17 07:28:06,527 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sat, 17 Oct 2015 07:28:06 GMT
Age: 0
Connection: close
INFO 2015-10-17 07:28:06,527 - head request with case(TE) costs 0.002124 seconds while the timout is 5.000000 seconds.
INFO 2015-10-17 07:28:06,529 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Sat, 17 Oct 2015 07:28:06 GMT
Age: 0
Connection: close
INFO 2015-10-17 07:28:06,529 - head request with case(CL) costs 0.001178 seconds while the timout is 5.000000 seconds.
INFO 2015-10-17 07:28:06,545 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sat, 17 Oct 2015 07:28:06 GMT
Age: 0
Connection: close
INFO 2015-10-17 07:28:06,546 - head request with case() costs 0.016820 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-17 07:28:06,732 - Environment prefix is /tmp/tsqa.env.nuex6r
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-17 07:28:10,202 - Environment prefix is /tmp/tsqa.env.lO8i1r
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-17 07:28:15,628 - Environment prefix is /tmp/tsqa.env.sCxDju
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-17 07:28:25,150 - Environment prefix is /tmp/tsqa.env.xAoAtq
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.xAoAtq
--------------------- >> 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-17 07:28:25,235 - Environment prefix is /tmp/tsqa.env.xOWxCW
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.xOWxCW
--------------------- >> end captured logging << ---------------------
INFO 2015-10-17 07:28:25,335 - Environment prefix is /tmp/tsqa.env.qnguS1
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-17 07:28:28,853 - Environment prefix is /tmp/tsqa.env.X2Croj
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-17 07:28:32,510 - Environment prefix is /tmp/tsqa.env.ONY2oi
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-17 07:28:36,126 - Environment prefix is /tmp/tsqa.env.BKU6OV
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 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:28:39] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-17 07:28:39,546 - Environment prefix is /tmp/tsqa.env.4nO1Nc
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-17 07:28:45,972 - Environment prefix is /tmp/tsqa.env.rSpUNP
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-17 07:28:52,459 - Environment prefix is /tmp/tsqa.env.oJ3zbe
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-17 07:29:13,949 - Environment prefix is /tmp/tsqa.env.rnce8T
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-17 07:29:35,443 - Environment prefix is /tmp/tsqa.env.IyzX09
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-17 07:29:38,918 - Environment prefix is /tmp/tsqa.env.eJ4kgw
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-17 07:29:42,422 - Environment prefix is /tmp/tsqa.env.BxSIMM
INFO 2015-10-17 07:29:42,424 - socket_server_port = 42771
INFO 2015-10-17 07:29:42,424 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-17 07:29:45,678 - Sending data back to the client: 919bc0e9c57e4486abb1e0a5331250a6
INFO 2015-10-17 07:29:45,679 - 919bc0e9c57e4486abb1e0a5331250a6
INFO 2015-10-17 07:29:50,686 - Sending data back to the client: 919bc0e9c57e4486abb1e0a5331250a6
INFO 2015-10-17 07:29:50,686 - 919bc0e9c57e4486abb1e0a5331250a6
ok
INFO 2015-10-17 07:29:50,871 - Environment prefix is /tmp/tsqa.env.mq_xRV
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [17/Oct/2015 07:29:54] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-17 07:29:54,324 - Environment prefix is /tmp/tsqa.env.2L1Vzt
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-17 07:32:28,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-17 07:32:38,229 - Environment prefix is /tmp/tsqa.env.oqc6_5
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [17/Oct/2015 07:32:41] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:32:41] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:32:41] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-17 07:32:41,664 - Environment prefix is /tmp/tsqa.env.NS5WdR
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [17/Oct/2015 07:32:44] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:32:44] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [17/Oct/2015 07:32:44] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-17 07:32:45,109 - Environment prefix is /tmp/tsqa.env.Z64_PI
INFO 2015-10-17 07:32:45,110 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-17 07:32:45,111 - spdy server port = 58199
INFO 2015-10-17 07:32:45,111 - http server port = 42744
Test that the origin does in fact support spdy 3 ... INFO 2015-10-17 07:32:48,342 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58199/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-17 07:32:49,476 - full args = ['/usr/local/bin/spdycat', 'https://localhost:42744/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-17 07:32:49,678 - Environment prefix is /tmp/tsqa.env.E7b4Ab
INFO 2015-10-17 07:32:49,680 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-17 07:32:49,680 - spdy server port = 56860
INFO 2015-10-17 07:32:49,680 - http server port = 47660
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-17 07:32:52,910 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56860/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-17 07:32:53,994 - full args = ['/usr/local/bin/spdycat', 'https://localhost:47660/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-17 07:32:54,198 - Environment prefix is /tmp/tsqa.env.roE_22
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=40111): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.9PBt_j
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 927.804s
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 #933
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/933/>
------------------------------------------
[...truncated 492 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-15 15:33:32,559 - Environment prefix is /tmp/tsqa.env.4ITlCP
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-15 15:35:16,208 - Environment prefix is /tmp/tsqa.env.t1j2nk
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-15 15:35:48,316 - 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-15 15:36:44,411 - 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-15 15:36:44,473 - Environment prefix is /tmp/tsqa.env.TUGTjZ
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-15 15:36:47,880 - Environment prefix is /tmp/tsqa.env.tdwCYe
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [15/Oct/2015 15:36:51] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-15 15:36:51,389 - Environment prefix is /tmp/tsqa.env.DAs8l4
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-15 15:37:04,870 - Environment prefix is /tmp/tsqa.env.T2WBq1
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:08] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-15 15:37:08,436 - Environment prefix is /tmp/tsqa.env.OdfEWR
INFO 2015-10-15 15:37:08,439 - map / http://127.0.0.1:37939/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-15 15:37:11,715 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 15 Oct 2015 15:37:11 GMT
Age: 0
Connection: close
INFO 2015-10-15 15:37:11,716 - head request with case(TE) costs 0.031400 seconds while the timout is 5.000000 seconds.
INFO 2015-10-15 15:37:11,727 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 15 Oct 2015 15:37:11 GMT
Age: 0
Connection: close
INFO 2015-10-15 15:37:11,728 - head request with case(CL) costs 0.012136 seconds while the timout is 5.000000 seconds.
INFO 2015-10-15 15:37:11,729 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 15 Oct 2015 15:37:11 GMT
Age: 0
Connection: close
INFO 2015-10-15 15:37:11,730 - head request with case() costs 0.001687 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-15 15:37:11,908 - Environment prefix is /tmp/tsqa.env.jELNhd
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-15 15:37:15,527 - Environment prefix is /tmp/tsqa.env.q9q4ZP
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-15 15:37:21,376 - Environment prefix is /tmp/tsqa.env.rjq7ZI
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-15 15:37:30,963 - Environment prefix is /tmp/tsqa.env.3VKhXr
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.3VKhXr
--------------------- >> 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-15 15:37:31,063 - Environment prefix is /tmp/tsqa.env.xSrKpM
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.xSrKpM
--------------------- >> end captured logging << ---------------------
INFO 2015-10-15 15:37:31,164 - Environment prefix is /tmp/tsqa.env.fitxNs
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-15 15:37:34,804 - Environment prefix is /tmp/tsqa.env.XWmDbF
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-15 15:37:38,493 - Environment prefix is /tmp/tsqa.env.bqpPB4
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-15 15:37:42,185 - Environment prefix is /tmp/tsqa.env.i0XqFW
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 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:37:45] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-15 15:37:45,614 - Environment prefix is /tmp/tsqa.env.J2VnRk
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-15 15:37:52,112 - Environment prefix is /tmp/tsqa.env.RtnQAW
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-15 15:37:58,591 - Environment prefix is /tmp/tsqa.env.mhQMho
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-15 15:38:20,113 - Environment prefix is /tmp/tsqa.env.E5TXlu
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-15 15:38:41,672 - Environment prefix is /tmp/tsqa.env.yHWGs1
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-15 15:38:45,127 - Environment prefix is /tmp/tsqa.env.sygLvD
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-15 15:38:48,604 - Environment prefix is /tmp/tsqa.env.vVex7a
INFO 2015-10-15 15:38:48,606 - socket_server_port = 44337
INFO 2015-10-15 15:38:48,606 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-15 15:38:51,846 - Sending data back to the client: 51e1abcb690c4d658ae42e843ef93fa7
INFO 2015-10-15 15:38:51,846 - 51e1abcb690c4d658ae42e843ef93fa7
INFO 2015-10-15 15:38:56,852 - Sending data back to the client: 51e1abcb690c4d658ae42e843ef93fa7
INFO 2015-10-15 15:38:56,861 - 51e1abcb690c4d658ae42e843ef93fa7
ok
INFO 2015-10-15 15:38:57,046 - Environment prefix is /tmp/tsqa.env.5_Uhqz
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:39:00] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-15 15:39:00,667 - Environment prefix is /tmp/tsqa.env.1Nq1TQ
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-15 15:41:36,712 - 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-15 15:41:46,631 - Environment prefix is /tmp/tsqa.env.zSWC1m
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [15/Oct/2015 15:41:49] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:41:49] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:41:49] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-15 15:41:50,163 - Environment prefix is /tmp/tsqa.env.AFWxu4
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [15/Oct/2015 15:41:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:41:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:41:53] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-15 15:41:53,709 - Environment prefix is /tmp/tsqa.env.1BCMWm
INFO 2015-10-15 15:41:53,711 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-15 15:41:53,711 - spdy server port = 51368
INFO 2015-10-15 15:41:53,711 - http server port = 55509
Test that the origin does in fact support spdy 3 ... INFO 2015-10-15 15:41:56,939 - full args = ['/usr/local/bin/spdycat', 'https://localhost:51368/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-15 15:41:57,409 - full args = ['/usr/local/bin/spdycat', 'https://localhost:55509/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-15 15:41:57,606 - Environment prefix is /tmp/tsqa.env.Oe1O3J
INFO 2015-10-15 15:41:57,607 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-15 15:41:57,608 - spdy server port = 45162
INFO 2015-10-15 15:41:57,608 - http server port = 45971
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-15 15:42:00,840 - full args = ['/usr/local/bin/spdycat', 'https://localhost:45162/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-15 15:42:01,264 - full args = ['/usr/local/bin/spdycat', 'https://localhost:45971/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-15 15:42:01,467 - Environment prefix is /tmp/tsqa.env.y7TuND
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=58104): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.B_gdK8
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 954.606s
FAILED (SKIP=8, errors=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Build failed in Jenkins: tsqa-master #932
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/932/changes>
Changes:
[James Peach] TS-2118: add the memcached_remap plugin to the build
------------------------------------------
[...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-15 15:32:24,156 - Environment prefix is /tmp/tsqa.env.mQrlLy
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-15 15:34:07,700 - Environment prefix is /tmp/tsqa.env.AXqDuW
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-15 15:34:38,105 - 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-15 15:35:30,336 - 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-15 15:35:30,402 - Environment prefix is /tmp/tsqa.env.s7yWyJ
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-15 15:35:33,810 - Environment prefix is /tmp/tsqa.env.coRjEZ
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [15/Oct/2015 15:35:37] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-15 15:35:37,242 - Environment prefix is /tmp/tsqa.env.pNCEe8
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-15 15:35:50,732 - Environment prefix is /tmp/tsqa.env.yzdajM
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:35:53] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-15 15:35:54,184 - Environment prefix is /tmp/tsqa.env.6v7x5Y
INFO 2015-10-15 15:35:54,186 - map / http://127.0.0.1:50306/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-15 15:35:57,416 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 15 Oct 2015 15:35:57 GMT
Age: 0
Connection: close
INFO 2015-10-15 15:35:57,416 - head request with case(TE) costs 0.001901 seconds while the timout is 5.000000 seconds.
INFO 2015-10-15 15:35:57,417 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 15 Oct 2015 15:35:57 GMT
Age: 0
Connection: close
INFO 2015-10-15 15:35:57,417 - head request with case(CL) costs 0.001266 seconds while the timout is 5.000000 seconds.
INFO 2015-10-15 15:35:57,418 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 15 Oct 2015 15:35:57 GMT
Age: 0
Connection: close
INFO 2015-10-15 15:35:57,418 - head request with case() costs 0.000950 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-15 15:35:57,610 - Environment prefix is /tmp/tsqa.env.xquds3
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-15 15:36:01,063 - Environment prefix is /tmp/tsqa.env.tArnzE
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-15 15:36:06,498 - Environment prefix is /tmp/tsqa.env.HHmNMF
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-15 15:36:15,975 - Environment prefix is /tmp/tsqa.env.t6jjll
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.t6jjll
--------------------- >> 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-15 15:36:16,062 - Environment prefix is /tmp/tsqa.env.TznNO6
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.TznNO6
--------------------- >> end captured logging << ---------------------
INFO 2015-10-15 15:36:16,163 - Environment prefix is /tmp/tsqa.env.Ir31Qh
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-15 15:36:19,753 - Environment prefix is /tmp/tsqa.env.nkZVn1
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-15 15:36:23,271 - Environment prefix is /tmp/tsqa.env.7cnH4f
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-15 15:36:26,850 - Environment prefix is /tmp/tsqa.env.rn88SX
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 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:36:30] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-15 15:36:30,272 - Environment prefix is /tmp/tsqa.env.ztS0Qv
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-15 15:36:36,689 - Environment prefix is /tmp/tsqa.env.0TqZID
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-15 15:36:43,187 - Environment prefix is /tmp/tsqa.env.OHeK6Y
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-15 15:37:04,671 - Environment prefix is /tmp/tsqa.env.XoaSzx
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-15 15:37:26,161 - Environment prefix is /tmp/tsqa.env.l6pEUH
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-15 15:37:29,617 - Environment prefix is /tmp/tsqa.env.ec9tOg
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-15 15:37:33,069 - Environment prefix is /tmp/tsqa.env.oo897D
INFO 2015-10-15 15:37:33,071 - socket_server_port = 51044
INFO 2015-10-15 15:37:33,071 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-15 15:37:36,309 - Sending data back to the client: 21514a43677b4f93a7cd43a4544d9cbc
INFO 2015-10-15 15:37:36,310 - 21514a43677b4f93a7cd43a4544d9cbc
INFO 2015-10-15 15:37:41,319 - Sending data back to the client: 21514a43677b4f93a7cd43a4544d9cbc
INFO 2015-10-15 15:37:41,319 - 21514a43677b4f93a7cd43a4544d9cbc
ok
INFO 2015-10-15 15:37:41,510 - Environment prefix is /tmp/tsqa.env.UmPUAS
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [15/Oct/2015 15:37:44] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-15 15:37:44,976 - Environment prefix is /tmp/tsqa.env.rrNJL0
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-15 15:40:19,045 - 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-15 15:40:28,323 - Environment prefix is /tmp/tsqa.env.wo0Bae
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [15/Oct/2015 15:40:31] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:40:31] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:40:31] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-15 15:40:31,747 - Environment prefix is /tmp/tsqa.env.JMM9MO
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [15/Oct/2015 15:40:35] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:40:35] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [15/Oct/2015 15:40:35] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-15 15:40:35,197 - Environment prefix is /tmp/tsqa.env.pYTK5n
INFO 2015-10-15 15:40:35,199 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-15 15:40:35,199 - spdy server port = 39883
INFO 2015-10-15 15:40:35,199 - http server port = 58420
Test that the origin does in fact support spdy 3 ... INFO 2015-10-15 15:40:38,424 - full args = ['/usr/local/bin/spdycat', 'https://localhost:39883/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-15 15:40:39,572 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58420/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-15 15:40:39,772 - Environment prefix is /tmp/tsqa.env.wPbOvz
INFO 2015-10-15 15:40:39,774 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-15 15:40:39,774 - spdy server port = 48677
INFO 2015-10-15 15:40:39,774 - http server port = 55475
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-15 15:40:43,001 - full args = ['/usr/local/bin/spdycat', 'https://localhost:48677/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-15 15:40:44,160 - full args = ['/usr/local/bin/spdycat', 'https://localhost:55475/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-15 15:40:44,363 - Environment prefix is /tmp/tsqa.env.8p4U62
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=46828): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.2i7ajC
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 918.101s
FAILED (SKIP=8, errors=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results