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/09/03 16:31:22 UTC
Build failed in Jenkins: tsqa-master #833
See <https://ci.trafficserver.apache.org/job/tsqa-master/833/changes>
Changes:
[solidwallofcode] TS-3848: Extend wait_for_cache to specify dependency on cache initialization.
[solidwallofcode] TS-3848: Documentation update.
------------------------------------------
[...truncated 491 lines...]
INFO 2015-09-03 14:21:06,960 - Client disconnected
INFO 2015-09-03 14:21:07,160 - Environment prefix is /tmp/tsqa.env.t6XHFX
INFO 2015-09-03 14:21:08,955 - 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 ... 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-09-03 14:21:18,474 - Environment prefix is /tmp/tsqa.env.mah2Qp
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-09-03 14:23:02,068 - Environment prefix is /tmp/tsqa.env.Vr1pWx
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-09-03 14:23:31,877 - 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-09-03 14:25:24,366 - 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-09-03 14:25:24,433 - Environment prefix is /tmp/tsqa.env.N2EYLd
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-09-03 14:25:27,860 - Environment prefix is /tmp/tsqa.env.5T_Ce2
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [03/Sep/2015 14:25:31] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-09-03 14:25:31,291 - Environment prefix is /tmp/tsqa.env.Dgvb5v
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 14:25:34] "GET / HTTP/1.1" 404 0
FAIL
INFO 2015-09-03 14:25:44,839 - Environment prefix is /tmp/tsqa.env.q33BH3
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-09-03 14:25:58,318 - Environment prefix is /tmp/tsqa.env.Erfqq9
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:01] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 14:26:01,782 - Environment prefix is /tmp/tsqa.env.a_DyR1
INFO 2015-09-03 14:26:01,784 - map / http://127.0.0.1:42929/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-09-03 14:26:05,024 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 14:26:05 GMT
Age: 0
Connection: close
INFO 2015-09-03 14:26:05,024 - head request with case(TE) costs 0.014487 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 14:26:05,026 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 14:26:05 GMT
Age: 0
Connection: close
INFO 2015-09-03 14:26:05,026 - head request with case(CL) costs 0.001596 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 14:26:05,027 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 14:26:05 GMT
Age: 0
Connection: close
INFO 2015-09-03 14:26:05,027 - head request with case() costs 0.001026 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-09-03 14:26:05,210 - Environment prefix is /tmp/tsqa.env.w0uUAb
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-09-03 14:26:08,661 - Environment prefix is /tmp/tsqa.env.2oNp7p
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-09-03 14:26:14,090 - Environment prefix is /tmp/tsqa.env.n3xb83
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-09-03 14:26:23,582 - Environment prefix is /tmp/tsqa.env.9TlKSK
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.9TlKSK
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-09-03 14:26:23,688 - Environment prefix is /tmp/tsqa.env.jndSa_
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-09-03 14:26:27,204 - Environment prefix is /tmp/tsqa.env.P46fx4
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-09-03 14:26:30,859 - Environment prefix is /tmp/tsqa.env.ZeMPb8
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-09-03 14:26:34,495 - Environment prefix is /tmp/tsqa.env.PdWbBJ
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 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:26:37] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-09-03 14:26:37,920 - Environment prefix is /tmp/tsqa.env.8KH5eD
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-09-03 14:26:44,372 - Environment prefix is /tmp/tsqa.env.zDkii1
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-09-03 14:26:50,814 - Environment prefix is /tmp/tsqa.env.Ck4bfu
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-09-03 14:27:12,290 - Environment prefix is /tmp/tsqa.env.R2LUpe
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-09-03 14:27:33,785 - Environment prefix is /tmp/tsqa.env.xIoTzI
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 14:27:37,278 - Environment prefix is /tmp/tsqa.env.dFCSod
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 14:27:40,747 - Environment prefix is /tmp/tsqa.env.qHvdt3
INFO 2015-09-03 14:27:40,749 - socket_server_port = 46645
INFO 2015-09-03 14:27:40,749 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-09-03 14:27:43,994 - Sending data back to the client: 4c52ebcdda5a4fe8866acfa9b8cdf270
INFO 2015-09-03 14:27:43,996 - 4c52ebcdda5a4fe8866acfa9b8cdf270
INFO 2015-09-03 14:27:49,001 - Sending data back to the client: 4c52ebcdda5a4fe8866acfa9b8cdf270
INFO 2015-09-03 14:27:49,001 - 4c52ebcdda5a4fe8866acfa9b8cdf270
ok
INFO 2015-09-03 14:27:49,186 - Environment prefix is /tmp/tsqa.env.KLOAb0
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 14:27:52] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-09-03 14:27:52,634 - Environment prefix is /tmp/tsqa.env.ZQHcBw
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-09-03 14:30:25,916 - 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-09-03 14:30:34,943 - Environment prefix is /tmp/tsqa.env.sSQeuk
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [03/Sep/2015 14:30:38] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:30:38] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:30:38] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 14:30:38,491 - Environment prefix is /tmp/tsqa.env.wmLPr3
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [03/Sep/2015 14:30:41] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:30:41] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 14:30:41] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-09-03 14:30:42,049 - Environment prefix is /tmp/tsqa.env.285WGb
INFO 2015-09-03 14:30:42,051 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 14:30:42,051 - spdy server port = 37326
INFO 2015-09-03 14:30:42,051 - http server port = 50487
Test that the origin does in fact support spdy 3 ... INFO 2015-09-03 14:30:45,275 - full args = ['/usr/local/bin/spdycat', 'https://localhost:37326/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 14:30:46,733 - full args = ['/usr/local/bin/spdycat', 'https://localhost:50487/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 14:30:46,932 - Environment prefix is /tmp/tsqa.env.F_pVuw
INFO 2015-09-03 14:30:46,934 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 14:30:46,934 - spdy server port = 54759
INFO 2015-09-03 14:30:46,935 - http server port = 45803
Test that the origin does in fact support spdy 3.1 ... INFO 2015-09-03 14:30:50,161 - full args = ['/usr/local/bin/spdycat', 'https://localhost:54759/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 14:30:51,565 - full args = ['/usr/local/bin/spdycat', 'https://localhost:45803/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 14:30:51,770 - Environment prefix is /tmp/tsqa.env.T_qH21
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok
======================================================================
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.Dgvb5v/var/log/squid.log
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Dgvb5v
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 84 tests in 1219.798s
FAILED (SKIP=7, failures=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Build failed in Jenkins: tsqa-master #837
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/837/changes>
Changes:
[Bryan Call] TS-3890: Errors in the huffman tree for HTTP/2
------------------------------------------
[...truncated 491 lines...]
INFO 2015-09-03 19:30:24,874 - Client disconnected
INFO 2015-09-03 19:30:25,078 - Environment prefix is /tmp/tsqa.env.d8DNsb
INFO 2015-09-03 19:30:26,869 - 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 ... 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-09-03 19:30:35,401 - Environment prefix is /tmp/tsqa.env.oxnhqi
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-09-03 19:32:18,996 - Environment prefix is /tmp/tsqa.env.pnust8
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-09-03 19:32:48,702 - 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-09-03 19:33:41,446 - 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-09-03 19:33:41,512 - Environment prefix is /tmp/tsqa.env.zxCV4F
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-09-03 19:33:44,941 - Environment prefix is /tmp/tsqa.env.obZpMV
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [03/Sep/2015 19:33:48] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-09-03 19:33:48,376 - Environment prefix is /tmp/tsqa.env.3HP8vN
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 19:33:51] "GET / HTTP/1.1" 404 0
FAIL
INFO 2015-09-03 19:34:01,986 - Environment prefix is /tmp/tsqa.env.aDVldH
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-09-03 19:34:15,502 - Environment prefix is /tmp/tsqa.env.nWEn8e
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:18] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 19:34:18,947 - Environment prefix is /tmp/tsqa.env.0XdcJO
INFO 2015-09-03 19:34:18,949 - map / http://127.0.0.1:51219/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-09-03 19:34:22,175 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 19:34:22 GMT
Age: 0
Connection: close
INFO 2015-09-03 19:34:22,175 - head request with case(TE) costs 0.002228 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 19:34:22,176 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 19:34:22 GMT
Age: 0
Connection: close
INFO 2015-09-03 19:34:22,176 - head request with case(CL) costs 0.001086 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 19:34:22,177 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 19:34:22 GMT
Age: 0
Connection: close
INFO 2015-09-03 19:34:22,178 - head request with case() costs 0.000968 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-09-03 19:34:22,361 - Environment prefix is /tmp/tsqa.env._rWDjb
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-09-03 19:34:25,811 - Environment prefix is /tmp/tsqa.env.Yi7Lqy
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-09-03 19:34:31,249 - Environment prefix is /tmp/tsqa.env.4fIz8M
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-09-03 19:34:40,729 - Environment prefix is /tmp/tsqa.env.pB_rRx
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.pB_rRx
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-09-03 19:34:40,832 - Environment prefix is /tmp/tsqa.env.OGkgQk
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-09-03 19:34:44,454 - Environment prefix is /tmp/tsqa.env.ZpsK_p
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-09-03 19:34:48,014 - Environment prefix is /tmp/tsqa.env.QBYgHT
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-09-03 19:34:51,560 - Environment prefix is /tmp/tsqa.env.YHFhec
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 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:34:54] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-09-03 19:34:54,989 - Environment prefix is /tmp/tsqa.env.BExypB
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-09-03 19:35:01,406 - Environment prefix is /tmp/tsqa.env.OmJ8gF
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-09-03 19:35:07,832 - Environment prefix is /tmp/tsqa.env.dOSok0
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-09-03 19:35:29,317 - Environment prefix is /tmp/tsqa.env.Chj2_p
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-09-03 19:35:50,822 - Environment prefix is /tmp/tsqa.env.mZgUyj
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 19:35:54,280 - Environment prefix is /tmp/tsqa.env.sDWkiV
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 19:35:57,769 - Environment prefix is /tmp/tsqa.env.oiLI_F
INFO 2015-09-03 19:35:57,771 - socket_server_port = 47805
INFO 2015-09-03 19:35:57,771 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-09-03 19:36:01,005 - Sending data back to the client: 421f3cf4e69d4dce8a94d1477ae3a87d
INFO 2015-09-03 19:36:01,010 - 421f3cf4e69d4dce8a94d1477ae3a87d
INFO 2015-09-03 19:36:06,021 - Sending data back to the client: 421f3cf4e69d4dce8a94d1477ae3a87d
INFO 2015-09-03 19:36:06,021 - 421f3cf4e69d4dce8a94d1477ae3a87d
ok
INFO 2015-09-03 19:36:06,204 - Environment prefix is /tmp/tsqa.env.KPoM1S
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 19:36:09] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-09-03 19:36:09,760 - Environment prefix is /tmp/tsqa.env._awnYt
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-09-03 19:38:42,222 - 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-09-03 19:38:51,396 - Environment prefix is /tmp/tsqa.env.AgeTZs
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [03/Sep/2015 19:38:54] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:38:54] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:38:54] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 19:38:54,854 - Environment prefix is /tmp/tsqa.env.cSW6db
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [03/Sep/2015 19:38:58] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:38:58] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 19:38:58] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-09-03 19:38:58,330 - Environment prefix is /tmp/tsqa.env.CiTDUm
INFO 2015-09-03 19:38:58,332 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 19:38:58,332 - spdy server port = 52507
INFO 2015-09-03 19:38:58,332 - http server port = 57066
Test that the origin does in fact support spdy 3 ... INFO 2015-09-03 19:39:01,558 - full args = ['/usr/local/bin/spdycat', 'https://localhost:52507/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 19:39:02,756 - full args = ['/usr/local/bin/spdycat', 'https://localhost:57066/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 19:39:02,958 - Environment prefix is /tmp/tsqa.env.jKITt1
INFO 2015-09-03 19:39:02,960 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 19:39:02,960 - spdy server port = 54473
INFO 2015-09-03 19:39:02,960 - http server port = 36929
Test that the origin does in fact support spdy 3.1 ... INFO 2015-09-03 19:39:06,186 - full args = ['/usr/local/bin/spdycat', 'https://localhost:54473/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 19:39:07,292 - full args = ['/usr/local/bin/spdycat', 'https://localhost:36929/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 19:39:07,494 - Environment prefix is /tmp/tsqa.env.2uhsIA
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok
======================================================================
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.3HP8vN/var/log/squid.log
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.3HP8vN
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 84 tests in 935.297s
FAILED (SKIP=7, failures=1)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Build failed in Jenkins: tsqa-master #836
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/836/changes>
Changes:
[Leif Hedstrom] TS-3889 Avoid reenabling the txn before we release the mbuf
------------------------------------------
[...truncated 492 lines...]
INFO 2015-09-03 18:44:07,199 - Client disconnected
INFO 2015-09-03 18:44:07,386 - Environment prefix is /tmp/tsqa.env.BBzkyd
INFO 2015-09-03 18:44:09,185 - 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 ... 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-09-03 18:44:18,712 - Environment prefix is /tmp/tsqa.env.FVnH_P
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-09-03 18:46:02,305 - Environment prefix is /tmp/tsqa.env.kpajKo
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-09-03 18:46:35,171 - 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-09-03 18:49:13,657 - 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-09-03 18:49:13,718 - Environment prefix is /tmp/tsqa.env.XzEfuR
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-09-03 18:49:17,154 - Environment prefix is /tmp/tsqa.env.3eYCKX
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [03/Sep/2015 18:49:20] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-09-03 18:49:20,621 - Environment prefix is /tmp/tsqa.env.5eIdT5
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [03/Sep/2015 18:49:23] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:23] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:23] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:23] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:24] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:24] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:24] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:24] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:24] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:49:24] "GET / HTTP/1.1" 404 0
FAIL
INFO 2015-09-03 18:49:34,248 - Environment prefix is /tmp/tsqa.env.uHQZql
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-09-03 18:49:47,819 - Environment prefix is /tmp/tsqa.env.7dcUzF
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:49:51] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 18:49:51,381 - Environment prefix is /tmp/tsqa.env.ZO2NJb
INFO 2015-09-03 18:49:51,383 - map / http://127.0.0.1:51873/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-09-03 18:49:54,716 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 18:49:54 GMT
Age: 0
Connection: close
INFO 2015-09-03 18:49:54,716 - head request with case(TE) costs 0.002441 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 18:49:54,718 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 18:49:54 GMT
Age: 0
Connection: close
INFO 2015-09-03 18:49:54,718 - head request with case(CL) costs 0.001147 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 18:49:54,728 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 18:49:54 GMT
Age: 0
Connection: close
INFO 2015-09-03 18:49:54,729 - head request with case() costs 0.010666 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-09-03 18:49:54,920 - Environment prefix is /tmp/tsqa.env.3ID8kj
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-09-03 18:49:58,479 - Environment prefix is /tmp/tsqa.env.YWu0xc
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-09-03 18:50:04,033 - Environment prefix is /tmp/tsqa.env.wscbT1
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-09-03 18:50:13,656 - Environment prefix is /tmp/tsqa.env.o8ut1T
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.o8ut1T
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-09-03 18:50:13,777 - Environment prefix is /tmp/tsqa.env.yrD83a
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-09-03 18:50:17,310 - Environment prefix is /tmp/tsqa.env.WAMfCd
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-09-03 18:50:20,996 - Environment prefix is /tmp/tsqa.env.Vu08U5
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-09-03 18:50:24,682 - Environment prefix is /tmp/tsqa.env.TtEK9q
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 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:50:28] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-09-03 18:50:28,238 - Environment prefix is /tmp/tsqa.env.0GdAqD
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-09-03 18:50:34,699 - Environment prefix is /tmp/tsqa.env.FC8a8x
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-09-03 18:50:41,139 - Environment prefix is /tmp/tsqa.env.FJYGeF
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-09-03 18:51:02,647 - Environment prefix is /tmp/tsqa.env.jC38tI
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-09-03 18:51:24,256 - Environment prefix is /tmp/tsqa.env.XgnnNq
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 18:51:27,768 - Environment prefix is /tmp/tsqa.env.mx4lTr
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 18:51:31,271 - Environment prefix is /tmp/tsqa.env.xJWKPT
INFO 2015-09-03 18:51:31,273 - socket_server_port = 58220
INFO 2015-09-03 18:51:31,274 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-09-03 18:51:34,610 - Sending data back to the client: 4a117317b2b8415fae917df3b451eb2f
INFO 2015-09-03 18:51:34,619 - 4a117317b2b8415fae917df3b451eb2f
INFO 2015-09-03 18:51:39,626 - Sending data back to the client: 4a117317b2b8415fae917df3b451eb2f
INFO 2015-09-03 18:51:39,626 - 4a117317b2b8415fae917df3b451eb2f
ok
INFO 2015-09-03 18:51:39,813 - Environment prefix is /tmp/tsqa.env.x9yK1c
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:51:43] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-09-03 18:51:43,385 - Environment prefix is /tmp/tsqa.env.LW6wUS
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-09-03 18:54:20,806 - 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-09-03 18:54:31,297 - Environment prefix is /tmp/tsqa.env._RwJZV
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [03/Sep/2015 18:54:34] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:54:34] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:54:34] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 18:54:34,828 - Environment prefix is /tmp/tsqa.env.r1WYwZ
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [03/Sep/2015 18:54:38] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:54:38] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:54:38] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-09-03 18:54:38,334 - Environment prefix is /tmp/tsqa.env.Ww31yL
INFO 2015-09-03 18:54:38,336 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 18:54:38,336 - spdy server port = 39261
INFO 2015-09-03 18:54:38,336 - http server port = 58705
Test that the origin does in fact support spdy 3 ... INFO 2015-09-03 18:54:41,567 - full args = ['/usr/local/bin/spdycat', 'https://localhost:39261/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 18:54:42,085 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58705/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 18:54:42,289 - Environment prefix is /tmp/tsqa.env.k0DL6y
INFO 2015-09-03 18:54:42,292 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 18:54:42,292 - spdy server port = 41980
INFO 2015-09-03 18:54:42,292 - http server port = 54060
Test that the origin does in fact support spdy 3.1 ... INFO 2015-09-03 18:54:45,529 - full args = ['/usr/local/bin/spdycat', 'https://localhost:41980/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 18:54:45,907 - full args = ['/usr/local/bin/spdycat', 'https://localhost:54060/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 18:54:46,118 - Environment prefix is /tmp/tsqa.env.zWh0rE
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok
======================================================================
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.5eIdT5/var/log/squid.log
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.5eIdT5
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 84 tests in 1485.743s
FAILED (SKIP=7, failures=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Build failed in Jenkins: tsqa-master #835
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/835/changes>
Changes:
[Bryan Call] TS-3877: Add a tracking ClassAllocator to keep track of where the allocation happened
[Bryan Call] clang-format
[Leif Hedstrom] TS-3848 clang-format
[Leif Hedstrom] TS-3461 changes sizeof() to not use non-static member variables
[Bryan Call] TS-3877: Add a tracking ClassAllocator to keep track of where the allocation happened
------------------------------------------
[...truncated 491 lines...]
INFO 2015-09-03 18:37:07,133 - Client disconnected
INFO 2015-09-03 18:37:07,326 - Environment prefix is /tmp/tsqa.env.MqR7fY
INFO 2015-09-03 18:37:09,128 - 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 ... 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-09-03 18:37:18,627 - Environment prefix is /tmp/tsqa.env.IsDYby
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-09-03 18:39:02,208 - Environment prefix is /tmp/tsqa.env.MVGlZi
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-09-03 18:39:31,834 - 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-09-03 18:41:50,955 - 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-09-03 18:41:51,023 - Environment prefix is /tmp/tsqa.env.oMFUdu
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-09-03 18:41:54,448 - Environment prefix is /tmp/tsqa.env.2jEOHi
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [03/Sep/2015 18:41:57] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-09-03 18:41:57,916 - Environment prefix is /tmp/tsqa.env.IqU3Jv
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 18:42:01] "GET / HTTP/1.1" 404 0
FAIL
INFO 2015-09-03 18:42:11,474 - Environment prefix is /tmp/tsqa.env.sMmqQG
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-09-03 18:42:24,996 - Environment prefix is /tmp/tsqa.env.qph9rr
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:42:28] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 18:42:28,537 - Environment prefix is /tmp/tsqa.env.tGtQTp
INFO 2015-09-03 18:42:28,539 - map / http://127.0.0.1:54871/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-09-03 18:42:31,769 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 18:42:31 GMT
Age: 0
Connection: close
INFO 2015-09-03 18:42:31,769 - head request with case(TE) costs 0.002328 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 18:42:31,781 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 18:42:31 GMT
Age: 0
Connection: close
INFO 2015-09-03 18:42:31,781 - head request with case(CL) costs 0.011993 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 18:42:31,782 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 18:42:31 GMT
Age: 0
Connection: close
INFO 2015-09-03 18:42:31,782 - head request with case() costs 0.000905 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-09-03 18:42:31,967 - Environment prefix is /tmp/tsqa.env.8kDBUk
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-09-03 18:42:35,416 - Environment prefix is /tmp/tsqa.env.3rTVL9
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-09-03 18:42:40,848 - Environment prefix is /tmp/tsqa.env.FZugRo
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-09-03 18:42:50,343 - Environment prefix is /tmp/tsqa.env.RwDGWP
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.RwDGWP
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-09-03 18:42:50,454 - Environment prefix is /tmp/tsqa.env.2p0IHM
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-09-03 18:42:53,970 - Environment prefix is /tmp/tsqa.env.3L9E_Y
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-09-03 18:42:57,538 - Environment prefix is /tmp/tsqa.env.jeQ2JY
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-09-03 18:43:01,089 - Environment prefix is /tmp/tsqa.env.QpEn7N
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 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:43:04] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-09-03 18:43:04,511 - Environment prefix is /tmp/tsqa.env.bWrbi9
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-09-03 18:43:10,931 - Environment prefix is /tmp/tsqa.env.GUZDUA
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-09-03 18:43:17,397 - Environment prefix is /tmp/tsqa.env.wVrIQE
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-09-03 18:43:38,879 - Environment prefix is /tmp/tsqa.env.YvZpQI
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-09-03 18:44:00,343 - Environment prefix is /tmp/tsqa.env.rgX0b2
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 18:44:03,792 - Environment prefix is /tmp/tsqa.env.WgJ82T
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 18:44:07,217 - Environment prefix is /tmp/tsqa.env.4V1l65
INFO 2015-09-03 18:44:07,219 - socket_server_port = 59338
INFO 2015-09-03 18:44:07,219 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-09-03 18:44:10,458 - Sending data back to the client: 793b3e9f62da4695a8de4d3d4b235d3f
INFO 2015-09-03 18:44:10,458 - 793b3e9f62da4695a8de4d3d4b235d3f
INFO 2015-09-03 18:44:15,473 - Sending data back to the client: 793b3e9f62da4695a8de4d3d4b235d3f
INFO 2015-09-03 18:44:15,473 - 793b3e9f62da4695a8de4d3d4b235d3f
ok
INFO 2015-09-03 18:44:15,656 - Environment prefix is /tmp/tsqa.env.zYmXud
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 18:44:18] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-09-03 18:44:19,102 - Environment prefix is /tmp/tsqa.env.XZynvh
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-09-03 18:46:52,387 - 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-09-03 18:47:01,475 - Environment prefix is /tmp/tsqa.env.PYfJLw
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [03/Sep/2015 18:47:04] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:47:04] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:47:04] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 18:47:04,898 - Environment prefix is /tmp/tsqa.env.jKdb01
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [03/Sep/2015 18:47:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:47:08] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 18:47:08] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-09-03 18:47:08,344 - Environment prefix is /tmp/tsqa.env.ShDXQ9
INFO 2015-09-03 18:47:08,346 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 18:47:08,346 - spdy server port = 48527
INFO 2015-09-03 18:47:08,346 - http server port = 34177
Test that the origin does in fact support spdy 3 ... INFO 2015-09-03 18:47:11,574 - full args = ['/usr/local/bin/spdycat', 'https://localhost:48527/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 18:47:12,656 - full args = ['/usr/local/bin/spdycat', 'https://localhost:34177/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 18:47:12,855 - Environment prefix is /tmp/tsqa.env.rM3Kz1
INFO 2015-09-03 18:47:12,857 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 18:47:12,857 - spdy server port = 58754
INFO 2015-09-03 18:47:12,857 - http server port = 46512
Test that the origin does in fact support spdy 3.1 ... INFO 2015-09-03 18:47:16,082 - full args = ['/usr/local/bin/spdycat', 'https://localhost:58754/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 18:47:17,466 - full args = ['/usr/local/bin/spdycat', 'https://localhost:46512/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 18:47:17,667 - Environment prefix is /tmp/tsqa.env.N2BX68
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok
======================================================================
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.IqU3Jv/var/log/squid.log
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.IqU3Jv
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 84 tests in 1362.509s
FAILED (SKIP=7, failures=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
Build failed in Jenkins: tsqa-master #834
Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/834/changes>
Changes:
[Phil Sorber] TS-3887: Use snprintf() instead of sprintf() in UrlPrintHack
[Phil Sorber] TS-3888: Initialize memory if buffer is large enough
------------------------------------------
[...truncated 491 lines...]
INFO 2015-09-03 15:50:27,470 - Client disconnected
INFO 2015-09-03 15:50:27,669 - Environment prefix is /tmp/tsqa.env.Cu2Jci
INFO 2015-09-03 15:50:29,465 - 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 ... 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-09-03 15:50:38,001 - Environment prefix is /tmp/tsqa.env.QEXMTU
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-09-03 15:52:21,623 - Environment prefix is /tmp/tsqa.env.73fbAp
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-09-03 15:52:51,227 - 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-09-03 15:53:44,967 - 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-09-03 15:53:45,033 - Environment prefix is /tmp/tsqa.env.zp6yyY
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-09-03 15:53:48,469 - Environment prefix is /tmp/tsqa.env.oiRVfM
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [03/Sep/2015 15:53:51] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-09-03 15:53:51,897 - Environment prefix is /tmp/tsqa.env.atH9WZ
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [03/Sep/2015 15:53:55] "GET / HTTP/1.1" 404 0
FAIL
INFO 2015-09-03 15:54:05,509 - Environment prefix is /tmp/tsqa.env.ioemoK
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-09-03 15:54:18,972 - Environment prefix is /tmp/tsqa.env.4R0VrE
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:22] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 15:54:22,423 - Environment prefix is /tmp/tsqa.env.fstb37
INFO 2015-09-03 15:54:22,425 - map / http://127.0.0.1:53102/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-09-03 15:54:25,653 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 15:54:25 GMT
Age: 0
Connection: close
INFO 2015-09-03 15:54:25,654 - head request with case(TE) costs 0.001912 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 15:54:25,655 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 15:54:25 GMT
Age: 0
Connection: close
INFO 2015-09-03 15:54:25,655 - head request with case(CL) costs 0.000843 seconds while the timout is 5.000000 seconds.
INFO 2015-09-03 15:54:25,655 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Thu, 03 Sep 2015 15:54:25 GMT
Age: 0
Connection: close
INFO 2015-09-03 15:54:25,656 - head request with case() costs 0.000856 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-09-03 15:54:25,839 - Environment prefix is /tmp/tsqa.env.4ap5TX
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-09-03 15:54:29,285 - Environment prefix is /tmp/tsqa.env.1Ih4wS
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-09-03 15:54:34,708 - Environment prefix is /tmp/tsqa.env.dDj2ud
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-09-03 15:54:44,193 - Environment prefix is /tmp/tsqa.env.Kzs4jI
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Kzs4jI
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-09-03 15:54:44,294 - Environment prefix is /tmp/tsqa.env.iAwxzk
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-09-03 15:54:47,831 - Environment prefix is /tmp/tsqa.env.b4Olw6
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-09-03 15:54:51,380 - Environment prefix is /tmp/tsqa.env.FyCF6N
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-09-03 15:54:54,959 - Environment prefix is /tmp/tsqa.env.6rdwEk
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 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:54:58] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-09-03 15:54:58,378 - Environment prefix is /tmp/tsqa.env.6ToCK0
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-09-03 15:55:04,795 - Environment prefix is /tmp/tsqa.env.B0xNWH
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-09-03 15:55:11,216 - Environment prefix is /tmp/tsqa.env.mRHcQX
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-09-03 15:55:32,798 - Environment prefix is /tmp/tsqa.env.Mg8Smx
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-09-03 15:55:54,335 - Environment prefix is /tmp/tsqa.env.1ImwUL
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 15:55:57,776 - Environment prefix is /tmp/tsqa.env.0EpsqS
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-09-03 15:56:01,220 - Environment prefix is /tmp/tsqa.env.cK_a9y
INFO 2015-09-03 15:56:01,222 - socket_server_port = 44650
INFO 2015-09-03 15:56:01,223 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-09-03 15:56:04,449 - Sending data back to the client: d73d3167fb5d4564a41385f741d041f5
INFO 2015-09-03 15:56:04,449 - d73d3167fb5d4564a41385f741d041f5
INFO 2015-09-03 15:56:09,456 - Sending data back to the client: d73d3167fb5d4564a41385f741d041f5
INFO 2015-09-03 15:56:09,456 - d73d3167fb5d4564a41385f741d041f5
ok
INFO 2015-09-03 15:56:09,639 - Environment prefix is /tmp/tsqa.env.seIWir
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [03/Sep/2015 15:56:12] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-09-03 15:56:13,137 - Environment prefix is /tmp/tsqa.env.zNtsdu
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-09-03 15:58:46,436 - 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-09-03 15:58:55,600 - Environment prefix is /tmp/tsqa.env.U_Up0O
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [03/Sep/2015 15:58:58] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:58:58] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:58:58] "GET / HTTP/1.1" 200 5
ok
INFO 2015-09-03 15:58:59,053 - Environment prefix is /tmp/tsqa.env.I1FtLp
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [03/Sep/2015 15:59:02] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:59:02] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [03/Sep/2015 15:59:02] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-09-03 15:59:02,500 - Environment prefix is /tmp/tsqa.env.WxBEVq
INFO 2015-09-03 15:59:02,502 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 15:59:02,502 - spdy server port = 57343
INFO 2015-09-03 15:59:02,502 - http server port = 43424
Test that the origin does in fact support spdy 3 ... INFO 2015-09-03 15:59:05,728 - full args = ['/usr/local/bin/spdycat', 'https://localhost:57343/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 15:59:06,962 - full args = ['/usr/local/bin/spdycat', 'https://localhost:43424/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 15:59:07,167 - Environment prefix is /tmp/tsqa.env.m_8zBB
INFO 2015-09-03 15:59:07,169 - spdycat path = /usr/local/bin/spdycat
INFO 2015-09-03 15:59:07,169 - spdy server port = 53603
INFO 2015-09-03 15:59:07,169 - http server port = 40968
Test that the origin does in fact support spdy 3.1 ... INFO 2015-09-03 15:59:10,392 - full args = ['/usr/local/bin/spdycat', 'https://localhost:53603/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-09-03 15:59:11,506 - full args = ['/usr/local/bin/spdycat', 'https://localhost:40968/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-09-03 15:59:11,714 - Environment prefix is /tmp/tsqa.env.PGQtNr
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok
======================================================================
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.atH9WZ/var/log/squid.log
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.atH9WZ
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 84 tests in 938.517s
FAILED (SKIP=7, failures=1)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results