See <https://ci.trafficserver.apache.org/job/tsqa-master/750/changes>
Changes: [Leif Hedstrom] Revert "TS-1007: SSLN Close called before TXN Close. This closes #249." ------------------------------------------ [...truncated 504 lines...] Test that incrementing the cache generation acts like a cache clear ... ok INFO 2015-07-31 14:16:03,389 - Environment prefix is /tmp/tsqa.env.DnPVC6 test_chunked_bad_close (test_chunked.TestChunked) ... INFO 2015-07-31 14:16:06,617 - sending data back to the client INFO 2015-07-31 14:16:09,119 - Client disconnected ok test_chunked_basic (test_chunked.TestChunked) ... INFO 2015-07-31 14:16:09,123 - sending data back to the client ok test_chunked_keepalive_client (test_chunked.TestChunked) ... INFO 2015-07-31 14:16:12,128 - sending data back to the client INFO 2015-07-31 14:16:15,133 - sending data back to the client INFO 2015-07-31 14:16:18,137 - sending data back to the client INFO 2015-07-31 14:16:20,541 - sending data back to the client INFO 2015-07-31 14:16:22,944 - sending data back to the client INFO 2015-07-31 14:16:26,949 - sending data back to the client ok test_chunked_keepalive_server (test_chunked.TestChunked) ... INFO 2015-07-31 14:16:30,954 - sending data back to the client INFO 2015-07-31 14:16:33,958 - sending data back to the client ok Test that the origin does in fact support keepalive ... INFO 2015-07-31 14:16:34,963 - sending data back to the client INFO 2015-07-31 14:16:37,967 - sending data back to the client INFO 2015-07-31 14:16:38,971 - sending data back to the client INFO 2015-07-31 14:16:40,972 - Client disconnected INFO 2015-07-31 14:16:41,374 - sending data back to the client INFO 2015-07-31 14:16:41,776 - sending data back to the client INFO 2015-07-31 14:16:43,778 - Client disconnected INFO 2015-07-31 14:16:45,781 - sending data back to the client ok INFO 2015-07-31 14:16:47,789 - Client disconnected INFO 2015-07-31 14:16:47,991 - Environment prefix is /tmp/tsqa.env.vl4SJB INFO 2015-07-31 14:16:49,784 - Client disconnected Verify that we get 502s from an origin which just did a bind ... ok Verify that we get 200s from origins that delayed_accept_after_connect ... ok Verify that we get 504s from origins that die_on_connect ... ok Verify that we get 502s from origins that bind + listen ... ok Verify that we get 504s from origins that return a partial_response ... FAIL Verify that we get 200s from origins that reset_after_accept ... FAIL INFO 2015-07-31 14:16:59,291 - Environment prefix is /tmp/tsqa.env.JKW5To test_log_field (test_custom_log.TestCustomLogField) ... ok INFO 2015-07-31 14:18:42,830 - Environment prefix is /tmp/tsqa.env.E88zIv test_default_404 (test_example.TestBootstrap) ... ok Test that traffic_line works, and verify that the values for proxy.config ... ok INFO 2015-07-31 14:19:12,862 - 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-07-31 14:20:12,079 - 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-07-31 14:20:12,146 - Environment prefix is /tmp/tsqa.env.xLrCN4 test_spdy (test_example.TestConfigureFlags) ... ok INFO 2015-07-31 14:20:15,556 - Environment prefix is /tmp/tsqa.env._PTrJV test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [31/Jul/2015 14:20:18] "GET /test HTTP/1.1" 404 0 ok INFO 2015-07-31 14:20:18,966 - Environment prefix is /tmp/tsqa.env.bDo3BQ test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 127.0.0.1 - - [31/Jul/2015 14:20:22] "GET / HTTP/1.1" 404 0 FAIL INFO 2015-07-31 14:20:32,460 - Environment prefix is /tmp/tsqa.env.fKmZ5K test_logs_exist (test_example.TestLogs) ... ok SKIP: Skip the entire class INFO 2015-07-31 14:20:45,922 - Environment prefix is /tmp/tsqa.env.bVUdE0 test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:20:49] "GET / HTTP/1.1" 200 5 ok INFO 2015-07-31 14:20:49,373 - Environment prefix is /tmp/tsqa.env.dJwpOi test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok INFO 2015-07-31 14:20:54,803 - Environment prefix is /tmp/tsqa.env.c9Lf8q Test basic fnctionality of hosts files ... ok Test that changes to hosts file get loaded within host_file.interval ... ok INFO 2015-07-31 14:21:04,291 - Environment prefix is /tmp/tsqa.env.5x7FGz SKIP: -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.5x7FGz --------------------- >> end captured logging << --------------------- INFO 2015-07-31 14:21:05,298 - Environment prefix is /tmp/tsqa.env.bM4mlX 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-07-31 14:21:08,828 - Environment prefix is /tmp/tsqa.env.d3xdjh 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-07-31 14:21:12,374 - Environment prefix is /tmp/tsqa.env.uVshlK 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-07-31 14:21:15,907 - Environment prefix is /tmp/tsqa.env.lHVCh6 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 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:21:19] "GET /exists/ HTTP/1.1" 200 5 ok INFO 2015-07-31 14:21:19,340 - Environment prefix is /tmp/tsqa.env.gZ9Abm Tests that origin_min_keep_alive_connections is honored via http. ... ok INFO 2015-07-31 14:21:25,771 - Environment prefix is /tmp/tsqa.env.S1F5dD Tests that origin_min_keep_alive_connections is honored via https. ... ok INFO 2015-07-31 14:21:32,198 - Environment prefix is /tmp/tsqa.env.AH3zjY 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-07-31 14:21:53,745 - Environment prefix is /tmp/tsqa.env.aHOQcM 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-07-31 14:22:15,243 - Environment prefix is /tmp/tsqa.env.u1qMaK Tests that keepalive works through ATS to origin via https. ... ok Tests that keepalive works through ATS to origin via https. ... ok INFO 2015-07-31 14:22:18,689 - Environment prefix is /tmp/tsqa.env.jKKnCO Tests that keepalive works through ATS to origin via https. ... ok Tests that keepalive works through ATS to origin via https. ... ok INFO 2015-07-31 14:22:22,117 - Environment prefix is /tmp/tsqa.env.J1h_pF test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/9 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/8 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/7 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/6 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/5 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/4 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/3 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/2 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/1 HTTP/1.1" 302 215 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /get HTTP/1.1" 200 437 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/10 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/9 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/8 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/7 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/6 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/5 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/4 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/3 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/2 HTTP/1.1" 302 229 127.0.0.1 - - [31/Jul/2015 14:22:25] "GET /redirect/1 HTTP/1.1" 302 215 ok INFO 2015-07-31 14:22:25,559 - Environment prefix is /tmp/tsqa.env.p27cEI test_regressions (test_regressions.TestRegressions) ... ok INFO 2015-07-31 14:24:58,700 - 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-07-31 14:25:07,854 - Environment prefix is /tmp/tsqa.env.pKIp8A test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [31/Jul/2015 14:25:11] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:25:11] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:25:11] "GET / HTTP/1.1" 200 5 ok INFO 2015-07-31 14:25:11,283 - Environment prefix is /tmp/tsqa.env.jel4Sz test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [31/Jul/2015 14:25:14] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:25:14] "GET / HTTP/1.1" 200 5 127.0.0.1 - - [31/Jul/2015 14:25:14] "GET / HTTP/1.1" 200 5 ok SKIP: Skipping spdy/2 tests INFO 2015-07-31 14:25:14,728 - Environment prefix is /tmp/tsqa.env.Hiif0D INFO 2015-07-31 14:25:14,730 - spdycat path = /usr/local/bin/spdycat INFO 2015-07-31 14:25:14,731 - spdy server port = 49507 INFO 2015-07-31 14:25:14,731 - http server port = 57083 Test that the origin does in fact support spdy 3 ... INFO 2015-07-31 14:25:17,952 - full args = ['/usr/local/bin/spdycat', 'https://localhost:49507/', '-nv', '--spdy3'] ok Test that non spdy port won't advertise spdy ... INFO 2015-07-31 14:25:19,060 - full args = ['/usr/local/bin/spdycat', 'https://localhost:57083/', '-nv', '--spdy3'] Fatal: EOF reqnum=1, completed=0 Some requests were not processed. total=1, processed=0 ok INFO 2015-07-31 14:25:19,265 - Environment prefix is /tmp/tsqa.env.qnynoi INFO 2015-07-31 14:25:19,267 - spdycat path = /usr/local/bin/spdycat INFO 2015-07-31 14:25:19,267 - spdy server port = 53413 INFO 2015-07-31 14:25:19,267 - http server port = 55385 Test that the origin does in fact support spdy 3.1 ... INFO 2015-07-31 14:25:22,494 - full args = ['/usr/local/bin/spdycat', 'https://localhost:53413/', '-nv', '--spdy3-1'] ok Test that non spdy port won't advertise spdy ... INFO 2015-07-31 14:25:23,516 - full args = ['/usr/local/bin/spdycat', 'https://localhost:55385/', '-nv', '--spdy3-1'] Fatal: EOF reqnum=1, completed=0 Some requests were not processed. total=1, processed=0 ok INFO 2015-07-31 14:25:23,724 - Environment prefix is /tmp/tsqa.env.NDZaup Make sure the new ticket key is loaded ... ok Make sure the new ticket key is loaded ... ok ====================================================================== FAIL: Verify that we get 504s from origins that return a partial_response ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_connect_attempts.py",> line 195, in test_partial_response_origin self.assertEqual(ret.status_code, 502) AssertionError: 200 != 502 ====================================================================== FAIL: Verify that we get 200s from origins that reset_after_accept ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_connect_attempts.py",> line 201, in test_reset_after_accept_origin self.assertEqual(ret.status_code, 200) AssertionError: 502 != 200 ====================================================================== FAIL: test_logs_exist (test_example.TestLogRefCounting) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_example.py",> line 215, in test_logs_exist self.assertTrue(os.path.isfile(logfile_path), logfile_path) AssertionError: /tmp/tsqa.env.bDo3BQ/var/log/squid.log -------------------- >> begin captured logging << -------------------- root: INFO: Environment prefix is /tmp/tsqa.env.bDo3BQ --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml> ---------------------------------------------------------------------- Ran 80 tests in 949.077s FAILED (SKIP=6, failures=3) 1 make: *** [test] Error 1 Build step 'Execute shell' marked build as failure Recording test results