2024/11/20-22:00:45.643647 140007980709440 DEBG dcompact_worker.cpp:2219: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00: fork to child time = 0.025865 sec 2024/11/20-22:00:45.644396 140007980709440 DEBG dcompact_worker.cpp:1013: Beg SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00 2024/11/20-22:00:45.651933 140007980709440 DEBG dcompact_worker.cpp:1033: End SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00 2024/11/20-22:00:45.654199 140007980709440 TRAC dcompact_worker.cpp:1083: INFO_LOG_LEVEL: rpc = INFO_LEVEL, env_var = undefined 2024/11/20-22:00:45.654554 140007980709440 [WARN] [column_family.cc:386] multiple cf_paths/db_paths and level_compaction_dynamic_level_bytes can't be used together 2024/11/20-22:00:45.704740 140007980709440 [version_set.cc:6211] Recovering from manifest file: /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-20T17.53.03/.rocksdb/job-16136/att-00/MANIFEST-049091 2024/11/20-22:00:45.766582 140007980709440 [version_set.cc:6254] Recovered from manifest file:/worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-20T17.53.03/.rocksdb/job-16136/att-00/MANIFEST-049091 succeeded,manifest_file_number is 49091, next_file_number is 76653, last_sequence is 1206123593, log_number is 0,prev_log_number is 0,max_column_family is 0,min_log_number_to_keep is 76499 2024/11/20-22:00:45.766593 140007980709440 [version_set.cc:6269] Column family [default] (ID 0), log number is 0 2024/11/20-22:00:45.766709 140007980709440 [version_set.cc:5724] Creating manifest 76653 2024/11/20-22:00:45.800202 140007980709440 DEBG dcompact_worker.cpp:1225: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00: bottommost_level: fake = 1, rpc = 0 2024/11/20-22:00:45.822078 140007980709440 [compaction_job.cc:2437] [default] [JOB 16136] Compacting 1@2 + 10@3 files to L3, score 0.96, subcompactions 1 : 1 2024/11/20-22:00:45.822104 140007980709440 [compaction_job.cc:2445] [default]: Compaction start summary: Base version 12569 Base level 2, inputs: [76624(31MB)], [76529(40MB) 76530(39MB) 76531(40MB) 76532(39MB) 76533(39MB) 76534(39MB) 76535(40MB) 76536(1788KB) 76519(40MB) 76646(40MB)] 2024/11/20-22:00:45.832864 140007980709440 [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/20-22:00:45.832902 140007980709440 [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/20-22:00:45.832933 140007980709440 [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/20-22:00:45.832947 140007980709440 [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/20-22:00:45.832962 140007980709440 [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/20-22:00:46.500996 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076654.sst) /dev/shm/ToplingTemp/Topling-1051206-b16v9q 2024/11/20-22:00:46.969303 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076654.sst): first pass time = 0.47's, 286.653'MB/sec 2024/11/20-22:00:47.805800 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076654.sst): old prealloc_size = 147639500, real_size = 40708512 2024/11/20-22:00:47.805936 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076654.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129430 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.71 raw-val = 0.1316 GB zip-val = 0.0405 GB avg-val =1016.99 avg-zval = 312.56 2024/11/20-22:00:47.806065 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076654.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:47.985027 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076654.sst): second pass time = 0.84's, 157.517'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.18's, 235.971'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2037.644'MB/sec (index lex order gen) rebuild zvType time = 0.13's, 0.244'MB/sec write SST data time = 0.05's, 904.667'MB/sec dict compress time = 2334118308.98's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 17581.610'MB/sec zip my value time = 0.84's, unzip length = 0.132'GB zip my value throughput = 157.517'MB/sec zip pipeline throughput = 288.133'MB/sec entries = 129430 avg-key = 20.00 avg-zkey = 1.71 avg-val = 1016.99 avg-zval = 312.56 usrkeys = 129430 avg-key = 12.00 avg-zkey = 1.71 avg-val = 1020.34 avg-zval = 312.56 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 61810 bytes = 216352 } seq expand size = 432670 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0405 GB dict = 1.38 MB all = 0.0423 GB } UnZip/Zip{ index = 7.0018 value = 3.2538 dict = 1.00 all = 3.1736 } Zip/UnZip{ index = 0.1428 value = 0.3073 dict = 1.00 all = 0.3151 } ---------------------------- total value len = 563.197794 GB avg = 0.331 KB (by entry num) total key len = 44.316995 GB avg = 0.026 KB total ukey len = 32.795695 GB avg = 0.014 KB total ukey num = 2.321144006 Billion total entry num = 1.700646028 Billion write speed all = 42.705631521 MB/sec (with seq num) write speed all = 41.749247724 MB/sec (without seq num) 2024/11/20-22:00:48.090193 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76654: 129430 keys, 42292588 bytes, temperature: kWarm 2024/11/20-22:00:48.090293 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111248090247, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76654, "file_size": 42292588, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205873330, "table_properties": {"data_size": 40454160, "index_size": 221824, "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": 2588600, "raw_average_key_size": 20, "raw_value_size": 131629523, "raw_average_value_size": 1016, "num_data_blocks": 1, "num_entries": 129430, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111246, "oldest_key_time": 0, "file_creation_time": 1732111246, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76654, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:48.129961 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076655.sst) /dev/shm/ToplingTemp/Topling-1051206-cNHGtr 2024/11/20-22:00:48.665009 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076655.sst): first pass time = 0.54's, 250.871'MB/sec 2024/11/20-22:00:49.495539 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076655.sst): old prealloc_size = 147639500, real_size = 40454160 2024/11/20-22:00:49.495663 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076655.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129431 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.76 raw-val = 0.1316 GB zip-val = 0.0402 GB avg-val =1016.98 avg-zval = 310.54 2024/11/20-22:00:49.495744 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076655.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:49.661402 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076655.sst): second pass time = 0.83's, 158.622'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.17's, 252.797'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2330.411'MB/sec (index lex order gen) rebuild zvType time = 0.12's, 0.275'MB/sec write SST data time = 0.05's, 874.469'MB/sec dict compress time = 2334118308.98's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 41474.462'MB/sec zip my value time = 0.83's, unzip length = 0.132'GB zip my value throughput = 158.622'MB/sec zip pipeline throughput = 317.243'MB/sec entries = 129431 avg-key = 20.00 avg-zkey = 1.76 avg-val = 1016.98 avg-zval = 310.54 usrkeys = 129431 avg-key = 12.00 avg-zkey = 1.76 avg-val = 1018.50 avg-zval = 310.54 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 28127 bytes = 98464 } seq expand size = 196889 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0402 GB dict = 1.38 MB all = 0.0419 GB } UnZip/Zip{ index = 6.8093 value = 3.2749 dict = 1.00 all = 3.2017 } Zip/UnZip{ index = 0.1469 value = 0.3054 dict = 1.00 all = 0.3123 } ---------------------------- total value len = 563.329621 GB avg = 0.331 KB (by entry num) total key len = 44.319584 GB avg = 0.026 KB total ukey len = 32.797248 GB avg = 0.014 KB total ukey num = 2.321273437 Billion total entry num = 1.700775459 Billion write speed all = 42.710047297 MB/sec (with seq num) write speed all = 41.753703409 MB/sec (without seq num) 2024/11/20-22:00:49.720014 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76655: 129431 keys, 41920324 bytes, temperature: kWarm 2024/11/20-22:00:49.720098 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111249720065, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76655, "file_size": 41920324, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205866574, "table_properties": {"data_size": 40193536, "index_size": 228096, "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": 2588620, "raw_average_key_size": 20, "raw_value_size": 131629186, "raw_average_value_size": 1016, "num_data_blocks": 1, "num_entries": 129431, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111248, "oldest_key_time": 0, "file_creation_time": 1732111248, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76655, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:49.759440 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076656.sst) /dev/shm/ToplingTemp/Topling-1051206-5Qa5vu 2024/11/20-22:00:50.549286 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076656.sst): first pass time = 0.79's, 169.939'MB/sec 2024/11/20-22:00:51.302807 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076656.sst): old prealloc_size = 147639500, real_size = 40489936 2024/11/20-22:00:51.302950 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076656.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129431 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.81 raw-val = 0.1316 GB zip-val = 0.0402 GB avg-val =1016.99 avg-zval = 310.77 2024/11/20-22:00:51.303038 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076656.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:51.471221 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076656.sst): second pass time = 0.75's, 174.881'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.17's, 249.436'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2104.851'MB/sec (index lex order gen) rebuild zvType time = 0.12's, 0.273'MB/sec write SST data time = 0.05's, 846.608'MB/sec dict compress time = 2334118308.98's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 36447.539'MB/sec zip my value time = 0.75's, unzip length = 0.132'GB zip my value throughput = 174.881'MB/sec zip pipeline throughput = 278.074'MB/sec entries = 129431 avg-key = 20.00 avg-zkey = 1.81 avg-val = 1016.99 avg-zval = 310.77 usrkeys = 129431 avg-key = 12.00 avg-zkey = 1.81 avg-val = 1019.33 avg-zval = 310.77 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 43317 bytes = 151632 } seq expand size = 303219 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0402 GB dict = 1.38 MB all = 0.0420 GB } UnZip/Zip{ index = 6.6343 value = 3.2725 dict = 1.00 all = 3.1950 } Zip/UnZip{ index = 0.1507 value = 0.3056 dict = 1.00 all = 0.3130 } ---------------------------- total value len = 563.461554 GB avg = 0.331 KB (by entry num) total key len = 44.322172 GB avg = 0.026 KB total ukey len = 32.798801 GB avg = 0.014 KB total ukey num = 2.321402868 Billion total entry num = 1.700904890 Billion write speed all = 42.714068884 MB/sec (with seq num) write speed all = 41.757773866 MB/sec (without seq num) 2024/11/20-22:00:51.579985 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76656: 129431 keys, 42009276 bytes, temperature: kWarm 2024/11/20-22:00:51.580074 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111251580025, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76656, "file_size": 42009276, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205871974, "table_properties": {"data_size": 40223296, "index_size": 234112, "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": 2588620, "raw_average_key_size": 20, "raw_value_size": 131629863, "raw_average_value_size": 1016, "num_data_blocks": 1, "num_entries": 129431, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111249, "oldest_key_time": 0, "file_creation_time": 1732111249, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76656, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:51.638363 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076657.sst) /dev/shm/ToplingTemp/Topling-1051206-b1g1Dt 2024/11/20-22:00:52.220920 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076657.sst): first pass time = 0.58's, 230.412'MB/sec 2024/11/20-22:00:52.717444 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076657.sst): old prealloc_size = 147639500, real_size = 40440320 2024/11/20-22:00:52.717562 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076657.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129435 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.75 raw-val = 0.1316 GB zip-val = 0.0402 GB avg-val =1016.95 avg-zval = 310.43 2024/11/20-22:00:52.717631 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076657.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:52.883789 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076657.sst): second pass time = 0.50's, 265.488'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.17's, 251.884'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2413.106'MB/sec (index lex order gen) rebuild zvType time = 0.12's, 0.275'MB/sec write SST data time = 0.05's, 861.091'MB/sec dict compress time = 2334118308.98's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 47572.188'MB/sec zip my value time = 0.50's, unzip length = 0.132'GB zip my value throughput = 265.488'MB/sec zip pipeline throughput = 265.488'MB/sec entries = 129435 avg-key = 20.00 avg-zkey = 1.75 avg-val = 1016.95 avg-zval = 310.43 usrkeys = 129435 avg-key = 12.00 avg-zkey = 1.75 avg-val = 1018.28 avg-zval = 310.43 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 24447 bytes = 85584 } seq expand size = 171129 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0402 GB dict = 1.38 MB all = 0.0419 GB } UnZip/Zip{ index = 6.8383 value = 3.2759 dict = 1.00 all = 3.2038 } Zip/UnZip{ index = 0.1462 value = 0.3053 dict = 1.00 all = 0.3121 } ---------------------------- total value len = 563.593354 GB avg = 0.331 KB (by entry num) total key len = 44.324761 GB avg = 0.026 KB total ukey len = 32.800354 GB avg = 0.014 KB total ukey num = 2.321532303 Billion total entry num = 1.701034325 Billion write speed all = 42.719272705 MB/sec (with seq num) write speed all = 41.762999847 MB/sec (without seq num) 2024/11/20-22:00:52.938000 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76657: 129435 keys, 41893226 bytes, temperature: kWarm 2024/11/20-22:00:52.938077 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111252938037, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76657, "file_size": 41893226, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205866996, "table_properties": {"data_size": 40180656, "index_size": 227136, "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": 2588700, "raw_average_key_size": 20, "raw_value_size": 131629568, "raw_average_value_size": 1016, "num_data_blocks": 1, "num_entries": 129435, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111251, "oldest_key_time": 0, "file_creation_time": 1732111251, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76657, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:52.982716 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076658.sst) /dev/shm/ToplingTemp/Topling-1051206-Jjhbas 2024/11/20-22:00:53.762815 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076658.sst): first pass time = 0.78's, 172.060'MB/sec 2024/11/20-22:00:54.458440 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076658.sst): old prealloc_size = 147639500, real_size = 40408464 2024/11/20-22:00:54.458605 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076658.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129426 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.72 raw-val = 0.1316 GB zip-val = 0.0402 GB avg-val =1017.03 avg-zval = 310.24 2024/11/20-22:00:54.458695 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076658.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:54.643760 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076658.sst): second pass time = 0.69's, 189.521'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.19's, 225.680'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 1614.568'MB/sec (index lex order gen) rebuild zvType time = 0.14's, 0.233'MB/sec write SST data time = 0.05's, 908.108'MB/sec dict compress time = 140029.08's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 23820.140'MB/sec zip my value time = 0.69's, unzip length = 0.132'GB zip my value throughput = 189.521'MB/sec zip pipeline throughput = 189.521'MB/sec entries = 129426 avg-key = 20.00 avg-zkey = 1.72 avg-val = 1017.03 avg-zval = 310.24 usrkeys = 129426 avg-key = 12.00 avg-zkey = 1.72 avg-val = 1017.71 avg-zval = 310.24 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 12555 bytes = 43952 } seq expand size = 87885 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0402 GB dict = 1.38 MB all = 0.0418 GB } UnZip/Zip{ index = 6.9734 value = 3.2782 dict = 1.00 all = 3.2095 } Zip/UnZip{ index = 0.1434 value = 0.3050 dict = 1.00 all = 0.3116 } ---------------------------- total value len = 563.725072 GB avg = 0.331 KB (by entry num) total key len = 44.327349 GB avg = 0.026 KB total ukey len = 32.801908 GB avg = 0.014 KB total ukey num = 2.321661729 Billion total entry num = 1.701163751 Billion write speed all = 42.723426730 MB/sec (with seq num) write speed all = 41.767199375 MB/sec (without seq num) 2024/11/20-22:00:54.694801 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76658: 129426 keys, 41819725 bytes, temperature: kWarm 2024/11/20-22:00:54.694870 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111254694838, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76658, "file_size": 41819725, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205854931, "table_properties": {"data_size": 40153216, "index_size": 222720, "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": 2588520, "raw_average_key_size": 20, "raw_value_size": 131629824, "raw_average_value_size": 1017, "num_data_blocks": 1, "num_entries": 129426, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111252, "oldest_key_time": 0, "file_creation_time": 1732111252, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76658, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:54.734015 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076659.sst) /dev/shm/ToplingTemp/Topling-1051206-q7bUrs 2024/11/20-22:00:55.306269 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076659.sst): first pass time = 0.57's, 234.568'MB/sec 2024/11/20-22:00:55.951608 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076659.sst): old prealloc_size = 147639500, real_size = 40399184 2024/11/20-22:00:55.951739 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076659.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129428 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.71 raw-val = 0.1316 GB zip-val = 0.0401 GB avg-val =1017.01 avg-zval = 310.17 2024/11/20-22:00:55.951819 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076659.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:56.114714 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076659.sst): second pass time = 0.64's, 204.231'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.16's, 256.289'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2202.274'MB/sec (index lex order gen) rebuild zvType time = 0.12's, 0.278'MB/sec write SST data time = 0.05's, 900.581'MB/sec dict compress time = 0.00's, 1377842.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 34528.054'MB/sec zip my value time = 0.64's, unzip length = 0.132'GB zip my value throughput = 204.231'MB/sec zip pipeline throughput = 228.664'MB/sec entries = 129428 avg-key = 20.00 avg-zkey = 1.71 avg-val = 1017.01 avg-zval = 310.17 usrkeys = 129428 avg-key = 12.00 avg-zkey = 1.71 avg-val = 1017.56 avg-zval = 310.17 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 10093 bytes = 35344 } seq expand size = 70651 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0401 GB dict = 1.38 MB all = 0.0418 GB } UnZip/Zip{ index = 7.0017 value = 3.2789 dict = 1.00 all = 3.2108 } Zip/UnZip{ index = 0.1428 value = 0.3050 dict = 1.00 all = 0.3114 } ---------------------------- total value len = 563.856772 GB avg = 0.331 KB (by entry num) total key len = 44.329938 GB avg = 0.026 KB total ukey len = 32.803461 GB avg = 0.014 KB total ukey num = 2.321791157 Billion total entry num = 1.701293179 Billion write speed all = 42.728446114 MB/sec (with seq num) write speed all = 41.772244833 MB/sec (without seq num) 2024/11/20-22:00:56.170847 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76659: 129428 keys, 41802033 bytes, temperature: kWarm 2024/11/20-22:00:56.170917 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111256170885, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76659, "file_size": 41802033, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205868527, "table_properties": {"data_size": 40144832, "index_size": 221824, "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": 2588560, "raw_average_key_size": 20, "raw_value_size": 131629816, "raw_average_value_size": 1017, "num_data_blocks": 1, "num_entries": 129428, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111254, "oldest_key_time": 0, "file_creation_time": 1732111254, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76659, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:56.210242 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076660.sst) /dev/shm/ToplingTemp/Topling-1051206-nz0oos 2024/11/20-22:00:56.788447 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076660.sst): first pass time = 0.58's, 232.148'MB/sec 2024/11/20-22:00:57.627363 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076660.sst): old prealloc_size = 147639500, real_size = 40904192 2024/11/20-22:00:57.627486 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076660.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129431 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.73 raw-val = 0.1316 GB zip-val = 0.0406 GB avg-val =1016.99 avg-zval = 314.05 2024/11/20-22:00:57.627634 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076660.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:57.791745 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076660.sst): second pass time = 0.84's, 157.049'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.16's, 259.627'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2297.180'MB/sec (index lex order gen) rebuild zvType time = 0.12's, 0.271'MB/sec write SST data time = 0.04's, 950.942'MB/sec dict compress time = 0.00's, 1377756.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 40491.271'MB/sec zip my value time = 0.84's, unzip length = 0.132'GB zip my value throughput = 157.049'MB/sec zip pipeline throughput = 164.032'MB/sec entries = 129431 avg-key = 20.00 avg-zkey = 1.73 avg-val = 1016.99 avg-zval = 314.05 usrkeys = 129431 avg-key = 12.00 avg-zkey = 1.73 avg-val = 1023.19 avg-zval = 314.05 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 114633 bytes = 401232 } seq expand size = 802431 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0406 GB dict = 1.38 MB all = 0.0427 GB } UnZip/Zip{ index = 6.9497 value = 3.2383 dict = 1.00 all = 3.1453 } Zip/UnZip{ index = 0.1439 value = 0.3088 dict = 1.00 all = 0.3179 } ---------------------------- total value len = 563.989205 GB avg = 0.331 KB (by entry num) total key len = 44.332527 GB avg = 0.026 KB total ukey len = 32.805014 GB avg = 0.014 KB total ukey num = 2.321920588 Billion total entry num = 1.701422610 Billion write speed all = 42.732897277 MB/sec (with seq num) write speed all = 41.776735906 MB/sec (without seq num) 2024/11/20-22:00:57.846789 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76660: 129431 keys, 42672859 bytes, temperature: kWarm 2024/11/20-22:00:57.846884 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111257846837, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76660, "file_size": 42672859, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205873291, "table_properties": {"data_size": 40648176, "index_size": 223488, "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": 2588620, "raw_average_key_size": 20, "raw_value_size": 131630139, "raw_average_value_size": 1016, "num_data_blocks": 1, "num_entries": 129431, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111256, "oldest_key_time": 0, "file_creation_time": 1732111256, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76660, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:57.893786 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076661.sst) /dev/shm/ToplingTemp/Topling-1051206-WVofFr 2024/11/20-22:00:58.534776 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076661.sst): first pass time = 0.64's, 209.410'MB/sec 2024/11/20-22:00:59.123172 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076661.sst): old prealloc_size = 147639500, real_size = 40727760 2024/11/20-22:00:59.123336 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076661.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129429 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.72 raw-val = 0.1316 GB zip-val = 0.0405 GB avg-val =1017.01 avg-zval = 312.70 2024/11/20-22:00:59.123470 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076661.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:00:59.325866 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076661.sst): second pass time = 0.59's, 224.060'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.20's, 208.840'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 1654.270'MB/sec (index lex order gen) rebuild zvType time = 0.15's, 0.214'MB/sec write SST data time = 0.05's, 828.024'MB/sec dict compress time = 0.00's, 1378144.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 42033.245'MB/sec zip my value time = 0.59's, unzip length = 0.132'GB zip my value throughput = 224.060'MB/sec zip pipeline throughput = 224.060'MB/sec entries = 129429 avg-key = 20.00 avg-zkey = 1.72 avg-val = 1017.01 avg-zval = 312.70 usrkeys = 129429 avg-key = 12.00 avg-zkey = 1.72 avg-val = 1020.59 avg-zval = 312.70 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 66205 bytes = 231728 } seq expand size = 463435 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0405 GB dict = 1.38 MB all = 0.0423 GB } UnZip/Zip{ index = 6.9776 value = 3.2523 dict = 1.00 all = 3.1710 } Zip/UnZip{ index = 0.1433 value = 0.3075 dict = 1.00 all = 0.3154 } ---------------------------- total value len = 564.121299 GB avg = 0.332 KB (by entry num) total key len = 44.335115 GB avg = 0.026 KB total ukey len = 32.806567 GB avg = 0.014 KB total ukey num = 2.322050017 Billion total entry num = 1.701552039 Billion write speed all = 42.737752576 MB/sec (with seq num) write speed all = 41.781621508 MB/sec (without seq num) 2024/11/20-22:00:59.380851 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76661: 129429 keys, 42327327 bytes, temperature: kWarm 2024/11/20-22:00:59.380922 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111259380891, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76661, "file_size": 42327327, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205873298, "table_properties": {"data_size": 40472640, "index_size": 222592, "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": 2588580, "raw_average_key_size": 20, "raw_value_size": 131630129, "raw_average_value_size": 1017, "num_data_blocks": 1, "num_entries": 129429, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111257, "oldest_key_time": 0, "file_creation_time": 1732111257, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76661, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:00:59.418092 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076662.sst) /dev/shm/ToplingTemp/Topling-1051206-CspEMs 2024/11/20-22:00:59.974989 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076662.sst): first pass time = 0.56's, 241.030'MB/sec 2024/11/20-22:01:00.782038 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076662.sst): old prealloc_size = 147639500, real_size = 40697536 2024/11/20-22:01:00.782187 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076662.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 129431 prefix = 4 raw-key = 0.0010 GB zip-key = 0.0002 GB avg-key = 8.00 avg-zkey = 1.78 raw-val = 0.1316 GB zip-val = 0.0404 GB avg-val =1016.99 avg-zval = 312.40 2024/11/20-22:01:00.782297 140007980709440 [top_zip_table_builder.cc:1325] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076662.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0003 GB, waited 0.000 sec, Key+Value = 0.134 GB 2024/11/20-22:01:00.951088 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076662.sst): second pass time = 0.81's, 163.298'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.17's, 250.366'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2291.997'MB/sec (index lex order gen) rebuild zvType time = 0.12's, 0.264'MB/sec write SST data time = 0.05's, 910.088'MB/sec dict compress time = 0.00's, 1377543.000'MB/sec z-dict build time = 0.00's, sample length = 1.378'MB, throughput = 43437.802'MB/sec zip my value time = 0.81's, unzip length = 0.132'GB zip my value throughput = 163.298'MB/sec zip pipeline throughput = 165.247'MB/sec entries = 129431 avg-key = 20.00 avg-zkey = 1.78 avg-val = 1016.99 avg-zval = 312.40 usrkeys = 129431 avg-key = 12.00 avg-zkey = 1.78 avg-val = 1020.90 avg-zval = 312.40 TagRS{ kinds = RS_Key0_TagN bytes = 20320 } TagArray{ size = 72400 bytes = 253408 } seq expand size = 506800 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0016 GB value = 0.1316 GB dict = 1.38 MB all = 0.1342 GB } __ZipSize{ index = 0.0002 GB value = 0.0404 GB dict = 1.38 MB all = 0.0423 GB } UnZip/Zip{ index = 6.7244 value = 3.2554 dict = 1.00 all = 3.1716 } Zip/UnZip{ index = 0.1487 value = 0.3072 dict = 1.00 all = 0.3153 } ---------------------------- total value len = 564.253435 GB avg = 0.332 KB (by entry num) total key len = 44.337704 GB avg = 0.026 KB total ukey len = 32.808120 GB avg = 0.014 KB total ukey num = 2.322179448 Billion total entry num = 1.701681470 Billion write speed all = 42.742336354 MB/sec (with seq num) write speed all = 41.786241700 MB/sec (without seq num) 2024/11/20-22:01:01.002800 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76662: 129431 keys, 42318342 bytes, temperature: kWarm 2024/11/20-22:01:01.002866 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111261002835, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76662, "file_size": 42318342, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205873118, "table_properties": {"data_size": 40434032, "index_size": 230976, "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": 2588620, "raw_average_key_size": 20, "raw_value_size": 131629425, "raw_average_value_size": 1016, "num_data_blocks": 1, "num_entries": 129431, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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": 1732111259, "oldest_key_time": 0, "file_creation_time": 1732111259, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76662, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:01:01.041228 140007980709440 [top_zip_table_builder.cc:960] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076663.sst) /dev/shm/ToplingTemp/Topling-1051206-x3evHu 2024/11/20-22:01:01.054530 140007980709440 [top_zip_table_builder.cc:1378] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076663.sst): first pass time = 0.01's, 523.906'MB/sec 2024/11/20-22:01:01.131994 140007980709440 [top_zip_table_builder.cc:2798] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076663.sst): old prealloc_size = 147639500, real_size = 2177768 2024/11/20-22:01:01.132040 140007980709440 [top_zip_table_builder.cc:1799] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076663.sst): index type = UintIndex_AllOne , store type = DictZipBlobStore usrkeys = 6702 prefix = 4 raw-key = 0.0001 GB zip-key = 0.0000 GB avg-key = 8.00 avg-zkey = 0.03 raw-val = 0.0068 GB zip-val = 0.0022 GB avg-val =1017.00 avg-zval = 324.64 2024/11/20-22:01:01.142952 140007980709440 [top_zip_table_builder.cc:3129] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00/076663.sst): second pass time = 0.08's, 88.809'MB/sec, value only(98.1% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.01's, 207.487'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 5.220'MB/sec (index lex order gen) rebuild zvType time = 0.01's, 0.204'MB/sec write SST data time = 0.00's, 841.934'MB/sec dict compress time = 0.00's, 72129.000'MB/sec z-dict build time = 0.00's, sample length = 0.072'MB, throughput = 1747.523'MB/sec zip my value time = 0.08's, unzip length = 0.007'GB zip my value throughput = 88.809'MB/sec zip pipeline throughput = 88.809'MB/sec entries = 6702 avg-key = 20.00 avg-zkey = 0.03 avg-val = 1017.00 avg-zval = 324.64 usrkeys = 6702 avg-key = 12.00 avg-zkey = 0.03 avg-val = 1022.76 avg-zval = 324.64 TagRS{ kinds = RS_Key0_TagN bytes = 1160 } TagArray{ size = 5510 bytes = 19296 } seq expand size = 38570 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0001 GB value = 0.0068 GB dict = 0.07 MB all = 0.0069 GB } __ZipSize{ index = 0.0000 GB value = 0.0022 GB dict = 0.07 MB all = 0.0023 GB } UnZip/Zip{ index = 418.8750 value = 3.1327 dict = 1.00 all = 3.0621 } Zip/UnZip{ index = 0.0024 value = 0.3192 dict = 1.00 all = 0.3266 } ---------------------------- total value len = 564.260289 GB avg = 0.332 KB (by entry num) total key len = 44.337838 GB avg = 0.026 KB total ukey len = 32.808201 GB avg = 0.014 KB total ukey num = 2.322186150 Billion total entry num = 1.701688172 Billion write speed all = 42.742251212 MB/sec (with seq num) write speed all = 41.786165676 MB/sec (without seq num) 2024/11/20-22:01:01.152597 140007980709440 [compaction_job.cc:1948] [default] [JOB 16136] Generated table #76663: 6702 keys, 2269700 bytes, temperature: kWarm 2024/11/20-22:01:01.152655 140007980709440 EVENT_LOG_v1 {"time_micros": 1732111261152621, "cf_name": "default", "job": 16136, "event": "table_file_creation", "file_number": 76663, "file_size": 2269700, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 1205872805, "table_properties": {"data_size": 2175728, "index_size": 192, "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": 134040, "raw_average_key_size": 20, "raw_value_size": 6815943, "raw_average_value_size": 1017, "num_data_blocks": 1, "num_entries": 6702, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 20, "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-UintIndex_AllOne-DictZipBlobStore", "creation_time": 1732111261, "oldest_key_time": 0, "file_creation_time": 1732111261, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "6MZ3RU376XPAYLWHL32R", "orig_file_number": 76663, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/20-22:01:01.164518 140007980709440 [compaction_job.cc:703] job-16136: subcompact[0], size: 0.381325 G, files: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-16136/att-00 [076654,076655,076656,076657,076658,076659,076660,076661,076662,076663] 2024/11/20-22:01:01.233421 140007980709440 (Original Log Time 2024/11/20-22:00:45.822193) EVENT_LOG_v1 {"time_micros": 1732111245822131, "job": 16136, "event": "compaction_started", "compaction_reason": "FilesMarkedForCompaction", "files_L2": [76624], "files_L3": [76529, 76530, 76531, 76532, 76533, 76534, 76535, 76536, 76519, 76646], "score": 0.959864, "input_data_size": 413616012, "oldest_snapshot_seqno": 1206123507} 2024/11/20-22:01:01.233425 140007980709440 (Original Log Time 2024/11/20-22:01:01.232449) [compaction_job.cc:2022] [default] [JOB 16136] Compacted 1@2 + 10@3 files to L3 => 381325400 bytes 2024/11/20-22:01:01.233426 140007980709440 (Original Log Time 2024/11/20-22:01:01.233349) [compaction_job.cc:1224] [default] compacted to: files[0 0 0 10 0 0 0] max score 0.01, MB/sec: 27.0 rd, 24.9 wr, level 3, files in(1, 10) out(10 +0 blob) MB in(31.2, 363.2 +0.0 blob) out(363.7 +0.0 blob), read-write-amplify(24.3) write-amplify(11.6) OK, records in: 1202196, records dropped: 30622 output_compression: Snappy 2024/11/20-22:01:01.233434 140007980709440 (Original Log Time 2024/11/20-22:01:01.233398) EVENT_LOG_v1 {"time_micros": 1732111261233374, "cf": "default", "job": 16136, "event": "compaction_finished", "compaction_time_micros": 15342332, "compaction_time_cpu_micros": 3821376, "output_level": 3, "num_output_files": 10, "total_output_size": 381325400, "num_input_records": 1202196, "num_output_records": 1171574, "num_subcompactions": 1, "output_compression": "Snappy", "num_single_delete_mismatches": 0, "num_single_delete_fallthrough": 0, "file_write_nanos": 274183141, "file_range_sync_nanos": 0, "file_fsync_nanos": 9774, "file_prepare_write_nanos": 20588, "lsm_state": [0, 0, 0, 10, 0, 0, 0]} 2024/11/20-22:01:01.367883 140007980709440 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":1732096383,"starts":1732111245,"executesMs":15580,"compactionJobId":16136,"attempt":0,"compactionInputRawBytes":1246670492,"compactionInputZipBytes":413616012,"compactionOutputRawBytes":0,"compactionOutputZipBytes":381325400,"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-42e35d979deffbbd07322a0474ccb7bf-1266bd4438bf95fd-00"}}, response = 2024/11/20-22:01:01.368001 140007980709440 INFO dcompact_worker.cpp:1464: finish /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-20T17.53.03/.rocksdb/job-16136/att-00: olev 3, work 15.581 s, result 7.731 ms, install 1.002 ms, input{raw 1.161 GiB zip 394.455 MiB}