2024/08/20-22:43:31.641470 139856782554688 DEBG dcompact_worker.cpp:2211: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00: fork to child time = 0.016254 sec 2024/08/20-22:43:31.642975 139856782554688 DEBG dcompact_worker.cpp:1011: Beg SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00 2024/08/20-22:43:31.649484 139856782554688 DEBG dcompact_worker.cpp:1031: End SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00 2024/08/20-22:43:31.651454 139856782554688 TRAC dcompact_worker.cpp:1081: INFO_LOG_LEVEL: rpc = INFO_LEVEL, env_var = undefined 2024/08/20-22:43:31.651870 139856782554688 [WARN] [column_family.cc:386] multiple cf_paths/db_paths and level_compaction_dynamic_level_bytes can't be used together 2024/08/20-22:43:31.689841 139856782554688 [version_set.cc:6139] Recovering from manifest file: /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-08-20T02.42.00/.rocksdb/job-53523/att-00/MANIFEST-14629260 2024/08/20-22:43:31.727478 139856782554688 [version_set.cc:6182] Recovered from manifest file:/worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-08-20T02.42.00/.rocksdb/job-53523/att-00/MANIFEST-14629260 succeeded,manifest_file_number is 14629260, next_file_number is 14690883, last_sequence is 191140053003, log_number is 0,prev_log_number is 0,max_column_family is 0,min_log_number_to_keep is 14690812 2024/08/20-22:43:31.727491 139856782554688 [version_set.cc:6197] Column family [default] (ID 0), log number is 0 2024/08/20-22:43:31.727616 139856782554688 [version_set.cc:5652] Creating manifest 14690883 2024/08/20-22:43:31.752732 139856782554688 DEBG dcompact_worker.cpp:1215: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00: bottommost_level: fake = 1, rpc = 0 2024/08/20-22:43:31.767714 139856782554688 [compaction_job.cc:2433] [default] [JOB 53523] Compacting 1@1 + 9@2 files to L2, score 0.99, subcompactions 1 : 1 2024/08/20-22:43:31.767737 139856782554688 [compaction_job.cc:2441] [default]: Compaction start summary: Base version 27100 Base level 1, inputs: [14690832(31MB)], [14690785(20MB) 14690786(20MB) 14690787(19MB) 14690788(20MB) 14690789(20MB) 14690791(20MB) 14690792(20MB) 14690793(20MB) 14690876(19MB)] 2024/08/20-22:43:32.021699 139856782554688 [top_zip_table.cc:59] core git_version_hash_info_is:commit 7517bad5c1a147474c3830831b9a22c996321ae8 Author: leipeng Date: 2024-01-08 19:18:17 +0800 vfork_cmd: call close before wait_finish g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. INCS = -Isrc -I3rdparty/re2 -I3rdparty/zstd -Iboost-include CXXFLAGS = -D TOPLING_IO_WITH_URING=1 -fPIC -time -Wno-class-memaccess -fdiagnostics-color -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -mcx16 -Wno-deprecated-declarations -Wstrict-aliasing=3 -DCLIENT_LICENSE_ID="public" -DNO_THREADS -ftls-model=initial-exec -DDIVSUFSORT_API= -fno-stack-protector RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 2024/08/20-22:43:32.021730 139856782554688 [top_zip_table.cc:60] fsa git_version_hash_info_is:commit 7517bad5c1a147474c3830831b9a22c996321ae8 Author: leipeng Date: 2024-01-08 19:18:17 +0800 vfork_cmd: call close before wait_finish g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. INCS = -Isrc -I3rdparty/re2 -I3rdparty/zstd -Iboost-include CXXFLAGS = -D TOPLING_IO_WITH_URING=1 -fPIC -time -Wno-class-memaccess -fdiagnostics-color -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -mcx16 -Wno-deprecated-declarations -Wstrict-aliasing=3 -DCLIENT_LICENSE_ID="public" -DNO_THREADS -ftls-model=initial-exec -DDIVSUFSORT_API= -fno-stack-protector RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 2024/08/20-22:43:32.021747 139856782554688 [top_zip_table.cc:61] zbs git_version_hash_info_is:commit 7517bad5c1a147474c3830831b9a22c996321ae8 Author: leipeng Date: 2024-01-08 19:18:17 +0800 vfork_cmd: call close before wait_finish g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. INCS = -Isrc -I3rdparty/re2 -I3rdparty/zstd -Iboost-include CXXFLAGS = -D TOPLING_IO_WITH_URING=1 -fPIC -time -Wno-class-memaccess -fdiagnostics-color -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -mcx16 -Wno-deprecated-declarations -Wstrict-aliasing=3 -DCLIENT_LICENSE_ID="public" -DNO_THREADS -ftls-model=initial-exec -DDIVSUFSORT_API= -fno-stack-protector RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 2024/08/20-22:43:32.021758 139856782554688 [top_zip_table.cc:62] topling-zip_table_reader: git_version_hash_info_is: commit 7f80399bfbd2071b6e0f5683e8ab7225b8e6e394 Author: leipeng Date: 2024-01-19 14:52:30 +0800 Change ToplingZipTableOptions::sampleRatio to vector g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. cpu_flag: -march=native -mbmi -mbmi2 2024/08/20-22:43:32.021777 139856782554688 [top_zip_table.cc:64] topling-rocks git_version_hash_info_is: commit 1240987ca13d0fe562c9b9c037155079f0877840 Author: leipeng Date: 2024-01-19 15:07:04 +0800 Change ToplingZipTableOptions::sampleRatio to vector g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. cpu_flag: -march=native -mbmi -mbmi2 2024/08/20-22:43:32.185100 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690884.sst) /dev/shm/ToplingTemp/Topling-46430-Vxim7Y 2024/08/20-22:43:32.445363 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690884.sst): first pass time = 0.26's, 257.901'MB/sec 2024/08/20-22:43:33.771816 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690884.sst): old prealloc_size = 73819750, real_size = 19170768 2024/08/20-22:43:33.772201 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690884.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 465218 prefix = 4 raw-key = 0.0074 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0541 GB zip-val = 0.0182 GB avg-val = 116.25 avg-zval = 39.05 2024/08/20-22:43:33.772673 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690884.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:34.173314 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690884.sst): second pass time = 1.32's, 40.828'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.40's, 52.585'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2486.244'MB/sec (index lex order gen) rebuild zvType time = 0.32's, 0.362'MB/sec write SST data time = 0.08's, 263.655'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.544'MB, throughput = 13573.959'MB/sec zip my value time = 1.32's, unzip length = 0.054'GB zip my value throughput = 40.828'MB/sec zip pipeline throughput = 120.944'MB/sec entries = 465218 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.25 avg-zval = 39.05 usrkeys = 465218 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.25 avg-zval = 39.05 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 465218 bytes = 1511968 } seq expand size = 3256526 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0182 GB dict = 0.54 MB all = 0.0211 GB } UnZip/Zip{ index = 10.5036 value = 2.9767 dict = 1.00 all = 3.1784 } Zip/UnZip{ index = 0.0952 value = 0.3359 dict = 1.00 all = 0.3146 } ---------------------------- total value len = 0.057339 GB avg = 0.123 KB (by entry num) total key len = 0.013026 GB avg = 0.028 KB total ukey len = 0.009304 GB avg = 0.020 KB total ukey num = 0.000465218 Billion total entry num = 0.000465218 Billion write speed all = 0.007686783 MB/sec (with seq num) write speed all = 0.007280217 MB/sec (without seq num) 2024/08/20-22:43:34.204884 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690884: 465218 keys, 21113926 bytes, temperature: kWarm 2024/08/20-22:43:34.204988 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165014204929, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690884, "file_size": 21113926, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191078932271, "largest_seqno": 191139770160, "table_properties": {"data_size": 18168448, "index_size": 885824, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13026104, "raw_average_key_size": 28, "raw_value_size": 54082868, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 465218, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165012, "oldest_key_time": 0, "file_creation_time": 1724165012, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690884, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:34.231583 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690885.sst) /dev/shm/ToplingTemp/Topling-46430-Ox1TI0 2024/08/20-22:43:34.896411 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690885.sst): first pass time = 0.66's, 100.949'MB/sec 2024/08/20-22:43:35.596118 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690885.sst): old prealloc_size = 73819750, real_size = 18966944 2024/08/20-22:43:35.596472 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690885.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 467505 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0540 GB zip-val = 0.0180 GB avg-val = 115.55 avg-zval = 38.40 2024/08/20-22:43:35.596888 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690885.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:35.967409 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690885.sst): second pass time = 0.70's, 77.290'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.37's, 56.488'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2721.696'MB/sec (index lex order gen) rebuild zvType time = 0.31's, 0.383'MB/sec write SST data time = 0.07's, 318.845'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.542'MB, throughput = 14354.502'MB/sec zip my value time = 0.70's, unzip length = 0.054'GB zip my value throughput = 77.290'MB/sec zip pipeline throughput = 77.290'MB/sec entries = 467505 avg-key = 28.00 avg-zkey = 1.92 avg-val = 115.55 avg-zval = 38.40 usrkeys = 467505 avg-key = 20.00 avg-zkey = 1.92 avg-val = 122.55 avg-zval = 38.40 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 467505 bytes = 1577840 } seq expand size = 3272535 multi value expand size = 0 cnt WriteAppend = 14 UnZipSize{ index = 0.0094 GB value = 0.0540 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0180 GB dict = 0.54 MB all = 0.0210 GB } UnZip/Zip{ index = 10.4346 value = 3.0088 dict = 1.00 all = 3.1997 } Zip/UnZip{ index = 0.0958 value = 0.3324 dict = 1.00 all = 0.3125 } ---------------------------- total value len = 0.114631 GB avg = 0.123 KB (by entry num) total key len = 0.026116 GB avg = 0.028 KB total ukey len = 0.018654 GB avg = 0.020 KB total ukey num = 0.000932723 Billion total entry num = 0.000932723 Billion write speed all = 0.015372304 MB/sec (with seq num) write speed all = 0.014557333 MB/sec (without seq num) 2024/08/20-22:43:35.999945 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690885: 467505 keys, 20973402 bytes, temperature: kWarm 2024/08/20-22:43:36.000010 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165015999979, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690885, "file_size": 20973402, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191052376133, "largest_seqno": 191139770716, "table_properties": {"data_size": 17953808, "index_size": 896064, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13090140, "raw_average_key_size": 28, "raw_value_size": 54018842, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 467505, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165014, "oldest_key_time": 0, "file_creation_time": 1724165014, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690885, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:36.024458 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690886.sst) /dev/shm/ToplingTemp/Topling-46430-jBbiI1 2024/08/20-22:43:36.446647 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690886.sst): first pass time = 0.42's, 158.972'MB/sec 2024/08/20-22:43:37.241998 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690886.sst): old prealloc_size = 73819750, real_size = 18815152 2024/08/20-22:43:37.242387 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690886.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 465667 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0541 GB zip-val = 0.0178 GB avg-val = 116.11 avg-zval = 38.24 2024/08/20-22:43:37.242805 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690886.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:37.613831 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690886.sst): second pass time = 0.79's, 68.057'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.37's, 55.992'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2437.468'MB/sec (index lex order gen) rebuild zvType time = 0.30's, 0.382'MB/sec write SST data time = 0.07's, 311.773'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 13906.634'MB/sec zip my value time = 0.79's, unzip length = 0.054'GB zip my value throughput = 68.057'MB/sec zip pipeline throughput = 68.057'MB/sec entries = 465667 avg-key = 28.00 avg-zkey = 1.92 avg-val = 116.11 avg-zval = 38.24 usrkeys = 465667 avg-key = 20.00 avg-zkey = 1.92 avg-val = 123.11 avg-zval = 38.24 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 465667 bytes = 1571648 } seq expand size = 3259669 multi value expand size = 0 cnt WriteAppend = 16 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0178 GB dict = 0.54 MB all = 0.0208 GB } UnZip/Zip{ index = 10.4309 value = 3.0367 dict = 1.00 all = 3.2234 } Zip/UnZip{ index = 0.0959 value = 0.3293 dict = 1.00 all = 0.3102 } ---------------------------- total value len = 0.171961 GB avg = 0.123 KB (by entry num) total key len = 0.039155 GB avg = 0.028 KB total ukey len = 0.027968 GB avg = 0.020 KB total ukey num = 0.001398390 Billion total entry num = 0.001398390 Billion write speed all = 0.023053781 MB/sec (with seq num) write speed all = 0.021832150 MB/sec (without seq num) 2024/08/20-22:43:37.642867 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690886: 465667 keys, 20819152 bytes, temperature: kWarm 2024/08/20-22:43:37.642941 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165017642904, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690886, "file_size": 20819152, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191066443594, "largest_seqno": 191139769962, "table_properties": {"data_size": 17805664, "index_size": 892864, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13038676, "raw_average_key_size": 28, "raw_value_size": 54070314, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 465667, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165016, "oldest_key_time": 0, "file_creation_time": 1724165016, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690886, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:37.670515 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690887.sst) /dev/shm/ToplingTemp/Topling-46430-cSA5o1 2024/08/20-22:43:38.069509 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690887.sst): first pass time = 0.40's, 168.215'MB/sec 2024/08/20-22:43:38.757300 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690887.sst): old prealloc_size = 73819750, real_size = 18984576 2024/08/20-22:43:38.757654 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690887.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466303 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0541 GB zip-val = 0.0180 GB avg-val = 115.92 avg-zval = 38.55 2024/08/20-22:43:38.758118 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690887.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:39.138630 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690887.sst): second pass time = 0.69's, 78.681'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.38's, 55.190'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2754.553'MB/sec (index lex order gen) rebuild zvType time = 0.31's, 0.374'MB/sec write SST data time = 0.07's, 303.706'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 10738.406'MB/sec zip my value time = 0.69's, unzip length = 0.054'GB zip my value throughput = 78.681'MB/sec zip pipeline throughput = 78.681'MB/sec entries = 466303 avg-key = 28.00 avg-zkey = 1.92 avg-val = 115.92 avg-zval = 38.55 usrkeys = 466303 avg-key = 20.00 avg-zkey = 1.92 avg-val = 122.92 avg-zval = 38.55 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466303 bytes = 1632080 } seq expand size = 3264121 multi value expand size = 0 cnt WriteAppend = 15 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0180 GB dict = 0.54 MB all = 0.0210 GB } UnZip/Zip{ index = 10.4361 value = 3.0072 dict = 1.00 all = 3.1886 } Zip/UnZip{ index = 0.0958 value = 0.3325 dict = 1.00 all = 0.3136 } ---------------------------- total value len = 0.229277 GB avg = 0.123 KB (by entry num) total key len = 0.052211 GB avg = 0.028 KB total ukey len = 0.037294 GB avg = 0.020 KB total ukey num = 0.001864693 Billion total entry num = 0.001864693 Billion write speed all = 0.030733386 MB/sec (with seq num) write speed all = 0.029104665 MB/sec (without seq num) 2024/08/20-22:43:39.169828 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690887: 466303 keys, 21046394 bytes, temperature: kWarm 2024/08/20-22:43:39.169900 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165019169866, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690887, "file_size": 21046394, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 190996035480, "largest_seqno": 191139767376, "table_properties": {"data_size": 17974192, "index_size": 893632, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13056484, "raw_average_key_size": 28, "raw_value_size": 54052462, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466303, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165017, "oldest_key_time": 0, "file_creation_time": 1724165017, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690887, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:39.195304 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690888.sst) /dev/shm/ToplingTemp/Topling-46430-U9lIj0 2024/08/20-22:43:39.606843 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690888.sst): first pass time = 0.41's, 163.088'MB/sec 2024/08/20-22:43:40.311425 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690888.sst): old prealloc_size = 73819750, real_size = 19101504 2024/08/20-22:43:40.311765 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690888.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466136 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.89 raw-val = 0.0541 GB zip-val = 0.0181 GB avg-val = 115.97 avg-zval = 38.84 2024/08/20-22:43:40.312241 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690888.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:40.681425 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690888.sst): second pass time = 0.70's, 76.817'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.37's, 57.519'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2828.513'MB/sec (index lex order gen) rebuild zvType time = 0.30's, 0.384'MB/sec write SST data time = 0.07's, 320.186'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 14132.608'MB/sec zip my value time = 0.70's, unzip length = 0.054'GB zip my value throughput = 76.817'MB/sec zip pipeline throughput = 76.817'MB/sec entries = 466136 avg-key = 28.00 avg-zkey = 1.89 avg-val = 115.97 avg-zval = 38.84 usrkeys = 466136 avg-key = 20.00 avg-zkey = 1.89 avg-val = 122.97 avg-zval = 38.84 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466136 bytes = 1748032 } seq expand size = 3262952 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0181 GB dict = 0.54 MB all = 0.0213 GB } UnZip/Zip{ index = 10.5702 value = 2.9861 dict = 1.00 all = 3.1534 } Zip/UnZip{ index = 0.0946 value = 0.3349 dict = 1.00 all = 0.3171 } ---------------------------- total value len = 0.286597 GB avg = 0.123 KB (by entry num) total key len = 0.065263 GB avg = 0.028 KB total ukey len = 0.046617 GB avg = 0.020 KB total ukey num = 0.002330829 Billion total entry num = 0.002330829 Billion write speed all = 0.038410234 MB/sec (with seq num) write speed all = 0.036374708 MB/sec (without seq num) 2024/08/20-22:43:40.709906 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690888: 466136 keys, 21281762 bytes, temperature: kWarm 2024/08/20-22:43:40.709973 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165020709937, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690888, "file_size": 21281762, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 190586022308, "largest_seqno": 191139771027, "table_properties": {"data_size": 18102832, "index_size": 881984, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13051808, "raw_average_key_size": 28, "raw_value_size": 54057168, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466136, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165019, "oldest_key_time": 0, "file_creation_time": 1724165019, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690888, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:40.737225 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690889.sst) /dev/shm/ToplingTemp/Topling-46430-Pl9Ti3 2024/08/20-22:43:41.134826 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690889.sst): first pass time = 0.40's, 168.813'MB/sec 2024/08/20-22:43:41.839028 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690889.sst): old prealloc_size = 73819750, real_size = 19226896 2024/08/20-22:43:41.839407 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690889.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 467461 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0540 GB zip-val = 0.0182 GB avg-val = 115.56 avg-zval = 38.96 2024/08/20-22:43:41.839833 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690889.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:42.206210 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690889.sst): second pass time = 0.70's, 76.878'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.37's, 57.835'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2574.183'MB/sec (index lex order gen) rebuild zvType time = 0.30's, 0.391'MB/sec write SST data time = 0.07's, 311.415'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 14158.628'MB/sec zip my value time = 0.70's, unzip length = 0.054'GB zip my value throughput = 76.878'MB/sec zip pipeline throughput = 76.878'MB/sec entries = 467461 avg-key = 28.00 avg-zkey = 1.92 avg-val = 115.56 avg-zval = 38.96 usrkeys = 467461 avg-key = 20.00 avg-zkey = 1.92 avg-val = 122.56 avg-zval = 38.96 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 467461 bytes = 1577696 } seq expand size = 3272227 multi value expand size = 0 cnt WriteAppend = 15 UnZipSize{ index = 0.0093 GB value = 0.0540 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0182 GB dict = 0.54 MB all = 0.0212 GB } UnZip/Zip{ index = 10.4314 value = 2.9659 dict = 1.00 all = 3.1602 } Zip/UnZip{ index = 0.0959 value = 0.3372 dict = 1.00 all = 0.3164 } ---------------------------- total value len = 0.343890 GB avg = 0.123 KB (by entry num) total key len = 0.078352 GB avg = 0.028 KB total ukey len = 0.055966 GB avg = 0.020 KB total ukey num = 0.002798290 Billion total entry num = 0.002798290 Billion write speed all = 0.046085599 MB/sec (with seq num) write speed all = 0.043642244 MB/sec (without seq num) 2024/08/20-22:43:42.234823 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690889: 467461 keys, 21235574 bytes, temperature: kWarm 2024/08/20-22:43:42.234895 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165022234859, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690889, "file_size": 21235574, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191037662625, "largest_seqno": 191139770565, "table_properties": {"data_size": 18213568, "index_size": 896256, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13088908, "raw_average_key_size": 28, "raw_value_size": 54020062, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 467461, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165020, "oldest_key_time": 0, "file_creation_time": 1724165020, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690889, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:42.258146 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690890.sst) /dev/shm/ToplingTemp/Topling-46430-Zdp3X2 2024/08/20-22:43:42.667435 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690890.sst): first pass time = 0.41's, 163.984'MB/sec 2024/08/20-22:43:43.391402 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690890.sst): old prealloc_size = 73819750, real_size = 19045152 2024/08/20-22:43:43.391773 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690890.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466315 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0541 GB zip-val = 0.0180 GB avg-val = 115.91 avg-zval = 38.69 2024/08/20-22:43:43.392227 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690890.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:44.014399 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690890.sst): second pass time = 0.72's, 74.752'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.62's, 33.694'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2606.094'MB/sec (index lex order gen) rebuild zvType time = 0.48's, 0.244'MB/sec write SST data time = 0.15's, 144.614'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 13429.730'MB/sec zip my value time = 0.72's, unzip length = 0.054'GB zip my value throughput = 74.752'MB/sec zip pipeline throughput = 74.752'MB/sec entries = 466315 avg-key = 28.00 avg-zkey = 1.90 avg-val = 115.91 avg-zval = 38.69 usrkeys = 466315 avg-key = 20.00 avg-zkey = 1.90 avg-val = 122.91 avg-zval = 38.69 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466315 bytes = 1515536 } seq expand size = 3264205 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0180 GB dict = 0.54 MB all = 0.0210 GB } UnZip/Zip{ index = 10.4996 value = 2.9962 dict = 1.00 all = 3.1971 } Zip/UnZip{ index = 0.0952 value = 0.3338 dict = 1.00 all = 0.3128 } ---------------------------- total value len = 0.401206 GB avg = 0.123 KB (by entry num) total key len = 0.091409 GB avg = 0.028 KB total ukey len = 0.065292 GB avg = 0.020 KB total ukey num = 0.003264605 Billion total entry num = 0.003264605 Billion write speed all = 0.053755864 MB/sec (with seq num) write speed all = 0.050905904 MB/sec (without seq num) 2024/08/20-22:43:44.044159 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690890: 466315 keys, 20990690 bytes, temperature: kWarm 2024/08/20-22:43:44.044244 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165024044201, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690890, "file_size": 20990690, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191102102124, "largest_seqno": 191139770121, "table_properties": {"data_size": 18040144, "index_size": 888256, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13056820, "raw_average_key_size": 28, "raw_value_size": 54052078, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466315, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165022, "oldest_key_time": 0, "file_creation_time": 1724165022, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690890, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:44.075837 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690891.sst) /dev/shm/ToplingTemp/Topling-46430-CljtG1 2024/08/20-22:43:44.704083 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690891.sst): first pass time = 0.63's, 106.830'MB/sec 2024/08/20-22:43:46.244636 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690891.sst): old prealloc_size = 73819750, real_size = 19093504 2024/08/20-22:43:46.244950 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690891.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 465600 prefix = 4 raw-key = 0.0074 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.89 raw-val = 0.0541 GB zip-val = 0.0181 GB avg-val = 116.13 avg-zval = 38.87 2024/08/20-22:43:46.245397 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690891.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:46.614184 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690891.sst): second pass time = 1.54's, 35.116'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.37's, 57.091'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3083.924'MB/sec (index lex order gen) rebuild zvType time = 0.30's, 0.385'MB/sec write SST data time = 0.07's, 315.490'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 14510.214'MB/sec zip my value time = 1.54's, unzip length = 0.054'GB zip my value throughput = 35.116'MB/sec zip pipeline throughput = 110.385'MB/sec entries = 465600 avg-key = 28.00 avg-zkey = 1.89 avg-val = 116.13 avg-zval = 38.87 usrkeys = 465600 avg-key = 20.00 avg-zkey = 1.89 avg-val = 123.13 avg-zval = 38.87 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 465600 bytes = 1571408 } seq expand size = 3259200 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0181 GB dict = 0.54 MB all = 0.0211 GB } UnZip/Zip{ index = 10.5734 value = 2.9880 dict = 1.00 all = 3.1809 } Zip/UnZip{ index = 0.0946 value = 0.3347 dict = 1.00 all = 0.3144 } ---------------------------- total value len = 0.458537 GB avg = 0.123 KB (by entry num) total key len = 0.104446 GB avg = 0.028 KB total ukey len = 0.074604 GB avg = 0.020 KB total ukey num = 0.003730205 Billion total entry num = 0.003730205 Billion write speed all = 0.061417254 MB/sec (with seq num) write speed all = 0.058161754 MB/sec (without seq num) 2024/08/20-22:43:46.651354 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690891: 465600 keys, 21097300 bytes, temperature: kWarm 2024/08/20-22:43:46.651430 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165026651395, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690891, "file_size": 21097300, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191031976588, "largest_seqno": 191139769667, "table_properties": {"data_size": 18096240, "index_size": 880704, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13036800, "raw_average_key_size": 28, "raw_value_size": 54072108, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 465600, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165024, "oldest_key_time": 0, "file_creation_time": 1724165024, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690891, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:46.676766 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690892.sst) /dev/shm/ToplingTemp/Topling-46430-kQaxh3 2024/08/20-22:43:47.086861 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690892.sst): first pass time = 0.41's, 163.664'MB/sec 2024/08/20-22:43:47.775614 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690892.sst): old prealloc_size = 73819750, real_size = 18967264 2024/08/20-22:43:47.775948 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690892.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466197 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0541 GB zip-val = 0.0180 GB avg-val = 115.95 avg-zval = 38.52 2024/08/20-22:43:47.776386 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690892.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/08/20-22:43:48.155835 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690892.sst): second pass time = 0.69's, 78.578'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.38's, 55.001'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2948.008'MB/sec (index lex order gen) rebuild zvType time = 0.31's, 0.373'MB/sec write SST data time = 0.07's, 308.957'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 14411.245'MB/sec zip my value time = 0.69's, unzip length = 0.054'GB zip my value throughput = 78.578'MB/sec zip pipeline throughput = 78.578'MB/sec entries = 466197 avg-key = 28.00 avg-zkey = 1.92 avg-val = 115.95 avg-zval = 38.52 usrkeys = 466197 avg-key = 20.00 avg-zkey = 1.92 avg-val = 122.95 avg-zval = 38.52 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466197 bytes = 1515152 } seq expand size = 3263379 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0180 GB dict = 0.54 MB all = 0.0209 GB } UnZip/Zip{ index = 10.4367 value = 3.0102 dict = 1.00 all = 3.2091 } Zip/UnZip{ index = 0.0958 value = 0.3322 dict = 1.00 all = 0.3116 } ---------------------------- total value len = 0.515856 GB avg = 0.123 KB (by entry num) total key len = 0.117499 GB avg = 0.028 KB total ukey len = 0.083928 GB avg = 0.020 KB total ukey num = 0.004196402 Billion total entry num = 0.004196402 Billion write speed all = 0.069082723 MB/sec (with seq num) write speed all = 0.065420969 MB/sec (without seq num) 2024/08/20-22:43:48.213691 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690892: 466197 keys, 20912246 bytes, temperature: kWarm 2024/08/20-22:43:48.213764 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165028213729, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690892, "file_size": 20912246, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191095253635, "largest_seqno": 191139770894, "table_properties": {"data_size": 17957136, "index_size": 893376, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 13053516, "raw_average_key_size": 28, "raw_value_size": 54055354, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466197, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165026, "oldest_key_time": 0, "file_creation_time": 1724165026, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690892, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:48.241179 139856782554688 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690893.sst) /dev/shm/ToplingTemp/Topling-46430-FTFM61 2024/08/20-22:43:48.397919 139856782554688 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690893.sst): first pass time = 0.16's, 213.746'MB/sec 2024/08/20-22:43:48.731154 139856782554688 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690893.sst): old prealloc_size = 73819750, real_size = 9707120 2024/08/20-22:43:48.731383 139856782554688 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690893.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 232652 prefix = 4 raw-key = 0.0037 GB zip-key = 0.0004 GB avg-key = 16.00 avg-zkey = 1.91 raw-val = 0.0270 GB zip-val = 0.0092 GB avg-val = 115.95 avg-zval = 39.57 2024/08/20-22:43:48.731617 139856782554688 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690893.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0005 GB, waited 0.000 sec, Key+Value = 0.033 GB 2024/08/20-22:43:48.931279 139856782554688 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00/14690893.sst): second pass time = 0.33's, 81.139'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.20's, 53.398'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2181.761'MB/sec (index lex order gen) rebuild zvType time = 0.16's, 0.363'MB/sec write SST data time = 0.04's, 270.387'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.277'MB, throughput = 7692.461'MB/sec zip my value time = 0.33's, unzip length = 0.027'GB zip my value throughput = 81.139'MB/sec zip pipeline throughput = 81.139'MB/sec entries = 232652 avg-key = 28.00 avg-zkey = 1.91 avg-val = 115.95 avg-zval = 39.57 usrkeys = 232652 avg-key = 20.00 avg-zkey = 1.91 avg-val = 122.95 avg-zval = 39.57 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 232652 bytes = 756128 } seq expand size = 1628564 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0047 GB value = 0.0270 GB dict = 0.28 MB all = 0.0335 GB } __ZipSize{ index = 0.0004 GB value = 0.0092 GB dict = 0.28 MB all = 0.0107 GB } UnZip/Zip{ index = 10.4881 value = 2.9306 dict = 1.00 all = 3.1344 } Zip/UnZip{ index = 0.0953 value = 0.3412 dict = 1.00 all = 0.3190 } ---------------------------- total value len = 0.544461 GB avg = 0.123 KB (by entry num) total key len = 0.124014 GB avg = 0.028 KB total ukey len = 0.088581 GB avg = 0.020 KB total ukey num = 0.004429054 Billion total entry num = 0.004429054 Billion write speed all = 0.072907204 MB/sec (with seq num) write speed all = 0.069042767 MB/sec (without seq num) 2024/08/20-22:43:48.948858 139856782554688 [compaction_job.cc:1944] [default] [JOB 53523] Generated table #14690893: 232652 keys, 10684948 bytes, temperature: kWarm 2024/08/20-22:43:48.948928 139856782554688 EVENT_LOG_v1 {"time_micros": 1724165028948894, "cf_name": "default", "job": 53523, "event": "table_file_creation", "file_number": 14690893, "file_size": 10684948, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 191080431857, "largest_seqno": 191139766967, "table_properties": {"data_size": 9205152, "index_size": 443648, "index_partitions": 0, "top_level_index_size": 0, "index_key_is_user_key": 0, "index_value_is_delta_encoded": 0, "filter_size": 0, "raw_key_size": 6514256, "raw_average_key_size": 28, "raw_value_size": 26976832, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 232652, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_Tag1-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1724165028, "oldest_key_time": 0, "file_creation_time": 1724165028, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "90ZT1ZM5QNL093I8HHQG", "orig_file_number": 14690893, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/08/20-22:43:48.958672 139856782554688 [compaction_job.cc:699] job-53523: subcompact[0], size: 0.200155 G, files: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-53523/att-00 [14690884,14690885,14690886,14690887,14690888,14690889,14690890,14690891,14690892,14690893] 2024/08/20-22:43:49.027072 139856782554688 (Original Log Time 2024/08/20-22:43:31.767805) EVENT_LOG_v1 {"time_micros": 1724165011767754, "job": 53523, "event": "compaction_started", "compaction_reason": "FilesMarkedForCompaction", "files_L1": [14690832], "files_L2": [14690785, 14690786, 14690787, 14690788, 14690789, 14690791, 14690792, 14690793, 14690876], "score": 0.992842, "input_data_size": 223028313, "oldest_snapshot_seqno": 191140052404} 2024/08/20-22:43:49.027076 139856782554688 (Original Log Time 2024/08/20-22:43:49.013792) [compaction_job.cc:2018] [default] [JOB 53523] Compacted 1@1 + 9@2 files to L2 => 200155394 bytes 2024/08/20-22:43:49.027078 139856782554688 (Original Log Time 2024/08/20-22:43:49.026993) [compaction_job.cc:1220] [default] compacted to: files[0 0 10 0 0 0 0] max score 0.07, MB/sec: 13.0 rd, 11.6 wr, level 2, files in(1, 9) out(10 +0 blob) MB in(31.8, 180.9 +0.0 blob) out(190.9 +0.0 blob), read-write-amplify(12.7) write-amplify(6.0) OK, records in: 4429054, records dropped: 0 output_compression: Snappy 2024/08/20-22:43:49.027084 139856782554688 (Original Log Time 2024/08/20-22:43:49.027046) EVENT_LOG_v1 {"time_micros": 1724165029027022, "cf": "default", "job": 53523, "event": "compaction_finished", "compaction_time_micros": 17190875, "compaction_time_cpu_micros": 6672008, "output_level": 2, "num_output_files": 10, "total_output_size": 200155394, "num_input_records": 4429054, "num_output_records": 4429054, "num_subcompactions": 1, "output_compression": "Snappy", "num_single_delete_mismatches": 0, "num_single_delete_fallthrough": 0, "file_write_nanos": 167427411, "file_range_sync_nanos": 0, "file_fsync_nanos": 7880, "file_prepare_write_nanos": 32043, "lsm_state": [0, 0, 10, 0, 0, 0, 0]} 2024/08/20-22:43:49.153333 139856782554688 DEBG dcompact_worker.cpp:240: HttpPost: 200 OK: url = http://nlb-7zny4kaa1poal01o64.cn-shenzhen.nlb.aliyuncs.com:8443, body = {"instanceId":"nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137","labourId":"","dbId":"a007a635-5c0a-4b4a-be96-b9c695cb016b","dbStarts":1724092920,"starts":1724165011,"executesMs":17366,"compactionJobId":53523,"attempt":0,"compactionInputRawBytes":637471600,"compactionInputZipBytes":223028313,"compactionOutputRawBytes":0,"compactionOutputZipBytes":200155394,"headers":{"Accept":"*/*","Connection":"close","Host":"aliyun-topling-saas.topling.cn:18443","RemoteIp":"120.24.192.169","X-Forwarded-For":"120.24.192.169","region":"cn-shenzhen","token":"e6474c481bd4415abc537135cc03626b","instance-token":"e6474c481bd4415abc537135cc03626b","provider":"aliyun","CloudMarketInstanceId":"si-59c0ae5c955845588903","MeteringAssit":"","Transfer-Encoding":"chunked","traceparent":"00-2314c63f78b2eaaf9031270c724bc1b9-b377ef7f660b161f-00"}}, response = 2024/08/20-22:43:49.153435 139856782554688 INFO dcompact_worker.cpp:1456: finish /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-08-20T02.42.00/.rocksdb/job-53523/att-00: olev 2, work 17.367 s, result 5.325 ms, install 13.325 ms, input{raw 607.940 MiB zip 212.696 MiB}