The message in question is below
"ctx":"LogicalSessionCacheRefresh","msg":"Slow query","attr":{"type":"command","ns":"config.$cmd","command":{"update":"system.sessions","ordered":false,"allowImplicitCollectionCreation"
In mongo 4.2, I see about 200 of these log msgs and all have durationMilis under 200. However, since upgrading to mongo 4.4, there are 600+ log msgs of them and 99% of them report durationMilis over 15000ms. Could these log msgs and how long it takes have an impact on the overall mongo performance?
Mongod.conf and rs.conf() below
mongod.conf :
#operationProfiling:
slowOpThresholdMs: 50
mode: slowOp
mode: all
mode: off
replication:
replSetName: "xxxxx"
oplogSizeMB: 5000000
enableMajorityReadConcern: false
processManagement:
fork: true
pidFilePath: /app/mongod/xxxxx/mongod.pid
net:
port: xxxx
bindIp: "xxxx"
ipv6: false
unixDomainSocket:
enabled: false
http:
enabled: false
JSONPEnabled: false
RESTInterfaceEnabled: false
storage:
indexBuildRetry: false
directoryPerDB: true
journal:
enabled: true
dbPath: "/app/mongod/prod1/data/xxxx"
engine: "wiredTiger"
wiredTiger:
indexConfig:
prefixCompression: true
engineConfig:
journalCompressor: snappy
directoryForIndexes: true
cacheSizeGB: 350
statisticsLogDelaySecs: 30
collectionConfig:
blockCompressor: snappy
inMemory:
engineConfig:
statisticsLogDelaySecs: 30
security:
keyFile: /app/mongod/prod1/xxx.keyfile
clusterAuthMode: keyFile
authorization: enabled
transitionToAuth: false
javascriptEnabled: true
redactClientLogData: false
systemLog:
verbosity: 0
quiet: false
traceAllExceptions: false
path: "/app/xxxxx/mongodb.log"
logAppend: true
logRotate: reopen
destination: file
timeStampFormat: ctime
MONGODB_PROD1:PRIMARY> rs.conf()
{
"_id" : "xxxx",
"version" : 65844,
"term" : 394,
"protocolVersion" : NumberLong(1),
"writeConcernMajorityJournalDefault" : true,
"members" : [
{
"_id" : 4,
"host" : "xxxx",
"arbiterOnly" : false,
"buildIndexes" : true,
"hidden" : false,
"priority" : 1,
"tags" : {
},
"slaveDelay" : NumberLong(0),
"votes" : 1
},
{
"_id" : 5,
"host" : "xxxx",
"arbiterOnly" : false,
"buildIndexes" : true,
"hidden" : false,
"priority" : 10,
"tags" : {
},
"slaveDelay" : NumberLong(0),
"votes" : 1
},
{
"_id" : 6,
"host" : "xxxx",
"arbiterOnly" : false,
"buildIndexes" : true,
"hidden" : false,
"priority" : 1,
"tags" : {
},
"slaveDelay" : NumberLong(0),
"votes" : 1
},
{
"_id" : 7,
"host" : "xxxx",
"arbiterOnly" : false,
"buildIndexes" : true,
"hidden" : false,
"priority" : 1,
"tags" : {
},
"slaveDelay" : NumberLong(0),
"votes" : 1
},
{
"_id" : 8,
"host" : "xxxx",
"arbiterOnly" : false,
"buildIndexes" : true,
"hidden" : false,
"priority" : 4,
"tags" : {
},
"slaveDelay" : NumberLong(0),
"votes" : 1
}
],
"settings" : {
"chainingAllowed" : true,
"heartbeatIntervalMillis" : 2000,
"heartbeatTimeoutSecs" : 10,
"electionTimeoutMillis" : 10000,
"catchUpTimeoutMillis" : -1,
"catchUpTakeoverDelayMillis" : 30000,
"getLastErrorModes" : {
},
"getLastErrorDefaults" : {
"w" : 1,
"wtimeout" : 0
},
"replicaSetId" : ObjectId("xxxx")
}
}