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/10/04 07:21:41 UTC

Build failed in Jenkins: tsqa-master #901

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

Changes:

[Leif Hedstrom] Clean up / clarify the cache key APIs

[Leif Hedstrom] Remove a double CR

[James Peach] doc: fix quoting

[James Peach] Fix traffic_via tests

------------------------------------------
[...truncated 478 lines...]
INFO 2015-10-04 05:13:59,617 - sending data back to the client
INFO 2015-10-04 05:14:01,616 - Client disconnected
INFO 2015-10-04 05:14:02,020 - sending data back to the client
INFO 2015-10-04 05:14:02,423 - sending data back to the client
INFO 2015-10-04 05:14:04,424 - Client disconnected
INFO 2015-10-04 05:14:06,427 - sending data back to the client
ok
INFO 2015-10-04 05:14:08,440 - Client disconnected
INFO 2015-10-04 05:14:08,641 - Environment prefix is /tmp/tsqa.env.3aD4us
INFO 2015-10-04 05:14:10,433 - 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-10-04 05:14:18,961 - Environment prefix is /tmp/tsqa.env.hK9D6l
test_log_field (test_custom_log.TestCustomLogField) ... FAIL
INFO 2015-10-04 05:14:32,393 - Environment prefix is /tmp/tsqa.env.LkcQ7H
test_default_404 (test_example.TestBootstrap) ... ok
Test that traffic_line works, and verify that the values for proxy.config ... ok
INFO 2015-10-04 05:15:03,221 - Starting build (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-04 05:15:56,295 - Build completed (1b6c9541459e058351cd39ec55dcb772): configure {'enable-spdy': None, 'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'disable-dependency-tracking': None}
INFO 2015-10-04 05:15:56,366 - Environment prefix is /tmp/tsqa.env.yc76RC
test_spdy (test_example.TestConfigureFlags) ... ok
INFO 2015-10-04 05:15:59,777 - Environment prefix is /tmp/tsqa.env.8JH4e6
test_basic_proxy (test_example.TestDynamicHTTPEndpointCase) ... 127.0.0.1 - - [04/Oct/2015 05:16:03] "GET /test HTTP/1.1" 404 0
ok
INFO 2015-10-04 05:16:03,196 - Environment prefix is /tmp/tsqa.env.1YmpiI
test_logs_exist (test_example.TestLogs) ... ok
SKIP: Skip the entire class
INFO 2015-10-04 05:16:16,678 - Environment prefix is /tmp/tsqa.env.51JNkb
test_basic_intercept (test_example.TestServerIntercept) ... 127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:19] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-04 05:16:20,138 - Environment prefix is /tmp/tsqa.env.j18rAu
INFO 2015-10-04 05:16:20,141 - map / http://127.0.0.1:52126/
test_head_request_without_timout (test_headrequest.TestHeadRequestWithoutTimeout) ... INFO 2015-10-04 05:16:23,378 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sun, 04 Oct 2015 05:16:23 GMT
Age: 0
Connection: close


INFO 2015-10-04 05:16:23,378 - head request with case(TE) costs 0.011597 seconds while the timout is 5.000000 seconds.
INFO 2015-10-04 05:16:23,380 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Content-Length: 123
Vary: Accept-Encoding
Date: Sun, 04 Oct 2015 05:16:23 GMT
Age: 0
Connection: close


INFO 2015-10-04 05:16:23,380 - head request with case(CL) costs 0.001375 seconds while the timout is 5.000000 seconds.
INFO 2015-10-04 05:16:23,381 - HTTP/1.1 200 OK
Server: ATS/6.1.0
Vary: Accept-Encoding
Date: Sun, 04 Oct 2015 05:16:23 GMT
Age: 0
Connection: close


INFO 2015-10-04 05:16:23,381 - head request with case() costs 0.001134 seconds while the timout is 5.000000 seconds.
ok
INFO 2015-10-04 05:16:23,573 - Environment prefix is /tmp/tsqa.env.e1fquH
test_working (test_hostdb.TestHostDBBadResolvConf) ... ok
INFO 2015-10-04 05:16:27,033 - Environment prefix is /tmp/tsqa.env.D8gcFv
test_lookup_timeout (test_hostdb.TestHostDBFailedDNS) ... ok
INFO 2015-10-04 05:16:32,467 - Environment prefix is /tmp/tsqa.env.qDwk_U
Test basic fnctionality of hosts files ... ok
Test that changes to hosts file get loaded within host_file.interval ... ok
INFO 2015-10-04 05:16:41,977 - Environment prefix is /tmp/tsqa.env.KsxJTt
SKIP: 
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.KsxJTt
--------------------- >> end captured logging << ---------------------
Failure: SkipTest (Cannot import hyper, skipping tests for HTTP/2) ... SKIP: Cannot import hyper, skipping tests for HTTP/2
INFO 2015-10-04 05:16:42,068 - Environment prefix is /tmp/tsqa.env.RXhozC
SKIP: Cannot find h2spec. skipping test.
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.RXhozC
--------------------- >> end captured logging << ---------------------
INFO 2015-10-04 05:16:42,171 - Environment prefix is /tmp/tsqa.env.I0miL6
test_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestECDSA) ... ok
test_intermediate_ca_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestECDSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-04 05:16:45,695 - Environment prefix is /tmp/tsqa.env.oRmStO
test_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_ecdsa (test_https.TestMix) ... ok
test_intermediate_ca_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestMix) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-04 05:16:49,272 - Environment prefix is /tmp/tsqa.env.9OoZxF
test_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_ecdsa (test_https.TestRSA) ... ok
test_intermediate_ca_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
test_rsa (test_https.TestRSA) ... ok
We should be served the first match, since we aren't sending SNI headers ... ok
Make sure we get the certificate we asked for if we pass in SNI headers ... ok
INFO 2015-10-04 05:16:52,832 - Environment prefix is /tmp/tsqa.env.Xuu7r7
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 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:16:56] "GET /exists/ HTTP/1.1" 200 5
ok
INFO 2015-10-04 05:16:56,260 - Environment prefix is /tmp/tsqa.env.hmFDoj
Tests that origin_min_keep_alive_connections is honored via http. ... ok
INFO 2015-10-04 05:17:02,720 - Environment prefix is /tmp/tsqa.env.7OpUDf
Tests that origin_min_keep_alive_connections is honored via https. ... ok
INFO 2015-10-04 05:17:09,174 - Environment prefix is /tmp/tsqa.env.BQyVYO
Test that the origin does in fact support keepalive via http. ... ok
Tests that keepalive works through ATS to origin via http. ... ok
Tests that origin does not timeout using keepalive via http. ... ok
Tests that keepalive timeout is honored through ATS to origin via http. ... ok
INFO 2015-10-04 05:17:30,676 - Environment prefix is /tmp/tsqa.env.ftnaR0
Test that the origin does in fact support keepalive via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
Tests that origin does not timeout using keepalive via https. ... ok
Tests that keepalive timeout is honored through ATS to origin via https. ... ok
INFO 2015-10-04 05:17:52,192 - Environment prefix is /tmp/tsqa.env.hJnksn
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-04 05:17:55,643 - Environment prefix is /tmp/tsqa.env.f4k6AS
Tests that keepalive works through ATS to origin via https. ... ok
Tests that keepalive works through ATS to origin via https. ... ok
INFO 2015-10-04 05:17:59,114 - Environment prefix is /tmp/tsqa.env.10o6dw
INFO 2015-10-04 05:17:59,116 - socket_server_port = 48624
INFO 2015-10-04 05:17:59,116 - starting the socket server
test_origin_min_connection (test_origin_min_keep_alive_connection.TestKeepAlive_Origin_Min_connections) ... INFO 2015-10-04 05:18:02,368 - Sending data back to the client: 559fa413f0ec438ab489846f05c2b633
INFO 2015-10-04 05:18:02,372 - 559fa413f0ec438ab489846f05c2b633
INFO 2015-10-04 05:18:07,385 - Sending data back to the client: 559fa413f0ec438ab489846f05c2b633
INFO 2015-10-04 05:18:07,386 - 559fa413f0ec438ab489846f05c2b633
ok
INFO 2015-10-04 05:18:07,572 - Environment prefix is /tmp/tsqa.env.cmT0hj
test_redirection (test_redirection.TestRedirection) ... 127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /redirect/9 HTTP/1.1" 302 247
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/1 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /get HTTP/1.1" 200 437
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /redirect/10 HTTP/1.1" 302 247
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/9 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/8 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/7 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/6 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/5 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/4 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/3 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/2 HTTP/1.1" 302 0
127.0.0.1 - - [04/Oct/2015 05:18:10] "GET /relative-redirect/1 HTTP/1.1" 302 0
ok
INFO 2015-10-04 05:18:11,043 - Environment prefix is /tmp/tsqa.env.q5Af44
test_regressions (test_regressions.TestRegressions) ... ok
INFO 2015-10-04 05:20:44,834 - Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
SKIP: Error 1 running: ['<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/configure',> '--prefix=/', '--enable-ccache', '--enable-experimental-plugins', '--enable-example-plugins', '--enable-test-tools', '--enable-linux-native-aio', '--disable-dependency-tracking']
configure: error: Linux native AIO requires libaio.h

