io_tracer_test.cc 13 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354
  1. // Copyright (c) 2011-present, Facebook, Inc. All rights reserved.
  2. // This source code is licensed under both the GPLv2 (found in the
  3. // COPYING file in the root directory) and Apache 2.0 License
  4. // (found in the LICENSE.Apache file in the root directory).
  5. #include "trace_replay/io_tracer.h"
  6. #include "rocksdb/db.h"
  7. #include "rocksdb/env.h"
  8. #include "rocksdb/status.h"
  9. #include "rocksdb/trace_reader_writer.h"
  10. #include "rocksdb/trace_record.h"
  11. #include "test_util/testharness.h"
  12. #include "test_util/testutil.h"
  13. namespace ROCKSDB_NAMESPACE {
  14. namespace {
  15. const std::string kDummyFile = "/dummy/file";
  16. } // namespace
  17. class IOTracerTest : public testing::Test {
  18. public:
  19. IOTracerTest() {
  20. test_path_ = test::PerThreadDBPath("io_tracer_test");
  21. env_ = ROCKSDB_NAMESPACE::Env::Default();
  22. clock_ = env_->GetSystemClock().get();
  23. EXPECT_OK(env_->CreateDir(test_path_));
  24. trace_file_path_ = test_path_ + "/io_trace";
  25. }
  26. ~IOTracerTest() override {
  27. EXPECT_OK(env_->DeleteFile(trace_file_path_));
  28. EXPECT_OK(env_->DeleteDir(test_path_));
  29. }
  30. std::string GetFileOperation(uint64_t id) {
  31. id = id % 4;
  32. switch (id) {
  33. case 0:
  34. return "CreateDir";
  35. case 1:
  36. return "GetChildren";
  37. case 2:
  38. return "FileSize";
  39. case 3:
  40. return "DeleteDir";
  41. default:
  42. assert(false);
  43. }
  44. return "";
  45. }
  46. void WriteIOOp(IOTraceWriter* writer, uint64_t nrecords) {
  47. assert(writer);
  48. for (uint64_t i = 0; i < nrecords; i++) {
  49. IOTraceRecord record;
  50. record.io_op_data = 0;
  51. record.trace_type = TraceType::kIOTracer;
  52. record.io_op_data |= (1 << IOTraceOp::kIOLen);
  53. record.io_op_data |= (1 << IOTraceOp::kIOOffset);
  54. record.file_operation = GetFileOperation(i);
  55. record.io_status = IOStatus::OK().ToString();
  56. record.file_name = kDummyFile + std::to_string(i);
  57. record.len = i;
  58. record.offset = i + 20;
  59. EXPECT_OK(writer->WriteIOOp(record, nullptr));
  60. }
  61. }
  62. void VerifyIOOp(IOTraceReader* reader, uint32_t nrecords) {
  63. assert(reader);
  64. for (uint32_t i = 0; i < nrecords; i++) {
  65. IOTraceRecord record;
  66. ASSERT_OK(reader->ReadIOOp(&record));
  67. ASSERT_EQ(record.file_operation, GetFileOperation(i));
  68. ASSERT_EQ(record.io_status, IOStatus::OK().ToString());
  69. ASSERT_EQ(record.len, i);
  70. ASSERT_EQ(record.offset, i + 20);
  71. }
  72. }
  73. Env* env_;
  74. SystemClock* clock_;
  75. EnvOptions env_options_;
  76. std::string trace_file_path_;
  77. std::string test_path_;
  78. };
  79. TEST_F(IOTracerTest, MultipleRecordsWithDifferentIOOpOptions) {
  80. std::string file_name = kDummyFile + std::to_string(5);
  81. {
  82. TraceOptions trace_opt;
  83. std::unique_ptr<TraceWriter> trace_writer;
  84. ASSERT_OK(NewFileTraceWriter(env_, env_options_, trace_file_path_,
  85. &trace_writer));
  86. IOTracer writer;
  87. ASSERT_OK(writer.StartIOTrace(clock_, trace_opt, std::move(trace_writer)));
  88. // Write general record.
  89. IOTraceRecord record0(0, TraceType::kIOTracer, 0 /*io_op_data*/,
  90. GetFileOperation(0), 155 /*latency*/,
  91. IOStatus::OK().ToString(), file_name);
  92. writer.WriteIOOp(record0, nullptr);
  93. // Write record with FileSize.
  94. uint64_t io_op_data = 0;
  95. io_op_data |= (1 << IOTraceOp::kIOFileSize);
  96. IOTraceRecord record1(0, TraceType::kIOTracer, io_op_data,
  97. GetFileOperation(1), 10 /*latency*/,
  98. IOStatus::OK().ToString(), file_name,
  99. 256 /*file_size*/);
  100. writer.WriteIOOp(record1, nullptr);
  101. // Write record with Length.
  102. io_op_data = 0;
  103. io_op_data |= (1 << IOTraceOp::kIOLen);
  104. IOTraceRecord record2(0, TraceType::kIOTracer, io_op_data,
  105. GetFileOperation(2), 10 /*latency*/,
  106. IOStatus::OK().ToString(), file_name, 100 /*length*/,
  107. 200 /*offset*/);
  108. writer.WriteIOOp(record2, nullptr);
  109. // Write record with Length and offset.
  110. io_op_data = 0;
  111. io_op_data |= (1 << IOTraceOp::kIOLen);
  112. io_op_data |= (1 << IOTraceOp::kIOOffset);
  113. IOTraceRecord record3(0, TraceType::kIOTracer, io_op_data,
  114. GetFileOperation(3), 10 /*latency*/,
  115. IOStatus::OK().ToString(), file_name, 120 /*length*/,
  116. 17 /*offset*/);
  117. writer.WriteIOOp(record3, nullptr);
  118. // Write record with offset.
  119. io_op_data = 0;
  120. io_op_data |= (1 << IOTraceOp::kIOOffset);
  121. IOTraceRecord record4(0, TraceType::kIOTracer, io_op_data,
  122. GetFileOperation(4), 10 /*latency*/,
  123. IOStatus::OK().ToString(), file_name, 13 /*length*/,
  124. 50 /*offset*/);
  125. writer.WriteIOOp(record4, nullptr);
  126. // Write record with IODebugContext.
  127. io_op_data = 0;
  128. IODebugContext dbg;
  129. const std::string test_request_id = "request_id_1";
  130. dbg.SetRequestId(&test_request_id);
  131. IOTraceRecord record5(0, TraceType::kIOTracer, io_op_data,
  132. GetFileOperation(5), 10 /*latency*/,
  133. IOStatus::OK().ToString(), file_name);
  134. writer.WriteIOOp(record5, &dbg);
  135. ASSERT_OK(env_->FileExists(trace_file_path_));
  136. }
  137. {
  138. // Verify trace file is generated correctly.
  139. std::unique_ptr<TraceReader> trace_reader;
  140. ASSERT_OK(NewFileTraceReader(env_, env_options_, trace_file_path_,
  141. &trace_reader));
  142. IOTraceReader reader(std::move(trace_reader));
  143. IOTraceHeader header;
  144. ASSERT_OK(reader.ReadHeader(&header));
  145. ASSERT_EQ(kMajorVersion, static_cast<int>(header.rocksdb_major_version));
  146. ASSERT_EQ(kMinorVersion, static_cast<int>(header.rocksdb_minor_version));
  147. // Read general record.
  148. IOTraceRecord record0;
  149. ASSERT_OK(reader.ReadIOOp(&record0));
  150. ASSERT_EQ(record0.file_operation, GetFileOperation(0));
  151. ASSERT_EQ(record0.latency, 155);
  152. ASSERT_EQ(record0.file_name, file_name);
  153. // Read record with FileSize.
  154. IOTraceRecord record1;
  155. ASSERT_OK(reader.ReadIOOp(&record1));
  156. ASSERT_EQ(record1.file_size, 256);
  157. ASSERT_EQ(record1.len, 0);
  158. ASSERT_EQ(record1.offset, 0);
  159. // Read record with Length.
  160. IOTraceRecord record2;
  161. ASSERT_OK(reader.ReadIOOp(&record2));
  162. ASSERT_EQ(record2.len, 100);
  163. ASSERT_EQ(record2.file_size, 0);
  164. ASSERT_EQ(record2.offset, 0);
  165. // Read record with Length and offset.
  166. IOTraceRecord record3;
  167. ASSERT_OK(reader.ReadIOOp(&record3));
  168. ASSERT_EQ(record3.len, 120);
  169. ASSERT_EQ(record3.file_size, 0);
  170. ASSERT_EQ(record3.offset, 17);
  171. // Read record with offset.
  172. IOTraceRecord record4;
  173. ASSERT_OK(reader.ReadIOOp(&record4));
  174. ASSERT_EQ(record4.len, 0);
  175. ASSERT_EQ(record4.file_size, 0);
  176. ASSERT_EQ(record4.offset, 50);
  177. IOTraceRecord record5;
  178. ASSERT_OK(reader.ReadIOOp(&record5));
  179. ASSERT_EQ(record5.len, 0);
  180. ASSERT_EQ(record5.file_size, 0);
  181. ASSERT_EQ(record5.offset, 0);
  182. ASSERT_EQ(record5.request_id, "request_id_1");
  183. // Read one more record and it should report error.
  184. IOTraceRecord record6;
  185. ASSERT_NOK(reader.ReadIOOp(&record6));
  186. }
  187. }
  188. TEST_F(IOTracerTest, AtomicWrite) {
  189. std::string file_name = kDummyFile + std::to_string(0);
  190. {
  191. IOTraceRecord record(0, TraceType::kIOTracer, 0 /*io_op_data*/,
  192. GetFileOperation(0), 10 /*latency*/,
  193. IOStatus::OK().ToString(), file_name);
  194. TraceOptions trace_opt;
  195. std::unique_ptr<TraceWriter> trace_writer;
  196. ASSERT_OK(NewFileTraceWriter(env_, env_options_, trace_file_path_,
  197. &trace_writer));
  198. IOTracer writer;
  199. ASSERT_OK(writer.StartIOTrace(clock_, trace_opt, std::move(trace_writer)));
  200. writer.WriteIOOp(record, nullptr);
  201. ASSERT_OK(env_->FileExists(trace_file_path_));
  202. }
  203. {
  204. // Verify trace file contains one record.
  205. std::unique_ptr<TraceReader> trace_reader;
  206. ASSERT_OK(NewFileTraceReader(env_, env_options_, trace_file_path_,
  207. &trace_reader));
  208. IOTraceReader reader(std::move(trace_reader));
  209. IOTraceHeader header;
  210. ASSERT_OK(reader.ReadHeader(&header));
  211. ASSERT_EQ(kMajorVersion, static_cast<int>(header.rocksdb_major_version));
  212. ASSERT_EQ(kMinorVersion, static_cast<int>(header.rocksdb_minor_version));
  213. // Read record and verify data.
  214. IOTraceRecord access_record;
  215. ASSERT_OK(reader.ReadIOOp(&access_record));
  216. ASSERT_EQ(access_record.file_operation, GetFileOperation(0));
  217. ASSERT_EQ(access_record.io_status, IOStatus::OK().ToString());
  218. ASSERT_EQ(access_record.file_name, file_name);
  219. ASSERT_NOK(reader.ReadIOOp(&access_record));
  220. }
  221. }
  222. TEST_F(IOTracerTest, AtomicWriteBeforeStartTrace) {
  223. std::string file_name = kDummyFile + std::to_string(0);
  224. {
  225. IOTraceRecord record(0, TraceType::kIOTracer, 0 /*io_op_data*/,
  226. GetFileOperation(0), 0, IOStatus::OK().ToString(),
  227. file_name);
  228. std::unique_ptr<TraceWriter> trace_writer;
  229. ASSERT_OK(NewFileTraceWriter(env_, env_options_, trace_file_path_,
  230. &trace_writer));
  231. IOTracer writer;
  232. // The record should not be written to the trace_file since StartIOTrace is
  233. // not called.
  234. writer.WriteIOOp(record, nullptr);
  235. ASSERT_OK(env_->FileExists(trace_file_path_));
  236. }
  237. {
  238. // Verify trace file contains nothing.
  239. std::unique_ptr<TraceReader> trace_reader;
  240. ASSERT_OK(NewFileTraceReader(env_, env_options_, trace_file_path_,
  241. &trace_reader));
  242. IOTraceReader reader(std::move(trace_reader));
  243. IOTraceHeader header;
  244. ASSERT_NOK(reader.ReadHeader(&header));
  245. }
  246. }
  247. TEST_F(IOTracerTest, AtomicNoWriteAfterEndTrace) {
  248. std::string file_name = kDummyFile + std::to_string(0);
  249. {
  250. uint64_t io_op_data = 0;
  251. io_op_data |= (1 << IOTraceOp::kIOFileSize);
  252. IOTraceRecord record(
  253. 0, TraceType::kIOTracer, io_op_data, GetFileOperation(2), 0 /*latency*/,
  254. IOStatus::OK().ToString(), file_name, 10 /*file_size*/);
  255. TraceOptions trace_opt;
  256. std::unique_ptr<TraceWriter> trace_writer;
  257. ASSERT_OK(NewFileTraceWriter(env_, env_options_, trace_file_path_,
  258. &trace_writer));
  259. IOTracer writer;
  260. ASSERT_OK(writer.StartIOTrace(clock_, trace_opt, std::move(trace_writer)));
  261. writer.WriteIOOp(record, nullptr);
  262. writer.EndIOTrace();
  263. // Write the record again. This time the record should not be written since
  264. // EndIOTrace is called.
  265. writer.WriteIOOp(record, nullptr);
  266. ASSERT_OK(env_->FileExists(trace_file_path_));
  267. }
  268. {
  269. // Verify trace file contains one record.
  270. std::unique_ptr<TraceReader> trace_reader;
  271. ASSERT_OK(NewFileTraceReader(env_, env_options_, trace_file_path_,
  272. &trace_reader));
  273. IOTraceReader reader(std::move(trace_reader));
  274. IOTraceHeader header;
  275. ASSERT_OK(reader.ReadHeader(&header));
  276. ASSERT_EQ(kMajorVersion, static_cast<int>(header.rocksdb_major_version));
  277. ASSERT_EQ(kMinorVersion, static_cast<int>(header.rocksdb_minor_version));
  278. IOTraceRecord access_record;
  279. ASSERT_OK(reader.ReadIOOp(&access_record));
  280. ASSERT_EQ(access_record.file_operation, GetFileOperation(2));
  281. ASSERT_EQ(access_record.io_status, IOStatus::OK().ToString());
  282. ASSERT_EQ(access_record.file_size, 10);
  283. // No more record.
  284. ASSERT_NOK(reader.ReadIOOp(&access_record));
  285. }
  286. }
  287. TEST_F(IOTracerTest, AtomicMultipleWrites) {
  288. {
  289. TraceOptions trace_opt;
  290. std::unique_ptr<TraceWriter> trace_writer;
  291. ASSERT_OK(NewFileTraceWriter(env_, env_options_, trace_file_path_,
  292. &trace_writer));
  293. IOTraceWriter writer(clock_, trace_opt, std::move(trace_writer));
  294. ASSERT_OK(writer.WriteHeader());
  295. // Write 10 records
  296. WriteIOOp(&writer, 10);
  297. ASSERT_OK(env_->FileExists(trace_file_path_));
  298. }
  299. {
  300. // Verify trace file is generated correctly.
  301. std::unique_ptr<TraceReader> trace_reader;
  302. ASSERT_OK(NewFileTraceReader(env_, env_options_, trace_file_path_,
  303. &trace_reader));
  304. IOTraceReader reader(std::move(trace_reader));
  305. IOTraceHeader header;
  306. ASSERT_OK(reader.ReadHeader(&header));
  307. ASSERT_EQ(kMajorVersion, static_cast<int>(header.rocksdb_major_version));
  308. ASSERT_EQ(kMinorVersion, static_cast<int>(header.rocksdb_minor_version));
  309. // Read 10 records.
  310. VerifyIOOp(&reader, 10);
  311. // Read one more and record and it should report error.
  312. IOTraceRecord record;
  313. ASSERT_NOK(reader.ReadIOOp(&record));
  314. }
  315. }
  316. } // namespace ROCKSDB_NAMESPACE
  317. int main(int argc, char** argv) {
  318. ROCKSDB_NAMESPACE::port::InstallStackTraceHandler();
  319. ::testing::InitGoogleTest(&argc, argv);
  320. return RUN_ALL_TESTS();
  321. }