AssertionError: Starting restore 2024-04-10T14:35:41.986308767Z from '2024-04-10T14:35:25Z'..........................Started physical restore. Waiting to finish..................................................................................................................................................................................................................... {"t":{"$date":"2024-04-10T14:36:27.618+00:00"},"s":"I", "c":"NETWORK", "id":4915701, "ctx":"-","msg":"Initialized wire specification","attr":{"spec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":13},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":13},"outgoing":{"minWireVersion":0,"maxWireVersion":13},"isInternalClient":true}}} {"t":{"$date":"2024-04-10T14:36:27.621+00:00"},"s":"I", "c":"CONTROL", "id":23285, "ctx":"-","msg":"Automatically disabling TLS 1.0, to force-enable TLS 1.0 specify --sslDisabledProtocols 'none'"} {"t":{"$date":"2024-04-10T14:36:27.621+00:00"},"s":"W", "c":"ASIO", "id":22601, "ctx":"main","msg":"No TransportLayer configured during NetworkInterface startup"} {"t":{"$date":"2024-04-10T14:36:27.621+00:00"},"s":"I", "c":"NETWORK", "id":4648601, "ctx":"main","msg":"Implicit TCP FastOpen unavailable. If TCP FastOpen is required, set tcpFastOpenServer, tcpFastOpenClient, and tcpFastOpenQueueSize."} {"t":{"$date":"2024-04-10T14:36:27.622+00:00"},"s":"W", "c":"ASIO", "id":22601, "ctx":"main","msg":"No TransportLayer configured during NetworkInterface startup"} {"t":{"$date":"2024-04-10T14:36:27.622+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"main","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationDonorService","ns":"config.tenantMigrationDonors"}} {"t":{"$date":"2024-04-10T14:36:27.622+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"main","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationRecipientService","ns":"config.tenantMigrationRecipients"}} {"t":{"$date":"2024-04-10T14:36:27.622+00:00"},"s":"I", "c":"CONTROL", "id":5945603, "ctx":"main","msg":"Multi threading initialized"} {"t":{"$date":"2024-04-10T14:36:27.622+00:00"},"s":"I", "c":"CONTROL", "id":4615611, "ctx":"initandlisten","msg":"MongoDB starting","attr":{"pid":286,"port":27617,"dbPath":"/var/lib/mongo","architecture":"64-bit","host":"rs103"}} {"t":{"$date":"2024-04-10T14:36:27.622+00:00"},"s":"I", "c":"CONTROL", "id":23403, "ctx":"initandlisten","msg":"Build Info","attr":{"buildInfo":{"version":"5.0.26-22","gitVersion":"565331dec31cc2affadd67913bef70906134aedc","openSSLVersion":"OpenSSL 1.1.1k FIPS 25 Mar 2021","modules":[],"allocator":"tcmalloc","environment":{"distarch":"x86_64","target_arch":"x86_64"}}}} {"t":{"$date":"2024-04-10T14:36:27.623+00:00"},"s":"I", "c":"CONTROL", "id":51765, "ctx":"initandlisten","msg":"Operating System","attr":{"os":{"name":"Oracle Linux Server release 8.9","version":"Kernel 6.5.0-1017-azure"}}} {"t":{"$date":"2024-04-10T14:36:27.623+00:00"},"s":"I", "c":"CONTROL", "id":21951, "ctx":"initandlisten","msg":"Options set by command line","attr":{"options":{"config":"/tmp/pbmMongdTmpConf3501313652","net":{"bindIp":"localhost","port":27617},"setParameter":{"recoverFromOplogAsStandalone":"true","takeUnstableCheckpointOnShutdown":"true"},"storage":{"dbPath":"/var/lib/mongo","directoryPerDB":false,"wiredTiger":{"collectionConfig":{"blockCompressor":"snappy"},"engineConfig":{"directoryForIndexes":false,"journalCompressor":"snappy"},"indexConfig":{"prefixCompression":true}}},"systemLog":{"destination":"file","path":"/var/lib/mongo/pbm.restore.log"}}}} {"t":{"$date":"2024-04-10T14:36:27.623+00:00"},"s":"I", "c":"STORAGE", "id":22270, "ctx":"initandlisten","msg":"Storage engine to use detected by data files","attr":{"dbpath":"/var/lib/mongo","storageEngine":"wiredTiger"}} {"t":{"$date":"2024-04-10T14:36:27.623+00:00"},"s":"I", "c":"STORAGE", "id":22315, "ctx":"initandlisten","msg":"Opening WiredTiger","attr":{"config":"create,cache_size=7478M,session_max=33000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,archive=true,path=journal,compressor=snappy),builtin_extension_config=(zstd=(compression_level=6)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=2000),statistics_log=(wait=0),verbose=[recovery_progress,checkpoint_progress,compact_progress],"}} {"t":{"$date":"2024-04-10T14:36:27.764+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:764109][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 8 through 9"}} {"t":{"$date":"2024-04-10T14:36:27.790+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:790837][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 9 through 9"}} {"t":{"$date":"2024-04-10T14:36:27.850+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:850772][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_ALL] Main recovery loop: starting at 8/60288 to 9/256"}} {"t":{"$date":"2024-04-10T14:36:27.902+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:902270][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 8 through 9"}} {"t":{"$date":"2024-04-10T14:36:27.938+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:938112][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 9 through 9"}} {"t":{"$date":"2024-04-10T14:36:27.965+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:965828][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] recovery log replay has successfully finished and ran for 201 milliseconds"}} {"t":{"$date":"2024-04-10T14:36:27.965+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:965919][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_ALL] Set global recovery timestamp: (1712759688, 3)"}} {"t":{"$date":"2024-04-10T14:36:27.965+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:965948][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_ALL] Set global oldest timestamp: (1712759388, 3)"}} {"t":{"$date":"2024-04-10T14:36:27.967+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:967018][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] recovery rollback to stable has successfully finished and ran for 1 milliseconds"}} {"t":{"$date":"2024-04-10T14:36:27.976+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:976056][286:0x7f311cc09c00], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 1, snapshot max: 1 snapshot count: 0, oldest timestamp: (1712759388, 3) , meta checkpoint timestamp: (1712759688, 3) base write gen: 65"}} {"t":{"$date":"2024-04-10T14:36:27.979+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:979039][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] recovery checkpoint has successfully finished and ran for 10 milliseconds"}} {"t":{"$date":"2024-04-10T14:36:27.979+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1712759787:979090][286:0x7f311cc09c00], txn-recover: [WT_VERB_RECOVERY_PROGRESS] recovery was completed successfully and took 215ms, including 201ms for the log replay, 1ms for the rollback to stable, and 10ms for the checkpoint."}} {"t":{"$date":"2024-04-10T14:36:27.979+00:00"},"s":"I", "c":"STORAGE", "id":4795906, "ctx":"initandlisten","msg":"WiredTiger opened","attr":{"durationMillis":355}} {"t":{"$date":"2024-04-10T14:36:27.979+00:00"},"s":"I", "c":"RECOVERY", "id":23987, "ctx":"initandlisten","msg":"WiredTiger recoveryTimestamp","attr":{"recoveryTimestamp":{"$timestamp":{"t":1712759688,"i":3}}}} {"t":{"$date":"2024-04-10T14:36:27.979+00:00"},"s":"I", "c":"RECOVERY", "id":5380106, "ctx":"initandlisten","msg":"WiredTiger oldestTimestamp","attr":{"oldestTimestamp":{"$timestamp":{"t":1712759388,"i":3}}}} {"t":{"$date":"2024-04-10T14:36:28.004+00:00"},"s":"I", "c":"STORAGE", "id":22262, "ctx":"initandlisten","msg":"Timestamp monitor starting"} {"t":{"$date":"2024-04-10T14:36:28.005+00:00"},"s":"W", "c":"CONTROL", "id":22120, "ctx":"initandlisten","msg":"Access control is not enabled for the database. Read and write access to data and configuration is unrestricted. You can use percona-server-mongodb-enable-auth.sh to fix it","tags":["startupWarnings"]} {"t":{"$date":"2024-04-10T14:36:28.005+00:00"},"s":"W", "c":"CONTROL", "id":22178, "ctx":"initandlisten","msg":"/sys/kernel/mm/transparent_hugepage/enabled is 'always'. We suggest setting it to 'never' in this binary version","tags":["startupWarnings"]} {"t":{"$date":"2024-04-10T14:36:28.014+00:00"},"s":"I", "c":"NETWORK", "id":4915702, "ctx":"initandlisten","msg":"Updated wire specification","attr":{"oldSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":13},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":13},"outgoing":{"minWireVersion":0,"maxWireVersion":13},"isInternalClient":true},"newSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":13},"incomingInternalClient":{"minWireVersion":13,"maxWireVersion":13},"outgoing":{"minWireVersion":13,"maxWireVersion":13},"isInternalClient":true}}} {"t":{"$date":"2024-04-10T14:36:28.014+00:00"},"s":"I", "c":"STORAGE", "id":5071100, "ctx":"initandlisten","msg":"Clearing temp directory"} {"t":{"$date":"2024-04-10T14:36:28.036+00:00"},"s":"I", "c":"CONTROL", "id":20536, "ctx":"initandlisten","msg":"Flow Control is enabled on this deployment"} {"t":{"$date":"2024-04-10T14:36:28.036+00:00"},"s":"I", "c":"STORAGE", "id":5380103, "ctx":"initandlisten","msg":"Unpin oldest timestamp request","attr":{"service":"_wt_startup","requestedTs":{"$timestamp":{"t":1712759388,"i":3}}}} {"t":{"$date":"2024-04-10T14:36:28.037+00:00"},"s":"W", "c":"SHARDING", "id":22075, "ctx":"initandlisten","msg":"Not started with --shardsvr, but a shardIdentity document was found on disk","attr":{"namespace":"admin.system.version","shardIdentityDocument":{"_id":"shardIdentity","shardName":"rs1","clusterId":{"$oid":"6616a1b0a5799aa2e112f234"},"configsvrConnectionString":"rscfg/rscfg01:27017,rscfg02:27017,rscfg03:27017"}}} {"t":{"$date":"2024-04-10T14:36:28.037+00:00"},"s":"I", "c":"FTDC", "id":20625, "ctx":"initandlisten","msg":"Initializing full-time diagnostic data capture","attr":{"dataDirectory":"/var/lib/mongo/diagnostic.data"}} {"t":{"$date":"2024-04-10T14:36:28.041+00:00"},"s":"I", "c":"REPL", "id":21557, "ctx":"initandlisten","msg":"Removing unapplied oplog entries after oplogTruncateAfterPoint","attr":{"oplogTruncateAfterPoint":{"":{"$timestamp":{"t":1712759728,"i":1}}}}} {"t":{"$date":"2024-04-10T14:36:28.041+00:00"},"s":"I", "c":"REPL", "id":21553, "ctx":"initandlisten","msg":"Truncating oplog from truncateAfterOplogEntryTimestamp (non-inclusive)","attr":{"truncateAfterOplogEntryTimestamp":{"$timestamp":{"t":1712759726,"i":70}},"oplogTruncateAfterPoint":{"$timestamp":{"t":1712759728,"i":1}}}} {"t":{"$date":"2024-04-10T14:36:28.041+00:00"},"s":"I", "c":"REPL", "id":21554, "ctx":"initandlisten","msg":"Replication recovery oplog truncation finished","attr":{"durationMillis":0}} {"t":{"$date":"2024-04-10T14:36:28.042+00:00"},"s":"I", "c":"REPL", "id":21544, "ctx":"initandlisten","msg":"Recovering from stable timestamp","attr":{"stableTimestamp":{"$timestamp":{"t":1712759688,"i":3}},"topOfOplog":{"ts":{"$timestamp":{"t":1712759726,"i":70}},"t":3},"appliedThrough":{"ts":{"$timestamp":{"t":0,"i":0}},"t":-1}}} {"t":{"$date":"2024-04-10T14:36:28.042+00:00"},"s":"I", "c":"REPL", "id":21545, "ctx":"initandlisten","msg":"Starting recovery oplog application at the stable timestamp","attr":{"stableTimestamp":{"$timestamp":{"t":1712759688,"i":3}}}} {"t":{"$date":"2024-04-10T14:36:28.043+00:00"},"s":"I", "c":"REPL", "id":5466604, "ctx":"initandlisten","msg":"Start point for recovery oplog application exists in oplog. No adjustment necessary","attr":{"startPoint":{"$timestamp":{"t":1712759688,"i":3}}}} {"t":{"$date":"2024-04-10T14:36:28.043+00:00"},"s":"I", "c":"REPL", "id":21550, "ctx":"initandlisten","msg":"Replaying stored operations from startPoint (exclusive) to endPoint (inclusive)","attr":{"startPoint":{"$timestamp":{"t":1712759688,"i":3}},"endPoint":{"$timestamp":{"t":1712759726,"i":70}}}} {"t":{"$date":"2024-04-10T14:36:28.045+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"ReplWriterWorker-0","msg":"createCollection","attr":{"namespace":"config.cache.chunks.config.system.sessions","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"6f78333e-c749-4820-99d8-ba1424d8b2c8"}},"options":{"uuid":{"$uuid":"6f78333e-c749-4820-99d8-ba1424d8b2c8"}}}} {"t":{"$date":"2024-04-10T14:36:28.051+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"ReplWriterWorker-0","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.cache.chunks.config.system.sessions","index":"_id_","commitTimestamp":{"$timestamp":{"t":1712759688,"i":1030}}}} {"t":{"$date":"2024-04-10T14:36:28.056+00:00"},"s":"I", "c":"INDEX", "id":20384, "ctx":"ReplWriterWorker-0","msg":"Index build: starting","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"6f78333e-c749-4820-99d8-ba1424d8b2c8"}},"namespace":"config.cache.chunks.config.system.sessions","properties":{"v":2,"key":{"lastmod":1},"name":"lastmod_1"},"method":"Hybrid","maxTemporaryMemoryUsageMB":200}} {"t":{"$date":"2024-04-10T14:36:28.056+00:00"},"s":"I", "c":"INDEX", "id":20391, "ctx":"ReplWriterWorker-0","msg":"Index build: collection scan done","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"6f78333e-c749-4820-99d8-ba1424d8b2c8"}},"namespace":"config.cache.chunks.config.system.sessions","totalRecords":0,"readSource":"kNoTimestamp","durationMillis":0}} {"t":{"$date":"2024-04-10T14:36:28.056+00:00"},"s":"I", "c":"INDEX", "id":20685, "ctx":"ReplWriterWorker-0","msg":"Index build: inserted keys from external sorter into index","attr":{"namespace":"config.cache.chunks.config.system.sessions","index":"lastmod_1","keysInserted":0,"durationMillis":0}} {"t":{"$date":"2024-04-10T14:36:28.057+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"ReplWriterWorker-0","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.cache.chunks.config.system.sessions","index":"lastmod_1","commitTimestamp":{"$timestamp":{"t":1712759688,"i":1031}}}} {"t":{"$date":"2024-04-10T14:36:28.059+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"ReplWriterWorker-1","msg":"createCollection","attr":{"namespace":"config.system.sessions","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"f7766647-1a35-4c6e-bcbe-8983964ce20e"}},"options":{"uuid":{"$uuid":"f7766647-1a35-4c6e-bcbe-8983964ce20e"}}}} {"t":{"$date":"2024-04-10T14:36:28.065+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"ReplWriterWorker-1","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.system.sessions","index":"_id_","commitTimestamp":{"$timestamp":{"t":1712759689,"i":1}}}} {"t":{"$date":"2024-04-10T14:36:28.066+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"ReplWriterWorker-1","msg":"createCollection","attr":{"namespace":"config.migrationCoordinators","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"a72d4d8a-f60b-4a2c-9592-d523857e0364"}},"options":{"uuid":{"$uuid":"a72d4d8a-f60b-4a2c-9592-d523857e0364"}}}} {"t":{"$date":"2024-04-10T14:36:28.071+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"ReplWriterWorker-1","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.migrationCoordinators","index":"_id_","commitTimestamp":{"$timestamp":{"t":1712759689,"i":24}}}} {"t":{"$date":"2024-04-10T14:36:28.081+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"ReplWriterWorker-7","msg":"createCollection","attr":{"namespace":"config.rangeDeletions","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"7de79b7f-888f-416a-b430-6f4f9023bc34"}},"options":{"uuid":{"$uuid":"7de79b7f-888f-416a-b430-6f4f9023bc34"}}}} {"t":{"$date":"2024-04-10T14:36:28.086+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"ReplWriterWorker-7","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.rangeDeletions","index":"_id_","commitTimestamp":{"$timestamp":{"t":1712759689,"i":1051}}}} {"t":{"$date":"2024-04-10T14:36:28.087+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"ReplWriterWorker-6","msg":"createCollection","attr":{"namespace":"config.vectorClock","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"a293bc08-84b1-42a6-88ac-0ddd25f8833c"}},"options":{"uuid":{"$uuid":"a293bc08-84b1-42a6-88ac-0ddd25f8833c"}}}} {"t":{"$date":"2024-04-10T14:36:28.092+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"ReplWriterWorker-6","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.vectorClock","index":"_id_","commitTimestamp":{"$timestamp":{"t":1712759689,"i":1074}}}} {"t":{"$date":"2024-04-10T14:36:28.143+00:00"},"s":"I", "c":"REPL", "id":21536, "ctx":"initandlisten","msg":"Completed oplog application for recovery","attr":{"numOpsApplied":1683,"numBatches":151,"applyThroughOpTime":{"ts":{"$timestamp":{"t":1712759726,"i":70}},"t":3}}} {"t":{"$date":"2024-04-10T14:36:28.145+00:00"},"s":"W", "c":"REPL", "id":21558, "ctx":"initandlisten","msg":"Setting mongod to readOnly mode as a result of specifying 'recoverFromOplogAsStandalone'"} {"t":{"$date":"2024-04-10T14:36:28.145+00:00"},"s":"I", "c":"REPL", "id":6015317, "ctx":"initandlisten","msg":"Setting new configuration state","attr":{"newState":"ConfigReplicationDisabled","oldState":"ConfigPreStart"}} {"t":{"$date":"2024-04-10T14:36:28.145+00:00"},"s":"I", "c":"INDEX", "id":20438, "ctx":"LogicalSessionCacheRefresh","msg":"Index build: registering","attr":{"buildUUID":{"uuid":{"$uuid":"ae78fc12-8777-48b1-87b4-cbb236010c9c"}},"namespace":"config.system.sessions","collectionUUID":{"uuid":{"$uuid":"f7766647-1a35-4c6e-bcbe-8983964ce20e"}},"indexes":1,"firstIndex":{"name":"lsidTTLIndex"}}} {"t":{"$date":"2024-04-10T14:36:28.145+00:00"},"s":"I", "c":"CONTROL", "id":20712, "ctx":"LogicalSessionCacheReap","msg":"Sessions collection is not set up; waiting until next sessions reap interval","attr":{"error":"IndexNotFound: config.system.sessions does not have the required TTL index"}} {"t":{"$date":"2024-04-10T14:36:28.146+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"/tmp/mongodb-27617.sock"}} {"t":{"$date":"2024-04-10T14:36:28.146+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"127.0.0.1"}} {"t":{"$date":"2024-04-10T14:36:28.146+00:00"},"s":"I", "c":"NETWORK", "id":23016, "ctx":"listener","msg":"Waiting for connections","attr":{"port":27617,"ssl":"off"}} {"t":{"$date":"2024-04-10T14:36:28.146+00:00"},"s":"E", "c":"INDEX", "id":20393, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Caught exception while cleaning up partially built indexes","attr":{"error":"IllegalOperation: Cannot execute a write operation in read-only mode"}} {"t":{"$date":"2024-04-10T14:36:28.146+00:00"},"s":"F", "c":"-", "id":23089, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Fatal assertion","attr":{"msgid":18644,"file":"src/mongo/db/catalog/multi_index_block.cpp","line":152}} {"t":{"$date":"2024-04-10T14:36:28.146+00:00"},"s":"F", "c":"-", "id":23090, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"\n\n***aborting after fassert() failure\n\n"} {"t":{"$date":"2024-04-10T14:36:28.146+00:00"},"s":"F", "c":"CONTROL", "id":6384300, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Writing fatal message","attr":{"message":"Got signal: 6 (Aborted).\n"}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31380, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"BACKTRACE","attr":{"bt":{"backtrace":[{"a":"558186CC9963","b":"558182ADD000","o":"41EC963","s":"_ZN5mongo34StackTraceAddressMetadataGenerator4loadEPv","s+":"FC3"},{"a":"558186CCC3A7","b":"558182ADD000","o":"41EF3A7","s":"_ZN5mongo15printStackTraceEv","s+":"37"},{"a":"558186CC4556","b":"558182ADD000","o":"41E7556","s":"abruptQuit","s+":"66"},{"a":"7F311A388D40","b":"7F311A376000","o":"12D40","s":"funlockfile","s+":"50"},{"a":"7F3119FFFB8F","b":"7F3119FB1000","o":"4EB8F","s":"gsignal","s+":"10F"},{"a":"7F3119FD2EA5","b":"7F3119FB1000","o":"21EA5","s":"abort","s+":"127"},{"a":"55818404795B","b":"558182ADD000","o":"156A95B","s":"_ZN5mongo25fassertFailedWithLocationEiPKcj","s+":"F6"},{"a":"558183DF3F41","b":"558182ADD000","o":"1316F41","s":"_ZN5mongo21AuthzVersionParameter13setFromStringERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE","s+":"5641"},{"a":"55818528AFAF","b":"558182ADD000","o":"27ADFAF","s":"_ZN5mongo18IndexBuildsManager15abortIndexBuildEPNS_16OperationContextERNS_16CollectionWriterERKNS_4UUIDESt8functionIFvvEE","s+":"FF"},{"a":"558183D5952A","b":"558182ADD000","o":"127C52A","s":"_ZZNK5mongo11BSONElement6NumberEvENKUlvE_clEv","s+":"7F6E"},{"a":"5581851FD934","b":"558182ADD000","o":"2720934","s":"_ZN5mongo22IndexBuildsCoordinator16_setUpIndexBuildEPNS_16OperationContextERKNS_4UUIDENS_9TimestampERKNS0_17IndexBuildOptionsE","s+":"D4"},{"a":"558184F1A5F8","b":"558182ADD000","o":"243D5F8","s":"_ZN5mongo28IndexBuildsCoordinatorMongod33_checkVoteCommitIndexCmdSucceededERKNS_7BSONObjERKNS_4UUIDE","s+":"C08"},{"a":"558186A8888E","b":"558182ADD000","o":"3FAB88E","s":"_ZN5mongo10ThreadPool4Impl10_doOneTaskEPSt11unique_lockISt5mutexE","s+":"13E"},{"a":"558186A8B508","b":"558182ADD000","o":"3FAE508","s":"_ZN5mongo10ThreadPool4Impl13_consumeTasksEv","s+":"98"},{"a":"558186A8C9FC","b":"558182ADD000","o":"3FAF9FC","s":"_ZN5mongo10ThreadPool4Impl17_workerThreadBodyERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE","s+":"26C"},{"a":"558186A8CFA0","b":"558182ADD000","o":"3FAFFA0","s":"_ZN5mongo10ThreadPool4Impl17_workerThreadBodyERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE","s+":"810"},{"a":"7F311ABF3B23","b":"7F311AB31000","o":"C2B23","s":"_ZNKSt10error_code23default_error_conditionEv","s+":"33"},{"a":"7F311A37E1DA","b":"7F311A376000","o":"81DA","s":"start_thread","s+":"EA"},{"a":"7F3119FEAE73","b":"7F3119FB1000","o":"39E73","s":"clone","s+":"43"}],"processInfo":{"mongodbVersion":"5.0.26-22","gitVersion":"565331dec31cc2affadd67913bef70906134aedc","compiledModules":[],"uname":{"sysname":"Linux","release":"6.5.0-1017-azure","version":"#17~22.04.1-Ubuntu SMP Sat Mar 9 04:50:38 UTC 2024","machine":"x86_64"},"somap":[{"b":"558182ADD000","elfType":3,"buildId":"AB02A6B07DC04E58D964CD14E2B1CB70D3994186"},{"b":"7F311AB31000","path":"/lib64/libstdc++.so.6","elfType":3,"buildId":"E93362FE1E45648362A283B9A6CDAA404C0B1BB8"},{"b":"7F311A376000","path":"/lib64/libpthread.so.0","elfType":3,"buildId":"0139FCF61B419338C758CF968027C84F35FFE321"},{"b":"7F3119FB1000","path":"/lib64/libc.so.6","elfType":3,"buildId":"464DB0B573C4CD336186A5A38BEA2BF91F6A3AEA"}]}}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558186CC9963","b":"558182ADD000","o":"41EC963","s":"_ZN5mongo34StackTraceAddressMetadataGenerator4loadEPv","s+":"FC3"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558186CCC3A7","b":"558182ADD000","o":"41EF3A7","s":"_ZN5mongo15printStackTraceEv","s+":"37"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558186CC4556","b":"558182ADD000","o":"41E7556","s":"abruptQuit","s+":"66"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"7F311A388D40","b":"7F311A376000","o":"12D40","s":"funlockfile","s+":"50"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"7F3119FFFB8F","b":"7F3119FB1000","o":"4EB8F","s":"gsignal","s+":"10F"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"7F3119FD2EA5","b":"7F3119FB1000","o":"21EA5","s":"abort","s+":"127"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"55818404795B","b":"558182ADD000","o":"156A95B","s":"_ZN5mongo25fassertFailedWithLocationEiPKcj","s+":"F6"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558183DF3F41","b":"558182ADD000","o":"1316F41","s":"_ZN5mongo21AuthzVersionParameter13setFromStringERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE","s+":"5641"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"55818528AFAF","b":"558182ADD000","o":"27ADFAF","s":"_ZN5mongo18IndexBuildsManager15abortIndexBuildEPNS_16OperationContextERNS_16CollectionWriterERKNS_4UUIDESt8functionIFvvEE","s+":"FF"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558183D5952A","b":"558182ADD000","o":"127C52A","s":"_ZZNK5mongo11BSONElement6NumberEvENKUlvE_clEv","s+":"7F6E"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"5581851FD934","b":"558182ADD000","o":"2720934","s":"_ZN5mongo22IndexBuildsCoordinator16_setUpIndexBuildEPNS_16OperationContextERKNS_4UUIDENS_9TimestampERKNS0_17IndexBuildOptionsE","s+":"D4"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558184F1A5F8","b":"558182ADD000","o":"243D5F8","s":"_ZN5mongo28IndexBuildsCoordinatorMongod33_checkVoteCommitIndexCmdSucceededERKNS_7BSONObjERKNS_4UUIDE","s+":"C08"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558186A8888E","b":"558182ADD000","o":"3FAB88E","s":"_ZN5mongo10ThreadPool4Impl10_doOneTaskEPSt11unique_lockISt5mutexE","s+":"13E"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558186A8B508","b":"558182ADD000","o":"3FAE508","s":"_ZN5mongo10ThreadPool4Impl13_consumeTasksEv","s+":"98"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558186A8C9FC","b":"558182ADD000","o":"3FAF9FC","s":"_ZN5mongo10ThreadPool4Impl17_workerThreadBodyERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE","s+":"26C"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"558186A8CFA0","b":"558182ADD000","o":"3FAFFA0","s":"_ZN5mongo10ThreadPool4Impl17_workerThreadBodyERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE","s+":"810"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"7F311ABF3B23","b":"7F311AB31000","o":"C2B23","s":"_ZNKSt10error_code23default_error_conditionEv","s+":"33"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"7F311A37E1DA","b":"7F311A376000","o":"81DA","s":"start_thread","s+":"EA"}}} {"t":{"$date":"2024-04-10T14:36:28.186+00:00"},"s":"I", "c":"CONTROL", "id":31445, "ctx":"IndexBuildsCoordinatorMongod-0","msg":"Frame","attr":{"frame":{"a":"7F3119FEAE73","b":"7F3119FB1000","o":"39E73","s":"clone","s+":"43"}}}