[ 
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

Reply via email to