Azure / azure-sdk-for-cpp

This repository is for active development of the Azure SDK for C++. For consumers of the SDK we recommend visiting our versioned developer docs at https://azure.github.io/azure-sdk-for-cpp.
MIT License
181 stars 126 forks source link

azure-core-amqp.TestManagement.ManagementRequestResponse fails intermittently because it "Cannot process received bytes" #4901

Closed ahsonkhan closed 1 year ago

ahsonkhan commented 1 year ago

See https://dev.azure.com/azure-sdk/public/_build/results?buildId=3014814&view=logs&j=98e09d1a-2dd9-54c0-d318-0eac30bf38a6&t=9de09327-270a-5760-30a2-161959e2b05a&l=14551 on Validate Win2022_Win32Api_release_curl_x86 from https://github.com/Azure/azure-sdk-for-cpp/pull/4897

https://github.com/Azure/azure-sdk-for-cpp/blob/c844535efb1321c0d7c28e1e275b424a68850a78/sdk/core/azure-core-amqp/test/ut/management_tests.cpp#L175-L176

2023-08-18T06:55:46.6466522Z test 559
2023-08-18T06:55:46.6467162Z         Start 559: azure-core-amqp.TestManagement.ManagementRequestResponse
2023-08-18T06:55:46.6467555Z 
2023-08-18T06:55:46.6468225Z 559: Test command: D:\a\_work\1\s\build\sdk\core\azure-core-amqp\test\ut\Release\azure-core-amqp-tests.exe "--gtest_filter=TestManagement.ManagementRequestResponse" "--gtest_also_run_disabled_tests"
2023-08-18T06:55:46.6469034Z 559: Working Directory: D:/a/_work/1/s/build/sdk/core/azure-core-amqp/test/ut
2023-08-18T06:55:46.6469508Z 559: Test timeout computed to be: 10000000
2023-08-18T06:55:46.6548440Z 559: Note: Google Test filter = TestManagement.ManagementRequestResponse
2023-08-18T06:55:46.6549090Z 559: [==========] Running 1 test from 1 test suite.
2023-08-18T06:55:46.6549577Z 559: [----------] Global test environment set-up.
2023-08-18T06:55:46.6550013Z 559: [----------] 1 test from TestManagement
2023-08-18T06:55:46.6550508Z 559: [ RUN      ] TestManagement.ManagementRequestResponse
2023-08-18T06:55:46.6587054Z 559: 
2023-08-18T06:55:46.6587781Z 559: [  INFO ] D:\a\_work\1\s\sdk\core\azure-core-amqp\test\ut\session_tests.cpp(119):: Trying Test port: 5000
2023-08-18T06:55:46.6592416Z 559: [2023-08-18T06:55:46.6591035Z] INFO  : Unknown port specified, assuming socket connection transport.
2023-08-18T06:55:46.6593171Z 559: [2023-08-18T06:55:46.6591376Z] DEBUG : Create socket transport for host localhost port: 5000
2023-08-18T06:55:46.6593673Z 559: 
2023-08-18T06:55:46.6594415Z 559: [  INFO ] D:\a\_work\1\s\sdk\core\azure-core-amqp\test\ut\mock_amqp_server.hpp(183):: Wait 10 seconds for listener to start.
2023-08-18T06:55:46.6598279Z 559: 
2023-08-18T06:55:46.6599046Z 559: [  INFO ] D:\a\_work\1\s\sdk\core\azure-core-amqp\test\ut\mock_amqp_server.hpp(139):: Start test listener on port 5000
2023-08-18T06:55:46.6599920Z 559: 
2023-08-18T06:55:46.6600570Z 559: [  INFO ] D:\a\_work\1\s\sdk\core\azure-core-amqp\test\ut\mock_amqp_server.hpp(141):: listener started
2023-08-18T06:55:46.6600952Z 559: 
2023-08-18T06:55:46.6601257Z 559: [  INFO ]
2023-08-18T06:55:46.6602239Z 559:  [  INFO ]D:\a\_work\1\s\sdk\core\azure-core-amqp\test\ut\mock_amqp_server.hpp(189)::  Listener running.D:\a\_work\1\s\sdk\core\azure-core-amqp\test\ut\mock_amqp_server.hpp(145):
2023-08-18T06:55:46.6602805Z 559: : Wait for connection on listener.
2023-08-18T06:56:17.3862350Z 559: [2023-08-18T06:56:17.3858464Z] ERROR : Message Sender Changed State to 5 while management client is opening
2023-08-18T06:56:17.3863643Z 559: [2023-08-18T06:56:17.3859180Z] ERROR : Message Sender Changed State to 5 while management client is closing
2023-08-18T06:56:17.3864795Z 559: [2023-08-18T06:56:17.3859666Z] ERROR : File: D:\a\_work\1\s\build\_deps\vcpkg-src\buildtrees\azure-uamqp-c\src\c1d5924306-398845d0ed.clean\src\connection.c:722 Func: _connection_on_bytes_received: Cannot process received bytes
2023-08-18T06:56:17.3865888Z 559: D:\a\_work\1\s\sdk\core\azure-core-amqp\test\ut\management_tests.cpp(176): error: Expected equality of these values:
2023-08-18T06:56:17.3866775Z 559:   openResult
2023-08-18T06:56:17.3867600Z 559:     Which is: 4-byte object <02-00 00-00>
2023-08-18T06:56:17.3868318Z 559:   ManagementOpenStatus::Ok
2023-08-18T06:56:17.3868966Z 559:     Which is: 4-byte object <01-00 00-00>
2023-08-18T06:56:17.3869863Z 559: [2023-08-18T06:56:17.3862983Z] ERROR : File: D:\a\_work\1\s\build\_deps\vcpkg-src\buildtrees\azure-c-shared-utility\src\10753faee5-044a82ff07.clean\adapters\socketio_win32.c:547 Func: _socketio_send: Failure: socket state is not opened.
2023-08-18T06:56:17.3870940Z 559: [2023-08-18T06:56:17.3863282Z] ERROR : File: D:\a\_work\1\s\build\_deps\vcpkg-src\buildtrees\azure-uamqp-c\src\c1d5924306-398845d0ed.clean\src\connection.c:268 Func: _on_bytes_encoded: Cannot send encoded bytes
2023-08-18T06:56:17.3886154Z 424/472 Test #559: azure-core-amqp.TestManagement.ManagementRequestResponse ..........................................***Failed   30.74 sec
LarryOsterman commented 1 year ago

Likely fixed in #4914