AssertionError: Cannot start restore, another operation running: {'type': 'backup', 'opID': '66ebc327e753190681c33c86', 'name': '2024-09-19T06:22:31Z', 'startTS': 1726726951, 'status': 'copyDone'} 2024-09-19T06:22:09Z I [rs1/rs102:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:22:09Z I [rs1/rs101:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:22:09Z I [rs1/rs101:27017] starting PITR routine 2024-09-19T06:22:09Z I [rs1/rs102:27017] starting PITR routine 2024-09-19T06:22:09Z I [rs1/rs104:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:22:09Z I [rs1/rs103:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:22:09Z I [rs1/rs103:27017] starting PITR routine 2024-09-19T06:22:09Z I [rs1/rs101:27017] node: rs1/rs101:27017 2024-09-19T06:22:09Z I [rs1/rs104:27017] node: rs1/rs104:27017 2024-09-19T06:22:09Z I [rs1/rs103:27017] node: rs1/rs103:27017 2024-09-19T06:22:09Z I [rs1/rs102:27017] node: rs1/rs102:27017 2024-09-19T06:22:09Z I [rs1/rs101:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:22:09Z I [rs1/rs103:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:22:09Z I [rs1/rs102:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:22:09Z I [rs1/rs104:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:22:09Z I [rs1/rs101:27017] listening for the commands 2024-09-19T06:22:09Z I [rs1/rs103:27017] listening for the commands 2024-09-19T06:22:09Z I [rs1/rs102:27017] listening for the commands 2024-09-19T06:22:09Z I [rs1/rs104:27017] listening for the commands 2024-09-19T06:22:14Z W [rs1/rs101:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:22:14Z W [rs1/rs104:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:22:14Z W [rs1/rs103:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:22:14Z E [rs1/rs104:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:14Z E [rs1/rs101:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:14Z W [rs1/rs102:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:22:14Z E [rs1/rs103:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:14Z E [rs1/rs102:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:19Z E [rs1/rs104:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:19Z E [rs1/rs101:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:19Z E [rs1/rs103:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:19Z E [rs1/rs102:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:22:21Z I [rs1/rs101:27017] got command resync <ts: 1726726940> 2024-09-19T06:22:21Z I [rs1/rs103:27017] got command resync <ts: 1726726940> 2024-09-19T06:22:21Z I [rs1/rs102:27017] got command resync <ts: 1726726940> 2024-09-19T06:22:21Z I [rs1/rs101:27017] got epoch {1726726939 8} 2024-09-19T06:22:21Z I [rs1/rs103:27017] got epoch {1726726939 8} 2024-09-19T06:22:21Z I [rs1/rs104:27017] got command resync <ts: 1726726940> 2024-09-19T06:22:21Z I [rs1/rs102:27017] got epoch {1726726939 8} 2024-09-19T06:22:21Z I [rs1/rs104:27017] got epoch {1726726939 8} 2024-09-19T06:22:21Z D [rs1/rs102:27017] [resync] lock not acquired 2024-09-19T06:22:21Z D [rs1/rs103:27017] [resync] lock not acquired 2024-09-19T06:22:21Z I [rs1/rs101:27017] [resync] started 2024-09-19T06:22:21Z D [rs1/rs104:27017] [resync] lock not acquired 2024-09-19T06:22:21Z D [rs1/rs101:27017] [resync] uploading ".pbm.init" [size hint: 5 (5.00B); part size: 10485760 (10.00MB)] 2024-09-19T06:22:21Z D [rs1/rs101:27017] [resync] got backups list: 0 2024-09-19T06:22:21Z D [rs1/rs101:27017] [resync] got physical restores list: 0 2024-09-19T06:22:21Z D [rs1/rs101:27017] [resync] epoch set to {1726726941 20} 2024-09-19T06:22:21Z I [rs1/rs101:27017] [resync] succeed 2024-09-19T06:22:31Z I [rs1/rs101:27017] got command backup [name: 2024-09-19T06:22:31Z, compression: s2 (level: default)] <ts: 1726726951> 2024-09-19T06:22:31Z I [rs1/rs103:27017] got command backup [name: 2024-09-19T06:22:31Z, compression: s2 (level: default)] <ts: 1726726951> 2024-09-19T06:22:31Z I [rs1/rs101:27017] got epoch {1726726941 20} 2024-09-19T06:22:31Z I [rs1/rs103:27017] got epoch {1726726941 20} 2024-09-19T06:22:31Z I [rs1/rs104:27017] got command backup [name: 2024-09-19T06:22:31Z, compression: s2 (level: default)] <ts: 1726726951> 2024-09-19T06:22:31Z I [rs1/rs102:27017] got command backup [name: 2024-09-19T06:22:31Z, compression: s2 (level: default)] <ts: 1726726951> 2024-09-19T06:22:31Z I [rs1/rs104:27017] got epoch {1726726941 20} 2024-09-19T06:22:31Z I [rs1/rs102:27017] got epoch {1726726941 20} 2024-09-19T06:22:31Z D [rs1/rs101:27017] [backup/2024-09-19T06:22:31Z] init backup meta 2024-09-19T06:22:31Z D [rs1/rs101:27017] [backup/2024-09-19T06:22:31Z] nomination list for rs1: [[rs103:27017] [rs102:27017] [rs101:27017]] 2024-09-19T06:22:31Z D [rs1/rs101:27017] [backup/2024-09-19T06:22:31Z] nomination rs1, set candidates [rs103:27017] 2024-09-19T06:22:32Z I [rs1/rs103:27017] [backup/2024-09-19T06:22:31Z] backup started 2024-09-19T06:22:32Z D [rs1/rs101:27017] [backup/2024-09-19T06:22:31Z] skip after nomination, probably started by another node 2024-09-19T06:22:32Z D [rs1/rs104:27017] [backup/2024-09-19T06:22:31Z] skip after nomination, probably started by another node 2024-09-19T06:22:32Z D [rs1/rs102:27017] [backup/2024-09-19T06:22:31Z] skip after nomination, probably started by another node 2024-09-19T06:22:33Z D [rs1/rs103:27017] [backup/2024-09-19T06:22:31Z] backup cursor id: d8867a67-3d84-4909-ad2a-b16c3d02361c 2024-09-19T06:22:36Z D [rs1/rs103:27017] [backup/2024-09-19T06:22:31Z] set journal up to {1726726953 1} 2024-09-19T06:22:36Z D [rs1/rs101:27017] [backup/2024-09-19T06:22:31Z] bcp nomination: rs1 won by rs103:27017

AssertionError: Cannot start restore, another operation running: {'type': 'backup', 'opID': '66ebc7b2ec1dfbe3445c83fc', 'name': '2024-09-19T06:41:54Z', 'startTS': 1726728115, 'status': 'copyDone'} 2024-09-19T06:41:43Z I [rs1/rs102:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:41:43Z I [rs1/rs101:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:41:43Z I [rs1/rs101:27017] starting PITR routine 2024-09-19T06:41:43Z I [rs1/rs103:27017] starting PITR routine 2024-09-19T06:41:43Z I [rs1/rs103:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:41:43Z I [rs1/rs102:27017] starting PITR routine 2024-09-19T06:41:43Z I [rs1/rs101:27017] node: rs1/rs101:27017 2024-09-19T06:41:43Z I [rs1/rs102:27017] node: rs1/rs102:27017 2024-09-19T06:41:43Z I [rs1/rs103:27017] node: rs1/rs103:27017 2024-09-19T06:41:43Z I [rs1/rs101:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:41:43Z I [rs1/rs103:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:41:43Z I [rs1/rs102:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:41:43Z I [rs1/rs101:27017] listening for the commands 2024-09-19T06:41:43Z I [rs1/rs103:27017] listening for the commands 2024-09-19T06:41:43Z I [rs1/rs102:27017] listening for the commands 2024-09-19T06:41:48Z W [rs1/rs103:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:41:48Z W [rs1/rs102:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:41:48Z W [rs1/rs101:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:41:48Z E [rs1/rs103:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:41:48Z E [rs1/rs102:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:41:48Z E [rs1/rs101:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:41:50Z I [rs1/rs101:27017] got command resync <ts: 1726728109> 2024-09-19T06:41:50Z I [rs1/rs103:27017] got command resync <ts: 1726728109> 2024-09-19T06:41:50Z I [rs1/rs102:27017] got command resync <ts: 1726728109> 2024-09-19T06:41:50Z I [rs1/rs103:27017] got epoch {1726728108 12} 2024-09-19T06:41:50Z I [rs1/rs101:27017] got epoch {1726728108 12} 2024-09-19T06:41:50Z I [rs1/rs102:27017] got epoch {1726728108 12} 2024-09-19T06:41:50Z D [rs1/rs102:27017] [resync] lock not acquired 2024-09-19T06:41:50Z D [rs1/rs101:27017] [resync] lock not acquired 2024-09-19T06:41:50Z I [rs1/rs103:27017] [resync] started 2024-09-19T06:41:50Z D [rs1/rs103:27017] [resync] uploading ".pbm.init" [size hint: 5 (5.00B); part size: 10485760 (10.00MB)] 2024-09-19T06:41:50Z D [rs1/rs103:27017] [resync] got backups list: 0 2024-09-19T06:41:50Z D [rs1/rs103:27017] [resync] got physical restores list: 2 2024-09-19T06:41:50Z D [rs1/rs103:27017] [resync] epoch set to {1726728110 19} 2024-09-19T06:41:50Z I [rs1/rs103:27017] [resync] succeed 2024-09-19T06:41:55Z I [rs1/rs101:27017] got command backup [name: 2024-09-19T06:41:54Z, compression: s2 (level: default)] <ts: 1726728114> 2024-09-19T06:41:55Z I [rs1/rs103:27017] got command backup [name: 2024-09-19T06:41:54Z, compression: s2 (level: default)] <ts: 1726728114> 2024-09-19T06:41:55Z I [rs1/rs102:27017] got command backup [name: 2024-09-19T06:41:54Z, compression: s2 (level: default)] <ts: 1726728114> 2024-09-19T06:41:55Z I [rs1/rs101:27017] got epoch {1726728110 19} 2024-09-19T06:41:55Z I [rs1/rs103:27017] got epoch {1726728110 19} 2024-09-19T06:41:55Z I [rs1/rs102:27017] got epoch {1726728110 19} 2024-09-19T06:41:55Z D [rs1/rs101:27017] [backup/2024-09-19T06:41:54Z] init backup meta 2024-09-19T06:41:55Z D [rs1/rs101:27017] [backup/2024-09-19T06:41:54Z] nomination list for rs1: [[rs103:27017 rs102:27017] [rs101:27017]] 2024-09-19T06:41:55Z D [rs1/rs101:27017] [backup/2024-09-19T06:41:54Z] nomination rs1, set candidates [rs103:27017 rs102:27017] 2024-09-19T06:41:55Z D [rs1/rs102:27017] [backup/2024-09-19T06:41:54Z] skip: lock not acquired 2024-09-19T06:41:55Z I [rs1/rs103:27017] [backup/2024-09-19T06:41:54Z] backup started 2024-09-19T06:41:56Z D [rs1/rs101:27017] [backup/2024-09-19T06:41:54Z] skip after nomination, probably started by another node 2024-09-19T06:41:56Z D [rs1/rs103:27017] [backup/2024-09-19T06:41:54Z] backup cursor id: b1a397cd-a1fc-4e35-9cb6-fedc8a67531d 2024-09-19T06:41:59Z D [rs1/rs103:27017] [backup/2024-09-19T06:41:54Z] set journal up to {1726728116 2} 2024-09-19T06:42:00Z D [rs1/rs101:27017] [backup/2024-09-19T06:41:54Z] bcp nomination: rs1 won by rs103:27017

Process completed with exit code 1.

AssertionError: Cannot start restore, another operation running: {'type': 'backup', 'opID': '66ebc824956cc301fe05ba0a', 'name': '2024-09-19T06:43:48Z', 'startTS': 1726728229, 'status': 'copyDone'} 2024-09-19T06:43:37Z I [rs1/rs103:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:43:37Z I [rs1/rs101:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:43:37Z I [rs1/rs103:27017] starting PITR routine 2024-09-19T06:43:37Z I [rs1/rs101:27017] starting PITR routine 2024-09-19T06:43:37Z I [rs1/rs102:27017] pbm-agent: Version: 2.6.0 Platform: linux/amd64 GitCommit: 4e467842b7e52c2892ff69bd24dac19a231db215 GitBranch: dev BuildTime: 2024-09-19_06:21_UTC GoVersion: go1.23.1 2024-09-19T06:43:37Z I [rs1/rs102:27017] starting PITR routine 2024-09-19T06:43:37Z I [rs1/rs102:27017] node: rs1/rs102:27017 2024-09-19T06:43:37Z I [rs1/rs101:27017] node: rs1/rs101:27017 2024-09-19T06:43:37Z I [rs1/rs103:27017] node: rs1/rs103:27017 2024-09-19T06:43:37Z I [rs1/rs102:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:43:37Z I [rs1/rs101:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:43:37Z I [rs1/rs103:27017] conn level ReadConcern: majority; WriteConcern: majority 2024-09-19T06:43:37Z I [rs1/rs102:27017] listening for the commands 2024-09-19T06:43:37Z I [rs1/rs103:27017] listening for the commands 2024-09-19T06:43:37Z I [rs1/rs101:27017] listening for the commands 2024-09-19T06:43:42Z W [rs1/rs101:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:43:42Z W [rs1/rs102:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:43:42Z W [rs1/rs103:27017] [agentCheckup] get current storage status: query mongo: mongo: no documents in result 2024-09-19T06:43:42Z E [rs1/rs101:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:43:42Z E [rs1/rs102:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:43:42Z E [rs1/rs103:27017] [agentCheckup] check storage connection: unable to get storage: get config: get: mongo: no documents in result 2024-09-19T06:43:44Z I [rs1/rs103:27017] got command resync <ts: 1726728223> 2024-09-19T06:43:44Z I [rs1/rs102:27017] got command resync <ts: 1726728223> 2024-09-19T06:43:44Z I [rs1/rs101:27017] got command resync <ts: 1726728223> 2024-09-19T06:43:44Z I [rs1/rs103:27017] got epoch {1726728222 12} 2024-09-19T06:43:44Z I [rs1/rs102:27017] got epoch {1726728222 12} 2024-09-19T06:43:44Z I [rs1/rs101:27017] got epoch {1726728222 12} 2024-09-19T06:43:44Z D [rs1/rs103:27017] [resync] lock not acquired 2024-09-19T06:43:44Z D [rs1/rs101:27017] [resync] lock not acquired 2024-09-19T06:43:44Z I [rs1/rs102:27017] [resync] started 2024-09-19T06:43:44Z D [rs1/rs102:27017] [resync] uploading ".pbm.init" [size hint: 5 (5.00B); part size: 10485760 (10.00MB)] 2024-09-19T06:43:44Z D [rs1/rs102:27017] [resync] got backups list: 0 2024-09-19T06:43:44Z D [rs1/rs102:27017] [resync] got physical restores list: 3 2024-09-19T06:43:44Z D [rs1/rs102:27017] [resync] epoch set to {1726728224 21} 2024-09-19T06:43:44Z I [rs1/rs102:27017] [resync] succeed 2024-09-19T06:43:49Z I [rs1/rs103:27017] got command backup [name: 2024-09-19T06:43:48Z, compression: s2 (level: default)] <ts: 1726728228> 2024-09-19T06:43:49Z I [rs1/rs102:27017] got command backup [name: 2024-09-19T06:43:48Z, compression: s2 (level: default)] <ts: 1726728228> 2024-09-19T06:43:49Z I [rs1/rs103:27017] got epoch {1726728224 21} 2024-09-19T06:43:49Z I [rs1/rs101:27017] got command backup [name: 2024-09-19T06:43:48Z, compression: s2 (level: default)] <ts: 1726728228> 2024-09-19T06:43:49Z I [rs1/rs102:27017] got epoch {1726728224 21} 2024-09-19T06:43:49Z I [rs1/rs101:27017] got epoch {1726728224 21} 2024-09-19T06:43:49Z D [rs1/rs101:27017] [backup/2024-09-19T06:43:48Z] init backup meta 2024-09-19T06:43:49Z D [rs1/rs101:27017] [backup/2024-09-19T06:43:48Z] nomination list for rs1: [[rs102:27017 rs103:27017] [rs101:27017]] 2024-09-19T06:43:49Z D [rs1/rs101:27017] [backup/2024-09-19T06:43:48Z] nomination rs1, set candidates [rs102:27017 rs103:27017] 2024-09-19T06:43:49Z D [rs1/rs102:27017] [backup/2024-09-19T06:43:48Z] skip: lock not acquired 2024-09-19T06:43:49Z I [rs1/rs103:27017] [backup/2024-09-19T06:43:48Z] backup started 2024-09-19T06:43:49Z D [rs1/rs101:27017] [backup/2024-09-19T06:43:48Z] skip after nomination, probably started by another node 2024-09-19T06:43:50Z D [rs1/rs103:27017] [backup/2024-09-19T06:43:48Z] backup cursor id: 9dab7be2-f16a-482a-9b5c-986d2b317543 2024-09-19T06:43:53Z D [rs1/rs103:27017] [backup/2024-09-19T06:43:48Z] set journal up to {1726728230 1} 2024-09-19T06:43:54Z D [rs1/rs101:27017] [backup/2024-09-19T06:43:48Z] bcp nomination: rs1 won by rs103:27017

Process completed with exit code 1.

AssertionError: Starting restore 2024-09-19T06:49:37.848614449Z to point-in-time 2024-09-19T06:48:03 from '2024-09-19T06:46:40Z'...Started logical restore. Waiting to finish....Error: operation failed with: reply oplog: replay chunk 1726728404.1726728481: apply oplog for chunk: applying a transaction entry: apply txn: { "Timestamp": { "T": 1726728452, "I": 2 }, "Term": 1, "Hash": null, "Version": 2, "Operation": "c", "Namespace": "admin.$cmd", "Object": [ { "Key": "applyOps", "Value": [ [ { "Key": "op", "Value": "c" }, { "Key": "ns", "Value": "config.$cmd" }, { "Key": "ui", "Value": { "Subtype": 4, "Data": "h+qt+AL9Tk68m8FBToRbEA==" } }, { "Key": "o", "Value": [ { "Key": "create", "Value": "databases" }, { "Key": "idIndex", "Value": [ { "Key": "v", "Value": 2 }, { "Key": "key", "Value": [ { "Key": "_id", "Value": 1 } ] }, { "Key": "name", "Value": "_id_" } ] } ] } ], [ { "Key": "op", "Value": "i" }, { "Key": "ns", "Value": "config.databases" }, { "Key": "ui", "Value": { "Subtype": 4, "Data": "h+qt+AL9Tk68m8FBToRbEA==" } }, { "Key": "o", "Value": [ { "Key": "_id", "Value": "test" }, { "Key": "primary", "Value": "rs2" }, { "Key": "partitioned", "Value": false }, { "Key": "version", "Value": [ { "Key": "uuid", "Value": { "Subtype": 4, "Data": "xX7fF7A4R0mUVZns82XteA==" } }, { "Key": "timestamp", "Value": { "T": 1726728451, "I": 15 } }, { "Key": "lastMod", "Value": 1 } ] } ] }, { "Key": "o2", "Value": [ { "Key": "_id", "Value": "test" } ] } ], [ { "Key": "op", "Value": "i" }, { "Key": "ns", "Value": "config.placementHistory" }, { "Key": "ui", "Value": { "Subtype": 4, "Data": "lcfVS94QTueJt9mz7nH6+w==" } }, { "Key": "o", "Value": [ { "Key": "_id", "Value": "66ebc904dcff9147ec748a65" }, { "Key": "nss", "Value": "test" }, { "Key": "timestamp", "Value": { "T": 1726728451, "I": 15 } }, { "Key": "shards", "Value": [ "rs2" ] } ] }, { "Key": "o2", "Value": [ { "Key": "_id", "Value": "66ebc904dcff9147ec748a65" } ] } ] ] } ], "Query": null, "UI": null, "LSID": "ZgAAAAVpZAAQAAAABFjqQsBt3EJvkm/lJ+YU5/wFdWlkACAAAAAAY5mrDaxi8gv8RmdTsQ+1j7fmkr7JUsabhNmXAheU0fgFdHhuVVVJRAAQAAAABGRTLswpB0xDvixa+7/VOr4A", "TxnNumber": 0, "PrevOpTime": "HAAAABF0cwAAAAAAAAAAABJ0AP//////////AA==", "MultiOpType": null }: applying transaction op: op: {"Timestamp":{"T":1726728452,"I":2},"Term":1,"Hash":null,"Version":0,"Operation":"i","Namespace":"config.databases","Object":[{"Key":"_id","Value":"test"},{"Key":"primary","Value":"rs2"},{"Key":"partitioned","Value":false},{"Key":"version","Value":[{"Key":"uuid","Value":{"Subtype":4,"Data":"xX7fF7A4R0mUVZns82XteA=="}},{"Key":"timestamp","Value":{"T":1726728451,"I":15}},{"Key":"lastMod","Value":1}]}],"Query":[{"Key":"_id","Value":"test"}],"UI":{"Subtype":4,"Data":"h+qt+AL9Tk68m8FBToRbEA=="},"LSID":null,"TxnNumber":null,"PrevOpTime":null,"MultiOpType":null} | merr <nil>: applyOps: (UnknownError) applyOps had one or more errors applying ops

Process completed with exit code 1.

AssertionError: Starting restore 2024-09-19T06:49:42.078119554Z to point-in-time 2024-09-19T06:48:11 from '2024-09-19T06:46:48Z'...Started logical restore. Waiting to finish....Error: operation failed with: reply oplog: replay chunk 1726728411.1726728489: apply oplog for chunk: applying an entry: op: {"Timestamp":{"T":1726728460,"I":2},"Term":1,"Hash":null,"Version":2,"Operation":"i","Namespace":"config.databases","Object":[{"Key":"_id","Value":"test"},{"Key":"primary","Value":"rs2"},{"Key":"partitioned","Value":true},{"Key":"version","Value":[{"Key":"uuid","Value":{"Subtype":4,"Data":"oF+WWVtbQKqaOi4C1IG3JQ=="}},{"Key":"timestamp","Value":{"T":1726728459,"I":15}},{"Key":"lastMod","Value":1}]}],"Query":null,"UI":{"Subtype":4,"Data":"Zou1EyCoQ2akn0UV7ryggQ=="},"LSID":null,"TxnNumber":null,"PrevOpTime":null,"MultiOpType":null} | merr <nil>: applyOps: (NamespaceNotFound) cannot apply insert or update operation on a non-existent namespace config.databases: { ts: Timestamp(1726728460, 2), t: 1, v: 2, op: "i", ns: "config.databases", o: { _id: "test", primary: "rs2", partitioned: true, version: { uuid: UUID("a05f9659-5b5b-40aa-9a3a-2e02d481b725"), timestamp: Timestamp(1726728459, 15), lastMod: 1 } }, ui: UUID("668bb513-20a8-4366-a49f-4515eebca081") }

Process completed with exit code 1.

AssertionError: Starting restore 2024-09-19T06:49:50.878884389Z to point-in-time 2024-09-19T06:48:13 from '2024-09-19T06:46:49Z'...Started logical restore. Waiting to finish....Error: operation failed with: reply oplog: replay chunk 1726728413.1726728491: apply oplog for chunk: applying an entry: op: {"Timestamp":{"T":1726728461,"I":17},"Term":1,"Hash":null,"Version":2,"Operation":"i","Namespace":"config.databases","Object":[{"Key":"_id","Value":"test"},{"Key":"primary","Value":"rs2"},{"Key":"partitioned","Value":false},{"Key":"version","Value":[{"Key":"uuid","Value":{"Subtype":4,"Data":"8vpkTFEXR0q+bjPKEhiV8w=="}},{"Key":"timestamp","Value":{"T":1726728461,"I":15}},{"Key":"lastMod","Value":1}]}],"Query":[{"Key":"_id","Value":"test"}],"UI":{"Subtype":4,"Data":"k6Urx7zbTL2UDTHpkzDVRA=="},"LSID":null,"TxnNumber":null,"PrevOpTime":null,"MultiOpType":null} | merr <nil>: applyOps: (NamespaceNotFound) cannot apply insert or update operation on a non-existent namespace config.databases: { ts: Timestamp(1726728461, 17), t: 1, v: 2, op: "i", ns: "config.databases", o: { _id: "test", primary: "rs2", partitioned: false, version: { uuid: UUID("f2fa644c-5117-474a-be6e-33ca121895f3"), timestamp: Timestamp(1726728461, 15), lastMod: 1 } }, o2: { _id: "test" }, ui: UUID("93a52bc7-bcdb-4cbd-940d-31e99330d544") }

Process completed with exit code 1.

AssertionError: Unexpected exit code 1 for CommandResult(backend=<testinfra.backend.docker.DockerBackend object at 0x7fe492434e10>, exit_status=1, command=b'supervisorctl start mongod-ce', _stdout=b'mongod-ce: ERROR (no such file)\n', _stderr=b'') assert 1 == 0 + where 1 = CommandResult(backend=<testinfra.backend.docker.DockerBackend object at 0x7fe492434e10>, exit_status=1, command=b'supervisorctl start mongod-ce', _stdout=b'mongod-ce: ERROR (no such file)\n', _stderr=b'').rc