See <https://ci.trafficserver.apache.org/job/tsqa-master/727/changes>
Changes:
[Sudheer Vinukonda] [TS-3794]: Enhance post SSL handshake read race condition
for SPDY and H2 scenarios.
------------------------------------------
[...truncated 516 lines...]
INFO 2015-07-23 20:10:55,571 - sending data back to the client
INFO 2015-07-23 20:10:59,576 - sending data back to the client
ok
test_chunked_keepalive_server (test_chunked.TestChunked) ... INFO 2015-07-23
20:11:03,581 - sending data back to the client
INFO 2015-07-23 20:11:06,586 - sending data back to the client
ok
Test that the origin does in fact support keepalive ... INFO 2015-07-23
20:11:07,590 - sending data back to the client
INFO 2015-07-23 20:11:10,596 - sending data back to the client
INFO 2015-07-23 20:11:11,599 - sending data back to the client
INFO 2015-07-23 20:11:13,600 - Client disconnected
INFO 2015-07-23 20:11:14,002 - sending data back to the client
INFO 2015-07-23 20:11:14,404 - sending data back to the client
INFO 2015-07-23 20:11:16,405 - Client disconnected
INFO 2015-07-23 20:11:18,409 - sending data back to the client
ok
INFO 2015-07-23 20:11:20,419 - Client disconnected
INFO 2015-07-23 20:11:20,612 - Environment prefix is /tmp/tsqa.env.jDCkVw
INFO 2015-07-23 20:11:22,414 - 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-23 20:11:30,908 - Environment prefix is /tmp/tsqa.env.c3JAx_
test_log_field (test_custom_log.TestCustomLogField) ... ok
INFO 2015-07-23 20:13:14,448 - Environment prefix is /tmp/tsqa.env.QFGtkv
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-07-23 20:13:44,408 - 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-23 20:14:46,442 - 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-23 20:14:46,507 - Environment prefix is /tmp/tsqa.env.AEmtSW
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-07-23 20:14:49,907 - Environment prefix is /tmp/tsqa.env.A2_rN9
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - -
[23/Jul/2015 20:14:53] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-07-23 20:14:53,316 - Environment prefix is /tmp/tsqa.env.Uq0llJ
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - -
[23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [23/Jul/2015 20:14:56] "GET / HTTP/1.1" 404 0
FAIL
INFO 2015-07-23 20:15:06,787 - Environment prefix is /tmp/tsqa.env.eaWP5V
test_logs_exist (test_example.TestLogs) ... FAIL
SKIP: Skip the entire class
INFO 2015-07-23 20:15:20,242 - Environment prefix is /tmp/tsqa.env.IkanEy
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - -
[23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:23] "GET / HTTP/1.1" 200 5
ok
INFO 2015-07-23 20:15:23,687 - Environment prefix is /tmp/tsqa.env.6DfzIZ
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-07-23 20:15:29,111 - Environment prefix is /tmp/tsqa.env.gpxVEG
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-07-23 20:15:38,577 - Environment prefix is /tmp/tsqa.env.8Ep5gl
SKIP:
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.8Ep5gl
--------------------- >> end captured logging << ---------------------
INFO 2015-07-23 20:15:39,544 - Environment prefix is /tmp/tsqa.env.awVfzi
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-23 20:15:43,057 - Environment prefix is /tmp/tsqa.env.l3OjHA
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-23 20:15:46,572 - Environment prefix is /tmp/tsqa.env.ITDIrl
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-23 20:15:50,076 - Environment prefix is /tmp/tsqa.env.x9pB1J
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 - -
[23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:15:53] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-07-23 20:15:53,493 - Environment prefix is /tmp/tsqa.env.NRbAxD
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-07-23 20:15:59,907 - Environment prefix is /tmp/tsqa.env.qsFvEH
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-07-23 20:16:06,327 - Environment prefix is /tmp/tsqa.env.KtzPM8
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-23 20:16:27,801 - Environment prefix is /tmp/tsqa.env.44dgeH
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-23 20:16:49,304 - Environment prefix is /tmp/tsqa.env.k57g7z
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-23 20:16:52,749 - Environment prefix is /tmp/tsqa.env.ulkGXS
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-23 20:16:56,169 - Environment prefix is /tmp/tsqa.env.L0GG3v
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - -
[23/Jul/2015 20:16:59] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [23/Jul/2015 20:16:59] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-07-23 20:16:59,644 - Environment prefix is /tmp/tsqa.env.aIJRlR
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-07-23 20:19:31,572 - 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-23 20:19:40,605 - Environment prefix is /tmp/tsqa.env.RDHnTT
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [23/Jul/2015
20:19:43] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:19:43] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:19:43] "GET / HTTP/1.1" 200 5
ok
INFO 2015-07-23 20:19:44,030 - Environment prefix is /tmp/tsqa.env.9HuNQQ
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [23/Jul/2015
20:19:47] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:19:47] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [23/Jul/2015 20:19:47] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-07-23 20:19:47,472 - Environment prefix is /tmp/tsqa.env.QtVFLc
INFO 2015-07-23 20:19:47,473 - spdycat path = /usr/local/bin/spdycat
INFO 2015-07-23 20:19:47,474 - spdy server port = 51401
INFO 2015-07-23 20:19:47,474 - http server port = 51800
Test that the origin does in fact support spdy 3 ... INFO 2015-07-23
20:19:50,698 - full args = ['/usr/local/bin/spdycat',
'https://localhost:51401/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-07-23 20:19:51,910 -
full args = ['/usr/local/bin/spdycat', 'https://localhost:51800/', '-nv',
'--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-07-23 20:19:52,111 - Environment prefix is /tmp/tsqa.env.szZoB5
INFO 2015-07-23 20:19:52,113 - spdycat path = /usr/local/bin/spdycat
INFO 2015-07-23 20:19:52,113 - spdy server port = 38980
INFO 2015-07-23 20:19:52,113 - http server port = 51145
Test that the origin does in fact support spdy 3.1 ... INFO 2015-07-23
20:19:55,337 - full args = ['/usr/local/bin/spdycat',
'https://localhost:38980/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-07-23 20:19:56,649 -
full args = ['/usr/local/bin/spdycat', 'https://localhost:51145/', '-nv',
'--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-07-23 20:19:56,853 - Environment prefix is /tmp/tsqa.env.hPgvRS
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.Uq0llJ/var/log/squid.log
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.Uq0llJ
--------------------- >> end captured logging << ---------------------
======================================================================
FAIL: test_logs_exist (test_example.TestLogs)
----------------------------------------------------------------------
Traceback (most recent call last):
File
"<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_example.py";,>
line 172, in test_logs_exist
self.assertTrue(os.path.isfile(logfile_path), logfile_path)
AssertionError: /tmp/tsqa.env.eaWP5V/var/log/error.log
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.eaWP5V
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML:
<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 80 tests in 960.418s
FAILED (SKIP=6, failures=4)
1
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results
