[2024-07-12 10:55:18.990007] Starting SPDK v24.09-pre git sha1 719d03c6a / DPDK 24.03.0 initialization... [2024-07-12 10:55:18.990210] [ 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_pid2142104 ] Set seed to 1720774518985529 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-07-12 10:55:19.198545] app.c: 908:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-07-12 10:55:19.513792] app.c: 603:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-07-12 10:55:19.513851] app.c: 604:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 2142104' to capture a snapshot of events at runtime. [2024-07-12 10:55:19.513871] app.c: 609:app_setup_trace: *NOTICE*: 'spdk_trace' without parameters will also work if this is the only [2024-07-12 10:55:19.513891] app.c: 610:app_setup_trace: *NOTICE*: SPDK application currently running. [2024-07-12 10:55:19.513914] app.c: 611:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid2142104 for offline analysis/debug. [2024-07-12 10:55:19.514079] reactor.c: 941:reactor_run: *NOTICE*: Reactor started on core 0 RocksDB: version 8.1.1 Date: Fri Jul 12 10:55:27 2024 CPU: 72 * Intel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz CPUCache: 25344 KB 2024/07/12-10:55:35 ... thread 0: (1000000,1000000) ops and (121305.5,121305.5) ops/second in (8.243652,8.243652) 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/7 503.25 MB 6.3 0.0 0.0 0.0 0.9 0.9 0.0 1.0 0.0 159.6 5.52 5.16 14 0.394 0 0 0.0 0.0 L1 1/1 10.04 MB 0.0 0.4 0.2 0.1 0.4 0.2 0.1 1.5 160.4 159.8 2.35 2.29 2 1.176 383K 1207 0.0 0.0 L2 2/0 55.36 MB 0.6 0.6 0.4 0.2 0.6 0.4 0.0 1.7 158.0 157.5 3.92 3.73 3 1.306 628K 1958 0.0 0.0 L3 19/2 1.07 GB 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 136/0 9.66 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 108/0 8.80 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 274/10 20.08 GB 0.0 1.0 0.6 0.4 1.8 1.5 0.5 2.1 84.5 159.0 11.79 11.17 19 0.620 1012K 3165 0.0 0.0 Int 0/0 0.00 KB 0.0 1.0 0.6 0.4 1.8 1.5 0.5 2.1 84.5 159.0 11.79 11.17 19 0.620 1012K 3165 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.0 0.6 0.4 1.0 0.6 0.0 0.0 158.9 158.4 6.27 6.02 5 1.254 1012K 3165 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 159.6 5.52 5.16 14 0.394 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.4 total, 8.2 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.83 GB write, 223.66 MB/s write, 0.97 GB read, 118.93 MB/s read, 11.8 seconds Interval compaction: 1.83 GB write, 227.23 MB/s write, 0.97 GB read, 120.83 MB/s read, 11.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: 116307 Average: 3.0437 StdDev: 19.23 Min: 1 Median: 2.2653 Max: 3594 Percentiles: P50: 2.27 P75: 2.70 P99: 5.97 P99.9: 14.39 P99.99: 552.31 ------------------------------------------------------ [ 0, 1 ] 12 0.010% 0.010% ( 1, 2 ] 40309 34.657% 34.668% ####### ( 2, 3 ] 67231 57.805% 92.473% ############ ( 3, 4 ] 3975 3.418% 95.890% # ( 4, 6 ] 3678 3.162% 99.053% # ( 6, 10 ] 733 0.630% 99.683% ( 10, 15 ] 291 0.250% 99.933% ( 15, 22 ] 45 0.039% 99.972% ( 22, 34 ] 4 0.003% 99.975% ( 34, 51 ] 3 0.003% 99.978% ( 51, 76 ] 1 0.001% 99.979% ( 380, 580 ] 19 0.016% 99.995% ( 580, 870 ] 2 0.002% 99.997% ( 870, 1300 ] 3 0.003% 99.999% ( 1900, 2900 ] 2 0.002% 100.001% ( 2900, 4400 ] 2 0.002% 100.003% ** Level 1 read latency histogram (micros): Count: 101796 Average: 3.0054 StdDev: 28.71 Min: 1 Median: 2.1975 Max: 6439 Percentiles: P50: 2.20 P75: 2.63 P99: 5.74 P99.9: 18.36 P99.99: 667.99 ------------------------------------------------------ [ 0, 1 ] 6 0.006% 0.006% ( 1, 2 ] 39401 38.706% 38.712% ######## ( 2, 3 ] 58196 57.169% 95.881% ########### ( 3, 4 ] 937 0.920% 96.801% ( 4, 6 ] 2573 2.528% 99.329% # ( 6, 10 ] 380 0.373% 99.702% ( 10, 15 ] 182 0.179% 99.881% ( 15, 22 ] 40 0.039% 99.920% ( 22, 34 ] 1 0.001% 99.921% ( 34, 51 ] 1 0.001% 99.922% ( 51, 76 ] 7 0.007% 99.929% ( 76, 110 ] 51 0.050% 99.979% ( 110, 170 ] 1 0.001% 99.980% ( 170, 250 ] 8 0.008% 99.988% ( 580, 870 ] 6 0.006% 99.994% ( 870, 1300 ] 2 0.002% 99.996% ( 1300, 1900 ] 2 0.002% 99.998% ( 4400, 6600 ] 2 0.002% 100.000% ** Level 2 read latency histogram (micros): Count: 77140 Average: 2.8679 StdDev: 10.86 Min: 1 Median: 2.1471 Max: 1690 Percentiles: P50: 2.15 P75: 2.63 P99: 6.28 P99.9: 14.45 P99.99: 444.30 ------------------------------------------------------ [ 0, 1 ] 101 0.131% 0.131% ( 1, 2 ] 32542 42.186% 42.317% ######## ( 2, 3 ] 40299 52.241% 94.558% ########## ( 3, 4 ] 1249 1.619% 96.177% ( 4, 6 ] 2138 2.772% 98.949% # ( 6, 10 ] 581 0.753% 99.702% ( 10, 15 ] 173 0.224% 99.926% ( 15, 22 ] 27 0.035% 99.961% ( 22, 34 ] 3 0.004% 99.965% ( 34, 51 ] 3 0.004% 99.969% ( 51, 76 ] 1 0.001% 99.970% ( 76, 110 ] 1 0.001% 99.971% ( 110, 170 ] 6 0.008% 99.979% ( 170, 250 ] 4 0.005% 99.984% ( 250, 380 ] 4 0.005% 99.990% ( 380, 580 ] 4 0.005% 99.995% ( 580, 870 ] 2 0.003% 99.997% ( 1300, 1900 ] 3 0.004% 100.001% ** Level 3 read latency histogram (micros): Count: 55 Average: 3542.2727 StdDev: 3374.94 Min: 137 Median: 1962.5000 Max: 11147 Percentiles: P50: 1962.50 P75: 6187.50 P99: 11147.00 P99.9: 11147.00 P99.99: 11147.00 ------------------------------------------------------ ( 110, 170 ] 4 7.273% 7.273% # ( 170, 250 ] 4 7.273% 14.545% # ( 250, 380 ] 1 1.818% 16.364% ( 380, 580 ] 2 3.636% 20.000% # ( 580, 870 ] 2 3.636% 23.636% # ( 870, 1300 ] 2 3.636% 27.273% # ( 1300, 1900 ] 12 21.818% 49.091% #### ( 1900, 2900 ] 8 14.545% 63.636% ### ( 2900, 4400 ] 3 5.455% 69.091% # ( 4400, 6600 ] 4 7.273% 76.364% # ( 6600, 9900 ] 11 20.000% 96.364% #### ( 9900, 14000 ] 2 3.636% 100.000% # ** Level 4 read latency histogram (micros): Count: 20 Average: 3399.7000 StdDev: 3103.96 Min: 69 Median: 2233.3333 Max: 10263 Percentiles: P50: 2233.33 P75: 5866.67 P99: 10263.00 P99.9: 10263.00 P99.99: 10263.00 ------------------------------------------------------ ( 51, 76 ] 1 5.000% 5.000% # ( 170, 250 ] 1 5.000% 10.000% # ( 580, 870 ] 3 15.000% 25.000% ### ( 870, 1300 ] 2 10.000% 35.000% ## ( 1300, 1900 ] 2 10.000% 45.000% ## ( 1900, 2900 ] 3 15.000% 60.000% ### ( 2900, 4400 ] 1 5.000% 65.000% # ( 4400, 6600 ] 3 15.000% 80.000% ### ( 6600, 9900 ] 3 15.000% 95.000% ### ( 9900, 14000 ] 1 5.000% 100.000% # ** DB Stats ** Uptime(secs): 8.4 total, 8.2 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 117.45 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, 119.31 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/07/12-10:55:43 ... thread 0: (1000000,2000000) ops and (120699.8,121001.9) ops/second in (8.285019,16.528671) 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/4 1.04 GB 43.9 0.7 0.0 0.7 2.6 1.8 0.0 1.4 46.7 163.3 16.16 15.17 33 0.490 766K 3615 0.0 0.0 L1 0/0 0.00 KB 0.0 0.8 0.7 0.1 0.8 0.7 0.1 1.2 157.7 156.6 5.25 5.10 3 1.750 840K 5590 0.0 0.0 L2 2/0 99.36 MB 1.0 0.7 0.4 0.3 0.7 0.4 0.4 1.7 157.9 157.1 4.56 4.35 4 1.141 731K 3716 0.0 0.0 L3 14/0 820.81 MB 0.8 0.4 0.2 0.2 0.4 0.2 0.5 1.8 161.6 159.9 2.31 2.11 3 0.770 379K 3817 0.0 0.0 L4 142/0 9.64 GB 1.0 0.2 0.2 0.0 0.2 0.2 0.5 1.0 182.7 182.7 0.94 0.87 1 0.938 173K 0 0.0 0.0 L5 116/0 9.47 GB 0.1 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 Sum 282/4 21.05 GB 0.0 2.8 1.4 1.3 4.6 3.3 2.2 2.5 97.5 161.5 29.22 27.60 44 0.664 2891K 16K 0.0 0.0 Int 0/0 0.00 KB 0.0 2.8 1.4 1.3 4.6 3.3 2.2 2.5 97.5 161.5 29.22 27.60 44 0.664 2891K 16K 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 2.8 1.4 1.3 2.8 1.4 0.0 0.0 158.4 157.4 17.98 17.15 14 1.284 2891K 16K 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 167.9 11.24 10.45 30 0.375 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.7 total, 16.5 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: 4.61 GB write, 283.12 MB/s write, 2.78 GB read, 170.87 MB/s read, 29.2 seconds Interval compaction: 4.61 GB write, 285.38 MB/s write, 2.78 GB read, 172.23 MB/s read, 29.2 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: 545265 Average: 3.3493 StdDev: 13.53 Min: 1 Median: 2.4935 Max: 3594 Percentiles: P50: 2.49 P75: 2.97 P99: 9.00 P99.9: 16.86 P99.99: 26.15 ------------------------------------------------------ [ 0, 1 ] 114 0.021% 0.021% ( 1, 2 ] 132266 24.257% 24.278% ##### ( 2, 3 ] 284178 52.117% 76.396% ########## ( 3, 4 ] 67043 12.295% 88.691% ## ( 4, 6 ] 47896 8.784% 97.475% ## ( 6, 10 ] 11075 2.031% 99.506% ( 10, 15 ] 1989 0.365% 99.871% ( 15, 22 ] 602 0.110% 99.981% ( 22, 34 ] 140 0.026% 100.007% ( 34, 51 ] 16 0.003% 100.010% ( 51, 76 ] 5 0.001% 100.011% ( 76, 110 ] 1 0.000% 100.011% ( 380, 580 ] 41 0.008% 100.019% ( 580, 870 ] 6 0.001% 100.020% ( 870, 1300 ] 8 0.001% 100.021% ( 1300, 1900 ] 2 0.000% 100.021% ( 1900, 2900 ] 5 0.001% 100.022% ( 2900, 4400 ] 4 0.001% 100.023% ** Level 1 read latency histogram (micros): Count: 166913 Average: 3.1626 StdDev: 22.86 Min: 1 Median: 2.3106 Max: 6439 Percentiles: P50: 2.31 P75: 2.76 P99: 8.37 P99.9: 14.83 P99.99: 102.87 ------------------------------------------------------ [ 0, 1 ] 31 0.019% 0.019% ( 1, 2 ] 54452 32.623% 32.642% ####### ( 2, 3 ] 93277 55.884% 88.525% ########### ( 3, 4 ] 6462 3.871% 92.397% # ( 4, 6 ] 9510 5.698% 98.094% # ( 6, 10 ] 2548 1.527% 99.621% ( 10, 15 ] 482 0.289% 99.910% ( 15, 22 ] 74 0.044% 99.954% ( 22, 34 ] 10 0.006% 99.960% ( 34, 51 ] 3 0.002% 99.962% ( 51, 76 ] 7 0.004% 99.966% ( 76, 110 ] 51 0.031% 99.996% ( 110, 170 ] 1 0.001% 99.997% ( 170, 250 ] 9 0.005% 100.002% ( 250, 380 ] 3 0.002% 100.004% ( 380, 580 ] 4 0.002% 100.007% ( 580, 870 ] 8 0.005% 100.011% ( 870, 1300 ] 3 0.002% 100.013% ( 1300, 1900 ] 2 0.001% 100.014% ( 4400, 6600 ] 2 0.001% 100.016% ** Level 2 read latency histogram (micros): Count: 156775 Average: 3.1914 StdDev: 10.22 Min: 1 Median: 2.2699 Max: 1690 Percentiles: P50: 2.27 P75: 2.76 P99: 8.93 P99.9: 23.84 P99.99: 273.22 ------------------------------------------------------ [ 0, 1 ] 203 0.129% 0.129% ( 1, 2 ] 56519 36.051% 36.181% ####### ( 2, 3 ] 80264 51.197% 87.377% ########## ( 3, 4 ] 6977 4.450% 91.828% # ( 4, 6 ] 9278 5.918% 97.746% # ( 6, 10 ] 2685 1.713% 99.458% ( 10, 15 ] 574 0.366% 99.825% ( 15, 22 ] 117 0.075% 99.899% ( 22, 34 ] 8 0.005% 99.904% ( 34, 51 ] 7 0.004% 99.909% ( 51, 76 ] 2 0.001% 99.910% ( 76, 110 ] 10 0.006% 99.916% ( 110, 170 ] 66 0.042% 99.959% ( 170, 250 ] 47 0.030% 99.989% ( 250, 380 ] 13 0.008% 99.997% ( 380, 580 ] 12 0.008% 100.004% ( 580, 870 ] 4 0.003% 100.007% ( 870, 1300 ] 1 0.001% 100.008% ( 1300, 1900 ] 3 0.002% 100.010% ** Level 3 read latency histogram (micros): Count: 100 Average: 1999.6200 StdDev: 3031.97 Min: 1 Median: 420.0000 Max: 11147 Percentiles: P50: 420.00 P75: 2275.00 P99: 11147.00 P99.9: 11147.00 P99.99: 11147.00 ------------------------------------------------------ [ 0, 1 ] 9 9.000% 9.000% ## ( 1, 2 ] 16 16.000% 25.000% ### ( 2, 3 ] 3 3.000% 28.000% # ( 3, 4 ] 1 1.000% 29.000% ( 4, 6 ] 2 2.000% 31.000% ( 6, 10 ] 2 2.000% 33.000% ( 110, 170 ] 4 4.000% 37.000% # ( 170, 250 ] 4 4.000% 41.000% # ( 250, 380 ] 8 8.000% 49.000% ## ( 380, 580 ] 5 5.000% 54.000% # ( 580, 870 ] 3 3.000% 57.000% # ( 870, 1300 ] 3 3.000% 60.000% # ( 1300, 1900 ] 12 12.000% 72.000% ## ( 1900, 2900 ] 8 8.000% 80.000% ## ( 2900, 4400 ] 3 3.000% 83.000% # ( 4400, 6600 ] 4 4.000% 87.000% # ( 6600, 9900 ] 11 11.000% 98.000% ## ( 9900, 14000 ] 2 2.000% 100.000% ** Level 4 read latency histogram (micros): Count: 50 Average: 1401.3400 StdDev: 2554.27 Min: 1 Median: 140.0000 Max: 10263 Percentiles: P50: 140.00 P75: 1450.00 P99: 10263.00 P99.9: 10263.00 P99.99: 10263.00 ------------------------------------------------------ [ 0, 1 ] 4 8.000% 8.000% ## ( 1, 2 ] 12 24.000% 32.000% ##### ( 2, 3 ] 2 4.000% 36.000% # ( 6, 10 ] 1 2.000% 38.000% ( 22, 34 ] 1 2.000% 40.000% ( 34, 51 ] 1 2.000% 42.000% ( 51, 76 ] 1 2.000% 44.000% ( 110, 170 ] 6 12.000% 56.000% ## ( 170, 250 ] 1 2.000% 58.000% ( 250, 380 ] 1 2.000% 60.000% ( 380, 580 ] 2 4.000% 64.000% # ( 580, 870 ] 3 6.000% 70.000% # ( 870, 1300 ] 2 4.000% 74.000% # ( 1300, 1900 ] 2 4.000% 78.000% # ( 1900, 2900 ] 3 6.000% 84.000% # ( 2900, 4400 ] 1 2.000% 86.000% ( 4400, 6600 ] 3 6.000% 92.000% # ( 6600, 9900 ] 3 6.000% 98.000% # ( 9900, 14000 ] 1 2.000% 100.000% ** Level 5 read latency histogram (micros): Count: 40 Average: 1019.2250 StdDev: 1334.70 Min: 89 Median: 223.3333 Max: 4503 Percentiles: P50: 223.33 P75: 1300.00 P99: 4503.00 P99.9: 4503.00 P99.99: 4503.00 ------------------------------------------------------ ( 76, 110 ] 3 7.500% 7.500% ## ( 110, 170 ] 15 37.500% 45.000% ######## ( 170, 250 ] 3 7.500% 52.500% ## ( 250, 380 ] 2 5.000% 57.500% # ( 380, 580 ] 1 2.500% 60.000% # ( 580, 870 ] 3 7.500% 67.500% ## ( 870, 1300 ] 3 7.500% 75.000% ## ( 1300, 1900 ] 2 5.000% 80.000% # ( 1900, 2900 ] 2 5.000% 85.000% # ( 2900, 4400 ] 5 12.500% 97.500% ### ( 4400, 6600 ] 1 2.500% 100.000% # ** DB Stats ** Uptime(secs): 16.7 total, 8.3 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 118.12 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.79 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.260 micros/op 121069 ops/sec 20.005 seconds 2421999 operations; 117.3 MB/s Microseconds per write: Count: 2421999 Average: 8.2597 StdDev: 25.65 Min: 3 Median: 5.8134 Max: 35394 Percentiles: P50: 5.81 P75: 9.96 P99: 21.30 P99.9: 252.39 P99.99: 379.23 ------------------------------------------------------ ( 2, 3 ] 297 0.012% 0.012% ( 3, 4 ] 54935 2.268% 2.280% ( 4, 6 ] 1274714 52.631% 54.911% ########### ( 6, 10 ] 491649 20.299% 75.210% #### ( 10, 15 ] 500955 20.684% 95.894% #### ( 15, 22 ] 83584 3.451% 99.345% # ( 22, 34 ] 11369 0.469% 99.814% ( 34, 51 ] 1770 0.073% 99.887% ( 51, 76 ] 203 0.008% 99.896% ( 76, 110 ] 57 0.002% 99.898% ( 110, 170 ] 2 0.000% 99.898% ( 170, 250 ] 1 0.000% 99.898% ( 250, 380 ] 2234 0.092% 99.991% ( 380, 580 ] 188 0.008% 99.998% ( 580, 870 ] 37 0.002% 100.000% ( 870, 1300 ] 1 0.000% 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 : 32764 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 : 2421999 rocksdb.number.keys.read COUNT : 0 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 2499502968 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 : 113 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 : 4321446085 rocksdb.compact.write.bytes COUNT : 4287045270 rocksdb.flush.write.bytes COUNT : 2440841914 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 : 56 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 : 2424433664 rocksdb.memtable.garbage.bytes.at.flush COUNT : 3936256 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 : 4348102003 rocksdb.non.last.level.read.count COUNT : 1047830 rocksdb.block.checksum.compute.count COUNT : 1047620 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.743902 P95 : 13.571182 P99 : 19.386069 P100 : 920.000000 COUNT : 2421999 SUM : 16410562 rocksdb.compaction.times.micros P50 : 1086666.666667 P95 : 3180000.000000 P99 : 3991282.000000 P100 : 3991282.000000 COUNT : 16 SUM : 23114787 rocksdb.compaction.times.cpu_micros P50 : 1030000.000000 P95 : 3180000.000000 P99 : 3895899.000000 P100 : 3895899.000000 COUNT : 16 SUM : 22171337 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 : 556.190476 P95 : 1741.428571 P99 : 1746.000000 P100 : 1746.000000 COUNT : 37 SUM : 29810 rocksdb.compaction.outfile.sync.micros P50 : 752.187500 P95 : 1129.000000 P99 : 1129.000000 P100 : 1129.000000 COUNT : 54 SUM : 41831 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 : 154.000000 P95 : 568.000000 P99 : 1504.000000 P100 : 1794.000000 COUNT : 66 SUM : 15461 rocksdb.table.open.io.micros P50 : 1840.000000 P95 : 25231.250000 P99 : 27097.000000 P100 : 27097.000000 COUNT : 113 SUM : 501894 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.130905 P95 : 9.294225 P99 : 14.140946 P100 : 21349.000000 COUNT : 1047466 SUM : 6279691 rocksdb.read.block.get.micros P50 : 739.032258 P95 : 7410.000000 P99 : 10911.333333 P100 : 11255.000000 COUNT : 226 SUM : 364091 rocksdb.write.raw.block.micros P50 : 0.776312 P95 : 1.996395 P99 : 8.137510 P100 : 46621.000000 COUNT : 1630622 SUM : 4919395 rocksdb.numfiles.in.singlecompaction P50 : 3.071429 P95 : 8.000000 P99 : 11.000000 P100 : 11.000000 COUNT : 30 SUM : 105 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.313744 P95 : 5.129815 P99 : 8.646942 P100 : 11147.000000 COUNT : 1048153 SUM : 3625506 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 : 2421999 SUM : 2499502968 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 : 327580.645161 P95 : 537700.000000 P99 : 882920.000000 P100 : 882920.000000 COUNT : 37 SUM : 13864662 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 : 57 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