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/25 18:15:15 UTC
Build failed in Jenkins: tsqa-master #947
See <https://ci.trafficserver.apache.org/job/tsqa-master/947/changes>
Changes:
[James Peach] format
------------------------------------------
[...truncated 495 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-25 17:06:22,159 - Environment prefix is /tmp/tsqa.env.oq1sKS
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-25 17:08:05,687 - Environment prefix is /tmp/tsqa.env._dsXya
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-25 17:08:36,119 - 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-25 17:09:30,075 - 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-25 17:09:30,144 - Environment prefix is /tmp/tsqa.env.xZqvhC
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-25 17:09:33,550 - Environment prefix is /tmp/tsqa.env.qpCbOz
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [25/Oct/2015 17:09:36] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-25 17:09:36,973 - Environment prefix is /tmp/tsqa.env.OMpLy3
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-25 17:09:50,435 - Environment prefix is /tmp/tsqa.env.ncmFNl
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:09:53] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-25 17:09:53,919 - Environment prefix is /tmp/tsqa.env.TQtiuY
INFO 2015-10-25 17:09:53,921 - map / http://127.0.0.1:57917/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-25 17:09:57,153 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sun, 25 Oct 2015 17:09:57 GMT
Age: 0
Connection: close
INFO 2015-10-25 17:09:57,154 - head request with case(TE) costs 0.007537 seconds while the timout is 5.000000 seconds.
INFO 2015-10-25 17:09:57,155 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Sun, 25 Oct 2015 17:09:57 GMT
Age: 0
Connection: close
INFO 2015-10-25 17:09:57,155 - head request with case(CL) costs 0.001277 seconds while the timout is 5.000000 seconds.
INFO 2015-10-25 17:09:57,173 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sun, 25 Oct 2015 17:09:57 GMT
Age: 0
Connection: close
INFO 2015-10-25 17:09:57,174 - head request with case() costs 0.018263 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-25 17:09:57,357 - Environment prefix is /tmp/tsqa.env.bKiWYk
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-25 17:10:00,820 - Environment prefix is /tmp/tsqa.env.8w10jV
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-25 17:10:06,373 - Environment prefix is /tmp/tsqa.env.6WyhA_
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-25 17:10:15,861 - Environment prefix is /tmp/tsqa.env.VE_lOn
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.VE_lOn
--------------------- >> 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-25 17:10:15,952 - Environment prefix is /tmp/tsqa.env.GqwKW3
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.GqwKW3
--------------------- >> end captured logging << ---------------------
INFO 2015-10-25 17:10:16,056 - Environment prefix is /tmp/tsqa.env.oyl6rQ
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-25 17:10:19,691 - Environment prefix is /tmp/tsqa.env.9mHov7
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-25 17:10:23,344 - Environment prefix is /tmp/tsqa.env.S3jKJw
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-25 17:10:26,881 - Environment prefix is /tmp/tsqa.env.jFwvto
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 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:10:30] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-25 17:10:30,312 - Environment prefix is /tmp/tsqa.env.5yqwVh
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-25 17:10:36,799 - Environment prefix is /tmp/tsqa.env.nadr5e
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-25 17:10:43,237 - Environment prefix is /tmp/tsqa.env.fNNAnp
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-25 17:11:04,726 - Environment prefix is /tmp/tsqa.env.8ZHwPq
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-25 17:11:26,312 - Environment prefix is /tmp/tsqa.env.3iydvx
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-25 17:11:29,810 - Environment prefix is /tmp/tsqa.env.D5Pmv9
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-25 17:11:33,261 - Environment prefix is /tmp/tsqa.env.x4D09j
INFO 2015-10-25 17:11:33,263 - socket_server_port = 43828
INFO 2015-10-25 17:11:33,263 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-25 17:11:36,489 - Sending data back to the client: 7c9f34fc1da743518383a3c978975dab
INFO 2015-10-25 17:11:36,490 - 7c9f34fc1da743518383a3c978975dab
INFO 2015-10-25 17:11:41,495 - Sending data back to the client: 7c9f34fc1da743518383a3c978975dab
INFO 2015-10-25 17:11:41,496 - 7c9f34fc1da743518383a3c978975dab
ok
INFO 2015-10-25 17:11:41,682 - Environment prefix is /tmp/tsqa.env.7OvrOV
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [25/Oct/2015 17:11:45] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-25 17:11:45,265 - Environment prefix is /tmp/tsqa.env.hlcpni
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-25 17:14:18,991 - 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-25 17:14:28,421 - Environment prefix is /tmp/tsqa.env.pRgtuN
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [25/Oct/2015 17:14:31] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:14:31] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:14:31] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-25 17:14:31,959 - Environment prefix is /tmp/tsqa.env.30fnxu
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [25/Oct/2015 17:14:35] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:14:35] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [25/Oct/2015 17:14:35] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-25 17:14:35,435 - Environment prefix is /tmp/tsqa.env.TdFGWv
INFO 2015-10-25 17:14:35,437 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-25 17:14:35,437 - spdy server port = 56998
INFO 2015-10-25 17:14:35,437 - http server port = 60654
Test that the origin does in fact support spdy 3 ... INFO 2015-10-25 17:14:38,664 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56998/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-25 17:14:39,908 - full args = ['/usr/local/bin/spdycat', 'https://localhost:60654/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-25 17:14:40,112 - Environment prefix is /tmp/tsqa.env.xS4tmF
INFO 2015-10-25 17:14:40,114 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-25 17:14:40,114 - spdy server port = 37891
INFO 2015-10-25 17:14:40,114 - http server port = 57643
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-25 17:14:43,341 - full args = ['/usr/local/bin/spdycat', 'https://localhost:37891/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-25 17:14:44,687 - full args = ['/usr/local/bin/spdycat', 'https://localhost:57643/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-25 17:14:44,891 - Environment prefix is /tmp/tsqa.env.a2t5Zo
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=57703): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.dIAGth
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.022s
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 #948
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/948/changes>
Changes:
[James Peach] TS-3982: ESI logs debug output using TSError
[Bryan Call] TS-3961: Open source Yahoo's ats-multiplexer plug-in
------------------------------------------
[...truncated 498 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-26 18:06:53,297 - Environment prefix is /tmp/tsqa.env.UnM0RM
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-26 18:08:36,845 - Environment prefix is /tmp/tsqa.env.FgVZtc
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-26 18:09:07,504 - 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-26 18:10:03,151 - 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-26 18:10:03,220 - Environment prefix is /tmp/tsqa.env.Q0OcEG
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-26 18:10:06,630 - Environment prefix is /tmp/tsqa.env.Hz5ru_
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [26/Oct/2015 18:10:09] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-26 18:10:10,059 - Environment prefix is /tmp/tsqa.env.DD0hPj
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-26 18:10:23,544 - Environment prefix is /tmp/tsqa.env.s46841
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:10:26] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-26 18:10:26,991 - Environment prefix is /tmp/tsqa.env.c4NAZC
INFO 2015-10-26 18:10:26,993 - map / http://127.0.0.1:50687/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-26 18:10:30,218 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Mon, 26 Oct 2015 18:10:30 GMT
Age: 0
Connection: close
INFO 2015-10-26 18:10:30,219 - head request with case(TE) costs 0.001767 seconds while the timout is 5.000000 seconds.
INFO 2015-10-26 18:10:30,220 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Mon, 26 Oct 2015 18:10:30 GMT
Age: 0
Connection: close
INFO 2015-10-26 18:10:30,220 - head request with case(CL) costs 0.001105 seconds while the timout is 5.000000 seconds.
INFO 2015-10-26 18:10:30,221 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Mon, 26 Oct 2015 18:10:30 GMT
Age: 0
Connection: close
INFO 2015-10-26 18:10:30,221 - head request with case() costs 0.000945 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-26 18:10:30,406 - Environment prefix is /tmp/tsqa.env.C5dXYZ
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-26 18:10:33,864 - Environment prefix is /tmp/tsqa.env.tFZTAX
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-26 18:10:39,294 - Environment prefix is /tmp/tsqa.env.RhSDci
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-26 18:10:48,774 - Environment prefix is /tmp/tsqa.env.jBS141
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.jBS141
--------------------- >> 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-26 18:10:48,862 - Environment prefix is /tmp/tsqa.env.qGcdbH
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.qGcdbH
--------------------- >> end captured logging << ---------------------
INFO 2015-10-26 18:10:48,966 - Environment prefix is /tmp/tsqa.env.DJg7ng
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-26 18:10:52,482 - Environment prefix is /tmp/tsqa.env.mIiXAH
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-26 18:10:56,032 - Environment prefix is /tmp/tsqa.env.50Fos0
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-26 18:10:59,587 - Environment prefix is /tmp/tsqa.env.UM0VUz
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 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:11:02] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-26 18:11:03,063 - Environment prefix is /tmp/tsqa.env.7DJ2y6
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-26 18:11:09,519 - Environment prefix is /tmp/tsqa.env.HNP2SO
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-26 18:11:15,952 - Environment prefix is /tmp/tsqa.env.EeiWRd
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-26 18:11:37,453 - Environment prefix is /tmp/tsqa.env.0X0Gu7
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-26 18:11:58,964 - Environment prefix is /tmp/tsqa.env.LumYzv
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-26 18:12:02,425 - Environment prefix is /tmp/tsqa.env.MJ84uI
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-26 18:12:05,934 - Environment prefix is /tmp/tsqa.env.hEZ50s
INFO 2015-10-26 18:12:05,936 - socket_server_port = 33833
INFO 2015-10-26 18:12:05,936 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-26 18:12:09,174 - Sending data back to the client: 74954215ab93450caec3d8720f4e8a75
INFO 2015-10-26 18:12:09,174 - 74954215ab93450caec3d8720f4e8a75
INFO 2015-10-26 18:12:14,180 - Sending data back to the client: 74954215ab93450caec3d8720f4e8a75
INFO 2015-10-26 18:12:14,180 - 74954215ab93450caec3d8720f4e8a75
ok
INFO 2015-10-26 18:12:14,364 - Environment prefix is /tmp/tsqa.env.itv2hB
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [26/Oct/2015 18:12:17] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-26 18:12:17,923 - Environment prefix is /tmp/tsqa.env.KZrtUG
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-26 18:14:52,012 - 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-26 18:15:01,511 - Environment prefix is /tmp/tsqa.env.gJD3_f
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [26/Oct/2015 18:15:04] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:15:04] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:15:04] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-26 18:15:05,005 - Environment prefix is /tmp/tsqa.env.Z8HCsY
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [26/Oct/2015 18:15:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:15:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [26/Oct/2015 18:15:08] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-26 18:15:08,470 - Environment prefix is /tmp/tsqa.env.3tGDEj
INFO 2015-10-26 18:15:08,472 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-26 18:15:08,472 - spdy server port = 59205
INFO 2015-10-26 18:15:08,472 - http server port = 60921
Test that the origin does in fact support spdy 3 ... INFO 2015-10-26 18:15:11,708 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59205/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-26 18:15:13,315 - full args = ['/usr/local/bin/spdycat', 'https://localhost:60921/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-26 18:15:13,520 - Environment prefix is /tmp/tsqa.env.dRE8x8
INFO 2015-10-26 18:15:13,522 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-26 18:15:13,522 - spdy server port = 35241
INFO 2015-10-26 18:15:13,523 - http server port = 59702
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-26 18:15:16,759 - full args = ['/usr/local/bin/spdycat', 'https://localhost:35241/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-26 18:15:17,765 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59702/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-26 18:15:17,971 - Environment prefix is /tmp/tsqa.env.zxZNAy
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=35259): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.oooivQ
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 938.491s
FAILED (SKIP=8, errors=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results