[2024-12-09 11:47:49.726078] Starting SPDK v25.01-pre git sha1 90d04af13 / DPDK 24.03.0 initialization... [2024-12-09 11:47:49.726393] [ 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_pid4183670 ] Set seed to 1733741269718892 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-12-09 11:47:49.875659] app.c: 919:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-12-09 11:47:49.981924] app.c: 612:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-12-09 11:47:49.981979] app.c: 613:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 4183670' to capture a snapshot of events at runtime. [2024-12-09 11:47:49.981993] app.c: 618:app_setup_trace: *NOTICE*: 'spdk_trace' without parameters will also work if this is the only [2024-12-09 11:47:49.982006] app.c: 619:app_setup_trace: *NOTICE*: SPDK application currently running. [2024-12-09 11:47:49.982016] app.c: 620:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid4183670 for offline analysis/debug. [2024-12-09 11:47:49.983232] reactor.c:1005:reactor_run: *NOTICE*: Reactor started on core 0 RocksDB: version 8.1.1 Date: Mon Dec 9 11:47:52 2024 CPU: 72 * Intel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz CPUCache: 25344 KB 2024/12/09-11:48:00 ... thread 0: (1000000,1000000) ops and (135924.6,135924.6) ops/second in (7.357020,7.357020) 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 628.69 MB 31.4 0.0 0.0 0.0 0.8 0.8 0.0 1.0 0.0 120.7 6.77 2.79 10 0.677 0 0 0.0 0.0 L1 1/0 60.52 MB 6.1 0.5 0.4 0.1 0.5 0.4 0.0 1.3 109.1 108.6 4.63 2.88 2 2.317 513K 2325 0.0 0.0 L2 6/2 320.28 MB 2.3 0.3 0.2 0.1 0.3 0.2 0.1 1.4 120.7 120.4 2.54 1.67 3 0.847 311K 957 0.0 0.0 L3 45/24 3.08 GB 1.4 3.4 2.4 1.0 3.2 2.2 0.0 1.3 100.6 93.9 34.65 18.66 11 3.150 2040K 90 0.0 0.0 L4 157/17 11.74 GB 1.1 1.9 1.4 0.5 1.8 1.3 0.7 1.3 104.0 98.5 19.15 11.50 7 2.735 66K 0 0.0 0.0 L5 116/0 9.17 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 333/47 24.96 GB 0.0 6.1 4.4 1.7 6.6 4.9 0.9 8.3 92.9 99.9 67.73 37.49 33 2.053 2931K 3372 0.0 0.0 Int 0/0 0.00 KB 0.0 6.1 4.4 1.7 6.6 4.9 0.9 8.3 92.9 99.9 67.73 37.49 33 2.053 2931K 3372 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 6.1 4.4 1.7 5.8 4.1 0.0 0.0 103.2 97.6 60.96 34.70 23 2.651 2931K 3372 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 0.8 0.8 0.0 0.0 0.0 120.7 6.77 2.79 10 0.677 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): 7.4 total, 7.4 interval Flush(GB): cumulative 0.798, interval 0.798 AddFile(GB): cumulative 0.000, interval 0.000 AddFile(Total Files): cumulative 0, interval 0 AddFile(L0 Files): cumulative 0, interval 0 AddFile(Keys): cumulative 0, interval 0 Cumulative compaction: 6.61 GB write, 909.55 MB/s write, 6.14 GB read, 845.59 MB/s read, 67.7 seconds Interval compaction: 6.61 GB write, 919.53 MB/s write, 6.14 GB read, 854.87 MB/s read, 67.7 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: 21, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 21, interval: 21 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 104025 Average: 51.6888 StdDev: 591.10 Min: 1 Median: 2.1763 Max: 49028 Percentiles: P50: 2.18 P75: 3.27 P99: 1069.88 P99.9: 5469.53 P99.99: 27597.50 ------------------------------------------------------ [ 0, 1 ] 2006 1.928% 1.928% ( 1, 2 ] 45038 43.295% 45.224% ######### ( 2, 3 ] 28182 27.092% 72.315% ##### ( 3, 4 ] 10358 9.957% 82.273% ## ( 4, 6 ] 11131 10.700% 92.973% ## ( 6, 10 ] 2818 2.709% 95.682% # ( 10, 15 ] 725 0.697% 96.379% ( 15, 22 ] 113 0.109% 96.487% ( 22, 34 ] 11 0.011% 96.498% ( 34, 51 ] 3 0.003% 96.501% ( 51, 76 ] 10 0.010% 96.510% ( 76, 110 ] 2 0.002% 96.512% ( 110, 170 ] 24 0.023% 96.535% ( 170, 250 ] 132 0.127% 96.662% ( 250, 380 ] 387 0.372% 97.034% ( 380, 580 ] 930 0.894% 97.928% ( 580, 870 ] 900 0.865% 98.794% ( 870, 1300 ] 462 0.444% 99.238% ( 1300, 1900 ] 162 0.156% 99.393% ( 1900, 2900 ] 198 0.190% 99.584% ( 2900, 4400 ] 293 0.282% 99.865% ( 4400, 6600 ] 74 0.071% 99.937% ( 6600, 9900 ] 22 0.021% 99.958% ( 9900, 14000 ] 3 0.003% 99.961% ( 14000, 22000 ] 25 0.024% 99.985% ( 22000, 33000 ] 11 0.011% 99.995% ( 33000, 50000 ] 7 0.007% 100.002% ** Level 1 read latency histogram (micros): Count: 82297 Average: 16.3156 StdDev: 288.73 Min: 1 Median: 2.2467 Max: 31468 Percentiles: P50: 2.25 P75: 3.23 P99: 21.06 P99.9: 3121.26 P99.99: 13811.65 ------------------------------------------------------ [ 0, 1 ] 1064 1.293% 1.293% ( 1, 2 ] 34028 41.348% 42.641% ######## ( 2, 3 ] 24550 29.831% 72.472% ###### ( 3, 4 ] 8926 10.846% 83.318% ## ( 4, 6 ] 10110 12.285% 95.603% ## ( 6, 10 ] 2267 2.755% 98.357% # ( 10, 15 ] 471 0.572% 98.929% ( 15, 22 ] 67 0.081% 99.011% ( 22, 34 ] 8 0.010% 99.021% ( 34, 51 ] 11 0.013% 99.034% ( 51, 76 ] 18 0.022% 99.056% ( 110, 170 ] 4 0.005% 99.061% ( 170, 250 ] 28 0.034% 99.095% ( 250, 380 ] 77 0.094% 99.188% ( 380, 580 ] 185 0.225% 99.413% ( 580, 870 ] 214 0.260% 99.673% ( 870, 1300 ] 103 0.125% 99.798% ( 1300, 1900 ] 35 0.043% 99.841% ( 1900, 2900 ] 40 0.049% 99.889% ( 2900, 4400 ] 59 0.072% 99.961% ( 4400, 6600 ] 15 0.018% 99.979% ( 6600, 9900 ] 4 0.005% 99.984% ( 9900, 14000 ] 5 0.006% 99.990% ( 14000, 22000 ] 5 0.006% 99.996% ( 22000, 33000 ] 3 0.004% 100.000% ** Level 2 read latency histogram (micros): Count: 582896 Average: 17.8387 StdDev: 324.77 Min: 1 Median: 2.2770 Max: 49880 Percentiles: P50: 2.28 P75: 3.29 P99: 13.61 P99.9: 1345.60 P99.99: 2442.78 ------------------------------------------------------ [ 0, 1 ] 5485 0.941% 0.941% ( 1, 2 ] 237429 40.733% 41.674% ######## ( 2, 3 ] 175198 30.056% 71.730% ###### ( 3, 4 ] 65454 11.229% 82.959% ## ( 4, 6 ] 71998 12.352% 95.311% ## ( 6, 10 ] 17950 3.079% 98.390% # ( 10, 15 ] 4921 0.844% 99.235% ( 15, 22 ] 825 0.142% 99.376% ( 22, 34 ] 102 0.017% 99.394% ( 34, 51 ] 145 0.025% 99.419% ( 51, 76 ] 118 0.020% 99.439% ( 76, 110 ] 43 0.007% 99.446% ( 110, 170 ] 63 0.011% 99.457% ( 170, 250 ] 155 0.027% 99.484% ( 250, 380 ] 470 0.081% 99.564% ( 380, 580 ] 843 0.145% 99.709% ( 580, 870 ] 711 0.122% 99.831% ( 870, 1300 ] 380 0.065% 99.896% ( 1300, 1900 ] 304 0.052% 99.948% ( 1900, 2900 ] 449 0.077% 100.025% ( 2900, 4400 ] 562 0.096% 100.122% ( 4400, 6600 ] 209 0.036% 100.157% ( 6600, 9900 ] 89 0.015% 100.173% ( 9900, 14000 ] 20 0.003% 100.176% ( 14000, 22000 ] 47 0.008% 100.184% ( 22000, 33000 ] 15 0.003% 100.187% ( 33000, 50000 ] 8 0.001% 100.188% ** Level 3 read latency histogram (micros): Count: 629341 Average: 23.0167 StdDev: 389.69 Min: 1 Median: 2.2951 Max: 54259 Percentiles: P50: 2.30 P75: 3.30 P99: 51.09 P99.9: 2135.65 P99.99: 3239.52 ------------------------------------------------------ [ 0, 1 ] 5323 0.846% 0.846% ( 1, 2 ] 252176 40.070% 40.916% ######## ( 2, 3 ] 193727 30.783% 71.698% ###### ( 3, 4 ] 69883 11.104% 82.802% ## ( 4, 6 ] 77181 12.264% 95.066% ## ( 6, 10 ] 19426 3.087% 98.153% # ( 10, 15 ] 4454 0.708% 98.861% ( 15, 22 ] 625 0.099% 98.960% ( 22, 34 ] 91 0.014% 98.974% ( 34, 51 ] 163 0.026% 99.000% ( 51, 76 ] 156 0.025% 99.025% ( 76, 110 ] 41 0.007% 99.032% ( 110, 170 ] 64 0.010% 99.042% ( 170, 250 ] 245 0.039% 99.081% ( 250, 380 ] 730 0.116% 99.197% ( 380, 580 ] 1564 0.249% 99.445% ( 580, 870 ] 1539 0.245% 99.690% ( 870, 1300 ] 749 0.119% 99.809% ( 1300, 1900 ] 452 0.072% 99.881% ( 1900, 2900 ] 529 0.084% 99.965% ( 2900, 4400 ] 716 0.114% 100.078% ( 4400, 6600 ] 225 0.036% 100.114% ( 6600, 9900 ] 108 0.017% 100.131% ( 9900, 14000 ] 34 0.005% 100.137% ( 14000, 22000 ] 76 0.012% 100.149% ( 22000, 33000 ] 42 0.007% 100.155% ( 33000, 50000 ] 7 0.001% 100.157% ( 50000, 75000 ] 1 0.000% 100.157% ** Level 4 read latency histogram (micros): Count: 299354 Average: 51.2569 StdDev: 595.13 Min: 1 Median: 2.3200 Max: 65044 Percentiles: P50: 2.32 P75: 3.42 P99: 918.62 P99.9: 3864.29 P99.99: 4336.96 ------------------------------------------------------ [ 0, 1 ] 3197 1.068% 1.068% ( 1, 2 ] 117671 39.308% 40.376% ######## ( 2, 3 ] 90041 30.078% 70.455% ###### ( 3, 4 ] 32764 10.945% 81.400% ## ( 4, 6 ] 35157 11.744% 93.144% ## ( 6, 10 ] 8537 2.852% 95.996% # ( 10, 15 ] 1937 0.647% 96.643% ( 15, 22 ] 286 0.096% 96.738% ( 22, 34 ] 44 0.015% 96.753% ( 34, 51 ] 98 0.033% 96.786% ( 51, 76 ] 63 0.021% 96.807% ( 76, 110 ] 20 0.007% 96.813% ( 110, 170 ] 111 0.037% 96.851% ( 170, 250 ] 352 0.118% 96.968% ( 250, 380 ] 1184 0.396% 97.364% ( 380, 580 ] 2406 0.804% 98.167% ( 580, 870 ] 2363 0.789% 98.957% ( 870, 1300 ] 1145 0.382% 99.339% ( 1300, 1900 ] 527 0.176% 99.515% ( 1900, 2900 ] 602 0.201% 99.716% ( 2900, 4400 ] 855 0.286% 100.002% ( 4400, 6600 ] 256 0.086% 100.088% ( 6600, 9900 ] 66 0.022% 100.110% ( 9900, 14000 ] 22 0.007% 100.117% ( 14000, 22000 ] 55 0.018% 100.135% ( 22000, 33000 ] 39 0.013% 100.148% ( 33000, 50000 ] 11 0.004% 100.152% ( 50000, 75000 ] 4 0.001% 100.153% ** Level 5 read latency histogram (micros): Count: 7254 Average: 1288.8216 StdDev: 2601.16 Min: 102 Median: 676.8322 Max: 65583 Percentiles: P50: 676.83 P75: 1189.17 P99: 8146.00 P99.9: 41068.20 P99.99: 65583.00 ------------------------------------------------------ ( 76, 110 ] 3 0.041% 0.041% ( 110, 170 ] 73 1.006% 1.048% ( 170, 250 ] 252 3.474% 4.522% # ( 250, 380 ] 877 12.090% 16.612% ## ( 380, 580 ] 1837 25.324% 41.935% ##### ( 580, 870 ] 1752 24.152% 66.088% ##### ( 870, 1300 ] 871 12.007% 78.095% ## ( 1300, 1900 ] 383 5.280% 83.375% # ( 1900, 2900 ] 410 5.652% 89.027% # ( 2900, 4400 ] 525 7.237% 96.264% # ( 4400, 6600 ] 183 2.523% 98.787% # ( 6600, 9900 ] 33 0.455% 99.242% ( 9900, 14000 ] 10 0.138% 99.380% ( 14000, 22000 ] 19 0.262% 99.642% ( 22000, 33000 ] 14 0.193% 99.835% ( 33000, 50000 ] 10 0.138% 99.972% ( 50000, 75000 ] 2 0.028% 100.000% ** DB Stats ** Uptime(secs): 7.4 total, 7.4 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 132.28 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:2.654 H:M:S, 35.7 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 133.72 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:2.654 H:M:S, 36.1 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 10 num-running-flushes: 1 2024/12/09-11:48:05 ... thread 0: (1000000,2000000) ops and (194269.6,159942.4) ops/second in (5.147485,12.504505) 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/4 1.59 GB 137.6 1.2 0.0 1.2 2.9 1.8 0.0 1.7 55.6 140.2 21.48 11.06 28 0.767 1213K 6788 0.0 0.0 L1 0/0 0.00 KB 0.0 0.5 0.4 0.1 0.5 0.4 0.0 1.3 109.1 108.6 4.63 2.88 2 2.317 513K 2325 0.0 0.0 L2 2/1 120.37 MB 0.6 0.3 0.2 0.1 0.3 0.2 0.2 1.4 120.7 120.4 2.54 1.67 3 0.847 311K 957 0.0 0.0 L3 36/19 2.15 GB 1.0 4.4 2.5 1.9 4.2 2.3 0.1 1.7 107.8 101.9 42.26 23.79 14 3.018 2927K 6279 0.0 0.0 L4 137/17 9.61 GB 0.9 4.6 2.3 2.2 4.1 1.9 1.0 1.8 122.1 110.4 38.21 23.34 17 2.248 900K 0 0.0 0.0 L5 152/0 12.12 GB 0.1 0.0 0.0 0.0 0.0 0.0 3.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 337/41 25.59 GB 0.0 11.0 5.5 5.5 12.1 6.6 4.2 6.8 102.9 113.1 109.12 62.73 64 1.705 5866K 16K 0.0 0.0 Int 0/0 0.00 KB 0.0 11.0 5.5 5.5 12.1 6.6 4.2 6.8 102.9 113.1 109.12 62.73 64 1.705 5866K 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 11.0 5.5 5.5 10.3 4.8 0.0 0.0 115.0 107.8 97.62 56.98 40 2.440 5866K 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 158.5 11.50 5.75 24 0.479 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.6 total, 12.5 interval Flush(GB): cumulative 1.781, interval 1.781 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: 12.05 GB write, 980.58 MB/s write, 10.96 GB read, 892.04 MB/s read, 109.1 seconds Interval compaction: 12.05 GB write, 986.91 MB/s write, 10.96 GB read, 897.80 MB/s read, 109.1 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: 31, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 31, interval: 31 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 443825 Average: 22.6042 StdDev: 314.95 Min: 1 Median: 1.9553 Max: 49028 Percentiles: P50: 1.96 P75: 2.88 P99: 501.85 P99.9: 3220.17 P99.99: 4861.09 ------------------------------------------------------ [ 0, 1 ] 15083 3.398% 3.398% # ( 1, 2 ] 216504 48.781% 52.180% ########## ( 2, 3 ] 114863 25.880% 78.060% ##### ( 3, 4 ] 37826 8.523% 86.583% ## ( 4, 6 ] 37510 8.452% 95.034% ## ( 6, 10 ] 9935 2.238% 97.273% ( 10, 15 ] 2347 0.529% 97.802% ( 15, 22 ] 322 0.073% 97.874% ( 22, 34 ] 35 0.008% 97.882% ( 34, 51 ] 24 0.005% 97.887% ( 51, 76 ] 19 0.004% 97.892% ( 76, 110 ] 24 0.005% 97.897% ( 110, 170 ] 555 0.125% 98.022% ( 170, 250 ] 1676 0.378% 98.400% ( 250, 380 ] 1483 0.334% 98.734% ( 380, 580 ] 1938 0.437% 99.171% ( 580, 870 ] 1674 0.377% 99.548% ( 870, 1300 ] 850 0.192% 99.739% ( 1300, 1900 ] 286 0.064% 99.804% ( 1900, 2900 ] 326 0.073% 99.877% ( 2900, 4400 ] 474 0.107% 99.984% ( 4400, 6600 ] 127 0.029% 100.013% ( 6600, 9900 ] 30 0.007% 100.019% ( 9900, 14000 ] 5 0.001% 100.021% ( 14000, 22000 ] 29 0.007% 100.027% ( 22000, 33000 ] 11 0.002% 100.030% ( 33000, 50000 ] 7 0.002% 100.031% ** Level 1 read latency histogram (micros): Count: 112216 Average: 17.5051 StdDev: 269.82 Min: 1 Median: 2.1806 Max: 31468 Percentiles: P50: 2.18 P75: 3.08 P99: 304.74 P99.9: 3126.62 P99.99: 11358.29 ------------------------------------------------------ [ 0, 1 ] 1845 1.644% 1.644% ( 1, 2 ] 48286 43.030% 44.674% ######### ( 2, 3 ] 33088 29.486% 74.160% ###### ( 3, 4 ] 11337 10.103% 84.262% ## ( 4, 6 ] 12335 10.992% 95.255% ## ( 6, 10 ] 3059 2.726% 97.981% # ( 10, 15 ] 631 0.562% 98.543% ( 15, 22 ] 88 0.078% 98.621% ( 22, 34 ] 8 0.007% 98.629% ( 34, 51 ] 12 0.011% 98.639% ( 51, 76 ] 21 0.019% 98.658% ( 76, 110 ] 3 0.003% 98.661% ( 110, 170 ] 78 0.070% 98.730% ( 170, 250 ] 222 0.198% 98.928% ( 250, 380 ] 192 0.171% 99.099% ( 380, 580 ] 284 0.253% 99.352% ( 580, 870 ] 304 0.271% 99.623% ( 870, 1300 ] 167 0.149% 99.772% ( 1300, 1900 ] 69 0.061% 99.833% ( 1900, 2900 ] 63 0.056% 99.889% ( 2900, 4400 ] 78 0.070% 99.959% ( 4400, 6600 ] 25 0.022% 99.981% ( 6600, 9900 ] 8 0.007% 99.988% ( 9900, 14000 ] 5 0.004% 99.993% ( 14000, 22000 ] 6 0.005% 99.998% ( 22000, 33000 ] 3 0.003% 100.001% ** Level 2 read latency histogram (micros): Count: 602892 Average: 17.9656 StdDev: 321.40 Min: 1 Median: 2.2810 Max: 49880 Percentiles: P50: 2.28 P75: 3.30 P99: 13.93 P99.9: 1423.95 P99.99: 2520.88 ------------------------------------------------------ [ 0, 1 ] 5591 0.927% 0.927% ( 1, 2 ] 244776 40.600% 41.528% ######## ( 2, 3 ] 181786 30.152% 71.680% ###### ( 3, 4 ] 67776 11.242% 82.922% ## ( 4, 6 ] 74505 12.358% 95.280% ## ( 6, 10 ] 18461 3.062% 98.342% # ( 10, 15 ] 5045 0.837% 99.179% ( 15, 22 ] 837 0.139% 99.317% ( 22, 34 ] 103 0.017% 99.335% ( 34, 51 ] 148 0.025% 99.359% ( 51, 76 ] 119 0.020% 99.379% ( 76, 110 ] 43 0.007% 99.386% ( 110, 170 ] 85 0.014% 99.400% ( 170, 250 ] 275 0.046% 99.446% ( 250, 380 ] 554 0.092% 99.538% ( 380, 580 ] 924 0.153% 99.691% ( 580, 870 ] 783 0.130% 99.821% ( 870, 1300 ] 412 0.068% 99.889% ( 1300, 1900 ] 320 0.053% 99.942% ( 1900, 2900 ] 465 0.077% 100.019% ( 2900, 4400 ] 583 0.097% 100.116% ( 4400, 6600 ] 218 0.036% 100.152% ( 6600, 9900 ] 90 0.015% 100.167% ( 9900, 14000 ] 20 0.003% 100.170% ( 14000, 22000 ] 47 0.008% 100.178% ( 22000, 33000 ] 15 0.002% 100.181% ( 33000, 50000 ] 8 0.001% 100.182% ** Level 3 read latency histogram (micros): Count: 1226478 Average: 18.1192 StdDev: 301.65 Min: 1 Median: 2.2609 Max: 54259 Percentiles: P50: 2.26 P75: 3.19 P99: 178.94 P99.9: 1417.26 P99.99: 2604.70 ------------------------------------------------------ [ 0, 1 ] 9291 0.758% 0.758% ( 1, 2 ] 504285 41.117% 41.874% ######## ( 2, 3 ] 381992 31.145% 73.019% ###### ( 3, 4 ] 129710 10.576% 83.595% ## ( 4, 6 ] 140629 11.466% 95.061% ## ( 6, 10 ] 36725 2.994% 98.056% # ( 10, 15 ] 8525 0.695% 98.751% ( 15, 22 ] 1182 0.096% 98.847% ( 22, 34 ] 145 0.012% 98.859% ( 34, 51 ] 265 0.022% 98.881% ( 51, 76 ] 263 0.021% 98.902% ( 76, 110 ] 92 0.008% 98.910% ( 110, 170 ] 824 0.067% 98.977% ( 170, 250 ] 2553 0.208% 99.185% ( 250, 380 ] 2288 0.187% 99.371% ( 380, 580 ] 2804 0.229% 99.600% ( 580, 870 ] 2392 0.195% 99.795% ( 870, 1300 ] 1155 0.094% 99.889% ( 1300, 1900 ] 673 0.055% 99.944% ( 1900, 2900 ] 798 0.065% 100.009% ( 2900, 4400 ] 1065 0.087% 100.096% ( 4400, 6600 ] 339 0.028% 100.124% ( 6600, 9900 ] 130 0.011% 100.134% ( 9900, 14000 ] 38 0.003% 100.137% ( 14000, 22000 ] 86 0.007% 100.144% ( 22000, 33000 ] 43 0.004% 100.148% ( 33000, 50000 ] 7 0.001% 100.148% ( 50000, 75000 ] 1 0.000% 100.149% ** Level 4 read latency histogram (micros): Count: 674644 Average: 39.8770 StdDev: 437.64 Min: 1 Median: 2.3512 Max: 65044 Percentiles: P50: 2.35 P75: 3.50 P99: 732.08 P99.9: 3325.50 P99.99: 3994.20 ------------------------------------------------------ [ 0, 1 ] 5918 0.877% 0.877% ( 1, 2 ] 259879 38.521% 39.398% ######## ( 2, 3 ] 203664 30.188% 69.586% ###### ( 3, 4 ] 73204 10.851% 80.437% ## ( 4, 6 ] 79978 11.855% 92.292% ## ( 6, 10 ] 19554 2.898% 95.191% # ( 10, 15 ] 4518 0.670% 95.860% ( 15, 22 ] 642 0.095% 95.955% ( 22, 34 ] 73 0.011% 95.966% ( 34, 51 ] 146 0.022% 95.988% ( 51, 76 ] 149 0.022% 96.010% ( 76, 110 ] 135 0.020% 96.030% ( 110, 170 ] 2148 0.318% 96.348% ( 170, 250 ] 5952 0.882% 97.231% ( 250, 380 ] 4683 0.694% 97.925% ( 380, 580 ] 5104 0.757% 98.681% ( 580, 870 ] 4101 0.608% 99.289% ( 870, 1300 ] 1894 0.281% 99.570% ( 1300, 1900 ] 862 0.128% 99.698% ( 1900, 2900 ] 979 0.145% 99.843% ( 2900, 4400 ] 1362 0.202% 100.045% ( 4400, 6600 ] 418 0.062% 100.107% ( 6600, 9900 ] 98 0.015% 100.121% ( 9900, 14000 ] 29 0.004% 100.125% ( 14000, 22000 ] 66 0.010% 100.135% ( 22000, 33000 ] 40 0.006% 100.141% ( 33000, 50000 ] 11 0.002% 100.143% ( 50000, 75000 ] 4 0.001% 100.143% ** Level 5 read latency histogram (micros): Count: 18964 Average: 802.8476 StdDev: 1764.25 Min: 91 Median: 402.5086 Max: 65583 Percentiles: P50: 402.51 P75: 753.09 P99: 5872.36 P99.9: 26742.57 P99.99: 48476.12 ------------------------------------------------------ ( 76, 110 ] 59 0.311% 0.311% ( 110, 170 ] 1511 7.968% 8.279% ## ( 170, 250 ] 4297 22.659% 30.938% ##### ( 250, 380 ] 3222 16.990% 47.928% ### ( 380, 580 ] 3492 18.414% 66.341% #### ( 580, 870 ] 2751 14.506% 80.848% ### ( 870, 1300 ] 1364 7.193% 88.040% # ( 1300, 1900 ] 545 2.874% 90.914% # ( 1900, 2900 ] 584 3.080% 93.994% # ( 2900, 4400 ] 770 4.060% 98.054% # ( 4400, 6600 ] 268 1.413% 99.467% ( 6600, 9900 ] 45 0.237% 99.705% ( 9900, 14000 ] 10 0.053% 99.757% ( 14000, 22000 ] 21 0.111% 99.868% ( 22000, 33000 ] 14 0.074% 99.942% ( 33000, 50000 ] 10 0.053% 99.995% ( 50000, 75000 ] 2 0.011% 100.005% ** DB Stats ** Uptime(secs): 12.6 total, 5.1 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 156.38 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:3.540 H:M:S, 28.1 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 191.20 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:0.886 H:M:S, 17.2 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 9 num-running-flushes: 1 2024/12/09-11:48:09 ... thread 0: (1000000,3000000) ops and (222447.4,176471.1) ops/second in (4.495445,16.999950) 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/13 2.63 GB 68.9 1.9 0.0 1.9 4.7 2.8 0.0 1.7 66.5 164.8 29.31 17.06 47 0.624 1979K 10K 0.0 0.0 L1 0/0 0.00 KB 0.0 0.5 0.4 0.1 0.5 0.4 0.0 1.3 109.1 108.6 4.63 2.88 2 2.317 513K 2325 0.0 0.0 L2 1/0 60.07 MB 0.6 0.3 0.2 0.1 0.3 0.2 0.2 1.4 120.7 120.4 2.54 1.67 3 0.847 311K 957 0.0 0.0 L3 17/0 954.85 MB 1.0 5.3 2.6 2.7 5.0 2.3 0.1 1.9 112.3 106.7 48.03 27.85 15 3.202 3778K 22K 0.0 0.0 L4 147/0 9.76 GB 1.0 7.7 3.1 4.6 6.7 2.1 1.5 2.1 134.4 116.0 59.01 36.95 29 2.035 1845K 5380 0.0 0.0 L5 160/0 12.61 GB 0.1 0.0 0.0 0.0 0.0 0.0 3.4 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 342/13 25.99 GB 0.0 15.7 6.3 9.4 17.2 7.8 5.2 6.1 112.1 122.7 143.53 86.41 96 1.495 8429K 41K 0.0 0.0 Int 0/0 0.00 KB 0.0 15.7 6.3 9.4 17.2 7.8 5.2 6.1 112.1 122.7 143.53 86.41 96 1.495 8429K 41K 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 15.7 6.3 9.4 14.4 5.0 0.0 0.0 126.1 115.4 127.58 77.66 56 2.278 8429K 41K 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 181.3 15.95 8.75 40 0.399 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): 17.1 total, 17.0 interval Flush(GB): cumulative 2.825, interval 2.825 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: 17.20 GB write, 1031.05 MB/s write, 15.71 GB read, 941.77 MB/s read, 143.5 seconds Interval compaction: 17.20 GB write, 1035.94 MB/s write, 15.71 GB read, 946.24 MB/s read, 143.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: 35, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 35, interval: 35 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 637887 Average: 26.0380 StdDev: 289.31 Min: 0 Median: 1.8337 Max: 49028 Percentiles: P50: 1.83 P75: 2.78 P99: 507.71 P99.9: 2888.25 P99.99: 4281.39 ------------------------------------------------------ [ 0, 1 ] 50620 7.936% 7.936% ## ( 1, 2 ] 321849 50.455% 58.391% ########## ( 2, 3 ] 136085 21.334% 79.725% #### ( 3, 4 ] 44160 6.923% 86.648% # ( 4, 6 ] 42447 6.654% 93.302% # ( 6, 10 ] 11064 1.734% 95.036% ( 10, 15 ] 2702 0.424% 95.460% ( 15, 22 ] 364 0.057% 95.517% ( 22, 34 ] 41 0.006% 95.524% ( 34, 51 ] 26 0.004% 95.528% ( 51, 76 ] 24 0.004% 95.531% ( 76, 110 ] 209 0.033% 95.564% ( 110, 170 ] 4854 0.761% 96.325% ( 170, 250 ] 11099 1.740% 98.065% ( 250, 380 ] 3772 0.591% 98.656% ( 380, 580 ] 3436 0.539% 99.195% ( 580, 870 ] 2508 0.393% 99.588% ( 870, 1300 ] 1132 0.177% 99.766% ( 1300, 1900 ] 364 0.057% 99.823% ( 1900, 2900 ] 501 0.079% 99.901% ( 2900, 4400 ] 617 0.097% 99.998% ( 4400, 6600 ] 151 0.024% 100.022% ( 6600, 9900 ] 38 0.006% 100.028% ( 9900, 14000 ] 5 0.001% 100.028% ( 14000, 22000 ] 30 0.005% 100.033% ( 22000, 33000 ] 15 0.002% 100.035% ( 33000, 50000 ] 7 0.001% 100.037% ** Level 1 read latency histogram (micros): Count: 113504 Average: 18.1278 StdDev: 270.33 Min: 1 Median: 2.1859 Max: 31468 Percentiles: P50: 2.19 P75: 3.10 P99: 335.82 P99.9: 3149.93 P99.99: 11252.67 ------------------------------------------------------ [ 0, 1 ] 1852 1.632% 1.632% ( 1, 2 ] 48681 42.889% 44.521% ######### ( 2, 3 ] 33451 29.471% 73.992% ###### ( 3, 4 ] 11464 10.100% 84.092% ## ( 4, 6 ] 12474 10.990% 95.082% ## ( 6, 10 ] 3092 2.724% 97.806% # ( 10, 15 ] 647 0.570% 98.376% ( 15, 22 ] 91 0.080% 98.456% ( 22, 34 ] 8 0.007% 98.463% ( 34, 51 ] 13 0.011% 98.475% ( 51, 76 ] 21 0.019% 98.493% ( 76, 110 ] 5 0.004% 98.498% ( 110, 170 ] 111 0.098% 98.596% ( 170, 250 ] 319 0.281% 98.877% ( 250, 380 ] 212 0.187% 99.063% ( 380, 580 ] 314 0.277% 99.340% ( 580, 870 ] 308 0.271% 99.611% ( 870, 1300 ] 171 0.151% 99.762% ( 1300, 1900 ] 72 0.063% 99.826% ( 1900, 2900 ] 71 0.063% 99.888% ( 2900, 4400 ] 81 0.071% 99.959% ( 4400, 6600 ] 25 0.022% 99.981% ( 6600, 9900 ] 8 0.007% 99.989% ( 9900, 14000 ] 5 0.004% 99.993% ( 14000, 22000 ] 6 0.005% 99.998% ( 22000, 33000 ] 3 0.003% 100.001% ** Level 2 read latency histogram (micros): Count: 603235 Average: 18.1605 StdDev: 321.69 Min: 1 Median: 2.2819 Max: 49880 Percentiles: P50: 2.28 P75: 3.30 P99: 14.27 P99.9: 1444.90 P99.99: 2536.84 ------------------------------------------------------ [ 0, 1 ] 5591 0.927% 0.927% ( 1, 2 ] 244776 40.577% 41.504% ######## ( 2, 3 ] 181786 30.135% 71.639% ###### ( 3, 4 ] 67776 11.235% 82.875% ## ( 4, 6 ] 74505 12.351% 95.226% ## ( 6, 10 ] 18461 3.060% 98.286% # ( 10, 15 ] 5045 0.836% 99.122% ( 15, 22 ] 837 0.139% 99.261% ( 22, 34 ] 103 0.017% 99.278% ( 34, 51 ] 148 0.025% 99.303% ( 51, 76 ] 119 0.020% 99.322% ( 76, 110 ] 44 0.007% 99.330% ( 110, 170 ] 159 0.026% 99.356% ( 170, 250 ] 435 0.072% 99.428% ( 250, 380 ] 596 0.099% 99.527% ( 380, 580 ] 952 0.158% 99.685% ( 580, 870 ] 805 0.133% 99.818% ( 870, 1300 ] 416 0.069% 99.887% ( 1300, 1900 ] 322 0.053% 99.940% ( 1900, 2900 ] 469 0.078% 100.018% ( 2900, 4400 ] 588 0.097% 100.116% ( 4400, 6600 ] 219 0.036% 100.152% ( 6600, 9900 ] 90 0.015% 100.167% ( 9900, 14000 ] 20 0.003% 100.170% ( 14000, 22000 ] 47 0.008% 100.178% ( 22000, 33000 ] 15 0.002% 100.181% ( 33000, 50000 ] 8 0.001% 100.182% ** Level 3 read latency histogram (micros): Count: 1420539 Average: 18.0219 StdDev: 291.66 Min: 1 Median: 2.2745 Max: 54259 Percentiles: P50: 2.27 P75: 3.23 P99: 211.00 P99.9: 1326.84 P99.99: 2527.30 ------------------------------------------------------ [ 0, 1 ] 11007 0.775% 0.775% ( 1, 2 ] 578146 40.699% 41.474% ######## ( 2, 3 ] 441275 31.064% 72.538% ###### ( 3, 4 ] 151803 10.686% 83.224% ## ( 4, 6 ] 164995 11.615% 94.839% ## ( 6, 10 ] 42679 3.004% 97.843% # ( 10, 15 ] 9924 0.699% 98.542% ( 15, 22 ] 1392 0.098% 98.640% ( 22, 34 ] 169 0.012% 98.652% ( 34, 51 ] 311 0.022% 98.674% ( 51, 76 ] 308 0.022% 98.696% ( 76, 110 ] 137 0.010% 98.705% ( 110, 170 ] 1816 0.128% 98.833% ( 170, 250 ] 4628 0.326% 99.159% ( 250, 380 ] 2985 0.210% 99.369% ( 380, 580 ] 3337 0.235% 99.604% ( 580, 870 ] 2830 0.199% 99.803% ( 870, 1300 ] 1343 0.095% 99.898% ( 1300, 1900 ] 748 0.053% 99.950% ( 1900, 2900 ] 899 0.063% 100.014% ( 2900, 4400 ] 1184 0.083% 100.097% ( 4400, 6600 ] 370 0.026% 100.123% ( 6600, 9900 ] 142 0.010% 100.133% ( 9900, 14000 ] 40 0.003% 100.136% ( 14000, 22000 ] 89 0.006% 100.142% ( 22000, 33000 ] 45 0.003% 100.145% ( 33000, 50000 ] 8 0.001% 100.146% ( 50000, 75000 ] 1 0.000% 100.146% ** Level 4 read latency histogram (micros): Count: 1222236 Average: 31.3457 StdDev: 355.05 Min: 0 Median: 2.3752 Max: 65044 Percentiles: P50: 2.38 P75: 3.54 P99: 529.02 P99.9: 2007.86 P99.99: 2810.79 ------------------------------------------------------ [ 0, 1 ] 9991 0.817% 0.817% ( 1, 2 ] 462299 37.824% 38.641% ######## ( 2, 3 ] 369975 30.270% 68.912% ###### ( 3, 4 ] 137810 11.275% 80.187% ## ( 4, 6 ] 148902 12.183% 92.370% ## ( 6, 10 ] 36582 2.993% 95.363% # ( 10, 15 ] 8956 0.733% 96.096% ( 15, 22 ] 1185 0.097% 96.193% ( 22, 34 ] 129 0.011% 96.203% ( 34, 51 ] 239 0.020% 96.223% ( 51, 76 ] 263 0.022% 96.244% ( 76, 110 ] 311 0.025% 96.270% ( 110, 170 ] 6241 0.511% 96.780% ( 170, 250 ] 14350 1.174% 97.954% ( 250, 380 ] 7393 0.605% 98.559% ( 380, 580 ] 7231 0.592% 99.151% ( 580, 870 ] 5427 0.444% 99.595% ( 870, 1300 ] 2455 0.201% 99.796% ( 1300, 1900 ] 1127 0.092% 99.888% ( 1900, 2900 ] 1370 0.112% 100.000% ( 2900, 4400 ] 1754 0.144% 100.144% ( 4400, 6600 ] 516 0.042% 100.186% ( 6600, 9900 ] 132 0.011% 100.197% ( 9900, 14000 ] 41 0.003% 100.200% ( 14000, 22000 ] 81 0.007% 100.207% ( 22000, 33000 ] 46 0.004% 100.210% ( 33000, 50000 ] 11 0.001% 100.211% ( 50000, 75000 ] 4 0.000% 100.211% ** Level 5 read latency histogram (micros): Count: 31942 Average: 622.1845 StdDev: 1422.69 Min: 91 Median: 285.2470 Max: 65583 Percentiles: P50: 285.25 P75: 569.84 P99: 5062.75 P99.9: 19112.00 P99.99: 44569.86 ------------------------------------------------------ ( 76, 110 ] 149 0.466% 0.466% ( 110, 170 ] 4282 13.406% 13.872% ### ( 170, 250 ] 10228 32.021% 45.893% ###### ( 250, 380 ] 4839 15.149% 61.042% ### ( 380, 580 ] 4697 14.705% 75.747% ### ( 580, 870 ] 3451 10.804% 86.551% ## ( 870, 1300 ] 1630 5.103% 91.654% # ( 1300, 1900 ] 621 1.944% 93.598% ( 1900, 2900 ] 716 2.242% 95.839% ( 2900, 4400 ] 918 2.874% 98.713% # ( 4400, 6600 ] 304 0.952% 99.665% ( 6600, 9900 ] 51 0.160% 99.825% ( 9900, 14000 ] 10 0.031% 99.856% ( 14000, 22000 ] 22 0.069% 99.925% ( 22000, 33000 ] 14 0.044% 99.969% ( 33000, 50000 ] 10 0.031% 100.000% ( 50000, 75000 ] 2 0.006% 100.006% ** DB Stats ** Uptime(secs): 17.1 total, 4.5 interval Cumulative writes: 0 writes, 3000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 2.88 GB, 172.84 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:4.135 H:M:S, 24.2 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 218.93 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.596 H:M:S, 13.3 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 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: 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] readwhilewriting : 541.680 micros/op 7366 ops/sec 20.226 seconds 148996 operations; 7.1 MB/s (37999 of 37999 found) Microseconds per read: Count: 148996 Average: 541.7020 StdDev: 1544.34 Min: 2 Median: 268.4121 Max: 89552 Percentiles: P50: 268.41 P75: 480.71 P99: 4670.41 P99.9: 23685.08 P99.99: 57083.89 ------------------------------------------------------ ( 1, 2 ] 1 0.001% 0.001% ( 2, 3 ] 20 0.013% 0.014% ( 3, 4 ] 49 0.033% 0.047% ( 4, 6 ] 105 0.070% 0.117% ( 6, 10 ] 280 0.188% 0.305% ( 10, 15 ] 605 0.406% 0.711% ( 15, 22 ] 1726 1.158% 1.870% ( 22, 34 ] 2923 1.962% 3.832% ( 34, 51 ] 1702 1.142% 4.974% ( 51, 76 ] 296 0.199% 5.173% ( 76, 110 ] 75 0.050% 5.223% ( 110, 170 ] 8198 5.502% 10.725% # ( 170, 250 ] 54160 36.350% 47.075% ####### ( 250, 380 ] 30770 20.652% 67.727% #### ( 380, 580 ] 21522 14.445% 82.171% ### ( 580, 870 ] 12804 8.594% 90.765% ## ( 870, 1300 ] 5506 3.695% 94.460% # ( 1300, 1900 ] 2152 1.444% 95.905% ( 1900, 2900 ] 1889 1.268% 97.172% ( 2900, 4400 ] 2615 1.755% 98.927% ( 4400, 6600 ] 879 0.590% 99.517% ( 6600, 9900 ] 267 0.179% 99.697% ( 9900, 14000 ] 109 0.073% 99.770% ( 14000, 22000 ] 177 0.119% 99.889% ( 22000, 33000 ] 111 0.074% 99.963% ( 33000, 50000 ] 35 0.023% 99.987% ( 50000, 75000 ] 18 0.012% 99.999% ( 75000, 110000 ] 2 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 : 2080520 rocksdb.bloom.filter.full.positive COUNT : 168510 rocksdb.bloom.filter.full.true.positive COUNT : 148252 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 : 744 rocksdb.memtable.miss COUNT : 148252 rocksdb.l0.hit COUNT : 14270 rocksdb.l1.hit COUNT : 114 rocksdb.l2andup.hit COUNT : 133868 rocksdb.compaction.key.drop.new COUNT : 1396120 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 : 3713489 rocksdb.number.keys.read COUNT : 148996 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 3832320648 rocksdb.bytes.read COUNT : 148996000 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 : 569 rocksdb.no.file.errors COUNT : 0 rocksdb.stall.micros COUNT : 4731854 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 : 17761693480 rocksdb.compact.write.bytes COUNT : 16322246181 rocksdb.flush.write.bytes COUNT : 3758925443 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 : 37 rocksdb.number.superversion_acquires COUNT : 757 rocksdb.number.superversion_releases COUNT : 740 rocksdb.number.superversion_cleanups COUNT : 191 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 : 166 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 : 3734866944 rocksdb.memtable.garbage.bytes.at.flush COUNT : 7191552 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 : 17893048990 rocksdb.non.last.level.read.count COUNT : 4295272 rocksdb.block.checksum.compute.count COUNT : 4474357 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 : 266.165270 P95 : 1522.785282 P99 : 4663.498290 P100 : 89551.000000 COUNT : 148996 SUM : 80565708 rocksdb.db.write.micros P50 : 1.607174 P95 : 5.130087 P99 : 7.635952 P100 : 799977.000000 COUNT : 3713489 SUM : 15369342 rocksdb.compaction.times.micros P50 : 1931250.000000 P95 : 4189166.666667 P99 : 5778373.000000 P100 : 5778373.000000 COUNT : 59 SUM : 130544897 rocksdb.compaction.times.cpu_micros P50 : 1337500.000000 P95 : 2575000.000000 P99 : 3474000.000000 P100 : 4060515.000000 COUNT : 59 SUM : 80556019 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 : 1085.000000 P95 : 8195.000000 P99 : 11379.000000 P100 : 11379.000000 COUNT : 51 SUM : 117508 rocksdb.compaction.outfile.sync.micros P50 : 2420.833333 P95 : 8566.250000 P99 : 40055.000000 P100 : 80481.000000 COUNT : 217 SUM : 779411 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 : 256.500000 P95 : 2050.000000 P99 : 8778.000000 P100 : 25596.000000 COUNT : 134 SUM : 94007 rocksdb.table.open.io.micros P50 : 5707.058824 P95 : 19139.130435 P99 : 31915.714286 P100 : 56818.000000 COUNT : 569 SUM : 3906476 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 : 4.621403 P95 : 9.745928 P99 : 160.094860 P100 : 53918.000000 COUNT : 4302952 SUM : 69702568 rocksdb.read.block.get.micros P50 : 221.658027 P95 : 1256.588648 P99 : 4161.429580 P100 : 65590.000000 COUNT : 170858 SUM : 73603724 rocksdb.write.raw.block.micros P50 : 0.537191 P95 : 1.429169 P99 : 4.684866 P100 : 108207.000000 COUNT : 4865301 SUM : 20909470 rocksdb.numfiles.in.singlecompaction P50 : 3.280000 P95 : 5.200000 P99 : 10.800000 P100 : 13.000000 COUNT : 84 SUM : 311 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.558785 P95 : 1115.986598 P99 : 1299.370515 P100 : 799805.000000 COUNT : 5171 SUM : 4732270 rocksdb.sst.read.micros P50 : 2.214923 P95 : 14.185166 P99 : 531.378765 P100 : 65583.000000 COUNT : 4295370 SUM : 127521261 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 : 148996 SUM : 148996000 rocksdb.bytes.per.write P50 : 1032.000000 P95 : 1032.000000 P99 : 1032.000000 P100 : 1032.000000 COUNT : 3713489 SUM : 3832320648 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 : 238000.000000 P95 : 833416.666667 P99 : 1057799.000000 P100 : 1057799.000000 COUNT : 51 SUM : 18151232 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 : 225 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