[2024-12-06 11:10:47.581440] Starting SPDK v25.01-pre git sha1 50b04b06b / DPDK 24.03.0 initialization... [2024-12-06 11:10:47.581753] [ 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_pid1880872 ] Set seed to 1733479847574253 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-12-06 11:10:47.730855] app.c: 919:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-12-06 11:10:47.833125] app.c: 612:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-12-06 11:10:47.833178] app.c: 613:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 1880872' to capture a snapshot of events at runtime. [2024-12-06 11:10:47.833191] app.c: 618:app_setup_trace: *NOTICE*: 'spdk_trace' without parameters will also work if this is the only [2024-12-06 11:10:47.833204] app.c: 619:app_setup_trace: *NOTICE*: SPDK application currently running. [2024-12-06 11:10:47.833214] app.c: 620:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid1880872 for offline analysis/debug. [2024-12-06 11:10:47.834432] reactor.c:1005:reactor_run: *NOTICE*: Reactor started on core 0 RocksDB: version 8.1.1 Date: Fri Dec 6 11:10:50 2024 CPU: 72 * Intel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz CPUCache: 25344 KB 2024/12/06-11:10:57 ... thread 0: (1000000,1000000) ops and (149422.6,149422.6) ops/second in (6.692426,6.692426) 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 7/4 815.26 MB 25.1 0.3 0.0 0.3 1.1 0.8 0.0 1.4 38.3 137.7 8.20 3.96 11 0.746 319K 1872 0.0 0.0 L1 2/2 210.11 MB 0.0 0.4 0.2 0.1 0.4 0.2 0.0 1.7 73.3 72.8 5.10 2.02 1 5.101 379K 2661 0.0 0.0 L2 3/1 290.13 MB 1.6 0.0 0.0 0.0 0.0 0.0 0.2 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L3 33/10 1.92 GB 1.3 2.1 1.7 0.4 2.0 1.7 0.0 1.2 100.8 99.0 21.09 11.43 10 2.109 1493K 4912 0.0 0.0 L4 168/28 11.99 GB 1.0 2.6 1.6 1.0 2.5 1.5 0.1 1.6 118.2 113.5 22.33 13.16 12 1.861 569K 0 0.0 0.0 L5 116/0 8.98 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 329/45 24.19 GB 0.0 5.3 3.5 1.8 6.0 4.1 0.2 7.5 96.2 108.0 56.72 30.58 34 1.668 2762K 9445 0.0 0.0 Int 0/0 0.00 KB 0.0 5.3 3.5 1.8 6.0 4.1 0.2 7.5 96.2 108.0 56.72 30.58 34 1.668 2762K 9445 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.3 3.5 1.8 5.2 3.3 0.0 0.0 107.7 104.8 50.62 28.10 24 2.109 2762K 9445 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 134.0 6.10 2.48 10 0.610 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.8 total, 6.7 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: 5.98 GB write, 903.53 MB/s write, 5.33 GB read, 804.74 MB/s read, 56.7 seconds Interval compaction: 5.98 GB write, 914.72 MB/s write, 5.33 GB read, 814.71 MB/s read, 56.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: 15, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 15, interval: 15 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 140224 Average: 44.6172 StdDev: 428.32 Min: 1 Median: 2.1700 Max: 46994 Percentiles: P50: 2.17 P75: 3.28 P99: 1131.29 P99.9: 4382.92 P99.99: 11927.04 ------------------------------------------------------ [ 0, 1 ] 3021 2.154% 2.154% ( 1, 2 ] 60681 43.274% 45.429% ######### ( 2, 3 ] 37697 26.883% 72.312% ##### ( 3, 4 ] 13483 9.615% 81.927% ## ( 4, 6 ] 15896 11.336% 93.264% ## ( 6, 10 ] 3972 2.833% 96.096% # ( 10, 15 ] 826 0.589% 96.685% ( 15, 22 ] 109 0.078% 96.763% ( 22, 34 ] 18 0.013% 96.776% ( 34, 51 ] 16 0.011% 96.787% ( 51, 76 ] 18 0.013% 96.800% ( 76, 110 ] 8 0.006% 96.806% ( 110, 170 ] 22 0.016% 96.822% ( 170, 250 ] 107 0.076% 96.898% ( 250, 380 ] 412 0.294% 97.192% ( 380, 580 ] 958 0.683% 97.875% ( 580, 870 ] 1136 0.810% 98.685% ( 870, 1300 ] 727 0.518% 99.203% ( 1300, 1900 ] 330 0.235% 99.439% ( 1900, 2900 ] 280 0.200% 99.638% ( 2900, 4400 ] 371 0.265% 99.903% ( 4400, 6600 ] 92 0.066% 99.969% ( 6600, 9900 ] 28 0.020% 99.989% ( 9900, 14000 ] 4 0.003% 99.991% ( 14000, 22000 ] 5 0.004% 99.995% ( 22000, 33000 ] 8 0.006% 100.001% ( 33000, 50000 ] 3 0.002% 100.003% ** Level 1 read latency histogram (micros): Count: 38127 Average: 25.5251 StdDev: 318.22 Min: 1 Median: 2.3466 Max: 30978 Percentiles: P50: 2.35 P75: 3.39 P99: 664.23 P99.9: 3934.80 P99.99: 10667.93 ------------------------------------------------------ [ 0, 1 ] 219 0.574% 0.574% ( 1, 2 ] 14692 38.534% 39.109% ######## ( 2, 3 ] 11982 31.427% 70.535% ###### ( 3, 4 ] 4329 11.354% 81.889% ## ( 4, 6 ] 4802 12.595% 94.484% ### ( 6, 10 ] 1177 3.087% 97.571% # ( 10, 15 ] 240 0.629% 98.201% ( 15, 22 ] 25 0.066% 98.266% ( 22, 34 ] 4 0.010% 98.277% ( 34, 51 ] 15 0.039% 98.316% ( 51, 76 ] 9 0.024% 98.340% ( 76, 110 ] 6 0.016% 98.355% ( 110, 170 ] 8 0.021% 98.376% ( 170, 250 ] 31 0.081% 98.458% ( 250, 380 ] 60 0.157% 98.615% ( 380, 580 ] 102 0.268% 98.883% ( 580, 870 ] 154 0.404% 99.287% ( 870, 1300 ] 103 0.270% 99.557% ( 1300, 1900 ] 52 0.136% 99.693% ( 1900, 2900 ] 43 0.113% 99.806% ( 2900, 4400 ] 52 0.136% 99.942% ( 4400, 6600 ] 14 0.037% 99.979% ( 6600, 9900 ] 4 0.010% 99.990% ( 9900, 14000 ] 1 0.003% 99.992% ( 14000, 22000 ] 1 0.003% 99.995% ( 22000, 33000 ] 2 0.005% 100.000% ** Level 2 read latency histogram (micros): Count: 408228 Average: 17.5879 StdDev: 308.00 Min: 1 Median: 2.2739 Max: 38884 Percentiles: P50: 2.27 P75: 3.34 P99: 13.51 P99.9: 1905.37 P99.99: 3052.24 ------------------------------------------------------ [ 0, 1 ] 4238 1.038% 1.038% ( 1, 2 ] 167274 40.976% 42.014% ######## ( 2, 3 ] 119024 29.156% 71.170% ###### ( 3, 4 ] 45708 11.197% 82.367% ## ( 4, 6 ] 52750 12.922% 95.288% ### ( 6, 10 ] 12656 3.100% 98.389% # ( 10, 15 ] 3555 0.871% 99.259% ( 15, 22 ] 587 0.144% 99.403% ( 22, 34 ] 87 0.021% 99.425% ( 34, 51 ] 138 0.034% 99.458% ( 51, 76 ] 81 0.020% 99.478% ( 76, 110 ] 22 0.005% 99.484% ( 110, 170 ] 25 0.006% 99.490% ( 170, 250 ] 78 0.019% 99.509% ( 250, 380 ] 210 0.051% 99.560% ( 380, 580 ] 404 0.099% 99.659% ( 580, 870 ] 431 0.106% 99.765% ( 870, 1300 ] 291 0.071% 99.836% ( 1300, 1900 ] 259 0.063% 99.900% ( 1900, 2900 ] 330 0.081% 99.980% ( 2900, 4400 ] 386 0.095% 100.075% ( 4400, 6600 ] 169 0.041% 100.116% ( 6600, 9900 ] 57 0.014% 100.130% ( 9900, 14000 ] 13 0.003% 100.134% ( 14000, 22000 ] 29 0.007% 100.141% ( 22000, 33000 ] 12 0.003% 100.144% ( 33000, 50000 ] 3 0.001% 100.144% ** Level 3 read latency histogram (micros): Count: 545661 Average: 18.6192 StdDev: 318.45 Min: 1 Median: 2.3556 Max: 63063 Percentiles: P50: 2.36 P75: 3.41 P99: 14.49 P99.9: 1754.81 P99.99: 2810.10 ------------------------------------------------------ [ 0, 1 ] 3667 0.672% 0.672% ( 1, 2 ] 208172 38.150% 38.822% ######## ( 2, 3 ] 171514 31.432% 70.255% ###### ( 3, 4 ] 62931 11.533% 81.788% ## ( 4, 6 ] 73206 13.416% 95.204% ### ( 6, 10 ] 17426 3.194% 98.397% # ( 10, 15 ] 3665 0.672% 99.069% ( 15, 22 ] 451 0.083% 99.152% ( 22, 34 ] 86 0.016% 99.167% ( 34, 51 ] 140 0.026% 99.193% ( 51, 76 ] 103 0.019% 99.212% ( 76, 110 ] 36 0.007% 99.219% ( 110, 170 ] 57 0.010% 99.229% ( 170, 250 ] 158 0.029% 99.258% ( 250, 380 ] 450 0.082% 99.340% ( 380, 580 ] 966 0.177% 99.517% ( 580, 870 ] 1044 0.191% 99.709% ( 870, 1300 ] 730 0.134% 99.843% ( 1300, 1900 ] 416 0.076% 99.919% ( 1900, 2900 ] 429 0.079% 99.997% ( 2900, 4400 ] 542 0.099% 100.097% ( 4400, 6600 ] 177 0.032% 100.129% ( 6600, 9900 ] 40 0.007% 100.137% ( 9900, 14000 ] 17 0.003% 100.140% ( 14000, 22000 ] 32 0.006% 100.146% ( 22000, 33000 ] 16 0.003% 100.148% ( 33000, 50000 ] 4 0.001% 100.149% ( 50000, 75000 ] 2 0.000% 100.150% ** Level 4 read latency histogram (micros): Count: 571239 Average: 33.4410 StdDev: 418.32 Min: 1 Median: 2.3502 Max: 62900 Percentiles: P50: 2.35 P75: 3.45 P99: 663.58 P99.9: 2469.40 P99.99: 3030.73 ------------------------------------------------------ [ 0, 1 ] 4553 0.797% 0.797% ( 1, 2 ] 220136 38.537% 39.334% ######## ( 2, 3 ] 173987 30.458% 69.791% ###### ( 3, 4 ] 66173 11.584% 81.376% ## ( 4, 6 ] 74337 13.013% 94.389% ### ( 6, 10 ] 17204 3.012% 97.401% # ( 10, 15 ] 3552 0.622% 98.022% ( 15, 22 ] 372 0.065% 98.087% ( 22, 34 ] 72 0.013% 98.100% ( 34, 51 ] 187 0.033% 98.133% ( 51, 76 ] 141 0.025% 98.158% ( 76, 110 ] 43 0.008% 98.165% ( 110, 170 ] 104 0.018% 98.183% ( 170, 250 ] 349 0.061% 98.244% ( 250, 380 ] 1160 0.203% 98.447% ( 380, 580 ] 2366 0.414% 98.862% ( 580, 870 ] 2750 0.481% 99.343% ( 870, 1300 ] 1778 0.311% 99.654% ( 1300, 1900 ] 858 0.150% 99.804% ( 1900, 2900 ] 962 0.168% 99.973% ( 2900, 4400 ] 1146 0.201% 100.173% ( 4400, 6600 ] 315 0.055% 100.229% ( 6600, 9900 ] 63 0.011% 100.240% ( 9900, 14000 ] 11 0.002% 100.242% ( 14000, 22000 ] 36 0.006% 100.248% ( 22000, 33000 ] 26 0.005% 100.252% ( 33000, 50000 ] 14 0.002% 100.255% ( 50000, 75000 ] 2 0.000% 100.255% ** Level 5 read latency histogram (micros): Count: 6545 Average: 1333.5971 StdDev: 2227.94 Min: 102 Median: 758.9688 Max: 61095 Percentiles: P50: 758.97 P75: 1360.76 P99: 6449.51 P99.9: 31583.75 P99.99: 54318.75 ------------------------------------------------------ ( 76, 110 ] 1 0.015% 0.015% ( 110, 170 ] 35 0.535% 0.550% ( 170, 250 ] 189 2.888% 3.438% # ( 250, 380 ] 660 10.084% 13.522% ## ( 380, 580 ] 1397 21.345% 34.866% #### ( 580, 870 ] 1605 24.523% 59.389% ##### ( 870, 1300 ] 978 14.943% 74.332% ### ( 1300, 1900 ] 432 6.600% 80.932% # ( 1900, 2900 ] 412 6.295% 87.227% # ( 2900, 4400 ] 601 9.183% 96.409% ## ( 4400, 6600 ] 182 2.781% 99.190% # ( 6600, 9900 ] 27 0.413% 99.603% ( 9900, 14000 ] 1 0.015% 99.618% ( 14000, 22000 ] 8 0.122% 99.740% ( 22000, 33000 ] 12 0.183% 99.924% ( 33000, 50000 ] 4 0.061% 99.985% ( 50000, 75000 ] 2 0.031% 100.015% ** DB Stats ** Uptime(secs): 6.8 total, 6.7 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 145.20 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.256 H:M:S, 33.3 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 146.98 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.256 H:M:S, 33.7 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 10 num-running-flushes: 1 2024/12/06-11:11:03 ... thread 0: (1000000,2000000) ops and (171382.4,159650.9) ops/second in (5.834905,12.527331) 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/16 1.84 GB 37.5 0.6 0.0 0.6 2.5 1.8 0.0 1.3 42.4 169.2 14.84 8.40 26 0.571 638K 3696 0.0 0.0 L1 2/2 210.11 MB 0.0 0.4 0.2 0.1 0.4 0.2 0.0 1.7 73.3 72.8 5.10 2.02 1 5.101 379K 2661 0.0 0.0 L2 1/0 60.21 MB 0.6 0.0 0.0 0.0 0.0 0.0 0.2 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L3 17/0 951.96 MB 1.0 2.4 1.9 0.5 2.4 1.9 0.0 1.2 104.0 102.3 23.71 13.15 12 1.976 1839K 8239 0.0 0.0 L4 147/0 9.59 GB 1.0 9.2 2.8 6.4 8.0 1.6 0.1 2.9 144.2 125.4 65.01 41.43 32 2.032 1843K 0 0.0 0.0 L5 156/0 11.50 GB 0.1 0.0 0.0 0.0 0.0 0.0 2.5 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 341/18 24.13 GB 0.0 12.5 4.9 7.6 13.1 5.5 2.7 7.1 118.2 123.9 108.66 65.01 71 1.530 4700K 14K 0.0 0.0 Int 0/0 0.00 KB 0.0 12.5 4.9 7.6 13.1 5.5 2.7 7.1 118.2 123.9 108.66 65.01 71 1.530 4700K 14K 0.0 0.0 ** Compaction Stats [default] ** Priority Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) --------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- Low 0/0 0.00 KB 0.0 12.5 4.9 7.6 11.3 3.7 0.0 0.0 132.0 119.0 97.29 59.35 47 2.070 4700K 14K 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 1.8 1.8 0.0 0.0 0.0 165.9 11.37 5.66 24 0.474 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.842, interval 1.842 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: 13.14 GB write, 1067.14 MB/s write, 12.54 GB read, 1018.52 MB/s read, 108.7 seconds Interval compaction: 13.14 GB write, 1074.21 MB/s write, 12.54 GB read, 1025.26 MB/s read, 108.7 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 1, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 1, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 33, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 1, total-stops: 33, interval: 34 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 457058 Average: 46.0203 StdDev: 384.18 Min: 1 Median: 1.9437 Max: 53987 Percentiles: P50: 1.94 P75: 2.94 P99: 821.43 P99.9: 2446.25 P99.99: 3162.14 ------------------------------------------------------ [ 0, 1 ] 15959 3.492% 3.492% # ( 1, 2 ] 225262 49.285% 52.777% ########## ( 2, 3 ] 107711 23.566% 76.343% ##### ( 3, 4 ] 35971 7.870% 84.213% ## ( 4, 6 ] 33333 7.293% 91.506% # ( 6, 10 ] 9375 2.051% 93.557% ( 10, 15 ] 1985 0.434% 93.992% ( 15, 22 ] 238 0.052% 94.044% ( 22, 34 ] 39 0.009% 94.052% ( 34, 51 ] 23 0.005% 94.057% ( 51, 76 ] 22 0.005% 94.062% ( 76, 110 ] 22 0.005% 94.067% ( 110, 170 ] 664 0.145% 94.212% ( 170, 250 ] 4430 0.969% 95.181% ( 250, 380 ] 7069 1.547% 96.728% ( 380, 580 ] 6294 1.377% 98.105% ( 580, 870 ] 4917 1.076% 99.181% ( 870, 1300 ] 2238 0.490% 99.671% ( 1300, 1900 ] 716 0.157% 99.827% ( 1900, 2900 ] 615 0.135% 99.962% ( 2900, 4400 ] 757 0.166% 100.127% ( 4400, 6600 ] 181 0.040% 100.167% ( 6600, 9900 ] 44 0.010% 100.177% ( 9900, 14000 ] 8 0.002% 100.178% ( 14000, 22000 ] 20 0.004% 100.183% ( 22000, 33000 ] 17 0.004% 100.186% ( 33000, 50000 ] 9 0.002% 100.188% ( 50000, 75000 ] 2 0.000% 100.189% ** Level 1 read latency histogram (micros): Count: 64498 Average: 24.6409 StdDev: 284.86 Min: 1 Median: 2.4187 Max: 30978 Percentiles: P50: 2.42 P75: 3.55 P99: 602.09 P99.9: 3715.66 P99.99: 8703.91 ------------------------------------------------------ [ 0, 1 ] 279 0.433% 0.433% ( 1, 2 ] 23336 36.181% 36.614% ####### ( 2, 3 ] 20623 31.975% 68.588% ###### ( 3, 4 ] 7508 11.641% 80.229% ## ( 4, 6 ] 8763 13.586% 93.815% ### ( 6, 10 ] 2065 3.202% 97.017% # ( 10, 15 ] 422 0.654% 97.671% ( 15, 22 ] 48 0.074% 97.746% ( 22, 34 ] 12 0.019% 97.764% ( 34, 51 ] 24 0.037% 97.801% ( 51, 76 ] 14 0.022% 97.823% ( 76, 110 ] 6 0.009% 97.832% ( 110, 170 ] 35 0.054% 97.887% ( 170, 250 ] 189 0.293% 98.180% ( 250, 380 ] 244 0.378% 98.558% ( 380, 580 ] 264 0.409% 98.967% ( 580, 870 ] 276 0.428% 99.395% ( 870, 1300 ] 154 0.239% 99.634% ( 1300, 1900 ] 67 0.104% 99.738% ( 1900, 2900 ] 61 0.095% 99.833% ( 2900, 4400 ] 80 0.124% 99.957% ( 4400, 6600 ] 19 0.029% 99.986% ( 6600, 9900 ] 4 0.006% 99.992% ( 9900, 14000 ] 1 0.002% 99.994% ( 14000, 22000 ] 1 0.002% 99.995% ( 22000, 33000 ] 3 0.005% 100.000% ** Level 2 read latency histogram (micros): Count: 408237 Average: 17.6061 StdDev: 308.04 Min: 1 Median: 2.2739 Max: 38884 Percentiles: P50: 2.27 P75: 3.34 P99: 13.52 P99.9: 1908.35 P99.99: 3052.24 ------------------------------------------------------ [ 0, 1 ] 4238 1.038% 1.038% ( 1, 2 ] 167274 40.975% 42.013% ######## ( 2, 3 ] 119024 29.156% 71.168% ###### ( 3, 4 ] 45708 11.196% 82.365% ## ( 4, 6 ] 52750 12.921% 95.286% ### ( 6, 10 ] 12656 3.100% 98.386% # ( 10, 15 ] 3555 0.871% 99.257% ( 15, 22 ] 587 0.144% 99.401% ( 22, 34 ] 87 0.021% 99.422% ( 34, 51 ] 138 0.034% 99.456% ( 51, 76 ] 81 0.020% 99.476% ( 76, 110 ] 22 0.005% 99.481% ( 110, 170 ] 25 0.006% 99.488% ( 170, 250 ] 78 0.019% 99.507% ( 250, 380 ] 212 0.052% 99.559% ( 380, 580 ] 406 0.099% 99.658% ( 580, 870 ] 434 0.106% 99.764% ( 870, 1300 ] 291 0.071% 99.836% ( 1300, 1900 ] 260 0.064% 99.899% ( 1900, 2900 ] 331 0.081% 99.980% ( 2900, 4400 ] 386 0.095% 100.075% ( 4400, 6600 ] 169 0.041% 100.116% ( 6600, 9900 ] 57 0.014% 100.130% ( 9900, 14000 ] 13 0.003% 100.134% ( 14000, 22000 ] 29 0.007% 100.141% ( 22000, 33000 ] 12 0.003% 100.144% ( 33000, 50000 ] 3 0.001% 100.144% ** Level 3 read latency histogram (micros): Count: 784066 Average: 17.7540 StdDev: 302.43 Min: 1 Median: 2.3393 Max: 63063 Percentiles: P50: 2.34 P75: 3.40 P99: 54.41 P99.9: 1594.29 P99.99: 2710.81 ------------------------------------------------------ [ 0, 1 ] 6751 0.861% 0.861% ( 1, 2 ] 302982 38.642% 39.503% ######## ( 2, 3 ] 242523 30.931% 70.435% ###### ( 3, 4 ] 90068 11.487% 81.922% ## ( 4, 6 ] 102958 13.131% 95.053% ### ( 6, 10 ] 24836 3.168% 98.221% # ( 10, 15 ] 5116 0.652% 98.874% ( 15, 22 ] 643 0.082% 98.956% ( 22, 34 ] 119 0.015% 98.971% ( 34, 51 ] 209 0.027% 98.997% ( 51, 76 ] 149 0.019% 99.016% ( 76, 110 ] 53 0.007% 99.023% ( 110, 170 ] 161 0.021% 99.044% ( 170, 250 ] 666 0.085% 99.129% ( 250, 380 ] 1132 0.144% 99.273% ( 380, 580 ] 1747 0.223% 99.496% ( 580, 870 ] 1822 0.232% 99.728% ( 870, 1300 ] 1086 0.139% 99.867% ( 1300, 1900 ] 532 0.068% 99.935% ( 1900, 2900 ] 536 0.068% 100.003% ( 2900, 4400 ] 647 0.083% 100.085% ( 4400, 6600 ] 196 0.025% 100.110% ( 6600, 9900 ] 41 0.005% 100.116% ( 9900, 14000 ] 21 0.003% 100.118% ( 14000, 22000 ] 36 0.005% 100.123% ( 22000, 33000 ] 24 0.003% 100.126% ( 33000, 50000 ] 7 0.001% 100.127% ( 50000, 75000 ] 2 0.000% 100.127% ** Level 4 read latency histogram (micros): Count: 1663392 Average: 22.9943 StdDev: 316.55 Min: 1 Median: 2.3236 Max: 62900 Percentiles: P50: 2.32 P75: 3.40 P99: 372.11 P99.9: 1040.12 P99.99: 1232.97 ------------------------------------------------------ [ 0, 1 ] 14738 0.886% 0.886% ( 1, 2 ] 655374 39.400% 40.286% ######## ( 2, 3 ] 499297 30.017% 70.303% ###### ( 3, 4 ] 194244 11.678% 81.980% ## ( 4, 6 ] 208572 12.539% 94.519% ### ( 6, 10 ] 50097 3.012% 97.531% # ( 10, 15 ] 10679 0.642% 98.173% ( 15, 22 ] 1115 0.067% 98.240% ( 22, 34 ] 270 0.016% 98.256% ( 34, 51 ] 507 0.030% 98.287% ( 51, 76 ] 345 0.021% 98.307% ( 76, 110 ] 118 0.007% 98.315% ( 110, 170 ] 971 0.058% 98.373% ( 170, 250 ] 4563 0.274% 98.647% ( 250, 380 ] 6247 0.376% 99.023% ( 380, 580 ] 6897 0.415% 99.437% ( 580, 870 ] 6374 0.383% 99.821% ( 870, 1300 ] 3338 0.201% 100.021% ( 1300, 1900 ] 1441 0.087% 100.108% ( 1900, 2900 ] 1555 0.093% 100.201% ( 2900, 4400 ] 1691 0.102% 100.303% ( 4400, 6600 ] 455 0.027% 100.330% ( 6600, 9900 ] 96 0.006% 100.336% ( 9900, 14000 ] 32 0.002% 100.338% ( 14000, 22000 ] 66 0.004% 100.342% ( 22000, 33000 ] 49 0.003% 100.345% ( 33000, 50000 ] 26 0.002% 100.347% ( 50000, 75000 ] 2 0.000% 100.347% ** Level 5 read latency histogram (micros): Count: 18385 Average: 837.9584 StdDev: 1559.16 Min: 96 Median: 485.6734 Max: 61095 Percentiles: P50: 485.67 P75: 816.15 P99: 5491.50 P99.9: 23917.67 P99.99: 47149.10 ------------------------------------------------------ ( 76, 110 ] 19 0.103% 0.103% ( 110, 170 ] 595 3.236% 3.340% # ( 170, 250 ] 2772 15.078% 18.417% ### ( 250, 380 ] 3739 20.337% 38.754% #### ( 380, 580 ] 3913 21.284% 60.038% #### ( 580, 870 ] 3378 18.374% 78.412% #### ( 870, 1300 ] 1645 8.948% 87.359% ## ( 1300, 1900 ] 611 3.323% 90.683% # ( 1900, 2900 ] 581 3.160% 93.843% # ( 2900, 4400 ] 839 4.564% 98.406% # ( 4400, 6600 ] 220 1.197% 99.603% ( 6600, 9900 ] 36 0.196% 99.799% ( 9900, 14000 ] 5 0.027% 99.826% ( 14000, 22000 ] 11 0.060% 99.886% ( 22000, 33000 ] 15 0.082% 99.967% ( 33000, 50000 ] 5 0.027% 99.995% ( 50000, 75000 ] 2 0.011% 100.005% ** DB Stats ** Uptime(secs): 12.6 total, 5.8 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 156.06 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.877 H:M:S, 30.7 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 168.68 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:1.621 H:M:S, 27.8 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 4 num-running-flushes: 1 2024/12/06-11:11:06 ... thread 0: (1000000,3000000) ops and (276699.7,185858.0) ops/second in (3.614026,16.141357) 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 15/8 2.75 GB 200.1 2.3 0.0 2.3 5.0 2.8 0.0 1.8 76.0 167.9 30.63 17.87 47 0.652 2362K 13K 0.0 0.0 L1 2/2 210.11 MB 0.0 0.4 0.2 0.1 0.4 0.2 0.0 1.7 73.3 72.8 5.10 2.02 1 5.101 379K 2661 0.0 0.0 L2 1/0 60.21 MB 0.6 0.0 0.0 0.0 0.0 0.0 0.2 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L3 17/0 951.96 MB 1.0 2.4 1.9 0.5 2.4 1.9 0.0 1.2 104.0 102.3 23.71 13.15 12 1.976 1839K 8239 0.0 0.0 L4 147/0 9.59 GB 1.0 9.2 2.8 6.4 8.0 1.6 0.1 2.9 144.2 125.4 65.01 41.43 32 2.032 1843K 0 0.0 0.0 L5 156/0 11.50 GB 0.1 0.0 0.0 0.0 0.0 0.0 2.5 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 338/10 25.04 GB 0.0 14.2 4.9 9.3 15.7 6.4 2.7 5.7 116.9 129.3 124.46 74.48 92 1.353 6425K 23K 0.0 0.0 Int 0/0 0.00 KB 0.0 14.2 4.9 9.3 15.7 6.4 2.7 5.7 116.9 129.3 124.46 74.48 92 1.353 6425K 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 14.2 4.9 9.3 13.0 3.7 0.0 0.0 132.0 120.4 110.17 66.24 53 2.079 6425K 23K 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 198.0 14.29 8.24 39 0.366 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 16.2 total, 16.1 interval Flush(GB): cumulative 2.763, interval 2.763 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: 15.71 GB write, 991.69 MB/s write, 14.20 GB read, 896.32 MB/s read, 124.5 seconds Interval compaction: 15.71 GB write, 996.78 MB/s write, 14.20 GB read, 900.92 MB/s read, 124.5 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 1, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 1, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 33, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 1, total-stops: 33, interval: 34 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 793856 Average: 32.0275 StdDev: 293.77 Min: 1 Median: 1.7550 Max: 53987 Percentiles: P50: 1.75 P75: 2.65 P99: 610.38 P99.9: 1640.59 P99.99: 2555.22 ------------------------------------------------------ [ 0, 1 ] 76359 9.619% 9.619% ## ( 1, 2 ] 424597 53.485% 63.104% ########### ( 2, 3 ] 145811 18.367% 81.472% #### ( 3, 4 ] 46971 5.917% 87.388% # ( 4, 6 ] 40110 5.053% 92.441% # ( 6, 10 ] 12388 1.560% 94.001% ( 10, 15 ] 2530 0.319% 94.320% ( 15, 22 ] 310 0.039% 94.359% ( 22, 34 ] 61 0.008% 94.367% ( 34, 51 ] 28 0.004% 94.370% ( 51, 76 ] 23 0.003% 94.373% ( 76, 110 ] 202 0.025% 94.399% ( 110, 170 ] 5472 0.689% 95.088% ( 170, 250 ] 14561 1.834% 96.922% ( 250, 380 ] 9052 1.140% 98.062% ( 380, 580 ] 6918 0.871% 98.934% ( 580, 870 ] 5016 0.632% 99.566% ( 870, 1300 ] 2246 0.283% 99.849% ( 1300, 1900 ] 719 0.091% 99.939% ( 1900, 2900 ] 616 0.078% 100.017% ( 2900, 4400 ] 758 0.095% 100.112% ( 4400, 6600 ] 181 0.023% 100.135% ( 6600, 9900 ] 44 0.006% 100.141% ( 9900, 14000 ] 8 0.001% 100.142% ( 14000, 22000 ] 20 0.003% 100.144% ( 22000, 33000 ] 17 0.002% 100.146% ( 33000, 50000 ] 9 0.001% 100.148% ( 50000, 75000 ] 2 0.000% 100.148% ** Level 1 read latency histogram (micros): Count: 68515 Average: 31.1171 StdDev: 278.90 Min: 1 Median: 2.4888 Max: 30978 Percentiles: P50: 2.49 P75: 3.81 P99: 572.98 P99.9: 3640.34 P99.99: 8372.51 ------------------------------------------------------ [ 0, 1 ] 298 0.435% 0.435% ( 1, 2 ] 23733 34.639% 35.074% ####### ( 2, 3 ] 20923 30.538% 65.612% ###### ( 3, 4 ] 7922 11.562% 77.174% ## ( 4, 6 ] 8960 13.077% 90.252% ### ( 6, 10 ] 2096 3.059% 93.311% # ( 10, 15 ] 447 0.652% 93.963% ( 15, 22 ] 56 0.082% 94.045% ( 22, 34 ] 16 0.023% 94.068% ( 34, 51 ] 24 0.035% 94.103% ( 51, 76 ] 14 0.020% 94.124% ( 76, 110 ] 42 0.061% 94.185% ( 110, 170 ] 738 1.077% 95.262% ( 170, 250 ] 1726 2.519% 97.782% # ( 250, 380 ] 501 0.731% 98.513% ( 380, 580 ] 346 0.505% 99.018% ( 580, 870 ] 282 0.412% 99.429% ( 870, 1300 ] 155 0.226% 99.656% ( 1300, 1900 ] 67 0.098% 99.753% ( 1900, 2900 ] 61 0.089% 99.842% ( 2900, 4400 ] 80 0.117% 99.959% ( 4400, 6600 ] 19 0.028% 99.987% ( 6600, 9900 ] 4 0.006% 99.993% ( 9900, 14000 ] 1 0.001% 99.994% ( 14000, 22000 ] 1 0.001% 99.996% ( 22000, 33000 ] 3 0.004% 100.000% ** Level 2 read latency histogram (micros): Count: 408237 Average: 17.6061 StdDev: 308.04 Min: 1 Median: 2.2739 Max: 38884 Percentiles: P50: 2.27 P75: 3.34 P99: 13.52 P99.9: 1908.35 P99.99: 3052.24 ------------------------------------------------------ [ 0, 1 ] 4238 1.038% 1.038% ( 1, 2 ] 167274 40.975% 42.013% ######## ( 2, 3 ] 119024 29.156% 71.168% ###### ( 3, 4 ] 45708 11.196% 82.365% ## ( 4, 6 ] 52750 12.921% 95.286% ### ( 6, 10 ] 12656 3.100% 98.386% # ( 10, 15 ] 3555 0.871% 99.257% ( 15, 22 ] 587 0.144% 99.401% ( 22, 34 ] 87 0.021% 99.422% ( 34, 51 ] 138 0.034% 99.456% ( 51, 76 ] 81 0.020% 99.476% ( 76, 110 ] 22 0.005% 99.481% ( 110, 170 ] 25 0.006% 99.488% ( 170, 250 ] 78 0.019% 99.507% ( 250, 380 ] 212 0.052% 99.559% ( 380, 580 ] 406 0.099% 99.658% ( 580, 870 ] 434 0.106% 99.764% ( 870, 1300 ] 291 0.071% 99.836% ( 1300, 1900 ] 260 0.064% 99.899% ( 1900, 2900 ] 331 0.081% 99.980% ( 2900, 4400 ] 386 0.095% 100.075% ( 4400, 6600 ] 169 0.041% 100.116% ( 6600, 9900 ] 57 0.014% 100.130% ( 9900, 14000 ] 13 0.003% 100.134% ( 14000, 22000 ] 29 0.007% 100.141% ( 22000, 33000 ] 12 0.003% 100.144% ( 33000, 50000 ] 3 0.001% 100.144% ** Level 3 read latency histogram (micros): Count: 786924 Average: 18.4519 StdDev: 302.14 Min: 1 Median: 2.3452 Max: 63063 Percentiles: P50: 2.35 P75: 3.42 P99: 229.27 P99.9: 1591.06 P99.99: 2710.28 ------------------------------------------------------ [ 0, 1 ] 6751 0.858% 0.858% ( 1, 2 ] 302982 38.502% 39.360% ######## ( 2, 3 ] 242523 30.819% 70.179% ###### ( 3, 4 ] 90068 11.446% 81.625% ## ( 4, 6 ] 102958 13.084% 94.708% ### ( 6, 10 ] 24836 3.156% 97.864% # ( 10, 15 ] 5116 0.650% 98.514% ( 15, 22 ] 643 0.082% 98.596% ( 22, 34 ] 119 0.015% 98.611% ( 34, 51 ] 209 0.027% 98.638% ( 51, 76 ] 149 0.019% 98.657% ( 76, 110 ] 81 0.010% 98.667% ( 110, 170 ] 909 0.116% 98.783% ( 170, 250 ] 2309 0.293% 99.076% ( 250, 380 ] 1443 0.183% 99.259% ( 380, 580 ] 1865 0.237% 99.496% ( 580, 870 ] 1831 0.233% 99.729% ( 870, 1300 ] 1087 0.138% 99.867% ( 1300, 1900 ] 532 0.068% 99.935% ( 1900, 2900 ] 536 0.068% 100.003% ( 2900, 4400 ] 647 0.082% 100.085% ( 4400, 6600 ] 196 0.025% 100.110% ( 6600, 9900 ] 41 0.005% 100.115% ( 9900, 14000 ] 21 0.003% 100.118% ( 14000, 22000 ] 36 0.005% 100.123% ( 22000, 33000 ] 24 0.003% 100.126% ( 33000, 50000 ] 7 0.001% 100.126% ( 50000, 75000 ] 2 0.000% 100.127% ** Level 4 read latency histogram (micros): Count: 1691311 Average: 26.0069 StdDev: 314.95 Min: 1 Median: 2.3515 Max: 62900 Percentiles: P50: 2.35 P75: 3.51 P99: 392.64 P99.9: 1037.05 P99.99: 1232.84 ------------------------------------------------------ [ 0, 1 ] 14738 0.871% 0.871% ( 1, 2 ] 655399 38.751% 39.622% ######## ( 2, 3 ] 499381 29.526% 69.149% ###### ( 3, 4 ] 194308 11.489% 80.637% ## ( 4, 6 ] 208662 12.337% 92.975% ## ( 6, 10 ] 50105 2.962% 95.937% # ( 10, 15 ] 10682 0.632% 96.569% ( 15, 22 ] 1115 0.066% 96.635% ( 22, 34 ] 270 0.016% 96.650% ( 34, 51 ] 507 0.030% 96.680% ( 51, 76 ] 345 0.020% 96.701% ( 76, 110 ] 455 0.027% 96.728% ( 110, 170 ] 8646 0.511% 97.239% ( 170, 250 ] 20060 1.186% 98.425% ( 250, 380 ] 9225 0.545% 98.970% ( 380, 580 ] 7908 0.468% 99.438% ( 580, 870 ] 6515 0.385% 99.823% ( 870, 1300 ] 3343 0.198% 100.021% ( 1300, 1900 ] 1443 0.085% 100.106% ( 1900, 2900 ] 1555 0.092% 100.198% ( 2900, 4400 ] 1691 0.100% 100.298% ( 4400, 6600 ] 455 0.027% 100.325% ( 6600, 9900 ] 96 0.006% 100.331% ( 9900, 14000 ] 32 0.002% 100.333% ( 14000, 22000 ] 66 0.004% 100.336% ( 22000, 33000 ] 49 0.003% 100.339% ( 33000, 50000 ] 26 0.002% 100.341% ( 50000, 75000 ] 2 0.000% 100.341% ** Level 5 read latency histogram (micros): Count: 36393 Average: 526.1026 StdDev: 1153.38 Min: 92 Median: 247.0162 Max: 61095 Percentiles: P50: 247.02 P75: 507.88 P99: 4273.19 P99.9: 10397.74 P99.99: 41026.38 ------------------------------------------------------ ( 76, 110 ] 230 0.632% 0.632% ( 110, 170 ] 5693 15.643% 16.275% ### ( 170, 250 ] 12749 35.031% 51.307% ####### ( 250, 380 ] 5704 15.673% 66.980% ### ( 380, 580 ] 4565 12.544% 79.524% ### ( 580, 870 ] 3477 9.554% 89.078% ## ( 870, 1300 ] 1650 4.534% 93.611% # ( 1300, 1900 ] 612 1.682% 95.293% ( 1900, 2900 ] 581 1.596% 96.890% ( 2900, 4400 ] 839 2.305% 99.195% ( 4400, 6600 ] 220 0.605% 99.799% ( 6600, 9900 ] 36 0.099% 99.898% ( 9900, 14000 ] 5 0.014% 99.912% ( 14000, 22000 ] 11 0.030% 99.942% ( 22000, 33000 ] 15 0.041% 99.984% ( 33000, 50000 ] 5 0.014% 99.997% ( 50000, 75000 ] 2 0.005% 100.003% ** DB Stats ** Uptime(secs): 16.2 total, 3.6 interval Cumulative writes: 0 writes, 3000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 2.88 GB, 181.96 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.877 H:M:S, 23.9 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 272.32 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:0.000 H:M:S, 0.0 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 1 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 : 469.751 micros/op 8498 ops/sec 20.122 seconds 170996 operations; 8.2 MB/s (41999 of 41999 found) Microseconds per read: Count: 170996 Average: 469.7660 StdDev: 1318.72 Min: 2 Median: 248.9100 Max: 82059 Percentiles: P50: 248.91 P75: 432.10 P99: 3993.21 P99.9: 21262.64 P99.99: 47591.86 ------------------------------------------------------ ( 1, 2 ] 5 0.003% 0.003% ( 2, 3 ] 36 0.021% 0.024% ( 3, 4 ] 53 0.031% 0.055% ( 4, 6 ] 174 0.102% 0.157% ( 6, 10 ] 320 0.187% 0.344% ( 10, 15 ] 953 0.557% 0.901% ( 15, 22 ] 2171 1.270% 2.171% ( 22, 34 ] 2990 1.749% 3.919% ( 34, 51 ] 1257 0.735% 4.654% ( 51, 76 ] 167 0.098% 4.752% ( 76, 110 ] 78 0.046% 4.798% ( 110, 170 ] 11125 6.506% 11.304% # ( 170, 250 ] 67083 39.231% 50.535% ######## ( 250, 380 ] 35947 21.022% 71.557% #### ( 380, 580 ] 22601 13.217% 84.774% ### ( 580, 870 ] 12968 7.584% 92.358% ## ( 870, 1300 ] 6035 3.529% 95.887% # ( 1300, 1900 ] 2223 1.300% 97.187% ( 1900, 2900 ] 1614 0.944% 98.131% ( 2900, 4400 ] 2039 1.192% 99.323% ( 4400, 6600 ] 560 0.327% 99.651% ( 6600, 9900 ] 220 0.129% 99.780% ( 9900, 14000 ] 78 0.046% 99.825% ( 14000, 22000 ] 141 0.082% 99.908% ( 22000, 33000 ] 110 0.064% 99.972% ( 33000, 50000 ] 36 0.021% 99.993% ( 50000, 75000 ] 11 0.006% 99.999% ( 75000, 110000 ] 1 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 : 2631669 rocksdb.bloom.filter.full.positive COUNT : 195740 rocksdb.bloom.filter.full.true.positive COUNT : 170140 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 : 856 rocksdb.memtable.miss COUNT : 170140 rocksdb.l0.hit COUNT : 19276 rocksdb.l1.hit COUNT : 1564 rocksdb.l2andup.hit COUNT : 149300 rocksdb.compaction.key.drop.new COUNT : 1312643 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 : 3889232 rocksdb.number.keys.read COUNT : 170996 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 4013687424 rocksdb.bytes.read COUNT : 170996000 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 : 551 rocksdb.no.file.errors COUNT : 0 rocksdb.stall.micros COUNT : 4565841 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 : 16872610985 rocksdb.compact.write.bytes COUNT : 15523242323 rocksdb.flush.write.bytes COUNT : 3890791483 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 : 24 rocksdb.number.superversion_acquires COUNT : 736 rocksdb.number.superversion_releases COUNT : 708 rocksdb.number.superversion_cleanups COUNT : 182 rocksdb.number.block.compressed COUNT : 0 rocksdb.number.block.decompressed COUNT : 0 rocksdb.number.block.not_compressed COUNT : 0 rocksdb.merge.operation.time.nanos COUNT : 0 rocksdb.filter.operation.time.nanos COUNT : 0 rocksdb.row.cache.hit COUNT : 0 rocksdb.row.cache.miss COUNT : 0 rocksdb.read.amp.estimate.useful.bytes COUNT : 0 rocksdb.read.amp.total.read.bytes COUNT : 0 rocksdb.number.rate_limiter.drains COUNT : 0 rocksdb.number.iter.skip COUNT : 0 rocksdb.blobdb.num.put COUNT : 0 rocksdb.blobdb.num.write COUNT : 0 rocksdb.blobdb.num.get COUNT : 0 rocksdb.blobdb.num.multiget COUNT : 0 rocksdb.blobdb.num.seek COUNT : 0 rocksdb.blobdb.num.next COUNT : 0 rocksdb.blobdb.num.prev COUNT : 0 rocksdb.blobdb.num.keys.written COUNT : 0 rocksdb.blobdb.num.keys.read COUNT : 0 rocksdb.blobdb.bytes.written COUNT : 0 rocksdb.blobdb.bytes.read COUNT : 0 rocksdb.blobdb.write.inlined COUNT : 0 rocksdb.blobdb.write.inlined.ttl COUNT : 0 rocksdb.blobdb.write.blob COUNT : 0 rocksdb.blobdb.write.blob.ttl COUNT : 0 rocksdb.blobdb.blob.file.bytes.written COUNT : 0 rocksdb.blobdb.blob.file.bytes.read COUNT : 0 rocksdb.blobdb.blob.file.synced COUNT : 0 rocksdb.blobdb.blob.index.expired.count COUNT : 0 rocksdb.blobdb.blob.index.expired.size COUNT : 0 rocksdb.blobdb.blob.index.evicted.count COUNT : 0 rocksdb.blobdb.blob.index.evicted.size COUNT : 0 rocksdb.blobdb.gc.num.files COUNT : 0 rocksdb.blobdb.gc.num.new.files COUNT : 0 rocksdb.blobdb.gc.failures COUNT : 0 rocksdb.blobdb.gc.num.keys.relocated COUNT : 0 rocksdb.blobdb.gc.bytes.relocated COUNT : 0 rocksdb.blobdb.fifo.num.files.evicted COUNT : 0 rocksdb.blobdb.fifo.num.keys.evicted COUNT : 0 rocksdb.blobdb.fifo.bytes.evicted COUNT : 0 rocksdb.txn.overhead.mutex.prepare COUNT : 0 rocksdb.txn.overhead.mutex.old.commit.map COUNT : 0 rocksdb.txn.overhead.duplicate.key COUNT : 0 rocksdb.txn.overhead.mutex.snapshot COUNT : 0 rocksdb.txn.get.tryagain COUNT : 0 rocksdb.number.multiget.keys.found COUNT : 0 rocksdb.num.iterator.created COUNT : 0 rocksdb.num.iterator.deleted COUNT : 0 rocksdb.block.cache.compression.dict.miss COUNT : 0 rocksdb.block.cache.compression.dict.hit COUNT : 0 rocksdb.block.cache.compression.dict.add COUNT : 0 rocksdb.block.cache.compression.dict.bytes.insert COUNT : 0 rocksdb.block.cache.add.redundant COUNT : 0 rocksdb.block.cache.index.add.redundant COUNT : 0 rocksdb.block.cache.filter.add.redundant COUNT : 0 rocksdb.block.cache.data.add.redundant COUNT : 0 rocksdb.block.cache.compression.dict.add.redundant COUNT : 0 rocksdb.files.marked.trash COUNT : 0 rocksdb.files.deleted.immediately COUNT : 63 rocksdb.error.handler.bg.errro.count COUNT : 0 rocksdb.error.handler.bg.io.errro.count COUNT : 0 rocksdb.error.handler.bg.retryable.io.errro.count COUNT : 0 rocksdb.error.handler.autoresume.count COUNT : 0 rocksdb.error.handler.autoresume.retry.total.count COUNT : 0 rocksdb.error.handler.autoresume.success.count COUNT : 0 rocksdb.memtable.payload.bytes.at.flush COUNT : 3865919488 rocksdb.memtable.garbage.bytes.at.flush COUNT : 7477248 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 : 17263403111 rocksdb.non.last.level.read.count COUNT : 4144684 rocksdb.block.checksum.compute.count COUNT : 4286921 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 : 248.119014 P95 : 1191.191553 P99 : 3992.276742 P100 : 82058.000000 COUNT : 170996 SUM : 80168744 rocksdb.db.write.micros P50 : 1.584678 P95 : 5.084710 P99 : 7.469821 P100 : 816143.000000 COUNT : 3889232 SUM : 15233161 rocksdb.compaction.times.micros P50 : 1957692.307692 P95 : 3705000.000000 P99 : 5740468.000000 P100 : 5740468.000000 COUNT : 57 SUM : 114017628 rocksdb.compaction.times.cpu_micros P50 : 1279032.258065 P95 : 1858225.806452 P99 : 2021344.000000 P100 : 2021344.000000 COUNT : 57 SUM : 69993028 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 : 11335.000000 P99 : 60691.000000 P100 : 60691.000000 COUNT : 53 SUM : 213020 rocksdb.compaction.outfile.sync.micros P50 : 2627.272727 P95 : 9004.285714 P99 : 33340.000000 P100 : 38203.000000 COUNT : 196 SUM : 686468 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 : 258.666667 P95 : 1805.714286 P99 : 4235.000000 P100 : 16569.000000 COUNT : 122 SUM : 77915 rocksdb.table.open.io.micros P50 : 5862.637363 P95 : 19993.548387 P99 : 28490.000000 P100 : 86081.000000 COUNT : 551 SUM : 3917075 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.481878 P95 : 9.766377 P99 : 233.420209 P100 : 62906.000000 COUNT : 4088057 SUM : 70649701 rocksdb.read.block.get.micros P50 : 216.131233 P95 : 1026.525319 P99 : 3631.649438 P100 : 61103.000000 COUNT : 198372 SUM : 72684595 rocksdb.write.raw.block.micros P50 : 0.535690 P95 : 1.382178 P99 : 4.241393 P100 : 114811.000000 COUNT : 4718529 SUM : 17572499 rocksdb.numfiles.in.singlecompaction P50 : 3.310345 P95 : 5.642857 P99 : 7.000000 P100 : 7.000000 COUNT : 70 SUM : 260 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.559505 P95 : 1104.217622 P99 : 1274.355202 P100 : 815794.000000 COUNT : 9318 SUM : 4566676 rocksdb.sst.read.micros P50 : 2.167423 P95 : 154.021165 P99 : 569.873401 P100 : 63063.000000 COUNT : 4144804 SUM : 129788311 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 : 170996 SUM : 170996000 rocksdb.bytes.per.write P50 : 1032.000000 P95 : 1032.000000 P99 : 1032.000000 P100 : 1032.000000 COUNT : 3889232 SUM : 4013687424 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 : 227777.777778 P95 : 894000.000000 P99 : 1087055.000000 P100 : 1087055.000000 COUNT : 54 SUM : 17301164 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 : 211 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