[2024-07-24 16:32:04.869930] Starting SPDK v24.09-pre git sha1 8ee2672c4 / DPDK 24.03.0 initialization... [2024-07-24 16:32:04.870108] [ 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_pid1580500 ] Set seed to 1721831524866105 because --seed was 0 EAL: No free 2048 kB hugepages reported on node 1 [2024-07-24 16:32:04.978737] app.c: 909:spdk_app_start: *NOTICE*: Total cores available: 1 [2024-07-24 16:32:05.187131] app.c: 603:app_setup_trace: *NOTICE*: Tracepoint Group Mask 0x80 specified. [2024-07-24 16:32:05.187178] app.c: 604:app_setup_trace: *NOTICE*: Use 'spdk_trace -s rocksdb -p 1580500' to capture a snapshot of events at runtime. [2024-07-24 16:32:05.187188] app.c: 609:app_setup_trace: *NOTICE*: 'spdk_trace' without parameters will also work if this is the only [2024-07-24 16:32:05.187199] app.c: 610:app_setup_trace: *NOTICE*: SPDK application currently running. [2024-07-24 16:32:05.187206] app.c: 611:app_setup_trace: *NOTICE*: Or copy /dev/shm/rocksdb_trace.pid1580500 for offline analysis/debug. [2024-07-24 16:32:05.187291] reactor.c: 941:reactor_run: *NOTICE*: Reactor started on core 0 RocksDB: version 8.1.1 Date: Wed Jul 24 16:32:14 2024 CPU: 96 * Intel(R) Xeon(R) Gold 6252 CPU @ 2.10GHz CPUCache: 36608 KB 2024/07/24-16:32:19 ... thread 0: (1000000,1000000) ops and (183929.6,183929.6) ops/second in (5.436863,5.436863) 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/14 2.03 GB 56.7 0.3 0.0 0.3 1.1 0.8 0.0 1.4 52.0 187.2 6.06 3.52 12 0.505 319K 340 0.0 0.0 L1 5/5 436.48 MB 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L3 12/0 928.45 MB 0.9 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 159/0 9.58 GB 1.0 2.9 1.9 1.0 2.9 1.9 0.2 1.5 100.2 99.6 29.47 13.95 17 1.733 477K 0 0.0 0.0 L5 1124/0 92.46 GB 0.9 0.0 0.0 0.0 0.0 0.0 5.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 1318/19 105.40 GB 0.0 3.2 1.9 1.3 4.0 2.7 5.2 5.0 92.0 114.5 35.52 17.47 29 1.225 797K 340 0.0 0.0 Int 0/0 0.00 KB 0.0 3.2 1.9 1.3 4.0 2.7 5.2 5.0 92.0 114.5 35.52 17.47 29 1.225 797K 340 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 3.2 1.9 1.3 3.2 1.9 0.0 0.0 106.2 105.6 30.77 15.15 18 1.709 797K 340 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 172.3 4.75 2.32 11 0.432 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): 5.7 total, 5.4 interval Flush(GB): cumulative 0.800, interval 0.800 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: 3.97 GB write, 719.96 MB/s write, 3.19 GB read, 578.41 MB/s read, 35.5 seconds Interval compaction: 3.97 GB write, 748.14 MB/s write, 3.19 GB read, 601.04 MB/s read, 35.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: 29, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 0, total-stops: 29, interval: 29 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 293865 Average: 11.5386 StdDev: 151.47 Min: 1 Median: 1.7097 Max: 14721 Percentiles: P50: 1.71 P75: 2.42 P99: 14.03 P99.9: 2099.01 P99.99: 3602.97 ------------------------------------------------------ [ 0, 1 ] 25537 8.690% 8.690% ## ( 1, 2 ] 171056 58.209% 66.899% ############ ( 2, 3 ] 56451 19.210% 86.109% #### ( 3, 4 ] 16186 5.508% 91.617% # ( 4, 6 ] 16290 5.543% 97.160% # ( 6, 10 ] 4740 1.613% 98.773% ( 10, 15 ] 827 0.281% 99.055% ( 15, 22 ] 119 0.040% 99.095% ( 22, 34 ] 5 0.002% 99.097% ( 34, 51 ] 1 0.000% 99.097% ( 76, 110 ] 56 0.019% 99.116% ( 110, 170 ] 435 0.148% 99.264% ( 170, 250 ] 363 0.124% 99.388% ( 250, 380 ] 265 0.090% 99.478% ( 380, 580 ] 289 0.098% 99.576% ( 580, 870 ] 310 0.105% 99.682% ( 870, 1300 ] 301 0.102% 99.784% ( 1300, 1900 ] 287 0.098% 99.882% ( 1900, 2900 ] 267 0.091% 99.973% ( 2900, 4400 ] 108 0.037% 100.010% ( 4400, 6600 ] 23 0.008% 100.017% ( 6600, 9900 ] 8 0.003% 100.020% ( 9900, 14000 ] 8 0.003% 100.023% ( 14000, 22000 ] 2 0.001% 100.023% ** Level 1 read latency histogram (micros): Count: 70 Average: 1852.1714 StdDev: 3667.53 Min: 102 Median: 480.0000 Max: 17584 Percentiles: P50: 480.00 P75: 1360.00 P99: 17584.00 P99.9: 17584.00 P99.99: 17584.00 ------------------------------------------------------ ( 76, 110 ] 1 1.429% 1.429% ( 110, 170 ] 12 17.143% 18.571% ### ( 170, 250 ] 9 12.857% 31.429% ### ( 250, 380 ] 8 11.429% 42.857% ## ( 380, 580 ] 10 14.286% 57.143% ### ( 580, 870 ] 6 8.571% 65.714% ## ( 870, 1300 ] 6 8.571% 74.286% ## ( 1300, 1900 ] 5 7.143% 81.429% # ( 1900, 2900 ] 3 4.286% 85.714% # ( 2900, 4400 ] 1 1.429% 87.143% ( 4400, 6600 ] 5 7.143% 94.286% # ( 9900, 14000 ] 1 1.429% 95.714% ( 14000, 22000 ] 3 4.286% 100.000% # ** Level 3 read latency histogram (micros): Count: 238304 Average: 18.8947 StdDev: 203.02 Min: 1 Median: 2.1497 Max: 13213 Percentiles: P50: 2.15 P75: 3.02 P99: 13.08 P99.9: 1984.75 P99.99: 2420.67 ------------------------------------------------------ [ 0, 1 ] 2945 1.236% 1.236% ( 1, 2 ] 105793 44.394% 45.630% ######### ( 2, 3 ] 69546 29.184% 74.814% ###### ( 3, 4 ] 23541 9.879% 84.692% ## ( 4, 6 ] 25728 10.796% 95.489% ## ( 6, 10 ] 7457 3.129% 98.618% # ( 10, 15 ] 1478 0.620% 99.238% ( 15, 22 ] 237 0.099% 99.337% ( 22, 34 ] 19 0.008% 99.345% ( 34, 51 ] 4 0.002% 99.347% ( 51, 76 ] 4 0.002% 99.349% ( 76, 110 ] 9 0.004% 99.353% ( 110, 170 ] 38 0.016% 99.368% ( 170, 250 ] 47 0.020% 99.388% ( 250, 380 ] 61 0.026% 99.414% ( 380, 580 ] 108 0.045% 99.459% ( 580, 870 ] 183 0.077% 99.536% ( 870, 1300 ] 367 0.154% 99.690% ( 1300, 1900 ] 459 0.193% 99.883% ( 1900, 2900 ] 492 0.206% 100.089% ( 2900, 4400 ] 249 0.104% 100.193% ( 4400, 6600 ] 70 0.029% 100.223% ( 6600, 9900 ] 6 0.003% 100.225% ( 9900, 14000 ] 1 0.000% 100.226% ** Level 4 read latency histogram (micros): Count: 187769 Average: 33.1880 StdDev: 280.88 Min: 1 Median: 2.0774 Max: 10768 Percentiles: P50: 2.08 P75: 2.96 P99: 1079.20 P99.9: 3283.82 P99.99: 4036.01 ------------------------------------------------------ [ 0, 1 ] 3353 1.786% 1.786% ( 1, 2 ] 86410 46.019% 47.805% ######### ( 2, 3 ] 53240 28.354% 76.159% ###### ( 3, 4 ] 17605 9.376% 85.535% ## ( 4, 6 ] 17630 9.389% 94.924% ## ( 6, 10 ] 4859 2.588% 97.512% # ( 10, 15 ] 985 0.525% 98.036% ( 15, 22 ] 159 0.085% 98.121% ( 22, 34 ] 10 0.005% 98.126% ( 34, 51 ] 1 0.001% 98.127% ( 51, 76 ] 2 0.001% 98.128% ( 76, 110 ] 46 0.024% 98.153% ( 110, 170 ] 239 0.127% 98.280% ( 170, 250 ] 291 0.155% 98.435% ( 250, 380 ] 197 0.105% 98.540% ( 380, 580 ] 290 0.154% 98.694% ( 580, 870 ] 315 0.168% 98.862% ( 870, 1300 ] 533 0.284% 99.146% ( 1300, 1900 ] 641 0.341% 99.487% ( 1900, 2900 ] 689 0.367% 99.854% ( 2900, 4400 ] 337 0.179% 100.034% ( 4400, 6600 ] 119 0.063% 100.097% ( 6600, 9900 ] 17 0.009% 100.106% ( 9900, 14000 ] 1 0.001% 100.107% ** Level 5 read latency histogram (micros): Count: 13120 Average: 1188.5476 StdDev: 1459.52 Min: 78 Median: 535.0673 Max: 13219 Percentiles: P50: 535.07 P75: 1641.06 P99: 6458.16 P99.9: 9598.92 P99.99: 12924.16 ------------------------------------------------------ ( 76, 110 ] 288 2.195% 2.195% ( 110, 170 ] 2002 15.259% 17.454% ### ( 170, 250 ] 1911 14.566% 32.020% ### ( 250, 380 ] 1265 9.642% 41.662% ## ( 380, 580 ] 1411 10.755% 52.416% ## ( 580, 870 ] 1240 9.451% 61.867% ## ( 870, 1300 ] 1125 8.575% 70.442% ## ( 1300, 1900 ] 1052 8.018% 78.460% ## ( 1900, 2900 ] 1112 8.476% 86.936% ## ( 2900, 4400 ] 1043 7.950% 94.886% ## ( 4400, 6600 ] 577 4.398% 99.284% # ( 6600, 9900 ] 89 0.678% 99.962% ( 9900, 14000 ] 5 0.038% 100.000% ** DB Stats ** Uptime(secs): 5.7 total, 5.4 interval Cumulative writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 0.96 GB, 174.14 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:1.792 H:M:S, 31.7 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 180.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:1.792 H:M:S, 32.9 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 1 2024/07/24-16:32:27 ... thread 0: (1000000,2000000) ops and (123449.2,147739.3) ops/second in (8.100498,13.537361) 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 21/17 3.14 GB 50.4 1.5 0.0 1.5 3.4 1.9 0.0 1.8 109.2 244.5 14.42 11.19 35 0.412 1599K 1581 0.0 0.0 L1 5/5 436.48 MB 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L3 12/0 928.45 MB 0.9 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 159/0 9.58 GB 1.0 2.9 1.9 1.0 2.9 1.9 0.2 1.5 100.2 99.6 29.47 13.95 17 1.733 477K 0 0.0 0.0 L5 1124/0 92.46 GB 0.9 0.0 0.0 0.0 0.0 0.0 5.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 1321/22 106.51 GB 0.0 4.4 1.9 2.5 6.3 3.8 5.2 3.3 103.2 147.2 43.89 25.13 52 0.844 2076K 1581 0.0 0.0 Int 0/0 0.00 KB 0.0 4.4 1.9 2.5 6.3 3.8 5.2 3.3 103.2 147.2 43.89 25.13 52 0.844 2076K 1581 0.0 0.0 ** Compaction Stats [default] ** Priority Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) --------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- Low 0/0 0.00 KB 0.0 4.4 1.9 2.5 4.4 1.9 0.0 0.0 127.5 127.0 35.51 19.81 23 1.544 2076K 1581 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 1.9 1.9 0.0 0.0 0.0 233.2 8.37 5.32 29 0.289 0 0 0.0 0.0 Blob file count: 0, total size: 0.0 GB, garbage size: 0.0 GB, space amp: 0.0 Uptime(secs): 13.8 total, 13.5 interval Flush(GB): cumulative 1.907, interval 1.907 AddFile(GB): cumulative 0.000, interval 0.000 AddFile(Total Files): cumulative 0, interval 0 AddFile(L0 Files): cumulative 0, interval 0 AddFile(Keys): cumulative 0, interval 0 Cumulative compaction: 6.31 GB write, 469.85 MB/s write, 4.42 GB read, 329.32 MB/s read, 43.9 seconds Interval compaction: 6.31 GB write, 477.23 MB/s write, 4.42 GB read, 334.49 MB/s read, 43.9 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 11, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 11, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 29, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 11, total-stops: 29, interval: 40 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 849090 Average: 17.0335 StdDev: 104.94 Min: 0 Median: 1.5412 Max: 14721 Percentiles: P50: 1.54 P75: 1.98 P99: 250.19 P99.9: 828.37 P99.99: 1764.00 ------------------------------------------------------ [ 0, 1 ] 164243 19.343% 19.343% #### ( 1, 2 ] 480938 56.642% 75.985% ########### ( 2, 3 ] 92435 10.886% 86.871% ## ( 3, 4 ] 27068 3.188% 90.059% # ( 4, 6 ] 23491 2.767% 92.826% # ( 6, 10 ] 5894 0.694% 93.520% ( 10, 15 ] 1240 0.146% 93.666% ( 15, 22 ] 176 0.021% 93.687% ( 22, 34 ] 11 0.001% 93.688% ( 34, 51 ] 4 0.000% 93.689% ( 51, 76 ] 2 0.000% 93.689% ( 76, 110 ] 2128 0.251% 93.939% ( 110, 170 ] 25268 2.976% 96.915% # ( 170, 250 ] 17698 2.084% 99.000% ( 250, 380 ] 4250 0.501% 99.500% ( 380, 580 ] 2568 0.302% 99.803% ( 580, 870 ] 969 0.114% 99.917% ( 870, 1300 ] 390 0.046% 99.963% ( 1300, 1900 ] 304 0.036% 99.998% ( 1900, 2900 ] 286 0.034% 100.032% ( 2900, 4400 ] 123 0.014% 100.047% ( 4400, 6600 ] 24 0.003% 100.049% ( 6600, 9900 ] 8 0.001% 100.050% ( 9900, 14000 ] 8 0.001% 100.051% ( 14000, 22000 ] 2 0.000% 100.052% ** Level 1 read latency histogram (micros): Count: 704 Average: 359.6378 StdDev: 1265.13 Min: 95 Median: 166.5868 Max: 17584 Percentiles: P50: 166.59 P75: 231.27 P99: 5262.40 P99.9: 17584.00 P99.99: 17584.00 ------------------------------------------------------ ( 76, 110 ] 37 5.256% 5.256% # ( 110, 170 ] 334 47.443% 52.699% ######### ( 170, 250 ] 205 29.119% 81.818% ###### ( 250, 380 ] 51 7.244% 89.063% # ( 380, 580 ] 35 4.972% 94.034% # ( 580, 870 ] 16 2.273% 96.307% ( 870, 1300 ] 7 0.994% 97.301% ( 1300, 1900 ] 5 0.710% 98.011% ( 1900, 2900 ] 4 0.568% 98.580% ( 2900, 4400 ] 1 0.142% 98.722% ( 4400, 6600 ] 5 0.710% 99.432% ( 9900, 14000 ] 1 0.142% 99.574% ( 14000, 22000 ] 3 0.426% 100.000% ** Level 3 read latency histogram (micros): Count: 240066 Average: 20.1775 StdDev: 203.03 Min: 1 Median: 2.1624 Max: 13213 Percentiles: P50: 2.16 P75: 3.07 P99: 163.64 P99.9: 1981.17 P99.99: 2420.31 ------------------------------------------------------ [ 0, 1 ] 2945 1.227% 1.227% ( 1, 2 ] 105793 44.068% 45.295% ######### ( 2, 3 ] 69546 28.970% 74.265% ###### ( 3, 4 ] 23541 9.806% 84.071% ## ( 4, 6 ] 25728 10.717% 94.788% ## ( 6, 10 ] 7457 3.106% 97.894% # ( 10, 15 ] 1478 0.616% 98.510% ( 15, 22 ] 237 0.099% 98.608% ( 22, 34 ] 19 0.008% 98.616% ( 34, 51 ] 4 0.002% 98.618% ( 51, 76 ] 4 0.002% 98.620% ( 76, 110 ] 107 0.045% 98.664% ( 110, 170 ] 902 0.376% 99.040% ( 170, 250 ] 624 0.260% 99.300% ( 250, 380 ] 174 0.072% 99.372% ( 380, 580 ] 185 0.077% 99.449% ( 580, 870 ] 214 0.089% 99.538% ( 870, 1300 ] 369 0.154% 99.692% ( 1300, 1900 ] 459 0.191% 99.883% ( 1900, 2900 ] 492 0.205% 100.088% ( 2900, 4400 ] 249 0.104% 100.192% ( 4400, 6600 ] 70 0.029% 100.221% ( 6600, 9900 ] 6 0.002% 100.224% ( 9900, 14000 ] 1 0.000% 100.224% ** Level 4 read latency histogram (micros): Count: 203217 Average: 44.2821 StdDev: 274.76 Min: 1 Median: 2.2193 Max: 10768 Percentiles: P50: 2.22 P75: 3.50 P99: 977.37 P99.9: 3215.06 P99.99: 4029.13 ------------------------------------------------------ [ 0, 1 ] 3353 1.650% 1.650% ( 1, 2 ] 86487 42.559% 44.209% ######### ( 2, 3 ] 53669 26.410% 70.619% ##### ( 3, 4 ] 17849 8.783% 79.402% ## ( 4, 6 ] 18039 8.877% 88.279% ## ( 6, 10 ] 4913 2.418% 90.696% ( 10, 15 ] 991 0.488% 91.184% ( 15, 22 ] 159 0.078% 91.262% ( 22, 34 ] 10 0.005% 91.267% ( 34, 51 ] 1 0.000% 91.267% ( 51, 76 ] 2 0.001% 91.268% ( 76, 110 ] 726 0.357% 91.626% ( 110, 170 ] 7330 3.607% 95.233% # ( 170, 250 ] 4871 2.397% 97.630% ( 250, 380 ] 1207 0.594% 98.224% ( 380, 580 ] 941 0.463% 98.687% ( 580, 870 ] 497 0.245% 98.931% ( 870, 1300 ] 560 0.276% 99.207% ( 1300, 1900 ] 644 0.317% 99.524% ( 1900, 2900 ] 694 0.342% 99.865% ( 2900, 4400 ] 337 0.166% 100.031% ( 4400, 6600 ] 119 0.059% 100.090% ( 6600, 9900 ] 17 0.008% 100.098% ( 9900, 14000 ] 1 0.000% 100.098% ** Level 5 read latency histogram (micros): Count: 121540 Average: 300.5950 StdDev: 580.68 Min: 78 Median: 168.8696 Max: 13219 Percentiles: P50: 168.87 P75: 233.84 P99: 3626.70 P99.9: 6494.99 P99.99: 9634.74 ------------------------------------------------------ ( 76, 110 ] 5569 4.582% 4.582% # ( 110, 170 ] 56261 46.290% 50.872% ######### ( 170, 250 ] 36748 30.235% 81.107% ###### ( 250, 380 ] 8951 7.365% 88.472% # ( 380, 580 ] 6174 5.080% 93.552% # ( 580, 870 ] 2606 2.144% 95.696% ( 870, 1300 ] 1291 1.062% 96.758% ( 1300, 1900 ] 1072 0.882% 97.640% ( 1900, 2900 ] 1141 0.939% 98.579% ( 2900, 4400 ] 1056 0.869% 99.448% ( 4400, 6600 ] 577 0.475% 99.923% ( 6600, 9900 ] 89 0.073% 99.996% ( 9900, 14000 ] 5 0.004% 100.000% ** DB Stats ** Uptime(secs): 13.8 total, 8.1 interval Cumulative writes: 0 writes, 2000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 1.92 GB, 143.12 MB/s Cumulative WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Cumulative stall: 00:00:6.222 H:M:S, 45.2 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 121.49 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:4.430 H:M:S, 54.7 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 2 num-running-flushes: 0 2024/07/24-16:32:35 ... thread 0: (1000000,3000000) ops and (140479.1,145237.2) ops/second in (7.118499,20.655860) 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/10 4.05 GB 288.6 3.9 0.0 3.9 6.8 2.8 0.0 2.4 152.0 260.9 26.51 22.67 55 0.482 4092K 11K 0.0 0.0 L1 5/5 436.48 MB 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L3 12/0 928.45 MB 0.9 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 159/0 9.58 GB 1.0 2.9 1.9 1.0 2.9 1.9 0.2 1.5 100.2 99.6 29.47 13.95 17 1.733 477K 0 0.0 0.0 L5 1124/0 92.46 GB 0.9 0.0 0.0 0.0 0.0 0.0 5.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 1318/15 107.42 GB 0.0 6.8 1.9 4.9 9.6 4.7 5.2 3.4 124.8 176.0 55.97 36.61 72 0.777 4570K 11K 0.0 0.0 Int 0/0 0.00 KB 0.0 6.8 1.9 4.9 9.6 4.7 5.2 3.4 124.8 176.0 55.97 36.61 72 0.777 4570K 11K 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.8 1.9 4.9 6.8 1.9 0.0 0.0 156.6 155.9 44.61 28.79 28 1.593 4570K 11K 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 254.9 11.37 7.83 44 0.258 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): 20.9 total, 20.7 interval Flush(GB): cumulative 2.830, interval 2.830 AddFile(GB): cumulative 0.000, interval 0.000 AddFile(Total Files): cumulative 0, interval 0 AddFile(L0 Files): cumulative 0, interval 0 AddFile(Keys): cumulative 0, interval 0 Cumulative compaction: 9.62 GB write, 472.05 MB/s write, 6.82 GB read, 334.66 MB/s read, 56.0 seconds Interval compaction: 9.62 GB write, 476.92 MB/s write, 6.82 GB read, 338.11 MB/s read, 56.0 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 20, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 20, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 29, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 20, total-stops: 29, interval: 49 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 1320457 Average: 18.6377 StdDev: 94.11 Min: 0 Median: 1.5136 Max: 14721 Percentiles: P50: 1.51 P75: 1.96 P99: 272.23 P99.9: 726.94 P99.99: 1249.81 ------------------------------------------------------ [ 0, 1 ] 277314 21.001% 21.001% #### ( 1, 2 ] 745496 56.457% 77.459% ########### ( 2, 3 ] 122396 9.269% 86.728% ## ( 3, 4 ] 35656 2.700% 89.428% # ( 4, 6 ] 29640 2.245% 91.673% ( 6, 10 ] 7039 0.533% 92.206% ( 10, 15 ] 1620 0.123% 92.329% ( 15, 22 ] 240 0.018% 92.347% ( 22, 34 ] 18 0.001% 92.348% ( 34, 51 ] 5 0.000% 92.349% ( 51, 76 ] 4 0.000% 92.349% ( 76, 110 ] 4119 0.312% 92.661% ( 110, 170 ] 48588 3.680% 96.341% # ( 170, 250 ] 33793 2.559% 98.900% # ( 250, 380 ] 7744 0.586% 99.486% ( 380, 580 ] 4664 0.353% 99.839% ( 580, 870 ] 1580 0.120% 99.959% ( 870, 1300 ] 463 0.035% 99.994% ( 1300, 1900 ] 324 0.025% 100.019% ( 1900, 2900 ] 303 0.023% 100.042% ( 2900, 4400 ] 134 0.010% 100.052% ( 4400, 6600 ] 24 0.002% 100.054% ( 6600, 9900 ] 8 0.001% 100.054% ( 9900, 14000 ] 8 0.001% 100.055% ( 14000, 22000 ] 2 0.000% 100.055% ** Level 1 read latency histogram (micros): Count: 1215 Average: 292.3465 StdDev: 969.08 Min: 87 Median: 167.2348 Max: 17584 Percentiles: P50: 167.23 P75: 228.83 P99: 2362.50 P99.9: 17584.00 P99.99: 17584.00 ------------------------------------------------------ ( 76, 110 ] 59 4.856% 4.856% # ( 110, 170 ] 575 47.325% 52.181% ######### ( 170, 250 ] 377 31.029% 83.210% ###### ( 250, 380 ] 91 7.490% 90.700% # ( 380, 580 ] 59 4.856% 95.556% # ( 580, 870 ] 28 2.305% 97.860% ( 870, 1300 ] 7 0.576% 98.436% ( 1300, 1900 ] 5 0.412% 98.848% ( 1900, 2900 ] 4 0.329% 99.177% ( 2900, 4400 ] 1 0.082% 99.259% ( 4400, 6600 ] 5 0.412% 99.671% ( 9900, 14000 ] 1 0.082% 99.753% ( 14000, 22000 ] 3 0.247% 100.000% ** Level 3 read latency histogram (micros): Count: 241564 Average: 21.2595 StdDev: 203.04 Min: 1 Median: 2.1732 Max: 13213 Percentiles: P50: 2.17 P75: 3.12 P99: 211.28 P99.9: 1978.12 P99.99: 2420.01 ------------------------------------------------------ [ 0, 1 ] 2945 1.219% 1.219% ( 1, 2 ] 105793 43.795% 45.014% ######### ( 2, 3 ] 69546 28.790% 73.804% ###### ( 3, 4 ] 23541 9.745% 83.549% ## ( 4, 6 ] 25728 10.651% 94.200% ## ( 6, 10 ] 7457 3.087% 97.287% # ( 10, 15 ] 1478 0.612% 97.899% ( 15, 22 ] 237 0.098% 97.997% ( 22, 34 ] 19 0.008% 98.005% ( 34, 51 ] 4 0.002% 98.006% ( 51, 76 ] 4 0.002% 98.008% ( 76, 110 ] 174 0.072% 98.080% ( 110, 170 ] 1646 0.681% 98.761% ( 170, 250 ] 1117 0.462% 99.224% ( 250, 380 ] 274 0.113% 99.337% ( 380, 580 ] 256 0.106% 99.443% ( 580, 870 ] 233 0.096% 99.540% ( 870, 1300 ] 373 0.154% 99.694% ( 1300, 1900 ] 459 0.190% 99.884% ( 1900, 2900 ] 492 0.204% 100.088% ( 2900, 4400 ] 249 0.103% 100.191% ( 4400, 6600 ] 70 0.029% 100.220% ( 6600, 9900 ] 6 0.002% 100.222% ( 9900, 14000 ] 1 0.000% 100.223% ** Level 4 read latency histogram (micros): Count: 216222 Average: 52.9294 StdDev: 270.21 Min: 1 Median: 2.3396 Max: 10768 Percentiles: P50: 2.34 P75: 4.07 P99: 904.27 P99.9: 3160.85 P99.99: 4024.46 ------------------------------------------------------ [ 0, 1 ] 3353 1.551% 1.551% ( 1, 2 ] 86497 40.004% 41.555% ######## ( 2, 3 ] 53769 24.867% 66.422% ##### ( 3, 4 ] 17942 8.298% 74.720% ## ( 4, 6 ] 18276 8.452% 83.172% ## ( 6, 10 ] 4927 2.279% 85.451% ( 10, 15 ] 993 0.459% 85.910% ( 15, 22 ] 159 0.074% 85.984% ( 22, 34 ] 10 0.005% 85.988% ( 34, 51 ] 1 0.000% 85.989% ( 51, 76 ] 2 0.001% 85.990% ( 76, 110 ] 1260 0.583% 86.573% ( 110, 170 ] 13622 6.300% 92.873% # ( 170, 250 ] 8977 4.152% 97.024% # ( 250, 380 ] 2085 0.964% 97.989% ( 380, 580 ] 1477 0.683% 98.672% ( 580, 870 ] 663 0.307% 98.978% ( 870, 1300 ] 587 0.271% 99.250% ( 1300, 1900 ] 649 0.300% 99.550% ( 1900, 2900 ] 698 0.323% 99.873% ( 2900, 4400 ] 338 0.156% 100.029% ( 4400, 6600 ] 119 0.055% 100.084% ( 6600, 9900 ] 17 0.008% 100.092% ( 9900, 14000 ] 1 0.000% 100.092% ** Level 5 read latency histogram (micros): Count: 213642 Average: 254.4064 StdDev: 447.48 Min: 78 Median: 166.8489 Max: 13219 Percentiles: P50: 166.85 P75: 227.54 P99: 2554.08 P99.9: 6143.83 P99.99: 9293.24 ------------------------------------------------------ ( 76, 110 ] 9507 4.450% 4.450% # ( 110, 170 ] 102708 48.075% 52.525% ########## ( 170, 250 ] 66756 31.247% 83.771% ###### ( 250, 380 ] 15219 7.124% 90.895% # ( 380, 580 ] 10209 4.779% 95.674% # ( 580, 870 ] 3788 1.773% 97.447% ( 870, 1300 ] 1444 0.676% 98.123% ( 1300, 1900 ] 1108 0.519% 98.641% ( 1900, 2900 ] 1172 0.549% 99.190% ( 2900, 4400 ] 1060 0.496% 99.686% ( 4400, 6600 ] 577 0.270% 99.956% ( 6600, 9900 ] 89 0.042% 99.998% ( 9900, 14000 ] 5 0.002% 100.000% ** DB Stats ** Uptime(secs): 20.9 total, 7.1 interval Cumulative writes: 0 writes, 3000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 2.88 GB, 141.47 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:9.693 H:M:S, 46.4 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 138.28 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:3.471 H:M:S, 48.8 percent Write Stall (count): write-buffer-manager-limit-stops: 0, num-running-compactions: 1 num-running-flushes: 0 2024/07/24-16:32:44 ... thread 0: (1000000,4000000) ops and (106843.4,133265.2) ops/second in (9.359489,30.015349) seconds ** Compaction Stats [default] ** Level Files Size Score Read(GB) Rn(GB) Rnp1(GB) Write(GB) Wnew(GB) Moved(GB) W-Amp Rd(MB/s) Wr(MB/s) Comp(sec) CompMergeCPU(sec) Comp(cnt) Avg(sec) KeyIn KeyDrop Rblob(GB) Wblob(GB) ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------ L0 19/14 4.96 GB 357.1 6.0 0.0 6.0 9.7 3.7 0.0 2.6 164.4 267.2 37.16 32.74 74 0.502 6202K 19K 0.0 0.0 L1 5/5 436.48 MB 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L3 12/0 928.45 MB 0.9 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 L4 159/0 9.58 GB 1.0 2.9 1.9 1.0 2.9 1.9 0.2 1.5 100.2 99.6 29.47 13.95 17 1.733 477K 0 0.0 0.0 L5 1124/0 92.46 GB 0.9 0.0 0.0 0.0 0.0 0.0 5.0 0.0 0.0 0.0 0.00 0.00 0 0.000 0 0 0.0 0.0 Sum 1319/19 108.34 GB 0.0 8.8 1.9 6.9 12.6 5.6 5.2 3.3 136.0 193.1 66.63 46.69 91 0.732 6679K 19K 0.0 0.0 Int 0/0 0.00 KB 0.0 8.8 1.9 6.9 12.6 5.6 5.2 3.3 136.0 193.1 66.63 46.69 91 0.732 6679K 19K 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 8.8 1.9 6.9 8.8 1.9 0.0 0.0 173.4 172.7 52.27 36.34 32 1.633 6679K 19K 0.0 0.0 High 0/0 0.00 KB 0.0 0.0 0.0 0.0 3.8 3.8 0.0 0.0 0.0 267.5 14.36 10.35 59 0.243 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): 30.2 total, 30.0 interval Flush(GB): cumulative 3.753, interval 3.753 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.57 GB write, 425.63 MB/s write, 8.85 GB read, 299.77 MB/s read, 66.6 seconds Interval compaction: 12.57 GB write, 428.64 MB/s write, 8.85 GB read, 301.90 MB/s read, 66.6 seconds Write Stall (count): cf-l0-file-count-limit-delays-with-ongoing-compaction: 28, cf-l0-file-count-limit-stops-with-ongoing-compaction: 0, l0-file-count-limit-delays: 28, l0-file-count-limit-stops: 0, memtable-limit-delays: 0, memtable-limit-stops: 29, pending-compaction-bytes-delays: 0, pending-compaction-bytes-stops: 0, total-delays: 28, total-stops: 29, interval: 57 total count ** File Read Latency Histogram By Level [default] ** ** Level 0 read latency histogram (micros): Count: 1937424 Average: 19.7088 StdDev: 87.23 Min: 0 Median: 1.4933 Max: 14721 Percentiles: P50: 1.49 P75: 1.94 P99: 277.45 P99.9: 669.46 P99.99: 972.13 ------------------------------------------------------ [ 0, 1 ] 433917 22.397% 22.397% #### ( 1, 2 ] 1084074 55.954% 78.351% ########### ( 2, 3 ] 157427 8.126% 86.477% ## ( 3, 4 ] 47120 2.432% 88.909% ( 4, 6 ] 37483 1.935% 90.843% ( 6, 10 ] 8288 0.428% 91.271% ( 10, 15 ] 1907 0.098% 91.370% ( 15, 22 ] 293 0.015% 91.385% ( 22, 34 ] 22 0.001% 91.386% ( 34, 51 ] 7 0.000% 91.386% ( 51, 76 ] 5 0.000% 91.386% ( 76, 110 ] 7597 0.392% 91.779% ( 110, 170 ] 82580 4.262% 96.041% # ( 170, 250 ] 54806 2.829% 98.870% # ( 250, 380 ] 11952 0.617% 99.487% ( 380, 580 ] 7288 0.376% 99.863% ( 580, 870 ] 2336 0.121% 99.983% ( 870, 1300 ] 540 0.028% 100.011% ( 1300, 1900 ] 335 0.017% 100.029% ( 1900, 2900 ] 319 0.016% 100.045% ( 2900, 4400 ] 155 0.008% 100.053% ( 4400, 6600 ] 25 0.001% 100.054% ( 6600, 9900 ] 8 0.000% 100.055% ( 9900, 14000 ] 8 0.000% 100.055% ( 14000, 22000 ] 2 0.000% 100.055% ** Level 1 read latency histogram (micros): Count: 1897 Average: 254.6484 StdDev: 778.92 Min: 87 Median: 165.7889 Max: 17584 Percentiles: P50: 165.79 P75: 224.63 P99: 1303.60 P99.9: 16941.33 P99.99: 17584.00 ------------------------------------------------------ ( 76, 110 ] 94 4.955% 4.955% # ( 110, 170 ] 919 48.445% 53.400% ########## ( 170, 250 ] 600 31.629% 85.029% ###### ( 250, 380 ] 136 7.169% 92.198% # ( 380, 580 ] 87 4.586% 96.784% # ( 580, 870 ] 35 1.845% 98.629% ( 870, 1300 ] 7 0.369% 98.998% ( 1300, 1900 ] 5 0.264% 99.262% ( 1900, 2900 ] 4 0.211% 99.473% ( 2900, 4400 ] 1 0.053% 99.526% ( 4400, 6600 ] 5 0.264% 99.789% ( 9900, 14000 ] 1 0.053% 99.842% ( 14000, 22000 ] 3 0.158% 100.000% ** Level 3 read latency histogram (micros): Count: 243573 Average: 22.6168 StdDev: 202.97 Min: 1 Median: 2.1876 Max: 13213 Percentiles: P50: 2.19 P75: 3.19 P99: 234.38 P99.9: 1975.92 P99.99: 2420.57 ------------------------------------------------------ [ 0, 1 ] 2945 1.209% 1.209% ( 1, 2 ] 105793 43.434% 44.643% ######### ( 2, 3 ] 69546 28.552% 73.195% ###### ( 3, 4 ] 23541 9.665% 82.860% ## ( 4, 6 ] 25728 10.563% 93.423% ## ( 6, 10 ] 7457 3.062% 96.484% # ( 10, 15 ] 1478 0.607% 97.091% ( 15, 22 ] 237 0.097% 97.189% ( 22, 34 ] 19 0.008% 97.196% ( 34, 51 ] 4 0.002% 97.198% ( 51, 76 ] 4 0.002% 97.200% ( 76, 110 ] 271 0.111% 97.311% ( 110, 170 ] 2689 1.104% 98.415% ( 170, 250 ] 1771 0.727% 99.142% ( 250, 380 ] 404 0.166% 99.308% ( 380, 580 ] 320 0.131% 99.439% ( 580, 870 ] 252 0.103% 99.543% ( 870, 1300 ] 374 0.154% 99.696% ( 1300, 1900 ] 459 0.188% 99.885% ( 1900, 2900 ] 493 0.202% 100.087% ( 2900, 4400 ] 249 0.102% 100.189% ( 4400, 6600 ] 70 0.029% 100.218% ( 6600, 9900 ] 6 0.002% 100.220% ( 9900, 14000 ] 1 0.000% 100.221% ** Level 4 read latency histogram (micros): Count: 233904 Average: 63.2676 StdDev: 264.16 Min: 1 Median: 2.5040 Max: 10768 Percentiles: P50: 2.50 P75: 5.52 P99: 839.03 P99.9: 3086.27 P99.99: 4017.74 ------------------------------------------------------ [ 0, 1 ] 3353 1.433% 1.433% ( 1, 2 ] 86497 36.980% 38.413% ####### ( 2, 3 ] 53769 22.988% 61.401% ##### ( 3, 4 ] 17942 7.671% 69.071% ## ( 4, 6 ] 18277 7.814% 76.885% ## ( 6, 10 ] 4927 2.106% 78.992% ( 10, 15 ] 993 0.425% 79.416% ( 15, 22 ] 159 0.068% 79.484% ( 22, 34 ] 10 0.004% 79.489% ( 34, 51 ] 1 0.000% 79.489% ( 51, 76 ] 2 0.001% 79.490% ( 76, 110 ] 2091 0.894% 80.384% ( 110, 170 ] 22735 9.720% 90.104% ## ( 170, 250 ] 14674 6.274% 96.377% # ( 250, 380 ] 3203 1.369% 97.747% ( 380, 580 ] 2137 0.914% 98.660% ( 580, 870 ] 890 0.380% 99.041% ( 870, 1300 ] 608 0.260% 99.301% ( 1300, 1900 ] 652 0.279% 99.579% ( 1900, 2900 ] 708 0.303% 99.882% ( 2900, 4400 ] 339 0.145% 100.027% ( 4400, 6600 ] 119 0.051% 100.078% ( 6600, 9900 ] 17 0.007% 100.085% ( 9900, 14000 ] 1 0.000% 100.086% ** Level 5 read latency histogram (micros): Count: 337056 Average: 230.5097 StdDev: 363.71 Min: 78 Median: 165.3268 Max: 13219 Percentiles: P50: 165.33 P75: 223.51 P99: 1677.62 P99.9: 5669.46 P99.99: 8798.56 ------------------------------------------------------ ( 76, 110 ] 15434 4.579% 4.579% # ( 110, 170 ] 166025 49.257% 53.836% ########## ( 170, 250 ] 106645 31.640% 85.477% ###### ( 250, 380 ] 23110 6.856% 92.333% # ( 380, 580 ] 15084 4.475% 96.808% # ( 580, 870 ] 5088 1.510% 98.318% ( 870, 1300 ] 1587 0.471% 98.789% ( 1300, 1900 ] 1132 0.336% 99.124% ( 1900, 2900 ] 1212 0.360% 99.484% ( 2900, 4400 ] 1069 0.317% 99.801% ( 4400, 6600 ] 577 0.171% 99.972% ( 6600, 9900 ] 89 0.026% 99.999% ( 9900, 14000 ] 5 0.001% 100.000% ** DB Stats ** Uptime(secs): 30.2 total, 9.4 interval Cumulative writes: 0 writes, 4000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 3.84 GB, 130.23 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:15.406 H:M:S, 51.0 percent Interval writes: 0 writes, 1000K keys, 0 commit groups, 0.0 writes per commit group, ingest: 984.19 MB, 105.15 MB/s Interval WAL: 0 writes, 0 syncs, 0.00 writes per sync, written: 0.00 GB, 0.00 MB/s Interval stall: 00:00:5.713 H:M:S, 61.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: 100000000 Prefix: 0 bytes Keys per prefix: 0 RawSize: 96893.3 MB (estimated) FileSize: 96893.3 MB (estimated) Write rate: 0 bytes/second Read rate: 0 ops/second Compression: NoCompression Compression sampling rate: 0 Memtablerep: SkipListFactory Perf Level: 1 ------------------------------------------------ DB path: [/mnt/rocksdb] readwhilewriting : 243.605 micros/op 16403 ops/sec 60.169 seconds 986996 operations; 15.9 MB/s (249999 of 249999 found) Microseconds per read: Count: 986996 Average: 243.6066 StdDev: 633.29 Min: 2 Median: 200.7891 Max: 72217 Percentiles: P50: 200.79 P75: 241.84 P99: 808.85 P99.9: 7829.78 P99.99: 29925.97 ------------------------------------------------------ ( 1, 2 ] 6 0.001% 0.001% ( 2, 3 ] 36 0.004% 0.004% ( 3, 4 ] 47 0.005% 0.009% ( 4, 6 ] 106 0.011% 0.020% ( 6, 10 ] 258 0.026% 0.046% ( 10, 15 ] 3086 0.313% 0.359% ( 15, 22 ] 3774 0.382% 0.741% ( 22, 34 ] 9765 0.989% 1.730% ( 34, 51 ] 2070 0.210% 1.940% ( 51, 76 ] 209 0.021% 1.961% ( 76, 110 ] 2959 0.300% 2.261% ( 110, 170 ] 286104 28.987% 31.248% ###### ( 170, 250 ] 480893 48.723% 79.971% ########## ( 250, 380 ] 116322 11.785% 91.757% ## ( 380, 580 ] 57963 5.873% 97.629% # ( 580, 870 ] 17143 1.737% 99.366% ( 870, 1300 ] 3688 0.374% 99.740% ( 1300, 1900 ] 623 0.063% 99.803% ( 1900, 2900 ] 453 0.046% 99.849% ( 2900, 4400 ] 249 0.025% 99.874% ( 4400, 6600 ] 176 0.018% 99.892% ( 6600, 9900 ] 212 0.021% 99.913% ( 9900, 14000 ] 226 0.023% 99.936% ( 14000, 22000 ] 396 0.040% 99.976% ( 22000, 33000 ] 185 0.019% 99.995% ( 33000, 50000 ] 41 0.004% 99.999% ( 50000, 75000 ] 6 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 : 14669312 rocksdb.bloom.filter.full.positive COUNT : 1128738 rocksdb.bloom.filter.full.true.positive COUNT : 986603 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 : 393 rocksdb.memtable.miss COUNT : 986603 rocksdb.l0.hit COUNT : 41789 rocksdb.l1.hit COUNT : 9208 rocksdb.l2andup.hit COUNT : 935606 rocksdb.compaction.key.drop.new COUNT : 75113 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 : 4478222 rocksdb.number.keys.read COUNT : 986996 rocksdb.number.keys.updated COUNT : 0 rocksdb.bytes.written COUNT : 4621525104 rocksdb.bytes.read COUNT : 986996000 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 : 1473 rocksdb.no.file.errors COUNT : 0 rocksdb.stall.micros COUNT : 43231958 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 : 13850878578 rocksdb.compact.write.bytes COUNT : 13767532231 rocksdb.flush.write.bytes COUNT : 4558133592 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 : 73 rocksdb.number.superversion_acquires COUNT : 749 rocksdb.number.superversion_releases COUNT : 717 rocksdb.number.superversion_cleanups COUNT : 187 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 : 147 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 : 4521141248 rocksdb.memtable.garbage.bytes.at.flush COUNT : 1549312 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 : 17864214852 rocksdb.non.last.level.read.count COUNT : 4169392 rocksdb.block.checksum.compute.count COUNT : 4491561 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 : 199.797035 P95 : 489.149817 P99 : 807.971057 P100 : 72215.000000 COUNT : 986996 SUM : 239467883 rocksdb.db.write.micros P50 : 1.521084 P95 : 4.405500 P99 : 11.287644 P100 : 822519.000000 COUNT : 4478222 SUM : 54180954 rocksdb.compaction.times.micros P50 : 1375000.000000 P95 : 5620000.000000 P99 : 39950096.000000 P100 : 39950096.000000 COUNT : 36 SUM : 98040413 rocksdb.compaction.times.cpu_micros P50 : 999090.909091 P95 : 5620000.000000 P99 : 12488000.000000 P100 : 13027393.000000 COUNT : 36 SUM : 55100987 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 : 781.585366 P95 : 5115.000000 P99 : 23306.000000 P100 : 23306.000000 COUNT : 67 SUM : 98060 rocksdb.compaction.outfile.sync.micros P50 : 3950.000000 P95 : 44687.500000 P99 : 167000.000000 P100 : 184441.000000 COUNT : 105 SUM : 1144563 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 : 186.296296 P95 : 6584.285714 P99 : 9071.000000 P100 : 9071.000000 COUNT : 121 SUM : 144685 rocksdb.table.open.io.micros P50 : 9304.166667 P95 : 20858.947368 P99 : 28090.000000 P100 : 31495.000000 COUNT : 1473 SUM : 14473231 rocksdb.db.multiget.micros P50 : 0.000000 P95 : 0.000000 P99 : 0.000000 P100 : 0.000000 COUNT : 0 SUM : 0 rocksdb.read.block.compaction.micros P50 : 3.653869 P95 : 140.223453 P99 : 244.315079 P100 : 10064.000000 COUNT : 3352791 SUM : 70955856 rocksdb.read.block.get.micros P50 : 157.801847 P95 : 343.262250 P99 : 682.642465 P100 : 28291.000000 COUNT : 1137308 SUM : 206414884 rocksdb.write.raw.block.micros P50 : 0.538704 P95 : 1.414076 P99 : 3.455975 P100 : 14455.000000 COUNT : 4438135 SUM : 11422449 rocksdb.numfiles.in.singlecompaction P50 : 3.352941 P95 : 7.200000 P99 : 27.520000 P100 : 30.000000 COUNT : 54 SUM : 241 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.567247 P95 : 1931.266247 P99 : 2706.588679 P100 : 822355.000000 COUNT : 231143 SUM : 43250486 rocksdb.sst.read.micros P50 : 1.951768 P95 : 230.319180 P99 : 471.503087 P100 : 17584.000000 COUNT : 4169509 SUM : 260923022 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 : 986996 SUM : 986996000 rocksdb.bytes.per.write P50 : 1032.000000 P95 : 1032.000000 P99 : 1032.000000 P100 : 1032.000000 COUNT : 4478222 SUM : 4621525104 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 : 214666.666667 P95 : 536750.000000 P99 : 972200.000000 P100 : 1043201.000000 COUNT : 67 SUM : 15958405 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 : 149 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