{"t":{"$date":"2024-11-19T10:35:49.446+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:43848","uuid":"a4a91b30-4562-4e35-b46a-cd91a3bd7a49","connectionId":16,"connectionCount":4}} {"t":{"$date":"2024-11-19T10:35:49.447+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn16","msg":"client metadata","attr":{"remote":"172.24.0.1:43848","client":"conn16","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:35:49.447+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:43856","uuid":"ee8626a6-799d-49aa-bc99-2d0878c2059e","connectionId":17,"connectionCount":5}} {"t":{"$date":"2024-11-19T10:35:49.447+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn17","msg":"client metadata","attr":{"remote":"172.24.0.1:43856","client":"conn17","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:35:49.448+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:43872","uuid":"06159ea3-9190-4718-9817-4b9815ea3b77","connectionId":18,"connectionCount":6}} {"t":{"$date":"2024-11-19T10:35:49.448+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:43888","uuid":"d4c2d038-6dd7-4b91-8876-19511ab4ab0a","connectionId":19,"connectionCount":7}} {"t":{"$date":"2024-11-19T10:35:49.449+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn19","msg":"client metadata","attr":{"remote":"172.24.0.1:43888","client":"conn19","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v20.18.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:35:49.449+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn18","msg":"client metadata","attr":{"remote":"172.24.0.1:43872","client":"conn18","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:35:49.542+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:36862","uuid":"a18c5446-bc50-4a8f-8bbb-37ef0e10866a","connectionId":21,"connectionCount":8}} {"t":{"$date":"2024-11-19T10:35:49.545+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn21","msg":"client metadata","attr":{"remote":"192.168.180.24:36862","client":"conn21","doc":{"application":{"name":"mongosh 1.8.2"},"driver":{"name":"nodejs|mongosh","version":"5.3.0|1.8.2"},"platform":"Node.js v16.19.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.16.1.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:35:50.847+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":1600}} {"t":{"$date":"2024-11-19T10:35:51.457+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:46202","uuid":"c62c2750-a949-4342-a697-ae60f4ac3159","connectionId":22,"connectionCount":9}} {"t":{"$date":"2024-11-19T10:35:51.459+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn22","msg":"client metadata","attr":{"remote":"192.168.180.24:46202","client":"conn22","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v20.18.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.16.1.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:35:51.659+00:00"},"s":"I", "c":"-", "id":20883, "ctx":"conn19","msg":"Interrupted operation as its client disconnected","attr":{"opId":166}} {"t":{"$date":"2024-11-19T10:35:51.661+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn19","msg":"Connection ended","attr":{"remote":"172.24.0.1:43888","uuid":"d4c2d038-6dd7-4b91-8876-19511ab4ab0a","connectionId":19,"connectionCount":8}} {"t":{"$date":"2024-11-19T10:35:51.668+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:43890","uuid":"e77721bc-5900-42c6-b3ac-8e0a8289bd54","connectionId":23,"connectionCount":9}} {"t":{"$date":"2024-11-19T10:35:51.669+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn23","msg":"client metadata","attr":{"remote":"172.24.0.1:43890","client":"conn23","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v20.18.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:35:52.449+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":1800}} {"t":{"$date":"2024-11-19T10:35:52.669+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:34474","uuid":"06495a99-69c3-4fcd-ace3-cad9e5469ffa","connectionId":24,"connectionCount":10}} {"t":{"$date":"2024-11-19T10:35:52.670+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn24","msg":"client metadata","attr":{"remote":"172.24.0.1:34474","client":"conn24","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:35:52.671+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:34488","uuid":"63e8f356-5975-43a2-b08f-cd4d58a6a80b","connectionId":25,"connectionCount":11}} {"t":{"$date":"2024-11-19T10:35:52.672+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn25","msg":"client metadata","attr":{"remote":"172.24.0.1:34488","client":"conn25","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:35:54.250+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":2000}} {"t":{"$date":"2024-11-19T10:35:54.345+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:48528","uuid":"451f9732-8eee-4a84-b8b4-aa5673ad6a96","connectionId":26,"connectionCount":12}} {"t":{"$date":"2024-11-19T10:35:54.347+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn26","msg":"client metadata","attr":{"remote":"192.168.180.24:48528","client":"conn26","doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"6.0.5"},"os":{"type":"Linux","name":"Ubuntu","architecture":"x86_64","version":"22.04"}}}} {"t":{"$date":"2024-11-19T10:35:54.444+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn26","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"__system","authenticationDatabase":"local","remote":"192.168.180.24:48528","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:35:54.625+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:59616","uuid":"541117ad-505a-4f80-a1b1-06006be02dc6","connectionId":27,"connectionCount":13}} {"t":{"$date":"2024-11-19T10:35:54.626+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn27","msg":"client metadata","attr":{"remote":"192.168.180.24:59616","client":"conn27","doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"6.0.5"},"os":{"type":"Linux","name":"Ubuntu","architecture":"x86_64","version":"22.04"}}}} {"t":{"$date":"2024-11-19T10:35:54.722+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn27","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"__system","authenticationDatabase":"local","remote":"192.168.180.24:59616","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:35:56.252+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":2200}} {"t":{"$date":"2024-11-19T10:35:57.806+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:34500","uuid":"5f04db34-6765-4b0e-98eb-4b2483a35d0a","connectionId":28,"connectionCount":14}} {"t":{"$date":"2024-11-19T10:35:57.807+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn28","msg":"client metadata","attr":{"remote":"172.24.0.1:34500","client":"conn28","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:35:58.455+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":2400}} {"t":{"$date":"2024-11-19T10:35:59.955+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:34514","uuid":"7e3dec62-c774-4d58-8e81-f5e6b54f8c1b","connectionId":29,"connectionCount":15}} {"t":{"$date":"2024-11-19T10:35:59.956+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn29","msg":"client metadata","attr":{"remote":"172.24.0.1:34514","client":"conn29","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:35:59.957+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:34530","uuid":"b0f91d57-984e-4423-9eb1-16c9d9f2d83e","connectionId":30,"connectionCount":16}} {"t":{"$date":"2024-11-19T10:35:59.958+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn30","msg":"client metadata","attr":{"remote":"172.24.0.1:34530","client":"conn30","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:00.111+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.169.215:47118","uuid":"c418e46d-2c75-4754-8e15-ecad6757a042","connectionId":31,"connectionCount":17}} {"t":{"$date":"2024-11-19T10:36:00.113+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn31","msg":"client metadata","attr":{"remote":"192.168.169.215:47118","client":"conn31","doc":{"driver":{"name":"nodejs|Mongoose","version":"5.9.0|7.6.3"},"platform":"Node.js v16.16.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:00.147+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:39964","uuid":"2cf0b0c5-018e-40ac-82ab-551f641c64b0","connectionId":32,"connectionCount":18}} {"t":{"$date":"2024-11-19T10:36:00.149+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn32","msg":"client metadata","attr":{"remote":"192.168.180.24:39964","client":"conn32","doc":{"application":{"name":"mongosh 1.8.2"},"driver":{"name":"nodejs|mongosh","version":"5.3.0|1.8.2"},"platform":"Node.js v16.19.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.16.1.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:00.856+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":2600}} {"t":{"$date":"2024-11-19T10:36:02.019+00:00"},"s":"I", "c":"ROLLBACK", "id":21607, "ctx":"BackgroundSync","msg":"Rollback common point","attr":{"commonPointOpTime":{"ts":{"$timestamp":{"t":1731943045,"i":6}},"t":150}}} {"t":{"$date":"2024-11-19T10:36:02.020+00:00"},"s":"F", "c":"ROLLBACK", "id":51121, "ctx":"BackgroundSync","msg":"Common point must be at least stable timestamp","attr":{"commonPoint":{"$timestamp":{"t":1731943045,"i":6}},"stableTimestamp":{"$timestamp":{"t":1731945661,"i":2}}}} {"t":{"$date":"2024-11-19T10:36:02.020+00:00"},"s":"F", "c":"ASSERT", "id":23091, "ctx":"BackgroundSync","msg":"Fatal assertion","attr":{"msgid":51121,"file":"src/mongo/db/repl/rollback_impl.cpp","line":1153}} {"t":{"$date":"2024-11-19T10:36:02.020+00:00"},"s":"F", "c":"ASSERT", "id":23092, "ctx":"BackgroundSync","msg":"\n\n***aborting after fassert() failure\n\n"} {"t":{"$date":"2024-11-19T10:36:07.414+00:00"},"s":"I", "c":"CONTROL", "id":20698, "ctx":"-","msg":"***** SERVER RESTARTED *****"} {"t":{"$date":"2024-11-19T10:36:07.417+00:00"},"s":"I", "c":"NETWORK", "id":4915701, "ctx":"main","msg":"Initialized wire specification","attr":{"spec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":17},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":17},"outgoing":{"minWireVersion":6,"maxWireVersion":17},"isInternalClient":true}}} {"t":{"$date":"2024-11-19T10:36:07.418+00:00"},"s":"I", "c":"CONTROL", "id":23285, "ctx":"main","msg":"Automatically disabling TLS 1.0, to force-enable TLS 1.0 specify --sslDisabledProtocols 'none'"} {"t":{"$date":"2024-11-19T10:36:07.420+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-11-19T10:36:07.755+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"main","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationDonorService","namespace":"config.tenantMigrationDonors"}} {"t":{"$date":"2024-11-19T10:36:07.755+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"main","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationRecipientService","namespace":"config.tenantMigrationRecipients"}} {"t":{"$date":"2024-11-19T10:36:07.755+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"main","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"ShardSplitDonorService","namespace":"config.tenantSplitDonors"}} {"t":{"$date":"2024-11-19T10:36:07.755+00:00"},"s":"I", "c":"CONTROL", "id":5945603, "ctx":"main","msg":"Multi threading initialized"} {"t":{"$date":"2024-11-19T10:36:07.756+00:00"},"s":"I", "c":"CONTROL", "id":4615611, "ctx":"initandlisten","msg":"MongoDB starting","attr":{"pid":1,"port":27017,"dbPath":"/data/db","architecture":"64-bit","host":"48f95c17ca32"}} {"t":{"$date":"2024-11-19T10:36:07.756+00:00"},"s":"W", "c":"CONTROL", "id":20720, "ctx":"initandlisten","msg":"Memory available to mongo process is less than total system memory","attr":{"availableMemSizeMB":4096,"systemMemSizeMB":15721}} {"t":{"$date":"2024-11-19T10:36:07.756+00:00"},"s":"I", "c":"CONTROL", "id":23403, "ctx":"initandlisten","msg":"Build Info","attr":{"buildInfo":{"version":"6.0.5","gitVersion":"c9a99c120371d4d4c52cbb15dac34a36ce8d3b1d","openSSLVersion":"OpenSSL 3.0.2 15 Mar 2022","modules":[],"allocator":"tcmalloc","environment":{"distmod":"ubuntu2204","distarch":"x86_64","target_arch":"x86_64"}}}} {"t":{"$date":"2024-11-19T10:36:07.756+00:00"},"s":"I", "c":"CONTROL", "id":51765, "ctx":"initandlisten","msg":"Operating System","attr":{"os":{"name":"Ubuntu","version":"22.04"}}} {"t":{"$date":"2024-11-19T10:36:07.756+00:00"},"s":"I", "c":"CONTROL", "id":21951, "ctx":"initandlisten","msg":"Options set by command line","attr":{"options":{"config":"/etc/mongod.conf","net":{"bindIp":"*","ipv6":true,"port":27017},"processManagement":{"timeZoneInfo":"/usr/share/zoneinfo"},"replication":{"replSetName":"rs0"},"security":{"authorization":"enabled","keyFile":"/data/replicaset.key"},"storage":{"dbPath":"/data/db","journal":{"enabled":true}},"systemLog":{"destination":"file","logAppend":true,"path":"/var/log/mongodb/mongod.log"}}}} {"t":{"$date":"2024-11-19T10:36:07.758+00:00"},"s":"W", "c":"STORAGE", "id":22271, "ctx":"initandlisten","msg":"Detected unclean shutdown - Lock file is not empty","attr":{"lockFile":"/data/db/mongod.lock"}} {"t":{"$date":"2024-11-19T10:36:07.758+00:00"},"s":"I", "c":"STORAGE", "id":22270, "ctx":"initandlisten","msg":"Storage engine to use detected by data files","attr":{"dbpath":"/data/db","storageEngine":"wiredTiger"}} {"t":{"$date":"2024-11-19T10:36:07.759+00:00"},"s":"W", "c":"STORAGE", "id":22302, "ctx":"initandlisten","msg":"Recovering data from the last clean checkpoint."} {"t":{"$date":"2024-11-19T10:36:07.759+00:00"},"s":"I", "c":"STORAGE", "id":22315, "ctx":"initandlisten","msg":"Opening WiredTiger","attr":{"config":"create,cache_size=1536M,session_max=33000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,remove=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),json_output=(error,message),verbose=[recovery_progress:1,checkpoint_progress:1,compact_progress:1,backup:0,checkpoint:0,compact:0,evict:0,history_store:0,recovery:0,rts:0,salvage:0,tiered:0,timestamp:0,transaction:0,verify:0,log:0],"}} {"t":{"$date":"2024-11-19T10:36:08.851+00:00"},"s":"I", "c":"STORAGE", "id":4795906, "ctx":"initandlisten","msg":"WiredTiger opened","attr":{"durationMillis":1092}} {"t":{"$date":"2024-11-19T10:36:08.851+00:00"},"s":"I", "c":"RECOVERY", "id":23987, "ctx":"initandlisten","msg":"WiredTiger recoveryTimestamp","attr":{"recoveryTimestamp":{"$timestamp":{"t":1731945661,"i":2}}}} {"t":{"$date":"2024-11-19T10:36:08.851+00:00"},"s":"I", "c":"RECOVERY", "id":5380106, "ctx":"initandlisten","msg":"WiredTiger oldestTimestamp","attr":{"oldestTimestamp":{"$timestamp":{"t":1731945361,"i":2}}}} {"t":{"$date":"2024-11-19T10:36:08.870+00:00"},"s":"I", "c":"STORAGE", "id":22383, "ctx":"initandlisten","msg":"The size storer reports that the oplog contains","attr":{"numRecords":26950935,"dataSize":6393494450}} {"t":{"$date":"2024-11-19T10:36:08.870+00:00"},"s":"I", "c":"STORAGE", "id":22386, "ctx":"initandlisten","msg":"Sampling the oplog to determine where to place markers for truncation"} {"t":{"$date":"2024-11-19T10:36:08.875+00:00"},"s":"I", "c":"STORAGE", "id":22389, "ctx":"initandlisten","msg":"Sampling from the oplog to determine where to place markers for truncation","attr":{"from":{"$timestamp":{"t":1730713551,"i":1}},"to":{"$timestamp":{"t":1731945661,"i":2}}}} {"t":{"$date":"2024-11-19T10:36:08.875+00:00"},"s":"I", "c":"STORAGE", "id":22390, "ctx":"initandlisten","msg":"Taking samples and assuming each oplog section contains","attr":{"numSamples":270,"minBytesPerStone":236150177,"containsNumRecords":995461,"containsNumBytes":236150411}} {"t":{"$date":"2024-11-19T10:36:09.070+00:00"},"s":"I", "c":"STORAGE", "id":22393, "ctx":"initandlisten","msg":"Oplog sampling complete"} {"t":{"$date":"2024-11-19T10:36:09.070+00:00"},"s":"I", "c":"STORAGE", "id":22382, "ctx":"initandlisten","msg":"WiredTiger record store oplog processing finished","attr":{"durationMillis":200}} {"t":{"$date":"2024-11-19T10:36:09.078+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'","tags":["startupWarnings"]} {"t":{"$date":"2024-11-19T10:36:09.078+00:00"},"s":"W", "c":"CONTROL", "id":5123300, "ctx":"initandlisten","msg":"vm.max_map_count is too low","attr":{"currentValue":65530,"recommendedMinimum":104856,"maxConns":52428},"tags":["startupWarnings"]} {"t":{"$date":"2024-11-19T10:36:09.083+00:00"},"s":"I", "c":"NETWORK", "id":4915702, "ctx":"initandlisten","msg":"Updated wire specification","attr":{"oldSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":17},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":17},"outgoing":{"minWireVersion":6,"maxWireVersion":17},"isInternalClient":true},"newSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":17},"incomingInternalClient":{"minWireVersion":17,"maxWireVersion":17},"outgoing":{"minWireVersion":17,"maxWireVersion":17},"isInternalClient":true}}} {"t":{"$date":"2024-11-19T10:36:09.083+00:00"},"s":"I", "c":"REPL", "id":5853300, "ctx":"initandlisten","msg":"current featureCompatibilityVersion value","attr":{"featureCompatibilityVersion":"6.0","context":"startup"}} {"t":{"$date":"2024-11-19T10:36:09.084+00:00"},"s":"I", "c":"STORAGE", "id":5071100, "ctx":"initandlisten","msg":"Clearing temp directory"} {"t":{"$date":"2024-11-19T10:36:09.142+00:00"},"s":"I", "c":"CONTROL", "id":20536, "ctx":"initandlisten","msg":"Flow Control is enabled on this deployment"} {"t":{"$date":"2024-11-19T10:36:09.142+00:00"},"s":"I", "c":"STORAGE", "id":5380103, "ctx":"initandlisten","msg":"Unpin oldest timestamp request","attr":{"service":"_wt_startup","requestedTs":{"$timestamp":{"t":1731945361,"i":2}}}} {"t":{"$date":"2024-11-19T10:36:09.142+00:00"},"s":"I", "c":"FTDC", "id":20625, "ctx":"initandlisten","msg":"Initializing full-time diagnostic data capture","attr":{"dataDirectory":"/data/db/diagnostic.data"}} {"t":{"$date":"2024-11-19T10:36:09.149+00:00"},"s":"I", "c":"REPL", "id":6015317, "ctx":"initandlisten","msg":"Setting new configuration state","attr":{"newState":"ConfigStartingUp","oldState":"ConfigPreStart"}} {"t":{"$date":"2024-11-19T10:36:09.149+00:00"},"s":"I", "c":"REPL", "id":6005300, "ctx":"initandlisten","msg":"Starting up replica set aware services"} {"t":{"$date":"2024-11-19T10:36:09.151+00:00"},"s":"I", "c":"REPL", "id":4280500, "ctx":"initandlisten","msg":"Attempting to create internal replication collections"} {"t":{"$date":"2024-11-19T10:36:09.151+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":200}} {"t":{"$date":"2024-11-19T10:36:09.154+00:00"},"s":"I", "c":"REPL", "id":4280501, "ctx":"initandlisten","msg":"Attempting to load local voted for document"} {"t":{"$date":"2024-11-19T10:36:09.154+00:00"},"s":"I", "c":"REPL", "id":4280502, "ctx":"initandlisten","msg":"Searching for local Rollback ID document"} {"t":{"$date":"2024-11-19T10:36:09.155+00:00"},"s":"I", "c":"REPL", "id":21529, "ctx":"initandlisten","msg":"Initializing rollback ID","attr":{"rbid":525}} {"t":{"$date":"2024-11-19T10:36:09.155+00:00"},"s":"I", "c":"REPL", "id":501401, "ctx":"initandlisten","msg":"Incrementing the rollback ID after unclean shutdown"} {"t":{"$date":"2024-11-19T10:36:09.156+00:00"},"s":"I", "c":"REPL", "id":21532, "ctx":"initandlisten","msg":"Incremented the rollback ID","attr":{"rbid":526}} {"t":{"$date":"2024-11-19T10:36:09.156+00:00"},"s":"I", "c":"REPL", "id":4280504, "ctx":"initandlisten","msg":"Cleaning up any partially applied oplog batches & reading last op from oplog"} {"t":{"$date":"2024-11-19T10:36:09.157+00:00"},"s":"I", "c":"CONTROL", "id":6608200, "ctx":"initandlisten","msg":"Initializing cluster server parameters from disk"} {"t":{"$date":"2024-11-19T10:36:09.158+00:00"},"s":"I", "c":"REPL", "id":21544, "ctx":"initandlisten","msg":"Recovering from stable timestamp","attr":{"stableTimestamp":{"$timestamp":{"t":1731945661,"i":2}},"topOfOplog":{"ts":{"$timestamp":{"t":1731945661,"i":2}},"t":151},"appliedThrough":{"ts":{"$timestamp":{"t":0,"i":0}},"t":-1}}} {"t":{"$date":"2024-11-19T10:36:09.158+00:00"},"s":"I", "c":"REPL", "id":21545, "ctx":"initandlisten","msg":"Starting recovery oplog application at the stable timestamp","attr":{"stableTimestamp":{"$timestamp":{"t":1731945661,"i":2}}}} {"t":{"$date":"2024-11-19T10:36:09.158+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":1731945661,"i":2}}}} {"t":{"$date":"2024-11-19T10:36:09.158+00:00"},"s":"I", "c":"REPL", "id":21549, "ctx":"initandlisten","msg":"No oplog entries to apply for recovery. Start point is at the top of the oplog"} {"t":{"$date":"2024-11-19T10:36:09.158+00:00"},"s":"I", "c":"REPL", "id":4280505, "ctx":"initandlisten","msg":"Creating any necessary TenantMigrationAccessBlockers for unfinished migrations"} {"t":{"$date":"2024-11-19T10:36:09.160+00:00"},"s":"I", "c":"REPL", "id":4280506, "ctx":"initandlisten","msg":"Reconstructing prepared transactions"} {"t":{"$date":"2024-11-19T10:36:09.163+00:00"},"s":"I", "c":"REPL", "id":4280507, "ctx":"initandlisten","msg":"Loaded replica set config, scheduled callback to set local config"} {"t":{"$date":"2024-11-19T10:36:09.163+00:00"},"s":"I", "c":"STORAGE", "id":22262, "ctx":"initandlisten","msg":"Timestamp monitor starting"} {"t":{"$date":"2024-11-19T10:36:09.163+00:00"},"s":"I", "c":"REPL", "id":4280508, "ctx":"ReplCoord-0","msg":"Attempting to set local replica set config; validating config for startup"} {"t":{"$date":"2024-11-19T10:36:09.165+00:00"},"s":"I", "c":"CONTROL", "id":20714, "ctx":"LogicalSessionCacheRefresh","msg":"Failed to refresh session cache, will try again at the next refresh interval","attr":{"error":"NotYetInitialized: Replication has not yet been configured"}} {"t":{"$date":"2024-11-19T10:36:09.166+00:00"},"s":"I", "c":"REPL", "id":40440, "ctx":"initandlisten","msg":"Starting the TopologyVersionObserver"} {"t":{"$date":"2024-11-19T10:36:09.166+00:00"},"s":"I", "c":"REPL", "id":40445, "ctx":"TopologyVersionObserver","msg":"Started TopologyVersionObserver"} {"t":{"$date":"2024-11-19T10:36:09.166+00:00"},"s":"I", "c":"CONTROL", "id":20711, "ctx":"LogicalSessionCacheReap","msg":"Failed to reap transaction table","attr":{"error":"NotYetInitialized: Replication has not yet been configured"}} {"t":{"$date":"2024-11-19T10:36:09.167+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"/tmp/mongodb-27017.sock"}} {"t":{"$date":"2024-11-19T10:36:09.167+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"0.0.0.0"}} {"t":{"$date":"2024-11-19T10:36:09.167+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"::"}} {"t":{"$date":"2024-11-19T10:36:09.167+00:00"},"s":"I", "c":"NETWORK", "id":23016, "ctx":"listener","msg":"Waiting for connections","attr":{"port":27017,"ssl":"off"}} {"t":{"$date":"2024-11-19T10:36:09.169+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53588","uuid":"49c93ac4-2ee1-4c5a-8fce-d1b6d50dc032","connectionId":2,"connectionCount":1}} {"t":{"$date":"2024-11-19T10:36:09.202+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53594","uuid":"e2454052-89de-4c84-9187-c75f5e1b3e7f","connectionId":3,"connectionCount":2}} {"t":{"$date":"2024-11-19T10:36:09.203+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn3","msg":"client metadata","attr":{"remote":"172.24.0.1:53594","client":"conn3","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:09.276+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn2","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":false,"principalName":"__system","authenticationDatabase":"local","remote":"172.24.0.1:53588","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:36:09.277+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn2","msg":"Connection ended","attr":{"remote":"172.24.0.1:53588","uuid":"49c93ac4-2ee1-4c5a-8fce-d1b6d50dc032","connectionId":2,"connectionCount":1}} {"t":{"$date":"2024-11-19T10:36:09.299+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53598","uuid":"047806bc-9718-4d33-bef5-8ca469ca0ac6","connectionId":4,"connectionCount":2}} {"t":{"$date":"2024-11-19T10:36:09.300+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn4","msg":"client metadata","attr":{"remote":"172.24.0.1:53598","client":"conn4","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:36:09.352+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":400}} {"t":{"$date":"2024-11-19T10:36:09.542+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53604","uuid":"597e6f54-47fc-4497-8964-f4c55344ec2f","connectionId":6,"connectionCount":3}} {"t":{"$date":"2024-11-19T10:36:09.544+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn6","msg":"client metadata","attr":{"remote":"172.24.0.1:53604","client":"conn6","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:09.592+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.169.215:40092","uuid":"38d3a205-adc4-422b-85ba-ed66eba33e2e","connectionId":7,"connectionCount":4}} {"t":{"$date":"2024-11-19T10:36:09.593+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn7","msg":"client metadata","attr":{"remote":"192.168.169.215:40092","client":"conn7","doc":{"driver":{"name":"nodejs|Mongoose","version":"5.9.0|7.6.3"},"platform":"Node.js v16.16.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:09.616+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53606","uuid":"4722dc40-9e18-4796-9426-87931cd66090","connectionId":8,"connectionCount":5}} {"t":{"$date":"2024-11-19T10:36:09.616+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn8","msg":"client metadata","attr":{"remote":"172.24.0.1:53606","client":"conn8","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v20.18.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:09.623+00:00"},"s":"I", "c":"REPL", "id":4280509, "ctx":"ReplCoord-0","msg":"Local configuration validated for startup"} {"t":{"$date":"2024-11-19T10:36:09.624+00:00"},"s":"I", "c":"REPL", "id":6015317, "ctx":"ReplCoord-0","msg":"Setting new configuration state","attr":{"newState":"ConfigSteady","oldState":"ConfigStartingUp"}} {"t":{"$date":"2024-11-19T10:36:09.624+00:00"},"s":"I", "c":"REPL", "id":21392, "ctx":"ReplCoord-0","msg":"New replica set config in use","attr":{"config":{"_id":"rs0","version":257351,"term":151,"members":[{"_id":0,"host":"mongo1.example.com:27017","arbiterOnly":false,"buildIndexes":true,"hidden":false,"priority":1,"tags":{},"secondaryDelaySecs":0,"votes":1},{"_id":1,"host":"mongo2.example.com:27019","arbiterOnly":false,"newlyAdded":true,"buildIndexes":true,"hidden":false,"priority":0.5,"tags":{},"secondaryDelaySecs":0,"votes":1}],"protocolVersion":1,"writeConcernMajorityJournalDefault":true,"settings":{"chainingAllowed":true,"heartbeatIntervalMillis":2000,"heartbeatTimeoutSecs":10,"electionTimeoutMillis":10000,"catchUpTimeoutMillis":-1,"catchUpTakeoverDelayMillis":30000,"getLastErrorModes":{},"getLastErrorDefaults":{"w":1,"wtimeout":0},"replicaSetId":{"$oid":"672897cf45022f0c1767e75c"}}}}} {"t":{"$date":"2024-11-19T10:36:09.624+00:00"},"s":"I", "c":"REPL", "id":21393, "ctx":"ReplCoord-0","msg":"Found self in config","attr":{"hostAndPort":"mongo1.example.com:27017"}} {"t":{"$date":"2024-11-19T10:36:09.624+00:00"},"s":"I", "c":"REPL", "id":21358, "ctx":"ReplCoord-0","msg":"Replica set state transition","attr":{"newState":"STARTUP2","oldState":"STARTUP"}} {"t":{"$date":"2024-11-19T10:36:09.625+00:00"},"s":"I", "c":"REPL", "id":21320, "ctx":"ReplCoord-0","msg":"Updated term","attr":{"term":151}} {"t":{"$date":"2024-11-19T10:36:09.625+00:00"},"s":"I", "c":"REPL", "id":21306, "ctx":"ReplCoord-0","msg":"Starting replication storage threads"} {"t":{"$date":"2024-11-19T10:36:09.625+00:00"},"s":"I", "c":"CONNPOOL", "id":22576, "ctx":"ReplNetwork","msg":"Connecting","attr":{"hostAndPort":"mongo2.example.com:27019"}} {"t":{"$date":"2024-11-19T10:36:09.627+00:00"},"s":"I", "c":"REPL", "id":4280512, "ctx":"ReplCoord-0","msg":"No initial sync required. Attempting to begin steady replication"} {"t":{"$date":"2024-11-19T10:36:09.627+00:00"},"s":"I", "c":"REPL", "id":21358, "ctx":"ReplCoord-0","msg":"Replica set state transition","attr":{"newState":"RECOVERING","oldState":"STARTUP2"}} {"t":{"$date":"2024-11-19T10:36:09.630+00:00"},"s":"I", "c":"REPL", "id":21299, "ctx":"ReplCoord-0","msg":"Starting replication fetcher thread"} {"t":{"$date":"2024-11-19T10:36:09.630+00:00"},"s":"I", "c":"REPL", "id":21300, "ctx":"ReplCoord-0","msg":"Starting replication applier thread"} {"t":{"$date":"2024-11-19T10:36:09.630+00:00"},"s":"I", "c":"REPL", "id":21301, "ctx":"ReplCoord-0","msg":"Starting replication reporter thread"} {"t":{"$date":"2024-11-19T10:36:09.630+00:00"},"s":"I", "c":"REPL", "id":21224, "ctx":"OplogApplier-0","msg":"Starting oplog application"} {"t":{"$date":"2024-11-19T10:36:09.631+00:00"},"s":"I", "c":"REPL", "id":4280511, "ctx":"ReplCoord-0","msg":"Set local replica set config"} {"t":{"$date":"2024-11-19T10:36:09.631+00:00"},"s":"I", "c":"REPL", "id":21783, "ctx":"BackgroundSync","msg":"Waiting for pings from other members before syncing","attr":{"pingsNeeded":2}} {"t":{"$date":"2024-11-19T10:36:09.631+00:00"},"s":"I", "c":"REPL", "id":21358, "ctx":"OplogApplier-0","msg":"Replica set state transition","attr":{"newState":"SECONDARY","oldState":"RECOVERING"}} {"t":{"$date":"2024-11-19T10:36:09.632+00:00"},"s":"I", "c":"REPL", "id":21106, "ctx":"OplogApplier-0","msg":"Resetting sync source to empty","attr":{"previousSyncSource":":27017"}} {"t":{"$date":"2024-11-19T10:36:09.649+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:57060","uuid":"9ee7ae26-46e6-4f4f-b612-619e7323148d","connectionId":9,"connectionCount":6}} {"t":{"$date":"2024-11-19T10:36:09.650+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn9","msg":"client metadata","attr":{"remote":"192.168.180.24:57060","client":"conn9","doc":{"driver":{"name":"NetworkInterfaceTL-ReplNetwork","version":"6.0.5"},"os":{"type":"Linux","name":"Ubuntu","architecture":"x86_64","version":"22.04"}}}} {"t":{"$date":"2024-11-19T10:36:09.721+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:57062","uuid":"3b25f130-5e0c-486f-a196-71fad0f73f8d","connectionId":11,"connectionCount":7}} {"t":{"$date":"2024-11-19T10:36:09.722+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:52950","uuid":"88602edb-697c-4352-88da-069375514a29","connectionId":12,"connectionCount":8}} {"t":{"$date":"2024-11-19T10:36:09.722+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn11","msg":"client metadata","attr":{"remote":"192.168.180.24:57062","client":"conn11","doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"6.0.5"},"os":{"type":"Linux","name":"Ubuntu","architecture":"x86_64","version":"22.04"}}}} {"t":{"$date":"2024-11-19T10:36:09.723+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn12","msg":"client metadata","attr":{"remote":"192.168.180.24:52950","client":"conn12","doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"6.0.5"},"os":{"type":"Linux","name":"Ubuntu","architecture":"x86_64","version":"22.04"}}}} {"t":{"$date":"2024-11-19T10:36:09.753+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":600}} {"t":{"$date":"2024-11-19T10:36:09.844+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn9","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"__system","authenticationDatabase":"local","remote":"192.168.180.24:57060","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:36:09.868+00:00"},"s":"I", "c":"REPL", "id":21215, "ctx":"ReplCoord-1","msg":"Member is in new state","attr":{"hostAndPort":"mongo2.example.com:27019","newState":"SECONDARY"}} {"t":{"$date":"2024-11-19T10:36:09.908+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn12","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"__system","authenticationDatabase":"local","remote":"192.168.180.24:52950","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:36:09.913+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn11","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"__system","authenticationDatabase":"local","remote":"192.168.180.24:57062","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:36:10.354+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":800}} {"t":{"$date":"2024-11-19T10:36:10.631+00:00"},"s":"I", "c":"REPL", "id":21799, "ctx":"BackgroundSync","msg":"Sync source candidate chosen","attr":{"syncSource":"mongo2.example.com:27019"}} {"t":{"$date":"2024-11-19T10:36:10.632+00:00"},"s":"I", "c":"CONNPOOL", "id":22576, "ctx":"ReplCoordExternNetwork","msg":"Connecting","attr":{"hostAndPort":"mongo2.example.com:27019"}} {"t":{"$date":"2024-11-19T10:36:10.875+00:00"},"s":"I", "c":"REPL", "id":21088, "ctx":"BackgroundSync","msg":"Changed sync source","attr":{"oldSyncSource":"empty","newSyncSource":"mongo2.example.com:27019"}} {"t":{"$date":"2024-11-19T10:36:11.156+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":1000}} {"t":{"$date":"2024-11-19T10:36:11.165+00:00"},"s":"I", "c":"REPL", "id":21098, "ctx":"BackgroundSync","msg":"Starting rollback due to fetcher error","attr":{"error":"OplogStartMissing: Received an empty batch from sync source.","lastCommittedOpTime":{"ts":{"$timestamp":{"t":0,"i":0}},"t":-1}}} {"t":{"$date":"2024-11-19T10:36:11.165+00:00"},"s":"I", "c":"REPL", "id":21102, "ctx":"BackgroundSync","msg":"Rollback using 'recoverToStableTimestamp' method"} {"t":{"$date":"2024-11-19T10:36:11.165+00:00"},"s":"I", "c":"REPL", "id":21104, "ctx":"BackgroundSync","msg":"Scheduling rollback","attr":{"syncSource":"mongo2.example.com:27019"}} {"t":{"$date":"2024-11-19T10:36:11.165+00:00"},"s":"I", "c":"ROLLBACK", "id":21593, "ctx":"BackgroundSync","msg":"Transition to ROLLBACK"} {"t":{"$date":"2024-11-19T10:36:11.165+00:00"},"s":"I", "c":"REPL", "id":21340, "ctx":"BackgroundSync","msg":"State transition ops metrics","attr":{"metrics":{"lastStateTransition":"rollback","userOpsKilled":8,"userOpsRunning":6}}} {"t":{"$date":"2024-11-19T10:36:11.166+00:00"},"s":"I", "c":"REPL", "id":21358, "ctx":"BackgroundSync","msg":"Replica set state transition","attr":{"newState":"ROLLBACK","oldState":"SECONDARY"}} {"t":{"$date":"2024-11-19T10:36:11.167+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":1200}} {"t":{"$date":"2024-11-19T10:36:11.167+00:00"},"s":"I", "c":"NETWORK", "id":22991, "ctx":"BackgroundSync","msg":"Skip closing connection for connection","attr":{"connectionId":12}} {"t":{"$date":"2024-11-19T10:36:11.167+00:00"},"s":"I", "c":"NETWORK", "id":22991, "ctx":"BackgroundSync","msg":"Skip closing connection for connection","attr":{"connectionId":11}} {"t":{"$date":"2024-11-19T10:36:11.167+00:00"},"s":"I", "c":"NETWORK", "id":22991, "ctx":"BackgroundSync","msg":"Skip closing connection for connection","attr":{"connectionId":9}} {"t":{"$date":"2024-11-19T10:36:11.167+00:00"},"s":"I", "c":"NETWORK", "id":22989, "ctx":"conn6","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":9001,"codeName":"SocketException","errmsg":"Broken pipe"},"remote":"172.24.0.1:53604","connectionId":6}} {"t":{"$date":"2024-11-19T10:36:11.167+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn6","msg":"Connection ended","attr":{"remote":"172.24.0.1:53604","uuid":"597e6f54-47fc-4497-8964-f4c55344ec2f","connectionId":6,"connectionCount":7}} {"t":{"$date":"2024-11-19T10:36:11.168+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":1400}} {"t":{"$date":"2024-11-19T10:36:11.168+00:00"},"s":"I", "c":"NETWORK", "id":22989, "ctx":"conn4","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":9001,"codeName":"SocketException","errmsg":"Broken pipe"},"remote":"172.24.0.1:53598","connectionId":4}} {"t":{"$date":"2024-11-19T10:36:11.168+00:00"},"s":"I", "c":"NETWORK", "id":22989, "ctx":"conn3","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":9001,"codeName":"SocketException","errmsg":"Broken pipe"},"remote":"172.24.0.1:53594","connectionId":3}} {"t":{"$date":"2024-11-19T10:36:11.168+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn4","msg":"Connection ended","attr":{"remote":"172.24.0.1:53598","uuid":"047806bc-9718-4d33-bef5-8ca469ca0ac6","connectionId":4,"connectionCount":6}} {"t":{"$date":"2024-11-19T10:36:11.169+00:00"},"s":"I", "c":"NETWORK", "id":22989, "ctx":"conn8","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":9001,"codeName":"SocketException","errmsg":"Broken pipe"},"remote":"172.24.0.1:53606","connectionId":8}} {"t":{"$date":"2024-11-19T10:36:11.169+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn3","msg":"Connection ended","attr":{"remote":"172.24.0.1:53594","uuid":"e2454052-89de-4c84-9187-c75f5e1b3e7f","connectionId":3,"connectionCount":5}} {"t":{"$date":"2024-11-19T10:36:11.169+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn8","msg":"Connection ended","attr":{"remote":"172.24.0.1:53606","uuid":"4722dc40-9e18-4796-9426-87931cd66090","connectionId":8,"connectionCount":4}} {"t":{"$date":"2024-11-19T10:36:11.170+00:00"},"s":"I", "c":"NETWORK", "id":22989, "ctx":"conn7","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":9001,"codeName":"SocketException","errmsg":"Broken pipe"},"remote":"192.168.169.215:40092","connectionId":7}} {"t":{"$date":"2024-11-19T10:36:11.170+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn7","msg":"Connection ended","attr":{"remote":"192.168.169.215:40092","uuid":"38d3a205-adc4-422b-85ba-ed66eba33e2e","connectionId":7,"connectionCount":3}} {"t":{"$date":"2024-11-19T10:36:11.170+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.169.215:40094","uuid":"bd768682-ca62-4d7e-9db1-9ae6994af308","connectionId":15,"connectionCount":4}} {"t":{"$date":"2024-11-19T10:36:11.170+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53614","uuid":"94c1e830-c20d-4e34-97f9-cf1ecb69866c","connectionId":16,"connectionCount":5}} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn15","msg":"client metadata","attr":{"remote":"192.168.169.215:40094","client":"conn15","doc":{"driver":{"name":"nodejs|Mongoose","version":"5.9.0|7.6.3"},"platform":"Node.js v16.16.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"REPL", "id":5123007, "ctx":"BackgroundSync","msg":"Interrupting PrimaryOnlyService due to stepDown","attr":{"service":"TenantMigrationRecipientService","numInstances":0,"numOperationContexts":0}} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"REPL", "id":5123007, "ctx":"BackgroundSync","msg":"Interrupting PrimaryOnlyService due to stepDown","attr":{"service":"TenantMigrationDonorService","numInstances":0,"numOperationContexts":0}} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"REPL", "id":5123007, "ctx":"BackgroundSync","msg":"Interrupting PrimaryOnlyService due to stepDown","attr":{"service":"ShardSplitDonorService","numInstances":0,"numOperationContexts":0}} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"ROLLBACK", "id":21606, "ctx":"BackgroundSync","msg":"Finding common point"} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53624","uuid":"237085c9-026a-4536-89f2-8938226126e3","connectionId":17,"connectionCount":6}} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn16","msg":"client metadata","attr":{"remote":"172.24.0.1:53614","client":"conn16","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:36:11.171+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53626","uuid":"8c7f31be-554a-4d1e-93d8-c630695a5957","connectionId":18,"connectionCount":7}} {"t":{"$date":"2024-11-19T10:36:11.172+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn18","msg":"client metadata","attr":{"remote":"172.24.0.1:53626","client":"conn18","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:11.172+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn17","msg":"client metadata","attr":{"remote":"172.24.0.1:53624","client":"conn17","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v20.18.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:11.173+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:53638","uuid":"fe288eb3-1255-468e-b918-7541dbee705f","connectionId":19,"connectionCount":8}} {"t":{"$date":"2024-11-19T10:36:11.174+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn19","msg":"client metadata","attr":{"remote":"172.24.0.1:53638","client":"conn19","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v16.20.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:12.147+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:46186","uuid":"8de1b4a0-bdec-4909-92ae-ee2deb54fdfc","connectionId":21,"connectionCount":9}} {"t":{"$date":"2024-11-19T10:36:12.149+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn21","msg":"client metadata","attr":{"remote":"192.168.180.24:46186","client":"conn21","doc":{"driver":{"name":"nodejs|Mongoose","version":"4.17.2|6.13.3"},"platform":"Node.js v20.18.0, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.16.1.el8_10.x86_64","type":"Linux"}}}} {"t":{"$date":"2024-11-19T10:36:12.569+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":1600}} {"t":{"$date":"2024-11-19T10:36:12.668+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:37048","uuid":"1d992a95-0079-43f1-bbe3-0662aa5ad3fb","connectionId":22,"connectionCount":10}} {"t":{"$date":"2024-11-19T10:36:12.669+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn22","msg":"client metadata","attr":{"remote":"172.24.0.1:37048","client":"conn22","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:36:12.671+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:37060","uuid":"d0ccdcef-9ab0-47a8-8b40-88dc9c50895f","connectionId":23,"connectionCount":11}} {"t":{"$date":"2024-11-19T10:36:12.672+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn23","msg":"client metadata","attr":{"remote":"172.24.0.1:37060","client":"conn23","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:36:14.171+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":1800}} {"t":{"$date":"2024-11-19T10:36:14.345+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:57078","uuid":"17aeed97-4f0f-41dc-8ea0-f72417a57e45","connectionId":24,"connectionCount":12}} {"t":{"$date":"2024-11-19T10:36:14.348+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn24","msg":"client metadata","attr":{"remote":"192.168.180.24:57078","client":"conn24","doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"6.0.5"},"os":{"type":"Linux","name":"Ubuntu","architecture":"x86_64","version":"22.04"}}}} {"t":{"$date":"2024-11-19T10:36:14.445+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn24","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"__system","authenticationDatabase":"local","remote":"192.168.180.24:57078","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:36:14.635+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:52966","uuid":"3ffc3ec0-9323-4c17-b4fc-3d6d2d52409c","connectionId":25,"connectionCount":13}} {"t":{"$date":"2024-11-19T10:36:14.635+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn25","msg":"client metadata","attr":{"remote":"192.168.180.24:52966","client":"conn25","doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"6.0.5"},"os":{"type":"Linux","name":"Ubuntu","architecture":"x86_64","version":"22.04"}}}} {"t":{"$date":"2024-11-19T10:36:14.740+00:00"},"s":"I", "c":"ACCESS", "id":20250, "ctx":"conn25","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"__system","authenticationDatabase":"local","remote":"192.168.180.24:52966","extraInfo":{}}} {"t":{"$date":"2024-11-19T10:36:15.819+00:00"},"s":"I", "c":"-", "id":20883, "ctx":"conn16","msg":"Interrupted operation as its client disconnected","attr":{"opId":154}} {"t":{"$date":"2024-11-19T10:36:15.820+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn16","msg":"Connection ended","attr":{"remote":"172.24.0.1:53614","uuid":"94c1e830-c20d-4e34-97f9-cf1ecb69866c","connectionId":16,"connectionCount":12}} {"t":{"$date":"2024-11-19T10:36:15.973+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":2000}} {"t":{"$date":"2024-11-19T10:36:16.498+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:37064","uuid":"973615c5-b1c4-45a5-9062-3247f2459cde","connectionId":26,"connectionCount":13}} {"t":{"$date":"2024-11-19T10:36:16.499+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn26","msg":"client metadata","attr":{"remote":"172.24.0.1:37064","client":"conn26","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:36:16.500+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.24.0.1:37070","uuid":"02019ff1-9edd-4107-af8e-d754804324ac","connectionId":27,"connectionCount":14}} {"t":{"$date":"2024-11-19T10:36:16.501+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn27","msg":"client metadata","attr":{"remote":"172.24.0.1:37070","client":"conn27","doc":{"driver":{"name":"mongo-go-driver","version":"v1.13.1"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.23.2","env":{"container":{"runtime":"docker"}}}}} {"t":{"$date":"2024-11-19T10:36:17.975+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":2200}} {"t":{"$date":"2024-11-19T10:36:19.121+00:00"},"s":"I", "c":"-", "id":20883, "ctx":"conn19","msg":"Interrupted operation as its client disconnected","attr":{"opId":168}} {"t":{"$date":"2024-11-19T10:36:19.122+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn19","msg":"Connection ended","attr":{"remote":"172.24.0.1:53638","uuid":"fe288eb3-1255-468e-b918-7541dbee705f","connectionId":19,"connectionCount":13}} {"t":{"$date":"2024-11-19T10:36:20.178+00:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"InterruptedDueToReplStateChange: Cannot refresh keys collection cache during rollback","nextWakeupMillis":2400}} {"t":{"$date":"2024-11-19T10:36:20.458+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"192.168.180.24:39458","uuid":"b645718e-1e68-44b0-9cb0-95753e037f18","connectionId":28,"connectionCount":14}} {"t":{"$date":"2024-11-19T10:36:20.461+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn28","msg":"client metadata","attr":{"remote":"192.168.180.24:39458","client":"conn28","doc":{"application":{"name":"mongosh 1.8.2"},"driver":{"name":"nodejs|mongosh","version":"5.3.0|1.8.2"},"platform":"Node.js v16.19.1, LE","os":{"name":"linux","architecture":"x64","version":"4.18.0-553.16.1.el8_10.x86_64","type":"Linux"}}}}