2024/11/21-04:50:37.575500 140008492664384 DEBG dcompact_worker.cpp:2219: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00: fork to child time = 0.010227 sec 2024/11/21-04:50:37.576073 140008492664384 DEBG dcompact_worker.cpp:1013: Beg SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00 2024/11/21-04:50:37.582855 140008492664384 DEBG dcompact_worker.cpp:1033: End SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00 2024/11/21-04:50:37.584626 140008492664384 TRAC dcompact_worker.cpp:1083: INFO_LOG_LEVEL: rpc = INFO_LEVEL, env_var = undefined 2024/11/21-04:50:37.584880 140008492664384 [WARN] [column_family.cc:386] multiple cf_paths/db_paths and level_compaction_dynamic_level_bytes can't be used together 2024/11/21-04:50:37.631459 140008492664384 [version_set.cc:6211] Recovering from manifest file: /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-21T00.56.43/.rocksdb/job-06028/att-00/MANIFEST-090329 2024/11/21-04:50:37.663507 140008492664384 [version_set.cc:6254] Recovered from manifest file:/worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-21T00.56.43/.rocksdb/job-06028/att-00/MANIFEST-090329 succeeded,manifest_file_number is 90329, next_file_number is 103120, last_sequence is 1546172011, log_number is 0,prev_log_number is 0,max_column_family is 0,min_log_number_to_keep is 102861 2024/11/21-04:50:37.663516 140008492664384 [version_set.cc:6269] Column family [default] (ID 0), log number is 0 2024/11/21-04:50:37.663604 140008492664384 [version_set.cc:5724] Creating manifest 103120 2024/11/21-04:50:37.695296 140008492664384 DEBG dcompact_worker.cpp:1225: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00: bottommost_level: fake = 1, rpc = 0 2024/11/21-04:50:37.716038 140008492664384 [compaction_job.cc:2437] [default] [JOB 6028] Compacting 1@2 + 13@3 files to L3, score 1.00, subcompactions 1 : 1 2024/11/21-04:50:37.716062 140008492664384 [compaction_job.cc:2445] [default]: Compaction start summary: Base version 4508 Base level 2, inputs: [103112(27MB)], [103052(37MB) 103054(38MB) 103055(39MB) 103056(38MB) 103057(38MB) 103058(38MB) 103059(38MB) 103060(39MB) 103061(37MB) 103062(36MB) 103063(39MB) 103064(37MB) 103075(36MB)] 2024/11/21-04:50:37.724162 140008492664384 [top_zip_table.cc:59] core git_version_hash_info_is:commit 81964c21ebbcc178d8e99dae0fbf61bded2729cc Author: rockeet Date: Mon Nov 11 21:28:46 2024 +0800 Makefile: fix gen git-version-*.cpp GIT_PATH_ARG = :!src/terark/fsa :!tools/fsa :!src/terark/zbs :!tools/zbs g++ (GCC) 12.2.1 20221121 (Red Hat 12.2.1-7) 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/zstd -Iboost-include DEFS = -DTOPLING_IO_WITH_URING=1 -DDIVSUFSORT_API= CXXFLAGS = -fPIC -time -fdiagnostics-color -mcx16 -fno-stack-protector WARNINGS = -Wno-class-memaccess -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -Wno-deprecated-declarations -Wstrict-aliasing=3 RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 LDFLAGS = -fPIC -rdynamic 2024/11/21-04:50:37.724186 140008492664384 [top_zip_table.cc:60] fsa git_version_hash_info_is:commit 5dfecb7d107196f044ff5bf78dc39d2e725b9d9b Author: leipeng Date: Thu Nov 7 15:22:45 2024 +0800 Makefile: fix for x86_64 CPU older than haswell GIT_PATH_ARG = src/terark/fsa tools/fsa g++ (GCC) 12.2.1 20221121 (Red Hat 12.2.1-7) 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/zstd -Iboost-include DEFS = -DTOPLING_IO_WITH_URING=1 -DDIVSUFSORT_API= CXXFLAGS = -fPIC -time -fdiagnostics-color -mcx16 -fno-stack-protector WARNINGS = -Wno-class-memaccess -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -Wno-deprecated-declarations -Wstrict-aliasing=3 RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 LDFLAGS = -fPIC -rdynamic 2024/11/21-04:50:37.724204 140008492664384 [top_zip_table.cc:61] zbs git_version_hash_info_is:commit d44dd5ff72707128fe3c916077b43d2093c01f7c Author: leipeng Date: Sun Oct 27 23:38:26 2024 +0800 Fix for msvc, when toplingdb on msvc GIT_PATH_ARG = src/terark/zbs tools/zbs g++ (GCC) 12.2.1 20221121 (Red Hat 12.2.1-7) 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/zstd -Iboost-include DEFS = -DTOPLING_IO_WITH_URING=1 -DDIVSUFSORT_API= CXXFLAGS = -fPIC -time -fdiagnostics-color -mcx16 -fno-stack-protector WARNINGS = -Wno-class-memaccess -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -Wno-deprecated-declarations -Wstrict-aliasing=3 RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 LDFLAGS = -fPIC -rdynamic 2024/11/21-04:50:37.724212 140008492664384 [top_zip_table.cc:62] topling-zip_table_reader: git_version_hash_info_is: commit 79614a7e7dc27362fc5151b0797eb7d83c674c7b Author: rockeet Date: Sun Nov 10 15:02:21 2024 +0800 cpu_has_bmi2.sh: detect by compile c++ code check __BMI2__ g++ (GCC) 12.2.1 20221121 (Red Hat 12.2.1-7) 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/11/21-04:50:37.724222 140008492664384 [top_zip_table.cc:64] topling-rocks git_version_hash_info_is: commit c46b65a52d9c74aa8b87aeb8438620ff2dbc669c Author: rockeet Date: Sun Nov 10 15:02:42 2024 +0800 cpu_has_bmi2.sh: detect by compile c++ code check __BMI2__ g++ (GCC) 12.2.1 20221121 (Red Hat 12.2.1-7) 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/11/21-04:50:38.349560 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103121.sst) /dev/shm/ToplingTemp/Topling-1344922-0oHdBS 2024/11/21-04:50:38.955650 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103121.sst): first pass time = 0.61's, 221.463'MB/sec 2024/11/21-04:50:40.543163 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103121.sst): old prealloc_size = 147639500, real_size = 35394272 2024/11/21-04:50:40.543967 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103121.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 930820 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1082 GB zip-val = 0.0334 GB avg-val = 116.19 avg-zval = 35.87 2024/11/21-04:50:40.545536 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103121.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:50:41.580405 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103121.sst): second pass time = 1.59's, 68.169'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.04's, 37.861'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2276.255'MB/sec (index lex order gen) rebuild zvType time = 0.87's, 0.268'MB/sec write SST data time = 0.17's, 231.486'MB/sec dict compress time = 7020094909.94's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.078'MB, throughput = 21844.044'MB/sec zip my value time = 1.59's, unzip length = 0.108'GB zip my value throughput = 68.169'MB/sec zip pipeline throughput = 122.043'MB/sec entries = 930820 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.19 avg-zval = 35.87 usrkeys = 930820 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.19 avg-zval = 35.87 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 930820 bytes = 3025184 } seq expand size = 6515740 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0186 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0334 GB dict = 1.08 MB all = 0.0393 GB } UnZip/Zip{ index = 10.5140 value = 3.2391 dict = 1.00 all = 3.4178 } Zip/UnZip{ index = 0.0951 value = 0.3087 dict = 1.00 all = 0.2926 } ---------------------------- total value len = 563.180403 GB avg = 0.331 KB (by entry num) total key len = 44.340469 GB avg = 0.026 KB total ukey len = 32.812758 GB avg = 0.014 KB total ukey num = 2.321945396 Billion total entry num = 1.701447418 Billion write speed all = 15.649997258 MB/sec (with seq num) write speed all = 15.299357158 MB/sec (without seq num) 2024/11/21-04:50:41.674152 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103121: 930820 keys, 39270750 bytes, temperature: kWarm 2024/11/21-04:50:41.674242 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135841674200, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103121, "file_size": 39270750, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1488448977, "largest_seqno": 1546138605, "table_properties": {"data_size": 33390736, "index_size": 1770624, "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": 26062960, "raw_average_key_size": 28, "raw_value_size": 108154768, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 930820, "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": 1732135838, "oldest_key_time": 0, "file_creation_time": 1732135838, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103121, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:50:41.712238 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103122.sst) /dev/shm/ToplingTemp/Topling-1344922-EL94DT 2024/11/21-04:50:42.651444 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103122.sst): first pass time = 0.94's, 142.911'MB/sec 2024/11/21-04:50:44.078190 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103122.sst): old prealloc_size = 147639500, real_size = 36691024 2024/11/21-04:50:44.078971 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103122.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 927812 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.97 raw-val = 0.1082 GB zip-val = 0.0346 GB avg-val = 116.66 avg-zval = 37.33 2024/11/21-04:50:44.079911 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103122.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:50:44.998138 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103122.sst): second pass time = 1.43's, 75.911'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.92's, 44.428'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2420.474'MB/sec (index lex order gen) rebuild zvType time = 0.74's, 0.312'MB/sec write SST data time = 0.18's, 232.497'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.080'MB, throughput = 22074.159'MB/sec zip my value time = 1.43's, unzip length = 0.108'GB zip my value throughput = 75.911'MB/sec zip pipeline throughput = 75.911'MB/sec entries = 927812 avg-key = 28.00 avg-zkey = 1.97 avg-val = 116.66 avg-zval = 37.33 usrkeys = 927812 avg-key = 20.00 avg-zkey = 1.97 avg-val = 123.05 avg-zval = 37.33 TagRS{ kinds = RS_Key0_TagN bytes = 145080 } TagArray{ size = 847320 bytes = 3177472 } seq expand size = 5931240 multi value expand size = 0 cnt WriteAppend = 28 UnZipSize{ index = 0.0186 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0346 GB dict = 1.08 MB all = 0.0409 GB } UnZip/Zip{ index = 10.1769 value = 3.1251 dict = 1.00 all = 3.2839 } Zip/UnZip{ index = 0.0983 value = 0.3200 dict = 1.00 all = 0.3045 } ---------------------------- total value len = 563.294573 GB avg = 0.331 KB (by entry num) total key len = 44.366448 GB avg = 0.026 KB total ukey len = 32.831314 GB avg = 0.014 KB total ukey num = 2.322873208 Billion total entry num = 1.702375230 Billion write speed all = 15.652229497 MB/sec (with seq num) write speed all = 15.301429075 MB/sec (without seq num) 2024/11/21-04:50:45.096205 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103122: 927812 keys, 40871160 bytes, temperature: kWarm 2024/11/21-04:50:45.096274 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135845096242, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103122, "file_size": 40871160, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1546138659, "table_properties": {"data_size": 34635520, "index_size": 1823360, "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": 25978736, "raw_average_key_size": 28, "raw_value_size": 108239044, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 927812, "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_TagN-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1732135841, "oldest_key_time": 0, "file_creation_time": 1732135841, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103122, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:50:45.140726 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103123.sst) /dev/shm/ToplingTemp/Topling-1344922-EUrTmV 2024/11/21-04:50:46.032760 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103123.sst): first pass time = 0.89's, 150.470'MB/sec 2024/11/21-04:50:47.553582 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103123.sst): old prealloc_size = 147639500, real_size = 37571744 2024/11/21-04:50:47.554414 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103123.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 927375 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.95 raw-val = 0.1083 GB zip-val = 0.0355 GB avg-val = 116.73 avg-zval = 38.31 2024/11/21-04:50:47.555118 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103123.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:50:48.546743 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103123.sst): second pass time = 1.52's, 71.226'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.99's, 41.243'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2250.877'MB/sec (index lex order gen) rebuild zvType time = 0.78's, 0.298'MB/sec write SST data time = 0.21's, 191.087'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.081'MB, throughput = 35416.257'MB/sec zip my value time = 1.52's, unzip length = 0.108'GB zip my value throughput = 71.226'MB/sec zip pipeline throughput = 71.226'MB/sec entries = 927375 avg-key = 28.00 avg-zkey = 1.95 avg-val = 116.73 avg-zval = 38.31 usrkeys = 927375 avg-key = 20.00 avg-zkey = 1.95 avg-val = 121.70 avg-zval = 38.31 TagRS{ kinds = RS_Key0_TagN bytes = 145000 } TagArray{ size = 657955 bytes = 2385104 } seq expand size = 4605685 multi value expand size = 0 cnt WriteAppend = 55 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0355 GB dict = 1.08 MB all = 0.0410 GB } UnZip/Zip{ index = 10.2415 value = 3.0469 dict = 1.00 all = 3.2768 } Zip/UnZip{ index = 0.0976 value = 0.3282 dict = 1.00 all = 0.3052 } ---------------------------- total value len = 563.407430 GB avg = 0.331 KB (by entry num) total key len = 44.392415 GB avg = 0.026 KB total ukey len = 32.849862 GB avg = 0.014 KB total ukey num = 2.323800583 Billion total entry num = 1.703302605 Billion write speed all = 15.654374444 MB/sec (with seq num) write speed all = 15.303415002 MB/sec (without seq num) 2024/11/21-04:50:48.678946 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103123: 927375 keys, 40960182 bytes, temperature: kWarm 2024/11/21-04:50:48.679016 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135848678984, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103123, "file_size": 40960182, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1323177458, "table_properties": {"data_size": 35528720, "index_size": 1811008, "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": 25966500, "raw_average_key_size": 28, "raw_value_size": 108251310, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 927375, "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_TagN-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1732135845, "oldest_key_time": 0, "file_creation_time": 1732135845, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103123, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:50:48.719072 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103124.sst) /dev/shm/ToplingTemp/Topling-1344922-M2AfcV 2024/11/21-04:50:49.629548 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103124.sst): first pass time = 0.91's, 147.422'MB/sec 2024/11/21-04:50:50.889321 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103124.sst): old prealloc_size = 147639500, real_size = 37240256 2024/11/21-04:50:50.889943 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103124.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 925326 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0017 GB avg-key = 16.00 avg-zkey = 1.89 raw-val = 0.1083 GB zip-val = 0.0353 GB avg-val = 117.05 avg-zval = 38.11 2024/11/21-04:50:50.890834 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103124.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:50:51.991356 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103124.sst): second pass time = 1.26's, 86.045'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.10's, 37.616'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2929.876'MB/sec (index lex order gen) rebuild zvType time = 0.87's, 0.265'MB/sec write SST data time = 0.23's, 180.222'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.081'MB, throughput = 24799.890'MB/sec zip my value time = 1.26's, unzip length = 0.108'GB zip my value throughput = 86.045'MB/sec zip pipeline throughput = 86.045'MB/sec entries = 925326 avg-key = 28.00 avg-zkey = 1.89 avg-val = 117.05 avg-zval = 38.11 usrkeys = 925326 avg-key = 20.00 avg-zkey = 1.89 avg-val = 124.05 avg-zval = 38.11 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 925326 bytes = 3354320 } seq expand size = 6477282 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0017 GB value = 0.0353 GB dict = 1.08 MB all = 0.0415 GB } UnZip/Zip{ index = 10.5840 value = 3.0717 dict = 1.00 all = 3.2378 } Zip/UnZip{ index = 0.0945 value = 0.3256 dict = 1.00 all = 0.3089 } ---------------------------- total value len = 563.522216 GB avg = 0.331 KB (by entry num) total key len = 44.418324 GB avg = 0.026 KB total ukey len = 32.868368 GB avg = 0.014 KB total ukey num = 2.324725909 Billion total entry num = 1.704227931 Billion write speed all = 15.656609122 MB/sec (with seq num) write speed all = 15.305490171 MB/sec (without seq num) 2024/11/21-04:50:52.045941 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103124: 925326 keys, 41453372 bytes, temperature: kWarm 2024/11/21-04:50:52.046007 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135852045976, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103124, "file_size": 41453372, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1052137445, "largest_seqno": 1331715475, "table_properties": {"data_size": 35260208, "index_size": 1748544, "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": 25909128, "raw_average_key_size": 28, "raw_value_size": 108308720, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 925326, "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": 1732135848, "oldest_key_time": 0, "file_creation_time": 1732135848, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103124, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:50:52.085883 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103125.sst) /dev/shm/ToplingTemp/Topling-1344922-n51NKR 2024/11/21-04:50:53.002782 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103125.sst): first pass time = 0.92's, 146.389'MB/sec 2024/11/21-04:50:54.371359 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103125.sst): old prealloc_size = 147639500, real_size = 35551200 2024/11/21-04:50:54.371921 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103125.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 928178 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1082 GB zip-val = 0.0336 GB avg-val = 116.60 avg-zval = 36.15 2024/11/21-04:50:54.372763 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103125.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:50:55.381236 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103125.sst): second pass time = 1.37's, 79.134'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.01's, 39.266'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3328.645'MB/sec (index lex order gen) rebuild zvType time = 0.86's, 0.270'MB/sec write SST data time = 0.15's, 266.859'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.079'MB, throughput = 30319.636'MB/sec zip my value time = 1.37's, unzip length = 0.108'GB zip my value throughput = 79.134'MB/sec zip pipeline throughput = 109.331'MB/sec entries = 928178 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.60 avg-zval = 36.15 usrkeys = 928178 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.60 avg-zval = 36.15 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 928178 bytes = 3248640 } seq expand size = 6497246 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0186 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0336 GB dict = 1.08 MB all = 0.0397 GB } UnZip/Zip{ index = 10.5115 value = 3.2256 dict = 1.00 all = 3.3848 } Zip/UnZip{ index = 0.0951 value = 0.3100 dict = 1.00 all = 0.2954 } ---------------------------- total value len = 563.636942 GB avg = 0.331 KB (by entry num) total key len = 44.444313 GB avg = 0.026 KB total ukey len = 32.886932 GB avg = 0.014 KB total ukey num = 2.325654087 Billion total entry num = 1.705156109 Billion write speed all = 15.658866000 MB/sec (with seq num) write speed all = 15.307586485 MB/sec (without seq num) 2024/11/21-04:50:55.432015 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103125: 928178 keys, 39653118 bytes, temperature: kWarm 2024/11/21-04:50:55.432115 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135855432068, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103125, "file_size": 39653118, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1187855354, "largest_seqno": 1331717282, "table_properties": {"data_size": 33552976, "index_size": 1766016, "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": 25988984, "raw_average_key_size": 28, "raw_value_size": 108228860, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 928178, "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": 1732135852, "oldest_key_time": 0, "file_creation_time": 1732135852, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103125, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:50:55.507760 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103126.sst) /dev/shm/ToplingTemp/Topling-1344922-gAOAvT 2024/11/21-04:50:56.497895 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103126.sst): first pass time = 0.99's, 135.563'MB/sec 2024/11/21-04:50:57.708235 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103126.sst): old prealloc_size = 147639500, real_size = 35498144 2024/11/21-04:50:57.708851 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103126.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 928475 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.91 raw-val = 0.1082 GB zip-val = 0.0335 GB avg-val = 116.56 avg-zval = 36.07 2024/11/21-04:50:57.709679 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103126.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:50:58.680779 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103126.sst): second pass time = 1.21's, 89.470'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.97's, 40.724'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3009.245'MB/sec (index lex order gen) rebuild zvType time = 0.84's, 0.275'MB/sec write SST data time = 0.13's, 307.858'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.080'MB, throughput = 29776.466'MB/sec zip my value time = 1.21's, unzip length = 0.108'GB zip my value throughput = 89.470'MB/sec zip pipeline throughput = 89.470'MB/sec entries = 928475 avg-key = 28.00 avg-zkey = 1.91 avg-val = 116.56 avg-zval = 36.07 usrkeys = 928475 avg-key = 20.00 avg-zkey = 1.91 avg-val = 123.56 avg-zval = 36.07 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 928475 bytes = 3249680 } seq expand size = 6499325 multi value expand size = 0 cnt WriteAppend = 14 UnZipSize{ index = 0.0186 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0335 GB dict = 1.08 MB all = 0.0396 GB } UnZip/Zip{ index = 10.4449 value = 3.2316 dict = 1.00 all = 3.3889 } Zip/UnZip{ index = 0.0957 value = 0.3094 dict = 1.00 all = 0.2951 } ---------------------------- total value len = 563.751662 GB avg = 0.330 KB (by entry num) total key len = 44.470310 GB avg = 0.026 KB total ukey len = 32.905501 GB avg = 0.014 KB total ukey num = 2.326582562 Billion total entry num = 1.706084584 Billion write speed all = 15.661158947 MB/sec (with seq num) write speed all = 15.309718018 MB/sec (without seq num) 2024/11/21-04:50:58.730566 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103126: 928475 keys, 39604780 bytes, temperature: kWarm 2024/11/21-04:50:58.730633 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135858730602, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103126, "file_size": 39604780, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1187855426, "largest_seqno": 1331716806, "table_properties": {"data_size": 33488016, "index_size": 1777856, "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": 25997300, "raw_average_key_size": 28, "raw_value_size": 108220522, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 928475, "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": 1732135855, "oldest_key_time": 0, "file_creation_time": 1732135855, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103126, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:50:58.776062 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103127.sst) /dev/shm/ToplingTemp/Topling-1344922-m6CwnV 2024/11/21-04:50:59.651340 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103127.sst): first pass time = 0.88's, 153.349'MB/sec 2024/11/21-04:51:00.785193 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103127.sst): old prealloc_size = 147639500, real_size = 36248128 2024/11/21-04:51:00.785742 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103127.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 927373 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.91 raw-val = 0.1083 GB zip-val = 0.0342 GB avg-val = 116.73 avg-zval = 36.92 2024/11/21-04:51:00.786578 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103127.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:51:01.684602 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103127.sst): second pass time = 1.13's, 95.539'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.90's, 44.862'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3355.564'MB/sec (index lex order gen) rebuild zvType time = 0.71's, 0.327'MB/sec write SST data time = 0.19's, 212.820'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.080'MB, throughput = 21084.348'MB/sec zip my value time = 1.13's, unzip length = 0.108'GB zip my value throughput = 95.539'MB/sec zip pipeline throughput = 95.539'MB/sec entries = 927373 avg-key = 28.00 avg-zkey = 1.91 avg-val = 116.73 avg-zval = 36.92 usrkeys = 927373 avg-key = 20.00 avg-zkey = 1.91 avg-val = 123.73 avg-zval = 36.92 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 927373 bytes = 3245824 } seq expand size = 6491611 multi value expand size = 0 cnt WriteAppend = 14 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0342 GB dict = 1.08 MB all = 0.0403 GB } UnZip/Zip{ index = 10.4445 value = 3.1615 dict = 1.00 all = 3.3265 } Zip/UnZip{ index = 0.0957 value = 0.3163 dict = 1.00 all = 0.3006 } ---------------------------- total value len = 563.866405 GB avg = 0.330 KB (by entry num) total key len = 44.496276 GB avg = 0.026 KB total ukey len = 32.924049 GB avg = 0.014 KB total ukey num = 2.327509935 Billion total entry num = 1.707011957 Billion write speed all = 15.663570576 MB/sec (with seq num) write speed all = 15.311965810 MB/sec (without seq num) 2024/11/21-04:51:01.736287 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103127: 927373 keys, 40348282 bytes, temperature: kWarm 2024/11/21-04:51:01.736347 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135861736318, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103127, "file_size": 40348282, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1187851486, "largest_seqno": 1331717093, "table_properties": {"data_size": 34240304, "index_size": 1775808, "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": 25966444, "raw_average_key_size": 28, "raw_value_size": 108251310, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 927373, "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": 1732135858, "oldest_key_time": 0, "file_creation_time": 1732135858, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103127, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:01.770812 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103128.sst) /dev/shm/ToplingTemp/Topling-1344922-178g5U 2024/11/21-04:51:02.805542 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103128.sst): first pass time = 1.03's, 129.716'MB/sec 2024/11/21-04:51:04.000076 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103128.sst): old prealloc_size = 147639500, real_size = 37218656 2024/11/21-04:51:04.000588 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103128.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 930341 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.89 raw-val = 0.1082 GB zip-val = 0.0352 GB avg-val = 116.27 avg-zval = 37.87 2024/11/21-04:51:04.001435 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103128.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:51:04.810549 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103128.sst): second pass time = 1.19's, 90.615'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.81's, 51.247'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3563.468'MB/sec (index lex order gen) rebuild zvType time = 0.68's, 0.342'MB/sec write SST data time = 0.13's, 320.226'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.079'MB, throughput = 36248.773'MB/sec zip my value time = 1.19's, unzip length = 0.108'GB zip my value throughput = 90.615'MB/sec zip pipeline throughput = 90.615'MB/sec entries = 930341 avg-key = 28.00 avg-zkey = 1.89 avg-val = 116.27 avg-zval = 37.87 usrkeys = 930341 avg-key = 20.00 avg-zkey = 1.89 avg-val = 123.15 avg-zval = 37.87 TagRS{ kinds = RS_Key0_TagN bytes = 145480 } TagArray{ size = 914310 bytes = 3314384 } seq expand size = 6400170 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0186 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0352 GB dict = 1.08 MB all = 0.0415 GB } UnZip/Zip{ index = 10.5824 value = 3.0706 dict = 1.00 all = 3.2315 } Zip/UnZip{ index = 0.0945 value = 0.3257 dict = 1.00 all = 0.3095 } ---------------------------- total value len = 563.980973 GB avg = 0.330 KB (by entry num) total key len = 44.522326 GB avg = 0.026 KB total ukey len = 32.942656 GB avg = 0.014 KB total ukey num = 2.328440276 Billion total entry num = 1.707942298 Billion write speed all = 15.665930223 MB/sec (with seq num) write speed all = 15.314162140 MB/sec (without seq num) 2024/11/21-04:51:04.860674 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103128: 930341 keys, 41534050 bytes, temperature: kWarm 2024/11/21-04:51:04.860740 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135864860710, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103128, "file_size": 41534050, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1375096600, "table_properties": {"data_size": 35227600, "index_size": 1758272, "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": 26049548, "raw_average_key_size": 28, "raw_value_size": 108168314, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 930341, "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_TagN-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1732135861, "oldest_key_time": 0, "file_creation_time": 1732135861, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103128, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:04.896415 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103129.sst) /dev/shm/ToplingTemp/Topling-1344922-n3m49S 2024/11/21-04:51:05.709307 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103129.sst): first pass time = 0.81's, 165.117'MB/sec 2024/11/21-04:51:06.827278 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103129.sst): old prealloc_size = 147639500, real_size = 34368352 2024/11/21-04:51:06.827848 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103129.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 931203 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1081 GB zip-val = 0.0324 GB avg-val = 116.13 avg-zval = 34.75 2024/11/21-04:51:06.828683 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103129.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:51:07.672954 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103129.sst): second pass time = 1.12's, 96.800'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.85's, 45.640'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3229.089'MB/sec (index lex order gen) rebuild zvType time = 0.72's, 0.324'MB/sec write SST data time = 0.13's, 303.607'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.078'MB, throughput = 19697.971'MB/sec zip my value time = 1.12's, unzip length = 0.108'GB zip my value throughput = 96.800'MB/sec zip pipeline throughput = 96.800'MB/sec entries = 931203 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.13 avg-zval = 34.75 usrkeys = 931203 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.13 avg-zval = 34.75 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 931203 bytes = 3375632 } seq expand size = 6518421 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0186 GB value = 0.1081 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0324 GB dict = 1.08 MB all = 0.0386 GB } UnZip/Zip{ index = 10.5130 value = 3.3415 dict = 1.00 all = 3.4776 } Zip/UnZip{ index = 0.0951 value = 0.2993 dict = 1.00 all = 0.2876 } ---------------------------- total value len = 564.095636 GB avg = 0.330 KB (by entry num) total key len = 44.548400 GB avg = 0.026 KB total ukey len = 32.961280 GB avg = 0.014 KB total ukey num = 2.329371479 Billion total entry num = 1.708873501 Billion write speed all = 15.668398835 MB/sec (with seq num) write speed all = 15.316464897 MB/sec (without seq num) 2024/11/21-04:51:07.720894 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103129: 931203 keys, 38595334 bytes, temperature: kWarm 2024/11/21-04:51:07.720952 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135867720922, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103129, "file_size": 38595334, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1053131138, "largest_seqno": 1375096388, "table_properties": {"data_size": 32363856, "index_size": 1771520, "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": 26073684, "raw_average_key_size": 28, "raw_value_size": 108144170, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 931203, "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": 1732135864, "oldest_key_time": 0, "file_creation_time": 1732135864, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103129, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:07.753793 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103130.sst) /dev/shm/ToplingTemp/Topling-1344922-EycY7U 2024/11/21-04:51:08.636484 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103130.sst): first pass time = 0.88's, 152.061'MB/sec 2024/11/21-04:51:09.857199 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103130.sst): old prealloc_size = 147639500, real_size = 36733904 2024/11/21-04:51:09.857799 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103130.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 926395 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1083 GB zip-val = 0.0347 GB avg-val = 116.88 avg-zval = 37.50 2024/11/21-04:51:09.858315 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103130.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:51:10.612923 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103130.sst): second pass time = 1.22's, 88.764'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.76's, 52.159'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3127.434'MB/sec (index lex order gen) rebuild zvType time = 0.63's, 0.368'MB/sec write SST data time = 0.13's, 312.420'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.080'MB, throughput = 17810.918'MB/sec zip my value time = 1.22's, unzip length = 0.108'GB zip my value throughput = 88.764'MB/sec zip pipeline throughput = 88.764'MB/sec entries = 926395 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.88 avg-zval = 37.50 usrkeys = 926395 avg-key = 20.00 avg-zkey = 1.90 avg-val = 120.38 avg-zval = 37.50 TagRS{ kinds = RS_Key0_TagN bytes = 144840 } TagArray{ size = 463606 bytes = 1680592 } seq expand size = 3245242 multi value expand size = 0 cnt WriteAppend = 14 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0347 GB dict = 1.08 MB all = 0.0394 GB } UnZip/Zip{ index = 10.5146 value = 3.1168 dict = 1.00 all = 3.4050 } Zip/UnZip{ index = 0.0951 value = 0.3208 dict = 1.00 all = 0.2937 } ---------------------------- total value len = 564.207160 GB avg = 0.330 KB (by entry num) total key len = 44.574339 GB avg = 0.026 KB total ukey len = 32.979808 GB avg = 0.014 KB total ukey num = 2.330297874 Billion total entry num = 1.709799896 Billion write speed all = 15.670751539 MB/sec (with seq num) write speed all = 15.318653462 MB/sec (without seq num) 2024/11/21-04:51:10.660343 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103130: 926395 keys, 39417545 bytes, temperature: kWarm 2024/11/21-04:51:10.660402 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135870660372, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103130, "file_size": 39417545, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1375096137, "table_properties": {"data_size": 34740032, "index_size": 1762112, "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": 25939060, "raw_average_key_size": 28, "raw_value_size": 108278750, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 926395, "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_TagN-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1732135867, "oldest_key_time": 0, "file_creation_time": 1732135867, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103130, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:10.693597 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103131.sst) /dev/shm/ToplingTemp/Topling-1344922-4XJDjT 2024/11/21-04:51:11.598288 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103131.sst): first pass time = 0.90's, 148.363'MB/sec 2024/11/21-04:51:12.712891 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103131.sst): old prealloc_size = 147639500, real_size = 35661840 2024/11/21-04:51:12.713530 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103131.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 927267 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1083 GB zip-val = 0.0337 GB avg-val = 116.75 avg-zval = 36.31 2024/11/21-04:51:12.714385 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103131.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:51:13.537717 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103131.sst): second pass time = 1.11's, 97.194'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.82's, 48.353'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2863.798'MB/sec (index lex order gen) rebuild zvType time = 0.70's, 0.332'MB/sec write SST data time = 0.13's, 316.661'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.080'MB, throughput = 34987.952'MB/sec zip my value time = 1.11's, unzip length = 0.108'GB zip my value throughput = 97.194'MB/sec zip pipeline throughput = 97.194'MB/sec entries = 927267 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.75 avg-zval = 36.31 usrkeys = 927267 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.75 avg-zval = 36.31 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 927267 bytes = 3361360 } seq expand size = 6490869 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0337 GB dict = 1.08 MB all = 0.0399 GB } UnZip/Zip{ index = 10.5157 value = 3.2155 dict = 1.00 all = 3.3654 } Zip/UnZip{ index = 0.0951 value = 0.3110 dict = 1.00 all = 0.2971 } ---------------------------- total value len = 564.321905 GB avg = 0.330 KB (by entry num) total key len = 44.600302 GB avg = 0.026 KB total ukey len = 32.998353 GB avg = 0.014 KB total ukey num = 2.331225141 Billion total entry num = 1.710727163 Billion write speed all = 15.673193551 MB/sec (with seq num) write speed all = 15.320931044 MB/sec (without seq num) 2024/11/21-04:51:13.586609 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103131: 927267 keys, 39881200 bytes, temperature: kWarm 2024/11/21-04:51:13.586669 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135873586640, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103131, "file_size": 39881200, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1080218058, "largest_seqno": 1483880164, "table_properties": {"data_size": 33666240, "index_size": 1763584, "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": 25963476, "raw_average_key_size": 28, "raw_value_size": 108254354, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 927267, "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": 1732135870, "oldest_key_time": 0, "file_creation_time": 1732135870, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103131, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:13.622016 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103132.sst) /dev/shm/ToplingTemp/Topling-1344922-Ag2BzR 2024/11/21-04:51:14.437506 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103132.sst): first pass time = 0.82's, 164.591'MB/sec 2024/11/21-04:51:15.555979 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103132.sst): old prealloc_size = 147639500, real_size = 34050896 2024/11/21-04:51:15.556608 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103132.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 925396 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1083 GB zip-val = 0.0321 GB avg-val = 117.04 avg-zval = 34.64 2024/11/21-04:51:15.557425 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103132.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:51:16.406201 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103132.sst): second pass time = 1.12's, 96.907'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.85's, 44.865'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2970.342'MB/sec (index lex order gen) rebuild zvType time = 0.72's, 0.320'MB/sec write SST data time = 0.13's, 300.866'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.081'MB, throughput = 26419.745'MB/sec zip my value time = 1.12's, unzip length = 0.108'GB zip my value throughput = 96.907'MB/sec zip pipeline throughput = 96.907'MB/sec entries = 925396 avg-key = 28.00 avg-zkey = 1.90 avg-val = 117.04 avg-zval = 34.64 usrkeys = 925396 avg-key = 20.00 avg-zkey = 1.90 avg-val = 124.04 avg-zval = 34.64 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 925396 bytes = 3238896 } seq expand size = 6477772 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0321 GB dict = 1.08 MB all = 0.0381 GB } UnZip/Zip{ index = 10.5140 value = 3.3783 dict = 1.00 all = 3.5186 } Zip/UnZip{ index = 0.0951 value = 0.2960 dict = 1.00 all = 0.2842 } ---------------------------- total value len = 564.436690 GB avg = 0.330 KB (by entry num) total key len = 44.626213 GB avg = 0.026 KB total ukey len = 33.016861 GB avg = 0.014 KB total ukey num = 2.332150537 Billion total entry num = 1.711652559 Billion write speed all = 15.675657569 MB/sec (with seq num) write speed all = 15.323230531 MB/sec (without seq num) 2024/11/21-04:51:16.451829 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103132: 925396 keys, 38144866 bytes, temperature: kWarm 2024/11/21-04:51:16.451887 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135876451858, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103132, "file_size": 38144866, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1375097067, "largest_seqno": 1546138709, "table_properties": {"data_size": 32059072, "index_size": 1760320, "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": 25911088, "raw_average_key_size": 28, "raw_value_size": 108306684, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 925396, "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": 1732135873, "oldest_key_time": 0, "file_creation_time": 1732135873, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103132, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:16.485561 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103133.sst) /dev/shm/ToplingTemp/Topling-1344922-iUkB6R 2024/11/21-04:51:17.384339 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103133.sst): first pass time = 0.90's, 149.339'MB/sec 2024/11/21-04:51:18.495300 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103133.sst): old prealloc_size = 147639500, real_size = 34538064 2024/11/21-04:51:18.495938 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103133.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 925271 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.1083 GB zip-val = 0.0325 GB avg-val = 117.06 avg-zval = 35.16 2024/11/21-04:51:18.496699 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103133.sst: sumWaitingMem = 0.002 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0023 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/21-04:51:19.338125 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103133.sst): second pass time = 1.11's, 97.562'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.84's, 45.837'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2887.382'MB/sec (index lex order gen) rebuild zvType time = 0.72's, 0.323'MB/sec write SST data time = 0.13's, 303.858'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.081'MB, throughput = 34203.051'MB/sec zip my value time = 1.11's, unzip length = 0.108'GB zip my value throughput = 97.562'MB/sec zip pipeline throughput = 97.562'MB/sec entries = 925271 avg-key = 28.00 avg-zkey = 1.92 avg-val = 117.06 avg-zval = 35.16 usrkeys = 925271 avg-key = 20.00 avg-zkey = 1.92 avg-val = 124.06 avg-zval = 35.16 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 925271 bytes = 3238464 } seq expand size = 6476897 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0325 GB dict = 1.08 MB all = 0.0386 GB } UnZip/Zip{ index = 10.4427 value = 3.3291 dict = 1.00 all = 3.4743 } Zip/UnZip{ index = 0.0958 value = 0.3004 dict = 1.00 all = 0.2878 } ---------------------------- total value len = 564.551477 GB avg = 0.330 KB (by entry num) total key len = 44.652121 GB avg = 0.026 KB total ukey len = 33.035366 GB avg = 0.014 KB total ukey num = 2.333075808 Billion total entry num = 1.712577830 Billion write speed all = 15.678095610 MB/sec (with seq num) write speed all = 15.325504666 MB/sec (without seq num) 2024/11/21-04:51:19.385640 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103133: 925271 keys, 38631804 bytes, temperature: kWarm 2024/11/21-04:51:19.385710 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135879385670, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103133, "file_size": 38631804, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1387289937, "largest_seqno": 1546138459, "table_properties": {"data_size": 32534464, "index_size": 1772096, "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": 25907588, "raw_average_key_size": 28, "raw_value_size": 108310242, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 925271, "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": 1732135876, "oldest_key_time": 0, "file_creation_time": 1732135876, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103133, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:19.420948 140008492664384 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103134.sst) /dev/shm/ToplingTemp/Topling-1344922-R8ZykT 2024/11/21-04:51:19.514642 140008492664384 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103134.sst): first pass time = 0.09's, 245.285'MB/sec 2024/11/21-04:51:19.699828 140008492664384 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103134.sst): old prealloc_size = 147639500, real_size = 6416496 2024/11/21-04:51:19.699978 140008492664384 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103134.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 160149 prefix = 4 raw-key = 0.0026 GB zip-key = 0.0003 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0185 GB zip-val = 0.0061 GB avg-val = 115.46 avg-zval = 37.89 2024/11/21-04:51:19.700169 140008492664384 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103134.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0004 GB, waited 0.000 sec, Key+Value = 0.023 GB 2024/11/21-04:51:19.841955 140008492664384 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00/103134.sst): second pass time = 0.18's, 100.212'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.14's, 50.055'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2373.512'MB/sec (index lex order gen) rebuild zvType time = 0.12's, 0.336'MB/sec write SST data time = 0.02's, 313.037'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.194'MB, throughput = 5208.264'MB/sec zip my value time = 0.18's, unzip length = 0.018'GB zip my value throughput = 100.212'MB/sec zip pipeline throughput = 100.212'MB/sec entries = 160149 avg-key = 28.00 avg-zkey = 1.92 avg-val = 115.46 avg-zval = 37.89 usrkeys = 160149 avg-key = 20.00 avg-zkey = 1.92 avg-val = 122.46 avg-zval = 37.89 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 160149 bytes = 540512 } seq expand size = 1121043 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0032 GB value = 0.0185 GB dict = 0.19 MB all = 0.0230 GB } __ZipSize{ index = 0.0003 GB value = 0.0061 GB dict = 0.19 MB all = 0.0071 GB } UnZip/Zip{ index = 10.3982 value = 3.0471 dict = 1.00 all = 3.2299 } Zip/UnZip{ index = 0.0962 value = 0.3282 dict = 1.00 all = 0.3096 } ---------------------------- total value len = 564.571088 GB avg = 0.330 KB (by entry num) total key len = 44.656605 GB avg = 0.026 KB total ukey len = 33.038569 GB avg = 0.014 KB total ukey num = 2.333235957 Billion total entry num = 1.712737979 Billion write speed all = 15.678512434 MB/sec (with seq num) write speed all = 15.325893090 MB/sec (without seq num) 2024/11/21-04:51:19.856157 140008492664384 [compaction_job.cc:1948] [default] [JOB 6028] Generated table #103134: 160149 keys, 7113103 bytes, temperature: kWarm 2024/11/21-04:51:19.856209 140008492664384 EVENT_LOG_v1 {"time_micros": 1732135879856181, "cf_name": "default", "job": 6028, "event": "table_file_creation", "file_number": 103134, "file_size": 7113103, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 1455466479, "largest_seqno": 1545622966, "table_properties": {"data_size": 6068256, "index_size": 308032, "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": 4484172, "raw_average_key_size": 28, "raw_value_size": 18490654, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 160149, "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": 1732135879, "oldest_key_time": 0, "file_creation_time": 1732135879, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "MNFBDNZRMES7C6T09KKW", "orig_file_number": 103134, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/21-04:51:19.866920 140008492664384 [compaction_job.cc:703] job-06028: subcompact[0], size: 0.525480 G, files: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-06028/att-00 [103121,103122,103123,103124,103125,103126,103127,103128,103129,103130,103131,103132,103133,103134] 2024/11/21-04:51:19.956385 140008492664384 (Original Log Time 2024/11/21-04:50:37.716120) EVENT_LOG_v1 {"time_micros": 1732135837716080, "job": 6028, "event": "compaction_started", "compaction_reason": "FilesMarkedForCompaction", "files_L2": [103112], "files_L3": [103052, 103054, 103055, 103056, 103057, 103058, 103059, 103060, 103061, 103062, 103063, 103064, 103075], "score": 0.99672, "input_data_size": 548794255, "oldest_snapshot_seqno": 1546171965} 2024/11/21-04:51:19.956389 140008492664384 (Original Log Time 2024/11/21-04:51:19.955148) [compaction_job.cc:2022] [default] [JOB 6028] Compacted 1@2 + 13@3 files to L3 => 525479546 bytes 2024/11/21-04:51:19.956390 140008492664384 (Original Log Time 2024/11/21-04:51:19.956319) [compaction_job.cc:1224] [default] compacted to: files[0 0 0 14 0 0 0] max score 0.02, MB/sec: 13.0 rd, 12.5 wr, level 3, files in(1, 13) out(14 +0 blob) MB in(27.2, 496.2 +0.0 blob) out(501.1 +0.0 blob), read-write-amplify(37.7) write-amplify(18.4) OK, records in: 12296335, records dropped: 74954 output_compression: Snappy 2024/11/21-04:51:19.956395 140008492664384 (Original Log Time 2024/11/21-04:51:19.956365) EVENT_LOG_v1 {"time_micros": 1732135879956341, "cf": "default", "job": 6028, "event": "compaction_finished", "compaction_time_micros": 42150804, "compaction_time_cpu_micros": 19015248, "output_level": 3, "num_output_files": 14, "total_output_size": 525479546, "num_input_records": 12296335, "num_output_records": 12221381, "num_subcompactions": 1, "output_compression": "Snappy", "num_single_delete_mismatches": 0, "num_single_delete_fallthrough": 0, "file_write_nanos": 418877548, "file_range_sync_nanos": 0, "file_fsync_nanos": 12232, "file_prepare_write_nanos": 50322, "lsm_state": [0, 0, 0, 14, 0, 0, 0]} 2024/11/21-04:51:20.098409 140008492664384 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":"d89b4006-2803-486e-b7a2-759bcf348921","dbStarts":1732121803,"starts":1732135837,"executesMs":42371,"compactionJobId":6028,"attempt":0,"compactionInputRawBytes":1778449838,"compactionInputZipBytes":548794255,"compactionOutputRawBytes":0,"compactionOutputZipBytes":525479546,"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-89b34cfc6fe80178b129d73aaa6e1e9c-7d24d8af391ce076-00"}}, response = 2024/11/21-04:51:20.098465 140008492664384 INFO dcompact_worker.cpp:1464: finish /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-21T00.56.43/.rocksdb/job-06028/att-00: olev 3, work 42.372 s, result 7.824 ms, install 1.261 ms, input{raw 1.656 GiB zip 523.371 MiB}