[2024-10-15 03:44:46.040275] Starting SPDK v25.01-pre git sha1 a73e7d07f / DPDK 24.03.0 initialization... [2024-10-15 03:44:46.040405] [ DPDK EAL parameters: rocksdb --no-shconf -c 0x1 --huge-unlink --no-telemetry --log-level=lib.eal:6 --log-level=lib.cryptodev:5 --log-level=lib.power:5 --log-level=user1:6 --base-virtaddr=0x200000000000 --match-allocations --file-prefix=spdk_pid538982 ] Set seed to 1728956686037517 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-10-15 03:44:46.199599] app.c: 917:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-10-15 03:44:46.466385] app.c: 610:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-10-15 03:44:46.466447] app.c: 611:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 538982' to capture a snapshot of events at runtime. [2024-10-15 03:44:46.466466] app.c: 616:app_setup_trace: *NOTICE*: 'spdk_trace' without parameters will also work if this is the only [2024-10-15 03:44:46.466486] app.c: 617:app_setup_trace: *NOTICE*: SPDK application currently running. [2024-10-15 03:44:46.466504] app.c: 618:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid538982 for offline analysis/debug. [2024-10-15 03:44:46.468241] reactor.c:1001:reactor_run: *NOTICE*: Reactor started on core 0 [2024-10-15 03:44:49.777708] bdev_nvme.c:1777:bdev_nvme_disconnected_qpair_cb: *NOTICE*: [0000:5e:00.0] qpair 0x20001a110aa0 was disconnected and freed. delete nvme_qpair. RocksDB: version 8.1.1 Date: Tue Oct 15 03:44:53 2024 CPU: 72 * Intel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz CPUCache: 25344 KB 2024/10/15-03:44:56 ... thread 0: (1000000,1000000) ops and (256470.2,256470.2) ops/second in (3.899089,3.899089) seconds ** Compaction Stats [default] ** Level Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------ L0 8/5 503.26 MB 18.9 0.0 0.0 0.0 0.9 0.9 0.0 1.0 0.0 320.9 2.74 2.44 14 0.196 0 0 0.0 0.0 L1 4/3 312.50 MB 1.3 0.4 0.3 0.1 0.4 0.3 0.1 1.4 192.7 191.8 2.28 2.22 2 1.142 447K 2025 0.0 0.0 L2 2/1 97.63 MB 0.4 0.1 0.1 0.0 0.1 0.1 0.0 1.6 177.0 176.9 0.55 0.52 1 0.552 99K 90 0.0 0.0 L3 11/0 755.94 MB 0.8 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 140/0 9.60 GB 1.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L5 132/0 8.86 GB 0.1 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 297/9 20.09 GB 0.0 0.5 0.4 0.2 1.4 1.2 0.1 1.6 96.4 253.8 5.58 5.18 17 0.328 546K 2115 0.0 0.0 Int 0/0 0.00 KB 0.0 0.5 0.4 0.2 1.4 1.2 0.1 1.6 96.4 253.8 5.58 5.18 17 0.328 546K 2115 0.0 0.0 ** Compaction Stats [default] ** Priority Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) --------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- Low 0/0 0.00 KB 0.0 0.5 0.4 0.2 0.5 0.4 0.0 0.0 189.6 188.9 2.84 2.74 3 0.946 546K 2115 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 0.9 0.9 0.0 0.0 0.0 320.9 2.74 2.44 14 0.196 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 4.0 total, 3.9 interval Flush(GB): cumulative 0.860, interval 0.860 AddFile(GB): cumulative 0.000, interval 0.000 AddFile(Total Files): cumulative 0, interval 0 AddFile(L0 Files): cumulative 0, interval 0 AddFile(Keys): cumulative 0, interval 0 Cumulative compaction: 1.38 GB write, 352.39 MB/s write, 0.53 GB read, 133.82 MB/s read, 5.6 seconds Interval compaction: 1.38 GB write, 363.11 MB/s write, 0.53 GB read, 137.89 MB/s read, 5.6 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 0, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 0, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 0, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 0, ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 147274 Average: 2.5578 StdDev: 15.39 Min: 0 Median: 1.7038 Max: 3350 Percentiles: P50: 1.70 P75: 2.20 P99: 5.93 P99.9: 13.82 P99.99: 217.27 ------------------------------------------------------ [ 0, 1 ] 2668 1.812% 1.812% ( 1, 2 ] 100836 68.468% 70.280% ############## ( 2, 3 ] 34696 23.559% 93.839% ##### ( 3, 4 ] 4365 2.964% 96.803% # ( 4, 6 ] 3350 2.275% 99.077% ( 6, 10 ] 962 0.653% 99.730% ( 10, 15 ] 328 0.223% 99.953% ( 15, 22 ] 34 0.023% 99.976% ( 22, 34 ] 9 0.006% 99.982% ( 34, 51 ] 1 0.001% 99.983% ( 51, 76 ] 1 0.001% 99.984% ( 76, 110 ] 2 0.001% 99.985% ( 170, 250 ] 14 0.010% 99.995% ( 380, 580 ] 5 0.003% 99.998% ( 580, 870 ] 3 0.002% 100.000% ( 870, 1300 ] 2 0.001% 100.001% ( 1300, 1900 ] 1 0.001% 100.002% ( 1900, 2900 ] 1 0.001% 100.003% ( 2900, 4400 ] 2 0.001% 100.004% ** Level 1 read latency histogram (micros): Count: 42327 Average: 2.4636 StdDev: 9.89 Min: 1 Median: 1.6588 Max: 1208 Percentiles: P50: 1.66 P75: 2.08 P99: 5.78 P99.9: 12.99 P99.99: 654.17 ------------------------------------------------------ [ 0, 1 ] 2141 5.058% 5.058% # ( 1, 2 ] 28874 68.217% 73.275% ############## ( 2, 3 ] 8922 21.079% 94.353% #### ( 3, 4 ] 1094 2.585% 96.938% # ( 4, 6 ] 979 2.313% 99.251% ( 6, 10 ] 234 0.553% 99.804% ( 10, 15 ] 68 0.161% 99.965% ( 15, 22 ] 6 0.014% 99.979% ( 22, 34 ] 1 0.002% 99.981% ( 170, 250 ] 1 0.002% 99.983% ( 250, 380 ] 1 0.002% 99.986% ( 380, 580 ] 1 0.002% 99.988% ( 580, 870 ] 3 0.007% 99.995% ( 870, 1300 ] 2 0.005% 100.000% ** Level 2 read latency histogram (micros): Count: 10949 Average: 4.3563 StdDev: 58.80 Min: 1 Median: 1.6119 Max: 4958 Percentiles: P50: 1.61 P75: 1.96 P99: 13.73 P99.9: 366.29 P99.99: 2805.10 ------------------------------------------------------ [ 0, 1 ] 600 5.480% 5.480% # ( 1, 2 ] 7966 72.756% 78.235% ############### ( 2, 3 ] 1712 15.636% 93.872% ### ( 3, 4 ] 219 2.000% 95.872% ( 4, 6 ] 164 1.498% 97.370% ( 6, 10 ] 121 1.105% 98.475% ( 10, 15 ] 77 0.703% 99.178% ( 15, 22 ] 15 0.137% 99.315% ( 22, 34 ] 3 0.027% 99.342% ( 51, 76 ] 28 0.256% 99.598% ( 76, 110 ] 10 0.091% 99.689% ( 110, 170 ] 3 0.027% 99.717% ( 170, 250 ] 12 0.110% 99.826% ( 250, 380 ] 9 0.082% 99.909% ( 380, 580 ] 3 0.027% 99.936% ( 580, 870 ] 4 0.037% 99.973% ( 1300, 1900 ] 1 0.009% 99.982% ( 1900, 2900 ] 1 0.009% 99.991% ( 4400, 6600 ] 1 0.009% 100.000% ** Level 3 read latency histogram (micros): Count: 55 Average: 3779.7091 StdDev: 2784.61 Min: 284 Median: 3931.2500 Max: 9861 Percentiles: P50: 3931.25 P75: 5946.88 P99: 9698.33 P99.9: 9861.00 P99.99: 9861.00 ------------------------------------------------------ ( 250, 380 ] 1 1.818% 1.818% ( 380, 580 ] 5 9.091% 10.909% ## ( 580, 870 ] 8 14.545% 25.455% ### ( 870, 1300 ] 4 7.273% 32.727% # ( 1300, 1900 ] 4 7.273% 40.000% # ( 2900, 4400 ] 8 14.545% 54.545% ### ( 4400, 6600 ] 16 29.091% 83.636% ###### ( 6600, 9900 ] 9 16.364% 100.000% ### ** Level 4 read latency histogram (micros): Count: 20 Average: 5009.7000 StdDev: 2718.62 Min: 548 Median: 4840.0000 Max: 9967 Percentiles: P50: 4840.00 P75: 7260.00 P99: 9967.00 P99.9: 9967.00 P99.99: 9967.00 ------------------------------------------------------ ( 380, 580 ] 1 5.000% 5.000% # ( 580, 870 ] 1 5.000% 10.000% # ( 1300, 1900 ] 1 5.000% 15.000% # ( 1900, 2900 ] 1 5.000% 20.000% # ( 2900, 4400 ] 5 25.000% 45.000% ##### ( 4400, 6600 ] 5 25.000% 70.000% ##### ( 6600, 9900 ] 5 25.000% 95.000% ##### ( 9900, 14000 ] 1 5.000% 100.000% # ** DB Stats ** Uptime(secs): 4.0 total, 3.9 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 244.82 MB/s Cumulative WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Cumulative stall: 00:00:0.000 H:M:S, 0.0 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 252.25 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:0.000 H:M:S, 0.0 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 1 2024/10/15-03:45:00 ... thread 0: (1000000,2000000) ops and (249133.7,252748.7) ops/second in (4.013909,7.912998) seconds ** Compaction Stats [default] ** Level Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------ L0 14/11 1.47 GB 37.6 0.8 0.0 0.8 2.6 1.8 0.0 1.4 83.4 275.4 9.81 9.01 33 0.297 830K 4533 0.0 0.0 L1 0/0 0.00 KB 0.0 0.4 0.3 0.1 0.4 0.3 0.1 1.4 192.7 191.8 2.28 2.22 2 1.142 447K 2025 0.0 0.0 L2 2/0 63.60 MB 0.6 0.5 0.4 0.1 0.5 0.4 0.0 1.3 209.6 208.8 2.42 2.31 3 0.808 515K 1716 0.0 0.0 L3 17/0 928.54 MB 0.9 0.0 0.0 0.0 0.0 0.0 0.3 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 147/0 9.77 GB 1.0 0.2 0.2 0.0 0.2 0.2 0.0 1.0 166.4 166.4 1.04 0.95 1 1.036 175K 0 0.0 0.0 L5 132/0 8.86 GB 0.1 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 312/11 21.06 GB 0.0 1.9 0.8 1.1 3.7 2.7 0.4 2.0 124.6 245.5 15.55 14.48 39 0.399 1968K 8274 0.0 0.0 Int 0/0 0.00 KB 0.0 1.9 0.8 1.1 3.7 2.7 0.4 2.0 124.6 245.5 15.55 14.48 39 0.399 1968K 8274 0.0 0.0 ** Compaction Stats [default] ** Priority Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) --------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- Low 0/0 0.00 KB 0.0 1.9 0.8 1.1 1.9 0.8 0.0 0.0 209.8 208.9 9.24 8.89 9 1.027 1968K 8274 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 1.8 1.8 0.0 0.0 0.0 299.0 6.31 5.59 30 0.210 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 8.0 total, 7.9 interval Flush(GB): cumulative 1.843, interval 1.843 AddFile(GB): cumulative 0.000, interval 0.000 AddFile(Total Files): cumulative 0, interval 0 AddFile(L0 Files): cumulative 0, interval 0 AddFile(Keys): cumulative 0, interval 0 Cumulative compaction: 3.73 GB write, 475.16 MB/s write, 1.89 GB read, 241.26 MB/s read, 15.5 seconds Interval compaction: 3.73 GB write, 482.28 MB/s write, 1.89 GB read, 244.88 MB/s read, 15.5 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 0, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 0, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 0, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 0, ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 492568 Average: 2.4955 StdDev: 14.00 Min: 0 Median: 1.6434 Max: 4393 Percentiles: P50: 1.64 P75: 2.08 P99: 5.91 P99.9: 12.84 P99.99: 136.03 ------------------------------------------------------ [ 0, 1 ] 37855 7.685% 7.685% ## ( 1, 2 ] 323969 65.771% 73.457% ############# ( 2, 3 ] 95267 19.341% 92.798% #### ( 3, 4 ] 18119 3.678% 96.476% # ( 4, 6 ] 13023 2.644% 99.120% # ( 6, 10 ] 3461 0.703% 99.823% ( 10, 15 ] 676 0.137% 99.960% ( 15, 22 ] 75 0.015% 99.975% ( 22, 34 ] 15 0.003% 99.978% ( 34, 51 ] 4 0.001% 99.979% ( 51, 76 ] 3 0.001% 99.979% ( 76, 110 ] 16 0.003% 99.983% ( 110, 170 ] 87 0.018% 100.000% ( 170, 250 ] 32 0.006% 100.007% ( 250, 380 ] 25 0.005% 100.012% ( 380, 580 ] 21 0.004% 100.016% ( 580, 870 ] 7 0.001% 100.018% ( 870, 1300 ] 8 0.002% 100.019% ( 1300, 1900 ] 6 0.001% 100.021% ( 1900, 2900 ] 4 0.001% 100.021% ( 2900, 4400 ] 3 0.001% 100.022% ** Level 1 read latency histogram (micros): Count: 111257 Average: 2.3546 StdDev: 6.17 Min: 1 Median: 1.6155 Max: 1208 Percentiles: P50: 1.62 P75: 2.00 P99: 5.89 P99.9: 12.77 P99.99: 20.62 ------------------------------------------------------ [ 0, 1 ] 10688 9.607% 9.607% ## ( 1, 2 ] 73013 65.626% 75.232% ############# ( 2, 3 ] 19218 17.274% 92.506% ### ( 3, 4 ] 4216 3.789% 96.295% # ( 4, 6 ] 3177 2.856% 99.151% # ( 6, 10 ] 730 0.656% 99.807% ( 10, 15 ] 187 0.168% 99.975% ( 15, 22 ] 21 0.019% 99.994% ( 22, 34 ] 7 0.006% 100.000% ( 51, 76 ] 1 0.001% 100.001% ( 76, 110 ] 1 0.001% 100.002% ( 170, 250 ] 1 0.001% 100.003% ( 250, 380 ] 1 0.001% 100.004% ( 380, 580 ] 1 0.001% 100.004% ( 580, 870 ] 3 0.003% 100.007% ( 870, 1300 ] 2 0.002% 100.009% ** Level 2 read latency histogram (micros): Count: 77453 Average: 3.0991 StdDev: 22.88 Min: 1 Median: 1.9936 Max: 4958 Percentiles: P50: 1.99 P75: 2.66 P99: 8.68 P99.9: 60.95 P99.99: 670.97 ------------------------------------------------------ [ 0, 1 ] 2502 3.230% 3.230% # ( 1, 2 ] 36458 47.071% 50.301% ######### ( 2, 3 ] 28975 37.410% 87.711% ####### ( 3, 4 ] 3876 5.004% 92.716% # ( 4, 6 ] 4288 5.536% 98.252% # ( 6, 10 ] 864 1.116% 99.367% ( 10, 15 ] 336 0.434% 99.801% ( 15, 22 ] 52 0.067% 99.868% ( 22, 34 ] 11 0.014% 99.883% ( 34, 51 ] 2 0.003% 99.885% ( 51, 76 ] 29 0.037% 99.923% ( 76, 110 ] 10 0.013% 99.935% ( 110, 170 ] 9 0.012% 99.947% ( 170, 250 ] 14 0.018% 99.965% ( 250, 380 ] 9 0.012% 99.977% ( 380, 580 ] 9 0.012% 99.988% ( 580, 870 ] 4 0.005% 99.994% ( 870, 1300 ] 1 0.001% 99.995% ( 1300, 1900 ] 1 0.001% 99.996% ( 1900, 2900 ] 1 0.001% 99.997% ( 4400, 6600 ] 1 0.001% 99.999% ** Level 3 read latency histogram (micros): Count: 55 Average: 3779.7091 StdDev: 2784.61 Min: 284 Median: 3931.2500 Max: 9861 Percentiles: P50: 3931.25 P75: 5946.88 P99: 9698.33 P99.9: 9861.00 P99.99: 9861.00 ------------------------------------------------------ ( 250, 380 ] 1 1.818% 1.818% ( 380, 580 ] 5 9.091% 10.909% ## ( 580, 870 ] 8 14.545% 25.455% ### ( 870, 1300 ] 4 7.273% 32.727% # ( 1300, 1900 ] 4 7.273% 40.000% # ( 2900, 4400 ] 8 14.545% 54.545% ### ( 4400, 6600 ] 16 29.091% 83.636% ###### ( 6600, 9900 ] 9 16.364% 100.000% ### ** Level 4 read latency histogram (micros): Count: 55 Average: 1894.6364 StdDev: 2873.77 Min: 1 Median: 164.0000 Max: 9967 Percentiles: P50: 164.00 P75: 3575.00 P99: 9967.00 P99.9: 9967.00 P99.99: 9967.00 ------------------------------------------------------ [ 0, 1 ] 7 12.727% 12.727% ### ( 1, 2 ] 12 21.818% 34.545% #### ( 2, 3 ] 3 5.455% 40.000% # ( 3, 4 ] 1 1.818% 41.818% ( 110, 170 ] 5 9.091% 50.909% ## ( 170, 250 ] 1 1.818% 52.727% ( 250, 380 ] 2 3.636% 56.364% # ( 380, 580 ] 3 5.455% 61.818% # ( 580, 870 ] 3 5.455% 67.273% # ( 1300, 1900 ] 1 1.818% 69.091% ( 1900, 2900 ] 1 1.818% 70.909% ( 2900, 4400 ] 5 9.091% 80.000% ## ( 4400, 6600 ] 5 9.091% 89.091% ## ( 6600, 9900 ] 5 9.091% 98.182% ## ( 9900, 14000 ] 1 1.818% 100.000% ** DB Stats ** Uptime(secs): 8.0 total, 4.0 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 245.01 MB/s Cumulative WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Cumulative stall: 00:00:0.000 H:M:S, 0.0 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 245.20 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:0.000 H:M:S, 0.0 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 1 2024/10/15-03:45:04 ... thread 0: (1000000,3000000) ops and (249669.3,251713.8) ops/second in (4.005298,11.918296) seconds ** Compaction Stats [default] ** Level Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------ L0 13/10 1.53 GB 37.6 1.5 0.0 1.5 4.3 2.8 0.0 1.6 97.5 272.6 16.12 14.85 51 0.316 1597K 8309 0.0 0.0 L1 7/7 464.50 MB 0.0 1.3 1.2 0.1 1.3 1.1 0.1 1.1 211.9 209.1 6.22 5.95 3 2.073 1338K 16K 0.0 0.0 L2 2/0 63.60 MB 0.6 0.5 0.4 0.1 0.5 0.4 0.4 1.3 209.6 208.8 2.42 2.31 3 0.808 515K 1716 0.0 0.0 L3 13/0 759.64 MB 0.8 0.0 0.0 0.0 0.0 0.0 0.7 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 147/0 9.77 GB 1.0 0.2 0.2 0.0 0.2 0.2 0.6 1.0 166.4 166.4 1.04 0.95 1 1.036 175K 0 0.0 0.0 L5 140/0 9.41 GB 0.1 0.0 0.0 0.0 0.0 0.0 0.6 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 322/17 21.97 GB 0.0 3.5 1.7 1.8 6.2 4.4 2.3 2.3 138.4 247.1 25.80 24.06 58 0.445 3626K 27K 0.0 0.0 Int 0/0 0.00 KB 0.0 3.5 1.7 1.8 6.2 4.4 2.3 2.3 138.4 247.1 25.80 24.06 58 0.445 3626K 27K 0.0 0.0 ** Compaction Stats [default] ** Priority Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) --------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- Low 0/0 0.00 KB 0.0 3.5 1.7 1.8 3.5 1.7 0.0 0.0 221.5 219.8 16.12 15.51 13 1.240 3626K 27K 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 2.8 2.8 0.0 0.0 0.0 292.3 9.68 8.55 45 0.215 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 12.0 total, 11.9 interval Flush(GB): cumulative 2.765, interval 2.765 AddFile(GB): cumulative 0.000, interval 0.000 AddFile(Total Files): cumulative 0, interval 0 AddFile(L0 Files): cumulative 0, interval 0 AddFile(Keys): cumulative 0, interval 0 Cumulative compaction: 6.23 GB write, 529.50 MB/s write, 3.49 GB read, 296.59 MB/s read, 25.8 seconds Interval compaction: 6.23 GB write, 534.77 MB/s write, 3.49 GB read, 299.54 MB/s read, 25.8 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 0, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 0, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 0, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 0, ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 895043 Average: 2.4246 StdDev: 13.10 Min: 0 Median: 1.5920 Max: 4393 Percentiles: P50: 1.59 P75: 1.96 P99: 5.92 P99.9: 12.98 P99.99: 157.12 ------------------------------------------------------ [ 0, 1 ] 91034 10.171% 10.171% ## ( 1, 2 ] 602204 67.282% 77.453% ############# ( 2, 3 ] 145352 16.240% 93.693% ### ( 3, 4 ] 29223 3.265% 96.958% # ( 4, 6 ] 19034 2.127% 99.084% ( 6, 10 ] 6674 0.746% 99.830% ( 10, 15 ] 1054 0.118% 99.948% ( 15, 22 ] 110 0.012% 99.960% ( 22, 34 ] 21 0.002% 99.962% ( 34, 51 ] 7 0.001% 99.963% ( 51, 76 ] 11 0.001% 99.964% ( 76, 110 ] 64 0.007% 99.972% ( 110, 170 ] 212 0.024% 99.995% ( 170, 250 ] 65 0.007% 100.002% ( 250, 380 ] 56 0.006% 100.009% ( 380, 580 ] 48 0.005% 100.014% ( 580, 870 ] 13 0.001% 100.016% ( 870, 1300 ] 17 0.002% 100.017% ( 1300, 1900 ] 8 0.001% 100.018% ( 1900, 2900 ] 5 0.001% 100.019% ( 2900, 4400 ] 5 0.001% 100.019% ** Level 1 read latency histogram (micros): Count: 129228 Average: 2.6321 StdDev: 12.68 Min: 0 Median: 1.6154 Max: 1754 Percentiles: P50: 1.62 P75: 1.99 P99: 6.49 P99.9: 105.01 P99.99: 493.46 ------------------------------------------------------ [ 0, 1 ] 12183 9.428% 9.428% ## ( 1, 2 ] 85193 65.925% 75.352% ############# ( 2, 3 ] 22122 17.119% 92.471% ### ( 3, 4 ] 4772 3.693% 96.163% # ( 4, 6 ] 3539 2.739% 98.902% # ( 6, 10 ] 1038 0.803% 99.705% ( 10, 15 ] 202 0.156% 99.861% ( 15, 22 ] 23 0.018% 99.879% ( 22, 34 ] 8 0.006% 99.885% ( 51, 76 ] 1 0.001% 99.886% ( 76, 110 ] 22 0.017% 99.903% ( 110, 170 ] 60 0.046% 99.950% ( 170, 250 ] 34 0.026% 99.976% ( 250, 380 ] 10 0.008% 99.984% ( 380, 580 ] 16 0.012% 99.996% ( 580, 870 ] 11 0.009% 100.005% ( 870, 1300 ] 4 0.003% 100.008% ( 1300, 1900 ] 1 0.001% 100.009% ** Level 2 read latency histogram (micros): Count: 77453 Average: 3.0991 StdDev: 22.88 Min: 1 Median: 1.9936 Max: 4958 Percentiles: P50: 1.99 P75: 2.66 P99: 8.68 P99.9: 60.95 P99.99: 670.97 ------------------------------------------------------ [ 0, 1 ] 2502 3.230% 3.230% # ( 1, 2 ] 36458 47.071% 50.301% ######### ( 2, 3 ] 28975 37.410% 87.711% ####### ( 3, 4 ] 3876 5.004% 92.716% # ( 4, 6 ] 4288 5.536% 98.252% # ( 6, 10 ] 864 1.116% 99.367% ( 10, 15 ] 336 0.434% 99.801% ( 15, 22 ] 52 0.067% 99.868% ( 22, 34 ] 11 0.014% 99.883% ( 34, 51 ] 2 0.003% 99.885% ( 51, 76 ] 29 0.037% 99.923% ( 76, 110 ] 10 0.013% 99.935% ( 110, 170 ] 9 0.012% 99.947% ( 170, 250 ] 14 0.018% 99.965% ( 250, 380 ] 9 0.012% 99.977% ( 380, 580 ] 9 0.012% 99.988% ( 580, 870 ] 4 0.005% 99.994% ( 870, 1300 ] 1 0.001% 99.995% ( 1300, 1900 ] 1 0.001% 99.996% ( 1900, 2900 ] 1 0.001% 99.997% ( 4400, 6600 ] 1 0.001% 99.999% ** Level 3 read latency histogram (micros): Count: 55 Average: 3779.7091 StdDev: 2784.61 Min: 284 Median: 3931.2500 Max: 9861 Percentiles: P50: 3931.25 P75: 5946.88 P99: 9698.33 P99.9: 9861.00 P99.99: 9861.00 ------------------------------------------------------ ( 250, 380 ] 1 1.818% 1.818% ( 380, 580 ] 5 9.091% 10.909% ## ( 580, 870 ] 8 14.545% 25.455% ### ( 870, 1300 ] 4 7.273% 32.727% # ( 1300, 1900 ] 4 7.273% 40.000% # ( 2900, 4400 ] 8 14.545% 54.545% ### ( 4400, 6600 ] 16 29.091% 83.636% ###### ( 6600, 9900 ] 9 16.364% 100.000% ### ** Level 4 read latency histogram (micros): Count: 55 Average: 1894.6364 StdDev: 2873.77 Min: 1 Median: 164.0000 Max: 9967 Percentiles: P50: 164.00 P75: 3575.00 P99: 9967.00 P99.9: 9967.00 P99.99: 9967.00 ------------------------------------------------------ [ 0, 1 ] 7 12.727% 12.727% ### ( 1, 2 ] 12 21.818% 34.545% #### ( 2, 3 ] 3 5.455% 40.000% # ( 3, 4 ] 1 1.818% 41.818% ( 110, 170 ] 5 9.091% 50.909% ## ( 170, 250 ] 1 1.818% 52.727% ( 250, 380 ] 2 3.636% 56.364% # ( 380, 580 ] 3 5.455% 61.818% # ( 580, 870 ] 3 5.455% 67.273% # ( 1300, 1900 ] 1 1.818% 69.091% ( 1900, 2900 ] 1 1.818% 70.909% ( 2900, 4400 ] 5 9.091% 80.000% ## ( 4400, 6600 ] 5 9.091% 89.091% ## ( 6600, 9900 ] 5 9.091% 98.182% ## ( 9900, 14000 ] 1 1.818% 100.000% ** Level 5 read latency histogram (micros): Count: 40 Average: 849.6750 StdDev: 955.96 Min: 96 Median: 420.0000 Max: 3314 Percentiles: P50: 420.00 P75: 1300.00 P99: 3314.00 P99.9: 3314.00 P99.99: 3314.00 ------------------------------------------------------ ( 76, 110 ] 3 7.500% 7.500% ## ( 110, 170 ] 10 25.000% 32.500% ##### ( 170, 250 ] 4 10.000% 42.500% ## ( 250, 380 ] 2 5.000% 47.500% # ( 380, 580 ] 5 12.500% 60.000% ### ( 580, 870 ] 5 12.500% 72.500% ### ( 870, 1300 ] 1 2.500% 75.000% # ( 1300, 1900 ] 3 7.500% 82.500% ## ( 1900, 2900 ] 4 10.000% 92.500% ## ( 2900, 4400 ] 3 7.500% 100.000% ## ** DB Stats ** Uptime(secs): 12.0 total, 4.0 interval Cumulative writes: 0 writes, 3000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 2.88 GB, 245.25 MB/s Cumulative WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Cumulative stall: 00:00:0.000 H:M:S, 0.0 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 245.72 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:0.000 H:M:S, 0.0 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 1 2024/10/15-03:45:08 ... thread 0: (1000000,4000000) ops and (249764.8,251223.7) ops/second in (4.003766,15.922062) seconds ** Compaction Stats [default] ** Level Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------ L0 11/4 1.59 GB 137.8 2.5 0.0 2.5 6.3 3.7 0.0 1.7 108.8 270.0 23.71 21.92 71 0.334 2619K 13K 0.0 0.0 L1 8/0 849.84 MB 85.0 2.7 2.1 0.6 2.6 2.0 0.1 1.3 216.0 211.5 12.60 12.00 4 3.150 2764K 56K 0.0 0.0 L2 5/3 564.36 MB 2.6 0.5 0.4 0.1 0.5 0.4 0.9 1.3 209.6 208.8 2.42 2.31 3 0.808 515K 1716 0.0 0.0 L3 14/6 774.00 MB 0.3 0.0 0.0 0.0 0.0 0.0 0.7 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 147/0 9.77 GB 1.0 0.2 0.2 0.0 0.2 0.2 0.6 1.0 166.4 166.4 1.04 0.95 1 1.036 175K 0 0.0 0.0 L5 140/0 9.41 GB 0.1 0.0 0.0 0.0 0.0 0.0 0.6 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 325/13 22.91 GB 0.0 5.8 2.6 3.2 9.5 6.3 2.8 2.5 150.4 245.1 39.77 37.18 79 0.503 6074K 71K 0.0 0.0 Int 0/0 0.00 KB 0.0 5.8 2.6 3.2 9.5 6.3 2.8 2.5 150.4 245.1 39.77 37.18 79 0.503 6074K 71K 0.0 0.0 ** Compaction Stats [default] ** Priority Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) --------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- Low 0/0 0.00 KB 0.0 5.8 2.6 3.2 5.8 2.5 0.0 0.0 226.1 223.4 26.45 25.43 18 1.469 6074K 71K 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 3.7 3.7 0.0 0.0 0.0 288.0 13.32 11.75 61 0.218 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 16.0 total, 15.9 interval Flush(GB): cumulative 3.748, interval 3.748 AddFile(GB): cumulative 0.000, interval 0.000 AddFile(Total Files): cumulative 0, interval 0 AddFile(L0 Files): cumulative 0, interval 0 AddFile(Keys): cumulative 0, interval 0 Cumulative compaction: 9.52 GB write, 607.61 MB/s write, 5.84 GB read, 372.85 MB/s read, 39.8 seconds Interval compaction: 9.52 GB write, 612.14 MB/s write, 5.84 GB read, 375.63 MB/s read, 39.8 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 0, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 0, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 0, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 0, ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 1255336 Average: 2.4525 StdDev: 13.12 Min: 0 Median: 1.5856 Max: 4393 Percentiles: P50: 1.59 P75: 1.96 P99: 5.96 P99.9: 13.70 P99.99: 200.50 ------------------------------------------------------ [ 0, 1 ] 130530 10.398% 10.398% ## ( 1, 2 ] 848968 67.629% 78.027% ############## ( 2, 3 ] 197633 15.743% 93.770% ### ( 3, 4 ] 40702 3.242% 97.013% # ( 4, 6 ] 25467 2.029% 99.041% ( 6, 10 ] 9622 0.766% 99.808% ( 10, 15 ] 1565 0.125% 99.932% ( 15, 22 ] 147 0.012% 99.944% ( 22, 34 ] 24 0.002% 99.946% ( 34, 51 ] 11 0.001% 99.947% ( 51, 76 ] 13 0.001% 99.948% ( 76, 110 ] 89 0.007% 99.955% ( 110, 170 ] 389 0.031% 99.986% ( 170, 250 ] 135 0.011% 99.997% ( 250, 380 ] 108 0.009% 100.005% ( 380, 580 ] 87 0.007% 100.012% ( 580, 870 ] 26 0.002% 100.014% ( 870, 1300 ] 27 0.002% 100.016% ( 1300, 1900 ] 16 0.001% 100.018% ( 1900, 2900 ] 6 0.000% 100.018% ( 2900, 4400 ] 5 0.000% 100.019% ** Level 1 read latency histogram (micros): Count: 241008 Average: 3.1365 StdDev: 21.94 Min: 0 Median: 1.6220 Max: 3263 Percentiles: P50: 1.62 P75: 2.00 P99: 8.29 P99.9: 217.21 P99.99: 724.19 ------------------------------------------------------ [ 0, 1 ] 21222 8.806% 8.806% ## ( 1, 2 ] 159624 66.232% 75.037% ############# ( 2, 3 ] 40727 16.899% 91.936% ### ( 3, 4 ] 8820 3.660% 95.596% # ( 4, 6 ] 6457 2.679% 98.275% # ( 6, 10 ] 3059 1.269% 99.544% ( 10, 15 ] 357 0.148% 99.692% ( 15, 22 ] 51 0.021% 99.713% ( 22, 34 ] 10 0.004% 99.717% ( 51, 76 ] 2 0.001% 99.718% ( 76, 110 ] 117 0.049% 99.767% ( 110, 170 ] 253 0.105% 99.872% ( 170, 250 ] 122 0.051% 99.922% ( 250, 380 ] 64 0.027% 99.949% ( 380, 580 ] 85 0.035% 99.984% ( 580, 870 ] 36 0.015% 99.999% ( 870, 1300 ] 16 0.007% 100.006% ( 1300, 1900 ] 5 0.002% 100.008% ( 1900, 2900 ] 4 0.002% 100.010% ( 2900, 4400 ] 1 0.000% 100.010% ** Level 2 read latency histogram (micros): Count: 80226 Average: 3.4149 StdDev: 25.50 Min: 1 Median: 2.0242 Max: 4958 Percentiles: P50: 2.02 P75: 2.68 P99: 9.11 P99.9: 218.54 P99.99: 824.88 ------------------------------------------------------ [ 0, 1 ] 2502 3.119% 3.119% # ( 1, 2 ] 36877 45.966% 49.085% ######### ( 2, 3 ] 30368 37.853% 86.938% ######## ( 3, 4 ] 4223 5.264% 92.202% # ( 4, 6 ] 4707 5.867% 98.069% # ( 6, 10 ] 961 1.198% 99.267% ( 10, 15 ] 360 0.449% 99.716% ( 15, 22 ] 61 0.076% 99.792% ( 22, 34 ] 12 0.015% 99.807% ( 34, 51 ] 2 0.002% 99.809% ( 51, 76 ] 29 0.036% 99.845% ( 76, 110 ] 11 0.014% 99.859% ( 110, 170 ] 17 0.021% 99.880% ( 170, 250 ] 26 0.032% 99.913% ( 250, 380 ] 26 0.032% 99.945% ( 380, 580 ] 25 0.031% 99.976% ( 580, 870 ] 13 0.016% 99.993% ( 870, 1300 ] 2 0.002% 99.995% ( 1300, 1900 ] 1 0.001% 99.996% ( 1900, 2900 ] 1 0.001% 99.998% ( 4400, 6600 ] 1 0.001% 99.999% ** Level 3 read latency histogram (micros): Count: 652 Average: 352.4126 StdDev: 1322.78 Min: 2 Median: 3.8643 Max: 9861 Percentiles: P50: 3.86 P75: 7.47 P99: 7509.33 P99.9: 9660.93 P99.99: 9861.00 ------------------------------------------------------ ( 1, 2 ] 6 0.920% 0.920% ( 2, 3 ] 129 19.785% 20.706% #### ( 3, 4 ] 221 33.896% 54.601% ####### ( 4, 6 ] 115 17.638% 72.239% #### ( 6, 10 ] 49 7.515% 79.755% ## ( 10, 15 ] 8 1.227% 80.982% ( 15, 22 ] 3 0.460% 81.442% ( 22, 34 ] 2 0.307% 81.748% ( 76, 110 ] 2 0.307% 82.055% ( 110, 170 ] 23 3.528% 85.583% # ( 170, 250 ] 12 1.840% 87.423% ( 250, 380 ] 12 1.840% 89.264% ( 380, 580 ] 14 2.147% 91.411% ( 580, 870 ] 13 1.994% 93.405% ( 870, 1300 ] 5 0.767% 94.172% ( 1300, 1900 ] 5 0.767% 94.939% ( 2900, 4400 ] 8 1.227% 96.166% ( 4400, 6600 ] 16 2.454% 98.620% ( 6600, 9900 ] 9 1.380% 100.000% ** Level 4 read latency histogram (micros): Count: 55 Average: 1894.6364 StdDev: 2873.77 Min: 1 Median: 164.0000 Max: 9967 Percentiles: P50: 164.00 P75: 3575.00 P99: 9967.00 P99.9: 9967.00 P99.99: 9967.00 ------------------------------------------------------ [ 0, 1 ] 7 12.727% 12.727% ### ( 1, 2 ] 12 21.818% 34.545% #### ( 2, 3 ] 3 5.455% 40.000% # ( 3, 4 ] 1 1.818% 41.818% ( 110, 170 ] 5 9.091% 50.909% ## ( 170, 250 ] 1 1.818% 52.727% ( 250, 380 ] 2 3.636% 56.364% # ( 380, 580 ] 3 5.455% 61.818% # ( 580, 870 ] 3 5.455% 67.273% # ( 1300, 1900 ] 1 1.818% 69.091% ( 1900, 2900 ] 1 1.818% 70.909% ( 2900, 4400 ] 5 9.091% 80.000% ## ( 4400, 6600 ] 5 9.091% 89.091% ## ( 6600, 9900 ] 5 9.091% 98.182% ## ( 9900, 14000 ] 1 1.818% 100.000% ** Level 5 read latency histogram (micros): Count: 40 Average: 849.6750 StdDev: 955.96 Min: 96 Median: 420.0000 Max: 3314 Percentiles: P50: 420.00 P75: 1300.00 P99: 3314.00 P99.9: 3314.00 P99.99: 3314.00 ------------------------------------------------------ ( 76, 110 ] 3 7.500% 7.500% ## ( 110, 170 ] 10 25.000% 32.500% ##### ( 170, 250 ] 4 10.000% 42.500% ## ( 250, 380 ] 2 5.000% 47.500% # ( 380, 580 ] 5 12.500% 60.000% ### ( 580, 870 ] 5 12.500% 72.500% ### ( 870, 1300 ] 1 2.500% 75.000% # ( 1300, 1900 ] 3 7.500% 82.500% ## ( 1900, 2900 ] 4 10.000% 92.500% ## ( 2900, 4400 ] 3 7.500% 100.000% ## ** DB Stats ** Uptime(secs): 16.0 total, 4.0 interval Cumulative writes: 0 writes, 4000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 3.84 GB, 245.39 MB/s Cumulative WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Cumulative stall: 00:00:0.000 H:M:S, 0.0 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 245.81 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:0.000 H:M:S, 0.0 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 4 num-running-flushes: 1 using bdev Nvme0n1 Initializing RocksDB Options from the specified file Initializing RocksDB Options from command-line flags Integrated BlobDB: blob cache disabled Keys: 16 bytes each (+ 0 bytes user-defined timestamp) Values: 1000 bytes each (1000 bytes after compression) Entries: 20000000 Prefix: 0 bytes Keys per prefix: 0 RawSize: 19378.7 MB (estimated) FileSize: 19378.7 MB (estimated) Write rate: 0 bytes/second Read rate: 0 ops/second Compression: NoCompression Compression sampling rate: 0 Memtablerep: SkipListFactory Perf Level: 1 ------------------------------------------------ DB path: [/mnt/rocksdb] overwrite : 4.013 micros/op 249174 ops/sec 20.002 seconds 4983999 operations; 241.4 MB/s Microseconds per write: Count: 4983999 Average: 4.0133 StdDev: 13.32 Min: 1 Median: 2.7182 Max: 26365 Percentiles: P50: 2.72 P75: 4.32 P99: 9.87 P99.9: 112.82 P99.99: 242.14 ------------------------------------------------------ [ 0, 1 ] 4952 0.099% 0.099% ( 1, 2 ] 1053951 21.147% 21.246% #### ( 2, 3 ] 1995397 40.036% 61.282% ######## ( 3, 4 ] 528868 10.611% 71.893% ## ( 4, 6 ] 972699 19.516% 91.410% #### ( 6, 10 ] 391391 7.853% 99.263% ## ( 10, 15 ] 24560 0.493% 99.756% ( 15, 22 ] 4846 0.097% 99.853% ( 22, 34 ] 1721 0.035% 99.887% ( 34, 51 ] 484 0.010% 99.897% ( 51, 76 ] 58 0.001% 99.898% ( 76, 110 ] 2 0.000% 99.898% ( 110, 170 ] 1833 0.037% 99.935% ( 170, 250 ] 3037 0.061% 99.996% ( 250, 380 ] 184 0.004% 100.000% ( 380, 580 ] 10 0.000% 100.000% ( 580, 870 ] 3 0.000% 100.000% ( 870, 1300 ] 2 0.000% 100.000% ( 22000, 33000 ] 1 0.000% 100.000% STATISTICS: rocksdb.block.cache.miss COUNT : 0 rocksdb.block.cache.hit COUNT : 0 rocksdb.block.cache.add COUNT : 0 rocksdb.block.cache.add.failures COUNT : 0 rocksdb.block.cache.index.miss COUNT : 0 rocksdb.block.cache.index.hit COUNT : 0 rocksdb.block.cache.index.add COUNT : 0 rocksdb.block.cache.index.bytes.insert COUNT : 0 rocksdb.block.cache.filter.miss COUNT : 0 rocksdb.block.cache.filter.hit COUNT : 0 rocksdb.block.cache.filter.add COUNT : 0 rocksdb.block.cache.filter.bytes.insert COUNT : 0 rocksdb.block.cache.data.miss COUNT : 0 rocksdb.block.cache.data.hit COUNT : 0 rocksdb.block.cache.data.add COUNT : 0 rocksdb.block.cache.data.bytes.insert COUNT : 0 rocksdb.block.cache.bytes.read COUNT : 0 rocksdb.block.cache.bytes.write COUNT : 0 rocksdb.bloom.filter.useful COUNT : 0 rocksdb.bloom.filter.full.positive COUNT : 0 rocksdb.bloom.filter.full.true.positive COUNT : 0 rocksdb.persistent.cache.hit COUNT : 0 rocksdb.persistent.cache.miss COUNT : 0 rocksdb.sim.block.cache.hit COUNT : 0 rocksdb.sim.block.cache.miss COUNT : 0 rocksdb.memtable.hit COUNT : 0 rocksdb.memtable.miss COUNT : 0 rocksdb.l0.hit COUNT : 0 rocksdb.l1.hit COUNT : 0 rocksdb.l2andup.hit COUNT : 0 rocksdb.compaction.key.drop.new COUNT : 126652 rocksdb.compaction.key.drop.obsolete COUNT : 0 rocksdb.compaction.key.drop.range_del COUNT : 0 rocksdb.compaction.key.drop.user COUNT : 0 rocksdb.compaction.range_del.drop.obsolete COUNT : 0 rocksdb.compaction.optimized.del.drop.obsolete COUNT : 0 rocksdb.compaction.cancelled COUNT : 0 rocksdb.number.keys.written COUNT : 4983999 rocksdb.number.keys.read COUNT : 0 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 5143486968 rocksdb.bytes.read COUNT : 0 rocksdb.number.db.seek COUNT : 0 rocksdb.number.db.next COUNT : 0 rocksdb.number.db.prev COUNT : 0 rocksdb.number.db.seek.found COUNT : 0 rocksdb.number.db.next.found COUNT : 0 rocksdb.number.db.prev.found COUNT : 0 rocksdb.db.iter.bytes.read COUNT : 0 rocksdb.no.file.opens COUNT : 171 rocksdb.no.file.errors COUNT : 0 rocksdb.stall.micros COUNT : 0 rocksdb.db.mutex.wait.micros COUNT : 0 rocksdb.number.multiget.get COUNT : 0 rocksdb.number.multiget.keys.read COUNT : 0 rocksdb.number.multiget.bytes.read COUNT : 0 rocksdb.number.merge.failures COUNT : 0 rocksdb.bloom.filter.prefix.checked COUNT : 0 rocksdb.bloom.filter.prefix.useful COUNT : 0 rocksdb.number.reseeks.iteration COUNT : 0 rocksdb.getupdatessince.calls COUNT : 0 rocksdb.wal.synced COUNT : 0 rocksdb.wal.bytes COUNT : 0 rocksdb.write.self COUNT : 0 rocksdb.write.other COUNT : 0 rocksdb.write.wal COUNT : 0 rocksdb.compact.read.bytes COUNT : 9520994405 rocksdb.compact.write.bytes COUNT : 9393392254 rocksdb.flush.write.bytes COUNT : 5013637730 rocksdb.compact.read.marked.bytes COUNT : 0 rocksdb.compact.read.periodic.bytes COUNT : 0 rocksdb.compact.read.ttl.bytes COUNT : 0 rocksdb.compact.write.marked.bytes COUNT : 0 rocksdb.compact.write.periodic.bytes COUNT : 0 rocksdb.compact.write.ttl.bytes COUNT : 0 rocksdb.number.direct.load.table.properties COUNT : 16 rocksdb.number.superversion_acquires COUNT : 0 rocksdb.number.superversion_releases COUNT : 0 rocksdb.number.superversion_cleanups COUNT : 0 rocksdb.number.block.compressed COUNT : 0 rocksdb.number.block.decompressed COUNT : 0 rocksdb.number.block.not_compressed COUNT : 0 rocksdb.merge.operation.time.nanos COUNT : 0 rocksdb.filter.operation.time.nanos COUNT : 0 rocksdb.row.cache.hit COUNT : 0 rocksdb.row.cache.miss COUNT : 0 rocksdb.read.amp.estimate.useful.bytes COUNT : 0 rocksdb.read.amp.total.read.bytes COUNT : 0 rocksdb.number.rate_limiter.drains COUNT : 0 rocksdb.number.iter.skip COUNT : 0 rocksdb.blobdb.num.put COUNT : 0 rocksdb.blobdb.num.write COUNT : 0 rocksdb.blobdb.num.get COUNT : 0 rocksdb.blobdb.num.multiget COUNT : 0 rocksdb.blobdb.num.seek COUNT : 0 rocksdb.blobdb.num.next COUNT : 0 rocksdb.blobdb.num.prev COUNT : 0 rocksdb.blobdb.num.keys.written COUNT : 0 rocksdb.blobdb.num.keys.read COUNT : 0 rocksdb.blobdb.bytes.written COUNT : 0 rocksdb.blobdb.bytes.read COUNT : 0 rocksdb.blobdb.write.inlined COUNT : 0 rocksdb.blobdb.write.inlined.ttl COUNT : 0 rocksdb.blobdb.write.blob COUNT : 0 rocksdb.blobdb.write.blob.ttl COUNT : 0 rocksdb.blobdb.blob.file.bytes.written COUNT : 0 rocksdb.blobdb.blob.file.bytes.read COUNT : 0 rocksdb.blobdb.blob.file.synced COUNT : 0 rocksdb.blobdb.blob.index.expired.count COUNT : 0 rocksdb.blobdb.blob.index.expired.size COUNT : 0 rocksdb.blobdb.blob.index.evicted.count COUNT : 0 rocksdb.blobdb.blob.index.evicted.size COUNT : 0 rocksdb.blobdb.gc.num.files COUNT : 0 rocksdb.blobdb.gc.num.new.files COUNT : 0 rocksdb.blobdb.gc.failures COUNT : 0 rocksdb.blobdb.gc.num.keys.relocated COUNT : 0 rocksdb.blobdb.gc.bytes.relocated COUNT : 0 rocksdb.blobdb.fifo.num.files.evicted COUNT : 0 rocksdb.blobdb.fifo.num.keys.evicted COUNT : 0 rocksdb.blobdb.fifo.bytes.evicted COUNT : 0 rocksdb.txn.overhead.mutex.prepare COUNT : 0 rocksdb.txn.overhead.mutex.old.commit.map COUNT : 0 rocksdb.txn.overhead.duplicate.key COUNT : 0 rocksdb.txn.overhead.mutex.snapshot COUNT : 0 rocksdb.txn.get.tryagain COUNT : 0 rocksdb.number.multiget.keys.found COUNT : 0 rocksdb.num.iterator.created COUNT : 0 rocksdb.num.iterator.deleted COUNT : 0 rocksdb.block.cache.compression.dict.miss COUNT : 0 rocksdb.block.cache.compression.dict.hit COUNT : 0 rocksdb.block.cache.compression.dict.add COUNT : 0 rocksdb.block.cache.compression.dict.bytes.insert COUNT : 0 rocksdb.block.cache.add.redundant COUNT : 0 rocksdb.block.cache.index.add.redundant COUNT : 0 rocksdb.block.cache.filter.add.redundant COUNT : 0 rocksdb.block.cache.data.add.redundant COUNT : 0 rocksdb.block.cache.compression.dict.add.redundant COUNT : 0 rocksdb.files.marked.trash COUNT : 0 rocksdb.files.deleted.immediately COUNT : 83 rocksdb.error.handler.bg.errro.count COUNT : 0 rocksdb.error.handler.bg.io.errro.count COUNT : 0 rocksdb.error.handler.bg.retryable.io.errro.count COUNT : 0 rocksdb.error.handler.autoresume.count COUNT : 0 rocksdb.error.handler.autoresume.retry.total.count COUNT : 0 rocksdb.error.handler.autoresume.success.count COUNT : 0 rocksdb.memtable.payload.bytes.at.flush COUNT : 4979842048 rocksdb.memtable.garbage.bytes.at.flush COUNT : 7988224 rocksdb.secondary.cache.hits COUNT : 0 rocksdb.verify_checksum.read.bytes COUNT : 0 rocksdb.backup.read.bytes COUNT : 0 rocksdb.backup.write.bytes COUNT : 0 rocksdb.remote.compact.read.bytes COUNT : 0 rocksdb.remote.compact.write.bytes COUNT : 0 rocksdb.hot.file.read.bytes COUNT : 0 rocksdb.warm.file.read.bytes COUNT : 0 rocksdb.cold.file.read.bytes COUNT : 0 rocksdb.hot.file.read.count COUNT : 0 rocksdb.warm.file.read.count COUNT : 0 rocksdb.cold.file.read.count COUNT : 0 rocksdb.last.level.read.bytes COUNT : 0 rocksdb.last.level.read.count COUNT : 0 rocksdb.non.last.level.read.bytes COUNT : 9564759235 rocksdb.non.last.level.read.count COUNT : 2308999 rocksdb.block.checksum.compute.count COUNT : 2308673 rocksdb.multiget.coroutine.count COUNT : 0 rocksdb.blobdb.cache.miss COUNT : 0 rocksdb.blobdb.cache.hit COUNT : 0 rocksdb.blobdb.cache.add COUNT : 0 rocksdb.blobdb.cache.add.failures COUNT : 0 rocksdb.blobdb.cache.bytes.read COUNT : 0 rocksdb.blobdb.cache.bytes.write COUNT : 0 rocksdb.read.async.micros COUNT : 0 rocksdb.async.read.error.count COUNT : 0 rocksdb.secondary.cache.filter.hits COUNT : 0 rocksdb.secondary.cache.index.hits COUNT : 0 rocksdb.secondary.cache.data.hits COUNT : 0 rocksdb.table.open.prefetch.tail.miss COUNT : 0 rocksdb.table.open.prefetch.tail.hit COUNT : 0 rocksdb.db.get.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.db.write.micros P50 : 1.941495 P95 : 6.187455 P99 : 9.606569 P100 : 845.000000 COUNT : 4983999 SUM : 16546266 rocksdb.compaction.times.micros P50 : 1129166.666667 P95 : 3950000.000000 P99 : 5950000.000000 P100 : 6381604.000000 COUNT : 25 SUM : 35484023 rocksdb.compaction.times.cpu_micros P50 : 1090714.285714 P95 : 3950000.000000 P99 : 5950000.000000 P100 : 6047513.000000 COUNT : 25 SUM : 34015481 rocksdb.subcompaction.setup.times.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.table.sync.micros P50 : 841.000000 P95 : 1780.000000 P99 : 2520.000000 P100 : 2847.000000 COUNT : 76 SUM : 70330 rocksdb.compaction.outfile.sync.micros P50 : 909.090909 P95 : 1640.000000 P99 : 1848.000000 P100 : 1889.000000 COUNT : 78 SUM : 74597 rocksdb.wal.file.sync.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.manifest.file.sync.micros P50 : 138.333333 P95 : 311.100000 P99 : 504.666667 P100 : 543.000000 COUNT : 113 SUM : 17330 rocksdb.table.open.io.micros P50 : 1653.571429 P95 : 22550.000000 P99 : 26565.000000 P100 : 26565.000000 COUNT : 171 SUM : 622116 rocksdb.db.multiget.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.read.block.compaction.micros P50 : 3.878178 P95 : 7.297078 P99 : 10.915607 P100 : 10362.000000 COUNT : 2308372 SUM : 11556902 rocksdb.read.block.get.micros P50 : 658.076923 P95 : 6112.857143 P99 : 9509.500000 P100 : 10040.000000 COUNT : 342 SUM : 462659 rocksdb.write.raw.block.micros P50 : 0.518579 P95 : 0.985300 P99 : 4.024686 P100 : 5592.000000 COUNT : 3507162 SUM : 7701588 rocksdb.numfiles.in.singlecompaction P50 : 3.420000 P95 : 10.250000 P99 : 17.000000 P100 : 17.000000 COUNT : 39 SUM : 165 rocksdb.db.seek.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.db.write.stall P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.sst.read.micros P50 : 1.678563 P95 : 3.954678 P99 : 7.567627 P100 : 9967.000000 COUNT : 2309352 SUM : 6862754 rocksdb.num.subcompactions.scheduled P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.bytes.per.read P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.bytes.per.write P50 : 1032.000000 P95 : 1032.000000 P99 : 1032.000000 P100 : 1032.000000 COUNT : 4983999 SUM : 5143486968 rocksdb.bytes.per.multiget P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.bytes.compressed P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.bytes.decompressed P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.compression.times.nanos P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.decompression.times.nanos P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.read.num.merge_operands P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.key.size P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.value.size P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.write.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.get.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.multiget.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.seek.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.next.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.prev.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.blob.file.write.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.blob.file.read.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.blob.file.sync.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.compression.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.blobdb.decompression.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.db.flush.micros P50 : 212816.901408 P95 : 281200.000000 P99 : 360240.000000 P100 : 367025.000000 COUNT : 76 SUM : 16880448 rocksdb.sst.batch.size P50 : 0.00000[2024-10-15 03:45:13.391205] bdev_nvme.c:1777:bdev_nvme_disconnected_qpair_cb: *NOTICE*: [0000:5e:00.0] qpair 0x20001a110aa0 was disconnected and freed. delete nvme_qpair. 0 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.num.index.and.filter.blocks.read.per.level P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.num.sst.read.per.level P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.error.handler.autoresume.retry.count P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.async.read.bytes P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.poll.wait.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.prefetched.bytes.discarded P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 104 SUM : 0 rocksdb.multiget.io.batch.size P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.num.level.read.per.multiget P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.async.prefetch.abort.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.table.open.prefetch.tail.read.bytes P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0