2024-01-03T11:17:19.417Z MongoMS:ResolveConfig Debug Mode Enabled, through Environment Variable 2024-01-03T11:17:19.419Z MongoMS:ResolveConfig findPackageJson: Found package.json at "/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/package.json" 2024-01-03T11:17:19.764Z MongoMS:MongoMemoryServer create: Called .create() method 2024-01-03T11:17:19.764Z MongoMS:MongoMemoryServer Mongo[unknown]: start: Called .start() method 2024-01-03T11:17:19.765Z MongoMS:MongoMemoryServer Mongo[unknown]: _startUpInstance: Called MongoMemoryServer._startUpInstance() method 2024-01-03T11:17:19.765Z MongoMS:MongoMemoryServer Mongo[unknown]: getStartOptions: forceSamePort: false 2024-01-03T11:17:19.765Z MongoMS:DryMongoBinary generateOptions 2024-01-03T11:17:19.765Z MongoMS:DryMongoBinary generateDownloadPath: Generating Download Path, preferGlobal: "true" 2024-01-03T11:17:19.766Z MongoMS:DryMongoBinary generatePaths { version: '6.0.9', downloadDir: '', os: { os: 'darwin' }, platform: 'darwin', arch: 'x64', systemBinary: '' } 2024-01-03T11:17:19.767Z MongoMS:DryMongoBinary getBinaryName 2024-01-03T11:17:19.768Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.768Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.768Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.768Z MongoMS:DryMongoBinary generateDownloadPath: Paths: { homeCache: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9', modulesCache: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/node_modules/.cache/mongodb-memory-server/mongod-x64-darwin-6.0.9', relative: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/mongodb-binaries/mongod-x64-darwin-6.0.9', resolveConfig: '' } 2024-01-03T11:17:19.769Z MongoMS:DryMongoBinary generateDownloadPath: Found binary in homeCache: "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:19.770Z MongoMS:GetPort EXP_NET0LISTEN false 2024-01-03T11:17:19.772Z MongoMS:MongoMemoryServer Mongo[unknown]: _startUpInstance: Creating new MongoDB instance with options: { instance: { port: 39345, dbName: '', ip: '127.0.0.1', storageEngine: 'ephemeralForTest', replSet: undefined, dbPath: '/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-nNW0FJ', tmpDir: '/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-nNW0FJ', keyfileLocation: undefined, launchTimeout: undefined, args: undefined, auth: false }, binary: { version: '6.0.9' }, spawn: undefined } 2024-01-03T11:17:19.772Z MongoMS:MongoInstance create: Called .create() method 2024-01-03T11:17:19.772Z MongoMS:MongoInstance Mongo[39345]: start 2024-01-03T11:17:19.773Z MongoMS:MongoBinary getPath 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary generateOptions 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary generateDownloadPath: Generating Download Path, preferGlobal: "true" 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary generatePaths { version: '6.0.9', downloadDir: '', os: { os: 'darwin' }, platform: 'darwin', arch: 'x64', systemBinary: '' } 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary getBinaryName 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.773Z MongoMS:DryMongoBinary generateDownloadPath: Paths: { homeCache: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9', modulesCache: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/node_modules/.cache/mongodb-memory-server/mongod-x64-darwin-6.0.9', relative: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/mongodb-binaries/mongod-x64-darwin-6.0.9', resolveConfig: '' } 2024-01-03T11:17:19.774Z MongoMS:DryMongoBinary generateDownloadPath: Found binary in homeCache: "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:19.774Z MongoMS:MongoBinary getPath: MongoBinary options: { "version": "6.0.9", "downloadDir": "/Users/USER/.cache/mongodb-binaries", "os": { "os": "darwin" }, "platform": "darwin", "arch": "x64", "systemBinary": "", "checkMD5": true } 2024-01-03T11:17:19.774Z MongoMS:DryMongoBinary locateBinary: Trying to locate Binary for version "6.0.9" 2024-01-03T11:17:19.774Z MongoMS:DryMongoBinary generateOptions 2024-01-03T11:17:19.774Z MongoMS:DryMongoBinary generateDownloadPath: Generating Download Path, preferGlobal: "true" 2024-01-03T11:17:19.774Z MongoMS:DryMongoBinary generatePaths { version: '6.0.9', downloadDir: '/Users/USER/.cache/mongodb-binaries', os: { os: 'darwin' }, platform: 'darwin', arch: 'x64', systemBinary: '' } 2024-01-03T11:17:19.774Z MongoMS:DryMongoBinary getBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary generatePaths: resolveConfigValue is not empty 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary generateDownloadPath: Paths: { homeCache: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9', modulesCache: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/node_modules/.cache/mongodb-memory-server/mongod-x64-darwin-6.0.9', relative: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/mongodb-binaries/mongod-x64-darwin-6.0.9', resolveConfig: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9' } 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary generateDownloadPath: Found binary in resolveConfig (DOWNLOAD_DIR): "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary locateBinary: running generateDownloadPath 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary generateDownloadPath: Generating Download Path, preferGlobal: "true" 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary generatePaths { version: '6.0.9', downloadDir: '/Users/USER/.cache/mongodb-binaries', os: { os: 'darwin' }, platform: 'darwin', arch: 'x64', systemBinary: '' } 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary getBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary generatePaths: resolveConfigValue is not empty 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:19.775Z MongoMS:DryMongoBinary generateDownloadPath: Paths: { homeCache: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9', modulesCache: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/node_modules/.cache/mongodb-memory-server/mongod-x64-darwin-6.0.9', relative: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/mongodb-binaries/mongod-x64-darwin-6.0.9', resolveConfig: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9' } 2024-01-03T11:17:19.776Z MongoMS:DryMongoBinary generateDownloadPath: Found binary in resolveConfig (DOWNLOAD_DIR): "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:19.776Z MongoMS:DryMongoBinary locateBinary: found binary at "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:19.776Z MongoMS:MongoBinary getPath: Mongod binary path: "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:19.776Z MongoMS:MongoInstance Mongo[39345]: start: Starting Processes 2024-01-03T11:17:19.776Z MongoMS:MongoInstance Mongo[39345]: _launchMongod: Launching Mongod Process 2024-01-03T11:17:19.776Z MongoMS:MongoInstance Mongo[39345]: prepareCommandArgs 2024-01-03T11:17:19.776Z MongoMS:MongoInstance Mongo[39345]: prepareCommandArgs: final argument array:["--port","39345","--dbpath","/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-nNW0FJ","--storageEngine","ephemeralForTest","--bind_ip","127.0.0.1","--noauth"] 2024-01-03T11:17:19.781Z MongoMS:MongoInstance Mongo[39345]: _launchKiller: Launching Killer Process (parent: 54756, child: 54760) 2024-01-03T11:17:19.915Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.914Z"},"s":"I", "c":"CONTROL", "id":5324701, "ctx":"-","msg":"Test storage engine does not support enableMajorityReadConcern=true, forcibly setting to false","attr":{"storageEngine":"ephemeralForTest"}} {"t":{"$date":"2024-01-03T11:17:19.915Z"},"s":"W", "c":"CONTROL", "id":4788401, "ctx":"-","msg":"Lock-free reads is not compatible with enableMajorityReadConcern=false: disabling lock-free reads."}"" 2024-01-03T11:17:19.918Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.918+00:00"},"s":"I", "c":"NETWORK", "id":4915701, "ctx":"-","msg":"Initialized wire specification","attr":{"spec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":17},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":17},"outgoing":{"minWireVersion":6,"maxWireVersion":17},"isInternalClient":true}}}"" 2024-01-03T11:17:19.920Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.920+00:00"},"s":"I", "c":"CONTROL", "id":23285, "ctx":"thread1","msg":"Automatically disabling TLS 1.0, to force-enable TLS 1.0 specify --sslDisabledProtocols 'none'"}"" 2024-01-03T11:17:19.920Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.920+00:00"},"s":"I", "c":"NETWORK", "id":4648602, "ctx":"thread1","msg":"Implicit TCP FastOpen in use."}"" 2024-01-03T11:17:19.921Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.921+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"thread1","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationDonorService","namespace":"config.tenantMigrationDonors"}} {"t":{"$date":"2024-01-03T11:17:19.921+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"thread1","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationRecipientService","namespace":"config.tenantMigrationRecipients"}} {"t":{"$date":"2024-01-03T11:17:19.921+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"thread1","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"ShardSplitDonorService","namespace":"config.tenantSplitDonors"}}"" 2024-01-03T11:17:19.922Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.921+00:00"},"s":"I", "c":"CONTROL", "id":5945603, "ctx":"thread1","msg":"Multi threading initialized"}"" 2024-01-03T11:17:19.922Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.922+00:00"},"s":"I", "c":"CONTROL", "id":4615611, "ctx":"initandlisten","msg":"MongoDB starting","attr":{"pid":54760,"port":39345,"dbPath":"/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-nNW0FJ","architecture":"64-bit","host":"3c22fb93beb5"}}"" 2024-01-03T11:17:19.922Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.922+00:00"},"s":"I", "c":"CONTROL", "id":23403, "ctx":"initandlisten","msg":"Build Info","attr":{"buildInfo":{"version":"6.0.9","gitVersion":"90c65f9cc8fc4e6664a5848230abaa9b3f3b02f7","modules":[],"allocator":"system","environment":{"distarch":"x86_64","target_arch":"x86_64"}}}} {"t":{"$date":"2024-01-03T11:17:19.922+00:00"},"s":"I", "c":"CONTROL", "id":51765, "ctx":"initandlisten","msg":"Operating System","attr":{"os":{"name":"Mac OS X","version":"23.2.0"}}}"" 2024-01-03T11:17:19.922Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.922+00:00"},"s":"I", "c":"CONTROL", "id":21951, "ctx":"initandlisten","msg":"Options set by command line","attr":{"options":{"net":{"bindIp":"127.0.0.1","port":39345},"security":{"authorization":"disabled"},"storage":{"dbPath":"/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-nNW0FJ","engine":"ephemeralForTest"}}}}"" 2024-01-03T11:17:19.923Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.923+00:00"},"s":"I", "c":"NETWORK", "id":5693100, "ctx":"initandlisten","msg":"Asio socket.set_option failed with std::system_error","attr":{"note":"acceptor TCP fast open","option":{"level":6,"name":261,"data":"00 04 00 00"},"error":{"what":"set_option: Invalid argument","message":"Invalid argument","category":"asio.system","value":22}}}"" 2024-01-03T11:17:19.925Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"CONTROL", "id":22197, "ctx":"initandlisten","msg":"The ephemeralForTest storage engine is for testing only. Do not use in production","tags":["startupWarnings"]}"" 2024-01-03T11:17:19.925Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"initandlisten","msg":"createCollection","attr":{"namespace":"admin.system.version","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"0853b3a9-bcdd-49fc-bb88-e5c215eeab22"}},"options":{"uuid":{"$uuid":"0853b3a9-bcdd-49fc-bb88-e5c215eeab22"}}}}"" 2024-01-03T11:17:19.925Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"initandlisten","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"0853b3a9-bcdd-49fc-bb88-e5c215eeab22"}},"namespace":"admin.system.version","index":"_id_","ident":"index-1-1963046817621729169","collectionIdent":"collection-0-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:19.925Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"REPL", "id":20459, "ctx":"initandlisten","msg":"Setting featureCompatibilityVersion","attr":{"newVersion":"6.0"}} {"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"REPL", "id":5853300, "ctx":"initandlisten","msg":"current featureCompatibilityVersion value","attr":{"featureCompatibilityVersion":"6.0","context":"setFCV"}}"" 2024-01-03T11:17:19.925Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+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}}}"" 2024-01-03T11:17:19.925Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"NETWORK", "id":4915702, "ctx":"initandlisten","msg":"Updated wire specification","attr":{"oldSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":17},"incomingInternalClient":{"minWireVersion":17,"maxWireVersion":17},"outgoing":{"minWireVersion":17,"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-01-03T11:17:19.925+00:00"},"s":"I", "c":"REPL", "id":5853300, "ctx":"initandlisten","msg":"current featureCompatibilityVersion value","attr":{"featureCompatibilityVersion":"6.0","context":"startup"}}"" 2024-01-03T11:17:19.925Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"STORAGE", "id":5071100, "ctx":"initandlisten","msg":"Clearing temp directory"}"" 2024-01-03T11:17:19.926Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"CONTROL", "id":20536, "ctx":"initandlisten","msg":"Flow Control is enabled on this deployment"} {"t":{"$date":"2024-01-03T11:17:19.925+00:00"},"s":"I", "c":"FTDC", "id":20625, "ctx":"initandlisten","msg":"Initializing full-time diagnostic data capture","attr":{"dataDirectory":"/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-nNW0FJ/diagnostic.data"}}"" 2024-01-03T11:17:19.926Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.926+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"initandlisten","msg":"createCollection","attr":{"namespace":"local.startup_log","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"cf67b4b9-3695-46a7-a701-cecd5db66f9d"}},"options":{"capped":true,"size":10485760}}}"" 2024-01-03T11:17:19.926Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.926+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"initandlisten","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"cf67b4b9-3695-46a7-a701-cecd5db66f9d"}},"namespace":"local.startup_log","index":"_id_","ident":"index-3-1963046817621729169","collectionIdent":"collection-2-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:19.927Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.927+00:00"},"s":"I", "c":"REPL", "id":6015317, "ctx":"initandlisten","msg":"Setting new configuration state","attr":{"newState":"ConfigReplicationDisabled","oldState":"ConfigPreStart"}} {"t":{"$date":"2024-01-03T11:17:19.927+00:00"},"s":"I", "c":"STORAGE", "id":22262, "ctx":"initandlisten","msg":"Timestamp monitor starting"}"" 2024-01-03T11:17:19.927Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.927+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"/tmp/mongodb-39345.sock"}}"" 2024-01-03T11:17:19.928Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.927+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"127.0.0.1"}} {"t":{"$date":"2024-01-03T11:17:19.927+00:00"},"s":"I", "c":"NETWORK", "id":23016, "ctx":"listener","msg":"Waiting for connections","attr":{"port":39345,"ssl":"off"}}"" 2024-01-03T11:17:19.928Z MongoMS:MongoInstance Mongo[39345]: constructor: Instance is ready! 2024-01-03T11:17:19.928Z MongoMS:MongoInstance Mongo[39345]: start: Processes Started 2024-01-03T11:17:19.928Z MongoMS:MongoMemoryServer Mongo[39345]: _startUpInstance: Instance Started, createAuth: "false" 2024-01-03T11:17:19.928Z MongoMS:MongoMemoryServer Mongo[39345]: start: Instance fully Started 2024-01-03T11:17:19.928Z MongoMS:MongoMemoryServer Mongo[39345]: getUri: running test undefined 2024-01-03T11:17:19.938Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.928+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":"NamespaceNotFound: config.system.sessions does not exist"}} {"t":{"$date":"2024-01-03T11:17:19.928+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"LogicalSessionCacheRefresh","msg":"createCollection","attr":{"namespace":"config.system.sessions","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"ca23e983-79f2-4649-a2a6-602655a6078b"}},"options":{}}} {"t":{"$date":"2024-01-03T11:17:19.928+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"LogicalSessionCacheRefresh","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"ca23e983-79f2-4649-a2a6-602655a6078b"}},"namespace":"config.system.sessions","index":"_id_","ident":"index-5-1963046817621729169","collectionIdent":"collection-4-1963046817621729169","commitTimestamp":null}} {"t":{"$date":"2024-01-03T11:17:19.928+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"LogicalSessionCacheRefresh","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"ca23e983-79f2-4649-a2a6-602655a6078b"}},"namespace":"config.system.sessions","index":"lsidTTLIndex","ident":"index-6-1963046817621729169","collectionIdent":"collection-4-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:19.942Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.939+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"127.0.0.1:63360","uuid":"ada7699d-f8b7-4565-a441-9cf1c669154e","connectionId":1,"connectionCount":1}}"" 2024-01-03T11:17:19.942Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.942+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn1","msg":"client metadata","attr":{"remote":"127.0.0.1:63360","client":"conn1","doc":{"driver":{"name":"nodejs","version":"4.17.1"},"platform":"Node.js v20.7.0, LE","os":{"name":"darwin","architecture":"x64","version":"23.2.0","type":"Darwin"}}}}"" 2024-01-03T11:17:19.957Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.957+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"127.0.0.1:63361","uuid":"ffcff6f9-9ee5-45ad-8f8a-04647994a7bf","connectionId":2,"connectionCount":2}}"" 2024-01-03T11:17:19.957Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.957+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn2","msg":"client metadata","attr":{"remote":"127.0.0.1:63361","client":"conn2","doc":{"driver":{"name":"nodejs","version":"4.17.1"},"platform":"Node.js v20.7.0, LE","os":{"name":"darwin","architecture":"x64","version":"23.2.0","type":"Darwin"}}}}"" 2024-01-03T11:17:19.966Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.966+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.nodes","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"a1d9e1af-ba0b-409c-a52e-60e42d433e96"}},"options":{}}}"" 2024-01-03T11:17:19.966Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:19.966+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"a1d9e1af-ba0b-409c-a52e-60e42d433e96"}},"namespace":"test.nodes","index":"_id_","ident":"index-8-1963046817621729169","collectionIdent":"collection-7-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:20.142Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.142+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.versions","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"5dc8ccb3-1da3-4936-a753-fbb0fd766855"}},"options":{}}}"" 2024-01-03T11:17:20.142Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.142+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"5dc8ccb3-1da3-4936-a753-fbb0fd766855"}},"namespace":"test.versions","index":"_id_","ident":"index-10-1963046817621729169","collectionIdent":"collection-9-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:20.376Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.376+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.snapshots","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"5971e32e-a166-4980-99df-82d14bfef074"}},"options":{}}}"" 2024-01-03T11:17:20.376Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.376+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"5971e32e-a166-4980-99df-82d14bfef074"}},"namespace":"test.snapshots","index":"_id_","ident":"index-12-1963046817621729169","collectionIdent":"collection-11-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:20.540Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.539+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.snapshotsLatest","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"cee7998e-695e-4c10-9319-42fd1ae53954"}},"options":{}}}"" 2024-01-03T11:17:20.540Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.540+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"cee7998e-695e-4c10-9319-42fd1ae53954"}},"namespace":"test.snapshotsLatest","index":"_id_","ident":"index-14-1963046817621729169","collectionIdent":"collection-13-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:20.973Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.966+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"127.0.0.1:63362","uuid":"26a374fd-c1a1-41a6-9e0b-037ba798b842","connectionId":3,"connectionCount":3}}"" 2024-01-03T11:17:20.976Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.974+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn3","msg":"client metadata","attr":{"remote":"127.0.0.1:63362","client":"conn3","doc":{"driver":{"name":"nodejs","version":"4.17.1"},"platform":"Node.js v20.7.0, LE","os":{"name":"darwin","architecture":"x64","version":"23.2.0","type":"Darwin"}}}}"" 2024-01-03T11:17:20.976Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.976+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.structures.files","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"b430cbd7-7667-4bdf-95f5-382818fcce98"}},"options":{}}} {"t":{"$date":"2024-01-03T11:17:20.976+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"b430cbd7-7667-4bdf-95f5-382818fcce98"}},"namespace":"test.structures.files","index":"_id_","ident":"index-16-1963046817621729169","collectionIdent":"collection-15-1963046817621729169","commitTimestamp":null}} {"t":{"$date":"2024-01-03T11:17:20.976+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"b430cbd7-7667-4bdf-95f5-382818fcce98"}},"namespace":"test.structures.files","index":"filename_1_uploadDate_1","ident":"index-17-1963046817621729169","collectionIdent":"collection-15-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:20.988Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:20.978+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.structures.chunks","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"996ee999-4b10-4eaf-94c6-73d8e70d9363"}},"options":{}}} {"t":{"$date":"2024-01-03T11:17:20.979+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"996ee999-4b10-4eaf-94c6-73d8e70d9363"}},"namespace":"test.structures.chunks","index":"_id_","ident":"index-19-1963046817621729169","collectionIdent":"collection-18-1963046817621729169","commitTimestamp":null}} {"t":{"$date":"2024-01-03T11:17:20.979+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"996ee999-4b10-4eaf-94c6-73d8e70d9363"}},"namespace":"test.structures.chunks","index":"files_id_1_n_1","ident":"index-20-1963046817621729169","collectionIdent":"collection-18-1963046817621729169","commitTimestamp":null}}"" 2024-01-03T11:17:21.288Z MongoMS:MongoMemoryServer create: Called .create() method 2024-01-03T11:17:21.288Z MongoMS:MongoMemoryServer Mongo[unknown]: start: Called .start() method 2024-01-03T11:17:21.288Z MongoMS:MongoMemoryServer Mongo[unknown]: _startUpInstance: Called MongoMemoryServer._startUpInstance() method 2024-01-03T11:17:21.288Z MongoMS:MongoMemoryServer Mongo[unknown]: getStartOptions: forceSamePort: false 2024-01-03T11:17:21.288Z MongoMS:DryMongoBinary generateOptions 2024-01-03T11:17:21.289Z MongoMS:DryMongoBinary generateDownloadPath: Generating Download Path, preferGlobal: "true" 2024-01-03T11:17:21.289Z MongoMS:DryMongoBinary generatePaths { version: '6.0.9', downloadDir: '', os: { os: 'darwin' }, platform: 'darwin', arch: 'x64', systemBinary: '' } 2024-01-03T11:17:21.289Z MongoMS:DryMongoBinary getBinaryName 2024-01-03T11:17:21.289Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.289Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.289Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.289Z MongoMS:DryMongoBinary generateDownloadPath: Paths: { homeCache: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9', modulesCache: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/node_modules/.cache/mongodb-memory-server/mongod-x64-darwin-6.0.9', relative: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/mongodb-binaries/mongod-x64-darwin-6.0.9', resolveConfig: '' } 2024-01-03T11:17:21.290Z MongoMS:DryMongoBinary generateDownloadPath: Found binary in homeCache: "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:21.290Z MongoMS:GetPort EXP_NET0LISTEN false 2024-01-03T11:17:21.291Z MongoMS:MongoMemoryServer Mongo[unknown]: _startUpInstance: Creating new MongoDB instance with options: { instance: { port: 40865, dbName: '', ip: '127.0.0.1', storageEngine: 'ephemeralForTest', replSet: undefined, dbPath: '/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-T1g1Ll', tmpDir: '/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-T1g1Ll', keyfileLocation: undefined, launchTimeout: undefined, args: undefined, auth: false }, binary: { version: '6.0.9' }, spawn: undefined } 2024-01-03T11:17:21.291Z MongoMS:MongoInstance create: Called .create() method 2024-01-03T11:17:21.291Z MongoMS:MongoInstance Mongo[40865]: start 2024-01-03T11:17:21.291Z MongoMS:MongoBinary getPath 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary generateOptions 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary generateDownloadPath: Generating Download Path, preferGlobal: "true" 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary generatePaths { version: '6.0.9', downloadDir: '', os: { os: 'darwin' }, platform: 'darwin', arch: 'x64', systemBinary: '' } 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary getBinaryName 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.291Z MongoMS:DryMongoBinary generateDownloadPath: Paths: { homeCache: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9', modulesCache: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/node_modules/.cache/mongodb-memory-server/mongod-x64-darwin-6.0.9', relative: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/mongodb-binaries/mongod-x64-darwin-6.0.9', resolveConfig: '' } 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary generateDownloadPath: Found binary in homeCache: "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:21.292Z MongoMS:MongoBinary getPath: MongoBinary options: { "version": "6.0.9", "downloadDir": "/Users/USER/.cache/mongodb-binaries", "os": { "os": "darwin" }, "platform": "darwin", "arch": "x64", "systemBinary": "", "checkMD5": true } 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary locateBinary: Trying to locate Binary for version "6.0.9" 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary generateOptions 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary generateDownloadPath: Generating Download Path, preferGlobal: "true" 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary generatePaths { version: '6.0.9', downloadDir: '/Users/USER/.cache/mongodb-binaries', os: { os: 'darwin' }, platform: 'darwin', arch: 'x64', systemBinary: '' } 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary getBinaryName 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary generatePaths: resolveConfigValue is not empty 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary combineBinaryName 2024-01-03T11:17:21.292Z MongoMS:DryMongoBinary generateDownloadPath: Paths: { homeCache: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9', modulesCache: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/node_modules/.cache/mongodb-memory-server/mongod-x64-darwin-6.0.9', relative: '/Users/USER/PROJECTS_DIR/MY_SERVICE_DIR/mongodb-binaries/mongod-x64-darwin-6.0.9', resolveConfig: '/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9' } 2024-01-03T11:17:21.293Z MongoMS:DryMongoBinary generateDownloadPath: Found binary in resolveConfig (DOWNLOAD_DIR): "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:21.293Z MongoMS:DryMongoBinary locateBinary: Requested Version found in cache: "[6.0.9, /Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9]" 2024-01-03T11:17:21.293Z MongoMS:MongoBinary getPath: Mongod binary path: "/Users/USER/.cache/mongodb-binaries/mongod-x64-darwin-6.0.9" 2024-01-03T11:17:21.293Z MongoMS:MongoInstance Mongo[40865]: start: Starting Processes 2024-01-03T11:17:21.293Z MongoMS:MongoInstance Mongo[40865]: _launchMongod: Launching Mongod Process 2024-01-03T11:17:21.293Z MongoMS:MongoInstance Mongo[40865]: prepareCommandArgs 2024-01-03T11:17:21.293Z MongoMS:MongoInstance Mongo[40865]: prepareCommandArgs: final argument array:["--port","40865","--dbpath","/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-T1g1Ll","--storageEngine","ephemeralForTest","--bind_ip","127.0.0.1","--noauth"] 2024-01-03T11:17:21.294Z MongoMS:MongoInstance Mongo[40865]: _launchKiller: Launching Killer Process (parent: 54756, child: 54763) 2024-01-03T11:17:21.434Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.432Z"},"s":"I", "c":"CONTROL", "id":5324701, "ctx":"-","msg":"Test storage engine does not support enableMajorityReadConcern=true, forcibly setting to false","attr":{"storageEngine":"ephemeralForTest"}} {"t":{"$date":"2024-01-03T11:17:21.434Z"},"s":"W", "c":"CONTROL", "id":4788401, "ctx":"-","msg":"Lock-free reads is not compatible with enableMajorityReadConcern=false: disabling lock-free reads."}"" 2024-01-03T11:17:21.435Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.435+00:00"},"s":"I", "c":"CONTROL", "id":23285, "ctx":"thread1","msg":"Automatically disabling TLS 1.0, to force-enable TLS 1.0 specify --sslDisabledProtocols 'none'"} {"t":{"$date":"2024-01-03T11:17:21.435+00:00"},"s":"I", "c":"NETWORK", "id":4915701, "ctx":"thread1","msg":"Initialized wire specification","attr":{"spec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":17},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":17},"outgoing":{"minWireVersion":6,"maxWireVersion":17},"isInternalClient":true}}}"" 2024-01-03T11:17:21.439Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.439+00:00"},"s":"I", "c":"NETWORK", "id":4648602, "ctx":"thread1","msg":"Implicit TCP FastOpen in use."}"" 2024-01-03T11:17:21.440Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"thread1","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationDonorService","namespace":"config.tenantMigrationDonors"}} {"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"thread1","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationRecipientService","namespace":"config.tenantMigrationRecipients"}} {"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"REPL", "id":5123008, "ctx":"thread1","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"ShardSplitDonorService","namespace":"config.tenantSplitDonors"}}"" 2024-01-03T11:17:21.440Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"CONTROL", "id":5945603, "ctx":"thread1","msg":"Multi threading initialized"}"" 2024-01-03T11:17:21.440Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"CONTROL", "id":4615611, "ctx":"initandlisten","msg":"MongoDB starting","attr":{"pid":54763,"port":40865,"dbPath":"/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-T1g1Ll","architecture":"64-bit","host":"3c22fb93beb5"}}"" 2024-01-03T11:17:21.440Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"CONTROL", "id":23403, "ctx":"initandlisten","msg":"Build Info","attr":{"buildInfo":{"version":"6.0.9","gitVersion":"90c65f9cc8fc4e6664a5848230abaa9b3f3b02f7","modules":[],"allocator":"system","environment":{"distarch":"x86_64","target_arch":"x86_64"}}}} {"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"CONTROL", "id":51765, "ctx":"initandlisten","msg":"Operating System","attr":{"os":{"name":"Mac OS X","version":"23.2.0"}}} {"t":{"$date":"2024-01-03T11:17:21.440+00:00"},"s":"I", "c":"CONTROL", "id":21951, "ctx":"initandlisten","msg":"Options set by command line","attr":{"options":{"net":{"bindIp":"127.0.0.1","port":40865},"security":{"authorization":"disabled"},"storage":{"dbPath":"/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-T1g1Ll","engine":"ephemeralForTest"}}}}"" 2024-01-03T11:17:21.441Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.441+00:00"},"s":"I", "c":"NETWORK", "id":5693100, "ctx":"initandlisten","msg":"Asio socket.set_option failed with std::system_error","attr":{"note":"acceptor TCP fast open","option":{"level":6,"name":261,"data":"00 04 00 00"},"error":{"what":"set_option: Invalid argument","message":"Invalid argument","category":"asio.system","value":22}}}"" 2024-01-03T11:17:21.443Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.442+00:00"},"s":"I", "c":"CONTROL", "id":22197, "ctx":"initandlisten","msg":"The ephemeralForTest storage engine is for testing only. Do not use in production","tags":["startupWarnings"]}"" 2024-01-03T11:17:21.443Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"initandlisten","msg":"createCollection","attr":{"namespace":"admin.system.version","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"32a458d4-6b63-4bc9-a891-151fc16e01b1"}},"options":{"uuid":{"$uuid":"32a458d4-6b63-4bc9-a891-151fc16e01b1"}}}}"" 2024-01-03T11:17:21.443Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"initandlisten","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"32a458d4-6b63-4bc9-a891-151fc16e01b1"}},"namespace":"admin.system.version","index":"_id_","ident":"index-1--5401962669269818485","collectionIdent":"collection-0--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:21.443Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"REPL", "id":20459, "ctx":"initandlisten","msg":"Setting featureCompatibilityVersion","attr":{"newVersion":"6.0"}}"" 2024-01-03T11:17:21.443Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"REPL", "id":5853300, "ctx":"initandlisten","msg":"current featureCompatibilityVersion value","attr":{"featureCompatibilityVersion":"6.0","context":"setFCV"}} {"t":{"$date":"2024-01-03T11:17:21.443+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}}}"" 2024-01-03T11:17:21.443Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"NETWORK", "id":4915702, "ctx":"initandlisten","msg":"Updated wire specification","attr":{"oldSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":17},"incomingInternalClient":{"minWireVersion":17,"maxWireVersion":17},"outgoing":{"minWireVersion":17,"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-01-03T11:17:21.443+00:00"},"s":"I", "c":"REPL", "id":5853300, "ctx":"initandlisten","msg":"current featureCompatibilityVersion value","attr":{"featureCompatibilityVersion":"6.0","context":"startup"}} {"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"STORAGE", "id":5071100, "ctx":"initandlisten","msg":"Clearing temp directory"}"" 2024-01-03T11:17:21.443Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"CONTROL", "id":20536, "ctx":"initandlisten","msg":"Flow Control is enabled on this deployment"}"" 2024-01-03T11:17:21.444Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.443+00:00"},"s":"I", "c":"FTDC", "id":20625, "ctx":"initandlisten","msg":"Initializing full-time diagnostic data capture","attr":{"dataDirectory":"/var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-T1g1Ll/diagnostic.data"}}"" 2024-01-03T11:17:21.444Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.444+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"initandlisten","msg":"createCollection","attr":{"namespace":"local.startup_log","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"0de86489-9677-4429-895f-7479e1d25efe"}},"options":{"capped":true,"size":10485760}}}"" 2024-01-03T11:17:21.444Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.444+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"initandlisten","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"0de86489-9677-4429-895f-7479e1d25efe"}},"namespace":"local.startup_log","index":"_id_","ident":"index-3--5401962669269818485","collectionIdent":"collection-2--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:21.444Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.444+00:00"},"s":"I", "c":"REPL", "id":6015317, "ctx":"initandlisten","msg":"Setting new configuration state","attr":{"newState":"ConfigReplicationDisabled","oldState":"ConfigPreStart"}}"" 2024-01-03T11:17:21.445Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.444+00:00"},"s":"I", "c":"STORAGE", "id":22262, "ctx":"initandlisten","msg":"Timestamp monitor starting"}"" 2024-01-03T11:17:21.445Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.445+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"/tmp/mongodb-40865.sock"}}"" 2024-01-03T11:17:21.445Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.445+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"127.0.0.1"}} {"t":{"$date":"2024-01-03T11:17:21.445+00:00"},"s":"I", "c":"NETWORK", "id":23016, "ctx":"listener","msg":"Waiting for connections","attr":{"port":40865,"ssl":"off"}}"" 2024-01-03T11:17:21.445Z MongoMS:MongoInstance Mongo[40865]: constructor: Instance is ready! 2024-01-03T11:17:21.445Z MongoMS:MongoInstance Mongo[40865]: start: Processes Started 2024-01-03T11:17:21.445Z MongoMS:MongoMemoryServer Mongo[40865]: _startUpInstance: Instance Started, createAuth: "false" 2024-01-03T11:17:21.445Z MongoMS:MongoMemoryServer Mongo[40865]: start: Instance fully Started 2024-01-03T11:17:21.445Z MongoMS:MongoMemoryServer Mongo[40865]: getUri: running test undefined 2024-01-03T11:17:21.447Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.445+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":"NamespaceNotFound: config.system.sessions does not exist"}} {"t":{"$date":"2024-01-03T11:17:21.445+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"LogicalSessionCacheRefresh","msg":"createCollection","attr":{"namespace":"config.system.sessions","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"8fd7088d-aa52-4ea0-bec2-1e3aacb1da48"}},"options":{}}} {"t":{"$date":"2024-01-03T11:17:21.445+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"LogicalSessionCacheRefresh","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"8fd7088d-aa52-4ea0-bec2-1e3aacb1da48"}},"namespace":"config.system.sessions","index":"_id_","ident":"index-5--5401962669269818485","collectionIdent":"collection-4--5401962669269818485","commitTimestamp":null}} {"t":{"$date":"2024-01-03T11:17:21.445+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"LogicalSessionCacheRefresh","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"8fd7088d-aa52-4ea0-bec2-1e3aacb1da48"}},"namespace":"config.system.sessions","index":"lsidTTLIndex","ident":"index-6--5401962669269818485","collectionIdent":"collection-4--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:21.448Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.448+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"127.0.0.1:63363","uuid":"3f95f8cf-afaa-4832-a6dd-afecaebc94e4","connectionId":1,"connectionCount":1}}"" 2024-01-03T11:17:21.448Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.448+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn1","msg":"client metadata","attr":{"remote":"127.0.0.1:63363","client":"conn1","doc":{"driver":{"name":"nodejs","version":"4.17.1"},"platform":"Node.js v20.7.0, LE","os":{"name":"darwin","architecture":"x64","version":"23.2.0","type":"Darwin"}}}}"" 2024-01-03T11:17:21.455Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.454+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"127.0.0.1:63364","uuid":"1929c024-4fe9-492c-9a2a-fdb68e2cee21","connectionId":2,"connectionCount":2}}"" 2024-01-03T11:17:21.455Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.455+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn2","msg":"client metadata","attr":{"remote":"127.0.0.1:63364","client":"conn2","doc":{"driver":{"name":"nodejs","version":"4.17.1"},"platform":"Node.js v20.7.0, LE","os":{"name":"darwin","architecture":"x64","version":"23.2.0","type":"Darwin"}}}}"" 2024-01-03T11:17:21.459Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.459+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.nodes","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"21f7dbf0-321a-483e-b3fd-12ac13fa92e2"}},"options":{}}}"" 2024-01-03T11:17:21.459Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.459+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"21f7dbf0-321a-483e-b3fd-12ac13fa92e2"}},"namespace":"test.nodes","index":"_id_","ident":"index-8--5401962669269818485","collectionIdent":"collection-7--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:21.605Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.605+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.versions","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"646b72e8-7e61-4fbc-a596-c824a14751f5"}},"options":{}}}"" 2024-01-03T11:17:21.605Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.605+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"646b72e8-7e61-4fbc-a596-c824a14751f5"}},"namespace":"test.versions","index":"_id_","ident":"index-10--5401962669269818485","collectionIdent":"collection-9--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:21.829Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.829+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.snapshots","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"0c25fa13-1abc-401f-b0bd-2eb03aece20b"}},"options":{}}}"" 2024-01-03T11:17:21.829Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.829+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"0c25fa13-1abc-401f-b0bd-2eb03aece20b"}},"namespace":"test.snapshots","index":"_id_","ident":"index-12--5401962669269818485","collectionIdent":"collection-11--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:21.982Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.982+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.snapshotsLatest","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"f87ae8ff-18ec-4a96-8d6c-450bc95b0eb3"}},"options":{}}}"" 2024-01-03T11:17:21.982Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:21.982+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"f87ae8ff-18ec-4a96-8d6c-450bc95b0eb3"}},"namespace":"test.snapshotsLatest","index":"_id_","ident":"index-14--5401962669269818485","collectionIdent":"collection-13--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:22.318Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.317+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"127.0.0.1:63365","uuid":"eb68db9c-b1e1-462b-af6a-62368743ee9a","connectionId":3,"connectionCount":3}}"" 2024-01-03T11:17:22.319Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.319+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn3","msg":"client metadata","attr":{"remote":"127.0.0.1:63365","client":"conn3","doc":{"driver":{"name":"nodejs","version":"4.17.1"},"platform":"Node.js v20.7.0, LE","os":{"name":"darwin","architecture":"x64","version":"23.2.0","type":"Darwin"}}}}"" 2024-01-03T11:17:22.320Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.319+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.structures.files","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"d284fd05-b97d-4a6c-b97b-e4b806cda533"}},"options":{}}}"" 2024-01-03T11:17:22.320Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.320+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"d284fd05-b97d-4a6c-b97b-e4b806cda533"}},"namespace":"test.structures.files","index":"_id_","ident":"index-16--5401962669269818485","collectionIdent":"collection-15--5401962669269818485","commitTimestamp":null}} {"t":{"$date":"2024-01-03T11:17:22.320+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"d284fd05-b97d-4a6c-b97b-e4b806cda533"}},"namespace":"test.structures.files","index":"filename_1_uploadDate_1","ident":"index-17--5401962669269818485","collectionIdent":"collection-15--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:22.328Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.328+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn2","msg":"createCollection","attr":{"namespace":"test.structures.chunks","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"b9b6f0bd-a6b7-4e61-b611-ac1f3495ee46"}},"options":{}}}"" 2024-01-03T11:17:22.328Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.328+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"b9b6f0bd-a6b7-4e61-b611-ac1f3495ee46"}},"namespace":"test.structures.chunks","index":"_id_","ident":"index-19--5401962669269818485","collectionIdent":"collection-18--5401962669269818485","commitTimestamp":null}} {"t":{"$date":"2024-01-03T11:17:22.328+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn2","msg":"Index build: done building","attr":{"buildUUID":null,"collectionUUID":{"uuid":{"$uuid":"b9b6f0bd-a6b7-4e61-b611-ac1f3495ee46"}},"namespace":"test.structures.chunks","index":"files_id_1_n_1","ident":"index-20--5401962669269818485","collectionIdent":"collection-18--5401962669269818485","commitTimestamp":null}}"" 2024-01-03T11:17:22.902Z MongoMS:MongoMemoryServer Mongo[40865]: stop: Called .stop() method 2024-01-03T11:17:22.902Z MongoMS:MongoMemoryServer Mongo[40865]: stop: Stopping MongoDB server on port 40865 with pid 54763 2024-01-03T11:17:22.902Z MongoMS:MongoInstance Mongo[40865]: stop 2024-01-03T11:17:22.902Z MongoMS:utils Mongo[40865] killProcess: mongodProcess: sending "SIGINT" 2024-01-03T11:17:22.913Z MongoMS:MongoInstance Mongo[40865]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"CONTROL", "id":23377, "ctx":"SignalHandler","msg":"Received signal","attr":{"signal":2,"error":"Interrupt: 2"}} {"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"CONTROL", "id":23381, "ctx":"SignalHandler","msg":"will terminate after current cmd ends"} {"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"REPL", "id":4784900, "ctx":"SignalHandler","msg":"Stepping down the ReplicationCoordinator for shutdown","attr":{"waitTimeMillis":15000}} {"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"REPL", "id":4794602, "ctx":"SignalHandler","msg":"Attempting to enter quiesce mode"} {"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"-", "id":6371601, "ctx":"SignalHandler","msg":"Shutting down the FLE Crud thread pool"} {"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"COMMAND", "id":4784901, "ctx":"SignalHandler","msg":"Shutting down the MirrorMaestro"} {"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"SHARDING", "id":4784902, "ctx":"SignalHandler","msg":"Shutting down the WaitForMajorityService"} {"t":{"$date":"2024-01-03T11:17:22.903+00:00"},"s":"I", "c":"CONTROL", "id":4784903, "ctx":"SignalHandler","msg":"Shutting down the LogicalSessionCache"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"NETWORK", "id":20562, "ctx":"SignalHandler","msg":"Shutdown: going to close listening sockets"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"NETWORK", "id":23017, "ctx":"listener","msg":"removing socket file","attr":{"path":"/tmp/mongodb-40865.sock"}} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"NETWORK", "id":4784905, "ctx":"SignalHandler","msg":"Shutting down the global connection pool"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"CONTROL", "id":4784906, "ctx":"SignalHandler","msg":"Shutting down the FlowControlTicketholder"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"-", "id":20520, "ctx":"SignalHandler","msg":"Stopping further Flow Control ticket acquisitions."} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"REPL", "id":4784909, "ctx":"SignalHandler","msg":"Shutting down the ReplicationCoordinator"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"SHARDING", "id":4784910, "ctx":"SignalHandler","msg":"Shutting down the ShardingInitializationMongoD"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"REPL", "id":4784911, "ctx":"SignalHandler","msg":"Enqueuing the ReplicationStateTransitionLock for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"-", "id":4784912, "ctx":"SignalHandler","msg":"Killing all operations for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"-", "id":4695300, "ctx":"SignalHandler","msg":"Interrupted all currently running operations","attr":{"opsKilled":4}} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"TENANT_M", "id":5093807, "ctx":"SignalHandler","msg":"Shutting down all TenantMigrationAccessBlockers on global shutdown"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"COMMAND", "id":4784913, "ctx":"SignalHandler","msg":"Shutting down all open transactions"} {"t":{"$date":"2024-01-03T11:17:22.904+00:00"},"s":"I", "c":"REPL", "id":4784914, "ctx":"SignalHandler","msg":"Acquiring the ReplicationStateTransitionLock for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.906+00:00"},"s":"I", "c":"INDEX", "id":4784915, "ctx":"SignalHandler","msg":"Shutting down the IndexBuildsCoordinator"} {"t":{"$date":"2024-01-03T11:17:22.906+00:00"},"s":"I", "c":"NETWORK", "id":4784918, "ctx":"SignalHandler","msg":"Shutting down the ReplicaSetMonitor"} {"t":{"$date":"2024-01-03T11:17:22.906+00:00"},"s":"I", "c":"SHARDING", "id":4784921, "ctx":"SignalHandler","msg":"Shutting down the MigrationUtilExecutor"} {"t":{"$date":"2024-01-03T11:17:22.906+00:00"},"s":"I", "c":"ASIO", "id":22582, "ctx":"MigrationUtil-TaskExecutor","msg":"Killing all outstanding egress activity."} {"t":{"$date":"2024-01-03T11:17:22.906+00:00"},"s":"I", "c":"COMMAND", "id":4784923, "ctx":"SignalHandler","msg":"Shutting down the ServiceEntryPoint"} {"t":{"$date":"2024-01-03T11:17:22.906+00:00"},"s":"I", "c":"CONTROL", "id":4784925, "ctx":"SignalHandler","msg":"Shutting down free monitoring"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"CONTROL", "id":20609, "ctx":"SignalHandler","msg":"Shutting down free monitoring"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"CONTROL", "id":4784927, "ctx":"SignalHandler","msg":"Shutting down the HealthLog"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"CONTROL", "id":4784928, "ctx":"SignalHandler","msg":"Shutting down the TTL monitor"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"INDEX", "id":3684100, "ctx":"SignalHandler","msg":"Shutting down TTL collection monitor thread"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"INDEX", "id":3684101, "ctx":"SignalHandler","msg":"Finished shutting down TTL collection monitor thread"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"CONTROL", "id":6278511, "ctx":"SignalHandler","msg":"Shutting down the Change Stream Expired Pre-images Remover"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"CONTROL", "id":4784929, "ctx":"SignalHandler","msg":"Acquiring the global lock for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"CONTROL", "id":4784930, "ctx":"SignalHandler","msg":"Shutting down the storage engine"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"STORAGE", "id":22320, "ctx":"SignalHandler","msg":"Shutting down journal flusher thread"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"STORAGE", "id":22321, "ctx":"SignalHandler","msg":"Finished shutting down journal flusher thread"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"STORAGE", "id":20282, "ctx":"SignalHandler","msg":"Deregistering all the collections"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"STORAGE", "id":22261, "ctx":"SignalHandler","msg":"Timestamp monitor shutting down"} {"t":{"$date":"2024-01-03T11:17:22.907+00:00"},"s":"I", "c":"STORAGE", "id":22279, "ctx":"SignalHandler","msg":"shutdown: removing fs lock..."} {"t":{"$date":"2024-01-03T11:17:22.908+00:00"},"s":"I", "c":"-", "id":4784931, "ctx":"SignalHandler","msg":"Dropping the scope cache for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.908+00:00"},"s":"I", "c":"FTDC", "id":20626, "ctx":"SignalHandler","msg":"Shutting down full-time diagnostic data capture"} {"t":{"$date":"2024-01-03T11:17:22.909+00:00"},"s":"I", "c":"CONTROL", "id":20565, "ctx":"SignalHandler","msg":"Now exiting"} {"t":{"$date":"2024-01-03T11:17:22.909+00:00"},"s":"I", "c":"CONTROL", "id":23138, "ctx":"SignalHandler","msg":"Shutting down","attr":{"exitCode":0}}"" 2024-01-03T11:17:22.939Z MongoMS:utils Mongo[40865] killProcess: mongodProcess: got exit signal, Code: 0, Signal: null 2024-01-03T11:17:22.939Z MongoMS:utils Mongo[40865] killProcess: killerProcess: sending "SIGINT" 2024-01-03T11:17:22.939Z MongoMS:MongoInstance Mongo[40865]: closeHandler: code: "0", signal: "null" 2024-01-03T11:17:22.947Z MongoMS:utils Mongo[40865] killProcess: killerProcess: got exit signal, Code: 0, Signal: null 2024-01-03T11:17:22.947Z MongoMS:MongoInstance Mongo[40865]: stop: Instance Finished Shutdown 2024-01-03T11:17:22.947Z MongoMS:MongoMemoryServer Mongo[40865]: cleanup: { doCleanup: true, force: false } 2024-01-03T11:17:22.947Z MongoMS:MongoMemoryServer Mongo[40865]: cleanup: removing tmpDir at /var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-T1g1Ll 2024-01-03T11:17:22.950Z MongoMS:MongoMemoryServer Mongo[39345]: stop: Called .stop() method 2024-01-03T11:17:22.950Z MongoMS:MongoMemoryServer Mongo[39345]: stop: Stopping MongoDB server on port 39345 with pid 54760 2024-01-03T11:17:22.950Z MongoMS:MongoInstance Mongo[39345]: stop 2024-01-03T11:17:22.950Z MongoMS:utils Mongo[39345] killProcess: mongodProcess: sending "SIGINT" 2024-01-03T11:17:22.950Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.950+00:00"},"s":"I", "c":"CONTROL", "id":23377, "ctx":"SignalHandler","msg":"Received signal","attr":{"signal":2,"error":"Interrupt: 2"}}"" 2024-01-03T11:17:22.950Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.950+00:00"},"s":"I", "c":"CONTROL", "id":23381, "ctx":"SignalHandler","msg":"will terminate after current cmd ends"} {"t":{"$date":"2024-01-03T11:17:22.950+00:00"},"s":"I", "c":"REPL", "id":4784900, "ctx":"SignalHandler","msg":"Stepping down the ReplicationCoordinator for shutdown","attr":{"waitTimeMillis":15000}}"" 2024-01-03T11:17:22.950Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.950+00:00"},"s":"I", "c":"REPL", "id":4794602, "ctx":"SignalHandler","msg":"Attempting to enter quiesce mode"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.950+00:00"},"s":"I", "c":"-", "id":6371601, "ctx":"SignalHandler","msg":"Shutting down the FLE Crud thread pool"} {"t":{"$date":"2024-01-03T11:17:22.950+00:00"},"s":"I", "c":"COMMAND", "id":4784901, "ctx":"SignalHandler","msg":"Shutting down the MirrorMaestro"} {"t":{"$date":"2024-01-03T11:17:22.950+00:00"},"s":"I", "c":"SHARDING", "id":4784902, "ctx":"SignalHandler","msg":"Shutting down the WaitForMajorityService"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":4784903, "ctx":"SignalHandler","msg":"Shutting down the LogicalSessionCache"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"NETWORK", "id":20562, "ctx":"SignalHandler","msg":"Shutdown: going to close listening sockets"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"NETWORK", "id":23017, "ctx":"listener","msg":"removing socket file","attr":{"path":"/tmp/mongodb-39345.sock"}}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"NETWORK", "id":4784905, "ctx":"SignalHandler","msg":"Shutting down the global connection pool"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":4784906, "ctx":"SignalHandler","msg":"Shutting down the FlowControlTicketholder"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"-", "id":20520, "ctx":"SignalHandler","msg":"Stopping further Flow Control ticket acquisitions."} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"REPL", "id":4784909, "ctx":"SignalHandler","msg":"Shutting down the ReplicationCoordinator"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"SHARDING", "id":4784910, "ctx":"SignalHandler","msg":"Shutting down the ShardingInitializationMongoD"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"REPL", "id":4784911, "ctx":"SignalHandler","msg":"Enqueuing the ReplicationStateTransitionLock for shutdown"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"-", "id":4784912, "ctx":"SignalHandler","msg":"Killing all operations for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"-", "id":4695300, "ctx":"SignalHandler","msg":"Interrupted all currently running operations","attr":{"opsKilled":3}} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"TENANT_M", "id":5093807, "ctx":"SignalHandler","msg":"Shutting down all TenantMigrationAccessBlockers on global shutdown"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"COMMAND", "id":4784913, "ctx":"SignalHandler","msg":"Shutting down all open transactions"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"REPL", "id":4784914, "ctx":"SignalHandler","msg":"Acquiring the ReplicationStateTransitionLock for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"INDEX", "id":4784915, "ctx":"SignalHandler","msg":"Shutting down the IndexBuildsCoordinator"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"NETWORK", "id":4784918, "ctx":"SignalHandler","msg":"Shutting down the ReplicaSetMonitor"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"SHARDING", "id":4784921, "ctx":"SignalHandler","msg":"Shutting down the MigrationUtilExecutor"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"ASIO", "id":22582, "ctx":"MigrationUtil-TaskExecutor","msg":"Killing all outstanding egress activity."}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"COMMAND", "id":4784923, "ctx":"SignalHandler","msg":"Shutting down the ServiceEntryPoint"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":4784925, "ctx":"SignalHandler","msg":"Shutting down free monitoring"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":20609, "ctx":"SignalHandler","msg":"Shutting down free monitoring"}"" 2024-01-03T11:17:22.951Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":4784927, "ctx":"SignalHandler","msg":"Shutting down the HealthLog"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":4784928, "ctx":"SignalHandler","msg":"Shutting down the TTL monitor"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"INDEX", "id":3684100, "ctx":"SignalHandler","msg":"Shutting down TTL collection monitor thread"}"" 2024-01-03T11:17:22.952Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"INDEX", "id":3684101, "ctx":"SignalHandler","msg":"Finished shutting down TTL collection monitor thread"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":6278511, "ctx":"SignalHandler","msg":"Shutting down the Change Stream Expired Pre-images Remover"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":4784929, "ctx":"SignalHandler","msg":"Acquiring the global lock for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"CONTROL", "id":4784930, "ctx":"SignalHandler","msg":"Shutting down the storage engine"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"STORAGE", "id":22320, "ctx":"SignalHandler","msg":"Shutting down journal flusher thread"} {"t":{"$date":"2024-01-03T11:17:22.951+00:00"},"s":"I", "c":"STORAGE", "id":22321, "ctx":"SignalHandler","msg":"Finished shutting down journal flusher thread"} {"t":{"$date":"2024-01-03T11:17:22.952+00:00"},"s":"I", "c":"STORAGE", "id":20282, "ctx":"SignalHandler","msg":"Deregistering all the collections"} {"t":{"$date":"2024-01-03T11:17:22.952+00:00"},"s":"I", "c":"NETWORK", "id":22944, "ctx":"conn1","msg":"Connection ended","attr":{"remote":"127.0.0.1:63360","uuid":"ada7699d-f8b7-4565-a441-9cf1c669154e","connectionId":1,"connectionCount":2}} {"t":{"$date":"2024-01-03T11:17:22.952+00:00"},"s":"I", "c":"STORAGE", "id":22261, "ctx":"SignalHandler","msg":"Timestamp monitor shutting down"}"" 2024-01-03T11:17:22.952Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.952+00:00"},"s":"I", "c":"STORAGE", "id":22279, "ctx":"SignalHandler","msg":"shutdown: removing fs lock..."}"" 2024-01-03T11:17:22.952Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.952+00:00"},"s":"I", "c":"-", "id":4784931, "ctx":"SignalHandler","msg":"Dropping the scope cache for shutdown"} {"t":{"$date":"2024-01-03T11:17:22.952+00:00"},"s":"I", "c":"FTDC", "id":20626, "ctx":"SignalHandler","msg":"Shutting down full-time diagnostic data capture"}"" 2024-01-03T11:17:22.953Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.953+00:00"},"s":"I", "c":"CONTROL", "id":20565, "ctx":"SignalHandler","msg":"Now exiting"}"" 2024-01-03T11:17:22.953Z MongoMS:MongoInstance Mongo[39345]: stdoutHandler: ""{"t":{"$date":"2024-01-03T11:17:22.953+00:00"},"s":"I", "c":"CONTROL", "id":23138, "ctx":"SignalHandler","msg":"Shutting down","attr":{"exitCode":0}}"" 2024-01-03T11:17:22.958Z MongoMS:utils Mongo[39345] killProcess: mongodProcess: got exit signal, Code: 0, Signal: null 2024-01-03T11:17:22.958Z MongoMS:utils Mongo[39345] killProcess: killerProcess: sending "SIGINT" 2024-01-03T11:17:22.958Z MongoMS:MongoInstance Mongo[39345]: closeHandler: code: "0", signal: "null" 2024-01-03T11:17:22.965Z MongoMS:utils Mongo[39345] killProcess: killerProcess: got exit signal, Code: 0, Signal: null 2024-01-03T11:17:22.965Z MongoMS:MongoInstance Mongo[39345]: stop: Instance Finished Shutdown 2024-01-03T11:17:22.965Z MongoMS:MongoMemoryServer Mongo[39345]: cleanup: { doCleanup: true, force: false } 2024-01-03T11:17:22.966Z MongoMS:MongoMemoryServer Mongo[39345]: cleanup: removing tmpDir at /var/folders/kh/m17dt8s927d7bp0c0h1kcbvh0000gn/T/mongo-mem-nNW0FJ