2024/07/09-22:15:29.838076 140433570997824 DEBG dcompact_worker.cpp:2211: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00: fork to child time = 0.012230 sec 2024/07/09-22:15:29.839000 140433570997824 DEBG dcompact_worker.cpp:1011: Beg SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00 2024/07/09-22:15:29.844129 140433570997824 DEBG dcompact_worker.cpp:1031: End SerDeRead: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00 2024/07/09-22:15:29.844435 140433570997824 TRAC dcompact_worker.cpp:1081: INFO_LOG_LEVEL: rpc = INFO_LEVEL, env_var = undefined 2024/07/09-22:15:29.844768 140433570997824 [WARN] [column_family.cc:386] multiple cf_paths/db_paths and level_compaction_dynamic_level_bytes can't be used together 2024/07/09-22:15:29.878780 140433570997824 [version_set.cc:6139] Recovering from manifest file: /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-07-08T14.41.36/.rocksdb/job-61639/att-00/MANIFEST-12625661 2024/07/09-22:15:29.914210 140433570997824 [version_set.cc:6182] Recovered from manifest file:/worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-07-08T14.41.36/.rocksdb/job-61639/att-00/MANIFEST-12625661 succeeded,manifest_file_number is 12625661, next_file_number is 12697367, last_sequence is 148764124147, log_number is 0,prev_log_number is 0,max_column_family is 0,min_log_number_to_keep is 12697332 2024/07/09-22:15:29.914217 140433570997824 [version_set.cc:6197] Column family [default] (ID 0), log number is 0 2024/07/09-22:15:29.914307 140433570997824 [version_set.cc:5652] Creating manifest 12697367 2024/07/09-22:15:29.935674 140433570997824 DEBG dcompact_worker.cpp:1215: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00: bottommost_level: fake = 1, rpc = 0 2024/07/09-22:15:29.947440 140433570997824 [compaction_job.cc:2433] [default] [JOB 61639] Compacting 1@1 + 9@2 files to L2, score 0.98, subcompactions 1 : 1 2024/07/09-22:15:29.947452 140433570997824 [compaction_job.cc:2441] [default]: Compaction start summary: Base version 31639 Base level 1, inputs: [12697350(31MB)], [12697301(20MB) 12697302(20MB) 12697303(20MB) 12697304(19MB) 12697327(20MB) 12697328(19MB) 12697329(19MB) 12697330(20MB) 12697331(20MB)] 2024/07/09-22:15:30.191882 140433570997824 [top_zip_table.cc:59] core git_version_hash_info_is:commit 7517bad5c1a147474c3830831b9a22c996321ae8 Author: leipeng Date: 2024-01-08 19:18:17 +0800 vfork_cmd: call close before wait_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. 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/07/09-22:15:30.191906 140433570997824 [top_zip_table.cc:60] fsa git_version_hash_info_is:commit 7517bad5c1a147474c3830831b9a22c996321ae8 Author: leipeng Date: 2024-01-08 19:18:17 +0800 vfork_cmd: call close before wait_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. 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/07/09-22:15:30.191924 140433570997824 [top_zip_table.cc:61] zbs git_version_hash_info_is:commit 7517bad5c1a147474c3830831b9a22c996321ae8 Author: leipeng Date: 2024-01-08 19:18:17 +0800 vfork_cmd: call close before wait_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. 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/07/09-22:15:30.191936 140433570997824 [top_zip_table.cc:62] topling-zip_table_reader: git_version_hash_info_is: commit 7f80399bfbd2071b6e0f5683e8ab7225b8e6e394 Author: leipeng Date: 2024-01-19 14:52:30 +0800 Change ToplingZipTableOptions::sampleRatio to vector 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/07/09-22:15:30.191952 140433570997824 [top_zip_table.cc:64] topling-rocks git_version_hash_info_is: commit 1240987ca13d0fe562c9b9c037155079f0877840 Author: leipeng Date: 2024-01-19 15:07:04 +0800 Change ToplingZipTableOptions::sampleRatio to vector 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/07/09-22:15:30.354419 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697368.sst) /dev/shm/ToplingTemp/Topling-114439-J825Wy 2024/07/09-22:15:30.622344 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697368.sst): first pass time = 0.27's, 250.513'MB/sec 2024/07/09-22:15:31.467219 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697368.sst): old prealloc_size = 73819750, real_size = 19396064 2024/07/09-22:15:31.467633 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697368.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 465576 prefix = 4 raw-key = 0.0074 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0541 GB zip-val = 0.0184 GB avg-val = 116.14 avg-zval = 39.49 2024/07/09-22:15:31.468124 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697368.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:31.998548 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697368.sst): second pass time = 0.84's, 64.069'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.53's, 40.161'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2288.311'MB/sec (index lex order gen) rebuild zvType time = 0.45's, 0.260'MB/sec write SST data time = 0.08's, 256.306'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 16203.895'MB/sec zip my value time = 0.84's, unzip length = 0.054'GB zip my value throughput = 64.069'MB/sec zip pipeline throughput = 64.069'MB/sec entries = 465576 avg-key = 28.00 avg-zkey = 1.92 avg-val = 116.14 avg-zval = 39.49 usrkeys = 465576 avg-key = 20.00 avg-zkey = 1.92 avg-val = 123.14 avg-zval = 39.49 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 465576 bytes = 1513136 } seq expand size = 3259032 multi value expand size = 0 cnt WriteAppend = 15 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0184 GB dict = 0.54 MB all = 0.0213 GB } UnZip/Zip{ index = 10.4356 value = 2.9408 dict = 1.00 all = 3.1448 } Zip/UnZip{ index = 0.0958 value = 0.3400 dict = 1.00 all = 0.3180 } ---------------------------- total value len = 0.057332 GB avg = 0.123 KB (by entry num) total key len = 0.013036 GB avg = 0.028 KB total ukey len = 0.009312 GB avg = 0.020 KB total ukey num = 0.000465576 Billion total entry num = 0.000465576 Billion write speed all = 0.002271555 MB/sec (with seq num) write speed all = 0.002151321 MB/sec (without seq num) 2024/07/09-22:15:32.034276 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697368: 465576 keys, 21339636 bytes, temperature: kWarm 2024/07/09-22:15:32.034338 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534532034298, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697368, "file_size": 21339636, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148729729858, "largest_seqno": 148764113436, "table_properties": {"data_size": 18387216, "index_size": 892288, "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": 13036128, "raw_average_key_size": 28, "raw_value_size": 54072848, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 465576, "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": 1720534530, "oldest_key_time": 0, "file_creation_time": 1720534530, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697368, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:32.063836 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697369.sst) /dev/shm/ToplingTemp/Topling-114439-kwL65x 2024/07/09-22:15:32.758847 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697369.sst): first pass time = 0.69's, 96.564'MB/sec 2024/07/09-22:15:36.672978 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697369.sst): old prealloc_size = 73819750, real_size = 18923120 2024/07/09-22:15:36.673386 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697369.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466679 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.89 raw-val = 0.0540 GB zip-val = 0.0179 GB avg-val = 115.80 avg-zval = 38.41 2024/07/09-22:15:36.673845 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697369.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:37.360901 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697369.sst): second pass time = 3.91's, 13.813'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.69's, 30.340'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2312.471'MB/sec (index lex order gen) rebuild zvType time = 0.51's, 0.227'MB/sec write SST data time = 0.17's, 119.757'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 11738.572'MB/sec zip my value time = 3.91's, unzip length = 0.054'GB zip my value throughput = 13.813'MB/sec zip pipeline throughput = 108.033'MB/sec entries = 466679 avg-key = 28.00 avg-zkey = 1.89 avg-val = 115.80 avg-zval = 38.41 usrkeys = 466679 avg-key = 20.00 avg-zkey = 1.89 avg-val = 122.80 avg-zval = 38.41 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466679 bytes = 1516720 } seq expand size = 3266753 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0540 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0179 GB dict = 0.54 MB all = 0.0209 GB } UnZip/Zip{ index = 10.5748 value = 3.0151 dict = 1.00 all = 3.2154 } Zip/UnZip{ index = 0.0946 value = 0.3317 dict = 1.00 all = 0.3110 } ---------------------------- total value len = 0.114641 GB avg = 0.123 KB (by entry num) total key len = 0.026103 GB avg = 0.028 KB total ukey len = 0.018645 GB avg = 0.020 KB total ukey num = 0.000932255 Billion total entry num = 0.000932255 Billion write speed all = 0.004542573 MB/sec (with seq num) write speed all = 0.004301861 MB/sec (without seq num) 2024/07/09-22:15:37.390078 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697369: 466679 keys, 20871120 bytes, temperature: kWarm 2024/07/09-22:15:37.390161 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534537390115, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697369, "file_size": 20871120, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148698676771, "largest_seqno": 148764113402, "table_properties": {"data_size": 17923616, "index_size": 882624, "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": 13067012, "raw_average_key_size": 28, "raw_value_size": 54041962, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466679, "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": 1720534532, "oldest_key_time": 0, "file_creation_time": 1720534532, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697369, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:37.430534 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697370.sst) /dev/shm/ToplingTemp/Topling-114439-a71wYv 2024/07/09-22:15:38.242866 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697370.sst): first pass time = 0.81's, 82.618'MB/sec 2024/07/09-22:15:41.346727 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697370.sst): old prealloc_size = 73819750, real_size = 19265136 2024/07/09-22:15:41.347091 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697370.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466628 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0540 GB zip-val = 0.0183 GB avg-val = 115.82 avg-zval = 39.13 2024/07/09-22:15:41.347492 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697370.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:42.093764 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697370.sst): second pass time = 3.10's, 17.416'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.75's, 28.395'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2680.161'MB/sec (index lex order gen) rebuild zvType time = 0.48's, 0.245'MB/sec write SST data time = 0.27's, 78.471'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.542'MB, throughput = 14301.277'MB/sec zip my value time = 3.10's, unzip length = 0.054'GB zip my value throughput = 17.416'MB/sec zip pipeline throughput = 141.521'MB/sec entries = 466628 avg-key = 28.00 avg-zkey = 1.90 avg-val = 115.82 avg-zval = 39.13 usrkeys = 466628 avg-key = 20.00 avg-zkey = 1.90 avg-val = 122.82 avg-zval = 39.13 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466628 bytes = 1516560 } seq expand size = 3266396 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0540 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0183 GB dict = 0.54 MB all = 0.0212 GB } UnZip/Zip{ index = 10.5013 value = 2.9597 dict = 1.00 all = 3.1639 } Zip/UnZip{ index = 0.0952 value = 0.3379 dict = 1.00 all = 0.3161 } ---------------------------- total value len = 0.171950 GB avg = 0.123 KB (by entry num) total key len = 0.039169 GB avg = 0.028 KB total ukey len = 0.027978 GB avg = 0.020 KB total ukey num = 0.001398883 Billion total entry num = 0.001398883 Billion write speed all = 0.006812931 MB/sec (with seq num) write speed all = 0.006451789 MB/sec (without seq num) 2024/07/09-22:15:42.143602 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697370: 466628 keys, 21210814 bytes, temperature: kWarm 2024/07/09-22:15:42.143688 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534542143642, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697370, "file_size": 21210814, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148726233964, "largest_seqno": 148764113762, "table_properties": {"data_size": 18259616, "index_size": 888704, "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": 13065584, "raw_average_key_size": 28, "raw_value_size": 54043356, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466628, "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": 1720534537, "oldest_key_time": 0, "file_creation_time": 1720534537, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697370, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:42.179920 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697371.sst) /dev/shm/ToplingTemp/Topling-114439-hYssuz 2024/07/09-22:15:43.050563 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697371.sst): first pass time = 0.87's, 77.084'MB/sec 2024/07/09-22:15:45.193749 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697371.sst): old prealloc_size = 73819750, real_size = 18615536 2024/07/09-22:15:45.194160 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697371.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466735 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0540 GB zip-val = 0.0176 GB avg-val = 115.78 avg-zval = 37.73 2024/07/09-22:15:45.194593 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697371.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:46.053469 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697371.sst): second pass time = 2.14's, 25.227'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.86's, 23.987'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2322.583'MB/sec (index lex order gen) rebuild zvType time = 0.70's, 0.166'MB/sec write SST data time = 0.16's, 130.837'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.542'MB, throughput = 13849.972'MB/sec zip my value time = 2.14's, unzip length = 0.054'GB zip my value throughput = 25.227'MB/sec zip pipeline throughput = 122.884'MB/sec entries = 466735 avg-key = 28.00 avg-zkey = 1.90 avg-val = 115.78 avg-zval = 37.73 usrkeys = 466735 avg-key = 20.00 avg-zkey = 1.90 avg-val = 122.78 avg-zval = 37.73 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466735 bytes = 1575248 } seq expand size = 3267145 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0540 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0176 GB dict = 0.54 MB all = 0.0206 GB } UnZip/Zip{ index = 10.5037 value = 3.0687 dict = 1.00 all = 3.2542 } Zip/UnZip{ index = 0.0952 value = 0.3259 dict = 1.00 all = 0.3073 } ---------------------------- total value len = 0.229258 GB avg = 0.123 KB (by entry num) total key len = 0.052237 GB avg = 0.028 KB total ukey len = 0.037312 GB avg = 0.020 KB total ukey num = 0.001865618 Billion total entry num = 0.001865618 Billion write speed all = 0.009082844 MB/sec (with seq num) write speed all = 0.008601269 MB/sec (without seq num) 2024/07/09-22:15:46.121288 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697371: 466735 keys, 20621952 bytes, temperature: kWarm 2024/07/09-22:15:46.121377 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534546121330, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697371, "file_size": 20621952, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148689416927, "largest_seqno": 148764113196, "table_properties": {"data_size": 17609952, "index_size": 888704, "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": 13068580, "raw_average_key_size": 28, "raw_value_size": 54040310, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466735, "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": 1720534542, "oldest_key_time": 0, "file_creation_time": 1720534542, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697371, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:46.155779 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697372.sst) /dev/shm/ToplingTemp/Topling-114439-SCkJCw 2024/07/09-22:15:46.870327 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697372.sst): first pass time = 0.71's, 93.924'MB/sec 2024/07/09-22:15:48.268578 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697372.sst): old prealloc_size = 73819750, real_size = 19266288 2024/07/09-22:15:48.269013 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697372.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466214 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.92 raw-val = 0.0541 GB zip-val = 0.0183 GB avg-val = 115.94 avg-zval = 39.16 2024/07/09-22:15:48.269469 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697372.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:48.944039 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697372.sst): second pass time = 1.40's, 38.683'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.68's, 31.490'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2188.121'MB/sec (index lex order gen) rebuild zvType time = 0.46's, 0.251'MB/sec write SST data time = 0.21's, 100.904'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 13007.717'MB/sec zip my value time = 1.40's, unzip length = 0.054'GB zip my value throughput = 38.683'MB/sec zip pipeline throughput = 84.754'MB/sec entries = 466214 avg-key = 28.00 avg-zkey = 1.92 avg-val = 115.94 avg-zval = 39.16 usrkeys = 466214 avg-key = 20.00 avg-zkey = 1.92 avg-val = 122.94 avg-zval = 39.16 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466214 bytes = 1573488 } seq expand size = 3263498 multi value expand size = 0 cnt WriteAppend = 15 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0183 GB dict = 0.54 MB all = 0.0213 GB } UnZip/Zip{ index = 10.4356 value = 2.9609 dict = 1.00 all = 3.1552 } Zip/UnZip{ index = 0.0958 value = 0.3377 dict = 1.00 all = 0.3169 } ---------------------------- total value len = 0.286576 GB avg = 0.123 KB (by entry num) total key len = 0.065291 GB avg = 0.028 KB total ukey len = 0.046637 GB avg = 0.020 KB total ukey num = 0.002331832 Billion total entry num = 0.002331832 Billion write speed all = 0.011352452 MB/sec (with seq num) write speed all = 0.010750589 MB/sec (without seq num) 2024/07/09-22:15:48.972611 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697372: 466214 keys, 21269522 bytes, temperature: kWarm 2024/07/09-22:15:48.972945 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534548972689, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697372, "file_size": 21269522, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148683235528, "largest_seqno": 148764110093, "table_properties": {"data_size": 18256032, "index_size": 893504, "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": 13053992, "raw_average_key_size": 28, "raw_value_size": 54054908, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466214, "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": 1720534546, "oldest_key_time": 0, "file_creation_time": 1720534546, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697372, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:49.020240 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697373.sst) /dev/shm/ToplingTemp/Topling-114439-TvTabw 2024/07/09-22:15:49.752314 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697373.sst): first pass time = 0.73's, 91.677'MB/sec 2024/07/09-22:15:50.755573 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697373.sst): old prealloc_size = 73819750, real_size = 18597456 2024/07/09-22:15:50.755956 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697373.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466534 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0540 GB zip-val = 0.0176 GB avg-val = 115.85 avg-zval = 37.71 2024/07/09-22:15:50.756393 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697373.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:51.638630 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697373.sst): second pass time = 1.00's, 53.918'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.88's, 23.332'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2496.931'MB/sec (index lex order gen) rebuild zvType time = 0.72's, 0.162'MB/sec write SST data time = 0.16's, 125.454'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.542'MB, throughput = 15519.416'MB/sec zip my value time = 1.00's, unzip length = 0.054'GB zip my value throughput = 53.918'MB/sec zip pipeline throughput = 53.918'MB/sec entries = 466534 avg-key = 28.00 avg-zkey = 1.90 avg-val = 115.85 avg-zval = 37.71 usrkeys = 466534 avg-key = 20.00 avg-zkey = 1.90 avg-val = 122.85 avg-zval = 37.71 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466534 bytes = 1574560 } seq expand size = 3265738 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0540 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0176 GB dict = 0.54 MB all = 0.0206 GB } UnZip/Zip{ index = 10.5022 value = 3.0722 dict = 1.00 all = 3.2572 } Zip/UnZip{ index = 0.0952 value = 0.3255 dict = 1.00 all = 0.3070 } ---------------------------- total value len = 0.343888 GB avg = 0.123 KB (by entry num) total key len = 0.078354 GB avg = 0.028 KB total ukey len = 0.055967 GB avg = 0.020 KB total ukey num = 0.002798366 Billion total entry num = 0.002798366 Billion write speed all = 0.013621797 MB/sec (with seq num) write speed all = 0.012899581 MB/sec (without seq num) 2024/07/09-22:15:51.665490 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697373: 466534 keys, 20603078 bytes, temperature: kWarm 2024/07/09-22:15:51.665573 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534551665529, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697373, "file_size": 20603078, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148671434009, "largest_seqno": 148764112057, "table_properties": {"data_size": 17592192, "index_size": 888448, "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": 13062952, "raw_average_key_size": 28, "raw_value_size": 54046036, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466534, "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": 1720534549, "oldest_key_time": 0, "file_creation_time": 1720534549, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697373, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:51.696395 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697374.sst) /dev/shm/ToplingTemp/Topling-114439-5TJfiv 2024/07/09-22:15:52.170785 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697374.sst): first pass time = 0.47's, 141.480'MB/sec 2024/07/09-22:15:52.917173 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697374.sst): old prealloc_size = 73819750, real_size = 19090224 2024/07/09-22:15:52.917493 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697374.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 465689 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0541 GB zip-val = 0.0181 GB avg-val = 116.11 avg-zval = 38.84 2024/07/09-22:15:52.917902 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697374.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:53.294237 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697374.sst): second pass time = 0.75's, 72.516'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.38's, 55.786'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2987.548'MB/sec (index lex order gen) rebuild zvType time = 0.31's, 0.379'MB/sec write SST data time = 0.07's, 302.757'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 14683.633'MB/sec zip my value time = 0.75's, unzip length = 0.054'GB zip my value throughput = 72.516'MB/sec zip pipeline throughput = 72.516'MB/sec entries = 465689 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.11 avg-zval = 38.84 usrkeys = 465689 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.11 avg-zval = 38.84 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 465689 bytes = 1513504 } seq expand size = 3259823 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0181 GB dict = 0.54 MB all = 0.0210 GB } UnZip/Zip{ index = 10.5006 value = 2.9895 dict = 1.00 all = 3.1904 } Zip/UnZip{ index = 0.0952 value = 0.3345 dict = 1.00 all = 0.3134 } ---------------------------- total value len = 0.401217 GB avg = 0.123 KB (by entry num) total key len = 0.091394 GB avg = 0.028 KB total ukey len = 0.065281 GB avg = 0.020 KB total ukey num = 0.003264055 Billion total entry num = 0.003264055 Billion write speed all = 0.015891089 MB/sec (with seq num) write speed all = 0.015048731 MB/sec (without seq num) 2024/07/09-22:15:53.320337 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697374: 465689 keys, 21034332 bytes, temperature: kWarm 2024/07/09-22:15:53.320403 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534553320371, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697374, "file_size": 21034332, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148709787123, "largest_seqno": 148764110640, "table_properties": {"data_size": 18086624, "index_size": 886976, "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": 13039292, "raw_average_key_size": 28, "raw_value_size": 54069670, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 465689, "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": 1720534551, "oldest_key_time": 0, "file_creation_time": 1720534551, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697374, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:53.342246 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697375.sst) /dev/shm/ToplingTemp/Topling-114439-zc5UTv 2024/07/09-22:15:54.004799 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697375.sst): first pass time = 0.66's, 101.295'MB/sec 2024/07/09-22:15:54.987482 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697375.sst): old prealloc_size = 73819750, real_size = 18754704 2024/07/09-22:15:54.987846 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697375.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 466628 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0540 GB zip-val = 0.0177 GB avg-val = 115.82 avg-zval = 38.04 2024/07/09-22:15:54.988243 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697375.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:55.370268 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697375.sst): second pass time = 0.98's, 55.053'MB/sec, value only(80.5% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.38's, 54.237'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2588.725'MB/sec (index lex order gen) rebuild zvType time = 0.32's, 0.369'MB/sec write SST data time = 0.07's, 311.749'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.542'MB, throughput = 12287.429'MB/sec zip my value time = 0.98's, unzip length = 0.054'GB zip my value throughput = 55.053'MB/sec zip pipeline throughput = 55.053'MB/sec entries = 466628 avg-key = 28.00 avg-zkey = 1.90 avg-val = 115.82 avg-zval = 38.04 usrkeys = 466628 avg-key = 20.00 avg-zkey = 1.90 avg-val = 122.82 avg-zval = 38.04 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 466628 bytes = 1574880 } seq expand size = 3266396 multi value expand size = 0 cnt WriteAppend = 14 UnZipSize{ index = 0.0093 GB value = 0.0540 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0177 GB dict = 0.54 MB all = 0.0208 GB } UnZip/Zip{ index = 10.5013 value = 3.0448 dict = 1.00 all = 3.2325 } Zip/UnZip{ index = 0.0952 value = 0.3284 dict = 1.00 all = 0.3094 } ---------------------------- total value len = 0.458527 GB avg = 0.123 KB (by entry num) total key len = 0.104459 GB avg = 0.028 KB total ukey len = 0.074614 GB avg = 0.020 KB total ukey num = 0.003730683 Billion total entry num = 0.003730683 Billion write speed all = 0.018160104 MB/sec (with seq num) write speed all = 0.017197386 MB/sec (without seq num) 2024/07/09-22:15:55.397498 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697375: 466628 keys, 20760810 bytes, temperature: kWarm 2024/07/09-22:15:55.397563 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534555397526, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697375, "file_size": 20760810, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148693131672, "largest_seqno": 148764112847, "table_properties": {"data_size": 17749184, "index_size": 888704, "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": 13065584, "raw_average_key_size": 28, "raw_value_size": 54043344, "raw_average_value_size": 115, "num_data_blocks": 1, "num_entries": 466628, "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": 1720534553, "oldest_key_time": 0, "file_creation_time": 1720534553, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697375, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:55.418526 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697376.sst) /dev/shm/ToplingTemp/Topling-114439-4KSzwv 2024/07/09-22:15:55.817206 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697376.sst): first pass time = 0.40's, 168.342'MB/sec 2024/07/09-22:15:56.530747 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697376.sst): old prealloc_size = 73819750, real_size = 19091312 2024/07/09-22:15:56.531093 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697376.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 465910 prefix = 4 raw-key = 0.0075 GB zip-key = 0.0009 GB avg-key = 16.00 avg-zkey = 1.90 raw-val = 0.0541 GB zip-val = 0.0181 GB avg-val = 116.04 avg-zval = 38.82 2024/07/09-22:15:56.531507 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697376.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0011 GB, waited 0.000 sec, Key+Value = 0.067 GB 2024/07/09-22:15:56.899956 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697376.sst): second pass time = 0.71's, 75.850'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.37's, 56.974'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2808.926'MB/sec (index lex order gen) rebuild zvType time = 0.30's, 0.387'MB/sec write SST data time = 0.07's, 310.445'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.543'MB, throughput = 14793.628'MB/sec zip my value time = 0.71's, unzip length = 0.054'GB zip my value throughput = 75.850'MB/sec zip pipeline throughput = 75.850'MB/sec entries = 465910 avg-key = 28.00 avg-zkey = 1.90 avg-val = 116.04 avg-zval = 38.82 usrkeys = 465910 avg-key = 20.00 avg-zkey = 1.90 avg-val = 123.04 avg-zval = 38.82 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 465910 bytes = 1514224 } seq expand size = 3261370 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0093 GB value = 0.0541 GB dict = 0.54 MB all = 0.0671 GB } __ZipSize{ index = 0.0009 GB value = 0.0181 GB dict = 0.54 MB all = 0.0210 GB } UnZip/Zip{ index = 10.5003 value = 2.9890 dict = 1.00 all = 3.1902 } Zip/UnZip{ index = 0.0952 value = 0.3346 dict = 1.00 all = 0.3135 } ---------------------------- total value len = 0.515852 GB avg = 0.123 KB (by entry num) total key len = 0.117505 GB avg = 0.028 KB total ukey len = 0.083932 GB avg = 0.020 KB total ukey num = 0.004196593 Billion total entry num = 0.004196593 Billion write speed all = 0.020429011 MB/sec (with seq num) write speed all = 0.019346117 MB/sec (without seq num) 2024/07/09-22:15:56.926810 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697376: 465910 keys, 21035856 bytes, temperature: kWarm 2024/07/09-22:15:56.926877 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534556926844, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697376, "file_size": 21035856, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148717173556, "largest_seqno": 148764113299, "table_properties": {"data_size": 18087200, "index_size": 887424, "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": 13045480, "raw_average_key_size": 28, "raw_value_size": 54063408, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 465910, "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": 1720534555, "oldest_key_time": 0, "file_creation_time": 1720534555, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697376, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:56.948655 140433570997824 [top_zip_table_builder.cc:934] ToplingZipTableBuilder(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697377.sst) /dev/shm/ToplingTemp/Topling-114439-A7sPcx 2024/07/09-22:15:57.070277 140433570997824 [top_zip_table_builder.cc:1344] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697377.sst): first pass time = 0.12's, 274.389'MB/sec 2024/07/09-22:15:57.414385 140433570997824 [top_zip_table_builder.cc:2764] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697377.sst): old prealloc_size = 73819750, real_size = 9887536 2024/07/09-22:15:57.414584 140433570997824 [top_zip_table_builder.cc:1765] BuildReorderMap(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697377.sst): index type = NestLoudsTrieDAWG_Mixed_XL_256_32_FL, store type = DictZipBlobStore usrkeys = 231101 prefix = 4 raw-key = 0.0037 GB zip-key = 0.0004 GB avg-key = 16.00 avg-zkey = 1.91 raw-val = 0.0269 GB zip-val = 0.0094 GB avg-val = 116.36 avg-zval = 40.63 2024/07/09-22:15:57.414844 140433570997824 [top_zip_table_builder.cc:1295] /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697377.sst: sumWaitingMem = 0.001 GB, sumWorkingMem = 0.000 GB, reorder workingMem = 0.0005 GB, waited 0.000 sec, Key+Value = 0.033 GB 2024/07/09-22:15:57.598001 140433570997824 [top_zip_table_builder.cc:3092] ToplingZipTableBuilder::Finish(/storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00/12697377.sst): second pass time = 0.34's, 78.308'MB/sec, value only(80.6% of KV) wait indexing time = 0.00's, remap KeyValue time = 0.18's, 59.145'MB/sec (all stages of remap) Get OrderMap time = 0.00's, 2601.534'MB/sec (index lex order gen) rebuild zvType time = 0.15's, 0.388'MB/sec write SST data time = 0.03's, 313.916'MB/sec dict compress time = 4356233619.02's, 0.000'MB/sec z-dict build time = 0.00's, sample length = 0.277'MB, throughput = 6981.267'MB/sec zip my value time = 0.34's, unzip length = 0.027'GB zip my value throughput = 78.308'MB/sec zip pipeline throughput = 78.308'MB/sec entries = 231101 avg-key = 28.00 avg-zkey = 1.91 avg-val = 116.36 avg-zval = 40.63 usrkeys = 231101 avg-key = 20.00 avg-zkey = 1.91 avg-val = 123.36 avg-zval = 40.63 TagRS{ kinds = RS_Key0_Tag1 bytes = 0 } TagArray{ size = 231101 bytes = 751088 } seq expand size = 1617707 multi value expand size = 0 cnt WriteAppend = 13 UnZipSize{ index = 0.0046 GB value = 0.0269 GB dict = 0.28 MB all = 0.0334 GB } __ZipSize{ index = 0.0004 GB value = 0.0094 GB dict = 0.28 MB all = 0.0109 GB } UnZip/Zip{ index = 10.4817 value = 2.8641 dict = 1.00 all = 3.0720 } Zip/UnZip{ index = 0.0954 value = 0.3491 dict = 1.00 all = 0.3255 } ---------------------------- total value len = 0.544360 GB avg = 0.123 KB (by entry num) total key len = 0.123975 GB avg = 0.028 KB total ukey len = 0.088554 GB avg = 0.020 KB total ukey num = 0.004427694 Billion total entry num = 0.004427694 Billion write speed all = 0.021556773 MB/sec (with seq num) write speed all = 0.020414271 MB/sec (without seq num) 2024/07/09-22:15:57.613828 140433570997824 [compaction_job.cc:1944] [default] [JOB 61639] Generated table #12697377: 231101 keys, 10859776 bytes, temperature: kWarm 2024/07/09-22:15:57.613886 140433570997824 EVENT_LOG_v1 {"time_micros": 1720534557613857, "cf_name": "default", "job": 61639, "event": "table_file_creation", "file_number": 12697377, "file_size": 10859776, "file_checksum": "", "file_checksum_func_name": "Unknown", "smallest_seqno": 148696812405, "largest_seqno": 148762306087, "table_properties": {"data_size": 9388640, "index_size": 440960, "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": 6470828, "raw_average_key_size": 28, "raw_value_size": 26890290, "raw_average_value_size": 116, "num_data_blocks": 1, "num_entries": 231101, "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": 1720534556, "oldest_key_time": 0, "file_creation_time": 1720534556, "slow_compression_estimated_data_size": 0, "fast_compression_estimated_data_size": 0, "db_id": "a007a635-5c0a-4b4a-be96-b9c695cb016b", "db_session_id": "465QC0QPK7Q93426EREI", "orig_file_number": 12697377, "seqno_to_time_mapping": "N/A", "__indexstats__": "[...1 records...]"}} 2024/07/09-22:15:57.624369 140433570997824 [compaction_job.cc:699] job-61639: subcompact[0], size: 0.199607 G, files: /storage/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/mytopling/.rocksdb/job-61639/att-00 [12697368,12697369,12697370,12697371,12697372,12697373,12697374,12697375,12697376,12697377] 2024/07/09-22:15:57.673618 140433570997824 (Original Log Time 2024/07/09-22:15:29.947506) EVENT_LOG_v1 {"time_micros": 1720534529947464, "job": 61639, "event": "compaction_started", "compaction_reason": "FilesMarkedForCompaction", "files_L1": [12697350], "files_L2": [12697301, 12697302, 12697303, 12697304, 12697327, 12697328, 12697329, 12697330, 12697331], "score": 0.98105, "input_data_size": 222321417, "oldest_snapshot_seqno": 148764123538} 2024/07/09-22:15:57.673621 140433570997824 (Original Log Time 2024/07/09-22:15:57.672758) [compaction_job.cc:2018] [default] [JOB 61639] Compacted 1@1 + 9@2 files to L2 => 199606896 bytes 2024/07/09-22:15:57.673623 140433570997824 (Original Log Time 2024/07/09-22:15:57.673554) [compaction_job.cc:1220] [default] compacted to: files[0 0 10 0 0 0 0] max score 0.07, MB/sec: 8.0 rd, 7.2 wr, level 2, files in(1, 9) out(10 +0 blob) MB in(31.8, 180.2 +0.0 blob) out(190.4 +0.0 blob), read-write-amplify(12.7) write-amplify(6.0) OK, records in: 4427694, records dropped: 0 output_compression: Snappy 2024/07/09-22:15:57.673630 140433570997824 (Original Log Time 2024/07/09-22:15:57.673598) EVENT_LOG_v1 {"time_micros": 1720534557673579, "cf": "default", "job": 61639, "event": "compaction_finished", "compaction_time_micros": 27676870, "compaction_time_cpu_micros": 8595686, "output_level": 2, "num_output_files": 10, "total_output_size": 199606896, "num_input_records": 4427694, "num_output_records": 4427694, "num_subcompactions": 1, "output_compression": "Snappy", "num_single_delete_mismatches": 0, "num_single_delete_fallthrough": 0, "file_write_nanos": 210251330, "file_range_sync_nanos": 0, "file_fsync_nanos": 8906, "file_prepare_write_nanos": 31632, "lsm_state": [0, 0, 10, 0, 0, 0, 0]} 2024/07/09-22:15:57.778787 140433570997824 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":"a007a635-5c0a-4b4a-be96-b9c695cb016b","dbStarts":1720420896,"starts":1720534529,"executesMs":27827,"compactionJobId":61639,"attempt":0,"compactionInputRawBytes":637341564,"compactionInputZipBytes":222321417,"compactionOutputRawBytes":0,"compactionOutputZipBytes":199606896,"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-26e79829bf480b09896443a51aa545ed-3bc5baa28f4a32a2-00"}}, response = 2024/07/09-22:15:57.778871 140433570997824 INFO dcompact_worker.cpp:1456: finish /worker/dcompact-log/nfs/i-wz9deglxdazgiryp6ltb_10.57.5.137/2024-07-08T14.41.36/.rocksdb/job-61639/att-00: olev 2, work 27.828 s, result 6.647 ms, install 0.892 ms, input{raw 607.816 MiB zip 212.022 MiB}