2024/11/23-10:33:28.769650 139957659977280 DEBG dcompact_worker.cpp:2214: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00: fork to child time = 0.006742 sec 2024/11/23-10:33:28.770176 139957659977280 DEBG dcompact_worker.cpp:1013: Beg SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00 2024/11/23-10:33:28.776696 139957659977280 DEBG dcompact_worker.cpp:1033: End SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00 2024/11/23-10:33:28.777574 139957659977280 TRAC dcompact_worker.cpp:1083: INFO_LOG_LEVEL: rpc = INFO_LEVEL, env_var = undefined 2024/11/23-10:33:28.777777 139957659977280 [WARN] [column_family.cc:386] multiple cf_paths/db_paths and level_compaction_dynamic_level_bytes can't be used together 2024/11/23-10:33:28.831991 139957659977280 [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-24446/att-00/MANIFEST-206347 2024/11/23-10:33:28.847164 139957659977280 [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-24446/att-00/MANIFEST-206347 succeeded,manifest_file_number is 206347, next_file_number is 256177, last_sequence is 3931809154, log_number is 0,prev_log_number is 0,max_column_family is 0,min_log_number_to_keep is 255973 2024/11/23-10:33:28.847170 139957659977280 [version_set.cc:6266] Column family [default] (ID 0), log number is 0 2024/11/23-10:33:28.847248 139957659977280 [version_set.cc:5721] Creating manifest 256177 2024/11/23-10:33:28.881050 139957659977280 DEBG dcompact_worker.cpp:1218: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00: bottommost_level: fake = 1, rpc = 0 2024/11/23-10:33:28.908832 139957659977280 [compaction_job.cc:2437] [default] [JOB 24446] Compacting 1@2 + 9@3 files to L3, score 1.00, subcompactions 1 : 1 2024/11/23-10:33:28.908848 139957659977280 [compaction_job.cc:2445] [default]: Compaction start summary: Base version 18339 Base level 2, inputs: [256124(27MB)], [256036(36MB) 256037(35MB) 256038(35MB) 256070(36MB) 256071(36MB) 256072(36MB) 256073(35MB) 256074(34MB) 256156(36MB)] 2024/11/23-10:33:28.915115 139957659977280 [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-10:33:28.915140 139957659977280 [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-10:33:28.915157 139957659977280 [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-10:33:28.915163 139957659977280 [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-10:33:28.915174 139957659977280 [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-10:33:29.454989 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256178.sst) /dev/shm/ToplingTemp/Topling-26608-PwIILa 2024/11/23-10:33:30.074715 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256178.sst): first pass time = 0.62's, 216.593'MB/sec 2024/11/23-10:33:31.915070 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256178.sst): old prealloc_size = 147639500, real_size = 34639328 2024/11/23-10:33:31.915735 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256178.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 931210 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.0326 GB avg-val = 116.13 avg-zval = 35.05 2024/11/23-10:33:31.916617 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256178.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-10:33:32.978364 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256178.sst): second pass time = 1.84's, 58.796'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 1.06's, 36.443'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2746.316'MB/sec (index lex order gen) rebuild zvType time = 0.92's, 0.254'MB/sec write SST data time = 0.15's, 263.509'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 = 33671.466'MB/sec zip my value time = 1.84's, unzip length = 0.108'GB zip my value throughput = 58.796'MB/sec zip pipeline throughput = 91.562'MB/sec entries = 931210 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.13 avg-zval = 35.05 usrkeys = 931210 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.13 avg-zval = 35.05 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 931210 bytes = 3259248 } seq expand size = 6518470 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0186 GB value = 0.1081 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0326 GB dict = 1.08 MB all = 0.0387 GB } UnZip/Zip{ index = 10.5108 value = 3.3138 dict = 1.00 all = 3.4637 } Zip/UnZip{ index = 0.0951 value = 0.3018 dict = 1.00 all = 0.2887 } ---------------------------- total value len = 8.963282 GB avg = 0.168 KB (by entry num) total key len = 1.466895 GB avg = 0.028 KB total ukey len = 1.016502 GB avg = 0.015 KB total ukey num = 0.066481645 Billion total entry num = 0.053289374 Billion write speed all = 1.767597834 MB/sec (with seq num) write speed all = 1.695350408 MB/sec (without seq num) 2024/11/23-10:33:33.025917 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256178: 931210 keys, 38749762 bytes, temperature: kWarm 2024/11/23-10:33:33.026017 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329213025947, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256178, "file_size": 38749762, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3711387651, "largest_seqno": 3931583807, "table_properties": {"data_size": 32634448, "index_size": 1771904, "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": 26073880, "raw_average_key_size": 28, "raw_value_size": 108143948, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 931210, "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": 1732329209, "oldest_key_time": 0, "file_creation_time": 1732329209, "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": 256178, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:33.064210 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256179.sst) /dev/shm/ToplingTemp/Topling-26608-LBVdHc 2024/11/23-10:33:34.196753 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256179.sst): first pass time = 1.13's, 118.514'MB/sec 2024/11/23-10:33:35.725511 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256179.sst): old prealloc_size = 147639500, real_size = 33608096 2024/11/23-10:33:35.726069 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256179.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 932935 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.0316 GB avg-val = 115.87 avg-zval = 33.87 2024/11/23-10:33:35.726830 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256179.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-10:33:36.575114 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256179.sst): second pass time = 1.53's, 70.743'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.85's, 44.265'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3312.311'MB/sec (index lex order gen) rebuild zvType time = 0.72's, 0.322'MB/sec write SST data time = 0.13's, 300.707'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 = 29402.013'MB/sec zip my value time = 1.53's, unzip length = 0.108'GB zip my value throughput = 70.743'MB/sec zip pipeline throughput = 116.423'MB/sec entries = 932935 avg-key = 28.00 avg-zkey = 1.90 avg-val = 115.87 avg-zval = 33.87 usrkeys = 932935 avg-key = 20.00 avg-zkey = 1.90 avg-val = 122.87 avg-zval = 33.87 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 932935 bytes = 3148672 } seq expand size = 6530545 multi value expand size = 0 cnt WriteAppend = 12 UnZipSize{ index = 0.0187 GB value = 0.1081 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0316 GB dict = 1.08 MB all = 0.0376 GB } UnZip/Zip{ index = 10.5113 value = 3.4208 dict = 1.00 all = 3.5690 } Zip/UnZip{ index = 0.0951 value = 0.2923 dict = 1.00 all = 0.2802 } ---------------------------- total value len = 9.077908 GB avg = 0.167 KB (by entry num) total key len = 1.493017 GB avg = 0.028 KB total ukey len = 1.035161 GB avg = 0.015 KB total ukey num = 0.067414580 Billion total entry num = 0.054222309 Billion write speed all = 1.790359105 MB/sec (with seq num) write speed all = 1.716891627 MB/sec (without seq num) 2024/11/23-10:33:36.627911 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256179: 932935 keys, 37607032 bytes, temperature: kWarm 2024/11/23-10:33:36.627988 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329216627943, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256179, "file_size": 37607032, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3845180379, "largest_seqno": 3931584435, "table_properties": {"data_size": 31599568, "index_size": 1775104, "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": 26122180, "raw_average_key_size": 28, "raw_value_size": 108095638, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 932935, "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": 1732329213, "oldest_key_time": 0, "file_creation_time": 1732329213, "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": 256179, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:36.662765 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256180.sst) /dev/shm/ToplingTemp/Topling-26608-Yjier8 2024/11/23-10:33:37.585666 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256180.sst): first pass time = 0.92's, 145.436'MB/sec 2024/11/23-10:33:39.110236 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256180.sst): old prealloc_size = 147639500, real_size = 33959936 2024/11/23-10:33:39.110777 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256180.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 932626 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.1081 GB zip-val = 0.0319 GB avg-val = 115.91 avg-zval = 34.25 2024/11/23-10:33:39.111541 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256180.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-10:33:39.958165 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256180.sst): second pass time = 1.52's, 70.947'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.85's, 44.766'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3436.595'MB/sec (index lex order gen) rebuild zvType time = 0.72's, 0.322'MB/sec write SST data time = 0.12's, 305.075'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 = 35975.029'MB/sec zip my value time = 1.52's, unzip length = 0.108'GB zip my value throughput = 70.947'MB/sec zip pipeline throughput = 112.015'MB/sec entries = 932626 avg-key = 28.00 avg-zkey = 1.92 avg-val = 115.91 avg-zval = 34.25 usrkeys = 932626 avg-key = 20.00 avg-zkey = 1.92 avg-val = 122.91 avg-zval = 34.25 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 932626 bytes = 3147632 } seq expand size = 6528382 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0187 GB value = 0.1081 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0319 GB dict = 1.08 MB all = 0.0380 GB } UnZip/Zip{ index = 10.4431 value = 3.3846 dict = 1.00 all = 3.5360 } Zip/UnZip{ index = 0.0958 value = 0.2955 dict = 1.00 all = 0.2828 } ---------------------------- total value len = 9.192541 GB avg = 0.167 KB (by entry num) total key len = 1.519131 GB avg = 0.028 KB total ukey len = 1.053813 GB avg = 0.015 KB total ukey num = 0.068347206 Billion total entry num = 0.055154935 Billion write speed all = 1.813157890 MB/sec (with seq num) write speed all = 1.738469563 MB/sec (without seq num) 2024/11/23-10:33:40.010971 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256180: 932626 keys, 37957840 bytes, temperature: kWarm 2024/11/23-10:33:40.011056 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329220011017, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256180, "file_size": 37957840, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3862184505, "largest_seqno": 3931583787, "table_properties": {"data_size": 31940464, "index_size": 1786112, "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": 26113528, "raw_average_key_size": 28, "raw_value_size": 108104336, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 932626, "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": 1732329216, "oldest_key_time": 0, "file_creation_time": 1732329216, "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": 256180, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:40.046835 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256181.sst) /dev/shm/ToplingTemp/Topling-26608-OrjW49 2024/11/23-10:33:40.864555 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256181.sst): first pass time = 0.82's, 164.144'MB/sec 2024/11/23-10:33:42.436551 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256181.sst): old prealloc_size = 147639500, real_size = 36966368 2024/11/23-10:33:42.437093 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256181.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 930207 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.93 raw-val = 0.1082 GB zip-val = 0.0349 GB avg-val = 116.29 avg-zval = 37.56 2024/11/23-10:33:42.437398 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256181.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-10:33:43.162107 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256181.sst): second pass time = 1.57's, 68.847'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.73's, 53.561'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3445.967'MB/sec (index lex order gen) rebuild zvType time = 0.60's, 0.387'MB/sec write SST data time = 0.12's, 313.926'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.079'MB, throughput = 37530.214'MB/sec zip my value time = 1.57's, unzip length = 0.108'GB zip my value throughput = 68.847'MB/sec zip pipeline throughput = 71.195'MB/sec entries = 930207 avg-key = 28.00 avg-zkey = 1.93 avg-val = 116.29 avg-zval = 37.56 usrkeys = 930207 avg-key = 20.00 avg-zkey = 1.93 avg-val = 118.08 avg-zval = 37.56 TagRS{ kinds = RS_Key0_TagN bytes = 145440 } TagArray{ size = 238082 bytes = 892816 } seq expand size = 1666574 multi value expand size = 0 cnt WriteAppend = 19 UnZipSize{ index = 0.0186 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0349 GB dict = 1.08 MB all = 0.0389 GB } UnZip/Zip{ index = 10.3773 value = 3.0959 dict = 1.00 all = 3.4538 } Zip/UnZip{ index = 0.0964 value = 0.3230 dict = 1.00 all = 0.2895 } ---------------------------- total value len = 9.302380 GB avg = 0.166 KB (by entry num) total key len = 1.545176 GB avg = 0.028 KB total ukey len = 1.072418 GB avg = 0.015 KB total ukey num = 0.069277413 Billion total entry num = 0.056085142 Billion write speed all = 1.835163698 MB/sec (with seq num) write speed all = 1.759256893 MB/sec (without seq num) 2024/11/23-10:33:43.212589 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256181: 930207 keys, 38860453 bytes, temperature: kWarm 2024/11/23-10:33:43.212647 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329223212615, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256181, "file_size": 38860453, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 3931584111, "table_properties": {"data_size": 34940880, "index_size": 1792768, "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": 26045796, "raw_average_key_size": 28, "raw_value_size": 108172050, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 930207, "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": 1732329220, "oldest_key_time": 0, "file_creation_time": 1732329220, "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": 256181, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:43.252282 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256182.sst) /dev/shm/ToplingTemp/Topling-26608-nJoyV9 2024/11/23-10:33:44.070255 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256182.sst): first pass time = 0.82's, 164.092'MB/sec 2024/11/23-10:33:45.762222 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256182.sst): old prealloc_size = 147639500, real_size = 36382064 2024/11/23-10:33:45.762754 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256182.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 926823 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.0344 GB avg-val = 116.81 avg-zval = 37.10 2024/11/23-10:33:45.762792 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256182.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-10:33:46.456477 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256182.sst): second pass time = 1.69's, 64.035'MB/sec, value only(80.7% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.69's, 53.643'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3438.570'MB/sec (index lex order gen) rebuild zvType time = 0.57's, 0.405'MB/sec write SST data time = 0.12's, 307.751'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.081'MB, throughput = 37097.645'MB/sec zip my value time = 1.69's, unzip length = 0.108'GB zip my value throughput = 64.035'MB/sec zip pipeline throughput = 73.242'MB/sec entries = 926823 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.81 avg-zval = 37.10 usrkeys = 926823 avg-key = 20.00 avg-zkey = 1.90 avg-val = 116.81 avg-zval = 37.10 TagRS{ kinds = LegacyZvType bytes = 0 } TagArray{ size = 0 bytes = 0 } seq expand size = 0 multi value expand size = 0 cnt WriteAppend = 9 UnZipSize{ index = 0.0185 GB value = 0.1083 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0344 GB dict = 1.08 MB all = 0.0372 GB } UnZip/Zip{ index = 10.5137 value = 3.1485 dict = 1.00 all = 3.6041 } Zip/UnZip{ index = 0.0951 value = 0.3176 dict = 1.00 all = 0.2775 } ---------------------------- total value len = 9.410646 GB avg = 0.165 KB (by entry num) total key len = 1.571128 GB avg = 0.028 KB total ukey len = 1.090954 GB avg = 0.016 KB total ukey num = 0.070204236 Billion total entry num = 0.057011965 Billion write speed all = 1.856835463 MB/sec (with seq num) write speed all = 1.779717257 MB/sec (without seq num) 2024/11/23-10:33:46.511448 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256182: 926823 keys, 37240380 bytes, temperature: kWarm 2024/11/23-10:33:46.511513 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329226511479, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256182, "file_size": 37240380, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 0, "table_properties": {"data_size": 34387104, "index_size": 1763072, "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": 25951044, "raw_average_key_size": 28, "raw_value_size": 108266706, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 926823, "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": "TooZip", "compression_options": "LegacyZvType-NestLoudsTrieDAWG_Mixed_XL_256_32_FL-DictZipBlobStore", "creation_time": 1732329223, "oldest_key_time": 0, "file_creation_time": 1732329223, "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": 256182, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:46.549378 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256183.sst) /dev/shm/ToplingTemp/Topling-26608-egfojb 2024/11/23-10:33:47.460700 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256183.sst): first pass time = 0.91's, 147.284'MB/sec 2024/11/23-10:33:49.040199 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256183.sst): old prealloc_size = 147639500, real_size = 33832896 2024/11/23-10:33:49.040733 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256183.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 933323 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.0318 GB avg-val = 115.81 avg-zval = 34.10 2024/11/23-10:33:49.041599 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256183.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-10:33:49.889322 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256183.sst): second pass time = 1.58's, 68.461'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.85's, 45.099'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3451.903'MB/sec (index lex order gen) rebuild zvType time = 0.72's, 0.324'MB/sec write SST data time = 0.13's, 297.781'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 = 31088.362'MB/sec zip my value time = 1.58's, unzip length = 0.108'GB zip my value throughput = 68.461'MB/sec zip pipeline throughput = 130.641'MB/sec entries = 933323 avg-key = 28.00 avg-zkey = 1.90 avg-val = 115.81 avg-zval = 34.10 usrkeys = 933323 avg-key = 20.00 avg-zkey = 1.90 avg-val = 122.73 avg-zval = 34.10 TagRS{ kinds = RS_Key0_TagN bytes = 145920 } TagArray{ size = 922780 bytes = 3460432 } seq expand size = 6459460 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0187 GB value = 0.1081 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0318 GB dict = 1.08 MB all = 0.0383 GB } UnZip/Zip{ index = 10.5138 value = 3.3963 dict = 1.00 all = 3.5049 } Zip/UnZip{ index = 0.0951 value = 0.2944 dict = 1.00 all = 0.2853 } ---------------------------- total value len = 9.525191 GB avg = 0.164 KB (by entry num) total key len = 1.597261 GB avg = 0.028 KB total ukey len = 1.109620 GB avg = 0.016 KB total ukey num = 0.071137559 Billion total entry num = 0.057945288 Billion write speed all = 1.879530704 MB/sec (with seq num) write speed all = 1.801195492 MB/sec (without seq num) 2024/11/23-10:33:49.937397 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256183: 933323 keys, 38293930 bytes, temperature: kWarm 2024/11/23-10:33:49.937487 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329229937423, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256183, "file_size": 38293930, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 0, "largest_seqno": 3931583960, "table_properties": {"data_size": 31823984, "index_size": 1775424, "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": 26133044, "raw_average_key_size": 28, "raw_value_size": 108084786, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 933323, "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": 1732329226, "oldest_key_time": 0, "file_creation_time": 1732329226, "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": 256183, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:49.971930 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256184.sst) /dev/shm/ToplingTemp/Topling-26608-oplzbb 2024/11/23-10:33:50.821524 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256184.sst): first pass time = 0.85's, 157.985'MB/sec 2024/11/23-10:33:52.324224 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256184.sst): old prealloc_size = 147639500, real_size = 31584720 2024/11/23-10:33:52.324750 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256184.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 929845 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.0296 GB avg-val = 116.34 avg-zval = 31.82 2024/11/23-10:33:52.325539 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256184.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-10:33:53.153385 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256184.sst): second pass time = 1.50's, 72.035'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.83's, 43.187'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3492.113'MB/sec (index lex order gen) rebuild zvType time = 0.70's, 0.330'MB/sec write SST data time = 0.12's, 288.381'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 1.079'MB, throughput = 37415.448'MB/sec zip my value time = 1.50's, unzip length = 0.108'GB zip my value throughput = 72.035'MB/sec zip pipeline throughput = 109.596'MB/sec entries = 929845 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.34 avg-zval = 31.82 usrkeys = 929845 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.34 avg-zval = 31.82 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 929845 bytes = 3370704 } seq expand size = 6508915 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.0296 GB dict = 1.08 MB all = 0.0358 GB } UnZip/Zip{ index = 10.5125 value = 3.6569 dict = 1.00 all = 3.7483 } Zip/UnZip{ index = 0.0951 value = 0.2735 dict = 1.00 all = 0.2668 } ---------------------------- total value len = 9.639882 GB avg = 0.164 KB (by entry num) total key len = 1.623296 GB avg = 0.028 KB total ukey len = 1.128217 GB avg = 0.016 KB total ukey num = 0.072067404 Billion total entry num = 0.058875133 Billion write speed all = 1.902262198 MB/sec (with seq num) write speed all = 1.822713822 MB/sec (without seq num) 2024/11/23-10:33:53.201163 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256184: 929845 keys, 35808070 bytes, temperature: kWarm 2024/11/23-10:33:53.201229 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329233201194, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256184, "file_size": 35808070, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3661646931, "largest_seqno": 3931585392, "table_properties": {"data_size": 29583040, "index_size": 1769024, "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": 26035660, "raw_average_key_size": 28, "raw_value_size": 108182122, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 929845, "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": 1732329229, "oldest_key_time": 0, "file_creation_time": 1732329229, "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": 256184, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:53.236473 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256185.sst) /dev/shm/ToplingTemp/Topling-26608-GRXC2c 2024/11/23-10:33:54.191083 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256185.sst): first pass time = 0.95's, 140.605'MB/sec 2024/11/23-10:33:55.670868 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256185.sst): old prealloc_size = 147639500, real_size = 32876176 2024/11/23-10:33:55.671452 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256185.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 929115 prefix = 4 raw-key = 0.0149 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.91 raw-val = 0.1082 GB zip-val = 0.0309 GB avg-val = 116.46 avg-zval = 33.22 2024/11/23-10:33:55.672267 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256185.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-10:33:56.530511 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256185.sst): second pass time = 1.48's, 73.160'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.86's, 43.156'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3153.473'MB/sec (index lex order gen) rebuild zvType time = 0.73's, 0.317'MB/sec write SST data time = 0.13's, 295.438'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 = 28796.970'MB/sec zip my value time = 1.48's, unzip length = 0.108'GB zip my value throughput = 73.160'MB/sec zip pipeline throughput = 98.098'MB/sec entries = 929115 avg-key = 28.00 avg-zkey = 1.91 avg-val = 116.46 avg-zval = 33.22 usrkeys = 929115 avg-key = 20.00 avg-zkey = 1.91 avg-val = 123.46 avg-zval = 33.22 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 929115 bytes = 3368064 } seq expand size = 6503805 multi value expand size = 0 cnt WriteAppend = 15 UnZipSize{ index = 0.0186 GB value = 0.1082 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0309 GB dict = 1.08 MB all = 0.0371 GB } UnZip/Zip{ index = 10.4446 value = 3.5057 dict = 1.00 all = 3.6180 } Zip/UnZip{ index = 0.0957 value = 0.2852 dict = 1.00 all = 0.2764 } ---------------------------- total value len = 9.754588 GB avg = 0.163 KB (by entry num) total key len = 1.649311 GB avg = 0.028 KB total ukey len = 1.146800 GB avg = 0.016 KB total ukey num = 0.072996519 Billion total entry num = 0.059804248 Billion write speed all = 1.924931037 MB/sec (with seq num) write speed all = 1.844173360 MB/sec (without seq num) 2024/11/23-10:33:56.580301 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256185: 929115 keys, 37097512 bytes, temperature: kWarm 2024/11/23-10:33:56.580368 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329236580333, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256185, "file_size": 37097512, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3583362754, "largest_seqno": 3931584001, "table_properties": {"data_size": 30864576, "index_size": 1779136, "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": 26015220, "raw_average_key_size": 28, "raw_value_size": 108202510, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 929115, "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": 1732329233, "oldest_key_time": 0, "file_creation_time": 1732329233, "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": 256185, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:33:56.615060 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256186.sst) /dev/shm/ToplingTemp/Topling-26608-DzYi0a 2024/11/23-10:33:57.526505 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256186.sst): first pass time = 0.91's, 147.264'MB/sec 2024/11/23-10:33:59.082461 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256186.sst): old prealloc_size = 147639500, real_size = 33801600 2024/11/23-10:33:59.083004 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256186.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 934769 prefix = 4 raw-key = 0.0150 GB zip-key = 0.0018 GB avg-key = 16.00 avg-zkey = 1.91 raw-val = 0.1080 GB zip-val = 0.0318 GB avg-val = 115.58 avg-zval = 34.00 2024/11/23-10:33:59.083835 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256186.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-10:33:59.940564 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256186.sst): second pass time = 1.56's, 69.476'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.86's, 44.467'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 3392.508'MB/sec (index lex order gen) rebuild zvType time = 0.73's, 0.319'MB/sec write SST data time = 0.13's, 302.639'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 = 29523.155'MB/sec zip my value time = 1.56's, unzip length = 0.108'GB zip my value throughput = 69.476'MB/sec zip pipeline throughput = 119.415'MB/sec entries = 934769 avg-key = 28.00 avg-zkey = 1.91 avg-val = 115.58 avg-zval = 34.00 usrkeys = 934769 avg-key = 20.00 avg-zkey = 1.91 avg-val = 122.58 avg-zval = 34.00 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 934769 bytes = 3505392 } seq expand size = 6543383 multi value expand size = 0 cnt WriteAppend = 15 UnZipSize{ index = 0.0187 GB value = 0.1080 GB dict = 1.08 MB all = 0.1342 GB } __ZipSize{ index = 0.0018 GB value = 0.0318 GB dict = 1.08 MB all = 0.0382 GB } UnZip/Zip{ index = 10.4443 value = 3.4000 dict = 1.00 all = 3.5175 } Zip/UnZip{ index = 0.0957 value = 0.2941 dict = 1.00 all = 0.2843 } ---------------------------- total value len = 9.869176 GB avg = 0.162 KB (by entry num) total key len = 1.675485 GB avg = 0.028 KB total ukey len = 1.165495 GB avg = 0.016 KB total ukey num = 0.073931288 Billion total entry num = 0.060739017 Billion write speed all = 1.947569907 MB/sec (with seq num) write speed all = 1.865597133 MB/sec (without seq num) 2024/11/23-10:33:59.989313 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256186: 934769 keys, 38157286 bytes, temperature: kWarm 2024/11/23-10:33:59.989376 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329239989344, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256186, "file_size": 38157286, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3376774746, "largest_seqno": 3931585552, "table_properties": {"data_size": 31777712, "index_size": 1790016, "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": 26173532, "raw_average_key_size": 28, "raw_value_size": 108044238, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 934769, "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": 1732329236, "oldest_key_time": 0, "file_creation_time": 1732329236, "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": 256186, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:34:00.027682 139957659977280 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256187.sst) /dev/shm/ToplingTemp/Topling-26608-regQma 2024/11/23-10:34:00.156171 139957659977280 [top_zip_table_builder.cc:1352] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256187.sst): first pass time = 0.13's, 236.462'MB/sec 2024/11/23-10:34:00.465855 139957659977280 [top_zip_table_builder.cc:2772] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256187.sst): old prealloc_size = 147639500, real_size = 8659392 2024/11/23-10:34:00.466050 139957659977280 [top_zip_table_builder.cc:1773] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256187.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 208044 prefix = 4 raw-key = 0.0033 GB zip-key = 0.0004 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0245 GB zip-val = 0.0082 GB avg-val = 118.00 avg-zval = 39.45 2024/11/23-10:34:00.466266 139957659977280 [top_zip_table_builder.cc:1299] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256187.sst: sumWaitingMem = 0.000 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0005 GB, waited 0.000 sec, Key+Value = 0.030 GB 2024/11/23-10:34:00.653816 139957659977280 [top_zip_table_builder.cc:3100] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00/256187.sst): second pass time = 0.31's, 79.452'MB/sec, value only(80.8% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.19's, 50.761'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2319.492'MB/sec (index lex order gen) rebuild zvType time = 0.16's, 0.328'MB/sec write SST data time = 0.03's, 327.373'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.255'MB, throughput = 9302.190'MB/sec zip my value time = 0.31's, unzip length = 0.025'GB zip my value throughput = 79.452'MB/sec zip pipeline throughput = 79.452'MB/sec entries = 208044 avg-key = 28.00 avg-zkey = 1.92 avg-val = 118.00 avg-zval = 39.45 usrkeys = 208044 avg-key = 20.00 avg-zkey = 1.92 avg-val = 125.00 avg-zval = 39.45 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 208044 bytes = 676160 } seq expand size = 1456308 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0042 GB value = 0.0245 GB dict = 0.25 MB all = 0.0304 GB } __ZipSize{ index = 0.0004 GB value = 0.0082 GB dict = 0.25 MB all = 0.0095 GB } UnZip/Zip{ index = 10.4122 value = 2.9910 dict = 1.00 all = 3.1839 } Zip/UnZip{ index = 0.0960 value = 0.3343 dict = 1.00 all = 0.3141 } ---------------------------- total value len = 9.895181 GB avg = 0.162 KB (by entry num) total key len = 1.681310 GB avg = 0.028 KB total ukey len = 1.169656 GB avg = 0.016 KB total ukey num = 0.074139332 Billion total entry num = 0.060947061 Billion write speed all = 1.952704756 MB/sec (with seq num) write speed all = 1.870461104 MB/sec (without seq num) 2024/11/23-10:34:00.670768 139957659977280 [compaction_job.cc:1948] [default] [JOB 24446] Generated table #256187: 208044 keys, 9540095 bytes, temperature: kWarm 2024/11/23-10:34:00.670826 139957659977280 EVENT_LOG_v1 {"time_micros": 1732329240670794, "cf_name": "default", "job": 24446, "event": "table_file_creation", "file_number": 256187, "file_size": 9540095, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 3886733932, "largest_seqno": 3928731725, "table_properties": {"data_size": 8207600, "index_size": 399616, "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": 5825232, "raw_average_key_size": 28, "raw_value_size": 24549192, "raw_average_value_size": 118, "num_data_blocks": 1, "num_entries": 208044, "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": 118, "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": 1732329240, "oldest_key_time": 0, "file_creation_time": 1732329240, "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": 256187, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/11/23-10:34:00.684477 139957659977280 [compaction_job.cc:703] job-24446: subcompact[0], size: 0.349312 G, files: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-24446/att-00 [256178,256179,256180,256181,256182,256183,256184,256185,256186,256187] 2024/11/23-10:34:00.745318 139957659977280 (Original Log Time 2024/11/23-10:33:28.908894) EVENT_LOG_v1 {"time_micros": 1732329208908860, "job": 24446, "event": "compaction_started", "compaction_reason": "FilesMarkedForCompaction", "files_L2": [256124], "files_L3": [256036, 256037, 256038, 256070, 256071, 256072, 256073, 256074, 256156], "score": 0.999731, "input_data_size": 368013538, "oldest_snapshot_seqno": 3931809083} 2024/11/23-10:34:00.745321 139957659977280 (Original Log Time 2024/11/23-10:34:00.744407) [compaction_job.cc:2022] [default] [JOB 24446] Compacted 1@2 + 9@3 files to L3 => 349312360 bytes 2024/11/23-10:34:00.745323 139957659977280 (Original Log Time 2024/11/23-10:34:00.745251) [compaction_job.cc:1224] [default] compacted to: files[0 0 0 10 0 0 0] max score 0.01, MB/sec: 11.6 rd, 11.0 wr, level 3, files in(1, 9) out(10 +0 blob) MB in(27.1, 323.9 +0.0 blob) out(333.1 +0.0 blob), read-write-amplify(25.2) write-amplify(12.3) OK, records in: 8610938, records dropped: 22041 output_compression: Snappy 2024/11/23-10:34:00.745329 139957659977280 (Original Log Time 2024/11/23-10:34:00.745298) EVENT_LOG_v1 {"time_micros": 1732329240745274, "cf": "default", "job": 24446, "event": "compaction_finished", "compaction_time_micros": 31775590, "compaction_time_cpu_micros": 12970602, "output_level": 3, "num_output_files": 10, "total_output_size": 349312360, "num_input_records": 8610938, "num_output_records": 8588897, "num_subcompactions": 1, "output_compression": "Snappy", "num_single_delete_mismatches": 0, "num_single_delete_fallthrough": 0, "file_write_nanos": 245008182, "file_range_sync_nanos": 0, "file_fsync_nanos": 6610, "file_prepare_write_nanos": 25194, "lsm_state": [0, 0, 0, 10, 0, 0, 0]} 2024/11/23-10:34:00.880329 139957659977280 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":1732329208,"executesMs":31966,"compactionJobId":24446,"attempt":0,"compactionInputRawBytes":1241464464,"compactionInputZipBytes":368013538,"compactionOutputRawBytes":0,"compactionOutputZipBytes":349312360,"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-317ef8633f45570d118c8c0dfc3b332e-62e25390712b7b63-00"}}, response = 2024/11/23-10:34:00.880414 139957659977280 INFO dcompact_worker.cpp:1459: finish /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-11-22T14.14.14/.rocksdb/job-24446/att-00: olev 3, work 31.967 s, result 7.756 ms, install 0.940 ms, input{raw 1.156 GiB zip 350.965 MiB}