[ https://issues.apache.org/jira/browse/DISPATCH-2139?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Ganesh Murthy resolved DISPATCH-2139. ------------------------------------- Fix Version/s: 1.17.0 Resolution: Cannot Reproduce > system_tests_http1_over_tcp failing with HTTP resp code 503 > ----------------------------------------------------------- > > Key: DISPATCH-2139 > URL: https://issues.apache.org/jira/browse/DISPATCH-2139 > Project: Qpid Dispatch > Issue Type: Test > Components: Protocol Adaptors > Affects Versions: 1.16.0 > Reporter: Ganesh Murthy > Assignee: Ken Giusti > Priority: Major > Fix For: 1.17.0 > > > {noformat} > test 69 > Start 69: system_tests_http1_over_tcp > 69: Test command: /opt/python/3.6.8/bin/python3.6 > "/home/travis/build/apache/qpid-dispatch/build/tests/run.py" "-m" "unittest" > "-v" "system_tests_http1_over_tcp" > 69: Test timeout computed to be: 1200 > 69: test_01_concurrent_requests > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) ... TestClient: > c470bf97aa5847beabbb59ee1c61e526 > 69: 2021-05-19 15:51:29.424833 TestClient connecting on 127.0.0.1:24777 > 69: 2021-05-19 15:51:29.424874 TestClient connected > 69: 2021-05-19 15:51:29.424879 TestClient start request 0 > 69: 2021-05-19 15:51:29.424883 TestClient sending PUT > /PUT/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:29.425373 TestClient getting PUT response > 69: 2021-05-19 15:51:30.282139 TestClient response PUT received > 69: 2021-05-19 15:51:30.282171 TestClient request PUT > /PUT/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:30.282176 TestClient sending GET > /GET/test_01_concurrent_requests_11_small request > 69: 2021-05-19 15:51:30.282246 TestClient getting GET response > 69: 2021-05-19 15:51:30.519709 TestClient response GET received > 69: 2021-05-19 15:51:30.519810 TestClient request GET > /GET/test_01_concurrent_requests_11_small completed! > 69: 2021-05-19 15:51:30.519816 TestClient sending GET > /GET/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:30.519905 TestClient getting GET response > 69: 2021-05-19 15:51:31.219387 TestClient response GET received > 69: 2021-05-19 15:51:31.690291 TestClient request GET > /GET/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:31.690308 TestClient start request 1 > 69: 2021-05-19 15:51:31.690316 TestClient sending PUT > /PUT/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:31.690553 TestClient getting PUT response > 69: 2021-05-19 15:51:32.307847 TestClient response PUT received > 69: 2021-05-19 15:51:32.307931 TestClient request PUT > /PUT/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:32.307938 TestClient sending GET > /GET/test_01_concurrent_requests_11_small request > 69: 2021-05-19 15:51:32.308040 TestClient getting GET response > 69: 2021-05-19 15:51:32.637675 TestClient response GET received > 69: 2021-05-19 15:51:32.637710 TestClient request GET > /GET/test_01_concurrent_requests_11_small completed! > 69: 2021-05-19 15:51:32.637714 TestClient sending GET > /GET/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:32.637780 TestClient getting GET response > 69: 2021-05-19 15:51:33.067768 TestClient response GET received > 69: 2021-05-19 15:51:33.740987 TestClient request GET > /GET/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:33.740998 TestClient start request 2 > 69: 2021-05-19 15:51:33.741004 TestClient sending PUT > /PUT/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:33.741220 TestClient getting PUT response > 69: 2021-05-19 15:51:34.523878 TestClient response PUT received > 69: 2021-05-19 15:51:34.523955 TestClient request PUT > /PUT/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:34.523960 TestClient sending GET > /GET/test_01_concurrent_requests_11_small request > 69: 2021-05-19 15:51:34.524036 TestClient getting GET response > 69: 2021-05-19 15:51:34.977493 TestClient response GET received > 69: 2021-05-19 15:51:34.977546 TestClient request GET > /GET/test_01_concurrent_requests_11_small completed! > 69: 2021-05-19 15:51:34.977551 TestClient sending GET > /GET/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:34.977662 TestClient getting GET response > 69: 2021-05-19 15:51:35.886808 TestClient response GET received > 69: 2021-05-19 15:51:36.406301 TestClient request GET > /GET/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:36.406315 TestClient start request 3 > 69: 2021-05-19 15:51:36.406321 TestClient sending PUT > /PUT/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:36.406545 TestClient getting PUT response > 69: 2021-05-19 15:51:37.316868 TestClient response PUT received > 69: 2021-05-19 15:51:37.316961 TestClient request PUT > /PUT/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:37.316969 TestClient sending GET > /GET/test_01_concurrent_requests_11_small request > 69: 2021-05-19 15:51:37.317073 TestClient getting GET response > 69: 2021-05-19 15:51:38.007026 TestClient response GET received > 69: 2021-05-19 15:51:38.008632 TestClient request GET > /GET/test_01_concurrent_requests_11_small completed! > 69: 2021-05-19 15:51:38.008641 TestClient sending GET > /GET/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:38.008743 TestClient getting GET response > 69: 2021-05-19 15:51:38.399380 TestClient response GET received > 69: 2021-05-19 15:51:38.800416 TestClient request GET > /GET/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:38.800429 TestClient start request 4 > 69: 2021-05-19 15:51:38.800436 TestClient sending PUT > /PUT/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:38.800696 TestClient getting PUT response > 69: 2021-05-19 15:51:39.641893 TestClient response PUT received > 69: 2021-05-19 15:51:39.641988 TestClient request PUT > /PUT/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:39.642005 TestClient sending GET > /GET/test_01_concurrent_requests_11_small request > 69: 2021-05-19 15:51:39.642113 TestClient getting GET response > 69: 2021-05-19 15:51:40.317618 TestClient response GET received > 69: 2021-05-19 15:51:40.320628 TestClient request GET > /GET/test_01_concurrent_requests_11_small completed! > 69: 2021-05-19 15:51:40.320640 TestClient sending GET > /GET/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:40.320751 TestClient getting GET response > 69: 2021-05-19 15:51:40.891824 TestClient response GET received > 69: 2021-05-19 15:51:41.362729 TestClient request GET > /GET/test_01_concurrent_requests_11 completed! > 69: 2021-05-19 15:51:41.362743 TestClient start request 5 > 69: 2021-05-19 15:51:41.362751 TestClient sending PUT > /PUT/test_01_concurrent_requests_11 request > 69: 2021-05-19 15:51:41.362981 TestClient getting PUT response > 69: 2021-05-19 15:55:29.483987 TestClient response PUT received > 69: 2021-05-19 15:55:29.484008 TestClient response invalid: Bad response > code, expected 201 got 503 > 69: 2021-05-19 15:55:29.488685 TestClient 127.0.0.1:24777 shut down > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=10, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 53792), raddr=('127.0.0.1', 24777)> > 69: self._sock = None > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=13, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 56870), raddr=('127.0.0.1', 24779)> > 69: self._sock = None > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=12, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 53796), raddr=('127.0.0.1', 24777)> > 69: self._sock = None > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=11, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 56874), raddr=('127.0.0.1', 24779)> > 69: self._sock = None > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=14, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 53800), raddr=('127.0.0.1', 24777)> > 69: self._sock = None > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=17, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 56844), raddr=('127.0.0.1', 24779)> > 69: self._sock = None > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=16, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 53804), raddr=('127.0.0.1', 24777)> > 69: self._sock = None > 69: /opt/python/3.6.8/lib/python3.6/socket.py:657: ResourceWarning: unclosed > <socket.socket fd=15, family=AddressFamily.AF_INET, type=2049, proto=6, > laddr=('127.0.0.1', 56912), raddr=('127.0.0.1', 24779)> > 69: self._sock = None > 69: FAIL > 69: test_02_credit_replenish > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) ... FAIL > 69: test_03_server_reconnect > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) ... FAIL > 69: test_04_server_pining_for_the_fjords > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) ... FAIL > 69: test_05_large_streaming_msg > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) ... FAIL > 69: > 69: Router EA2 output file: > 69: >>>> > 69: ----------------------------------------------------- > 69: Suppressions used: > 69: count bytes template > 69: 1 56 ^IoAdapter_init$ > 69: 2 48 ^pn_condition$ > 69: 2 3072 ^pn_raw_connection$ > 69: 10 496 ^pn_object_new$ > 69: 2 256 ^pn_list$ > 69: 4 96 ^pni_record_create$ > 69: 574 879980 /libpython3.*.so > 69: ----------------------------------------------------- > 69: > 69: > 69: <<<< > 69: > 69: Router EA2 debug dump file: > 69: >>>> > 69: alloc.c: Items of type 'qd_buffer_t' remain allocated at shutdown: 17 > (SUPPRESSED) > 69: > 69: <<<< > 69: > 69: Router EA1 output file: > 69: >>>> > 69: ----------------------------------------------------- > 69: Suppressions used: > 69: count bytes template > 69: 1 56 ^IoAdapter_init$ > 69: 574 879980 /libpython3.*.so > 69: ----------------------------------------------------- > 69: <<<< > 69: test_001_get (system_tests_http1_over_tcp.Http1OverTcpOneRouterTest) ... > ok > 69: test_002_head (system_tests_http1_over_tcp.Http1OverTcpOneRouterTest) ... > ok > 69: test_003_post (system_tests_http1_over_tcp.Http1OverTcpOneRouterTest) ... > ok > 69: test_004_put (system_tests_http1_over_tcp.Http1OverTcpOneRouterTest) ... > ok > 69: test_006_head_10 (system_tests_http1_over_tcp.Http1OverTcpOneRouterTest) > ... ok > 69: test_007_post_10 (system_tests_http1_over_tcp.Http1OverTcpOneRouterTest) > ... ok > 69: test_008_put_10 (system_tests_http1_over_tcp.Http1OverTcpOneRouterTest) > ... ok > 69: > 69: Router INT.A output file: > 69: >>>> > 69: ----------------------------------------------------- > 69: Suppressions used: > 69: count bytes template > 69: 1 56 ^IoAdapter_init$ > 69: 571 877716 /libpython3.*.so > 69: ----------------------------------------------------- > 69: > 69: > 69: <<<< > 69: > 69: ====================================================================== > 69: FAIL: test_01_concurrent_requests > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) > 69: ---------------------------------------------------------------------- > 69: Traceback (most recent call last): > 69: File "/home/travis/build/apache/qpid-dispatch/tests/http1_tests.py", > line 501, in test_01_concurrent_requests > 69: self.assertIsNone(client.error) > 69: AssertionError: 'client failed: Bad response code, expected 201 got 503' > is not None > 69: > 69: ====================================================================== > 69: FAIL: test_02_credit_replenish > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) > 69: ---------------------------------------------------------------------- > 69: Traceback (most recent call last): > 69: File "/home/travis/build/apache/qpid-dispatch/tests/http1_tests.py", > line 533, in test_02_credit_replenish > 69: self.assertIsNotNone(server, TEST_SERVER_ERROR % > self.http_server11_port) > 69: AssertionError: unexpectedly None : TestServer failed to start due to > port 24776 already in use issue > 69: > 69: ====================================================================== > 69: FAIL: test_03_server_reconnect > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) > 69: ---------------------------------------------------------------------- > 69: Traceback (most recent call last): > 69: File "/home/travis/build/apache/qpid-dispatch/tests/http1_tests.py", > line 565, in test_03_server_reconnect > 69: self.assertIsNotNone(server, TEST_SERVER_ERROR % > self.http_server11_port) > 69: AssertionError: unexpectedly None : TestServer failed to start due to > port 24776 already in use issue > 69: > 69: ====================================================================== > 69: FAIL: test_04_server_pining_for_the_fjords > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) > 69: ---------------------------------------------------------------------- > 69: Traceback (most recent call last): > 69: File "/home/travis/build/apache/qpid-dispatch/tests/http1_tests.py", > line 615, in test_04_server_pining_for_the_fjords > 69: self.assertIsNotNone(server, TEST_SERVER_ERROR % > self.http_server11_port) > 69: AssertionError: unexpectedly None : TestServer failed to start due to > port 24776 already in use issue > 69: > 69: ====================================================================== > 69: FAIL: test_05_large_streaming_msg > (system_tests_http1_over_tcp.Http1OverTcpEdge2EdgeTest) > 69: ---------------------------------------------------------------------- > 69: Traceback (most recent call last): > 69: File "/home/travis/build/apache/qpid-dispatch/tests/http1_tests.py", > line 722, in test_05_large_streaming_msg > 69: self.assertIsNotNone(server11, TEST_SERVER_ERROR % > self.http_server11_port) > 69: AssertionError: unexpectedly None : TestServer failed to start due to > port 24776 already in use issue > 69: > 69: ---------------------------------------------------------------------- > 69: Ran 12 tests in 258.477s > 69: > 69: FAILED (failures=5) > 69/72 Test #69: system_tests_http1_over_tcp .......................***Failed > 258.63 sec {noformat} -- This message was sent by Atlassian Jira (v8.3.4#803005) --------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@qpid.apache.org For additional commands, e-mail: dev-h...@qpid.apache.org