[2024-11-27 21:06:32.973137] Starting SPDK v24.01.1-pre git sha1 c13c99a5e / DPDK 23.11.0 initialization... [2024-11-27 21:06:32.973407] [ DPDK EAL parameters: rocksdb --no-shconf -c 0x1 --huge-unlink --no-telemetry --log-level=lib.eal:6 --log-level=lib.cryptodev:5 --log-level=user1:6 --base-virtaddr=0x200000000000 --match-allocations --file-prefix=spdk_pid742779 ] Set seed to 1732737992967690 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-11-27 21:06:33.088779] app.c: 798:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-11-27 21:06:33.294093] app.c: 488:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-11-27 21:06:33.294142] app.c: 489:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 742779' to capture a snapshot of events at runtime. [2024-11-27 21:06:33.294152] app.c: 494:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid742779 for offline analysis/debug. [2024-11-27 21:06:33.294196] reactor.c: 937:reactor_run: *NOTICE*: Reactor started on core 0 RocksDB: version 8.1.1 Date: Wed Nov 27 21:06:42 2024 CPU: 96 * Intel(R) Xeon(R) Gold 6252 CPU @ 2.10GHz CPUCache: 36608 KB 2024/11/27-21:06:46 ... thread 0: (1000000,1000000) ops and (236609.4,236609.4) ops/second in (4.226375,4.226375) 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 19/16 2.58 GB 62.9 0.6 0.0 0.6 1.4 0.9 0.0 1.6 102.8 262.5 5.52 4.46 15 0.368 575K 642 0.0 0.0 L1 11/11 1.10 GB 0.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 L2 1/0 99.82 MB 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 L3 13/0 956.97 MB 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 L4 166/0 9.70 GB 1.0 0.2 0.1 0.1 0.2 0.1 0.0 1.7 141.8 141.3 1.55 1.08 1 1.552 0 0 0.0 0.0 L5 1104/0 90.74 GB 0.9 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 1314/27 105.15 GB 0.0 0.8 0.1 0.6 1.6 1.0 0.0 1.9 111.3 235.9 7.07 5.54 16 0.442 575K 642 0.0 0.0 Int 0/0 0.00 KB 0.0 0.8 0.1 0.6 1.6 1.0 0.0 1.9 111.3 235.9 7.07 5.54 16 0.442 575K 642 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.1 0.6 0.8 0.1 0.0 0.0 209.9 209.5 3.75 3.23 3 1.250 575K 642 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 265.6 3.32 2.31 13 0.255 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 4.4 total, 4.2 interval Flush(GB): cumulative 0.861, interval 0.861 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.63 GB write, 374.98 MB/s write, 0.77 GB read, 177.00 MB/s read, 7.1 seconds Interval compaction: 1.63 GB write, 394.34 MB/s write, 0.77 GB read, 186.13 MB/s read, 7.1 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 2, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 2, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 2, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 2, total-stops: 2, interval: 4 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 376312 Average: 7.8558 StdDev: 108.55 Min: 1 Median: 1.5115 Max: 20825 Percentiles: P50: 1.51 P75: 1.90 P99: 150.80 P99.9: 782.83 P99.99: 1380.70 ------------------------------------------------------ [ 0, 1 ] 63829 16.962% 16.962% ### ( 1, 2 ] 243042 64.585% 81.547% ############# ( 2, 3 ] 39077 10.384% 91.931% ## ( 3, 4 ] 12468 3.313% 95.244% # ( 4, 6 ] 8201 2.179% 97.424% ( 6, 10 ] 3802 1.010% 98.434% ( 10, 15 ] 677 0.180% 98.614% ( 15, 22 ] 94 0.025% 98.639% ( 22, 34 ] 12 0.003% 98.642% ( 34, 51 ] 4 0.001% 98.643% ( 51, 76 ] 3 0.001% 98.644% ( 76, 110 ] 184 0.049% 98.693% ( 110, 170 ] 1700 0.452% 99.145% ( 170, 250 ] 1405 0.373% 99.518% ( 250, 380 ] 620 0.165% 99.683% ( 380, 580 ] 561 0.149% 99.832% ( 580, 870 ] 367 0.098% 99.929% ( 870, 1300 ] 209 0.056% 99.985% ( 1300, 1900 ] 144 0.038% 100.023% ( 1900, 2900 ] 87 0.023% 100.046% ( 2900, 4400 ] 21 0.006% 100.052% ( 4400, 6600 ] 6 0.002% 100.053% ( 6600, 9900 ] 3 0.001% 100.054% ( 9900, 14000 ] 1 0.000% 100.054% ( 14000, 22000 ] 7 0.002% 100.056% ** Level 1 read latency histogram (micros): Count: 217 Average: 968.2995 StdDev: 2758.80 Min: 90 Median: 241.2000 Max: 20747 Percentiles: P50: 241.20 P75: 561.25 P99: 17660.00 P99.9: 20747.00 P99.99: 20747.00 ------------------------------------------------------ ( 76, 110 ] 8 3.687% 3.687% # ( 110, 170 ] 56 25.806% 29.493% ##### ( 170, 250 ] 50 23.041% 52.535% ##### ( 250, 380 ] 27 12.442% 64.977% ## ( 380, 580 ] 24 11.060% 76.037% ## ( 580, 870 ] 13 5.991% 82.028% # ( 870, 1300 ] 8 3.687% 85.714% # ( 1300, 1900 ] 12 5.530% 91.244% # ( 1900, 2900 ] 5 2.304% 93.548% ( 2900, 4400 ] 6 2.765% 96.313% # ( 4400, 6600 ] 3 1.382% 97.696% ( 6600, 9900 ] 1 0.461% 98.157% ( 14000, 22000 ] 4 1.843% 100.000% ** Level 2 read latency histogram (micros): Count: 22 Average: 570.8182 StdDev: 1017.77 Min: 109 Median: 234.0000 Max: 4989 Percentiles: P50: 234.00 P75: 480.00 P99: 4989.00 P99.9: 4989.00 P99.99: 4989.00 ------------------------------------------------------ ( 76, 110 ] 1 4.545% 4.545% # ( 110, 170 ] 6 27.273% 31.818% ##### ( 170, 250 ] 5 22.727% 54.545% ##### ( 250, 380 ] 4 18.182% 72.727% #### ( 380, 580 ] 1 4.545% 77.273% # ( 580, 870 ] 2 9.091% 86.364% ## ( 870, 1300 ] 1 4.545% 90.909% # ( 1300, 1900 ] 1 4.545% 95.455% # ( 4400, 6600 ] 1 4.545% 100.000% # ** Level 3 read latency histogram (micros): Count: 223 Average: 530.8789 StdDev: 768.04 Min: 83 Median: 238.9362 Max: 4726 Percentiles: P50: 238.94 P75: 526.55 P99: 4726.00 P99.9: 4726.00 P99.99: 4726.00 ------------------------------------------------------ ( 76, 110 ] 16 7.175% 7.175% # ( 110, 170 ] 55 24.664% 31.839% ##### ( 170, 250 ] 47 21.076% 52.915% #### ( 250, 380 ] 28 12.556% 65.471% ### ( 380, 580 ] 29 13.004% 78.475% ### ( 580, 870 ] 14 6.278% 84.753% # ( 870, 1300 ] 10 4.484% 89.238% # ( 1300, 1900 ] 14 6.278% 95.516% # ( 1900, 2900 ] 3 1.345% 96.861% ( 2900, 4400 ] 4 1.794% 98.655% ( 4400, 6600 ] 3 1.345% 100.000% ** Level 4 read latency histogram (micros): Count: 20056 Average: 83.9588 StdDev: 362.74 Min: 1 Median: 1.7088 Max: 6620 Percentiles: P50: 1.71 P75: 2.85 P99: 1883.62 P99.9: 4694.40 P99.99: 6499.44 ------------------------------------------------------ [ 0, 1 ] 2446 12.196% 12.196% ## ( 1, 2 ] 10697 53.336% 65.532% ########### ( 2, 3 ] 2238 11.159% 76.690% ## ( 3, 4 ] 958 4.777% 81.467% # ( 4, 6 ] 676 3.371% 84.837% # ( 6, 10 ] 297 1.481% 86.318% ( 10, 15 ] 76 0.379% 86.697% ( 15, 22 ] 15 0.075% 86.772% ( 22, 34 ] 4 0.020% 86.792% ( 51, 76 ] 2 0.010% 86.802% ( 76, 110 ] 98 0.489% 87.291% ( 110, 170 ] 673 3.356% 90.646% # ( 170, 250 ] 515 2.568% 93.214% # ( 250, 380 ] 270 1.346% 94.560% ( 380, 580 ] 309 1.541% 96.101% ( 580, 870 ] 230 1.147% 97.248% ( 870, 1300 ] 189 0.942% 98.190% ( 1300, 1900 ] 167 0.833% 99.023% ( 1900, 2900 ] 127 0.633% 99.656% ( 2900, 4400 ] 46 0.229% 99.885% ( 4400, 6600 ] 22 0.110% 99.995% ( 6600, 9900 ] 1 0.005% 100.000% ** Level 5 read latency histogram (micros): Count: 18500 Average: 630.5536 StdDev: 923.66 Min: 80 Median: 243.6809 Max: 6804 Percentiles: P50: 243.68 P75: 624.81 P99: 4736.11 P99.9: 6431.94 P99.99: 6765.00 ------------------------------------------------------ ( 76, 110 ] 644 3.481% 3.481% # ( 110, 170 ] 5073 27.422% 30.903% ##### ( 170, 250 ] 3836 20.735% 51.638% #### ( 250, 380 ] 2099 11.346% 62.984% ## ( 380, 580 ] 1996 10.789% 73.773% ## ( 580, 870 ] 1469 7.941% 81.714% ## ( 870, 1300 ] 1035 5.595% 87.308% # ( 1300, 1900 ] 716 3.870% 91.178% # ( 1900, 2900 ] 756 4.086% 95.265% # ( 2900, 4400 ] 658 3.557% 98.822% # ( 4400, 6600 ] 216 1.168% 99.989% ( 6600, 9900 ] 3 0.016% 100.005% ** DB Stats ** Uptime(secs): 4.4 total, 4.2 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 221.29 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.752 H:M:S, 16.9 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 232.70 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.752 H:M:S, 17.8 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 1 2024/11/27-21:06:55 ... thread 0: (1000000,2000000) ops and (109534.9,149746.7) ops/second in (9.129509,13.355884) 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 18/12 3.62 GB 194.8 2.6 0.0 2.6 4.5 1.9 0.0 2.4 161.5 280.4 16.38 14.73 38 0.431 2685K 4467 0.0 0.0 L1 11/11 1.10 GB 0.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 L2 1/0 99.82 MB 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 L3 13/0 956.97 MB 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 L4 166/0 9.70 GB 1.0 0.2 0.1 0.1 0.2 0.1 0.0 1.7 141.8 141.3 1.55 1.08 1 1.552 0 0 0.0 0.0 L5 1104/0 90.74 GB 0.9 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 1313/23 106.20 GB 0.0 2.8 0.1 2.7 4.7 2.0 0.0 2.5 159.8 268.4 17.93 15.81 39 0.460 2685K 4467 0.0 0.0 Int 0/0 0.00 KB 0.0 2.8 0.1 2.7 4.7 2.0 0.0 2.5 159.8 268.4 17.93 15.81 39 0.460 2685K 4467 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 0.1 2.7 2.8 0.1 0.0 0.0 251.8 251.3 11.38 10.76 9 1.264 2685K 4467 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 1.9 1.9 0.0 0.0 0.0 298.0 6.55 5.05 30 0.218 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 13.6 total, 13.4 interval Flush(GB): cumulative 1.907, interval 1.907 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.70 GB write, 354.50 MB/s write, 2.80 GB read, 211.05 MB/s read, 17.9 seconds Interval compaction: 4.70 GB write, 360.30 MB/s write, 2.80 GB read, 214.50 MB/s read, 17.9 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 16, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 16, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 2, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 16, total-stops: 2, interval: 18 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 929373 Average: 16.9612 StdDev: 88.99 Min: 0 Median: 1.4771 Max: 20825 Percentiles: P50: 1.48 P75: 1.91 P99: 248.10 P99.9: 639.37 P99.99: 902.60 ------------------------------------------------------ [ 0, 1 ] 209439 22.536% 22.536% ##### ( 1, 2 ] 534950 57.560% 80.096% ############ ( 2, 3 ] 68544 7.375% 87.471% # ( 3, 4 ] 24918 2.681% 90.152% # ( 4, 6 ] 16641 1.791% 91.943% ( 6, 10 ] 5909 0.636% 92.579% ( 10, 15 ] 1301 0.140% 92.719% ( 15, 22 ] 206 0.022% 92.741% ( 22, 34 ] 24 0.003% 92.743% ( 34, 51 ] 4 0.000% 92.744% ( 51, 76 ] 8 0.001% 92.745% ( 76, 110 ] 3138 0.338% 93.082% ( 110, 170 ] 34129 3.672% 96.755% # ( 170, 250 ] 21375 2.300% 99.055% ( 250, 380 ] 4634 0.499% 99.553% ( 380, 580 ] 3014 0.324% 99.877% ( 580, 870 ] 1024 0.110% 99.988% ( 870, 1300 ] 291 0.031% 100.019% ( 1300, 1900 ] 165 0.018% 100.037% ( 1900, 2900 ] 114 0.012% 100.049% ( 2900, 4400 ] 37 0.004% 100.053% ( 4400, 6600 ] 6 0.001% 100.054% ( 6600, 9900 ] 3 0.000% 100.054% ( 9900, 14000 ] 1 0.000% 100.054% ( 14000, 22000 ] 7 0.001% 100.055% ** Level 1 read latency histogram (micros): Count: 1917 Average: 279.6703 StdDev: 965.58 Min: 87 Median: 165.2763 Max: 20747 Percentiles: P50: 165.28 P75: 226.47 P99: 1891.50 P99.9: 18166.00 P99.99: 20747.00 ------------------------------------------------------ ( 76, 110 ] 75 3.912% 3.912% # ( 110, 170 ] 959 50.026% 53.938% ########## ( 170, 250 ] 572 29.838% 83.777% ###### ( 250, 380 ] 127 6.625% 90.402% # ( 380, 580 ] 101 5.269% 95.670% # ( 580, 870 ] 42 2.191% 97.861% ( 870, 1300 ] 10 0.522% 98.383% ( 1300, 1900 ] 12 0.626% 99.009% ( 1900, 2900 ] 5 0.261% 99.270% ( 2900, 4400 ] 6 0.313% 99.583% ( 4400, 6600 ] 3 0.156% 99.739% ( 6600, 9900 ] 1 0.052% 99.791% ( 14000, 22000 ] 4 0.209% 100.000% ** Level 2 read latency histogram (micros): Count: 205 Average: 239.6780 StdDev: 367.86 Min: 99 Median: 168.4536 Max: 4989 Percentiles: P50: 168.45 P75: 231.90 P99: 1278.50 P99.9: 4989.00 P99.99: 4989.00 ------------------------------------------------------ ( 76, 110 ] 8 3.902% 3.902% # ( 110, 170 ] 97 47.317% 51.220% ######### ( 170, 250 ] 63 30.732% 81.951% ###### ( 250, 380 ] 17 8.293% 90.244% ## ( 380, 580 ] 13 6.341% 96.585% # ( 580, 870 ] 4 1.951% 98.537% ( 870, 1300 ] 1 0.488% 99.024% ( 1300, 1900 ] 1 0.488% 99.512% ( 4400, 6600 ] 1 0.488% 100.000% ** Level 3 read latency histogram (micros): Count: 1897 Average: 221.9789 StdDev: 299.95 Min: 83 Median: 162.3620 Max: 4726 Percentiles: P50: 162.36 P75: 218.75 P99: 1541.20 P99.9: 4726.00 P99.99: 4726.00 ------------------------------------------------------ ( 76, 110 ] 95 5.008% 5.008% # ( 110, 170 ] 978 51.555% 56.563% ########## ( 170, 250 ] 574 30.258% 86.821% ###### ( 250, 380 ] 114 6.009% 92.831% # ( 380, 580 ] 68 3.585% 96.415% # ( 580, 870 ] 32 1.687% 98.102% ( 870, 1300 ] 11 0.580% 98.682% ( 1300, 1900 ] 15 0.791% 99.473% ( 1900, 2900 ] 3 0.158% 99.631% ( 2900, 4400 ] 4 0.211% 99.842% ( 4400, 6600 ] 3 0.158% 100.000% ** Level 4 read latency histogram (micros): Count: 34859 Average: 126.1672 StdDev: 287.93 Min: 1 Median: 7.3013 Max: 6620 Percentiles: P50: 7.30 P75: 164.85 P99: 1378.63 P99.9: 4013.29 P99.99: 6351.41 ------------------------------------------------------ [ 0, 1 ] 2446 7.017% 7.017% # ( 1, 2 ] 10705 30.709% 37.726% ###### ( 2, 3 ] 2333 6.693% 44.419% # ( 3, 4 ] 1018 2.920% 47.339% # ( 4, 6 ] 826 2.370% 49.709% ( 6, 10 ] 312 0.895% 50.604% ( 10, 15 ] 83 0.238% 50.842% ( 15, 22 ] 16 0.046% 50.888% ( 22, 34 ] 4 0.011% 50.899% ( 51, 76 ] 2 0.006% 50.905% ( 76, 110 ] 794 2.278% 53.183% ( 110, 170 ] 8320 23.868% 77.050% ##### ( 170, 250 ] 4984 14.298% 91.348% ### ( 250, 380 ] 1167 3.348% 94.696% # ( 380, 580 ] 885 2.539% 97.235% # ( 580, 870 ] 389 1.116% 98.350% ( 870, 1300 ] 204 0.585% 98.936% ( 1300, 1900 ] 171 0.491% 99.426% ( 1900, 2900 ] 131 0.376% 99.802% ( 2900, 4400 ] 46 0.132% 99.934% ( 4400, 6600 ] 22 0.063% 99.997% ( 6600, 9900 ] 1 0.003% 100.000% ** Level 5 read latency histogram (micros): Count: 141558 Average: 244.5910 StdDev: 378.57 Min: 80 Median: 164.4660 Max: 6804 Percentiles: P50: 164.47 P75: 225.33 P99: 2215.52 P99.9: 5178.58 P99.99: 6476.19 ------------------------------------------------------ ( 76, 110 ] 6688 4.725% 4.725% # ( 110, 170 ] 70603 49.876% 54.600% ########## ( 170, 250 ] 41755 29.497% 84.097% ###### ( 250, 380 ] 9402 6.642% 90.739% # ( 380, 580 ] 6728 4.753% 95.492% # ( 580, 870 ] 2771 1.958% 97.449% ( 870, 1300 ] 1203 0.850% 98.299% ( 1300, 1900 ] 746 0.527% 98.826% ( 1900, 2900 ] 781 0.552% 99.378% ( 2900, 4400 ] 663 0.468% 99.846% ( 4400, 6600 ] 216 0.153% 99.999% ( 6600, 9900 ] 3 0.002% 100.001% ** DB Stats ** Uptime(secs): 13.6 total, 9.1 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 144.98 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:6.225 H:M:S, 45.9 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 107.80 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:5.473 H:M:S, 59.9 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 1 num-running-flushes: 0 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: 100000000 Prefix: 0 bytes Keys per prefix: 0 RawSize: 96893.3 MB (estimated) FileSize: 96893.3 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] readwhilewriting : 229.193 micros/op 17428 ops/sec 60.190 seconds 1048996 operations; 16.9 MB/s (264999 of 264999 found) Microseconds per read: Count: 1048996 Average: 229.1952 StdDev: 389.77 Min: 2 Median: 197.5861 Max: 38741 Percentiles: P50: 197.59 P75: 240.94 P99: 723.62 P99.9: 6484.25 P99.99: 17063.44 ------------------------------------------------------ ( 1, 2 ] 10 0.001% 0.001% ( 2, 3 ] 33 0.003% 0.004% ( 3, 4 ] 63 0.006% 0.010% ( 4, 6 ] 86 0.008% 0.018% ( 6, 10 ] 489 0.047% 0.065% ( 10, 15 ] 5494 0.524% 0.589% ( 15, 22 ] 2892 0.276% 0.864% ( 22, 34 ] 8093 0.771% 1.636% ( 34, 51 ] 902 0.086% 1.722% ( 51, 76 ] 94 0.009% 1.731% ( 76, 110 ] 3582 0.341% 2.072% ( 110, 170 ] 335873 32.019% 34.091% ###### ( 170, 250 ] 483975 46.137% 80.228% ######### ( 250, 380 ] 134430 12.815% 93.043% ### ( 380, 580 ] 56598 5.395% 98.438% # ( 580, 870 ] 11897 1.134% 99.572% ( 870, 1300 ] 2338 0.223% 99.795% ( 1300, 1900 ] 409 0.039% 99.834% ( 1900, 2900 ] 286 0.027% 99.862% ( 2900, 4400 ] 205 0.020% 99.881% ( 4400, 6600 ] 209 0.020% 99.901% ( 6600, 9900 ] 524 0.050% 99.951% ( 9900, 14000 ] 362 0.035% 99.986% ( 14000, 22000 ] 123 0.012% 99.997% ( 22000, 33000 ] 21 0.002% 99.999% ( 33000, 50000 ] 8 0.001% 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 : 20179884 rocksdb.bloom.filter.full.positive COUNT : 1243418 rocksdb.bloom.filter.full.true.positive COUNT : 1048623 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 : 373 rocksdb.memtable.miss COUNT : 1048623 rocksdb.l0.hit COUNT : 41598 rocksdb.l1.hit COUNT : 11608 rocksdb.l2andup.hit COUNT : 995417 rocksdb.compaction.key.drop.new COUNT : 38200 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 : 2527745 rocksdb.number.keys.read COUNT : 1048996 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 2608632840 rocksdb.bytes.read COUNT : 1048996000 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 : 1360 rocksdb.no.file.errors COUNT : 0 rocksdb.stall.micros COUNT : 50191696 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 : 7243438510 rocksdb.compact.write.bytes COUNT : 7217465474 rocksdb.flush.write.bytes COUNT : 2576410919 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 : 19 rocksdb.number.superversion_acquires COUNT : 365 rocksdb.number.superversion_releases COUNT : 351 rocksdb.number.superversion_cleanups COUNT : 89 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 : 0 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 : 2555450368 rocksdb.memtable.garbage.bytes.at.flush COUNT : 825344 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 : 12770173574 rocksdb.non.last.level.read.count COUNT : 2942532 rocksdb.block.checksum.compute.count COUNT : 3012431 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 : 196.660361 P95 : 450.898806 P99 : 722.210867 P100 : 38739.000000 COUNT : 1048996 SUM : 239580405 rocksdb.db.write.micros P50 : 1.497188 P95 : 5.541218 P99 : 1044.225734 P100 : 250611.000000 COUNT : 2527745 SUM : 56703103 rocksdb.compaction.times.micros P50 : 1086666.666667 P95 : 2985835.000000 P99 : 2985835.000000 P100 : 2985835.000000 COUNT : 12 SUM : 16323720 rocksdb.compaction.times.cpu_micros P50 : 1064000.000000 P95 : 2956597.000000 P99 : 2956597.000000 P100 : 2956597.000000 COUNT : 12 SUM : 15620050 rocksdb.subcompaction.setup.times.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.table.sync.micros P50 : 841.000000 P95 : 3450.000000 P99 : 4210.000000 P100 : 4264.000000 COUNT : 38 SUM : 46531 rocksdb.compaction.outfile.sync.micros P50 : 956.000000 P95 : 2740.000000 P99 : 3860.000000 P100 : 4276.000000 COUNT : 36 SUM : 46034 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 : 201.304348 P95 : 1042.000000 P99 : 1912.000000 P100 : 1912.000000 COUNT : 52 SUM : 15679 rocksdb.table.open.io.micros P50 : 6789.847716 P95 : 11931.531532 P99 : 13940.900901 P100 : 33108.000000 COUNT : 1360 SUM : 9479470 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.653798 P95 : 177.053982 P99 : 246.275436 P100 : 11185.000000 COUNT : 1757576 SUM : 50092760 rocksdb.read.block.get.micros P50 : 151.968391 P95 : 249.306519 P99 : 546.959434 P100 : 21064.000000 COUNT : 1253574 SUM : 207653732 rocksdb.write.raw.block.micros P50 : 0.573049 P95 : 1.763724 P99 : 3.426261 P100 : 5808.000000 COUNT : 2372032 SUM : 5638749 rocksdb.numfiles.in.singlecompaction P50 : 3.500000 P95 : 23.000000 P99 : 23.000000 P100 : 23.000000 COUNT : 14 SUM : 72 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.592989 P95 : 2180.309307 P99 : 2756.172328 P100 : 250410.000000 COUNT : 208520 SUM : 50213871 rocksdb.sst.read.micros P50 : 5.460113 P95 : 233.728813 P99 : 422.249486 P100 : 20825.000000 COUNT : 2942677 SUM : 248378356 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 : 1000.000000 P95 : 1000.000000 P99 : 1000.000000 P100 : 1000.000000 COUNT : 1048996 SUM : 1048996000 rocksdb.bytes.per.write P50 : 1032.000000 P95 : 1032.000000 P99 : 1032.000000 P100 : 1032.000000 COUNT : 2527745 SUM : 2608632840 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 : 216060.606061 P95 : 350750.000000 P99 : 469991.000000 P100 : 469991.000000 COUNT : 38 SUM : 8154379 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