-------------------- >> begin captured logging << --------------------
tsqa.environment: INFO: Starting build (d133993325226bee52737bbab4e1cbc1): configure {'enable-ccache': None, 'enable-experimental-plugins': None, 'enable-example-plugins': None, 'enable-test-tools': None, 'enable-linux-native-aio': None, 'disable-dependency-tracking': None}
--------------------- >> end captured logging << ---------------------
INFO 2015-10-04 05:20:54,360 - Environment prefix is /tmp/tsqa.env.Uq49wW
test_remap_http (test_remap.TestRemapHTTP) ... 127.0.0.1 - - [04/Oct/2015 05:20:57] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:20:57] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:20:57] "GET / HTTP/1.1" 200 5
ok
INFO 2015-10-04 05:20:57,809 - Environment prefix is /tmp/tsqa.env.5fjPZf
test_remap_https (test_remap.TestRemapHTTPS) ... 127.0.0.1 - - [04/Oct/2015 05:21:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:21:01] "GET / HTTP/1.1" 200 5
127.0.0.1 - - [04/Oct/2015 05:21:01] "GET / HTTP/1.1" 200 5
ok
SKIP: Skipping spdy/2 tests
INFO 2015-10-04 05:21:01,267 - Environment prefix is /tmp/tsqa.env.WRoEDt
INFO 2015-10-04 05:21:01,269 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-04 05:21:01,269 - spdy server port = 35416
INFO 2015-10-04 05:21:01,269 - http server port = 46984
Test that the origin does in fact support spdy 3 ... INFO 2015-10-04 05:21:04,499 - full args = ['/usr/local/bin/spdycat', 'https://localhost:35416/', '-nv', '--spdy3']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-04 05:21:05,556 - full args = ['/usr/local/bin/spdycat', 'https://localhost:46984/', '-nv', '--spdy3']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-04 05:21:05,759 - Environment prefix is /tmp/tsqa.env.Ug9GNz
INFO 2015-10-04 05:21:05,762 - spdycat path = /usr/local/bin/spdycat
INFO 2015-10-04 05:21:05,762 - spdy server port = 40926
INFO 2015-10-04 05:21:05,762 - http server port = 44670
Test that the origin does in fact support spdy 3.1 ... INFO 2015-10-04 05:21:08,992 - full args = ['/usr/local/bin/spdycat', 'https://localhost:40926/', '-nv', '--spdy3-1']
ok
Test that non spdy port won't advertise spdy ... INFO 2015-10-04 05:21:10,396 - full args = ['/usr/local/bin/spdycat', 'https://localhost:44670/', '-nv', '--spdy3-1']
Fatal: EOF
reqnum=1, completed=0
Some requests were not processed. total=1, processed=0
ok
INFO 2015-10-04 05:21:10,605 - Environment prefix is /tmp/tsqa.env.vHkZlz
Make sure the new ticket key is loaded ... ok
Make sure the new ticket key is loaded ... ok

======================================================================
FAIL: test_log_field (test_custom_log.TestCustomLogField)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "<https://ci.trafficserver.apache.org/job/tsqa-master/ws/src/ci/tsqa/tests/test_custom_log.py",> line 70, in test_log_field
    self.assertEqual(line, expected_line)
AssertionError: '127.0.0.1 7F000001\n' != '127.43.196.75 7F2BC44B\n'
-------------------- >> begin captured logging << --------------------
root: INFO: Environment prefix is /tmp/tsqa.env.hK9D6l
--------------------- >> end captured logging << ---------------------

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

FAILED (SKIP=8, 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 #902

Posted by je...@ci.trafficserver.apache.org.

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