[2024-12-09 23:56:53.150665] Starting SPDK v25.01-pre git sha1 c12cb8fe3 / DPDK 24.03.0 initialization... [2024-12-09 23:56:53.150820] [ 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_pid2828293 ] Set seed to 1733785013147134 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-12-09 23:56:53.299843] app.c: 919:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-12-09 23:56:53.408647] app.c: 612:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-12-09 23:56:53.408702] app.c: 613:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 2828293' to capture a snapshot of events at runtime. [2024-12-09 23:56:53.408715] app.c: 618:app_setup_trace: *NOTICE*: 'spdk_trace' without parameters will also work if this is the only [2024-12-09 23:56:53.408730] app.c: 619:app_setup_trace: *NOTICE*: SPDK application currently running. [2024-12-09 23:56:53.408741] app.c: 620:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid2828293 for offline analysis/debug. [2024-12-09 23:56:53.410303] reactor.c:1005:reactor_run: *NOTICE*: Reactor started on core 0 RocksDB: version 8.1.1 Date: Mon Dec 9 23:56:59 2024 CPU: 72 * Intel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz CPUCache: 25344 KB 2024/12/09-23:57:02 ... thread 0: (1000000,1000000) ops and (328860.2,328860.2) ops/second in (3.040806,3.040806) 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 10/8 629.11 MB 12.6 0.0 0.0 0.0 0.9 0.9 0.0 1.0 0.0 342.7 2.57 2.29 13 0.198 0 0 0.0 0.0 L1 3/3 188.04 MB 0.0 0.2 0.2 0.0 0.2 0.2 0.1 1.0 252.2 251.6 0.75 0.72 1 0.747 191K 423 0.0 0.0 L2 1/1 100.74 MB 0.0 0.2 0.1 0.1 0.2 0.1 0.0 2.6 240.9 240.4 0.67 0.63 1 0.667 163K 325 0.0 0.0 L3 18/11 1004.66 MB 0.1 0.1 0.1 0.0 0.1 0.1 0.0 1.0 174.5 174.5 0.34 0.29 1 0.342 60K 0 0.0 0.0 L4 116/0 9.47 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.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 256/23 20.09 GB 0.0 0.4 0.3 0.1 1.3 1.2 0.1 1.5 94.5 297.9 4.33 3.93 16 0.270 415K 748 0.0 0.0 Int 0/0 0.00 KB 0.0 0.4 0.3 0.1 1.3 1.2 0.1 1.5 94.5 297.9 4.33 3.93 16 0.270 415K 748 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.4 0.3 0.1 0.4 0.3 0.0 0.0 232.8 232.4 1.76 1.64 3 0.586 415K 748 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 342.7 2.57 2.29 13 0.198 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): 3.2 total, 3.0 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.26 GB write, 408.71 MB/s write, 0.40 GB read, 129.70 MB/s read, 4.3 seconds Interval compaction: 1.26 GB write, 423.60 MB/s write, 0.40 GB read, 134.42 MB/s read, 4.3 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: 1, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 1, interval: 1 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 132847 Average: 2.2052 StdDev: 18.13 Min: 1 Median: 1.4111 Max: 3406 Percentiles: P50: 1.41 P75: 1.83 P99: 5.91 P99.9: 12.97 P99.99: 73.63 ------------------------------------------------------ [ 0, 1 ] 33453 25.182% 25.182% ##### ( 1, 2 ] 80199 60.369% 85.551% ############ ( 2, 3 ] 10477 7.887% 93.438% ## ( 3, 4 ] 4606 3.467% 96.905% # ( 4, 6 ] 2918 2.197% 99.101% ( 6, 10 ] 942 0.709% 99.810% ( 10, 15 ] 207 0.156% 99.966% ( 15, 22 ] 26 0.020% 99.986% ( 22, 34 ] 4 0.003% 99.989% ( 34, 51 ] 3 0.002% 99.991% ( 51, 76 ] 3 0.002% 99.993% ( 76, 110 ] 1 0.001% 99.994% ( 170, 250 ] 12 0.009% 100.003% ( 250, 380 ] 2 0.002% 100.005% ( 380, 580 ] 3 0.002% 100.007% ( 580, 870 ] 3 0.002% 100.009% ( 870, 1300 ] 1 0.001% 100.010% ( 1300, 1900 ] 2 0.002% 100.011% ( 1900, 2900 ] 2 0.002% 100.013% ( 2900, 4400 ] 2 0.002% 100.014% ** Level 1 read latency histogram (micros): Count: 28150 Average: 2.1757 StdDev: 8.04 Min: 1 Median: 1.4695 Max: 1187 Percentiles: P50: 1.47 P75: 1.87 P99: 5.75 P99.9: 10.57 P99.99: 274.05 ------------------------------------------------------ [ 0, 1 ] 5893 20.934% 20.934% #### ( 1, 2 ] 17428 61.911% 82.845% ############ ( 2, 3 ] 2787 9.901% 92.746% ## ( 3, 4 ] 1118 3.972% 96.718% # ( 4, 6 ] 733 2.604% 99.321% # ( 6, 10 ] 160 0.568% 99.890% ( 10, 15 ] 25 0.089% 99.979% ( 15, 22 ] 2 0.007% 99.986% ( 170, 250 ] 1 0.004% 99.989% ( 250, 380 ] 1 0.004% 99.993% ( 380, 580 ] 1 0.004% 99.996% ( 870, 1300 ] 1 0.004% 100.000% ** Level 2 read latency histogram (micros): Count: 40119 Average: 3.2392 StdDev: 53.32 Min: 1 Median: 1.4506 Max: 6116 Percentiles: P50: 1.45 P75: 1.90 P99: 10.00 P99.9: 119.41 P99.99: 2894.05 ------------------------------------------------------ [ 0, 1 ] 10047 25.043% 25.043% ##### ( 1, 2 ] 22222 55.390% 80.433% ########### ( 2, 3 ] 3743 9.330% 89.763% ## ( 3, 4 ] 1597 3.981% 93.744% # ( 4, 6 ] 1479 3.687% 97.430% # ( 6, 10 ] 630 1.570% 99.000% ( 10, 15 ] 197 0.491% 99.492% ( 15, 22 ] 34 0.085% 99.576% ( 22, 34 ] 10 0.025% 99.601% ( 34, 51 ] 22 0.055% 99.656% ( 51, 76 ] 84 0.209% 99.865% ( 76, 110 ] 12 0.030% 99.895% ( 110, 170 ] 12 0.030% 99.925% ( 170, 250 ] 14 0.035% 99.960% ( 250, 380 ] 4 0.010% 99.970% ( 380, 580 ] 2 0.005% 99.975% ( 580, 870 ] 3 0.007% 99.983% ( 870, 1300 ] 1 0.002% 99.985% ( 1900, 2900 ] 2 0.005% 99.990% ( 2900, 4400 ] 2 0.005% 99.995% ( 4400, 6600 ] 2 0.005% 100.000% ** Level 3 read latency histogram (micros): Count: 28322 Average: 8.6922 StdDev: 149.93 Min: 1 Median: 1.7315 Max: 8063 Percentiles: P50: 1.73 P75: 2.56 P99: 14.69 P99.9: 2139.71 P99.99: 7563.43 ------------------------------------------------------ [ 0, 1 ] 1702 6.009% 6.009% # ( 1, 2 ] 17033 60.141% 66.150% ############ ( 2, 3 ] 4500 15.889% 82.039% ### ( 3, 4 ] 2133 7.531% 89.570% ## ( 4, 6 ] 1752 6.186% 95.756% # ( 6, 10 ] 686 2.422% 98.178% ( 10, 15 ] 249 0.879% 99.057% ( 15, 22 ] 51 0.180% 99.237% ( 22, 34 ] 10 0.035% 99.273% ( 51, 76 ] 1 0.004% 99.276% ( 76, 110 ] 32 0.113% 99.389% ( 110, 170 ] 68 0.240% 99.629% ( 170, 250 ] 30 0.106% 99.735% ( 250, 380 ] 20 0.071% 99.806% ( 380, 580 ] 12 0.042% 99.848% ( 580, 870 ] 8 0.028% 99.876% ( 870, 1300 ] 3 0.011% 99.887% ( 1300, 1900 ] 3 0.011% 99.898% ( 1900, 2900 ] 7 0.025% 99.922% ( 2900, 4400 ] 11 0.039% 99.961% ( 4400, 6600 ] 8 0.028% 99.989% ( 6600, 9900 ] 4 0.014% 100.004% ** Level 4 read latency histogram (micros): Count: 15 Average: 3247.1333 StdDev: 2640.31 Min: 215 Median: 3275.0000 Max: 8773 Percentiles: P50: 3275.00 P75: 5637.50 P99: 8773.00 P99.9: 8773.00 P99.99: 8773.00 ------------------------------------------------------ ( 170, 250 ] 2 13.333% 13.333% ### ( 380, 580 ] 1 6.667% 20.000% # ( 870, 1300 ] 3 20.000% 40.000% #### ( 1900, 2900 ] 1 6.667% 46.667% # ( 2900, 4400 ] 2 13.333% 60.000% ### ( 4400, 6600 ] 4 26.667% 86.667% ##### ( 6600, 9900 ] 2 13.333% 100.000% ### ** DB Stats ** Uptime(secs): 3.2 total, 3.0 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 312.10 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.183 H:M:S, 5.8 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 323.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.183 H:M:S, 6.0 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 3 num-running-flushes: 1 2024/12/09-23:57:05 ... thread 0: (1000000,2000000) ops and (312741.0,320598.1) ops/second in (3.197534,6.238340) 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 9/4 1.35 GB 106.5 1.0 0.0 1.0 2.8 1.8 0.0 1.5 105.3 302.2 9.56 8.79 32 0.299 1022K 4841 0.0 0.0 L1 1/0 49.66 MB 5.0 0.6 0.4 0.2 0.6 0.4 0.1 1.4 239.1 237.5 2.63 2.55 2 1.314 637K 4069 0.0 0.0 L2 1/1 100.74 MB 0.0 0.2 0.1 0.1 0.2 0.1 0.4 2.6 240.9 240.4 0.67 0.63 1 0.667 163K 325 0.0 0.0 L3 22/11 1.36 GB 0.4 0.5 0.4 0.1 0.5 0.4 0.0 1.2 207.7 207.2 2.65 2.46 4 0.663 559K 1338 0.0 0.0 L4 116/0 9.47 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.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 257/16 21.06 GB 0.0 2.3 0.9 1.4 4.1 2.8 0.4 2.2 151.3 272.3 15.51 14.43 39 0.398 2382K 10K 0.0 0.0 Int 0/0 0.00 KB 0.0 2.3 0.9 1.4 4.1 2.8 0.4 2.2 151.3 272.3 15.51 14.43 39 0.398 2382K 10K 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.3 0.9 1.4 2.3 0.9 0.0 0.0 235.4 234.4 9.97 9.55 11 0.906 2382K 10K 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 340.7 5.54 4.88 28 0.198 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): 6.4 total, 6.2 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.12 GB write, 664.92 MB/s write, 2.29 GB read, 369.49 MB/s read, 15.5 seconds Interval compaction: 4.12 GB write, 676.73 MB/s write, 2.29 GB read, 376.05 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: 4, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 4, interval: 4 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 397480 Average: 2.4367 StdDev: 13.65 Min: 1 Median: 1.5867 Max: 3406 Percentiles: P50: 1.59 P75: 1.99 P99: 6.64 P99.9: 13.32 P99.99: 18.52 ------------------------------------------------------ [ 0, 1 ] 52605 13.235% 13.235% ### ( 1, 2 ] 249074 62.663% 75.898% ############# ( 2, 3 ] 55370 13.930% 89.828% ### ( 3, 4 ] 21417 5.388% 95.216% # ( 4, 6 ] 14473 3.641% 98.858% # ( 6, 10 ] 3541 0.891% 99.748% ( 10, 15 ] 907 0.228% 99.977% ( 15, 22 ] 106 0.027% 100.003% ( 22, 34 ] 10 0.003% 100.006% ( 34, 51 ] 5 0.001% 100.007% ( 51, 76 ] 4 0.001% 100.008% ( 76, 110 ] 1 0.000% 100.008% ( 170, 250 ] 27 0.007% 100.015% ( 250, 380 ] 4 0.001% 100.016% ( 380, 580 ] 9 0.002% 100.018% ( 580, 870 ] 8 0.002% 100.020% ( 870, 1300 ] 9 0.002% 100.023% ( 1300, 1900 ] 3 0.001% 100.023% ( 1900, 2900 ] 3 0.001% 100.024% ( 2900, 4400 ] 3 0.001% 100.025% ** Level 1 read latency histogram (micros): Count: 145803 Average: 2.7951 StdDev: 12.12 Min: 1 Median: 1.7155 Max: 2047 Percentiles: P50: 1.72 P75: 2.42 P99: 8.87 P99.9: 17.58 P99.99: 178.07 ------------------------------------------------------ [ 0, 1 ] 9583 6.573% 6.573% # ( 1, 2 ] 88497 60.696% 67.269% ############ ( 2, 3 ] 26804 18.384% 85.653% #### ( 3, 4 ] 10047 6.891% 92.543% # ( 4, 6 ] 7766 5.326% 97.870% # ( 6, 10 ] 2293 1.573% 99.442% ( 10, 15 ] 637 0.437% 99.879% ( 15, 22 ] 82 0.056% 99.936% ( 22, 34 ] 9 0.006% 99.942% ( 34, 51 ] 1 0.001% 99.942% ( 76, 110 ] 40 0.027% 99.970% ( 110, 170 ] 27 0.019% 99.988% ( 170, 250 ] 24 0.016% 100.005% ( 250, 380 ] 14 0.010% 100.014% ( 380, 580 ] 8 0.005% 100.020% ( 580, 870 ] 2 0.001% 100.021% ( 870, 1300 ] 3 0.002% 100.023% ( 1300, 1900 ] 2 0.001% 100.025% ( 1900, 2900 ] 2 0.001% 100.026% ** Level 2 read latency histogram (micros): Count: 40688 Average: 4.4364 StdDev: 59.80 Min: 1 Median: 1.4617 Max: 6116 Percentiles: P50: 1.46 P75: 1.92 P99: 12.97 P99.9: 547.67 P99.99: 2877.07 ------------------------------------------------------ [ 0, 1 ] 10047 24.693% 24.693% ##### ( 1, 2 ] 22303 54.815% 79.507% ########### ( 2, 3 ] 4011 9.858% 89.365% ## ( 3, 4 ] 1647 4.048% 93.413% # ( 4, 6 ] 1513 3.719% 97.132% # ( 6, 10 ] 640 1.573% 98.705% ( 10, 15 ] 202 0.496% 99.201% ( 15, 22 ] 35 0.086% 99.287% ( 22, 34 ] 10 0.025% 99.312% ( 34, 51 ] 23 0.057% 99.368% ( 51, 76 ] 84 0.206% 99.575% ( 76, 110 ] 16 0.039% 99.614% ( 110, 170 ] 39 0.096% 99.710% ( 170, 250 ] 28 0.069% 99.779% ( 250, 380 ] 25 0.061% 99.840% ( 380, 580 ] 29 0.071% 99.912% ( 580, 870 ] 20 0.049% 99.961% ( 870, 1300 ] 9 0.022% 99.983% ( 1900, 2900 ] 3 0.007% 99.990% ( 2900, 4400 ] 2 0.005% 99.995% ( 4400, 6600 ] 2 0.005% 100.000% ** Level 3 read latency histogram (micros): Count: 241635 Average: 4.0234 StdDev: 54.47 Min: 1 Median: 1.7062 Max: 8063 Percentiles: P50: 1.71 P75: 2.39 P99: 9.88 P99.9: 268.84 P99.99: 853.49 ------------------------------------------------------ [ 0, 1 ] 15160 6.274% 6.274% # ( 1, 2 ] 149623 61.921% 68.195% ############ ( 2, 3 ] 42092 17.420% 85.615% ### ( 3, 4 ] 16232 6.718% 92.332% # ( 4, 6 ] 11231 4.648% 96.980% # ( 6, 10 ] 5036 2.084% 99.064% ( 10, 15 ] 1152 0.477% 99.541% ( 15, 22 ] 176 0.073% 99.614% ( 22, 34 ] 23 0.010% 99.623% ( 34, 51 ] 5 0.002% 99.625% ( 51, 76 ] 3 0.001% 99.627% ( 76, 110 ] 145 0.060% 99.687% ( 110, 170 ] 353 0.146% 99.833% ( 170, 250 ] 148 0.061% 99.894% ( 250, 380 ] 106 0.044% 99.938% ( 380, 580 ] 91 0.038% 99.976% ( 580, 870 ] 38 0.016% 99.991% ( 870, 1300 ] 12 0.005% 99.996% ( 1300, 1900 ] 9 0.004% 100.000% ( 1900, 2900 ] 8 0.003% 100.003% ( 2900, 4400 ] 11 0.005% 100.008% ( 4400, 6600 ] 8 0.003% 100.011% ( 6600, 9900 ] 4 0.002% 100.013% ** Level 4 read latency histogram (micros): Count: 15 Average: 3247.1333 StdDev: 2640.31 Min: 215 Median: 3275.0000 Max: 8773 Percentiles: P50: 3275.00 P75: 5637.50 P99: 8773.00 P99.9: 8773.00 P99.99: 8773.00 ------------------------------------------------------ ( 170, 250 ] 2 13.333% 13.333% ### ( 380, 580 ] 1 6.667% 20.000% # ( 870, 1300 ] 3 20.000% 40.000% #### ( 1900, 2900 ] 1 6.667% 46.667% # ( 2900, 4400 ] 2 13.333% 60.000% ### ( 4400, 6600 ] 4 26.667% 86.667% ##### ( 6600, 9900 ] 2 13.333% 100.000% ### ** DB Stats ** Uptime(secs): 6.4 total, 3.2 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 309.93 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.383 H:M:S, 6.0 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 307.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.201 H:M:S, 6.3 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 1 2024/12/09-23:57:08 ... thread 0: (1000000,3000000) ops and (325590.3,322245.1) ops/second in (3.071345,9.309685) 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/4 2.26 GB 200.4 1.8 0.0 1.8 4.5 2.8 0.0 1.6 118.6 301.9 15.39 14.24 49 0.314 1852K 9160 0.0 0.0 L1 1/0 49.66 MB 5.0 0.6 0.4 0.2 0.6 0.4 0.1 1.4 239.1 237.5 2.63 2.55 2 1.314 637K 4069 0.0 0.0 L2 0/0 0.00 KB 0.0 0.2 0.1 0.1 0.2 0.1 0.4 2.6 240.9 240.4 0.67 0.63 1 0.667 163K 325 0.0 0.0 L3 18/0 746.55 MB 0.7 1.6 0.5 1.0 1.6 0.5 0.0 2.9 224.5 223.9 7.11 6.51 5 1.422 1621K 4264 0.0 0.0 L4 122/0 9.58 GB 1.0 0.2 0.2 0.0 0.2 0.2 0.5 1.0 209.1 209.1 1.08 0.99 1 1.080 229K 0 0.0 0.0 L5 116/0 9.35 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 271/4 21.97 GB 0.0 4.3 1.2 3.1 7.1 4.0 1.6 2.6 165.1 269.7 26.87 24.92 58 0.463 4504K 17K 0.0 0.0 Int 0/0 0.00 KB 0.0 4.3 1.2 3.1 7.1 4.0 1.6 2.6 165.1 269.7 26.87 24.92 58 0.463 4504K 17K 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 4.3 1.2 3.1 4.3 1.2 0.0 0.0 237.9 236.9 18.64 17.66 16 1.165 4504K 17K 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 344.0 8.23 7.26 42 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): 9.4 total, 9.3 interval Flush(GB): cumulative 2.764, interval 2.764 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: 7.08 GB write, 769.29 MB/s write, 4.33 GB read, 470.78 MB/s read, 26.9 seconds Interval compaction: 7.08 GB write, 778.44 MB/s write, 4.33 GB read, 476.39 MB/s read, 26.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: 6, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 6, interval: 6 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 636845 Average: 2.3571 StdDev: 13.73 Min: 0 Median: 1.5495 Max: 3478 Percentiles: P50: 1.55 P75: 1.94 P99: 6.00 P99.9: 13.00 P99.99: 19.21 ------------------------------------------------------ [ 0, 1 ] 94504 14.839% 14.839% ### ( 1, 2 ] 407499 63.987% 78.827% ############# ( 2, 3 ] 80082 12.575% 91.401% ### ( 3, 4 ] 29740 4.670% 96.071% # ( 4, 6 ] 18653 2.929% 99.000% # ( 6, 10 ] 5011 0.787% 99.787% ( 10, 15 ] 1199 0.188% 99.975% ( 15, 22 ] 155 0.024% 100.000% ( 22, 34 ] 15 0.002% 100.002% ( 34, 51 ] 7 0.001% 100.003% ( 51, 76 ] 5 0.001% 100.004% ( 76, 110 ] 2 0.000% 100.004% ( 170, 250 ] 41 0.006% 100.011% ( 250, 380 ] 5 0.001% 100.011% ( 380, 580 ] 15 0.002% 100.014% ( 580, 870 ] 12 0.002% 100.016% ( 870, 1300 ] 12 0.002% 100.018% ( 1300, 1900 ] 7 0.001% 100.019% ( 1900, 2900 ] 4 0.001% 100.019% ( 2900, 4400 ] 5 0.001% 100.020% ** Level 1 read latency histogram (micros): Count: 145803 Average: 2.7951 StdDev: 12.12 Min: 1 Median: 1.7155 Max: 2047 Percentiles: P50: 1.72 P75: 2.42 P99: 8.87 P99.9: 17.58 P99.99: 178.07 ------------------------------------------------------ [ 0, 1 ] 9583 6.573% 6.573% # ( 1, 2 ] 88497 60.696% 67.269% ############ ( 2, 3 ] 26804 18.384% 85.653% #### ( 3, 4 ] 10047 6.891% 92.543% # ( 4, 6 ] 7766 5.326% 97.870% # ( 6, 10 ] 2293 1.573% 99.442% ( 10, 15 ] 637 0.437% 99.879% ( 15, 22 ] 82 0.056% 99.936% ( 22, 34 ] 9 0.006% 99.942% ( 34, 51 ] 1 0.001% 99.942% ( 76, 110 ] 40 0.027% 99.970% ( 110, 170 ] 27 0.019% 99.988% ( 170, 250 ] 24 0.016% 100.005% ( 250, 380 ] 14 0.010% 100.014% ( 380, 580 ] 8 0.005% 100.020% ( 580, 870 ] 2 0.001% 100.021% ( 870, 1300 ] 3 0.002% 100.023% ( 1300, 1900 ] 2 0.001% 100.025% ( 1900, 2900 ] 2 0.001% 100.026% ** Level 2 read latency histogram (micros): Count: 65615 Average: 3.6676 StdDev: 47.38 Min: 1 Median: 1.5207 Max: 6116 Percentiles: P50: 1.52 P75: 1.94 P99: 9.73 P99.9: 382.66 P99.99: 2046.17 ------------------------------------------------------ [ 0, 1 ] 12608 19.215% 19.215% #### ( 1, 2 ] 38794 59.124% 78.339% ############ ( 2, 3 ] 7462 11.372% 89.711% ## ( 3, 4 ] 2909 4.433% 94.145% # ( 4, 6 ] 2160 3.292% 97.437% # ( 6, 10 ] 1099 1.675% 99.111% ( 10, 15 ] 251 0.383% 99.494% ( 15, 22 ] 39 0.059% 99.553% ( 22, 34 ] 10 0.015% 99.569% ( 34, 51 ] 23 0.035% 99.604% ( 51, 76 ] 84 0.128% 99.732% ( 76, 110 ] 17 0.026% 99.758% ( 110, 170 ] 40 0.061% 99.819% ( 170, 250 ] 28 0.043% 99.861% ( 250, 380 ] 25 0.038% 99.899% ( 380, 580 ] 29 0.044% 99.944% ( 580, 870 ] 20 0.030% 99.974% ( 870, 1300 ] 10 0.015% 99.989% ( 1900, 2900 ] 3 0.005% 99.994% ( 2900, 4400 ] 2 0.003% 99.997% ( 4400, 6600 ] 2 0.003% 100.000% ** Level 3 read latency histogram (micros): Count: 324127 Average: 3.8081 StdDev: 48.33 Min: 1 Median: 1.6850 Max: 8063 Percentiles: P50: 1.68 P75: 2.30 P99: 9.74 P99.9: 265.87 P99.99: 920.57 ------------------------------------------------------ [ 0, 1 ] 22004 6.789% 6.789% # ( 1, 2 ] 204469 63.083% 69.872% ############# ( 2, 3 ] 55228 17.039% 86.911% ### ( 3, 4 ] 19686 6.074% 92.984% # ( 4, 6 ] 13283 4.098% 97.082% # ( 6, 10 ] 6645 2.050% 99.132% ( 10, 15 ] 1487 0.459% 99.591% ( 15, 22 ] 212 0.065% 99.657% ( 22, 34 ] 30 0.009% 99.666% ( 34, 51 ] 6 0.002% 99.668% ( 51, 76 ] 4 0.001% 99.669% ( 76, 110 ] 164 0.051% 99.720% ( 110, 170 ] 388 0.120% 99.839% ( 170, 250 ] 181 0.056% 99.895% ( 250, 380 ] 130 0.040% 99.935% ( 380, 580 ] 112 0.035% 99.970% ( 580, 870 ] 63 0.019% 99.989% ( 870, 1300 ] 22 0.007% 99.996% ( 1300, 1900 ] 12 0.004% 100.000% ( 1900, 2900 ] 8 0.002% 100.002% ( 2900, 4400 ] 11 0.003% 100.006% ( 4400, 6600 ] 8 0.002% 100.008% ( 6600, 9900 ] 4 0.001% 100.009% ** Level 4 read latency histogram (micros): Count: 45 Average: 1137.2667 StdDev: 2136.75 Min: 0 Median: 125.0000 Max: 8773 Percentiles: P50: 125.00 P75: 977.50 P99: 8773.00 P99.9: 8773.00 P99.99: 8773.00 ------------------------------------------------------ [ 0, 1 ] 9 20.000% 20.000% #### ( 1, 2 ] 8 17.778% 37.778% #### ( 2, 3 ] 1 2.222% 40.000% ( 6, 10 ] 1 2.222% 42.222% ( 10, 15 ] 1 2.222% 44.444% ( 34, 51 ] 1 2.222% 46.667% ( 110, 170 ] 6 13.333% 60.000% ### ( 170, 250 ] 2 4.444% 64.444% # ( 250, 380 ] 1 2.222% 66.667% ( 380, 580 ] 2 4.444% 71.111% # ( 580, 870 ] 1 2.222% 73.333% ( 870, 1300 ] 3 6.667% 80.000% # ( 1900, 2900 ] 1 2.222% 82.222% ( 2900, 4400 ] 2 4.444% 86.667% # ( 4400, 6600 ] 4 8.889% 95.556% ## ( 6600, 9900 ] 2 4.444% 100.000% # ** Level 5 read latency histogram (micros): Count: 40 Average: 900.2250 StdDev: 1023.51 Min: 99 Median: 380.0000 Max: 4645 Percentiles: P50: 380.00 P75: 1300.00 P99: 4645.00 P99.9: 4645.00 P99.99: 4645.00 ------------------------------------------------------ ( 76, 110 ] 1 2.500% 2.500% # ( 110, 170 ] 7 17.500% 20.000% #### ( 170, 250 ] 7 17.500% 37.500% #### ( 250, 380 ] 5 12.500% 50.000% ### ( 380, 580 ] 4 10.000% 60.000% ## ( 580, 870 ] 2 5.000% 65.000% # ( 870, 1300 ] 4 10.000% 75.000% ## ( 1300, 1900 ] 3 7.500% 82.500% ## ( 1900, 2900 ] 5 12.500% 95.000% ### ( 2900, 4400 ] 1 2.500% 97.500% # ( 4400, 6600 ] 1 2.500% 100.000% # ** DB Stats ** Uptime(secs): 9.4 total, 3.1 interval Cumulative writes: 0 writes, 3000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 2.88 GB, 313.36 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.557 H:M:S, 5.9 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 320.46 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.174 H:M:S, 5.7 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 1 num-running-flushes: 1 2024/12/09-23:57:11 ... thread 0: (1000000,4000000) ops and (329067.6,323924.0) ops/second in (3.038889,12.348574) 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 17/14 3.24 GB 18.9 2.8 0.0 2.8 6.6 3.7 0.0 1.8 129.9 301.6 22.27 20.73 68 0.328 2938K 14K 0.0 0.0 L1 1/1 49.66 MB 0.0 0.6 0.4 0.2 0.6 0.4 0.1 1.4 239.1 237.5 2.63 2.55 2 1.314 637K 4069 0.0 0.0 L2 0/0 0.00 KB 0.0 0.2 0.1 0.1 0.2 0.1 0.4 2.6 240.9 240.4 0.67 0.63 1 0.667 163K 325 0.0 0.0 L3 18/0 746.55 MB 0.7 1.6 0.5 1.0 1.6 0.5 0.0 2.9 224.5 223.9 7.11 6.51 5 1.422 1621K 4264 0.0 0.0 L4 122/0 9.58 GB 1.0 0.2 0.2 0.0 0.2 0.2 0.5 1.0 209.1 209.1 1.08 0.99 1 1.080 229K 0 0.0 0.0 L5 116/0 9.35 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 274/15 22.95 GB 0.0 5.4 1.2 4.1 9.1 5.0 1.6 2.4 163.1 276.0 33.76 31.41 77 0.438 5590K 23K 0.0 0.0 Int 0/0 0.00 KB 0.0 5.4 1.2 4.1 9.1 5.0 1.6 2.4 163.1 276.0 33.76 31.41 77 0.438 5590K 23K 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.4 1.2 4.1 5.4 1.2 0.0 0.0 242.6 241.6 22.69 21.61 20 1.134 5590K 23K 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 346.7 11.07 9.80 57 0.194 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.5 total, 12.4 interval Flush(GB): cumulative 3.747, interval 3.747 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.10 GB write, 747.81 MB/s write, 5.38 GB read, 441.79 MB/s read, 33.8 seconds Interval compaction: 9.10 GB write, 754.52 MB/s write, 5.38 GB read, 445.75 MB/s read, 33.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: 7, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 7, interval: 7 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 886099 Average: 2.3495 StdDev: 14.84 Min: 0 Median: 1.5055 Max: 3595 Percentiles: P50: 1.51 P75: 1.89 P99: 5.94 P99.9: 14.05 P99.99: 150.56 ------------------------------------------------------ [ 0, 1 ] 154140 17.395% 17.395% ### ( 1, 2 ] 571519 64.498% 81.894% ############# ( 2, 3 ] 96238 10.861% 92.755% ## ( 3, 4 ] 35324 3.986% 96.741% # ( 4, 6 ] 20664 2.332% 99.073% ( 6, 10 ] 6188 0.698% 99.771% ( 10, 15 ] 1406 0.159% 99.930% ( 15, 22 ] 168 0.019% 99.949% ( 22, 34 ] 21 0.002% 99.951% ( 34, 51 ] 9 0.001% 99.952% ( 51, 76 ] 6 0.001% 99.953% ( 76, 110 ] 203 0.023% 99.976% ( 110, 170 ] 184 0.021% 99.997% ( 170, 250 ] 88 0.010% 100.007% ( 250, 380 ] 18 0.002% 100.009% ( 380, 580 ] 33 0.004% 100.012% ( 580, 870 ] 20 0.002% 100.015% ( 870, 1300 ] 19 0.002% 100.017% ( 1300, 1900 ] 11 0.001% 100.018% ( 1900, 2900 ] 6 0.001% 100.019% ( 2900, 4400 ] 8 0.001% 100.020% ** Level 1 read latency histogram (micros): Count: 145804 Average: 2.7964 StdDev: 12.13 Min: 1 Median: 1.7155 Max: 2047 Percentiles: P50: 1.72 P75: 2.42 P99: 8.88 P99.9: 17.66 P99.99: 180.94 ------------------------------------------------------ [ 0, 1 ] 9583 6.573% 6.573% # ( 1, 2 ] 88497 60.696% 67.268% ############ ( 2, 3 ] 26804 18.384% 85.652% #### ( 3, 4 ] 10047 6.891% 92.543% # ( 4, 6 ] 7766 5.326% 97.869% # ( 6, 10 ] 2293 1.573% 99.442% ( 10, 15 ] 637 0.437% 99.879% ( 15, 22 ] 82 0.056% 99.935% ( 22, 34 ] 9 0.006% 99.941% ( 34, 51 ] 1 0.001% 99.942% ( 76, 110 ] 40 0.027% 99.969% ( 110, 170 ] 27 0.019% 99.988% ( 170, 250 ] 25 0.017% 100.005% ( 250, 380 ] 14 0.010% 100.014% ( 380, 580 ] 8 0.005% 100.020% ( 580, 870 ] 2 0.001% 100.021% ( 870, 1300 ] 3 0.002% 100.023% ( 1300, 1900 ] 2 0.001% 100.025% ( 1900, 2900 ] 2 0.001% 100.026% ** Level 2 read latency histogram (micros): Count: 65615 Average: 3.6676 StdDev: 47.38 Min: 1 Median: 1.5207 Max: 6116 Percentiles: P50: 1.52 P75: 1.94 P99: 9.73 P99.9: 382.66 P99.99: 2046.17 ------------------------------------------------------ [ 0, 1 ] 12608 19.215% 19.215% #### ( 1, 2 ] 38794 59.124% 78.339% ############ ( 2, 3 ] 7462 11.372% 89.711% ## ( 3, 4 ] 2909 4.433% 94.145% # ( 4, 6 ] 2160 3.292% 97.437% # ( 6, 10 ] 1099 1.675% 99.111% ( 10, 15 ] 251 0.383% 99.494% ( 15, 22 ] 39 0.059% 99.553% ( 22, 34 ] 10 0.015% 99.569% ( 34, 51 ] 23 0.035% 99.604% ( 51, 76 ] 84 0.128% 99.732% ( 76, 110 ] 17 0.026% 99.758% ( 110, 170 ] 40 0.061% 99.819% ( 170, 250 ] 28 0.043% 99.861% ( 250, 380 ] 25 0.038% 99.899% ( 380, 580 ] 29 0.044% 99.944% ( 580, 870 ] 20 0.030% 99.974% ( 870, 1300 ] 10 0.015% 99.989% ( 1900, 2900 ] 3 0.005% 99.994% ( 2900, 4400 ] 2 0.003% 99.997% ( 4400, 6600 ] 2 0.003% 100.000% ** Level 3 read latency histogram (micros): Count: 324127 Average: 3.8081 StdDev: 48.33 Min: 1 Median: 1.6850 Max: 8063 Percentiles: P50: 1.68 P75: 2.30 P99: 9.74 P99.9: 265.87 P99.99: 920.57 ------------------------------------------------------ [ 0, 1 ] 22004 6.789% 6.789% # ( 1, 2 ] 204469 63.083% 69.872% ############# ( 2, 3 ] 55228 17.039% 86.911% ### ( 3, 4 ] 19686 6.074% 92.984% # ( 4, 6 ] 13283 4.098% 97.082% # ( 6, 10 ] 6645 2.050% 99.132% ( 10, 15 ] 1487 0.459% 99.591% ( 15, 22 ] 212 0.065% 99.657% ( 22, 34 ] 30 0.009% 99.666% ( 34, 51 ] 6 0.002% 99.668% ( 51, 76 ] 4 0.001% 99.669% ( 76, 110 ] 164 0.051% 99.720% ( 110, 170 ] 388 0.120% 99.839% ( 170, 250 ] 181 0.056% 99.895% ( 250, 380 ] 130 0.040% 99.935% ( 380, 580 ] 112 0.035% 99.970% ( 580, 870 ] 63 0.019% 99.989% ( 870, 1300 ] 22 0.007% 99.996% ( 1300, 1900 ] 12 0.004% 100.000% ( 1900, 2900 ] 8 0.002% 100.002% ( 2900, 4400 ] 11 0.003% 100.006% ( 4400, 6600 ] 8 0.002% 100.008% ( 6600, 9900 ] 4 0.001% 100.009% ** Level 4 read latency histogram (micros): Count: 45 Average: 1137.2667 StdDev: 2136.75 Min: 0 Median: 125.0000 Max: 8773 Percentiles: P50: 125.00 P75: 977.50 P99: 8773.00 P99.9: 8773.00 P99.99: 8773.00 ------------------------------------------------------ [ 0, 1 ] 9 20.000% 20.000% #### ( 1, 2 ] 8 17.778% 37.778% #### ( 2, 3 ] 1 2.222% 40.000% ( 6, 10 ] 1 2.222% 42.222% ( 10, 15 ] 1 2.222% 44.444% ( 34, 51 ] 1 2.222% 46.667% ( 110, 170 ] 6 13.333% 60.000% ### ( 170, 250 ] 2 4.444% 64.444% # ( 250, 380 ] 1 2.222% 66.667% ( 380, 580 ] 2 4.444% 71.111% # ( 580, 870 ] 1 2.222% 73.333% ( 870, 1300 ] 3 6.667% 80.000% # ( 1900, 2900 ] 1 2.222% 82.222% ( 2900, 4400 ] 2 4.444% 86.667% # ( 4400, 6600 ] 4 8.889% 95.556% ## ( 6600, 9900 ] 2 4.444% 100.000% # ** Level 5 read latency histogram (micros): Count: 40 Average: 900.2250 StdDev: 1023.51 Min: 99 Median: 380.0000 Max: 4645 Percentiles: P50: 380.00 P75: 1300.00 P99: 4645.00 P99.9: 4645.00 P99.99: 4645.00 ------------------------------------------------------ ( 76, 110 ] 1 2.500% 2.500% # ( 110, 170 ] 7 17.500% 20.000% #### ( 170, 250 ] 7 17.500% 37.500% #### ( 250, 380 ] 5 12.500% 50.000% ### ( 380, 580 ] 4 10.000% 60.000% ## ( 580, 870 ] 2 5.000% 65.000% # ( 870, 1300 ] 4 10.000% 75.000% ## ( 1300, 1900 ] 3 7.500% 82.500% ## ( 1900, 2900 ] 5 12.500% 95.000% ### ( 2900, 4400 ] 1 2.500% 97.500% # ( 4400, 6600 ] 1 2.500% 100.000% # ** DB Stats ** Uptime(secs): 12.5 total, 3.0 interval Cumulative writes: 0 writes, 4000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 3.84 GB, 315.92 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.753 H:M:S, 6.0 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 323.84 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.196 H:M:S, 6.5 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 : 4.061 micros/op 246271 ops/sec 20.002 seconds 4925999 operations; 238.6 MB/s Microseconds per write: Count: 4925999 Average: 4.0606 StdDev: 171.84 Min: 0 Median: 1.7815 Max: 196478 Percentiles: P50: 1.78 P75: 3.11 P99: 8.40 P99.9: 159.70 P99.99: 2408.00 ------------------------------------------------------ [ 0, 1 ] 621685 12.620% 12.620% ### ( 1, 2 ] 2356259 47.833% 60.454% ########## ( 2, 3 ] 645361 13.101% 73.555% ### ( 3, 4 ] 665429 13.509% 87.063% ### ( 4, 6 ] 546060 11.085% 98.148% ## ( 6, 10 ] 70033 1.422% 99.570% ( 10, 15 ] 8953 0.182% 99.752% ( 15, 22 ] 2542 0.052% 99.804% ( 22, 34 ] 850 0.017% 99.821% ( 34, 51 ] 124 0.003% 99.823% ( 51, 76 ] 28 0.001% 99.824% ( 76, 110 ] 4 0.000% 99.824% ( 110, 170 ] 4521 0.092% 99.916% ( 170, 250 ] 405 0.008% 99.924% ( 250, 380 ] 71 0.001% 99.925% ( 380, 580 ] 3 0.000% 99.925% ( 580, 870 ] 3 0.000% 99.926% ( 870, 1300 ] 2674 0.054% 99.980% ( 1900, 2900 ] 987 0.020% 100.000% ( 6600, 9900 ] 1 0.000% 100.000% ( 9900, 14000 ] 1 0.000% 100.000% ( 22000, 33000 ] 1 0.000% 100.000% ( 170000, 250000 ] 4 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 : 163186 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 : 4925999 rocksdb.number.keys.read COUNT : 0 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 5083630968 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 : 161 rocksdb.no.file.errors COUNT : 0 rocksdb.stall.micros COUNT : 5670477 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 : 9277650960 rocksdb.compact.write.bytes COUNT : 9117276693 rocksdb.flush.write.bytes COUNT : 4946921335 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 : 15 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 : 4914385920 rocksdb.memtable.garbage.bytes.at.flush COUNT : 8640512 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 : 9319777051 rocksdb.non.last.level.read.count COUNT : 2250093 rocksdb.block.checksum.compute.count COUNT : 2249786 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.440132 P95 : 4.916720 P99 : 7.083171 P100 : 196473.000000 COUNT : 4925999 SUM : 17771588 rocksdb.compaction.times.micros P50 : 1016923.076923 P95 : 4020000.000000 P99 : 4458672.000000 P100 : 4458672.000000 COUNT : 24 SUM : 28907535 rocksdb.compaction.times.cpu_micros P50 : 1005714.285714 P95 : 3460000.000000 P99 : 4053051.000000 P100 : 4053051.000000 COUNT : 24 SUM : 27578348 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 : 592.083333 P95 : 1288.738095 P99 : 1314.000000 P100 : 1314.000000 COUNT : 71 SUM : 52650 rocksdb.compaction.outfile.sync.micros P50 : 752.619048 P95 : 1672.000000 P99 : 2510.000000 P100 : 2593.000000 COUNT : 78 SUM : 64681 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 : 93.809524 P95 : 242.666667 P99 : 346.850000 P100 : 347.000000 COUNT : 102 SUM : 11531 rocksdb.table.open.io.micros P50 : 1624.000000 P95 : 15560.000000 P99 : 20712.000000 P100 : 21412.000000 COUNT : 161 SUM : 486772 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.595880 P95 : 6.845379 P99 : 11.857963 P100 : 3758.000000 COUNT : 2249459 SUM : 10922828 rocksdb.read.block.get.micros P50 : 580.000000 P95 : 4721.538462 P99 : 7774.800000 P100 : 8870.000000 COUNT : 322 SUM : 375233 rocksdb.write.raw.block.micros P50 : 0.513514 P95 : 0.975677 P99 : 3.626875 P100 : 2921.000000 COUNT : 3421819 SUM : 6473737 rocksdb.numfiles.in.singlecompaction P50 : 3.400000 P95 : 11.000000 P99 : 14.200000 P100 : 15.000000 COUNT : 32 SUM : 137 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.559815 P95 : 1181.918848 P99 : 2555.258359 P100 : 196242.000000 COUNT : 34526 SUM : 5672437 rocksdb.sst.read.micros P50 : 1.555338 P95 : 3.824083 P99 : 8.344215 P100 : 8773.000000 COUNT : 2250374 SUM : 6546090 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 : 4925999 SUM : 5083630968 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 : 206428.571429 P95 : 287700.000000 P99 : 361540.000000 P100 : 362752.000000 COUNT : 71 SUM : 13667308 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 : 98 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