2024/11/22-15:52:26.515946 140024760219200 DEBG dcompact_worker.cpp:2214: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00: fork to child time = 0.009781 sec 2024/11/22-15:52:26.516774 140024760219200 DEBG dcompact_worker.cpp:1013: Beg SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00 2024/11/22-15:52:26.522904 140024760219200 DEBG dcompact_worker.cpp:1033: End SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00 2024/11/22-15:52:26.524048 140024760219200 TRAC dcompact_worker.cpp:1083: INFO_LOG_LEVEL: rpc = INFO_LEVEL, env_var = undefined 2024/11/22-15:52:26.524486 140024760219200 [WARN] [column_family.cc:386] multiple cf_paths/db_paths and level_compaction_dynamic_level_bytes can't be used together 2024/11/22-15:52:26.577265 140024760219200 [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-03568/att-00/MANIFEST-206347 2024/11/22-15:52:26.591123 140024760219200 [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-03568/att-00/MANIFEST-206347 succeeded,manifest_file_number is 206347, next_file_number is 212646, last_sequence is 3352514241, log_number is 0,prev_log_number is 0,max_column_family is 0,min_log_number_to_keep is 212515 2024/11/22-15:52:26.591130 140024760219200 [version_set.cc:6266] Column family [default] (ID 0), log number is 0 2024/11/22-15:52:26.591388 140024760219200 [version_set.cc:5721] Creating manifest 212646 2024/11/22-15:52:26.636574 140024760219200 DEBG dcompact_worker.cpp:1218: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00: bottommost_level: fake = 1, rpc = 0 2024/11/22-15:52:26.656746 140024760219200 [compaction_job.cc:2437] [default] [JOB 3568] Compacting 1@2 + 5@3 files to L3, score 0.99, subcompactions 1 : 1 2024/11/22-15:52:26.656762 140024760219200 [compaction_job.cc:2445] [default]: Compaction start summary: Base version 2834 Base level 2, inputs: [212644(19MB)], [212603(36MB) 212604(36MB) 212605(36MB) 212606(36MB) 212607(34MB)] 2024/11/22-15:52:26.666606 140024760219200 [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/22-15:52:26.666645 140024760219200 [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/22-15:52:26.666675 140024760219200 [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/22-15:52:26.666681 140024760219200 [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/22-15:52:26.666692 140024760219200 [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/22-15:52:27.100139 140024760219200 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212647.sst) /dev/shm/ToplingTemp/Topling-185096-vqboGi 2024/11/22-15:52:27.656590 140024760219200 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212647.sst): first pass time = 0.56's, 241.219'MB/sec 2024/11/22-15:52:29.407158 140024760219200 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212647.sst): old prealloc_size = 147639500, real_size = 34154272 2024/11/22-15:52:29.407736 140024760219200 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212647.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 922390 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.91 raw-val = 0.1084 GB zip-val = 0.0322 GB avg-val = 117.51 avg-zval = 34.86 2024/11/22-15:52:29.408538 140024760219200 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212647.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/22-15:52:30.367066 140024760219200 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212647.sst): second pass time = 1.75's, 61.958'MB/sec, value only(80.8% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.96's, 39.719'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3162.006'MB/sec (index lex order gen) rebuild zvType time = 0.80's, 0.287'MB/sec write SST data time = 0.15's, 246.717'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.083'MB, throughput = 34889.784'MB/sec zip my value time = 1.75's, unzip length = 0.108'GB zip my value throughput = 61.958'MB/sec zip pipeline throughput = 75.259'MB/sec entries = 922390 avg-key = 28.00 avg-zkey = 1.91 avg-val = 117.51 avg-zval = 34.86 usrkeys = 922390 avg-key = 20.00 avg-zkey = 1.91 avg-val = 124.51 avg-zval = 34.86 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 922390 bytes = 3113088 } seq expand size = 6456730 multi value expand size = 0 cnt WriteAppend = 14 UnZipSize{ index = 0.0184 GB value = 0.1084 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0322 GB dict = 1.08 MB all = 0.0381 GB } UnZip/Zip{ index = 10.4449 value = 3.3707 dict = 1.00 all = 3.5204 } Zip/UnZip{ index = 0.0957 value = 0.2967 dict = 1.00 all = 0.2841 } ---------------------------- total value len = 0.114848 GB avg = 0.125 KB (by entry num) total key len = 0.025827 GB avg = 0.028 KB total ukey len = 0.018448 GB avg = 0.020 KB total ukey num = 0.000922390 Billion total entry num = 0.000922390 Billion write speed all = 0.005580713 MB/sec (with seq num) write speed all = 0.005287975 MB/sec (without seq num) 2024/11/22-15:52:30.403175 140024760219200 [compaction_job.cc:1948] [default] [JOB 3568] Generated table #212647: 922390 keys, 38125770 bytes, temperature: kWarm 2024/11/22-15:52:30.403279 140024760219200 EVENT_LOG_v1 {"time_micros": 1732261950403213, "cf_name": "default", "job": 3568, "event": "table_file_creation", "file_number": 212647, "file_size": 38125770, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3273701510, "largest_seqno": 3352489779, "table_properties": {"data_size": 32157264, "index_size": 1766208, "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": 25826920, "raw_average_key_size": 28, "raw_value_size": 108390896, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 922390, "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": 1732261947, "oldest_key_time": 0, "file_creation_time": 1732261947, "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": 212647, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/22-15:52:30.476023 140024760219200 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212648.sst) /dev/shm/ToplingTemp/Topling-185096-yzqqdh 2024/11/22-15:52:31.352014 140024760219200 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212648.sst): first pass time = 0.88's, 153.224'MB/sec 2024/11/22-15:52:34.457472 140024760219200 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212648.sst): old prealloc_size = 147639500, real_size = 33960832 2024/11/22-15:52:34.458026 140024760219200 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212648.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 922416 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1084 GB zip-val = 0.0320 GB avg-val = 117.51 avg-zval = 34.66 2024/11/22-15:52:34.458770 140024760219200 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212648.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/22-15:52:35.383831 140024760219200 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212648.sst): second pass time = 3.10's, 34.960'MB/sec, value only(80.8% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.93's, 40.949'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3292.312'MB/sec (index lex order gen) rebuild zvType time = 0.80's, 0.289'MB/sec write SST data time = 0.13's, 297.325'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.083'MB, throughput = 33055.076'MB/sec zip my value time = 3.10's, unzip length = 0.108'GB zip my value throughput = 34.960'MB/sec zip pipeline throughput = 111.509'MB/sec entries = 922416 avg-key = 28.00 avg-zkey = 1.90 avg-val = 117.51 avg-zval = 34.66 usrkeys = 922416 avg-key = 20.00 avg-zkey = 1.90 avg-val = 124.51 avg-zval = 34.66 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 922416 bytes = 3113168 } seq expand size = 6456912 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0184 GB value = 0.1084 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0320 GB dict = 1.08 MB all = 0.0379 GB } UnZip/Zip{ index = 10.5149 value = 3.3898 dict = 1.00 all = 3.5383 } Zip/UnZip{ index = 0.0951 value = 0.2950 dict = 1.00 all = 0.2826 } ---------------------------- total value len = 0.229695 GB avg = 0.125 KB (by entry num) total key len = 0.051655 GB avg = 0.028 KB total ukey len = 0.036896 GB avg = 0.020 KB total ukey num = 0.001844806 Billion total entry num = 0.001844806 Billion write speed all = 0.011159214 MB/sec (with seq num) write speed all = 0.010573847 MB/sec (without seq num) 2024/11/22-15:52:35.419708 140024760219200 [compaction_job.cc:1948] [default] [JOB 3568] Generated table #212648: 922416 keys, 37932546 bytes, temperature: kWarm 2024/11/22-15:52:35.419769 140024760219200 EVENT_LOG_v1 {"time_micros": 1732261955419738, "cf_name": "default", "job": 3568, "event": "table_file_creation", "file_number": 212648, "file_size": 37932546, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3273701550, "largest_seqno": 3352490356, "table_properties": {"data_size": 31975536, "index_size": 1754496, "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": 25827648, "raw_average_key_size": 28, "raw_value_size": 108390220, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 922416, "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": 1732261950, "oldest_key_time": 0, "file_creation_time": 1732261950, "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": 212648, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/22-15:52:35.458036 140024760219200 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212649.sst) /dev/shm/ToplingTemp/Topling-185096-Zr2Szj 2024/11/22-15:52:36.282967 140024760219200 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212649.sst): first pass time = 0.82's, 162.709'MB/sec 2024/11/22-15:52:38.445425 140024760219200 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212649.sst): old prealloc_size = 147639500, real_size = 33820544 2024/11/22-15:52:38.446001 140024760219200 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212649.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 922355 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1084 GB zip-val = 0.0318 GB avg-val = 117.52 avg-zval = 34.51 2024/11/22-15:52:38.446755 140024760219200 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212649.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/22-15:52:39.383579 140024760219200 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212649.sst): second pass time = 2.16's, 50.140'MB/sec, value only(80.8% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.94's, 40.284'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3153.528'MB/sec (index lex order gen) rebuild zvType time = 0.81's, 0.285'MB/sec write SST data time = 0.13's, 295.982'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.084'MB, throughput = 32106.729'MB/sec zip my value time = 2.16's, unzip length = 0.108'GB zip my value throughput = 50.140'MB/sec zip pipeline throughput = 80.947'MB/sec entries = 922355 avg-key = 28.00 avg-zkey = 1.90 avg-val = 117.52 avg-zval = 34.51 usrkeys = 922355 avg-key = 20.00 avg-zkey = 1.90 avg-val = 124.52 avg-zval = 34.51 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 922355 bytes = 3112960 } seq expand size = 6456485 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0184 GB value = 0.1084 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0318 GB dict = 1.08 MB all = 0.0378 GB } UnZip/Zip{ index = 10.5127 value = 3.4048 dict = 1.00 all = 3.5515 } Zip/UnZip{ index = 0.0951 value = 0.2937 dict = 1.00 all = 0.2816 } ---------------------------- total value len = 0.344543 GB avg = 0.125 KB (by entry num) total key len = 0.077481 GB avg = 0.028 KB total ukey len = 0.055343 GB avg = 0.020 KB total ukey num = 0.002767161 Billion total entry num = 0.002767161 Billion write speed all = 0.016736149 MB/sec (with seq num) write speed all = 0.015858253 MB/sec (without seq num) 2024/11/22-15:52:39.421851 140024760219200 [compaction_job.cc:1948] [default] [JOB 3568] Generated table #212649: 922355 keys, 37792322 bytes, temperature: kWarm 2024/11/22-15:52:39.421912 140024760219200 EVENT_LOG_v1 {"time_micros": 1732261959421881, "cf_name": "default", "job": 3568, "event": "table_file_creation", "file_number": 212649, "file_size": 37792322, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3273701573, "largest_seqno": 3352489120, "table_properties": {"data_size": 31834992, "index_size": 1754752, "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": 25825940, "raw_average_key_size": 28, "raw_value_size": 108391794, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 922355, "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": 1732261955, "oldest_key_time": 0, "file_creation_time": 1732261955, "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": 212649, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/22-15:52:39.455935 140024760219200 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212650.sst) /dev/shm/ToplingTemp/Topling-185096-nFGFui 2024/11/22-15:52:40.387431 140024760219200 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212650.sst): first pass time = 0.93's, 144.094'MB/sec 2024/11/22-15:52:42.152391 140024760219200 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212650.sst): old prealloc_size = 147639500, real_size = 34016768 2024/11/22-15:52:42.152932 140024760219200 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212650.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 921947 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.1084 GB zip-val = 0.0320 GB avg-val = 117.58 avg-zval = 34.73 2024/11/22-15:52:42.153691 140024760219200 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212650.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/22-15:52:43.078527 140024760219200 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212650.sst): second pass time = 1.76's, 61.444'MB/sec, value only(80.8% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.93's, 41.018'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3375.653'MB/sec (index lex order gen) rebuild zvType time = 0.80's, 0.288'MB/sec write SST data time = 0.13's, 302.562'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.084'MB, throughput = 37352.682'MB/sec zip my value time = 1.76's, unzip length = 0.108'GB zip my value throughput = 61.444'MB/sec zip pipeline throughput = 61.444'MB/sec entries = 921947 avg-key = 28.00 avg-zkey = 1.92 avg-val = 117.58 avg-zval = 34.73 usrkeys = 921947 avg-key = 20.00 avg-zkey = 1.92 avg-val = 124.58 avg-zval = 34.73 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 921947 bytes = 3111584 } seq expand size = 6453629 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0184 GB value = 0.1084 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0320 GB dict = 1.08 MB all = 0.0380 GB } UnZip/Zip{ index = 10.4433 value = 3.3854 dict = 1.00 all = 3.5332 } Zip/UnZip{ index = 0.0958 value = 0.2954 dict = 1.00 all = 0.2830 } ---------------------------- total value len = 0.459400 GB avg = 0.125 KB (by entry num) total key len = 0.103295 GB avg = 0.028 KB total ukey len = 0.073782 GB avg = 0.020 KB total ukey num = 0.003689108 Billion total entry num = 0.003689108 Billion write speed all = 0.022311474 MB/sec (with seq num) write speed all = 0.021141256 MB/sec (without seq num) 2024/11/22-15:52:43.109699 140024760219200 [compaction_job.cc:1948] [default] [JOB 3568] Generated table #212650: 921947 keys, 37987372 bytes, temperature: kWarm 2024/11/22-15:52:43.109761 140024760219200 EVENT_LOG_v1 {"time_micros": 1732261963109729, "cf_name": "default", "job": 3568, "event": "table_file_creation", "file_number": 212650, "file_size": 37987372, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3273701589, "largest_seqno": 3352489717, "table_properties": {"data_size": 32020464, "index_size": 1765632, "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": 25814516, "raw_average_key_size": 28, "raw_value_size": 108403286, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 921947, "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": 1732261959, "oldest_key_time": 0, "file_creation_time": 1732261959, "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": 212650, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/22-15:52:43.150058 140024760219200 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212651.sst) /dev/shm/ToplingTemp/Topling-185096-xII3nh 2024/11/22-15:52:44.416116 140024760219200 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212651.sst): first pass time = 1.27's, 106.016'MB/sec 2024/11/22-15:52:45.736432 140024760219200 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212651.sst): old prealloc_size = 147639500, real_size = 34080320 2024/11/22-15:52:45.736958 140024760219200 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212651.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 921930 prefix = 4 raw-key = 0.0148 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.1084 GB zip-val = 0.0321 GB avg-val = 117.58 avg-zval = 34.81 2024/11/22-15:52:45.737701 140024760219200 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212651.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/22-15:52:46.652466 140024760219200 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212651.sst): second pass time = 1.32's, 82.146'MB/sec, value only(80.8% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.92's, 41.539'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3472.953'MB/sec (index lex order gen) rebuild zvType time = 0.79's, 0.292'MB/sec write SST data time = 0.13's, 304.030'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.084'MB, throughput = 35148.677'MB/sec zip my value time = 1.32's, unzip length = 0.108'GB zip my value throughput = 82.146'MB/sec zip pipeline throughput = 82.146'MB/sec entries = 921930 avg-key = 28.00 avg-zkey = 1.90 avg-val = 117.58 avg-zval = 34.81 usrkeys = 921930 avg-key = 20.00 avg-zkey = 1.90 avg-val = 124.58 avg-zval = 34.81 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 921930 bytes = 3111536 } seq expand size = 6453510 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0184 GB value = 0.1084 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0321 GB dict = 1.08 MB all = 0.0381 GB } UnZip/Zip{ index = 10.5143 value = 3.3775 dict = 1.00 all = 3.5273 } Zip/UnZip{ index = 0.0951 value = 0.2961 dict = 1.00 all = 0.2835 } ---------------------------- total value len = 0.574257 GB avg = 0.125 KB (by entry num) total key len = 0.129109 GB avg = 0.028 KB total ukey len = 0.092221 GB avg = 0.020 KB total ukey num = 0.004611038 Billion total entry num = 0.004611038 Billion write speed all = 0.027885297 MB/sec (with seq num) write speed all = 0.026422842 MB/sec (without seq num) 2024/11/22-15:52:46.689463 140024760219200 [compaction_job.cc:1948] [default] [JOB 3568] Generated table #212651: 921930 keys, 38050888 bytes, temperature: kWarm 2024/11/22-15:52:46.689523 140024760219200 EVENT_LOG_v1 {"time_micros": 1732261966689492, "cf_name": "default", "job": 3568, "event": "table_file_creation", "file_number": 212651, "file_size": 38050888, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3273701615, "largest_seqno": 3352490518, "table_properties": {"data_size": 32095984, "index_size": 1753664, "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": 25814040, "raw_average_key_size": 28, "raw_value_size": 108403824, "raw_average_value_size": 117, "num_data_blocks": 1, "num_entries": 921930, "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": 1732261963, "oldest_key_time": 0, "file_creation_time": 1732261963, "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": 212651, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/22-15:52:46.730463 140024760219200 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212652.sst) /dev/shm/ToplingTemp/Topling-185096-Y43nxg 2024/11/22-15:52:46.759108 140024760219200 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212652.sst): first pass time = 0.03's, 211.247'MB/sec 2024/11/22-15:52:46.823190 140024760219200 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212652.sst): old prealloc_size = 147639500, real_size = 1791440 2024/11/22-15:52:46.823264 140024760219200 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212652.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 42343 prefix = 4 raw-key = 0.0007 GB zip-key = 0.0001 GB avg-key = 16.00 avg-zkey = 1.95 raw-val = 0.0049 GB zip-val = 0.0017 GB avg-val = 114.74 avg-zval = 40.10 2024/11/22-15:52:46.823330 140024760219200 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212652.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0001 GB, waited 0.000 sec, Key+Value = 0.006 GB 2024/11/22-15:52:46.855424 140024760219200 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00/212652.sst): second pass time = 0.06's, 76.373'MB/sec, value only(80.4% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.03's, 60.126'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 1498.332'MB/sec (index lex order gen) rebuild zvType time = 0.03's, 0.406'MB/sec write SST data time = 0.01's, 317.064'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.048'MB, throughput = 1952.235'MB/sec zip my value time = 0.06's, unzip length = 0.005'GB zip my value throughput = 76.373'MB/sec zip pipeline throughput = 76.373'MB/sec entries = 42343 avg-key = 28.00 avg-zkey = 1.95 avg-val = 114.74 avg-zval = 40.10 usrkeys = 42343 avg-key = 20.00 avg-zkey = 1.95 avg-val = 120.45 avg-zval = 40.10 TagRS{ kinds = RS_Key0_TagN bytes = 6720 } TagArray{ size = 34534 bytes = 99296 } seq expand size = 241738 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0008 GB value = 0.0049 GB dict = 0.05 MB all = 0.0060 GB } __ZipSize{ index = 0.0001 GB value = 0.0017 GB dict = 0.05 MB all = 0.0019 GB } UnZip/Zip{ index = 10.2496 value = 2.8611 dict = 1.00 all = 3.1206 } Zip/UnZip{ index = 0.0976 value = 0.3495 dict = 1.00 all = 0.3204 } ---------------------------- total value len = 0.579357 GB avg = 0.125 KB (by entry num) total key len = 0.130295 GB avg = 0.028 KB total ukey len = 0.093068 GB avg = 0.020 KB total ukey num = 0.004653381 Billion total entry num = 0.004653381 Billion write speed all = 0.028134269 MB/sec (with seq num) write speed all = 0.026658397 MB/sec (without seq num) 2024/11/22-15:52:46.861981 140024760219200 [compaction_job.cc:1948] [default] [JOB 3568] Generated table #212652: 42343 keys, 1936767 bytes, temperature: kWarm 2024/11/22-15:52:46.862030 140024760219200 EVENT_LOG_v1 {"time_micros": 1732261966862003, "cf_name": "default", "job": 3568, "event": "table_file_creation", "file_number": 212652, "file_size": 1936767, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 3352490244, "table_properties": {"data_size": 1698048, "index_size": 82624, "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": 1185604, "raw_average_key_size": 28, "raw_value_size": 4858338, "raw_average_value_size": 114, "num_data_blocks": 1, "num_entries": 42343, "num_filter_entries": 0, "num_deletions": 0, "num_merge_operands": 0, "num_range_deletions": 0, "format_version": 0, "fixed_key_len": 28, "fixed_value_len": 18446744073709551615, "filter_policy": "", "column_family_name": "default", "column_family_id": 0, "comparator": "leveldb.BytewiseComparator", "merge_operator": "nullptr", "prefix_extractor_name": "nullptr", "property_collectors": "[Rdb_tbl_prop_coll_factory]", "compression": "FlatZip", "compression_options": "RS_Key0_TagN-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1732261966, "oldest_key_time": 0, "file_creation_time": 1732261966, "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": 212652, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/22-15:52:46.872392 140024760219200 [compaction_job.cc:703] job-03568: subcompact[0], size: 0.191826 G, files: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-03568/att-00 [212647,212648,212649,212650,212651,212652] 2024/11/22-15:52:46.911672 140024760219200 (Original Log Time 2024/11/22-15:52:26.656833) EVENT_LOG_v1 {"time_micros": 1732261946656786, "job": 3568, "event": "compaction_started", "compaction_reason": "FilesMarkedForCompaction", "files_L2": [212644], "files_L3": [212603, 212604, 212605, 212606, 212607], "score": 0.990933, "input_data_size": 209556684, "oldest_snapshot_seqno": 3352514169} 2024/11/22-15:52:46.911676 140024760219200 (Original Log Time 2024/11/22-15:52:46.911170) [compaction_job.cc:2022] [default] [JOB 3568] Compacted 1@2 + 5@3 files to L3 => 191825665 bytes 2024/11/22-15:52:46.911677 140024760219200 (Original Log Time 2024/11/22-15:52:46.911611) [compaction_job.cc:1224] [default] compacted to: files[0 0 0 6 0 0 0] max score 0.01, MB/sec: 10.4 rd, 9.5 wr, level 3, files in(1, 5) out(6 +0 blob) MB in(19.1, 180.8 +0.0 blob) out(182.9 +0.0 blob), read-write-amplify(20.1) write-amplify(9.6) OK, records in: 4728478, records dropped: 75097 output_compression: Snappy 2024/11/22-15:52:46.911683 140024760219200 (Original Log Time 2024/11/22-15:52:46.911652) EVENT_LOG_v1 {"time_micros": 1732261966911633, "cf": "default", "job": 3568, "event": "compaction_finished", "compaction_time_micros": 20215563, "compaction_time_cpu_micros": 7956861, "output_level": 3, "num_output_files": 6, "total_output_size": 191825665, "num_input_records": 4728478, "num_output_records": 4653381, "num_subcompactions": 1, "output_compression": "Snappy", "num_single_delete_mismatches": 0, "num_single_delete_fallthrough": 0, "file_write_nanos": 120126539, "file_range_sync_nanos": 0, "file_fsync_nanos": 5733, "file_prepare_write_nanos": 13451, "lsm_state": [0, 0, 0, 6, 0, 0, 0]} 2024/11/22-15:52:47.040836 140024760219200 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":1732261946,"executesMs":20390,"compactionJobId":3568,"attempt":0,"compactionInputRawBytes":687796800,"compactionInputZipBytes":209556684,"compactionOutputRawBytes":0,"compactionOutputZipBytes":191825665,"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-3e2070a2fff4689248cce4d16c83bfcd-cb50adf561a86637-00"}}, response = 2024/11/22-15:52:47.040914 140024760219200 INFO dcompact_worker.cpp:1459: finish /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-22T14.14.14/.rocksdb/job-03568/att-00: olev 3, work 20.390 s, result 4.825 ms, install 0.531 ms, input{raw 655.934 MiB zip 199.849 MiB}