summaryrefslogtreecommitdiff
diff options
context:
space:
mode:
authorGregory Noma <gregory.noma@gmail.com>2021-08-05 23:20:57 -0400
committerEvergreen Agent <no-reply@evergreen.mongodb.com>2021-08-12 23:45:54 +0000
commit8e2f3869aef5565b4448a85a194f2c912bba56c0 (patch)
tree36e0a31423ba4d2e9ef6a46b52a45e2963f09b7f
parent191a3313c10b44270984d34bc658751408cf5712 (diff)
downloadmongo-8e2f3869aef5565b4448a85a194f2c912bba56c0.tar.gz
SERVER-59025 Increase storage log verbosity in `oplog_slow_sampling_logging.js`
(cherry picked from commit 84a1a0599614a8c077da4b3899aba5a647202746)
-rw-r--r--jstests/replsets/oplog_slow_sampling_logging.js3
-rw-r--r--src/mongo/db/storage/wiredtiger/wiredtiger_size_storer.cpp31
2 files changed, 16 insertions, 18 deletions
diff --git a/jstests/replsets/oplog_slow_sampling_logging.js b/jstests/replsets/oplog_slow_sampling_logging.js
index 1fbe932bafe..87767ad234e 100644
--- a/jstests/replsets/oplog_slow_sampling_logging.js
+++ b/jstests/replsets/oplog_slow_sampling_logging.js
@@ -32,7 +32,8 @@ const replSet = new ReplSetTest({
"maxOplogTruncationPointsDuringStartup": 10,
"oplogSamplingLogIntervalSeconds": kLoggingIntervalSeconds,
"failpoint.slowOplogSamplingReads":
- tojson({mode: "alwaysOn", data: {"delay": kOplogSampleReadDelay}})
+ tojson({mode: "alwaysOn", data: {"delay": kOplogSampleReadDelay}}),
+ logComponentVerbosity: tojson({storage: {verbosity: 2}}),
}
}
});
diff --git a/src/mongo/db/storage/wiredtiger/wiredtiger_size_storer.cpp b/src/mongo/db/storage/wiredtiger/wiredtiger_size_storer.cpp
index 18b11ed8fc2..933f3c0f64e 100644
--- a/src/mongo/db/storage/wiredtiger/wiredtiger_size_storer.cpp
+++ b/src/mongo/db/storage/wiredtiger/wiredtiger_size_storer.cpp
@@ -82,15 +82,13 @@ void WiredTigerSizeStorer::store(StringData uri, std::shared_ptr<SizeInfo> sizeI
entry->_dirty.store(false);
entry = sizeInfo;
entry->_dirty.store(true);
- LOGV2_DEBUG(
- 22423,
- 2,
- "WiredTigerSizeStorer::store Marking {uri} dirty, numRecords: {sizeInfo_numRecords_load}, "
- "dataSize: {sizeInfo_dataSize_load}, use_count: {entry_use_count}",
- "uri"_attr = uri,
- "sizeInfo_numRecords_load"_attr = sizeInfo->numRecords.load(),
- "sizeInfo_dataSize_load"_attr = sizeInfo->dataSize.load(),
- "entry_use_count"_attr = entry.use_count());
+ LOGV2_DEBUG(22423,
+ 2,
+ "WiredTigerSizeStorer::store",
+ "uri"_attr = uri,
+ "numRecords"_attr = sizeInfo->numRecords.load(),
+ "dataSize"_attr = sizeInfo->dataSize.load(),
+ "entryUseCount"_attr = entry.use_count());
}
std::shared_ptr<WiredTigerSizeStorer::SizeInfo> WiredTigerSizeStorer::load(StringData uri) const {
@@ -121,11 +119,8 @@ std::shared_ptr<WiredTigerSizeStorer::SizeInfo> WiredTigerSizeStorer::load(Strin
invariantWTOK(_cursor->get_value(_cursor, &value));
BSONObj data(reinterpret_cast<const char*>(value.data));
- LOGV2_DEBUG(22424,
- 2,
- "WiredTigerSizeStorer::load {uri} -> {data}",
- "uri"_attr = uri,
- "data"_attr = redact(data));
+ LOGV2_DEBUG(
+ 22424, 2, "WiredTigerSizeStorer::load", "uri"_attr = uri, "data"_attr = redact(data));
return std::make_shared<SizeInfo>(data["numRecords"].safeNumberLong(),
data["dataSize"].safeNumberLong());
}
@@ -169,7 +164,7 @@ void WiredTigerSizeStorer::flush(bool syncToDisk) {
auto& uri = it->first;
LOGV2_DEBUG(22425,
2,
- "WiredTigerSizeStorer::flush {uri} -> {data}",
+ "WiredTigerSizeStorer::flush",
"uri"_attr = uri,
"data"_attr = redact(data));
WiredTigerItem key(uri.c_str(), uri.size());
@@ -183,7 +178,9 @@ void WiredTigerSizeStorer::flush(bool syncToDisk) {
buffer.clear();
}
- auto micros = t.micros();
- LOGV2_DEBUG(22426, 2, "WiredTigerSizeStorer flush took {micros} µs", "micros"_attr = micros);
+ LOGV2_DEBUG(22426,
+ 2,
+ "WiredTigerSizeStorer::flush completed",
+ "duration"_attr = Microseconds{t.micros()});
}
} // namespace mongo