Flaky Test: ensure monitors properly create and unpause connection pools when they discover servers [45]

XMLWordPrintableJSON

    • Type: Build Failure
    • Resolution: Unresolved
    • Priority: Unknown
    • None
    • Affects Version/s: None
    • Component/s: Flaky Test
    • 3
    • None
    • Hide

      Create a copy of the Kickoff Template with the issue key (NODE-XXX) in the filename and share a link to the new doc via this field.

      Show
      Create a copy of the Kickoff Template with the issue key (NODE-XXX) in the filename and share a link to the new doc via this field.
    • Not Needed
    • None
    • None
    • None
    • None
    • None
    • None

      https://evergreen.mongodb.com/task/mongo_node_driver_next_windows_64_vs2019_fermium_test_latest_server_v1_api_b439893b7404180e6d39f1c7efbb241042411b1f_23_04_12_20_22_08

      [2023/04/12 20:52:10.990]   1) Server Discovery and Monitoring Prose Tests
      [2023/04/12 20:52:10.990]        Connection Pool Management
      [2023/04/12 20:52:10.990]          ensure monitors properly create and unpause connection pools when they discover servers:
      [2023/04/12 20:52:10.990]       AssertionError: expected 'serverHeartbeatFailed' to equal 'serverHeartbeatSucceeded'
      [2023/04/12 20:52:10.990]       + expected - actual
      [2023/04/12 20:52:10.990]       -serverHeartbeatFailed
      [2023/04/12 20:52:10.990]       +serverHeartbeatSucceeded
      [2023/04/12 20:52:10.990]       
      [2023/04/12 20:52:10.990]       at Context.test (Z:\data\mci\5faec0d9a4c55281764356efcacc5cb6\src\test\integration\server-discovery-and-monitoring\server_discovery_and_monitoring.prose.test.ts:175:35)
      [2023/04/12 20:52:10.990]       at runMicrotasks (<anonymous>)
      [2023/04/12 20:52:10.990]       at processTicksAndRejections (internal/process/task_queues.js:95:5) 

      Captured logs from:
      https://evergreen.mongodb.com/task_log_raw/mongo_node_driver_next_rhel80_large_node_latest_test_latest_server_v1_api_2f67139da901d417c8dc065258bc7e6f1abaddca_25_09_02_20_22_24/0?type=T
       

      [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.584Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"message":"Starting topology monitoring"}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.584Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"message":"Topology description changed","reply":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":629884,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":null,\"se...","previousDescription":"{\"type\":\"Unknown\",\"servers\":{},\"stale\":false,\"compatible\":true,\"heartbeatFrequencyMS\":0,\"localThresholdMS\":15,\"setName\":null,\"maxElectionId\":null,\"maxSetVersion\":null,\"commonWireVersion\":0,\"logicalSessionTimeoutMinutes\":null}","newDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":629884,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":null,\"se..."}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.585Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"serverHost":"localhost","serverPort":27017,"message":"Starting server monitoring"}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.586Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":false,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat started"}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.586Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"readPreferenceServers","operation":"handshake","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":629884,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":null,\"se...","message":"Server selection started"}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.586Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"info","selector":"readPreferenceServers","operation":"handshake","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":629884,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":null,\"se...","message":"Waiting for suitable server to become available","remainingTimeMS":30000}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.586Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection pool created","maxIdleTimeMS":0,"minPoolSize":0,"maxPoolSize":100,"maxConnecting":2,"waitQueueTimeoutMS":0}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.587Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection pool ready"}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.587Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"readPreferenceServers","operation":"handshake","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":629884,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":null,\"se...","message":"Server selection succeeded","serverHost":"localhost","serverPort":27017}
       [2025/09/02 16:34:50.096] {"t":"2025-09-02T20:34:48.587Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"message":"Topology description changed","reply":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":0,\"lastUpdateTime\":629887,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","previousDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":629884,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":null,\"se...","newDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":0,\"lastUpdateTime\":629887,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro..."}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.587Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":true,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat succeeded","durationMS":1,"serverConnectionId":13647,"reply":"{\"helloOk\":true,\"isWritablePrimary\":true,\"topologyVersion\":{\"processId\":{\"$oid\":\"68b75301b6599644f66d16f9\"},\"counter\":0},\"maxBsonObjectSize\":16777216,\"maxMessageSizeBytes\":48000000,\"maxWriteBatchSize\":100000,\"localTime\":{\"$date\":\"2025-09-02T20:34:48.587Z\"},\"logicalSessionTimeoutMinutes\":30,\"connecti..."}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.587Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checkout started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.587Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection created","driverConnectionId":1}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.588Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection ready","driverConnectionId":1,"durationMS":1}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.588Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked out","driverConnectionId":1,"durationMS":1}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.588Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked in","driverConnectionId":1}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.589Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"{\"mode\":\"primary\",\"tags\":null,\"hedge\":null,\"maxStalenessSeconds\":null,\"minWireVersion\":null}","operation":"runCommand","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":0,\"lastUpdateTime\":629887,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","message":"Server selection started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.589Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"readPreferenceServers","operation":"runCommand","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":0,\"lastUpdateTime\":629887,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","message":"Server selection succeeded","serverHost":"localhost","serverPort":27017}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.589Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checkout started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.589Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked out","driverConnectionId":1,"durationMS":0}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.589Z","id":"68b754e88d511ad854d67eed","c":"command","s":"debug","commandName":"configureFailPoint","requestId":69374,"driverConnectionId":1,"serverHost":"::1","serverPort":27017,"databaseName":"admin","serverConnectionId":{"bigint":{"$numberLong":"13648"}},"message":"Command started","command":"{\"configureFailPoint\":\"failCommand\",\"mode\":{\"times\":2},\"data\":{\"failCommands\":[\"hello\"],\"errorCode\":1234,\"appName\":\"SDAMPoolManagementTest\"},\"apiVersion\":\"1\",\"lsid\":{\"id\":{\"$binary\":{\"base64\":\"C6/Fi2PkSSG/iYN79fAXCQ==\",\"subType\":\"04\"}}},\"$db\":\"admin\"}"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.589Z","id":"68b754e88d511ad854d67eed","c":"command","s":"debug","commandName":"configureFailPoint","requestId":69374,"driverConnectionId":1,"serverHost":"::1","serverPort":27017,"databaseName":"admin","serverConnectionId":{"bigint":{"$numberLong":"13648"}},"message":"Command succeeded","durationMS":0,"reply":"{\"count\":509,\"ok\":1}"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:48.589Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked in","driverConnectionId":1}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:49.086Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":true,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:49.087Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":true,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat failed","durationMS":1,"failure":"Failing command via 'failCommand' failpoint"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:49.087Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection pool cleared"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:49.087Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"message":"Topology description changed","reply":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":630387,\"lastWriteDate\":0,\"error\":{\"errorLabelSet\":{},\"errorRespo...","previousDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":0,\"lastUpdateTime\":629887,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","newDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":630387,\"lastWriteDate\":0,\"error\":{\"errorLabelSet\":{},\"errorRespo..."}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:49.588Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":false,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:49.590Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":false,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat failed","durationMS":0,"failure":"Failing command via 'failCommand' failpoint"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.090Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":false,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.091Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection pool ready"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.092Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection closed","driverConnectionId":1,"reason":"Connection became stale because the pool was cleared"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.092Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"message":"Topology description changed","reply":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":1,\"lastUpdateTime\":631391,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","previousDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Unknown\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":0,\"roundTripTime\":-1,\"minRoundTripTime\":0,\"lastUpdateTime\":630889,\"lastWriteDate\":0,\"error\":{\"errorLabelSet\":{},\"errorRespo...","newDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":1,\"lastUpdateTime\":631391,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro..."}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.092Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"awaited":true,"driverConnectionId":"localhost:27017","serverHost":"localhost","serverPort":27017,"message":"Server heartbeat succeeded","durationMS":1,"serverConnectionId":13651,"reply":"{\"helloOk\":true,\"isWritablePrimary\":true,\"topologyVersion\":{\"processId\":{\"$oid\":\"68b75301b6599644f66d16f9\"},\"counter\":0},\"maxBsonObjectSize\":16777216,\"maxMessageSizeBytes\":48000000,\"maxWriteBatchSize\":100000,\"localTime\":{\"$date\":\"2025-09-02T20:34:50.091Z\"},\"logicalSessionTimeoutMinutes\":30,\"connecti..."}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.093Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"{\"mode\":\"primary\",\"tags\":null,\"hedge\":null,\"maxStalenessSeconds\":null,\"minWireVersion\":null}","operation":"runCommand","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":1,\"lastUpdateTime\":631391,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","message":"Server selection started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.093Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"readPreferenceServers","operation":"runCommand","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":1,\"lastUpdateTime\":631391,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","message":"Server selection succeeded","serverHost":"localhost","serverPort":27017}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.093Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checkout started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.093Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection created","driverConnectionId":2}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.095Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection ready","driverConnectionId":2,"durationMS":2}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.095Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked out","driverConnectionId":2,"durationMS":2}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.095Z","id":"68b754e88d511ad854d67eed","c":"command","s":"debug","commandName":"configureFailPoint","requestId":69381,"driverConnectionId":2,"serverHost":"::1","serverPort":27017,"databaseName":"admin","serverConnectionId":{"bigint":{"$numberLong":"13652"}},"message":"Command started","command":"{\"configureFailPoint\":\"failCommand\",\"mode\":\"off\",\"data\":{\"failCommands\":[\"hello\"],\"errorCode\":1234,\"appName\":\"SDAMPoolManagementTest\"},\"apiVersion\":\"1\",\"lsid\":{\"id\":{\"$binary\":{\"base64\":\"C6/Fi2PkSSG/iYN79fAXCQ==\",\"subType\":\"04\"}}},\"$db\":\"admin\"}"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.095Z","id":"68b754e88d511ad854d67eed","c":"command","s":"debug","commandName":"configureFailPoint","requestId":69381,"driverConnectionId":2,"serverHost":"::1","serverPort":27017,"databaseName":"admin","serverConnectionId":{"bigint":{"$numberLong":"13652"}},"message":"Command succeeded","durationMS":0,"reply":"{\"count\":512,\"ok\":1}"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.095Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked in","driverConnectionId":2}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.095Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"{\"mode\":\"primary\",\"tags\":null,\"hedge\":null,\"maxStalenessSeconds\":null,\"minWireVersion\":null}","operation":"endSessions","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":1,\"lastUpdateTime\":631391,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","message":"Server selection started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"serverSelection","s":"debug","selector":"readPreferenceServers","operation":"endSessions","topologyDescription":"{\"type\":\"Single\",\"servers\":{\"localhost:27017\":{\"address\":\"localhost:27017\",\"type\":\"Standalone\",\"hosts\":[],\"passives\":[],\"arbiters\":[],\"tags\":{},\"minWireVersion\":0,\"maxWireVersion\":28,\"roundTripTime\":1,\"minRoundTripTime\":1,\"lastUpdateTime\":631391,\"lastWriteDate\":0,\"error\":null,\"topologyVersion\":{\"pro...","message":"Server selection succeeded","serverHost":"localhost","serverPort":27017}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checkout started"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked out","driverConnectionId":2,"durationMS":0}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"command","s":"debug","commandName":"endSessions","requestId":69382,"driverConnectionId":2,"serverHost":"::1","serverPort":27017,"databaseName":"admin","serverConnectionId":{"bigint":{"$numberLong":"13652"}},"message":"Command started","command":"{\"endSessions\":[{\"id\":{\"$binary\":{\"base64\":\"C6/Fi2PkSSG/iYN79fAXCQ==\",\"subType\":\"04\"}}}],\"apiVersion\":\"1\",\"$db\":\"admin\"}"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"command","s":"debug","commandName":"endSessions","requestId":69382,"driverConnectionId":2,"serverHost":"::1","serverPort":27017,"databaseName":"admin","serverConnectionId":{"bigint":{"$numberLong":"13652"}},"message":"Command succeeded","durationMS":1,"reply":"null"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection checked in","driverConnectionId":2}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection closed","driverConnectionId":2,"reason":"Connection pool was closed"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"connection","s":"debug","serverHost":"localhost","serverPort":27017,"message":"Connection pool closed"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"serverHost":"localhost","serverPort":27017,"message":"Stopped server monitoring"}
       [2025/09/02 16:34:50.097] {"t":"2025-09-02T20:34:50.096Z","id":"68b754e88d511ad854d67eed","c":"topology","s":"debug","topologyId":6562,"message":"Stopped topology monitoring"}

      AC

      • Investigate the logs and try to find and address the root cause of the flakiness; send back to team if path forward is still unclear

            Assignee:
            Unassigned
            Reporter:
            Daria Pardue
            Bailey Pearson
            Votes:
            0 Vote for this issue
            Watchers:
            9 Start watching this issue

              Created:
              Updated: