See <https://ci.trafficserver.apache.org/job/tsqa-master/954/changes>
Changes: [Bryan Call] TS-3961: Open source Yahoo's ats-multiplexer plug-in ------------------------------------------ [...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-26 22:04:12,558 - Environment prefix is /tmp/tsqa.env.9YFc0Q test_log_field (test_custom_log.TestCustomLogField) ... ok INFO 2015-10-26 22:05:56,330 - Environment prefix is /tmp/tsqa.env.FKCNCy 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 22:06:26,974 - 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 22:07:19,575 - 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 22:07:19,642 - Environment prefix is /tmp/tsqa.env.B1LAr4 test_spdy (test_example.TestConfigureFlags) ... ok INFO 2015-10-26 22:07:23,076 - Environment prefix is /tmp/tsqa.env.EK0vSr test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [26/Oct/2015 22:07:26] "GET /test HTTP/1.1" 404 0 ok INFO 2015-10-26 22:07:26,534 - Environment prefix is /tmp/tsqa.env.a3N7vt test_logs_exist (test_example.TestLogs) ... ok SKIP: Skip the entire class INFO 2015-10-26 22:07:40,134 - Environment prefix is /tmp/tsqa.env.oTZ5HS test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:07:43] "GET / HTTP/1.1" 200 5 ok INFO 2015-10-26 22:07:43,628 - Environment prefix is /tmp/tsqa.env.HDtoZy INFO 2015-10-26 22:07:43,630 - map / http://127.0.0.1:49874/ test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-26 22:07:46,976 - HTTP/1.1 200 OK Server: ATS/6.1.0 Vary: Accept-Encoding Date: Mon, 26 Oct 2015 22:07:46 GMT Age: 0 Connection: close INFO 2015-10-26 22:07:46,976 - head request with case(TE) costs 0.002012 seconds while the timout is 5.000000 seconds. INFO 2015-10-26 22:07:46,977 - HTTP/1.1 200 OK Server: ATS/6.1.0 Content-Length: 123 Vary: Accept-Encoding Date: Mon, 26 Oct 2015 22:07:46 GMT Age: 0 Connection: close INFO 2015-10-26 22:07:46,978 - head request with case(CL) costs 0.001068 seconds while the timout is 5.000000 seconds. INFO 2015-10-26 22:07:46,993 - HTTP/1.1 200 OK Server: ATS/6.1.0 Vary: Accept-Encoding Date: Mon, 26 Oct 2015 22:07:46 GMT Age: 0 Connection: close INFO 2015-10-26 22:07:46,994 - head request with case() costs 0.015849 seconds while the timout is 5.000000 seconds. ok INFO 2015-10-26 22:07:47,184 - Environment prefix is /tmp/tsqa.env.gW96MY test_working (test_hostdb.TestHostDBBadResolvConf) ... ok INFO 2015-10-26 22:07:50,774 - Environment prefix is /tmp/tsqa.env.QlLpnE test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok INFO 2015-10-26 22:07:56,405 - Environment prefix is /tmp/tsqa.env.Qas45B Test basic fnctionality of hosts files ... ok Test that changes to hosts file get loaded within host_file.interval ... ok INFO 2015-10-26 22:08:06,041 - Environment prefix is /tmp/tsqa.env.wTXZaC SKIP: -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.wTXZaC --------------------- >> 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 22:08:06,127 - Environment prefix is /tmp/tsqa.env.GPf2fP SKIP: Cannot find h2spec. skipping test. -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.GPf2fP --------------------- >> end captured logging << --------------------- INFO 2015-10-26 22:08:06,229 - Environment prefix is /tmp/tsqa.env.2g0Ujs 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 22:08:09,890 - Environment prefix is /tmp/tsqa.env.lfQHwn 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 22:08:13,657 - Environment prefix is /tmp/tsqa.env.r6osCL 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 22:08:17,341 - Environment prefix is /tmp/tsqa.env.bjv9m7 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 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:08:20] "GET /exists/ HTTP/1.1" 200 5 ok INFO 2015-10-26 22:08:20,823 - Environment prefix is /tmp/tsqa.env.NaIaCq Tests that origin_min_keep_alive_connections is honored via http. ... ok INFO 2015-10-26 22:08:27,314 - Environment prefix is /tmp/tsqa.env.6bw8t4 Tests that origin_min_keep_alive_connections is honored via https. ... ok INFO 2015-10-26 22:08:33,835 - Environment prefix is /tmp/tsqa.env._Y9elv 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 22:08:55,410 - Environment prefix is /tmp/tsqa.env.Qr5vgN 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 22:09:17,041 - Environment prefix is /tmp/tsqa.env.MAhVGp 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 22:09:20,531 - Environment prefix is /tmp/tsqa.env.GSjwde 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 22:09:24,087 - Environment prefix is /tmp/tsqa.env.vdASG0 INFO 2015-10-26 22:09:24,089 - socket_server_port = 37751 INFO 2015-10-26 22:09:24,089 - starting the socket server test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-26 22:09:27,567 - Sending data back to the client: f81186a024cc49f795e0e98ee00a4a6f INFO 2015-10-26 22:09:27,575 - f81186a024cc49f795e0e98ee00a4a6f INFO 2015-10-26 22:09:32,586 - Sending data back to the client: f81186a024cc49f795e0e98ee00a4a6f INFO 2015-10-26 22:09:32,586 - f81186a024cc49f795e0e98ee00a4a6f ok INFO 2015-10-26 22:09:32,772 - Environment prefix is /tmp/tsqa.env.Msd44j test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /redirect/9 HTTP/1.1" 302 247 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/8 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/7 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/6 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/5 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/4 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/3 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/2 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/1 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /get HTTP/1.1" 200 391 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /redirect/10 HTTP/1.1" 302 247 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/9 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/8 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/7 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/6 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/5 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/4 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/3 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/2 HTTP/1.1" 302 0 127.0.0.1 - - [26/Oct/2015 22:09:36] "GET /relative-redirect/1 HTTP/1.1" 302 0 ok INFO 2015-10-26 22:09:36,343 - Environment prefix is /tmp/tsqa.env.u1E8vO test_regressions (test_regressions.TestRegressions) ... ok INFO 2015-10-26 22:12:09,631 - 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 22:12:19,018 - Environment prefix is /tmp/tsqa.env.f0vxhr test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [26/Oct/2015 22:12:22] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:12:22] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:12:22] "GET / HTTP/1.1" 200 5 ok INFO 2015-10-26 22:12:22,571 - Environment prefix is /tmp/tsqa.env.DiBe8j test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [26/Oct/2015 22:12:25] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:12:25] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [26/Oct/2015 22:12:25] "GET / HTTP/1.1" 200 5 ok SKIP: Skipping spdy/2 tests INFO 2015-10-26 22:12:26,133 - Environment prefix is /tmp/tsqa.env.5_gfiT INFO 2015-10-26 22:12:26,135 - spdycat path = /usr/local/bin/spdycat INFO 2015-10-26 22:12:26,135 - spdy server port = 54841 INFO 2015-10-26 22:12:26,135 - http server port = 41058 Test that the origin does in fact support spdy 3 ... INFO 2015-10-26 22:12:29,375 - full args = ['/usr/local/bin/spdycat', 'https://localhost:54841/', '-nv', '--spdy3'] ok Test that non spdy port won't advertise spdy ... INFO 2015-10-26 22:12:30,528 - full args = ['/usr/local/bin/spdycat', 'https://localhost:41058/', '-nv', '--spdy3'] Fatal: EOF reqnum=1, completed=0 Some requests were not processed. total=1, processed=0 ok INFO 2015-10-26 22:12:30,750 - Environment prefix is /tmp/tsqa.env.m5eYHd INFO 2015-10-26 22:12:30,751 - spdycat path = /usr/local/bin/spdycat INFO 2015-10-26 22:12:30,752 - spdy server port = 59957 INFO 2015-10-26 22:12:30,752 - http server port = 48672 Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-26 22:12:33,925 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59957/', '-nv', '--spdy3-1'] ok Test that non spdy port won't advertise spdy ... INFO 2015-10-26 22:12:35,140 - full args = ['/usr/local/bin/spdycat', 'https://localhost:48672/', '-nv', '--spdy3-1'] Fatal: EOF reqnum=1, completed=0 Some requests were not processed. total=1, processed=0 ok INFO 2015-10-26 22:12:35,368 - Environment prefix is /tmp/tsqa.env.eRNfTH 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=42380): Read timed out. -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.y62jFQ test_chunked: INFO: sending data back to the client test_chunked: INFO: Client disconnected --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml> ---------------------------------------------------------------------- Ran 83 tests in 921.520s FAILED (SKIP=8, errors=1) 2 make: *** [test] Error 1 Build step 'Execute shell' marked build as failure Recording test results