Uploaded image for project: 'Debezium'
  1. Debezium
  2. DBZ-6875

Intermittent failure of MongoDbReplicaSetAuthTest

    XMLWordPrintable

Details

    • False
    • None
    • False

    Description

      See for example https://github.com/debezium/debezium/actions/runs/6106077308/job/16573890614?pr=4837

      The error in question is

      [INFO] Running io.debezium.testing.testcontainers.MongoDbReplicaSetAuthTest
      2023-09-07 08:27:45,205 INFO   ||  Starting MongoDbReplicaSet{name='rs0', memberCount=3, configServer=false, network=org.testcontainers.containers.Network$NetworkImpl@3562e7c7, members=[GenericContainer(exposedPorts=[], portBindings=[], extraHosts=[], networkMode=null, network=org.testcontainers.containers.Network$NetworkImpl@3562e7c7, networkAliases=[tc-mMGLQXtK, test-mongo1], image=RemoteDockerImage(imageName=mongo:6.0, imagePullPolicy=DefaultPullPolicy(), imageNameSubstitutor=org.testcontainers.utility.ImageNameSubstitutor$LogWrappedImageNameSubstitutor@2776fd8f), env=[], labels={}, commandParts=[], binds=[], privilegedMode=false, volumesFroms=[], linkedContainers={}, startupCheckStrategy=org.testcontainers.containers.startupcheck.IsRunningStartupCheckStrategy@66d2885c, startupAttempts=1, workingDirectory=null, shmSize=null, copyToFileContainerPathMap={}, copyToTransferableContainerPathMap={}, dependencies=[], dockerClient=LazyDockerClient, containerId=null, containerInfo=null, waitStrategy=org.testcontainers.containers.wait.strategy.HostPortWaitStrategy@2bfc8558, logConsumers=[], createContainerCmdModifiers=[], tmpFsMapping=null, shouldBeReused=false, hostAccessible=false), GenericContainer(exposedPorts=[], portBindings=[], extraHosts=[], networkMode=null, network=org.testcontainers.containers.Network$NetworkImpl@3562e7c7, networkAliases=[tc-9AcHUSuX, test-mongo2], image=RemoteDockerImage(imageName=mongo:6.0, imagePullPolicy=DefaultPullPolicy(), imageNameSubstitutor=org.testcontainers.utility.ImageNameSubstitutor$LogWrappedImageNameSubstitutor@2776fd8f), env=[], labels={}, commandParts=[], binds=[], privilegedMode=false, volumesFroms=[], linkedContainers={}, startupCheckStrategy=org.testcontainers.containers.startupcheck.IsRunningStartupCheckStrategy@6029f2a4, startupAttempts=1, workingDirectory=null, shmSize=null, copyToFileContainerPathMap={}, copyToTransferableContainerPathMap={}, dependencies=[], dockerClient=LazyDockerClient, containerId=null, containerInfo=null, waitStrategy=org.testcontainers.containers.wait.strategy.HostPortWaitStrategy@42576db9, logConsumers=[], createContainerCmdModifiers=[], tmpFsMapping=null, shouldBeReused=false, hostAccessible=false), GenericContainer(exposedPorts=[], portBindings=[], extraHosts=[], networkMode=null, network=org.testcontainers.containers.Network$NetworkImpl@3562e7c7, networkAliases=[tc-QEFm4FsS, test-mongo3], image=RemoteDockerImage(imageName=mongo:6.0, imagePullPolicy=DefaultPullPolicy(), imageNameSubstitutor=org.testcontainers.utility.ImageNameSubstitutor$LogWrappedImageNameSubstitutor@2776fd8f), env=[], labels={}, commandParts=[], binds=[], privilegedMode=false, volumesFroms=[], linkedContainers={}, startupCheckStrategy=org.testcontainers.containers.startupcheck.IsRunningStartupCheckStrategy@30358dc7, startupAttempts=1, workingDirectory=null, shmSize=null, copyToFileContainerPathMap={}, copyToTransferableContainerPathMap={}, dependencies=[], dockerClient=LazyDockerClient, containerId=null, containerInfo=null, waitStrategy=org.testcontainers.containers.wait.strategy.HostPortWaitStrategy@7fac18dc, logConsumers=[], createContainerCmdModifiers=[], tmpFsMapping=null, shouldBeReused=false, hostAccessible=false)], started=false}...   [io.debezium.testing.testcontainers.MongoDbReplicaSetAuthTest]
      2023-09-07 08:27:45,206 INFO   ||  [rs0] Starting 3 node replica set...   [io.debezium.testing.testcontainers.MongoDbReplicaSet]
      2023-09-07 08:27:45,206 INFO   ||  command is: echo 'secret' > /data/replica.key && chown 999:999 /data/replica.key && chmod 0600 /data/replica.key && docker-entrypoint.sh mongod  --replSet rs0  --port 27017 --bind_ip localhost,test-mongo2 --keyFile /data/replica.key   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:45,206 INFO   ||  command is: echo 'secret' > /data/replica.key && chown 999:999 /data/replica.key && chmod 0600 /data/replica.key && docker-entrypoint.sh mongod  --replSet rs0  --port 27017 --bind_ip localhost,test-mongo1 --keyFile /data/replica.key   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:45,207 INFO   ||  command is: echo 'secret' > /data/replica.key && chown 999:999 /data/replica.key && chmod 0600 /data/replica.key && docker-entrypoint.sh mongod  --replSet rs0  --port 27017 --bind_ip localhost,test-mongo3 --keyFile /data/replica.key   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:47,058 INFO   ||  [rs0] Initializing replica set...   [io.debezium.testing.testcontainers.MongoDbReplicaSet]
      2023-09-07 08:27:47,058 INFO   ||  [rs0:test-mongo1] Initializing replica set...   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:48,060 INFO   ||  {"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:48,060 INFO   ||  [rs0] Awaiting primary...   [io.debezium.testing.testcontainers.MongoDbReplicaSet]
      2023-09-07 08:27:49,887 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:49.869Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":3,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":1,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:49.524Z","lastHeartbeatRecv":"2023-09-07T08:27:49.711Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":1,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:49.525Z","lastHeartbeatRecv":"2023-09-07T08:27:49.739Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:50,832 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:50.801Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":4,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":2,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:50.525Z","lastHeartbeatRecv":"2023-09-07T08:27:50.711Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":2,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:50.525Z","lastHeartbeatRecv":"2023-09-07T08:27:50.739Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:51,756 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:51.733Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":5,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":3,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:51.527Z","lastHeartbeatRecv":"2023-09-07T08:27:51.711Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":3,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:51.527Z","lastHeartbeatRecv":"2023-09-07T08:27:51.239Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:52,703 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:52.668Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":6,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":4,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:52.529Z","lastHeartbeatRecv":"2023-09-07T08:27:52.211Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":4,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:52.529Z","lastHeartbeatRecv":"2023-09-07T08:27:52.239Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:53,626 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:53.596Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":7,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":5,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:53.531Z","lastHeartbeatRecv":"2023-09-07T08:27:53.211Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":5,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:53.531Z","lastHeartbeatRecv":"2023-09-07T08:27:53.239Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:54,525 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:54.508Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":8,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"Could not find member to sync from","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":6,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:54.032Z","lastHeartbeatRecv":"2023-09-07T08:27:54.211Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":6,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:54.032Z","lastHeartbeatRecv":"2023-09-07T08:27:54.239Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:55,446 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:55.429Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":9,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"Could not find member to sync from","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":7,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:55.032Z","lastHeartbeatRecv":"2023-09-07T08:27:55.214Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":7,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:55.032Z","lastHeartbeatRecv":"2023-09-07T08:27:55.239Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:56,383 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:56.351Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":10,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"Could not find member to sync from","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":8,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:56.033Z","lastHeartbeatRecv":"2023-09-07T08:27:56.214Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":8,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:56.032Z","lastHeartbeatRecv":"2023-09-07T08:27:56.239Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:57,305 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:57.288Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":11,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"Could not find member to sync from","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":9,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:57.033Z","lastHeartbeatRecv":"2023-09-07T08:27:57.214Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":9,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:57.032Z","lastHeartbeatRecv":"2023-09-07T08:27:57.239Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:58,255 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:58.233Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":12,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"Could not find member to sync from","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":10,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:58.033Z","lastHeartbeatRecv":"2023-09-07T08:27:58.214Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":10,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:58.033Z","lastHeartbeatRecv":"2023-09-07T08:27:57.739Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:27:59,207 INFO   ||  {"set":"rs0","date":"2023-09-07T08:27:59.171Z","myState":2,"term":{"low":0,"high":0,"unsigned":false},"syncSourceHost":"","syncSourceId":-1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:27:48.011Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":13,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","syncSourceHost":"","syncSourceId":-1,"infoMessage":"Could not find member to sync from","configVersion":1,"configTerm":0,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":11,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:59.034Z","lastHeartbeatRecv":"2023-09-07T08:27:58.714Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":11,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:59.034Z","lastHeartbeatRecv":"2023-09-07T08:27:58.739Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":0}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:28:00,232 INFO   ||  {"set":"rs0","date":"2023-09-07T08:28:00.198Z","myState":2,"term":{"low":1,"high":0,"unsigned":false},"syncSourceHost":"172.21.0.2:27017","syncSourceId":1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997924562042884"},"t":{"low":1,"high":0,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:28:00.130Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997924562042884"},"t":{"low":1,"high":0,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997924562042884"},"t":{"low":1,"high":0,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997924562042884"},"t":{"low":1,"high":0,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:28:00.130Z","lastDurableWallTime":"2023-09-07T08:28:00.130Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"electionParticipantMetrics":{"votedForCandidate":true,"electionTerm":{"low":1,"high":0,"unsigned":false},"lastVoteDate":"2023-09-07T08:27:59.370Z","electionCandidateMemberId":1,"voteReason":"","lastAppliedOpTimeAtElection":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"maxAppliedOpTimeInSet":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"priorityAtElection":1,"newTermStartDate":"2023-09-07T08:27:59.398Z","newTermAppliedDate":"2023-09-07T08:28:00.090Z"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":14,"optime":{"ts":{"$timestamp":"7275997924562042884"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDate":"2023-09-07T08:28:00.000Z","lastAppliedWallTime":"2023-09-07T08:28:00.130Z","lastDurableWallTime":"2023-09-07T08:28:00.130Z","syncSourceHost":"172.21.0.2:27017","syncSourceId":1,"infoMessage":"syncing from: 172.21.0.2:27017","configVersion":1,"configTerm":1,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":1,"stateStr":"PRIMARY","uptime":12,"optime":{"ts":{"$timestamp":"7275997920267075593"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997920267075593"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDate":"2023-09-07T08:27:59.000Z","optimeDurableDate":"2023-09-07T08:27:59.000Z","lastAppliedWallTime":"2023-09-07T08:27:59.416Z","lastDurableWallTime":"2023-09-07T08:27:59.416Z","lastHeartbeat":"2023-09-07T08:27:59.886Z","lastHeartbeatRecv":"2023-09-07T08:27:59.377Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","electionTime":{"$timestamp":"7275997920267075585"},"electionDate":"2023-09-07T08:27:59.000Z","configVersion":1,"configTerm":1},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":12,"optime":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"optimeDate":"2023-09-07T08:27:48.000Z","optimeDurableDate":"2023-09-07T08:27:48.000Z","lastAppliedWallTime":"2023-09-07T08:27:48.011Z","lastDurableWallTime":"2023-09-07T08:27:48.011Z","lastHeartbeat":"2023-09-07T08:27:59.886Z","lastHeartbeatRecv":"2023-09-07T08:27:59.881Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","configVersion":1,"configTerm":1}],"ok":1}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:28:00,232 INFO   ||  [rs0] Creating root user...   [io.debezium.testing.testcontainers.MongoDbReplicaSet]
      2023-09-07 08:28:01,103 INFO   ||  {"set":"rs0","date":"2023-09-07T08:28:01.084Z","myState":2,"term":{"low":1,"high":0,"unsigned":false},"syncSourceHost":"172.21.0.2:27017","syncSourceId":1,"heartbeatIntervalMillis":{"low":2000,"high":0,"unsigned":false},"majorityVoteCount":2,"writeMajorityCount":2,"votingMembersCount":3,"writableVotingMembersCount":3,"optimes":{"lastCommittedOpTime":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"lastCommittedWallTime":"2023-09-07T08:28:00.148Z","readConcernMajorityOpTime":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"appliedOpTime":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"durableOpTime":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"lastAppliedWallTime":"2023-09-07T08:28:00.148Z","lastDurableWallTime":"2023-09-07T08:28:00.148Z"},"lastStableRecoveryTimestamp":{"$timestamp":"7275997873022435329"},"electionParticipantMetrics":{"votedForCandidate":true,"electionTerm":{"low":1,"high":0,"unsigned":false},"lastVoteDate":"2023-09-07T08:27:59.370Z","electionCandidateMemberId":1,"voteReason":"","lastAppliedOpTimeAtElection":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"maxAppliedOpTimeInSet":{"ts":{"$timestamp":"7275997873022435329"},"t":{"low":-1,"high":-1,"unsigned":false}},"priorityAtElection":1,"newTermStartDate":"2023-09-07T08:27:59.398Z","newTermAppliedDate":"2023-09-07T08:28:00.090Z"},"members":[{"_id":0,"name":"172.21.0.3:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":15,"optime":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDate":"2023-09-07T08:28:00.000Z","lastAppliedWallTime":"2023-09-07T08:28:00.148Z","lastDurableWallTime":"2023-09-07T08:28:00.148Z","syncSourceHost":"172.21.0.2:27017","syncSourceId":1,"infoMessage":"","configVersion":1,"configTerm":1,"self":true,"lastHeartbeatMessage":""},{"_id":1,"name":"172.21.0.2:27017","health":1,"state":1,"stateStr":"PRIMARY","uptime":13,"optime":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDate":"2023-09-07T08:28:00.000Z","optimeDurableDate":"2023-09-07T08:28:00.000Z","lastAppliedWallTime":"2023-09-07T08:28:00.148Z","lastDurableWallTime":"2023-09-07T08:28:00.148Z","lastHeartbeat":"2023-09-07T08:28:00.386Z","lastHeartbeatRecv":"2023-09-07T08:27:59.377Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"","syncSourceId":-1,"infoMessage":"","electionTime":{"$timestamp":"7275997920267075585"},"electionDate":"2023-09-07T08:27:59.000Z","configVersion":1,"configTerm":1},{"_id":2,"name":"172.21.0.4:27017","health":1,"state":2,"stateStr":"SECONDARY","uptime":13,"optime":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDurable":{"ts":{"$timestamp":"7275997924562042887"},"t":{"low":1,"high":0,"unsigned":false}},"optimeDate":"2023-09-07T08:28:00.000Z","optimeDurableDate":"2023-09-07T08:28:00.000Z","lastAppliedWallTime":"2023-09-07T08:28:00.148Z","lastDurableWallTime":"2023-09-07T08:28:00.148Z","lastHeartbeat":"2023-09-07T08:28:00.386Z","lastHeartbeatRecv":"2023-09-07T08:28:00.382Z","pingMs":{"low":0,"high":0,"unsigned":false},"lastHeartbeatMessage":"","syncSourceHost":"172.21.0.2:27017","syncSourceId":1,"infoMessage":"","configVersion":1,"configTerm":1}],"ok":1,"$clusterTime":{"clusterTime":{"$timestamp":"7275997924562042887"},"signature":{"hash":"bnFjalkJ/rHRconM4VoVCYUbZJw=","keyId":{"low":5,"high":1694075279,"unsigned":false}}},"operationTime":{"$timestamp":"7275997924562042887"}}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:28:02,024 INFO   ||  {"ok":1,"$clusterTime":{"clusterTime":{"$timestamp":"7275997928857010180"},"signature":{"hash":"iQeJRBHcx9aeOnb/Iwmx7jav4Bw=","keyId":{"low":5,"high":1694075279,"unsigned":false}}},"operationTime":{"$timestamp":"7275997928857010180"}}:   [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:28:02,024 INFO   ||  Setting up users   [io.debezium.testing.testcontainers.MongoDbReplicaSetAuthTest]
      2023-09-07 08:28:02,862 ERROR  ||  An error occurred: MongoServerError: command replSetGetStatus requires authentication
         [io.debezium.testing.testcontainers.MongoDbContainer]
      2023-09-07 08:28:02,865 INFO   ||  [rs0] Stopping...   [io.debezium.testing.testcontainers.MongoDbReplicaSet]
      Error:  Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 18.191 s <<< FAILURE! - in io.debezium.testing.testcontainers.MongoDbReplicaSetAuthTest
      Error:  io.debezium.testing.testcontainers.MongoDbReplicaSetAuthTest  Time elapsed: 18.191 s  <<< ERROR!
      java.lang.IllegalStateException: 
      An error occurred: MongoServerError: command replSetGetStatus requires authentication
      
      	at io.debezium.testing.testcontainers.MongoDbContainer.checkExitCode(MongoDbContainer.java:383)
      	at io.debezium.testing.testcontainers.MongoDbContainer.execMongoInContainer(MongoDbContainer.java:345)
      	at io.debezium.testing.testcontainers.MongoDbContainer.eval(MongoDbContainer.java:351)
      	at io.debezium.testing.testcontainers.MongoDbReplicaSet.getStatus(MongoDbReplicaSet.java:361)
      	at io.debezium.testing.testcontainers.MongoDbReplicaSet.tryPrimary(MongoDbReplicaSet.java:345)
      	at io.debezium.testing.testcontainers.MongoDbReplicaSet.createUser(MongoDbReplicaSet.java:311)
      	at io.debezium.testing.testcontainers.MongoDbReplicaSetAuthTest.beforeAll(MongoDbReplicaSetAuthTest.java:49)
      	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
      	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      	at java.base/java.lang.reflect.Method.invoke(Method.java:568)
      	at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727)
      	at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
      	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131)
      	at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156)
      	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptLifecycleMethod(TimeoutExtension.java:128)
      	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptBeforeAllMethod(TimeoutExtension.java:70)
      	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103)
      	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93)
      	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106)
      	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64)
      	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45)
      	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37)
      	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92)
      	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86)
      	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.lambda$invokeBeforeAllMethods$13(ClassBasedTestDescriptor.java:411)
      	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
      	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.invokeBeforeAllMethods(ClassBasedTestDescriptor.java:409)
      	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.before(ClassBasedTestDescriptor.java:215)
      	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.before(ClassBasedTestDescriptor.java:84)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:148)
      	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
      	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
      	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
      	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
      	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155)
      	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
      	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
      	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
      	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
      	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35)
      	at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
      	at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54)
      	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147)
      	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127)
      	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90)
      	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55)
      	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102)
      	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54)
      	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114)
      	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86)
      	at org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86)
      	at org.apache.maven.surefire.junitplatform.LazyLauncher.execute(LazyLauncher.java:55)
      	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.execute(JUnitPlatformProvider.java:223)
      	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:175)
      	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:139)
      	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:456)
      	at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:169)
      	at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:595)
      	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:581)
      
      [INFO] 
      [INFO] Results:
      [INFO] 
      Error:  Errors: 
      Error:    MongoDbReplicaSetAuthTest.beforeAll:49 » IllegalState An error occurred: MongoServerError: command replSetGetStatus requires authentication
      

      Attachments

        Activity

          People

            jcechace@redhat.com Jakub Čecháček
            jpechane Jiri Pechanec
            Votes:
            0 Vote for this issue
            Watchers:
            4 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: