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/06 20:57:26 UTC
Build failed in Jenkins: tsqa-master #914
See <https://ci.trafficserver.apache.org/job/tsqa-master/914/changes>
Changes:
[shinrich] TS-3957 - Core dump for SpdyClientSession::state_session_start
------------------------------------------
[...truncated 494 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-06 18:48:34,214 - Environment prefix is /tmp/tsqa.env.M10W5p
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-06 18:50:17,771 - Environment prefix is /tmp/tsqa.env._jOxx_
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-06 18:50:47,956 - 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-06 18:51:42,152 - 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-06 18:51:42,219 - Environment prefix is /tmp/tsqa.env.Mio_qC
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-06 18:51:45,730 - Environment prefix is /tmp/tsqa.env.dl1Hoz
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [06/Oct/2015 18:51:48] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-06 18:51:49,152 - Environment prefix is /tmp/tsqa.env.pOeERh
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-06 18:52:02,666 - Environment prefix is /tmp/tsqa.env.pYdMHL
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:05] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:06] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 18:52:06,186 - Environment prefix is /tmp/tsqa.env.vfmKBz
INFO 2015-10-06 18:52:06,189 - map / http://127.0.0.1:57051/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-06 18:52:09,419 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 18:52:09 GMT
Age: 0
Connection: close
INFO 2015-10-06 18:52:09,419 - head request with case(TE) costs 0.001972 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 18:52:09,420 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 18:52:09 GMT
Age: 0
Connection: close
INFO 2015-10-06 18:52:09,420 - head request with case(CL) costs 0.001123 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 18:52:09,421 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 18:52:09 GMT
Age: 0
Connection: close
INFO 2015-10-06 18:52:09,421 - head request with case() costs 0.000926 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-06 18:52:09,607 - Environment prefix is /tmp/tsqa.env.Gldwkf
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-06 18:52:13,090 - Environment prefix is /tmp/tsqa.env.JDOf5l
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-06 18:52:18,549 - Environment prefix is /tmp/tsqa.env.zL_J_5
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-06 18:52:28,055 - Environment prefix is /tmp/tsqa.env.bvPbEz
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.bvPbEz
--------------------- >> 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-06 18:52:28,142 - Environment prefix is /tmp/tsqa.env.mwNLlr
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.mwNLlr
--------------------- >> end captured logging << ---------------------
INFO 2015-10-06 18:52:28,246 - Environment prefix is /tmp/tsqa.env.jWZvdo
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-06 18:52:31,763 - Environment prefix is /tmp/tsqa.env.kHP7k1
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-06 18:52:35,315 - Environment prefix is /tmp/tsqa.env.RKpHFd
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-06 18:52:38,897 - Environment prefix is /tmp/tsqa.env.isf63x
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 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:52:42] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-06 18:52:42,322 - Environment prefix is /tmp/tsqa.env.ziWoSm
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-06 18:52:48,745 - Environment prefix is /tmp/tsqa.env.WVRF2S
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-06 18:52:55,226 - Environment prefix is /tmp/tsqa.env.2d3QUm
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-06 18:53:16,704 - Environment prefix is /tmp/tsqa.env.DeSlOj
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-06 18:53:38,254 - Environment prefix is /tmp/tsqa.env.ig3Bwj
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-06 18:53:41,714 - Environment prefix is /tmp/tsqa.env.izUtvu
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-06 18:53:45,205 - Environment prefix is /tmp/tsqa.env.LDPtLj
INFO 2015-10-06 18:53:45,207 - socket_server_port = 50860
INFO 2015-10-06 18:53:45,207 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-06 18:53:48,452 - Sending data back to the client: 1e82b184813147879173388045c59d49
INFO 2015-10-06 18:53:48,505 - 1e82b184813147879173388045c59d49
INFO 2015-10-06 18:53:53,514 - Sending data back to the client: 1e82b184813147879173388045c59d49
INFO 2015-10-06 18:53:53,514 - 1e82b184813147879173388045c59d49
ok
INFO 2015-10-06 18:53:53,698 - Environment prefix is /tmp/tsqa.env.iB9n1H
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 18:53:56] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-06 18:53:57,167 - Environment prefix is /tmp/tsqa.env.1gH7En
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-06 18:56:30,917 - 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-06 18:56:40,335 - Environment prefix is /tmp/tsqa.env.ivygJ8
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [06/Oct/2015 18:56:43] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:56:43] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:56:43] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 18:56:43,780 - Environment prefix is /tmp/tsqa.env.GtPMbA
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [06/Oct/2015 18:56:47] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:56:47] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 18:56:47] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-06 18:56:47,251 - Environment prefix is /tmp/tsqa.env.NNu8ca
INFO 2015-10-06 18:56:47,253 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 18:56:47,253 - spdy server port = 34583
INFO 2015-10-06 18:56:47,253 - http server port = 58932
Test that the origin does in fact support spdy 3 ... INFO 2015-10-06 18:56:50,483 - full args = ['/usr/local/bin/spdycat', 'https://localhost:34583/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 18:56:51,555 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58932/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 18:56:51,757 - Environment prefix is /tmp/tsqa.env.8QY4n8
INFO 2015-10-06 18:56:51,758 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 18:56:51,759 - spdy server port = 34335
INFO 2015-10-06 18:56:51,759 - http server port = 50923
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-06 18:56:54,987 - full args = ['/usr/local/bin/spdycat', 'https://localhost:34335/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 18:56:56,102 - full args = ['/usr/local/bin/spdycat', 'https://localhost:50923/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 18:56:56,306 - Environment prefix is /tmp/tsqa.env.Ki1vME
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=33005): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.fgYPQK
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 931.792s
FAILED (SKIP=8, errors=1)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Re: Build failed in Jenkins: tsqa-master #917
Posted by Susan Hinrichs <sh...@network-geographics.com>.
Hi Thomas and others,
I could use some guidance on fixing these problems. I caught up on
committing some stability fixes I've been making over the past month.
And it looks like my changes broke two TSQA tests.
I tried running both tests on my FC21 VM, but they both succeed. Do I
need a specific OS? Can I access the logs from the jenkins machine?
Thanks,
Susan
On 10/6/2015 2:49 PM, jenkins@ci.trafficserver.apache.org wrote:
> See <https://ci.trafficserver.apache.org/job/tsqa-master/917/changes>
>
> Changes:
>
> [shinrich] TS-3701 - Crash in trampoline cleanup
>
> ------------------------------------------
> [...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-06 19:40:25,549 - Environment prefix is /tmp/tsqa.env.Xy3nQJ
> test_log_field (test_custom_log.TestCustomLogField) ... ok
> INFO 2015-10-06 19:42:09,106 - Environment prefix is /tmp/tsqa.env.x8X_nR
> test_default_404 (test_example.TestBootstrap) ... ok
> Test that traffic_line works, and verify that the values for proxy.config ... ok
> INFO 2015-10-06 19:42:39,572 - 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-06 19:43:31,143 - 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-06 19:43:31,211 - Environment prefix is /tmp/tsqa.env.HgtNma
> test_spdy (test_example.TestConfigureFlags) ... ok
> INFO 2015-10-06 19:43:34,622 - Environment prefix is /tmp/tsqa.env.hSBhiM
> test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [06/Oct/2015 19:43:37] "GET /test HTTP/1.1" 404 0
> ok
> INFO 2015-10-06 19:43:38,151 - Environment prefix is /tmp/tsqa.env.lO59dR
> test_logs_exist (test_example.TestLogs) ... ok
> SKIP: Skip the entire class
> INFO 2015-10-06 19:43:51,744 - Environment prefix is /tmp/tsqa.env.5ybhyW
> test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [06/Oct/2015 19:43:54] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:54] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
> ok
> INFO 2015-10-06 19:43:55,218 - Environment prefix is /tmp/tsqa.env.Icf9I1
> INFO 2015-10-06 19:43:55,220 - map / http://127.0.0.1:39454/
> test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-06 19:43:58,459 - HTTP/1.1 200 OK
> Server: ATS/6.1.0
> Vary: Accept-Encoding
> Date: Tue, 06 Oct 2015 19:43:58 GMT
> Age: 0
> Connection: close
>
>
> INFO 2015-10-06 19:43:58,460 - head request with case(TE) costs 0.012634 seconds while the timout is 5.000000 seconds.
> INFO 2015-10-06 19:43:58,461 - HTTP/1.1 200 OK
> Server: ATS/6.1.0
> Content-Length: 123
> Vary: Accept-Encoding
> Date: Tue, 06 Oct 2015 19:43:58 GMT
> Age: 0
> Connection: close
>
>
> INFO 2015-10-06 19:43:58,461 - head request with case(CL) costs 0.001248 seconds while the timout is 5.000000 seconds.
> INFO 2015-10-06 19:43:58,462 - HTTP/1.1 200 OK
> Server: ATS/6.1.0
> Vary: Accept-Encoding
> Date: Tue, 06 Oct 2015 19:43:58 GMT
> Age: 0
> Connection: close
>
>
> INFO 2015-10-06 19:43:58,462 - head request with case() costs 0.000903 seconds while the timout is 5.000000 seconds.
> ok
> INFO 2015-10-06 19:43:58,650 - Environment prefix is /tmp/tsqa.env.khUBnS
> test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
> INFO 2015-10-06 19:44:02,214 - Environment prefix is /tmp/tsqa.env.5Drpn3
> test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
> INFO 2015-10-06 19:44:07,672 - Environment prefix is /tmp/tsqa.env.ZC6sC2
> Test basic fnctionality of hosts files ... ok
> Test that changes to hosts file get loaded within host_file.interval ... ok
> INFO 2015-10-06 19:44:17,153 - Environment prefix is /tmp/tsqa.env.xxtBlv
> SKIP:
> -------------------- >> begin captured logging << --------------------
> root: INFO: Environment prefix is /tmp/tsqa.env.xxtBlv
> --------------------- >> 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-06 19:44:17,244 - Environment prefix is /tmp/tsqa.env.585v8A
> SKIP: Cannot find h2spec. skipping test.
> -------------------- >> begin captured logging << --------------------
> root: INFO: Environment prefix is /tmp/tsqa.env.585v8A
> --------------------- >> end captured logging << ---------------------
> INFO 2015-10-06 19:44:17,350 - Environment prefix is /tmp/tsqa.env.FKAsi4
> 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-06 19:44:20,861 - Environment prefix is /tmp/tsqa.env.4F9y0N
> 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-06 19:44:24,438 - Environment prefix is /tmp/tsqa.env.GWtnHY
> 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-06 19:44:28,078 - Environment prefix is /tmp/tsqa.env.nUld_x
> 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 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
> ok
> INFO 2015-10-06 19:44:31,508 - Environment prefix is /tmp/tsqa.env.lCp2gA
> Tests that origin_min_keep_alive_connections is honored via http. ... ok
> INFO 2015-10-06 19:44:37,977 - Environment prefix is /tmp/tsqa.env.1AhrQW
> Tests that origin_min_keep_alive_connections is honored via https. ... ok
> INFO 2015-10-06 19:44:44,420 - Environment prefix is /tmp/tsqa.env.Dh8jMj
> 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-06 19:45:05,936 - Environment prefix is /tmp/tsqa.env.Da9pPO
> 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-06 19:45:27,461 - Environment prefix is /tmp/tsqa.env.jqbzow
> 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-06 19:45:30,930 - Environment prefix is /tmp/tsqa.env.Bn7wJ8
> 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-06 19:45:34,373 - Environment prefix is /tmp/tsqa.env.Rrdw6V
> INFO 2015-10-06 19:45:34,375 - socket_server_port = 45943
> INFO 2015-10-06 19:45:34,375 - starting the socket server
> test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-06 19:45:37,649 - Sending data back to the client: f7329ef30d274fcca61c2178c546eba8
> INFO 2015-10-06 19:45:37,650 - f7329ef30d274fcca61c2178c546eba8
> INFO 2015-10-06 19:45:42,652 - Sending data back to the client: f7329ef30d274fcca61c2178c546eba8
> INFO 2015-10-06 19:45:42,653 - f7329ef30d274fcca61c2178c546eba8
> ok
> INFO 2015-10-06 19:45:42,843 - Environment prefix is /tmp/tsqa.env.MYoWfx
> test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /redirect/9 HTTP/1.1" 302 247
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/8 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/7 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/6 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/5 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/4 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/3 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/2 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/1 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /get HTTP/1.1" 200 391
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /redirect/10 HTTP/1.1" 302 247
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/9 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/8 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/7 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/6 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/5 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/4 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/3 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/2 HTTP/1.1" 302 0
> 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/1 HTTP/1.1" 302 0
> ok
> INFO 2015-10-06 19:45:46,413 - Environment prefix is /tmp/tsqa.env.0xlzrr
> test_regressions (test_regressions.TestRegressions) ... ok
> INFO 2015-10-06 19:48:20,454 - 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-06 19:48:29,918 - Environment prefix is /tmp/tsqa.env.kEEirS
> test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [06/Oct/2015 19:48:33] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:48:33] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:48:33] "GET / HTTP/1.1" 200 5
> ok
> INFO 2015-10-06 19:48:33,488 - Environment prefix is /tmp/tsqa.env.FoYDFt
> test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [06/Oct/2015 19:48:36] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:48:36] "GET / HTTP/1.1" 200 5
> 127.0.0.1 - - [06/Oct/2015 19:48:36] "GET / HTTP/1.1" 200 5
> ok
> SKIP: Skipping spdy/2 tests
> INFO 2015-10-06 19:48:36,970 - Environment prefix is /tmp/tsqa.env.BjJh9s
> INFO 2015-10-06 19:48:36,972 - spdycat path = /usr/local/bin/spdycat
> INFO 2015-10-06 19:48:36,972 - spdy server port = 39975
> INFO 2015-10-06 19:48:36,972 - http server port = 40496
> Test that the origin does in fact support spdy 3 ... INFO 2015-10-06 19:48:40,197 - full args = ['/usr/local/bin/spdycat', 'https://localhost:39975/', '-nv', '--spdy3']
> ok
> Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:48:41,387 - full args = ['/usr/local/bin/spdycat', 'https://localhost:40496/', '-nv', '--spdy3']
> Fatal: EOF
> reqnum=1, completed=0
> Some requests were not processed. total=1, processed=0
> ok
> INFO 2015-10-06 19:48:41,592 - Environment prefix is /tmp/tsqa.env.QZ2SjS
> INFO 2015-10-06 19:48:41,594 - spdycat path = /usr/local/bin/spdycat
> INFO 2015-10-06 19:48:41,594 - spdy server port = 56167
> INFO 2015-10-06 19:48:41,594 - http server port = 56184
> Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-06 19:48:44,829 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56167/', '-nv', '--spdy3-1']
> ok
> Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:48:45,907 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56184/', '-nv', '--spdy3-1']
> Fatal: EOF
> reqnum=1, completed=0
> Some requests were not processed. total=1, processed=0
> ok
> INFO 2015-10-06 19:48:46,118 - Environment prefix is /tmp/tsqa.env.Z_Ust1
> 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=45057): Read timed out.
> -------------------- >> begin captured logging << --------------------
> root: INFO: Environment prefix is /tmp/tsqa.env.PDQqR1
> 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 924.049s
>
> 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 #917
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/917/changes>
Changes:
[shinrich] TS-3701 - Crash in trampoline cleanup
------------------------------------------
[...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-06 19:40:25,549 - Environment prefix is /tmp/tsqa.env.Xy3nQJ
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-10-06 19:42:09,106 - Environment prefix is /tmp/tsqa.env.x8X_nR
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-06 19:42:39,572 - 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-06 19:43:31,143 - 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-06 19:43:31,211 - Environment prefix is /tmp/tsqa.env.HgtNma
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-06 19:43:34,622 - Environment prefix is /tmp/tsqa.env.hSBhiM
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [06/Oct/2015 19:43:37] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-06 19:43:38,151 - Environment prefix is /tmp/tsqa.env.lO59dR
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-06 19:43:51,744 - Environment prefix is /tmp/tsqa.env.5ybhyW
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [06/Oct/2015 19:43:54] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:54] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:43:55] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:43:55,218 - Environment prefix is /tmp/tsqa.env.Icf9I1
INFO 2015-10-06 19:43:55,220 - map / http://127.0.0.1:39454/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-06 19:43:58,459 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:43:58 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:43:58,460 - head request with case(TE) costs 0.012634 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 19:43:58,461 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:43:58 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:43:58,461 - head request with case(CL) costs 0.001248 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 19:43:58,462 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:43:58 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:43:58,462 - head request with case() costs 0.000903 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-06 19:43:58,650 - Environment prefix is /tmp/tsqa.env.khUBnS
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-06 19:44:02,214 - Environment prefix is /tmp/tsqa.env.5Drpn3
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-06 19:44:07,672 - Environment prefix is /tmp/tsqa.env.ZC6sC2
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-06 19:44:17,153 - Environment prefix is /tmp/tsqa.env.xxtBlv
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.xxtBlv
--------------------- >> 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-06 19:44:17,244 - Environment prefix is /tmp/tsqa.env.585v8A
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.585v8A
--------------------- >> end captured logging << ---------------------
INFO 2015-10-06 19:44:17,350 - Environment prefix is /tmp/tsqa.env.FKAsi4
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-06 19:44:20,861 - Environment prefix is /tmp/tsqa.env.4F9y0N
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-06 19:44:24,438 - Environment prefix is /tmp/tsqa.env.GWtnHY
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-06 19:44:28,078 - Environment prefix is /tmp/tsqa.env.nUld_x
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 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:44:31] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:44:31,508 - Environment prefix is /tmp/tsqa.env.lCp2gA
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-06 19:44:37,977 - Environment prefix is /tmp/tsqa.env.1AhrQW
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-06 19:44:44,420 - Environment prefix is /tmp/tsqa.env.Dh8jMj
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-06 19:45:05,936 - Environment prefix is /tmp/tsqa.env.Da9pPO
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-06 19:45:27,461 - Environment prefix is /tmp/tsqa.env.jqbzow
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-06 19:45:30,930 - Environment prefix is /tmp/tsqa.env.Bn7wJ8
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-06 19:45:34,373 - Environment prefix is /tmp/tsqa.env.Rrdw6V
INFO 2015-10-06 19:45:34,375 - socket_server_port = 45943
INFO 2015-10-06 19:45:34,375 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-06 19:45:37,649 - Sending data back to the client: f7329ef30d274fcca61c2178c546eba8
INFO 2015-10-06 19:45:37,650 - f7329ef30d274fcca61c2178c546eba8
INFO 2015-10-06 19:45:42,652 - Sending data back to the client: f7329ef30d274fcca61c2178c546eba8
INFO 2015-10-06 19:45:42,653 - f7329ef30d274fcca61c2178c546eba8
ok
INFO 2015-10-06 19:45:42,843 - Environment prefix is /tmp/tsqa.env.MYoWfx
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:45:46] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-06 19:45:46,413 - Environment prefix is /tmp/tsqa.env.0xlzrr
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-06 19:48:20,454 - 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-06 19:48:29,918 - Environment prefix is /tmp/tsqa.env.kEEirS
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [06/Oct/2015 19:48:33] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:48:33] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:48:33] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:48:33,488 - Environment prefix is /tmp/tsqa.env.FoYDFt
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [06/Oct/2015 19:48:36] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:48:36] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:48:36] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-06 19:48:36,970 - Environment prefix is /tmp/tsqa.env.BjJh9s
INFO 2015-10-06 19:48:36,972 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 19:48:36,972 - spdy server port = 39975
INFO 2015-10-06 19:48:36,972 - http server port = 40496
Test that the origin does in fact support spdy 3 ... INFO 2015-10-06 19:48:40,197 - full args = ['/usr/local/bin/spdycat', 'https://localhost:39975/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:48:41,387 - full args = ['/usr/local/bin/spdycat', 'https://localhost:40496/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 19:48:41,592 - Environment prefix is /tmp/tsqa.env.QZ2SjS
INFO 2015-10-06 19:48:41,594 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 19:48:41,594 - spdy server port = 56167
INFO 2015-10-06 19:48:41,594 - http server port = 56184
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-06 19:48:44,829 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56167/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:48:45,907 - full args = ['/usr/local/bin/spdycat', 'https://localhost:56184/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 19:48:46,118 - Environment prefix is /tmp/tsqa.env.Z_Ust1
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=45057): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.PDQqR1
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 924.049s
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 #916
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/916/>
------------------------------------------
[...truncated 503 lines...]
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-06 19:15:28,147 - Environment prefix is /tmp/tsqa.env.uzADnl
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [06/Oct/2015 19:15:31] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-06 19:15:31,671 - Environment prefix is /tmp/tsqa.env.0_S9fA
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-06 19:15:45,132 - Environment prefix is /tmp/tsqa.env.nz60wS
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:48] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:15:48,687 - Environment prefix is /tmp/tsqa.env.AgQjo1
INFO 2015-10-06 19:15:48,690 - map / http://127.0.0.1:36332/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-06 19:15:51,923 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:15:51 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:15:51,923 - head request with case(TE) costs 0.004466 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 19:15:51,948 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:15:51 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:15:51,949 - head request with case(CL) costs 0.024961 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 19:15:51,950 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:15:51 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:15:51,950 - head request with case() costs 0.001592 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-06 19:15:52,135 - Environment prefix is /tmp/tsqa.env.7vxvaY
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-06 19:15:55,710 - Environment prefix is /tmp/tsqa.env.O9_xab
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-06 19:16:01,212 - Environment prefix is /tmp/tsqa.env.l0102s
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-06 19:16:10,710 - Environment prefix is /tmp/tsqa.env.2bkI5d
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.2bkI5d
--------------------- >> 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-06 19:16:10,791 - Environment prefix is /tmp/tsqa.env.syQ7YH
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.syQ7YH
--------------------- >> end captured logging << ---------------------
INFO 2015-10-06 19:16:10,887 - Environment prefix is /tmp/tsqa.env.NzN0aA
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-06 19:16:14,506 - Environment prefix is /tmp/tsqa.env.ZfV7sq
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-06 19:16:18,179 - Environment prefix is /tmp/tsqa.env._M8Rbk
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-06 19:16:21,735 - Environment prefix is /tmp/tsqa.env.hammzb
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 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:16:25] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:16:25,228 - Environment prefix is /tmp/tsqa.env.3Vxg03
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-06 19:16:31,711 - Environment prefix is /tmp/tsqa.env.HZd1xm
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-06 19:16:38,175 - Environment prefix is /tmp/tsqa.env.2Bdp2k
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-06 19:16:59,689 - Environment prefix is /tmp/tsqa.env.d1OPT8
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-06 19:17:21,200 - Environment prefix is /tmp/tsqa.env.zwHz6u
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-06 19:17:24,783 - Environment prefix is /tmp/tsqa.env.fzZsZ4
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-06 19:17:28,288 - Environment prefix is /tmp/tsqa.env.WkzupJ
INFO 2015-10-06 19:17:28,290 - socket_server_port = 55587
INFO 2015-10-06 19:17:28,290 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-06 19:17:31,629 - Sending data back to the client: 805157c0663542df82ada042e1e1cd3f
INFO 2015-10-06 19:17:31,629 - 805157c0663542df82ada042e1e1cd3f
INFO 2015-10-06 19:17:36,636 - Sending data back to the client: 805157c0663542df82ada042e1e1cd3f
INFO 2015-10-06 19:17:36,636 - 805157c0663542df82ada042e1e1cd3f
ok
INFO 2015-10-06 19:17:36,819 - Environment prefix is /tmp/tsqa.env.DDUimS
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:17:40] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-06 19:17:40,460 - Environment prefix is /tmp/tsqa.env.8Uxerj
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-06 19:20:15,998 - 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-06 19:20:26,099 - Environment prefix is /tmp/tsqa.env.T5X27t
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [06/Oct/2015 19:20:29] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:20:29] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:20:29] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:20:29,643 - Environment prefix is /tmp/tsqa.env.DFNjRm
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [06/Oct/2015 19:20:32] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:20:32] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:20:32] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-06 19:20:33,152 - Environment prefix is /tmp/tsqa.env.trIDNj
INFO 2015-10-06 19:20:33,154 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 19:20:33,155 - spdy server port = 59981
INFO 2015-10-06 19:20:33,155 - http server port = 53432
Test that the origin does in fact support spdy 3 ... INFO 2015-10-06 19:20:36,385 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59981/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:20:36,599 - full args = ['/usr/local/bin/spdycat', 'https://localhost:53432/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 19:20:36,803 - Environment prefix is /tmp/tsqa.env.0b6zSH
INFO 2015-10-06 19:20:36,805 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 19:20:36,805 - spdy server port = 47011
INFO 2015-10-06 19:20:36,805 - http server port = 59908
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-06 19:20:40,040 - full args = ['/usr/local/bin/spdycat', 'https://localhost:47011/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:20:40,296 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59908/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 19:20:40,501 - Environment prefix is /tmp/tsqa.env.hWNF7x
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=45240): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Os6Rh3
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.222.188.22 7FDEBC16\n'
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.wVE6xd
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 890.161s
FAILED (SKIP=8, errors=1, failures=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Build failed in Jenkins: tsqa-master #915
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/915/changes>
Changes:
[shinrich] TS-3984 - Missing NULL checks in HttpSM::handler_server_setup_error.
------------------------------------------
[...truncated 502 lines...]
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-06 19:14:35,757 - Environment prefix is /tmp/tsqa.env.rTMfGc
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [06/Oct/2015 19:14:39] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-06 19:14:39,321 - Environment prefix is /tmp/tsqa.env.z_bPJH
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-06 19:14:52,803 - Environment prefix is /tmp/tsqa.env.cl698Y
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:14:56] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:14:56,281 - Environment prefix is /tmp/tsqa.env.grLMTW
INFO 2015-10-06 19:14:56,284 - map / http://127.0.0.1:53008/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-06 19:14:59,511 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:14:59 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:14:59,511 - head request with case(TE) costs 0.002379 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 19:14:59,512 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:14:59 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:14:59,513 - head request with case(CL) costs 0.001458 seconds while the timout is 5.000000 seconds.
INFO 2015-10-06 19:14:59,513 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Tue, 06 Oct 2015 19:14:59 GMT
Age: 0
Connection: close
INFO 2015-10-06 19:14:59,514 - head request with case() costs 0.001031 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-06 19:14:59,697 - Environment prefix is /tmp/tsqa.env.JbLi4F
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-06 19:15:03,153 - Environment prefix is /tmp/tsqa.env.ggrFKO
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-06 19:15:08,619 - Environment prefix is /tmp/tsqa.env.6FBD7x
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-06 19:15:18,118 - Environment prefix is /tmp/tsqa.env.Zn2trp
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Zn2trp
--------------------- >> 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-06 19:15:18,204 - Environment prefix is /tmp/tsqa.env.eAJf0a
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.eAJf0a
--------------------- >> end captured logging << ---------------------
INFO 2015-10-06 19:15:18,303 - Environment prefix is /tmp/tsqa.env.NU9uHN
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-06 19:15:21,838 - Environment prefix is /tmp/tsqa.env.NztNz6
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-06 19:15:25,426 - Environment prefix is /tmp/tsqa.env.J2spdI
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-06 19:15:29,117 - Environment prefix is /tmp/tsqa.env.gVBL5L
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 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:15:32] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:15:32,609 - Environment prefix is /tmp/tsqa.env.FhlEsg
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-06 19:15:39,024 - Environment prefix is /tmp/tsqa.env.KbjgAB
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-06 19:15:45,484 - Environment prefix is /tmp/tsqa.env.KVOj1L
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-06 19:16:07,003 - Environment prefix is /tmp/tsqa.env.ZHi0s_
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-06 19:16:28,638 - Environment prefix is /tmp/tsqa.env.2ReHKF
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-06 19:16:32,100 - Environment prefix is /tmp/tsqa.env.UiVFOY
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-06 19:16:35,567 - Environment prefix is /tmp/tsqa.env.6UMnkg
INFO 2015-10-06 19:16:35,568 - socket_server_port = 39433
INFO 2015-10-06 19:16:35,569 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-06 19:16:38,913 - Sending data back to the client: 2ab1516cb97d4e87874628f42ab21c07
INFO 2015-10-06 19:16:38,920 - 2ab1516cb97d4e87874628f42ab21c07
INFO 2015-10-06 19:16:43,926 - Sending data back to the client: 2ab1516cb97d4e87874628f42ab21c07
INFO 2015-10-06 19:16:43,926 - 2ab1516cb97d4e87874628f42ab21c07
ok
INFO 2015-10-06 19:16:44,108 - Environment prefix is /tmp/tsqa.env.F9xf6v
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /get HTTP/1.1" 200 391
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [06/Oct/2015 19:16:47] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-06 19:16:47,563 - Environment prefix is /tmp/tsqa.env.rqM6Bt
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-06 19:19:21,441 - 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-06 19:19:30,995 - Environment prefix is /tmp/tsqa.env.58KhXV
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [06/Oct/2015 19:19:34] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:19:34] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:19:34] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-06 19:19:34,469 - Environment prefix is /tmp/tsqa.env.xSgRtu
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [06/Oct/2015 19:19:37] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:19:37] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/Oct/2015 19:19:37] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-06 19:19:37,944 - Environment prefix is /tmp/tsqa.env.COOudS
INFO 2015-10-06 19:19:37,946 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 19:19:37,946 - spdy server port = 36582
INFO 2015-10-06 19:19:37,947 - http server port = 48710
Test that the origin does in fact support spdy 3 ... INFO 2015-10-06 19:19:41,172 - full args = ['/usr/local/bin/spdycat', 'https://localhost:36582/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:19:42,486 - full args = ['/usr/local/bin/spdycat', 'https://localhost:48710/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 19:19:42,689 - Environment prefix is /tmp/tsqa.env.g3AaZv
INFO 2015-10-06 19:19:42,691 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-06 19:19:42,691 - spdy server port = 42946
INFO 2015-10-06 19:19:42,691 - http server port = 57551
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-06 19:19:45,919 - full args = ['/usr/local/bin/spdycat', 'https://localhost:42946/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-06 19:19:47,403 - full args = ['/usr/local/bin/spdycat', 'https://localhost:57551/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-06 19:19:47,613 - Environment prefix is /tmp/tsqa.env.ckwpO4
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=37311): Read timed out.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.8RTWD0
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.75.136.247 7F4B88F7\n'
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.3qK9JY
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 83 tests in 859.978s
FAILED (SKIP=8, errors=1, failures=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results