AssertionError: Backup failed{"Error":"get backup metadata: get: context deadline exceeded"} 2024-09-09T16:29:14Z I [rs1/rs103:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:14Z I [rs2/rs201:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:14Z I [rs1/rs101:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:14Z I [rs2/rs201:27017] starting PITR routine 2024-09-09T16:29:14Z I [rs1/rs103:27017] starting PITR routine 2024-09-09T16:29:14Z I [rs1/rs101:27017] starting PITR routine 2024-09-09T16:29:14Z I [rs1/rs102:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:14Z I [rs1/rs102:27017] starting PITR routine 2024-09-09T16:29:14Z I [rs1/rs101:27017] node: rs1/rs101:27017 2024-09-09T16:29:14Z I [rs2/rs201:27017] node: rs2/rs201:27017 2024-09-09T16:29:14Z I [rs1/rs102:27017] node: rs1/rs102:27017 2024-09-09T16:29:14Z I [rs2/rs201:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:14Z I [rs1/rs101:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:14Z I [rs1/rs103:27017] node: rs1/rs103:27017 2024-09-09T16:29:14Z I [rs2/rs201:27017] listening for the commands 2024-09-09T16:29:14Z I [rs1/rs102:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:14Z I [rs1/rs103:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:14Z I [rs1/rs101:27017] listening for the commands 2024-09-09T16:29:14Z I [rs1/rs102:27017] listening for the commands 2024-09-09T16:29:14Z I [rs1/rs103:27017] listening for the commands 2024-09-09T16:29:16Z I [rscfg/rscfg01:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:16Z I [rscfg/rscfg01:27017] starting PITR routine 2024-09-09T16:29:16Z I [rscfg/rscfg01:27017] node: rscfg/rscfg01:27017 2024-09-09T16:29:16Z I [rscfg/rscfg01:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:16Z I [rscfg/rscfg01:27017] listening for the commands 2024-09-09T16:29:16Z I [rscfg/rscfg02:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:16Z I [rscfg/rscfg02:27017] starting PITR routine 2024-09-09T16:29:16Z I [rscfg/rscfg02:27017] node: rscfg/rscfg02:27017 2024-09-09T16:29:16Z I [rscfg/rscfg02:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:16Z I [rs2/rs203:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:16Z I [rs2/rs203:27017] starting PITR routine 2024-09-09T16:29:16Z I [rscfg/rscfg02:27017] listening for the commands 2024-09-09T16:29:16Z I [rs2/rs203:27017] node: rs2/rs203:27017 2024-09-09T16:29:16Z I [rs2/rs202:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:16Z I [rs2/rs202:27017] starting PITR routine 2024-09-09T16:29:16Z I [rs2/rs203:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:16Z I [rs2/rs203:27017] listening for the commands 2024-09-09T16:29:16Z I [rs2/rs202:27017] node: rs2/rs202:27017 2024-09-09T16:29:16Z I [rs2/rs202:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:16Z I [rs2/rs202:27017] listening for the commands 2024-09-09T16:29:18Z I [rscfg/rscfg03:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 972b5e7cbc852e417601b9255e183ff5ba8cb6d2 GitBranch: CURRENT_PR BuildTime: 2024-09-09_15:50_UTC GoVersion: go1.22.7 2024-09-09T16:29:18Z I [rscfg/rscfg03:27017] starting PITR routine 2024-09-09T16:29:18Z I [rscfg/rscfg03:27017] node: rscfg/rscfg03:27017 2024-09-09T16:29:18Z I [rscfg/rscfg03:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-09T16:29:18Z I [rscfg/rscfg03:27017] listening for the commands 2024-09-09T16:29:19Z W [rs2/rs201:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:19Z W [rs1/rs103:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:19Z W [rs1/rs101:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:19Z W [rs1/rs102:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:19Z E [rs2/rs201:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:19Z E [rs1/rs101:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:19Z E [rs1/rs102:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:19Z E [rs1/rs103:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:21Z W [rscfg/rscfg01:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:21Z E [rscfg/rscfg01:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:21Z W [rscfg/rscfg02:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:21Z E [rscfg/rscfg02:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:21Z W [rs2/rs203:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:21Z E [rs2/rs203:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:21Z W [rs2/rs202:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:21Z E [rs2/rs202:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:23Z W [rscfg/rscfg03:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-09T16:29:23Z E [rscfg/rscfg03:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-09T16:29:24Z I [rscfg/rscfg01:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rscfg/rscfg01:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z I [rscfg/rscfg01:27017] [resync] started 2024-09-09T16:29:24Z I [rscfg/rscfg02:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rscfg/rscfg02:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z D [rscfg/rscfg02:27017] [resync] lock not acquired 2024-09-09T16:29:24Z D [rscfg/rscfg01:27017] [resync] uploading ".pbm.init" [size hint: 5 (5.00B); part size: 10485760 (10.00MB)] 2024-09-09T16:29:24Z I [rs2/rs203:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rs2/rs203:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z I [rs2/rs202:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rs2/rs203:27017] [resync] not a member of the leader rs 2024-09-09T16:29:24Z I [rs2/rs202:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z I [rs2/rs202:27017] [resync] not a member of the leader rs 2024-09-09T16:29:24Z D [rscfg/rscfg01:27017] [resync] got backups list: 0 2024-09-09T16:29:24Z D [rscfg/rscfg01:27017] [resync] got physical restores list: 4 2024-09-09T16:29:24Z I [rs2/rs201:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rs1/rs101:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rs2/rs201:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z I [rs1/rs102:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rs1/rs103:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:24Z I [rs1/rs101:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z I [rs2/rs201:27017] [resync] not a member of the leader rs 2024-09-09T16:29:24Z I [rs1/rs102:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z I [rs1/rs103:27017] got epoch {1725899364 1} 2024-09-09T16:29:24Z I [rs1/rs101:27017] [resync] not a member of the leader rs 2024-09-09T16:29:24Z I [rs1/rs102:27017] [resync] not a member of the leader rs 2024-09-09T16:29:24Z I [rs1/rs103:27017] [resync] not a member of the leader rs 2024-09-09T16:29:24Z D [rscfg/rscfg01:27017] [resync] epoch set to {1725899364 43} 2024-09-09T16:29:24Z I [rscfg/rscfg01:27017] [resync] succeed 2024-09-09T16:29:25Z I [rscfg/rscfg03:27017] got command resync <ts: 1725899364> 2024-09-09T16:29:25Z I [rscfg/rscfg03:27017] got epoch {1725899364 43} 2024-09-09T16:29:25Z D [rscfg/rscfg03:27017] [resync] get lock: duplicate operation: 66df226466d65eb7624a16ef [Resync storage] 2024-09-09T16:29:25Z D [rscfg/rscfg03:27017] [resync] lock not acquired 2024-09-09T16:29:29Z I [rs1/rs101:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:29Z I [rs2/rs201:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:29Z I [rs1/rs103:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:29Z I [rs1/rs102:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:29Z I [rs1/rs101:27017] got epoch {1725899364 43} 2024-09-09T16:29:29Z I [rs2/rs201:27017] got epoch {1725899364 43} 2024-09-09T16:29:29Z I [rs1/rs102:27017] got epoch {1725899364 43} 2024-09-09T16:29:29Z I [rs1/rs103:27017] got epoch {1725899364 43} 2024-09-09T16:29:29Z I [rs1/rs101:27017] [resync] not a member of the leader rs 2024-09-09T16:29:29Z I [rs2/rs201:27017] [resync] not a member of the leader rs 2024-09-09T16:29:29Z I [rs1/rs102:27017] [resync] not a member of the leader rs 2024-09-09T16:29:29Z I [rs1/rs103:27017] [resync] not a member of the leader rs 2024-09-09T16:29:30Z I [rscfg/rscfg03:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:30Z I [rscfg/rscfg03:27017] got epoch {1725899364 43} 2024-09-09T16:29:30Z I [rscfg/rscfg03:27017] [resync] started 2024-09-09T16:29:30Z D [rscfg/rscfg03:27017] [resync] BufferSize is set to 10485760 (~10Mb) | 5 2024-09-09T16:29:30Z D [rscfg/rscfg03:27017] [resync] got backups list: 0 2024-09-09T16:29:30Z D [rscfg/rscfg03:27017] [resync] got physical restores list: 0 2024-09-09T16:29:30Z D [rscfg/rscfg03:27017] [resync] epoch set to {1725899370 49} 2024-09-09T16:29:30Z I [rscfg/rscfg03:27017] [resync] succeed 2024-09-09T16:29:30Z I [rscfg/rscfg01:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:30Z I [rscfg/rscfg01:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z D [rscfg/rscfg01:27017] [resync] get lock: duplicate operation: 66df22698abecc1af86c88cf [Resync storage] 2024-09-09T16:29:30Z D [rscfg/rscfg01:27017] [resync] lock not acquired 2024-09-09T16:29:30Z I [rscfg/rscfg02:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:30Z I [rscfg/rscfg01:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rscfg/rscfg02:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rscfg/rscfg01:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z E [rscfg/rscfg01:27017] [backup/2024-09-09T16:29:30Z] unable to proceed with the backup, active lock is present 2024-09-09T16:29:30Z D [rscfg/rscfg02:27017] [resync] get lock: duplicate operation: 66df22698abecc1af86c88cf [Resync storage] 2024-09-09T16:29:30Z I [rs2/rs203:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:30Z D [rscfg/rscfg02:27017] [resync] lock not acquired 2024-09-09T16:29:30Z I [rs2/rs203:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rscfg/rscfg02:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rs2/rs202:27017] got command resync <ts: 1725899369> 2024-09-09T16:29:30Z I [rs2/rs203:27017] [resync] not a member of the leader rs 2024-09-09T16:29:30Z I [rscfg/rscfg02:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rs2/rs203:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rs2/rs202:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rs2/rs203:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rs2/rs202:27017] [resync] not a member of the leader rs 2024-09-09T16:29:30Z I [rs2/rs202:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rs2/rs202:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rs1/rs101:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rs2/rs201:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rs1/rs101:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rs1/rs103:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rs1/rs102:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:30Z I [rs2/rs201:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rs1/rs102:27017] got epoch {1725899370 49} 2024-09-09T16:29:30Z I [rs1/rs103:27017] got epoch {1725899370 49} 2024-09-09T16:29:31Z I [rscfg/rscfg03:27017] got command backup [name: 2024-09-09T16:29:30Z, compression: s2 (level: default)] <ts: 1725899370> 2024-09-09T16:29:31Z I [rscfg/rscfg03:27017] got epoch {1725899370 49} 2024-09-09T16:29:45Z D [rscfg/rscfg02:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:45Z D [rscfg/rscfg02:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node 2024-09-09T16:29:45Z D [rs2/rs203:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:45Z D [rs2/rs203:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node 2024-09-09T16:29:45Z D [rs2/rs202:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:45Z D [rs2/rs202:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node 2024-09-09T16:29:45Z D [rs1/rs101:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:45Z D [rs2/rs201:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:45Z D [rs1/rs101:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node 2024-09-09T16:29:45Z D [rs1/rs102:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:45Z D [rs2/rs201:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node 2024-09-09T16:29:45Z D [rs1/rs103:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:45Z D [rs1/rs102:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node 2024-09-09T16:29:45Z D [rs1/rs103:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node 2024-09-09T16:29:46Z D [rscfg/rscfg03:27017] [backup/2024-09-09T16:29:30Z] nomination timeout 2024-09-09T16:29:46Z D [rscfg/rscfg03:27017] [backup/2024-09-09T16:29:30Z] skip after nomination, probably started by another node

The following actions use a deprecated Node.js version and will be forced to run on node20: github/codeql-action/upload-sarif@v2. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/