2024/11/23-17:26:45.818896 139957399803456 DEBG dcompact_worker.cpp:2214: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00: fork to child time = 0.012149 sec 2024/11/23-17:26:45.819743 139957399803456 DEBG dcompact_worker.cpp:1013: Beg SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00 2024/11/23-17:26:45.830017 139957399803456 DEBG dcompact_worker.cpp:1033: End SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00 2024/11/23-17:26:45.830954 139957399803456 TRAC dcompact_worker.cpp:1083: INFO_LOG_LEVEL: rpc = INFO_LEVEL, env_var = undefined 2024/11/23-17:26:45.831267 139957399803456 [WARN] [column_family.cc:386] multiple cf_paths/db_paths and level_compaction_dynamic_level_bytes can't be used together 2024/11/23-17:26:45.886850 139957399803456 [version_set.cc:6208] Recovering from manifest file: /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-22T14.14.14/.rocksdb/job-31896/att-00/MANIFEST-206347 2024/11/23-17:26:45.902785 139957399803456 [version_set.cc:6251] Recovered from manifest file:/worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-22T14.14.14/.rocksdb/job-31896/att-00/MANIFEST-206347 succeeded,manifest_file_number is 206347, next_file_number is 272222, last_sequence is 4146783281, log_number is 0,prev_log_number is 0,max_column_family is 0,min_log_number_to_keep is 272086 2024/11/23-17:26:45.902793 139957399803456 [version_set.cc:6266] Column family [default] (ID 0), log number is 0 2024/11/23-17:26:45.902861 139957399803456 [version_set.cc:5721] Creating manifest 272222 2024/11/23-17:26:45.940665 139957399803456 DEBG dcompact_worker.cpp:1218: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00: bottommost_level: fake = 1, rpc = 0 2024/11/23-17:26:45.960437 139957399803456 [compaction_job.cc:2437] [default] [JOB 31896] Compacting 1@2 + 6@3 files to L3, score 0.99, subcompactions 1 : 1 2024/11/23-17:26:45.960450 139957399803456 [compaction_job.cc:2445] [default]: Compaction start summary: Base version 23875 Base level 2, inputs: [272220(27MB)], [272189(37MB) 272190(36MB) 272191(34MB) 272192(10MB) 272138(35MB) 272139(36MB)] 2024/11/23-17:26:45.968002 139957399803456 [top_zip_table.cc:59] core git_version_hash_info_is:commit fc4ab4f2fbfdcdfa23a955d69e26d2fc533b902d Author: leipeng Date: 2024-04-16 20:29:43 +0800 test_sso.cpp: test swap g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. INCS = -Isrc -I3rdparty/re2 -I3rdparty/zstd -Iboost-include CXXFLAGS = -D TOPLING_IO_WITH_URING=1 -fPIC -time -Wno-class-memaccess -fdiagnostics-color -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -mcx16 -Wno-deprecated-declarations -Wstrict-aliasing=3 -DCLIENT_LICENSE_ID="public" -DNO_THREADS -ftls-model=initial-exec -DDIVSUFSORT_API= -fno-stack-protector RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 2024/11/23-17:26:45.968035 139957399803456 [top_zip_table.cc:60] fsa git_version_hash_info_is:commit fc4ab4f2fbfdcdfa23a955d69e26d2fc533b902d Author: leipeng Date: 2024-04-16 20:29:43 +0800 test_sso.cpp: test swap g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. INCS = -Isrc -I3rdparty/re2 -I3rdparty/zstd -Iboost-include CXXFLAGS = -D TOPLING_IO_WITH_URING=1 -fPIC -time -Wno-class-memaccess -fdiagnostics-color -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -mcx16 -Wno-deprecated-declarations -Wstrict-aliasing=3 -DCLIENT_LICENSE_ID="public" -DNO_THREADS -ftls-model=initial-exec -DDIVSUFSORT_API= -fno-stack-protector RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 2024/11/23-17:26:45.968055 139957399803456 [top_zip_table.cc:61] zbs git_version_hash_info_is:commit fc4ab4f2fbfdcdfa23a955d69e26d2fc533b902d Author: leipeng Date: 2024-04-16 20:29:43 +0800 test_sso.cpp: test swap g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. INCS = -Isrc -I3rdparty/re2 -I3rdparty/zstd -Iboost-include CXXFLAGS = -D TOPLING_IO_WITH_URING=1 -fPIC -time -Wno-class-memaccess -fdiagnostics-color -Wformat=2 -Wcomment -Wall -Wextra -Wno-unused-parameter -Wno-alloc-size-larger-than -mcx16 -Wno-deprecated-declarations -Wstrict-aliasing=3 -DCLIENT_LICENSE_ID="public" -DNO_THREADS -ftls-model=initial-exec -DDIVSUFSORT_API= -fno-stack-protector RLS_FLAGS = -O3 -DNDEBUG -g3 WITH_BMI2 = 1 compile_cpu_flag: -march=haswell -mbmi -mbmi2 2024/11/23-17:26:45.968060 139957399803456 [top_zip_table.cc:62] topling-zip_table_reader: git_version_hash_info_is: commit a4a382006cb82713acf5b3425835f22711877681 Author: leipeng Date: 2024-04-11 19:44:14 +0800 fixed_len_hole_index.cc: Add env bool FixedLenHoleIndexUseAVX512 for ut & debug 1. FixedLenHoleIndexUseAVX512 is only in unit tests or debug 2. In release mode, use avx512 by compile options(-march=) g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. cpu_flag: -march=native -mbmi -mbmi2 2024/11/23-17:26:45.968070 139957399803456 [top_zip_table.cc:64] topling-rocks git_version_hash_info_is: commit feab587e468621ba0204d47b4ffacc52e7c4290d Author: leipeng Date: 2024-03-22 13:35:06 +0800 ToplingZipTableBuilder::Add: immediately return after error This function returns void, and caller does not check builder->status() after calling this function and graceful abandon. So immediately return after error, and return error status in Finish(). g++ (GCC) 12.1.0 Copyright (C) 2022 Free Software Foundation, Inc. This is free software; see the source for copying conditions. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. cpu_flag: -march=native -mbmi -mbmi2 2024/11/23-17:26:46.578001 139957399803456 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272223.sst) /dev/shm/ToplingTemp/Topling-132456-vkIKJV 2024/11/23-17:26:47.137392 139957399803456 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272223.sst): first pass time = 0.56's, 239.949'MB/sec 2024/11/23-17:26:48.699039 139957399803456 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272223.sst): old prealloc_size = 147639500, real_size = 35575536 2024/11/23-17:26:48.699764 139957399803456 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272223.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 928756 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.51 avg-zval = 36.15 2024/11/23-17:26:48.700635 139957399803456 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272223.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/23-17:26:49.835319 139957399803456 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272223.sst): second pass time = 1.56's, 69.345'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.14's, 34.716'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2542.367'MB/sec (index lex order gen) rebuild zvType time = 0.88's, 0.265'MB/sec write SST data time = 0.26's, 151.558'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.080'MB, throughput = 35815.191'MB/sec zip my value time = 1.56's, unzip length = 0.108'GB zip my value throughput = 69.345'MB/sec zip pipeline throughput = 69.345'MB/sec entries = 928756 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.51 avg-zval = 36.15 usrkeys = 928756 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.51 avg-zval = 36.15 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 928756 bytes = 3018464 } seq expand size = 6501292 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.0336 GB dict = 1.08 MB all = 0.0394 GB } UnZip/Zip{ index = 10.5150 value = 3.2229 dict = 1.00 all = 3.4024 } Zip/UnZip{ index = 0.0951 value = 0.3103 dict = 1.00 all = 0.2939 } ---------------------------- total value len = 8.963334 GB avg = 0.168 KB (by entry num) total key len = 1.466826 GB avg = 0.028 KB total ukey len = 1.016453 GB avg = 0.015 KB total ukey num = 0.066479191 Billion total entry num = 0.053286920 Billion write speed all = 0.339770959 MB/sec (with seq num) write speed all = 0.325884041 MB/sec (without seq num) 2024/11/23-17:26:49.887047 139957399803456 [compaction_job.cc:1948] [default] [JOB 31896] Generated table #272223: 928756 keys, 39447460 bytes, temperature: kWarm 2024/11/23-17:26:49.887170 139957399803456 EVENT_LOG_v1 {"time_micros": 1732354009887092, "cf_name": "default", "job": 31896, "event": "table_file_creation", "file_number": 272223, "file_size": 39447460, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 4096159344, "largest_seqno": 4146760909, "table_properties": {"data_size": 33576608, "index_size": 1766528, "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": 26005168, "raw_average_key_size": 28, "raw_value_size": 108212688, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 928756, "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": 1732354006, "oldest_key_time": 0, "file_creation_time": 1732354006, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "U1ECJGOXSO4Y1P7ZZXV1", "orig_file_number": 272223, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-17:26:49.962743 139957399803456 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272224.sst) /dev/shm/ToplingTemp/Topling-132456-PU3HLV 2024/11/23-17:26:51.497403 139957399803456 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272224.sst): first pass time = 1.53's, 87.461'MB/sec 2024/11/23-17:26:53.192306 139957399803456 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272224.sst): old prealloc_size = 147639500, real_size = 34350384 2024/11/23-17:26:53.192881 139957399803456 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272224.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 924426 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.0324 GB avg-val = 117.19 avg-zval = 35.01 2024/11/23-17:26:53.193648 139957399803456 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272224.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/23-17:26:54.273762 139957399803456 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272224.sst): second pass time = 1.69's, 63.943'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.08's, 35.444'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3176.220'MB/sec (index lex order gen) rebuild zvType time = 0.95's, 0.244'MB/sec write SST data time = 0.13's, 290.552'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.082'MB, throughput = 32855.807'MB/sec zip my value time = 1.69's, unzip length = 0.108'GB zip my value throughput = 63.943'MB/sec zip pipeline throughput = 63.943'MB/sec entries = 924426 avg-key = 28.00 avg-zkey = 1.90 avg-val = 117.19 avg-zval = 35.01 usrkeys = 924426 avg-key = 20.00 avg-zkey = 1.90 avg-val = 124.19 avg-zval = 35.01 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 924426 bytes = 3119952 } seq expand size = 6470982 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.0324 GB dict = 1.08 MB all = 0.0383 GB } UnZip/Zip{ index = 10.5121 value = 3.3477 dict = 1.00 all = 3.5016 } Zip/UnZip{ index = 0.0951 value = 0.2987 dict = 1.00 all = 0.2856 } ---------------------------- total value len = 9.078139 GB avg = 0.167 KB (by entry num) total key len = 1.492710 GB avg = 0.028 KB total ukey len = 1.034942 GB avg = 0.015 KB total ukey num = 0.067403617 Billion total entry num = 0.054211346 Billion write speed all = 0.344304231 MB/sec (with seq num) write speed all = 0.330178443 MB/sec (without seq num) 2024/11/23-17:26:54.321460 139957399803456 [compaction_job.cc:1948] [default] [JOB 31896] Generated table #272224: 924426 keys, 38330532 bytes, temperature: kWarm 2024/11/23-17:26:54.321528 139957399803456 EVENT_LOG_v1 {"time_micros": 1732354014321494, "cf_name": "default", "job": 31896, "event": "table_file_creation", "file_number": 272224, "file_size": 38330532, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 4050411210, "largest_seqno": 4146761402, "table_properties": {"data_size": 32360288, "index_size": 1758784, "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": 25883928, "raw_average_key_size": 28, "raw_value_size": 108333928, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 924426, "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": 1732354009, "oldest_key_time": 0, "file_creation_time": 1732354009, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "U1ECJGOXSO4Y1P7ZZXV1", "orig_file_number": 272224, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-17:26:54.363687 139957399803456 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272225.sst) /dev/shm/ToplingTemp/Topling-132456-RJAvbU 2024/11/23-17:26:55.948973 139957399803456 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272225.sst): first pass time = 1.59's, 84.667'MB/sec 2024/11/23-17:26:57.837172 139957399803456 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272225.sst): old prealloc_size = 147639500, real_size = 32668256 2024/11/23-17:26:57.837721 139957399803456 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272225.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 932028 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.0307 GB avg-val = 116.01 avg-zval = 32.90 2024/11/23-17:26:57.838511 139957399803456 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272225.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/23-17:26:58.967882 139957399803456 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272225.sst): second pass time = 1.89's, 57.318'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.13's, 32.427'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3385.985'MB/sec (index lex order gen) rebuild zvType time = 0.95's, 0.246'MB/sec write SST data time = 0.18's, 199.658'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.078'MB, throughput = 31911.831'MB/sec zip my value time = 1.89's, unzip length = 0.108'GB zip my value throughput = 57.318'MB/sec zip pipeline throughput = 59.601'MB/sec entries = 932028 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.01 avg-zval = 32.90 usrkeys = 932028 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.01 avg-zval = 32.90 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 932028 bytes = 3145616 } seq expand size = 6524196 multi value expand size = 0 cnt WriteAppend = 11 UnZipSize{ index = 0.0186 GB value = 0.1081 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0307 GB dict = 1.08 MB all = 0.0367 GB } UnZip/Zip{ index = 10.5148 value = 3.5262 dict = 1.00 all = 3.6607 } Zip/UnZip{ index = 0.0951 value = 0.2836 dict = 1.00 all = 0.2732 } ---------------------------- total value len = 9.192784 GB avg = 0.167 KB (by entry num) total key len = 1.518807 GB avg = 0.028 KB total ukey len = 1.053582 GB avg = 0.015 KB total ukey num = 0.068335645 Billion total entry num = 0.055143374 Billion write speed all = 0.348835018 MB/sec (with seq num) write speed all = 0.334468569 MB/sec (without seq num) 2024/11/23-17:26:59.014189 139957399803456 [compaction_job.cc:1948] [default] [JOB 31896] Generated table #272225: 932028 keys, 36664558 bytes, temperature: kWarm 2024/11/23-17:26:59.014255 139957399803456 EVENT_LOG_v1 {"time_micros": 1732354019014222, "cf_name": "default", "job": 31896, "event": "table_file_creation", "file_number": 272225, "file_size": 36664558, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 4076718630, "largest_seqno": 4146761604, "table_properties": {"data_size": 30662288, "index_size": 1772800, "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": 26096784, "raw_average_key_size": 28, "raw_value_size": 108120968, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 932028, "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": 1732354014, "oldest_key_time": 0, "file_creation_time": 1732354014, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "U1ECJGOXSO4Y1P7ZZXV1", "orig_file_number": 272225, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-17:26:59.059635 139957399803456 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272226.sst) /dev/shm/ToplingTemp/Topling-132456-rtmFdU 2024/11/23-17:27:00.869888 139957399803456 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272226.sst): first pass time = 1.81's, 74.145'MB/sec 2024/11/23-17:27:02.388118 139957399803456 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272226.sst): old prealloc_size = 147639500, real_size = 35593136 2024/11/23-17:27:02.388841 139957399803456 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272226.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 930463 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.25 avg-zval = 36.10 2024/11/23-17:27:02.389651 139957399803456 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272226.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/23-17:27:03.389100 139957399803456 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272226.sst): second pass time = 1.52's, 71.289'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.00's, 39.431'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2527.739'MB/sec (index lex order gen) rebuild zvType time = 0.85's, 0.275'MB/sec write SST data time = 0.15's, 256.872'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.078'MB, throughput = 27681.057'MB/sec zip my value time = 1.52's, unzip length = 0.108'GB zip my value throughput = 71.289'MB/sec zip pipeline throughput = 71.289'MB/sec entries = 930463 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.25 avg-zval = 36.10 usrkeys = 930463 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.25 avg-zval = 36.10 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 930463 bytes = 3024016 } seq expand size = 6513241 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.0336 GB dict = 1.08 MB all = 0.0395 GB } UnZip/Zip{ index = 10.5142 value = 3.2201 dict = 1.00 all = 3.4006 } Zip/UnZip{ index = 0.0951 value = 0.3105 dict = 1.00 all = 0.2941 } ---------------------------- total value len = 9.307462 GB avg = 0.166 KB (by entry num) total key len = 1.544860 GB avg = 0.028 KB total ukey len = 1.072191 GB avg = 0.015 KB total ukey num = 0.069266108 Billion total entry num = 0.056073837 Billion write speed all = 0.353367203 MB/sec (with seq num) write speed all = 0.338760445 MB/sec (without seq num) 2024/11/23-17:27:03.444355 139957399803456 [compaction_job.cc:1948] [default] [JOB 31896] Generated table #272226: 930463 keys, 39468870 bytes, temperature: kWarm 2024/11/23-17:27:03.444429 139957399803456 EVENT_LOG_v1 {"time_micros": 1732354023444388, "cf_name": "default", "job": 31896, "event": "table_file_creation", "file_number": 272226, "file_size": 39468870, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 4083442763, "largest_seqno": 4146761649, "table_properties": {"data_size": 33590432, "index_size": 1769920, "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": 26052964, "raw_average_key_size": 28, "raw_value_size": 108164818, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 930463, "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": 1732354019, "oldest_key_time": 0, "file_creation_time": 1732354019, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "U1ECJGOXSO4Y1P7ZZXV1", "orig_file_number": 272226, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-17:27:03.482026 139957399803456 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272227.sst) /dev/shm/ToplingTemp/Topling-132456-WZl2WT 2024/11/23-17:27:04.636155 139957399803456 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272227.sst): first pass time = 1.15's, 116.297'MB/sec 2024/11/23-17:27:06.310113 139957399803456 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272227.sst): old prealloc_size = 147639500, real_size = 33699664 2024/11/23-17:27:06.310809 139957399803456 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272227.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 927498 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1082 GB zip-val = 0.0317 GB avg-val = 116.71 avg-zval = 34.18 2024/11/23-17:27:06.311633 139957399803456 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272227.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/23-17:27:07.249176 139957399803456 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272227.sst): second pass time = 1.67's, 64.697'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.94's, 40.007'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2615.513'MB/sec (index lex order gen) rebuild zvType time = 0.78's, 0.298'MB/sec write SST data time = 0.16's, 233.025'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.080'MB, throughput = 35443.577'MB/sec zip my value time = 1.67's, unzip length = 0.108'GB zip my value throughput = 64.697'MB/sec zip pipeline throughput = 88.405'MB/sec entries = 927498 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.71 avg-zval = 34.18 usrkeys = 927498 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.71 avg-zval = 34.18 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 927498 bytes = 3014384 } seq expand size = 6492486 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0185 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0317 GB dict = 1.08 MB all = 0.0376 GB } UnZip/Zip{ index = 10.5130 value = 3.4144 dict = 1.00 all = 3.5726 } Zip/UnZip{ index = 0.0951 value = 0.2929 dict = 1.00 all = 0.2799 } ---------------------------- total value len = 9.422202 GB avg = 0.165 KB (by entry num) total key len = 1.570830 GB avg = 0.028 KB total ukey len = 1.090741 GB avg = 0.016 KB total ukey num = 0.070193606 Billion total entry num = 0.057001335 Billion write speed all = 0.357903949 MB/sec (with seq num) write speed all = 0.343057452 MB/sec (without seq num) 2024/11/23-17:27:07.300492 139957399803456 [compaction_job.cc:1948] [default] [JOB 31896] Generated table #272227: 927498 keys, 37568414 bytes, temperature: kWarm 2024/11/23-17:27:07.300549 139957399803456 EVENT_LOG_v1 {"time_micros": 1732354027300518, "cf_name": "default", "job": 31896, "event": "table_file_creation", "file_number": 272227, "file_size": 37568414, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 4098574454, "largest_seqno": 4146761667, "table_properties": {"data_size": 31703104, "index_size": 1764480, "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": 25969944, "raw_average_key_size": 28, "raw_value_size": 108247888, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 927498, "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": 1732354023, "oldest_key_time": 0, "file_creation_time": 1732354023, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "U1ECJGOXSO4Y1P7ZZXV1", "orig_file_number": 272227, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-17:27:07.339996 139957399803456 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272228.sst) /dev/shm/ToplingTemp/Topling-132456-B5Cq0S 2024/11/23-17:27:07.614143 139957399803456 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272228.sst): first pass time = 0.27's, 225.034'MB/sec 2024/11/23-17:27:08.665244 139957399803456 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272228.sst): old prealloc_size = 147639500, real_size = 16593680 2024/11/23-17:27:08.665720 139957399803456 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272228.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 426693 prefix = 4 raw-key = 0.0068 GB zip-key = 0.0008 GB avg-key = 16.00 avg-zkey = 1.93 raw-val = 0.0497 GB zip-val = 0.0157 GB avg-val = 116.56 avg-zval = 36.71 2024/11/23-17:27:08.666216 139957399803456 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272228.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0010 GB, waited 0.000 sec, Key+Value = 0.062 GB 2024/11/23-17:27:09.119379 139957399803456 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00/272228.sst): second pass time = 1.05's, 47.351'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.45's, 40.598'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 1786.362'MB/sec (index lex order gen) rebuild zvType time = 0.34's, 0.309'MB/sec write SST data time = 0.11's, 169.474'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.505'MB, throughput = 16486.239'MB/sec zip my value time = 1.05's, unzip length = 0.050'GB zip my value throughput = 47.351'MB/sec zip pipeline throughput = 136.832'MB/sec entries = 426693 avg-key = 28.00 avg-zkey = 1.93 avg-val = 116.56 avg-zval = 36.71 usrkeys = 426693 avg-key = 20.00 avg-zkey = 1.93 avg-val = 123.56 avg-zval = 36.71 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 426693 bytes = 1440096 } seq expand size = 2986851 multi value expand size = 0 cnt WriteAppend = 19 UnZipSize{ index = 0.0085 GB value = 0.0497 GB dict = 0.50 MB all = 0.0617 GB } __ZipSize{ index = 0.0008 GB value = 0.0157 GB dict = 0.50 MB all = 0.0184 GB } UnZip/Zip{ index = 10.3623 value = 3.1753 dict = 1.00 all = 3.3459 } Zip/UnZip{ index = 0.0965 value = 0.3149 dict = 1.00 all = 0.2989 } ---------------------------- total value len = 9.474924 GB avg = 0.165 KB (by entry num) total key len = 1.582777 GB avg = 0.028 KB total ukey len = 1.099275 GB avg = 0.016 KB total ukey num = 0.070620299 Billion total entry num = 0.057428028 Billion write speed all = 0.359987498 MB/sec (with seq num) write speed all = 0.345030775 MB/sec (without seq num) 2024/11/23-17:27:09.150413 139957399803456 [compaction_job.cc:1948] [default] [JOB 31896] Generated table #272228: 426693 keys, 18435437 bytes, temperature: kWarm 2024/11/23-17:27:09.150514 139957399803456 EVENT_LOG_v1 {"time_micros": 1732354029150465, "cf_name": "default", "job": 31896, "event": "table_file_creation", "file_number": 272228, "file_size": 18435437, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 4042106349, "largest_seqno": 4145240590, "table_properties": {"data_size": 15663296, "index_size": 823552, "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": 11947404, "raw_average_key_size": 28, "raw_value_size": 49735258, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 426693, "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": 1732354027, "oldest_key_time": 0, "file_creation_time": 1732354027, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "d89b4006-2803-486e-b7a2-759bcf348921", "db_session_id": "U1ECJGOXSO4Y1P7ZZXV1", "orig_file_number": 272228, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-17:27:09.174245 139957399803456 [compaction_job.cc:703] job-31896: subcompact[0], size: 0.209915 G, files: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-31896/att-00 [272223,272224,272225,272226,272227,272228] 2024/11/23-17:27:09.316877 139957399803456 (Original Log Time 2024/11/23-17:26:45.960506) EVENT_LOG_v1 {"time_micros": 1732354005960464, "job": 31896, "event": "compaction_started", "compaction_reason": "FilesMarkedForCompaction", "files_L2": [272220], "files_L3": [272189, 272190, 272191, 272192, 272138, 272139], "score": 0.994032, "input_data_size": 230049613, "oldest_snapshot_seqno": 4146783281} 2024/11/23-17:27:09.316881 139957399803456 (Original Log Time 2024/11/23-17:27:09.305435) [compaction_job.cc:2022] [default] [JOB 31896] Compacted 1@2 + 6@3 files to L3 => 209915271 bytes 2024/11/23-17:27:09.316882 139957399803456 (Original Log Time 2024/11/23-17:27:09.316804) [compaction_job.cc:1224] [default] compacted to: files[0 0 0 6 0 0 0] max score 0.01, MB/sec: 9.9 rd, 9.0 wr, level 3, files in(1, 6) out(6 +0 blob) MB in(27.1, 192.3 +0.0 blob) out(200.2 +0.0 blob), read-write-amplify(15.5) write-amplify(7.4) OK, records in: 5129899, records dropped: 60035 output_compression: Snappy 2024/11/23-17:27:09.316890 139957399803456 (Original Log Time 2024/11/23-17:27:09.316853) EVENT_LOG_v1 {"time_micros": 1732354029316832, "cf": "default", "job": 31896, "event": "compaction_finished", "compaction_time_micros": 23213756, "compaction_time_cpu_micros": 10081579, "output_level": 3, "num_output_files": 6, "total_output_size": 209915271, "num_input_records": 5129899, "num_output_records": 5069864, "num_subcompactions": 1, "output_compression": "Snappy", "num_single_delete_mismatches": 0, "num_single_delete_fallthrough": 0, "file_write_nanos": 192532287, "file_range_sync_nanos": 0, "file_fsync_nanos": 4926, "file_prepare_write_nanos": 17830, "lsm_state": [0, 0, 0, 6, 0, 0, 0]} 2024/11/23-17:27:09.434637 139957399803456 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":1732256054,"starts":1732354005,"executesMs":23478,"compactionJobId":31896,"attempt":0,"compactionInputRawBytes":741296710,"compactionInputZipBytes":230049613,"compactionOutputRawBytes":0,"compactionOutputZipBytes":209915271,"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-61dea9aa60dcc4d6a385bc43f28cc6f2-0b25c7732bdc6ed2-00"}}, response = 2024/11/23-17:27:09.434725 139957399803456 INFO dcompact_worker.cpp:1459: finish /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-22T14.14.14/.rocksdb/job-31896/att-00: olev 3, work 23.478 s, result 7.907 ms, install 11.494 ms, input{raw 706.956 MiB zip 219.392 MiB}