[2024-07-24 22:55:04.680369] Starting SPDK v24.09-pre git sha1 23fce3def / DPDK 24.03.0 initialization... [2024-07-24 22:55:04.680689] [ 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_pid2826375 ] Set seed to 1721854504673072 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-07-24 22:55:04.879390] app.c: 909:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-07-24 22:55:05.194140] app.c: 603:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-07-24 22:55:05.194193] app.c: 604:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 2826375' to capture a snapshot of events at runtime. [2024-07-24 22:55:05.194212] app.c: 609:app_setup_trace: *NOTICE*: 'spdk_trace' without parameters will also work if this is the only [2024-07-24 22:55:05.194231] app.c: 610:app_setup_trace: *NOTICE*: SPDK application currently running. [2024-07-24 22:55:05.194245] app.c: 611:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid2826375 for offline analysis/debug. [2024-07-24 22:55:05.194368] reactor.c: 941:reactor_run: *NOTICE*: Reactor started on core 0 RocksDB: version 8.1.1 Date: Wed Jul 24 22:55:13 2024 CPU: 72 * Intel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz CPUCache: 25344 KB 2024/07/24-22:55:21 ... thread 0: (1000000,1000000) ops and (120353.1,120353.1) ops/second in (8.308884,8.308884) 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/8 503.27 MB 0.0 0.0 0.0 0.0 0.9 0.9 0.0 1.0 0.0 191.6 4.60 4.20 14 0.328 0 0 0.0 0.0 L1 2/2 133.78 MB 0.0 0.3 0.3 0.0 0.3 0.3 0.1 1.0 166.0 165.5 1.93 1.88 2 0.966 325K 900 0.0 0.0 L2 1/1 100.68 MB 0.0 0.4 0.2 0.2 0.4 0.2 0.0 1.9 158.2 157.8 2.91 2.77 3 0.971 467K 1240 0.0 0.0 L3 22/13 1.09 GB 0.2 0.0 0.0 0.0 0.0 0.0 0.2 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 140/0 9.54 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 140/0 8.74 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 313/24 20.09 GB 0.0 0.8 0.5 0.2 1.6 1.4 0.3 1.9 82.8 175.8 9.44 8.85 19 0.497 793K 2140 0.0 0.0 Int 0/0 0.00 KB 0.0 0.8 0.5 0.2 1.6 1.4 0.3 1.9 82.8 175.8 9.44 8.85 19 0.497 793K 2140 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.8 0.5 0.2 0.8 0.5 0.0 0.0 161.3 160.9 4.84 4.65 5 0.969 793K 2140 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 191.6 4.60 4.20 14 0.328 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.5 total, 8.3 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.62 GB write, 196.37 MB/s write, 0.76 GB read, 92.44 MB/s read, 9.4 seconds Interval compaction: 1.62 GB write, 199.70 MB/s write, 0.76 GB read, 94.00 MB/s read, 9.4 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: 172293 Average: 3.1322 StdDev: 14.63 Min: 1 Median: 2.2886 Max: 3115 Percentiles: P50: 2.29 P75: 2.77 P99: 8.88 P99.9: 17.83 P99.99: 33.70 ------------------------------------------------------ [ 0, 1 ] 11 0.006% 0.006% ( 1, 2 ] 60524 35.129% 35.135% ####### ( 2, 3 ] 88760 51.517% 86.652% ########## ( 3, 4 ] 6896 4.002% 90.654% # ( 4, 6 ] 12141 7.047% 97.701% # ( 6, 10 ] 3112 1.806% 99.507% ( 10, 15 ] 606 0.352% 99.859% ( 15, 22 ] 180 0.104% 99.963% ( 22, 34 ] 49 0.028% 99.992% ( 34, 51 ] 3 0.002% 99.994% ( 51, 76 ] 2 0.001% 99.995% ( 76, 110 ] 1 0.001% 99.995% ( 250, 380 ] 4 0.002% 99.998% ( 380, 580 ] 14 0.008% 100.006% ( 580, 870 ] 4 0.002% 100.008% ( 870, 1300 ] 1 0.001% 100.009% ( 1300, 1900 ] 2 0.001% 100.010% ( 1900, 2900 ] 1 0.001% 100.010% ( 2900, 4400 ] 2 0.001% 100.012% ** Level 1 read latency histogram (micros): Count: 80066 Average: 2.8573 StdDev: 6.54 Min: 1 Median: 2.2325 Max: 1416 Percentiles: P50: 2.23 P75: 2.68 P99: 6.69 P99.9: 13.03 P99.99: 75.83 ------------------------------------------------------ [ 0, 1 ] 7 0.009% 0.009% ( 1, 2 ] 29644 37.024% 37.033% ####### ( 2, 3 ] 44656 55.774% 92.807% ########### ( 3, 4 ] 2328 2.908% 95.715% # ( 4, 6 ] 2497 3.119% 98.833% # ( 6, 10 ] 784 0.979% 99.813% ( 10, 15 ] 117 0.146% 99.959% ( 15, 22 ] 21 0.026% 99.985% ( 22, 34 ] 2 0.002% 99.988% ( 34, 51 ] 2 0.002% 99.990% ( 51, 76 ] 1 0.001% 99.991% ( 250, 380 ] 2 0.002% 99.994% ( 380, 580 ] 4 0.005% 99.999% ( 580, 870 ] 1 0.001% 100.000% ( 1300, 1900 ] 1 0.001% 100.001% ** Level 2 read latency histogram (micros): Count: 55474 Average: 3.4201 StdDev: 39.66 Min: 1 Median: 2.0483 Max: 4867 Percentiles: P50: 2.05 P75: 2.57 P99: 8.53 P99.9: 97.38 P99.99: 2352.60 ------------------------------------------------------ [ 0, 1 ] 28 0.050% 0.050% ( 1, 2 ] 26426 47.637% 47.687% ########## ( 2, 3 ] 26545 47.851% 95.538% ########## ( 3, 4 ] 455 0.820% 96.359% ( 4, 6 ] 1206 2.174% 98.533% ( 6, 10 ] 410 0.739% 99.272% ( 10, 15 ] 200 0.361% 99.632% ( 15, 22 ] 41 0.074% 99.706% ( 22, 34 ] 9 0.016% 99.722% ( 34, 51 ] 2 0.004% 99.726% ( 51, 76 ] 72 0.130% 99.856% ( 76, 110 ] 39 0.070% 99.926% ( 110, 170 ] 7 0.013% 99.939% ( 170, 250 ] 12 0.022% 99.960% ( 250, 380 ] 9 0.016% 99.977% ( 380, 580 ] 3 0.005% 99.982% ( 580, 870 ] 2 0.004% 99.986% ( 870, 1300 ] 1 0.002% 99.987% ( 1300, 1900 ] 1 0.002% 99.989% ( 1900, 2900 ] 1 0.002% 99.991% ( 2900, 4400 ] 4 0.007% 99.998% ( 4400, 6600 ] 1 0.002% 100.000% ** Level 3 read latency histogram (micros): Count: 24072 Average: 15.2078 StdDev: 285.12 Min: 1 Median: 2.3062 Max: 11824 Percentiles: P50: 2.31 P75: 2.91 P99: 16.81 P99.9: 4384.57 P99.99: 11824.00 ------------------------------------------------------ [ 0, 1 ] 126 0.523% 0.523% ( 1, 2 ] 8834 36.698% 37.222% ####### ( 2, 3 ] 10049 41.746% 78.967% ######## ( 3, 4 ] 1628 6.763% 85.730% # ( 4, 6 ] 1947 8.088% 93.819% ## ( 6, 10 ] 952 3.955% 97.773% # ( 10, 15 ] 281 1.167% 98.941% ( 15, 22 ] 59 0.245% 99.186% ( 22, 34 ] 4 0.017% 99.202% ( 76, 110 ] 23 0.096% 99.298% ( 110, 170 ] 40 0.166% 99.464% ( 170, 250 ] 54 0.224% 99.688% ( 250, 380 ] 12 0.050% 99.738% ( 380, 580 ] 7 0.029% 99.767% ( 580, 870 ] 6 0.025% 99.792% ( 870, 1300 ] 4 0.017% 99.809% ( 1300, 1900 ] 8 0.033% 99.842% ( 1900, 2900 ] 8 0.033% 99.875% ( 2900, 4400 ] 7 0.029% 99.904% ( 4400, 6600 ] 8 0.033% 99.938% ( 6600, 9900 ] 7 0.029% 99.967% ( 9900, 14000 ] 9 0.037% 100.004% ** Level 4 read latency histogram (micros): Count: 5 Average: 4477.2000 StdDev: 3689.02 Min: 445 Median: 2650.0000 Max: 10805 Percentiles: P50: 2650.00 P75: 6050.00 P99: 10805.00 P99.9: 10805.00 P99.99: 10805.00 ------------------------------------------------------ ( 380, 580 ] 1 20.000% 20.000% #### ( 1900, 2900 ] 2 40.000% 60.000% ######## ( 4400, 6600 ] 1 20.000% 80.000% #### ( 9900, 14000 ] 1 20.000% 100.000% #### ** DB Stats ** Uptime(secs): 8.5 total, 8.3 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 116.41 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, 118.37 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: 3 num-running-flushes: 1 2024/07/24-22:55:29 ... thread 0: (1000000,2000000) ops and (119808.3,120080.1) ops/second in (8.346666,16.655550) 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/7 1.23 GB 43.9 0.7 0.0 0.7 2.6 1.8 0.0 1.4 49.8 174.0 15.17 14.14 33 0.460 766K 3547 0.0 0.0 L1 1/1 69.47 MB 0.0 0.7 0.6 0.1 0.7 0.5 0.1 1.2 160.4 159.5 4.40 4.28 3 1.467 717K 3862 0.0 0.0 L2 1/0 58.01 MB 0.6 0.4 0.2 0.2 0.4 0.2 0.3 1.9 158.2 157.8 2.91 2.77 3 0.971 467K 1240 0.0 0.0 L3 20/0 932.08 MB 0.9 1.3 0.3 1.0 1.3 0.3 0.2 3.8 184.4 183.6 7.44 6.89 3 2.480 1393K 5561 0.0 0.0 L4 142/0 9.57 GB 1.0 0.0 0.0 0.0 0.0 0.0 0.5 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L5 148/0 9.23 GB 0.1 0.0 0.0 0.0 0.0 0.0 0.5 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 323/8 21.06 GB 0.0 3.2 1.1 2.1 5.0 3.0 1.6 2.7 110.1 172.7 29.92 28.08 42 0.712 3344K 14K 0.0 0.0 Int 0/0 0.00 KB 0.0 3.2 1.1 2.1 5.0 3.0 1.6 2.7 110.1 172.7 29.92 28.08 42 0.712 3344K 14K 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.2 1.1 2.1 3.2 1.1 0.0 0.0 164.9 164.2 19.97 19.00 12 1.664 3344K 14K 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 189.7 9.95 9.08 30 0.332 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.8 total, 16.7 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: 5.05 GB write, 307.53 MB/s write, 3.22 GB read, 196.04 MB/s read, 29.9 seconds Interval compaction: 5.05 GB write, 310.13 MB/s write, 3.22 GB read, 197.69 MB/s read, 29.9 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: 525728 Average: 3.3413 StdDev: 13.78 Min: 1 Median: 2.3700 Max: 3996 Percentiles: P50: 2.37 P75: 2.94 P99: 9.38 P99.9: 19.95 P99.99: 155.89 ------------------------------------------------------ [ 0, 1 ] 430 0.082% 0.082% ( 1, 2 ] 177347 33.734% 33.815% ####### ( 2, 3 ] 229954 43.740% 77.556% ######### ( 3, 4 ] 46741 8.891% 86.446% ## ( 4, 6 ] 53977 10.267% 96.713% ## ( 6, 10 ] 14206 2.702% 99.415% # ( 10, 15 ] 2111 0.402% 99.817% ( 15, 22 ] 617 0.117% 99.934% ( 22, 34 ] 178 0.034% 99.968% ( 34, 51 ] 11 0.002% 99.970% ( 51, 76 ] 8 0.002% 99.972% ( 76, 110 ] 22 0.004% 99.976% ( 110, 170 ] 96 0.018% 99.994% ( 170, 250 ] 22 0.004% 99.998% ( 250, 380 ] 11 0.002% 100.001% ( 380, 580 ] 38 0.007% 100.008% ( 580, 870 ] 11 0.002% 100.010% ( 870, 1300 ] 5 0.001% 100.011% ( 1300, 1900 ] 8 0.002% 100.012% ( 1900, 2900 ] 3 0.001% 100.013% ( 2900, 4400 ] 3 0.001% 100.014% ** Level 1 read latency histogram (micros): Count: 145984 Average: 3.2801 StdDev: 10.36 Min: 1 Median: 2.3575 Max: 2214 Percentiles: P50: 2.36 P75: 2.81 P99: 9.17 P99.9: 21.94 P99.99: 352.48 ------------------------------------------------------ [ 0, 1 ] 23 0.016% 0.016% ( 1, 2 ] 44156 30.247% 30.263% ###### ( 2, 3 ] 80598 55.210% 85.473% ########### ( 3, 4 ] 7839 5.370% 90.843% # ( 4, 6 ] 9340 6.398% 97.241% # ( 6, 10 ] 3238 2.218% 99.459% ( 10, 15 ] 529 0.362% 99.821% ( 15, 22 ] 116 0.079% 99.901% ( 22, 34 ] 12 0.008% 99.909% ( 34, 51 ] 4 0.003% 99.912% ( 51, 76 ] 2 0.001% 99.913% ( 76, 110 ] 16 0.011% 99.924% ( 110, 170 ] 61 0.042% 99.966% ( 170, 250 ] 22 0.015% 99.981% ( 250, 380 ] 17 0.012% 99.992% ( 380, 580 ] 12 0.008% 100.001% ( 580, 870 ] 5 0.003% 100.004% ( 1300, 1900 ] 1 0.001% 100.005% ( 1900, 2900 ] 1 0.001% 100.005% ** Level 2 read latency histogram (micros): Count: 115002 Average: 3.4715 StdDev: 29.55 Min: 1 Median: 2.0491 Max: 4867 Percentiles: P50: 2.05 P75: 2.65 P99: 9.56 P99.9: 160.83 P99.99: 536.25 ------------------------------------------------------ [ 0, 1 ] 630 0.548% 0.548% ( 1, 2 ] 54513 47.402% 47.950% ######### ( 2, 3 ] 48022 41.758% 89.707% ######## ( 3, 4 ] 3711 3.227% 92.934% # ( 4, 6 ] 5056 4.396% 97.330% # ( 6, 10 ] 2159 1.877% 99.208% ( 10, 15 ] 480 0.417% 99.625% ( 15, 22 ] 113 0.098% 99.723% ( 22, 34 ] 20 0.017% 99.741% ( 34, 51 ] 3 0.003% 99.743% ( 51, 76 ] 73 0.063% 99.807% ( 76, 110 ] 46 0.040% 99.847% ( 110, 170 ] 72 0.063% 99.910% ( 170, 250 ] 44 0.038% 99.948% ( 250, 380 ] 36 0.031% 99.979% ( 380, 580 ] 16 0.014% 99.993% ( 580, 870 ] 6 0.005% 99.998% ( 870, 1300 ] 1 0.001% 99.999% ( 1300, 1900 ] 2 0.002% 100.001% ( 1900, 2900 ] 1 0.001% 100.002% ( 2900, 4400 ] 4 0.003% 100.005% ( 4400, 6600 ] 1 0.001% 100.006% ** Level 3 read latency histogram (micros): Count: 224154 Average: 4.9180 StdDev: 94.60 Min: 1 Median: 2.0844 Max: 11824 Percentiles: P50: 2.08 P75: 2.74 P99: 10.66 P99.9: 243.64 P99.99: 4835.76 ------------------------------------------------------ [ 0, 1 ] 1699 0.758% 0.758% ( 1, 2 ] 103126 46.007% 46.765% ######### ( 2, 3 ] 85914 38.328% 85.093% ######## ( 3, 4 ] 10712 4.779% 89.872% # ( 4, 6 ] 13733 6.127% 95.998% # ( 6, 10 ] 6564 2.928% 98.927% # ( 10, 15 ] 1240 0.553% 99.480% ( 15, 22 ] 158 0.070% 99.550% ( 22, 34 ] 17 0.008% 99.558% ( 51, 76 ] 3 0.001% 99.559% ( 76, 110 ] 171 0.076% 99.636% ( 110, 170 ] 429 0.191% 99.827% ( 170, 250 ] 178 0.079% 99.906% ( 250, 380 ] 73 0.033% 99.939% ( 380, 580 ] 52 0.023% 99.962% ( 580, 870 ] 29 0.013% 99.975% ( 870, 1300 ] 9 0.004% 99.979% ( 1300, 1900 ] 8 0.004% 99.983% ( 1900, 2900 ] 8 0.004% 99.986% ( 2900, 4400 ] 7 0.003% 99.989% ( 4400, 6600 ] 8 0.004% 99.993% ( 6600, 9900 ] 7 0.003% 99.996% ( 9900, 14000 ] 9 0.004% 100.000% ** Level 4 read latency histogram (micros): Count: 5 Average: 4477.2000 StdDev: 3689.02 Min: 445 Median: 2650.0000 Max: 10805 Percentiles: P50: 2650.00 P75: 6050.00 P99: 10805.00 P99.9: 10805.00 P99.99: 10805.00 ------------------------------------------------------ ( 380, 580 ] 1 20.000% 20.000% #### ( 1900, 2900 ] 2 40.000% 60.000% ######## ( 4400, 6600 ] 1 20.000% 80.000% #### ( 9900, 14000 ] 1 20.000% 100.000% #### ** Level 5 read latency histogram (micros): Count: 40 Average: 833.4500 StdDev: 1113.49 Min: 100 Median: 250.0000 Max: 5354 Percentiles: P50: 250.00 P75: 1013.33 P99: 5354.00 P99.9: 5354.00 P99.99: 5354.00 ------------------------------------------------------ ( 76, 110 ] 2 5.000% 5.000% # ( 110, 170 ] 12 30.000% 35.000% ###### ( 170, 250 ] 6 15.000% 50.000% ### ( 250, 380 ] 1 2.500% 52.500% # ( 380, 580 ] 4 10.000% 62.500% ## ( 580, 870 ] 4 10.000% 72.500% ## ( 870, 1300 ] 3 7.500% 80.000% ## ( 1300, 1900 ] 3 7.500% 87.500% ## ( 1900, 2900 ] 1 2.500% 90.000% # ( 2900, 4400 ] 3 7.500% 97.500% ## ( 4400, 6600 ] 1 2.500% 100.000% # ** DB Stats ** Uptime(secs): 16.8 total, 8.3 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 117.16 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, 117.92 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: 1 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 : 8.323 micros/op 120154 ops/sec 20.008 seconds 2403999 operations; 116.4 MB/s Microseconds per write: Count: 2403999 Average: 8.3225 StdDev: 25.74 Min: 3 Median: 5.8445 Max: 35499 Percentiles: P50: 5.84 P75: 10.17 P99: 21.36 P99.9: 252.40 P99.99: 379.10 ------------------------------------------------------ ( 2, 3 ] 210 0.009% 0.009% ( 3, 4 ] 49546 2.061% 2.070% ( 4, 6 ] 1249415 51.972% 54.042% ########## ( 6, 10 ] 486213 20.225% 74.267% #### ( 10, 15 ] 513961 21.379% 95.647% #### ( 15, 22 ] 88722 3.691% 99.337% # ( 22, 34 ] 11650 0.485% 99.822% ( 34, 51 ] 1603 0.067% 99.889% ( 51, 76 ] 195 0.008% 99.897% ( 76, 110 ] 38 0.002% 99.898% ( 110, 170 ] 1 0.000% 99.898% ( 250, 380 ] 2220 0.092% 99.991% ( 380, 580 ] 192 0.008% 99.999% ( 580, 870 ] 30 0.001% 100.000% ( 1300, 1900 ] 1 0.000% 100.000% ( 1900, 2900 ] 1 0.000% 100.000% ( 33000, 50000 ] 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 : 45149 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 : 2403999 rocksdb.number.keys.read COUNT : 0 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 2480926968 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 : 129 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 : 5374813074 rocksdb.compact.write.bytes COUNT : 5326088305 rocksdb.flush.write.bytes COUNT : 2440844142 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 : 13 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 : 63 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 : 2424420352 rocksdb.memtable.garbage.bytes.at.flush COUNT : 3918848 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 : 5400720742 rocksdb.non.last.level.read.count COUNT : 1303144 rocksdb.block.checksum.compute.count COUNT : 1302899 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 : 4.758195 P95 : 13.741419 P99 : 19.425999 P100 : 854.000000 COUNT : 2403999 SUM : 16378474 rocksdb.compaction.times.micros P50 : 1200000.000000 P95 : 5083797.000000 P99 : 5083797.000000 P100 : 5083797.000000 COUNT : 16 SUM : 29012799 rocksdb.compaction.times.cpu_micros P50 : 1200000.000000 P95 : 4713893.000000 P99 : 4713893.000000 P100 : 4713893.000000 COUNT : 16 SUM : 27699632 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 : 779.375000 P95 : 1761.250000 P99 : 1845.000000 P100 : 1845.000000 COUNT : 37 SUM : 33094 rocksdb.compaction.outfile.sync.micros P50 : 824.428571 P95 : 1276.907407 P99 : 1693.000000 P100 : 1735.000000 COUNT : 69 SUM : 57488 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 : 161.818182 P95 : 652.500000 P99 : 1955.000000 P100 : 1955.000000 COUNT : 65 SUM : 15477 rocksdb.table.open.io.micros P50 : 1628.571429 P95 : 24131.250000 P99 : 24224.000000 P100 : 24224.000000 COUNT : 129 SUM : 536154 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 : 5.261795 P95 : 9.918754 P99 : 16.374066 P100 : 12705.000000 COUNT : 1302939 SUM : 8620996 rocksdb.read.block.get.micros P50 : 658.644068 P95 : 8855.000000 P99 : 12080.000000 P100 : 12080.000000 COUNT : 258 SUM : 413114 rocksdb.write.raw.block.micros P50 : 0.718670 P95 : 1.996772 P99 : 7.779595 P100 : 5407.000000 COUNT : 1883073 SUM : 5402117 rocksdb.numfiles.in.singlecompaction P50 : 3.375000 P95 : 11.000000 P99 : 14.000000 P100 : 14.000000 COUNT : 32 SUM : 138 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 : 2.410995 P95 : 5.972326 P99 : 10.549942 P100 : 11824.000000 COUNT : 1303758 SUM : 5203524 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 : 2403999 SUM : 2480926968 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 : 292391.304348 P95 : 452833.333333 P99 : 484246.000000 P100 : 484246.000000 COUNT : 37 SUM : 11711958 rocksdb.sst.batch.size P50 : 0.000000 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 : 77 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