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/13 02:24:08 UTC
Build failed in Jenkins: tsqa-master #927
See <https://ci.trafficserver.apache.org/job/tsqa-master/927/changes>
Changes:
[Bryan Call] TS-3958: HTTP/2 coredump with NULL FetchSM
------------------------------------------
[...truncated 503 lines...]
INFO 2015-10-13 00:18:25,900 - Environment prefix is /tmp/tsqa.env.Tc95q8
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [13/Oct/2015 00:18:29] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-13 00:18:29,334 - Environment prefix is /tmp/tsqa.env.59CrZd
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-13 00:18:42,819 - Environment prefix is /tmp/tsqa.env.tk1npc
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:18:46] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-13 00:18:46,267 - Environment prefix is /tmp/tsqa.env.j6IpMm
INFO 2015-10-13 00:18:46,269 - map / http://127.0.0.1:52482/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-13 00:18:49,498 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 13 Oct 2015 00:18:49 GMT
Age: 0
Connection: close
INFO 2015-10-13 00:18:49,499 - head request with case(TE) costs 0.001980 seconds while the timout is 5.000000 seconds.
INFO 2015-10-13 00:18:49,500 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Tue, 13 Oct 2015 00:18:49 GMT
Age: 0
Connection: close
INFO 2015-10-13 00:18:49,500 - head request with case(CL) costs 0.001189 seconds while the timout is 5.000000 seconds.
INFO 2015-10-13 00:18:49,512 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 13 Oct 2015 00:18:49 GMT
Age: 0
Connection: close
INFO 2015-10-13 00:18:49,513 - head request with case() costs 0.012673 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-13 00:18:49,699 - Environment prefix is /tmp/tsqa.env.jyNZ5k
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-13 00:18:53,156 - Environment prefix is /tmp/tsqa.env.qMHBEI
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-13 00:18:58,697 - Environment prefix is /tmp/tsqa.env.9I8Sta
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-13 00:19:08,388 - Environment prefix is /tmp/tsqa.env.sxlZyX
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.sxlZyX
--------------------- >> 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-13 00:19:08,480 - Environment prefix is /tmp/tsqa.env.Wd3uoK
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Wd3uoK
--------------------- >> end captured logging << ---------------------
INFO 2015-10-13 00:19:08,584 - Environment prefix is /tmp/tsqa.env.4aaoxS
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-13 00:19:12,103 - Environment prefix is /tmp/tsqa.env.c8iChL
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-13 00:19:15,667 - Environment prefix is /tmp/tsqa.env.bBlGsF
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-13 00:19:19,212 - Environment prefix is /tmp/tsqa.env.S4W6f7
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 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:22] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-13 00:19:22,637 - Environment prefix is /tmp/tsqa.env.5vAQXO
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-13 00:19:29,153 - Environment prefix is /tmp/tsqa.env.Plv5s0
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-13 00:19:35,576 - Environment prefix is /tmp/tsqa.env.VmwYAQ
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-13 00:19:57,069 - Environment prefix is /tmp/tsqa.env.6kWp0J
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-13 00:20:18,580 - Environment prefix is /tmp/tsqa.env.Mfcap5
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-13 00:20:22,076 - Environment prefix is /tmp/tsqa.env.v5Avsj
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-13 00:20:25,544 - Environment prefix is /tmp/tsqa.env.xQ_N8u
INFO 2015-10-13 00:20:25,546 - socket_server_port = 39286
INFO 2015-10-13 00:20:25,546 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-13 00:20:28,876 - Sending data back to the client: 74e343612c98401487477ee953d60090
INFO 2015-10-13 00:20:28,877 - 74e343612c98401487477ee953d60090
INFO 2015-10-13 00:20:33,884 - Sending data back to the client: 74e343612c98401487477ee953d60090
INFO 2015-10-13 00:20:33,885 - 74e343612c98401487477ee953d60090
ok
INFO 2015-10-13 00:20:34,074 - Environment prefix is /tmp/tsqa.env.kCA5pR
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:20:37] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-13 00:20:37,681 - Environment prefix is /tmp/tsqa.env.BdPYzv
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-13 00:23:11,763 - 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-13 00:23:21,354 - Environment prefix is /tmp/tsqa.env.Ocb0PO
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [13/Oct/2015 00:23:24] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:23:24] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:23:24] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-13 00:23:24,798 - Environment prefix is /tmp/tsqa.env.I4Punm
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [13/Oct/2015 00:23:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:23:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:23:28] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-13 00:23:28,260 - Environment prefix is /tmp/tsqa.env.xqeo5T
INFO 2015-10-13 00:23:28,262 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-13 00:23:28,263 - spdy server port = 42938
INFO 2015-10-13 00:23:28,263 - http server port = 46634
Test that the origin does in fact support spdy 3 ... INFO 2015-10-13 00:23:31,492 - full args = ['/usr/local/bin/spdycat', 'https://localhost:42938/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-13 00:23:32,573 - full args = ['/usr/local/bin/spdycat', 'https://localhost:46634/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-13 00:23:32,774 - Environment prefix is /tmp/tsqa.env.V4Y12D
INFO 2015-10-13 00:23:32,776 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-13 00:23:32,776 - spdy server port = 51484
INFO 2015-10-13 00:23:32,776 - http server port = 35910
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-13 00:23:36,008 - full args = ['/usr/local/bin/spdycat', 'https://localhost:51484/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-13 00:23:37,133 - full args = ['/usr/local/bin/spdycat', 'https://localhost:35910/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-13 00:23:37,339 - Environment prefix is /tmp/tsqa.env.RJfXZn
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 471, 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 611, 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=39753): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.jSm5Mj
test_chunked: INFO: sending data back to the client
test_chunked: INFO: Client disconnected
--------------------- >> 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.226.66.91 7FE2425B\n'
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.AMekw_
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 850.321s
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
Build failed in Jenkins: tsqa-master #931
Posted by je...@ci.trafficserver.apache.org.
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 #930
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/930/>
------------------------------------------
[...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-14 04:37:11,449 - Environment prefix is /tmp/tsqa.env.8bwLZQ
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-14 04:38:55,085 - Environment prefix is /tmp/tsqa.env.bPo86z
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-14 04:39:26,285 - 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-14 04:40:22,759 - 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-14 04:40:22,821 - Environment prefix is /tmp/tsqa.env.uyI201
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-14 04:40:26,227 - Environment prefix is /tmp/tsqa.env.YKJ9Ub
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [14/Oct/2015 04:40:29] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-14 04:40:29,799 - Environment prefix is /tmp/tsqa.env.MmFJxH
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-14 04:40:43,367 - Environment prefix is /tmp/tsqa.env.u4xrPK
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:46] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:40:46,965 - Environment prefix is /tmp/tsqa.env.IBqUWa
INFO 2015-10-14 04:40:46,968 - map / http://127.0.0.1:40120/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-14 04:40:50,278 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:40:50 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:40:50,278 - head request with case(TE) costs 0.075321 seconds while the timout is 5.000000 seconds.
INFO 2015-10-14 04:40:50,280 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:40:50 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:40:50,280 - head request with case(CL) costs 0.001502 seconds while the timout is 5.000000 seconds.
INFO 2015-10-14 04:40:50,296 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:40:50 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:40:50,296 - head request with case() costs 0.016224 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-14 04:40:50,477 - Environment prefix is /tmp/tsqa.env.Ae1Sq8
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-14 04:40:53,929 - Environment prefix is /tmp/tsqa.env.oAHaPI
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-14 04:40:59,355 - Environment prefix is /tmp/tsqa.env.6iYHxD
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:41:08,965 - Environment prefix is /tmp/tsqa.env.mScgor
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.mScgor
--------------------- >> 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:41:09,048 - Environment prefix is /tmp/tsqa.env.7gJ_aV
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.7gJ_aV
--------------------- >> end captured logging << ---------------------
INFO 2015-10-14 04:41:09,156 - Environment prefix is /tmp/tsqa.env.SRiiOY
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:41:12,740 - Environment prefix is /tmp/tsqa.env.g9eqhy
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:41:16,480 - Environment prefix is /tmp/tsqa.env.2o6INH
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:41:20,050 - Environment prefix is /tmp/tsqa.env.rNVZXf
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:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:41:23] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:41:23,570 - Environment prefix is /tmp/tsqa.env.YEqO8E
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-14 04:41:30,125 - Environment prefix is /tmp/tsqa.env.8wTgDI
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-14 04:41:36,649 - Environment prefix is /tmp/tsqa.env.ux9kio
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:41:58,169 - Environment prefix is /tmp/tsqa.env.fhrJse
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:42:19,758 - Environment prefix is /tmp/tsqa.env.GlwlvF
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:42:23,347 - Environment prefix is /tmp/tsqa.env.TaAsQP
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:42:26,842 - Environment prefix is /tmp/tsqa.env.UkYnCE
INFO 2015-10-14 04:42:26,844 - socket_server_port = 40502
INFO 2015-10-14 04:42:26,844 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-14 04:42:30,195 - Sending data back to the client: 72287d20f2f84f9380ccf94e9905a9df
INFO 2015-10-14 04:42:30,196 - 72287d20f2f84f9380ccf94e9905a9df
INFO 2015-10-14 04:42:35,207 - Sending data back to the client: 72287d20f2f84f9380ccf94e9905a9df
INFO 2015-10-14 04:42:35,207 - 72287d20f2f84f9380ccf94e9905a9df
ok
INFO 2015-10-14 04:42:35,386 - Environment prefix is /tmp/tsqa.env.V4daTa
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:42:38] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-14 04:42:38,931 - Environment prefix is /tmp/tsqa.env.QHvFXe
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-14 04:45:13,605 - 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:45:23,334 - Environment prefix is /tmp/tsqa.env.3VIO69
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [14/Oct/2015 04:45:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:45:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:45:26] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:45:26,848 - Environment prefix is /tmp/tsqa.env.gVNeGL
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [14/Oct/2015 04:45:30] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:45:30] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:45:30] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-14 04:45:30,392 - Environment prefix is /tmp/tsqa.env.FhoBWx
INFO 2015-10-14 04:45:30,394 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-14 04:45:30,394 - spdy server port = 39789
INFO 2015-10-14 04:45:30,394 - http server port = 45954
Test that the origin does in fact support spdy 3 ... INFO 2015-10-14 04:45:33,623 - full args = ['/usr/local/bin/spdycat', 'https://localhost:39789/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-14 04:45:34,101 - full args = ['/usr/local/bin/spdycat', 'https://localhost:45954/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-14 04:45:34,294 - Environment prefix is /tmp/tsqa.env.c0jHIi
INFO 2015-10-14 04:45:34,296 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-14 04:45:34,296 - spdy server port = 56017
INFO 2015-10-14 04:45:34,296 - http server port = 41298
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-14 04:45:37,528 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56017/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-14 04:45:37,967 - full args = ['/usr/local/bin/spdycat', 'https://localhost:41298/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-14 04:45:38,170 - Environment prefix is /tmp/tsqa.env._0FpJC
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=52210): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.KoiWMt
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 958.418s
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 #929
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/929/changes>
Changes:
[James Peach] Consistently use ink_mutex in preference to pthread_mutex.
------------------------------------------
[...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-14 04:36:32,307 - Environment prefix is /tmp/tsqa.env.e1v42N
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-14 04:38:15,976 - Environment prefix is /tmp/tsqa.env.6PIXrI
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-14 04:38:46,430 - 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-14 04:39:41,610 - 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-14 04:39:41,677 - Environment prefix is /tmp/tsqa.env._SEyZj
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-14 04:39:45,091 - Environment prefix is /tmp/tsqa.env.7MXnjv
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [14/Oct/2015 04:39:48] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-14 04:39:48,522 - Environment prefix is /tmp/tsqa.env.dTg79v
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-14 04:40:01,997 - Environment prefix is /tmp/tsqa.env.Bx_M3n
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:05] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:40:05,481 - Environment prefix is /tmp/tsqa.env.8EteAg
INFO 2015-10-14 04:40:05,483 - map / http://127.0.0.1:55250/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-14 04:40:08,720 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:40:08 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:40:08,721 - head request with case(TE) costs 0.010862 seconds while the timout is 5.000000 seconds.
INFO 2015-10-14 04:40:08,723 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:40:08 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:40:08,723 - head request with case(CL) costs 0.002714 seconds while the timout is 5.000000 seconds.
INFO 2015-10-14 04:40:08,724 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Wed, 14 Oct 2015 04:40:08 GMT
Age: 0
Connection: close
INFO 2015-10-14 04:40:08,725 - head request with case() costs 0.001039 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-14 04:40:08,915 - Environment prefix is /tmp/tsqa.env.sU3MM6
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-14 04:40:12,418 - Environment prefix is /tmp/tsqa.env.8J_nq9
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-14 04:40:17,854 - Environment prefix is /tmp/tsqa.env.cS86Wt
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:40:27,339 - Environment prefix is /tmp/tsqa.env.aaYNmU
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.aaYNmU
--------------------- >> 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:40:27,427 - Environment prefix is /tmp/tsqa.env.mieO7Y
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.mieO7Y
--------------------- >> end captured logging << ---------------------
INFO 2015-10-14 04:40:27,529 - Environment prefix is /tmp/tsqa.env.qJmUCn
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:40:31,062 - Environment prefix is /tmp/tsqa.env.yu2Mwf
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:40:34,710 - Environment prefix is /tmp/tsqa.env.07iJ5f
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:40:38,269 - Environment prefix is /tmp/tsqa.env.bK9iOY
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:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:40:41] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:40:41,700 - Environment prefix is /tmp/tsqa.env.V4ePqF
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-14 04:40:48,125 - Environment prefix is /tmp/tsqa.env.t6pt9q
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-14 04:40:54,552 - Environment prefix is /tmp/tsqa.env.AsvRE0
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:41:16,042 - Environment prefix is /tmp/tsqa.env.4hBXFu
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:41:37,540 - Environment prefix is /tmp/tsqa.env.xBFsXk
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:41:40,983 - Environment prefix is /tmp/tsqa.env.f4ha29
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:41:44,407 - Environment prefix is /tmp/tsqa.env.2e3o_1
INFO 2015-10-14 04:41:44,409 - socket_server_port = 52156
INFO 2015-10-14 04:41:44,409 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-14 04:41:47,662 - Sending data back to the client: 73b1337ea6fd4abcb40bd5b493f178cc
INFO 2015-10-14 04:41:47,663 - 73b1337ea6fd4abcb40bd5b493f178cc
INFO 2015-10-14 04:41:52,669 - Sending data back to the client: 73b1337ea6fd4abcb40bd5b493f178cc
INFO 2015-10-14 04:41:52,669 - 73b1337ea6fd4abcb40bd5b493f178cc
ok
INFO 2015-10-14 04:41:52,859 - Environment prefix is /tmp/tsqa.env.OuaLDv
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [14/Oct/2015 04:41:56] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-14 04:41:56,326 - Environment prefix is /tmp/tsqa.env.OHzIwV
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-14 04:44:30,111 - 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:44:39,729 - Environment prefix is /tmp/tsqa.env.hRGMqO
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [14/Oct/2015 04:44:42] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:44:42] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:44:42] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-14 04:44:43,159 - Environment prefix is /tmp/tsqa.env.CutBMy
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [14/Oct/2015 04:44:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:44:46] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [14/Oct/2015 04:44:46] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-14 04:44:46,603 - Environment prefix is /tmp/tsqa.env.4j0H2S
INFO 2015-10-14 04:44:46,606 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-14 04:44:46,606 - spdy server port = 49721
INFO 2015-10-14 04:44:46,606 - http server port = 33954
Test that the origin does in fact support spdy 3 ... INFO 2015-10-14 04:44:49,838 - full args = ['/usr/local/bin/spdycat', 'https://localhost:49721/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-14 04:44:50,984 - full args = ['/usr/local/bin/spdycat', 'https://localhost:33954/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-14 04:44:51,191 - Environment prefix is /tmp/tsqa.env.ndNQ8v
INFO 2015-10-14 04:44:51,192 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-14 04:44:51,193 - spdy server port = 32844
INFO 2015-10-14 04:44:51,193 - http server port = 51084
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-14 04:44:54,420 - full args = ['/usr/local/bin/spdycat', 'https://localhost:32844/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-14 04:44:55,540 - full args = ['/usr/local/bin/spdycat', 'https://localhost:51084/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-14 04:44:55,746 - Environment prefix is /tmp/tsqa.env.4vpBgw
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=39830): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.cGK2lI
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 935.985s
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 #928
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/928/>
------------------------------------------
[...truncated 504 lines...]
INFO 2015-10-13 00:19:36,094 - Environment prefix is /tmp/tsqa.env.7U8AtX
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [13/Oct/2015 00:19:39] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-13 00:19:39,534 - Environment prefix is /tmp/tsqa.env.46sWHW
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-13 00:19:53,018 - Environment prefix is /tmp/tsqa.env.BYsr_Y
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:19:56] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-13 00:19:56,608 - Environment prefix is /tmp/tsqa.env.T08pWb
INFO 2015-10-13 00:19:56,611 - map / http://127.0.0.1:36873/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-13 00:19:59,940 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 13 Oct 2015 00:19:59 GMT
Age: 0
Connection: close
INFO 2015-10-13 00:19:59,941 - head request with case(TE) costs 0.002237 seconds while the timout is 5.000000 seconds.
INFO 2015-10-13 00:19:59,942 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Tue, 13 Oct 2015 00:19:59 GMT
Age: 0
Connection: close
INFO 2015-10-13 00:19:59,943 - head request with case(CL) costs 0.001540 seconds while the timout is 5.000000 seconds.
INFO 2015-10-13 00:19:59,958 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 13 Oct 2015 00:19:59 GMT
Age: 0
Connection: close
INFO 2015-10-13 00:19:59,959 - head request with case() costs 0.016013 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-13 00:20:00,148 - Environment prefix is /tmp/tsqa.env.79p3GD
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-13 00:20:03,705 - Environment prefix is /tmp/tsqa.env.JsJVY0
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-13 00:20:09,549 - Environment prefix is /tmp/tsqa.env._c9rDZ
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-13 00:20:19,125 - Environment prefix is /tmp/tsqa.env.lJUYIA
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.lJUYIA
--------------------- >> 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-13 00:20:19,214 - Environment prefix is /tmp/tsqa.env.QI7SBo
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.QI7SBo
--------------------- >> end captured logging << ---------------------
INFO 2015-10-13 00:20:19,334 - Environment prefix is /tmp/tsqa.env.qnJhk0
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-13 00:20:22,960 - Environment prefix is /tmp/tsqa.env.iBIyty
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-13 00:20:26,619 - Environment prefix is /tmp/tsqa.env.wxZBkQ
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-13 00:20:30,256 - Environment prefix is /tmp/tsqa.env.UnHLP3
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 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:20:33] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-13 00:20:33,727 - Environment prefix is /tmp/tsqa.env.JtWp7a
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-13 00:20:40,211 - Environment prefix is /tmp/tsqa.env.CTfGRn
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-13 00:20:46,684 - Environment prefix is /tmp/tsqa.env.LNnTyB
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-13 00:21:08,276 - Environment prefix is /tmp/tsqa.env.vD4N0B
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-13 00:21:29,857 - Environment prefix is /tmp/tsqa.env.L55Xjl
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-13 00:21:33,382 - Environment prefix is /tmp/tsqa.env.CxcpmC
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-13 00:21:36,828 - Environment prefix is /tmp/tsqa.env.B6GO_D
INFO 2015-10-13 00:21:36,830 - socket_server_port = 58539
INFO 2015-10-13 00:21:36,831 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-13 00:21:40,127 - Sending data back to the client: a6bd65b1735f45c6b6accc64998ab2a3
INFO 2015-10-13 00:21:40,129 - a6bd65b1735f45c6b6accc64998ab2a3
INFO 2015-10-13 00:21:45,131 - Sending data back to the client: a6bd65b1735f45c6b6accc64998ab2a3
INFO 2015-10-13 00:21:45,131 - a6bd65b1735f45c6b6accc64998ab2a3
ok
INFO 2015-10-13 00:21:45,313 - Environment prefix is /tmp/tsqa.env.UcMpiV
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [13/Oct/2015 00:21:48] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-13 00:21:48,777 - Environment prefix is /tmp/tsqa.env.0Eoz1y
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-13 00:24:25,052 - 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-13 00:24:34,994 - Environment prefix is /tmp/tsqa.env.PWnmOn
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [13/Oct/2015 00:24:38] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:24:38] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:24:38] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-13 00:24:38,526 - Environment prefix is /tmp/tsqa.env.9HY7Jp
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [13/Oct/2015 00:24:41] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:24:41] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [13/Oct/2015 00:24:41] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-13 00:24:42,004 - Environment prefix is /tmp/tsqa.env.c4yUZS
INFO 2015-10-13 00:24:42,006 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-13 00:24:42,006 - spdy server port = 48340
INFO 2015-10-13 00:24:42,006 - http server port = 42416
Test that the origin does in fact support spdy 3 ... INFO 2015-10-13 00:24:45,243 - full args = ['/usr/local/bin/spdycat', 'https://localhost:48340/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-13 00:24:45,682 - full args = ['/usr/local/bin/spdycat', 'https://localhost:42416/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-13 00:24:45,885 - Environment prefix is /tmp/tsqa.env.fww6IX
INFO 2015-10-13 00:24:45,886 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-13 00:24:45,886 - spdy server port = 35131
INFO 2015-10-13 00:24:45,887 - http server port = 49554
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-13 00:24:49,114 - full args = ['/usr/local/bin/spdycat', 'https://localhost:35131/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-13 00:24:49,536 - full args = ['/usr/local/bin/spdycat', 'https://localhost:49554/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-13 00:24:49,739 - Environment prefix is /tmp/tsqa.env.wP06BK
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 471, 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 611, 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=47522): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.XrqGXx
test_chunked: INFO: sending data back to the client
test_chunked: INFO: Client disconnected
--------------------- >> end captured logging << ---------------------
======================================================================
ERROR: 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 66, in test_log_field
with open(self.log_file_path) as f:
IOError: [Errno 2] No such file or directory: '/tmp/tsqa.env.XwNwou/var/log/test_log_field.log'
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.XwNwou
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 900.581s
FAILED (SKIP=8, errors=2)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results