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/05/06 05:38:18 UTC

Build failed in Jenkins: tsqa-master #374

See <https://ci.trafficserver.apache.org/job/tsqa-master/374/changes>

Changes:

[Bryan Call] TS-2513: Missing SOCKS documentation

[Sudheer Vinukonda] update CHANGES for TS-3029

[briang] TS-3582: Change @dst_ip to @in_ip

[briang] TS-3582: Change @dst_ip to @in_ip: UPDATE DOCS

[briang] TS-3582: Change @dst_ip to @in_ip: UPDATE CHANGES

------------------------------------------
[...truncated 424 lines...]
    warning: no previously-included files matching 'lextab.*' found under directory 'tests'
    warning: no previously-included files matching 'yacctab.*' found under directory 'examples'
    warning: no previously-included files matching 'lextab.*' found under directory 'examples'
    Build the lexing/parsing tables
Successfully installed pyyaml pyOpenSSL nose unittest2 requests flask httpbin tsqa cryptography six argparse traceback2 Werkzeug Jinja2 itsdangerous MarkupSafe decorator pyasn1 enum34 cffi linecache2 pycparser
Cleaning up...
Virtualenv ready!
virtualenv/bin/nosetests --with-xunit -sv --logging-level=INFO
INFO 2015-05-06 03:23:02,814 - Starting build (3375ae446536ef83975ccaf91d67fcdc): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 03:24:17,448 - Build completed (3375ae446536ef83975ccaf91d67fcdc): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 03:24:17,528 - Environment prefix is /tmp/tsqa.env.bdVaof
test_buildoption (test_buildoptions.TestBuildOption) ... ok
INFO 2015-05-06 03:24:47,446 - Starting build (e127c1a05c3ef1c71d1fc780ec9f804c): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'disable-diags': None, 'enable-test-tools': None}
INFO 2015-05-06 03:26:02,627 - Build completed (e127c1a05c3ef1c71d1fc780ec9f804c): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'disable-diags': None, 'enable-test-tools': None}
INFO 2015-05-06 03:26:02,706 - Environment prefix is /tmp/tsqa.env.0KbZVL
test_buildoption (test_buildoptions.TestBuildOptionDisableDiags) ... ok
INFO 2015-05-06 03:26:32,488 - Starting build (fcf436ddaf8d96eb997c6f84f34ee815): configure {'disable-tests': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 03:27:46,426 - Build completed (fcf436ddaf8d96eb997c6f84f34ee815): configure {'disable-tests': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 03:27:46,506 - Environment prefix is /tmp/tsqa.env.mGqb31
test_buildoption (test_buildoptions.TestBuildOptionDisableTests) ... ok
SKIP: Skip until atscppapi supports out of tree builds
SKIP: Skip until TS-3577 is resolved
INFO 2015-05-06 03:28:16,226 - Starting build (790e5816af185c4fe8093b72e4794a0d): configure {'enable-fast-sdk': None, 'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 03:29:30,758 - Build completed (790e5816af185c4fe8093b72e4794a0d): configure {'enable-fast-sdk': None, 'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 03:29:30,838 - Environment prefix is /tmp/tsqa.env.PaSm9R
test_buildoption (test_buildoptions.TestBuildOptionFastSDK) ... ok
INFO 2015-05-06 03:29:34,281 - Environment prefix is /tmp/tsqa.env.qzp70n
test_chunked_bad_close (test_chunked.TestChunked) ... INFO 2015-05-06 03:29:37,526 - sending data back to the client
okINFO 2015-05-06 03:29:40,030 - Client disconnected

test_chunked_basic (test_chunked.TestChunked) ... INFO 2015-05-06 03:29:40,034 - sending data back to the client
ok
test_chunked_keepalive_client (test_chunked.TestChunked) ... INFO 2015-05-06 03:29:43,039 - sending data back to the client
INFO 2015-05-06 03:29:46,044 - sending data back to the client
INFO 2015-05-06 03:29:49,048 - sending data back to the client
INFO 2015-05-06 03:29:51,452 - sending data back to the client
INFO 2015-05-06 03:29:53,854 - sending data back to the client
INFO 2015-05-06 03:29:57,858 - sending data back to the client
ok
test_chunked_keepalive_server (test_chunked.TestChunked) ... INFO 2015-05-06 03:30:01,862 - sending data back to the client
INFO 2015-05-06 03:30:04,867 - sending data back to the client
ok
Test that the origin does in fact support keepalive ... INFO 2015-05-06 03:30:05,871 - sending data back to the client
INFO 2015-05-06 03:30:08,874 - sending data back to the client
INFO 2015-05-06 03:30:09,878 - sending data back to the client
INFO 2015-05-06 03:30:11,877 - Client disconnected
INFO 2015-05-06 03:30:12,281 - sending data back to the client
INFO 2015-05-06 03:30:12,683 - sending data back to the client
INFO 2015-05-06 03:30:14,684 - Client disconnected
INFO 2015-05-06 03:30:16,687 - sending data back to the client
ok
INFO 2015-05-06 03:30:18,698 - Client disconnected
INFO 2015-05-06 03:30:18,911 - Environment prefix is /tmp/tsqa.env.ZiztBn
INFO 2015-05-06 03:30:20,692 - 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 ... /usr/lib64/python2.7/unittest/case.py:380: RuntimeWarning: TestResult has no addExpectedFailure method, reporting as passes
  RuntimeWarning)
ok
Verify that we get 200s from origins that reset_after_accept ... ok
INFO 2015-05-06 03:30:29,261 - Environment prefix is /tmp/tsqa.env.NajPZh
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-05-06 03:30:59,206 - Starting build (a1de67cffb8c345a8296170a52ca4784): configure {'enable-spdy': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 03:32:15,551 - Build completed (a1de67cffb8c345a8296170a52ca4784): configure {'enable-spdy': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 03:32:15,636 - Environment prefix is /tmp/tsqa.env.zXEgS4
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-05-06 03:32:19,091 - Environment prefix is /tmp/tsqa.env.yB3yfS
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [06/May/2015 03:32:22] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-05-06 03:32:22,730 - Environment prefix is /tmp/tsqa.env.jN3wJ8
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 03:32:25] "GET / HTTP/1.1" 404 0
ok
INFO 2015-05-06 03:32:36,220 - Environment prefix is /tmp/tsqa.env.nTANhx
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-05-06 03:32:49,699 - Environment prefix is /tmp/tsqa.env.G61WPt
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:32:52] "GET / HTTP/1.1" 200 5
ok
INFO 2015-05-06 03:32:53,191 - Environment prefix is /tmp/tsqa.env.7MYV34
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-05-06 03:32:58,664 - Environment prefix is /tmp/tsqa.env.wIXPtH
test_working (test_hostdb.TestHostDBPartiallyFailedDNS) ... FAIL
INFO 2015-05-06 03:33:05,870 - Environment prefix is /tmp/tsqa.env.4nYUCz
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-05-06 03:33:09,744 - Environment prefix is /tmp/tsqa.env.ayIYwE
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-05-06 03:33:13,617 - Environment prefix is /tmp/tsqa.env.jvM9jP
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-05-06 03:33:17,489 - Environment prefix is /tmp/tsqa.env.yc85gz
test_error_path (test_keepalive.TestKeepAliveInHTTP) ... ok
Ensure that sending a request with a body doesn't break the keepalive session ... ok
test_working_path (test_keepalive.TestKeepAliveInHTTP) ... 127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:33:20] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-05-06 03:33:20,936 - Environment prefix is /tmp/tsqa.env.oa1VLq
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-05-06 03:33:27,453 - Environment prefix is /tmp/tsqa.env.gAFPcA
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-05-06 03:33:33,919 - Environment prefix is /tmp/tsqa.env.tSsdil
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-05-06 03:33:55,415 - Environment prefix is /tmp/tsqa.env.ekKSOu
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-05-06 03:34:16,931 - Environment prefix is /tmp/tsqa.env.iEcwUw
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-05-06 03:34:20,447 - Environment prefix is /tmp/tsqa.env.D1YQf5
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-05-06 03:34:23,890 - Environment prefix is /tmp/tsqa.env.2rPxTg
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [06/May/2015 03:34:27] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 03:34:27] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-05-06 03:34:27,350 - Environment prefix is /tmp/tsqa.env.XeOP2k
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-05-06 03:37:01,024 - Starting build (481f22ae002c99c89179cba0bbc2ef76): configure {'enable-linux-native-aio': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
SKIP: Error 1 running: ['<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/configure',> '--prefix=/', '--enable-linux-native-aio', '--disable-dependency-tracking', '--enable-ccache', '--enable-test-tools', '--enable-example-plugins']
configure: error: Linux native AIO requires libaio.h

-------------------- >> begin captured logging << --------------------
tsqa.environment: INFO: Starting build (481f22ae002c99c89179cba0bbc2ef76): configure {'enable-linux-native-aio': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
--------------------- >> end captured logging << ---------------------
INFO 2015-05-06 03:37:10,546 - Environment prefix is /tmp/tsqa.env.pUhEYc
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [06/May/2015 03:37:13] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:37:13] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:37:13] "GET / HTTP/1.1" 200 5
ok
INFO 2015-05-06 03:37:13,988 - Environment prefix is /tmp/tsqa.env.MtppIF
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [06/May/2015 03:37:17] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:37:17] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 03:37:17] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-05-06 03:37:17,448 - Environment prefix is /tmp/tsqa.env.pRPWp0
INFO 2015-05-06 03:37:17,450 - spdycat path = /usr/local/bin/spdycat
INFO 2015-05-06 03:37:17,450 - spdy server port = 59432
INFO 2015-05-06 03:37:17,451 - http server port = 34971
Test that the origin does in fact support spdy 3 ... INFO 2015-05-06 03:37:20,676 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59432/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-05-06 03:37:21,907 - full args = ['/usr/local/bin/spdycat', 'https://localhost:34971/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-05-06 03:37:22,124 - Environment prefix is /tmp/tsqa.env.bzSzda
INFO 2015-05-06 03:37:22,126 - spdycat path = /usr/local/bin/spdycat
INFO 2015-05-06 03:37:22,126 - spdy server port = 44890
INFO 2015-05-06 03:37:22,126 - http server port = 33976
Test that the origin does in fact support spdy 3.1 ... INFO 2015-05-06 03:37:25,354 - full args = ['/usr/local/bin/spdycat', 'https://localhost:44890/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-05-06 03:37:26,411 - full args = ['/usr/local/bin/spdycat', 'https://localhost:33976/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok

======================================================================
FAIL: test_working (test_hostdb.TestHostDBPartiallyFailedDNS)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_hostdb.py",> line 53, in test_working
    self.assertLess(time.time() - start, self.configs['records.config']['CONFIG']['proxy.config.hostdb.lookup_timeout'])
AssertionError: 2.928140878677368 not less than 2
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.wIXPtH
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 73 tests in 890.827s

FAILED (SKIP=5, failures=1)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results

Jenkins build is back to normal : tsqa-master #376

Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/376/changes>


Build failed in Jenkins: tsqa-master #375

Posted by je...@ci.trafficserver.apache.org.
See <https://ci.trafficserver.apache.org/job/tsqa-master/375/changes>

Changes:

[solidwallofcode] TS-3585: DNS is not done for redirects if cache is disabled.

------------------------------------------
[...truncated 424 lines...]
    warning: no previously-included files matching 'lextab.*' found under directory 'tests'
    warning: no previously-included files matching 'yacctab.*' found under directory 'examples'
    warning: no previously-included files matching 'lextab.*' found under directory 'examples'
    Build the lexing/parsing tables
Successfully installed pyyaml pyOpenSSL nose unittest2 requests flask httpbin tsqa cryptography six argparse traceback2 Werkzeug Jinja2 itsdangerous MarkupSafe decorator pyasn1 enum34 cffi linecache2 pycparser
Cleaning up...
Virtualenv ready!
virtualenv/bin/nosetests --with-xunit -sv --logging-level=INFO
INFO 2015-05-06 18:56:18,676 - Starting build (3375ae446536ef83975ccaf91d67fcdc): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 18:57:09,295 - Build completed (3375ae446536ef83975ccaf91d67fcdc): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 18:57:09,374 - Environment prefix is /tmp/tsqa.env.G3Xe5F
test_buildoption (test_buildoptions.TestBuildOption) ... ok
INFO 2015-05-06 18:57:38,963 - Starting build (e127c1a05c3ef1c71d1fc780ec9f804c): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'disable-diags': None, 'enable-test-tools': None}
INFO 2015-05-06 18:58:30,275 - Build completed (e127c1a05c3ef1c71d1fc780ec9f804c): configure {'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'disable-diags': None, 'enable-test-tools': None}
INFO 2015-05-06 18:58:30,360 - Environment prefix is /tmp/tsqa.env.PO9qpj
test_buildoption (test_buildoptions.TestBuildOptionDisableDiags) ... ok
INFO 2015-05-06 18:59:00,024 - Starting build (fcf436ddaf8d96eb997c6f84f34ee815): configure {'disable-tests': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 18:59:50,265 - Build completed (fcf436ddaf8d96eb997c6f84f34ee815): configure {'disable-tests': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 18:59:50,344 - Environment prefix is /tmp/tsqa.env.0V_GTk
test_buildoption (test_buildoptions.TestBuildOptionDisableTests) ... ok
SKIP: Skip until atscppapi supports out of tree builds
SKIP: Skip until TS-3577 is resolved
INFO 2015-05-06 19:00:19,884 - Starting build (790e5816af185c4fe8093b72e4794a0d): configure {'enable-fast-sdk': None, 'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 19:01:10,367 - Build completed (790e5816af185c4fe8093b72e4794a0d): configure {'enable-fast-sdk': None, 'enable-example-plugins': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None}
INFO 2015-05-06 19:01:10,448 - Environment prefix is /tmp/tsqa.env.4BmqEm
test_buildoption (test_buildoptions.TestBuildOptionFastSDK) ... ok
INFO 2015-05-06 19:01:13,891 - Environment prefix is /tmp/tsqa.env.vJ6a_2
test_chunked_bad_close (test_chunked.TestChunked) ... INFO 2015-05-06 19:01:17,129 - sending data back to the client
INFO 2015-05-06 19:01:19,633 - Client disconnected
ok
test_chunked_basic (test_chunked.TestChunked) ... INFO 2015-05-06 19:01:19,637 - sending data back to the client
ok
test_chunked_keepalive_client (test_chunked.TestChunked) ... INFO 2015-05-06 19:01:22,641 - sending data back to the client
INFO 2015-05-06 19:01:25,645 - sending data back to the client
INFO 2015-05-06 19:01:28,650 - sending data back to the client
INFO 2015-05-06 19:01:31,053 - sending data back to the client
INFO 2015-05-06 19:01:33,456 - sending data back to the client
INFO 2015-05-06 19:01:37,462 - sending data back to the client
ok
test_chunked_keepalive_server (test_chunked.TestChunked) ... INFO 2015-05-06 19:01:41,466 - sending data back to the client
INFO 2015-05-06 19:01:44,470 - sending data back to the client
ok
Test that the origin does in fact support keepalive ... INFO 2015-05-06 19:01:45,475 - sending data back to the client
INFO 2015-05-06 19:01:48,478 - sending data back to the client
INFO 2015-05-06 19:01:49,481 - sending data back to the client
INFO 2015-05-06 19:01:51,482 - Client disconnected
INFO 2015-05-06 19:01:51,884 - sending data back to the client
INFO 2015-05-06 19:01:52,286 - sending data back to the client
INFO 2015-05-06 19:01:54,288 - Client disconnected
INFO 2015-05-06 19:01:56,291 - sending data back to the client
ok
INFO 2015-05-06 19:01:58,303 - Client disconnected
INFO 2015-05-06 19:01:58,512 - Environment prefix is /tmp/tsqa.env.ySW60c
INFO 2015-05-06 19:02:00,296 - 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 ... /usr/lib64/python2.7/unittest/case.py:380: RuntimeWarning: TestResult has no addExpectedFailure method, reporting as passes
  RuntimeWarning)
ok
Verify that we get 200s from origins that reset_after_accept ... ok
INFO 2015-05-06 19:02:08,853 - Environment prefix is /tmp/tsqa.env.8txEvX
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-05-06 19:02:38,395 - Starting build (a1de67cffb8c345a8296170a52ca4784): configure {'enable-spdy': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 19:03:29,375 - Build completed (a1de67cffb8c345a8296170a52ca4784): configure {'enable-spdy': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
INFO 2015-05-06 19:03:29,454 - Environment prefix is /tmp/tsqa.env.vzGsCD
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-05-06 19:03:32,898 - Environment prefix is /tmp/tsqa.env.VdBumR
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [06/May/2015 19:03:36] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-05-06 19:03:36,346 - Environment prefix is /tmp/tsqa.env.bpvRNA
test_logs_exist (test_example.TestLogRefCounting) ... 127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
127.0.0.1 - - [06/May/2015 19:03:39] "GET / HTTP/1.1" 404 0
ok
INFO 2015-05-06 19:03:49,824 - Environment prefix is /tmp/tsqa.env.r2ttYk
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-05-06 19:04:03,303 - Environment prefix is /tmp/tsqa.env.W0YsE6
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:06] "GET / HTTP/1.1" 200 5
ok
INFO 2015-05-06 19:04:06,780 - Environment prefix is /tmp/tsqa.env.qrzisy
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-05-06 19:04:12,247 - Environment prefix is /tmp/tsqa.env.SrEMmU
test_working (test_hostdb.TestHostDBPartiallyFailedDNS) ... FAIL
INFO 2015-05-06 19:04:19,404 - Environment prefix is /tmp/tsqa.env.4EKggN
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-05-06 19:04:23,262 - Environment prefix is /tmp/tsqa.env.mUkeIf
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-05-06 19:04:27,109 - Environment prefix is /tmp/tsqa.env.30PpHV
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-05-06 19:04:30,963 - Environment prefix is /tmp/tsqa.env.BL5pS6
test_error_path (test_keepalive.TestKeepAliveInHTTP) ... ok
Ensure that sending a request with a body doesn't break the keepalive session ... ok
test_working_path (test_keepalive.TestKeepAliveInHTTP) ... 127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:04:34] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-05-06 19:04:34,397 - Environment prefix is /tmp/tsqa.env.EJbqjW
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-05-06 19:04:40,830 - Environment prefix is /tmp/tsqa.env.UGyxpg
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-05-06 19:04:47,315 - Environment prefix is /tmp/tsqa.env.xTlh9q
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-05-06 19:05:08,822 - Environment prefix is /tmp/tsqa.env.WTkIHm
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-05-06 19:05:30,323 - Environment prefix is /tmp/tsqa.env.dSxYkC
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-05-06 19:05:33,785 - Environment prefix is /tmp/tsqa.env.o3JXuj
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-05-06 19:05:37,227 - Environment prefix is /tmp/tsqa.env.XNkGzx
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/1 HTTP/1.1" 302 215
127.0.0.1 - - [06/May/2015 19:05:40] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/10 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/9 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/8 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/7 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/6 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/5 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/4 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/3 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/2 HTTP/1.1" 302 229
127.0.0.1 - - [06/May/2015 19:05:40] "GET /redirect/1 HTTP/1.1" 302 215
ok
INFO 2015-05-06 19:05:40,685 - Environment prefix is /tmp/tsqa.env.kw5diT
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-05-06 19:08:12,448 - Starting build (481f22ae002c99c89179cba0bbc2ef76): configure {'enable-linux-native-aio': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
SKIP: Error 1 running: ['<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/configure',> '--prefix=/', '--enable-linux-native-aio', '--disable-dependency-tracking', '--enable-ccache', '--enable-test-tools', '--enable-example-plugins']
configure: error: Linux native AIO requires libaio.h

-------------------- >> begin captured logging << --------------------
tsqa.environment: INFO: Starting build (481f22ae002c99c89179cba0bbc2ef76): configure {'enable-linux-native-aio': None, 'disable-dependency-tracking': None, 'enable-ccache': None, 'enable-test-tools': None, 'enable-example-plugins': None}
--------------------- >> end captured logging << ---------------------
INFO 2015-05-06 19:08:21,791 - Environment prefix is /tmp/tsqa.env.i3e6uP
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [06/May/2015 19:08:25] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:08:25] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:08:25] "GET / HTTP/1.1" 200 5
ok
INFO 2015-05-06 19:08:25,236 - Environment prefix is /tmp/tsqa.env.fWG9ow
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [06/May/2015 19:08:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:08:28] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [06/May/2015 19:08:28] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-05-06 19:08:28,693 - Environment prefix is /tmp/tsqa.env.JHole_
INFO 2015-05-06 19:08:28,694 - spdycat path = /usr/local/bin/spdycat
INFO 2015-05-06 19:08:28,695 - spdy server port = 43506
INFO 2015-05-06 19:08:28,695 - http server port = 59322
Test that the origin does in fact support spdy 3 ... INFO 2015-05-06 19:08:31,922 - full args = ['/usr/local/bin/spdycat', 'https://localhost:43506/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-05-06 19:08:33,245 - full args = ['/usr/local/bin/spdycat', 'https://localhost:59322/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-05-06 19:08:33,464 - Environment prefix is /tmp/tsqa.env.Rkr8rT
INFO 2015-05-06 19:08:33,466 - spdycat path = /usr/local/bin/spdycat
INFO 2015-05-06 19:08:33,467 - spdy server port = 42237
INFO 2015-05-06 19:08:33,467 - http server port = 49046
Test that the origin does in fact support spdy 3.1 ... INFO 2015-05-06 19:08:36,692 - full args = ['/usr/local/bin/spdycat', 'https://localhost:42237/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-05-06 19:08:37,792 - full args = ['/usr/local/bin/spdycat', 'https://localhost:49046/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok

======================================================================
FAIL: test_working (test_hostdb.TestHostDBPartiallyFailedDNS)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_hostdb.py",> line 53, in test_working
    self.assertLess(time.time() - start, self.configs['records.config']['CONFIG']['proxy.config.hostdb.lookup_timeout'])
AssertionError: 2.9067130088806152 not less than 2
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.SrEMmU
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
XML: <https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/nosetests.xml>
----------------------------------------------------------------------
Ran 73 tests in 766.587s

FAILED (SKIP=5, failures=1)
2
make: *** [test] Error 1
Build step 'Execute shell' marked build as failure
Recording test results