2025-04-01 18:12:25 Using queries from '/repo/tests/queries' directory 2025-04-01 18:12:25 Connecting to ClickHouse server... OK 2025-04-01 18:12:25 Connected to server 24.12.2.20221.altinityantalya @ 82252d159dc02cab0f366aaa5691adc1545dd11d HEAD 2025-04-01 18:12:25 Won't run stateless tests because they were manually disabled. 2025-04-01 18:12:25 Found 133 parallel tests and 6 sequential tests 2025-04-01 18:12:25 Running about 66 stateful tests (Process-3). 2025-04-01 18:12:25 00176_distinct_limit_by_limit_bug_43377: [ OK ] 0.17 sec. 2025-04-01 18:12:26 Running about 66 stateful tests (Process-4). 2025-04-01 18:12:26 00008_uniq: [ OK ] 0.38 sec. 2025-04-01 18:12:26 00054_merge_tree_partitions: [ OK ] 0.63 sec. 2025-04-01 18:12:26 00065_loyalty_with_storage_join: [ OK ] 0.62 sec. 2025-04-01 18:12:27 00096_obfuscator_save_load: [ OK ] 0.87 sec. 2025-04-01 18:12:29 00161_parallel_parsing_with_names: [ OK ] 2.63 sec. 2025-04-01 18:12:29 00091_prewhere_two_conditions: [ OK ] 2.08 sec. 2025-04-01 18:12:30 00174_distinct_in_order: [ OK ] 0.89 sec. 2025-04-01 18:12:31 00089_position_functions_with_non_constant_arg: [ OK ] 2.04 sec. 2025-04-01 18:12:31 00182_simple_squashing_transform_bug: [ OK ] 1.04 sec. 2025-04-01 18:12:31 00183_prewhere_conditions_order: [ OK ] 0.17 sec. 2025-04-01 18:12:32 00049_max_string_if: [ OK ] 0.47 sec. 2025-04-01 18:12:32 00177_memory_bound_merging: [ OK ] 1.17 sec. 2025-04-01 18:12:32 00009_uniq_distributed: [ OK ] 0.32 sec. 2025-04-01 18:12:32 00004_top_counters: [ OK ] 0.22 sec. 2025-04-01 18:12:33 00030_array_enumerate_uniq: [ OK ] 0.42 sec. 2025-04-01 18:12:33 00141_transform: [ OK ] 0.22 sec. 2025-04-01 18:12:33 00151_order_by_read_in_order: [ OK ] 0.22 sec. 2025-04-01 18:12:33 00036_aggregate_hashed: [ OK ] 0.22 sec. 2025-04-01 18:12:33 00055_index_and_not: [ OK ] 0.17 sec. 2025-04-01 18:12:34 00071_merge_tree_optimize_aio: [ OK ] 1.32 sec. 2025-04-01 18:12:34 00022_merge_prewhere: [ OK ] 0.22 sec. 2025-04-01 18:12:35 00085_monotonic_evaluation_segfault: [ OK ] 1.52 sec. 2025-04-01 18:12:35 00154_avro: [ OK ] 0.47 sec. 2025-04-01 18:12:37 00184_parallel_hash_returns_same_res_as_hash: [ OK ] 2.53 sec. 2025-04-01 18:12:37 00059_merge_sorting_empty_array_joined: [ OK ] 1.57 sec. 2025-04-01 18:12:37 00149_quantiles_timing_distributed: [ OK ] 0.62 sec. 2025-04-01 18:12:38 00073_uniq_array: [ OK ] 0.17 sec. 2025-04-01 18:12:38 00051_min_max_array: [ OK ] 0.57 sec. 2025-04-01 18:12:38 00035_aggregate_keys128: [ OK ] 0.22 sec. 2025-04-01 18:12:38 00175_counting_resources_in_subqueries: [ OK ] 0.22 sec. 2025-04-01 18:12:38 00052_group_by_in: [ OK ] 0.52 sec. 2025-04-01 18:12:39 00002_count_visits: [ OK ] 0.52 sec. 2025-04-01 18:12:39 00144_functions_of_aggregation_states: [ OK ] 0.27 sec. 2025-04-01 18:12:39 00005_filtering: [ OK ] 0.17 sec. 2025-04-01 18:12:39 00012_sorting_distributed: [ OK ] 0.22 sec. 2025-04-01 18:12:39 00146_aggregate_function_uniq: [ OK ] 1.27 sec. 2025-04-01 18:12:40 00010_quantiles_segfault: [ OK ] 0.27 sec. 2025-04-01 18:12:40 00021_1_select_with_in: [ OK ] 0.27 sec. 2025-04-01 18:12:40 00007_uniq: [ OK ] 0.17 sec. 2025-04-01 18:12:40 00017_aggregation_uninitialized_memory: [ OK ] 0.17 sec. 2025-04-01 18:12:42 00013_sorting_of_nested: [ OK ] 2.28 sec. 2025-04-01 18:12:42 00150_quantiles_timing_precision: [ OK ] 0.37 sec. 2025-04-01 18:12:44 00080_array_join_and_union: [ OK ] 1.33 sec. 2025-04-01 18:12:47 00090_thread_pool_deadlock: [ OK ] 3.23 sec. 2025-04-01 18:12:47 00088_global_in_one_shard_and_rows_before_limit: [ OK ] 0.42 sec. 2025-04-01 18:12:48 00001_count_hits: [ OK ] 0.17 sec. 2025-04-01 18:12:48 00014_filtering_arrays: [ OK ] 0.22 sec. 2025-04-01 18:12:48 00066_sorting_distributed_many_replicas: [ OK ] 0.12 sec. 2025-04-01 18:12:49 00094_order_by_array_join_limit: [ OK ] 0.72 sec. 2025-04-01 18:12:49 00033_aggregate_key_string: [ OK ] 0.37 sec. 2025-04-01 18:12:49 00031_array_enumerate_uniq: [ OK ] 0.17 sec. 2025-04-01 18:12:51 00167_read_bytes_from_fs: [ OK ] 2.02 sec. 2025-04-01 18:12:51 00021_2_select_with_in: [ OK ] 0.12 sec. 2025-04-01 18:12:52 00081_group_by_without_key_and_totals: [ OK ] 0.27 sec. 2025-04-01 18:12:52 00048_min_max: [ OK ] 0.12 sec. 2025-04-01 18:12:52 00098_primary_key_memory_allocated: [ OK ] 0.12 sec. 2025-04-01 18:12:52 00143_transform_non_const_default: [ OK ] 0.27 sec. 2025-04-01 18:12:53 00092_obfuscator: [ OK ] 0.97 sec. 2025-04-01 18:12:54 00159_parallel_formatting_json_and_friends_1: [ OK ] 14.26 sec. 2025-04-01 18:12:55 00171_grouping_aggregated_transform_bug: [ OK ] 0.67 sec. 2025-04-01 18:12:55 00178_quantile_ddsketch: [ OK ] 2.13 sec. 2025-04-01 18:12:58 00046_uniq_upto_distributed: [ OK ] 2.38 sec. 2025-04-01 18:12:58 00038_uniq_state_merge2: [ OK ] 0.72 sec. 2025-04-01 18:12:58 00163_column_oriented_formats: [ OK ] 3.03 sec. 2025-04-01 18:12:59 00021_3_select_with_in: [ OK ] 0.17 sec. 2025-04-01 18:12:59 00056_view: [ OK ] 0.27 sec. 2025-04-01 18:12:59 00006_agregates: [ OK ] 0.22 sec. 2025-04-01 18:13:00 00061_storage_buffer: [ OK ] 0.57 sec. 2025-04-01 18:13:00 00060_move_to_prewhere_and_sets: [ OK ] 0.27 sec. 2025-04-01 18:13:01 00165_jit_aggregate_functions: [ OK ] 0.72 sec. 2025-04-01 18:13:01 00083_array_filter: [ OK ] 0.22 sec. 2025-04-01 18:13:01 00032_aggregate_key64: [ OK ] 0.22 sec. 2025-04-01 18:13:03 00156_max_execution_speed_sample_merge: [ OK ] 4.28 sec. 2025-04-01 18:13:03 00063_loyalty_joins: [ OK ] 1.32 sec. 2025-04-01 18:13:03 00068_subquery_in_prewhere: [ OK ] 0.22 sec. 2025-04-01 18:13:05 00041_aggregating_materialized_view: [ OK ] 2.38 sec. 2025-04-01 18:13:07 00082_quantiles: [ OK ] 1.73 sec. 2025-04-01 18:13:07 00176_bson_parallel_parsing: [ SKIPPED ] 0.00 sec. 2025-04-01 18:13:07 Reason: disabled 2025-04-01 18:13:09 00159_parallel_formatting_tsv_and_friends: [ OK ] 5.94 sec. 2025-04-01 18:13:10 00164_quantileBfloat16: [ OK ] 1.52 sec. 2025-04-01 18:13:11 00159_parallel_formatting_http: [ OK ] 4.43 sec. 2025-04-01 18:13:12 00047_bar: [ OK ] 0.22 sec. 2025-04-01 18:13:12 00016_any_if_distributed_cond_always_false: [ OK ] 0.22 sec. 2025-04-01 18:13:13 00147_global_in_aggregate_function: [ OK ] 1.12 sec. 2025-04-01 18:13:13 00040_aggregating_materialized_view: [ OK ] 3.38 sec. 2025-04-01 18:13:14 00042_any_left_join: [ OK ] 1.02 sec. 2025-04-01 18:13:14 00087_where_0: [ OK ] 0.17 sec. 2025-04-01 18:13:15 00072_compare_date_and_string_index: [ OK ] 1.53 sec. 2025-04-01 18:13:16 00053_replicate_segfault: [ OK ] 1.22 sec. 2025-04-01 18:13:19 00169_contingency: [ OK ] 4.43 sec. 2025-04-01 18:13:20 00095_hyperscan_profiler: [ OK ] 3.83 sec. 2025-04-01 18:13:30 00159_parallel_formatting_json_and_friends_2: [ OK ] 10.30 sec. 2025-04-01 18:13:31 00023_totals_limit: [ OK ] 0.87 sec. 2025-04-01 18:13:32 00044_any_left_join_string: [ OK ] 13.16 sec. 2025-04-01 18:13:32 00079_array_join_not_used_joined_column: [ OK ] 0.92 sec. 2025-04-01 18:13:33 00173_group_by_use_nulls: [ OK ] 0.72 sec. 2025-04-01 18:13:33 00015_totals_and_no_aggregate_functions: [ OK ] 0.17 sec. 2025-04-01 18:13:33 00175_obfuscator_schema_inference: [ OK ] 1.12 sec. 2025-04-01 18:13:34 00011_sorting: [ OK ] 0.17 sec. 2025-04-01 18:13:34 00153_aggregate_arena_race: [ OK ] 0.62 sec. 2025-04-01 18:13:34 00160_decode_xml_component: [ OK ] 1.42 sec. 2025-04-01 18:13:35 00086_array_reduce: [ OK ] 0.82 sec. 2025-04-01 18:13:38 00162_mmap_compression_none: [ OK ] 2.63 sec. 2025-04-01 18:13:38 00181_cross_join_compression: [ OK ] 0.57 sec. 2025-04-01 18:13:41 00084_external_aggregation: [ OK ] 6.64 sec. 2025-04-01 18:13:41 00097_constexpr_in_index: [ OK ] 0.12 sec. 2025-04-01 18:13:41 00062_loyalty: [ OK ] 0.17 sec. 2025-04-01 18:13:41 00069_duplicate_aggregation_keys: [ OK ] 0.17 sec. 2025-04-01 18:13:42 00075_left_array_join: [ OK ] 0.47 sec. 2025-04-01 18:13:47 00020_distinct_order_by_distributed: [ OK ] 8.65 sec. 2025-04-01 18:13:47 00043_any_left_join: [ OK ] 0.27 sec. 2025-04-01 18:13:48 00074_full_join: [ OK ] 0.67 sec. 2025-04-01 18:13:48 00050_min_max: [ OK ] 0.27 sec. 2025-04-01 18:13:49 00093_prewhere_array_join: [ OK ] 0.62 sec. 2025-04-01 18:13:50 00148_monotonic_functions_and_index: [ OK ] 0.67 sec. 2025-04-01 18:13:50 00145_aggregate_functions_statistics: [ OK ] 0.52 sec. 2025-04-01 18:13:50 00172_hits_joins: [ OK ] 8.25 sec. 2025-04-01 18:13:55 00077_log_tinylog_stripelog: [ OK ] 4.63 sec. 2025-04-01 18:13:55 00076_system_columns_bytes: [ OK ] 0.17 sec. 2025-04-01 18:13:55 00034_aggregate_key_fixed_string: [ OK ] 0.37 sec. 2025-04-01 18:14:01 00024_random_counters: [ OK ] 10.60 sec. 2025-04-01 18:14:06 00159_parallel_formatting_csv_and_friends: [ OK ] 10.10 sec. 2025-04-01 18:14:06 00167_parallel_parsing_with_names_and_types: [ OK ] 5.74 sec. 2025-04-01 18:14:07 00037_uniq_state_merge1: [ OK ] 0.92 sec. 2025-04-01 18:14:07 00166_explain_estimate: [ OK ] 0.17 sec. 2025-04-01 18:14:07 00142_system_columns: [ OK ] 0.17 sec. 2025-04-01 18:14:07 00067_union_all: [ OK ] 0.27 sec. 2025-04-01 18:14:08 00139_like: [ OK ] 1.62 sec. 2025-04-01 18:14:08 00172_early_constant_folding: [ OK ] 0.17 sec. 2025-04-01 18:14:10 00078_group_by_arrays: [ OK ] 2.88 sec. 2025-04-01 18:14:10 00039_primary_key: [ OK ] 0.17 sec. 2025-04-01 18:14:10 2025-04-01 18:14:10 80 tests passed. 1 tests skipped. 104.82 s elapsed (Process-3). 2025-04-01 18:14:11 00045_uniq_upto: [ OK ] 2.17 sec. 2025-04-01 18:14:11 2025-04-01 18:14:11 52 tests passed. 0 tests skipped. 105.40 s elapsed (Process-4). 2025-04-01 18:14:11 Running 6 stateful tests (MainProcess). 2025-04-01 18:14:20 00180_no_seek_avoiding_when_reading_from_cache: [ OK ] 9.00 sec. 2025-04-01 18:14:25 00170_s3_cache: [ OK ] 5.60 sec. 2025-04-01 18:14:48 00158_cache_dictionary_has: [ OK ] 22.64 sec. 2025-04-01 18:20:37 00157_cache_dictionary: [ FAIL ] 348.56 sec. 2025-04-01 18:20:37 Reason: return code: 160 2025-04-01 18:20:37 [feedd944810f] 2025.04.01 15:20:36.978871 [ 2588 ] {fe925cc0-6079-4c63-87cc-7bae30653d17} executeQuery: Code: 160. DB::Exception: Estimated query execution time (1288.65552 seconds) is too long. Maximum: 600. Estimated rows to process: 1000000 (270336 read in 348.36998 seconds).: While executing MergeTreeSelect(pool: ReadPool, algorithm: Thread). (TOO_SLOW) (version 24.12.2.20221.altinityantalya (altinity build)) (from [::1]:57018) (comment: 00157_cache_dictionary.sql) (in query: INSERT INTO test.hits_1m SELECT * FROM test.hits LIMIT 1000000 SETTINGS min_insert_block_size_rows = 0, min_insert_block_size_bytes = 0, max_block_size = 8192, max_insert_threads = 1, max_threads = 1, max_parallel_replicas=1;), Stack trace (when copying this message, always include the lines below): 2025-04-01 18:20:37 2025-04-01 18:20:37 0. ./contrib/llvm-project/libcxx/include/vector:676: DB::Exception::Exception(DB::Exception::MessageMasked&&, int, bool) @ 0x000000000c16d544 2025-04-01 18:20:37 1. DB::Exception::Exception(PreformattedMessage&&, int) @ 0x0000000007d8bf5c 2025-04-01 18:20:37 2. ./src/Common/Exception.h:123: DB::Exception::Exception(int, FormatStringHelperImpl::type, std::type_identity::type, std::type_identity::type, std::type_identity::type, std::type_identity::type>, double&, int&&, unsigned long&, unsigned long&, double&) @ 0x000000000f9353f4 2025-04-01 18:20:37 3. ./build_docker/./src/QueryPipeline/ExecutionSpeedLimits.cpp:87: DB::ExecutionSpeedLimits::throttle(unsigned long, unsigned long, unsigned long, unsigned long, DB::OverflowMode) const @ 0x000000000f934c38 2025-04-01 18:20:37 4. ./build_docker/./src/QueryPipeline/ReadProgressCallback.cpp:131: DB::ReadProgressCallback::onProgress(unsigned long, unsigned long, std::list> const&) @ 0x000000000f93429c 2025-04-01 18:20:37 5. ./build_docker/./src/Processors/Executors/ExecutionThreadContext.cpp:64: DB::ExecutionThreadContext::executeTask() @ 0x0000000011915d4c 2025-04-01 18:20:37 6. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:290: DB::PipelineExecutor::executeStepImpl(unsigned long, std::atomic*) @ 0x000000001190b214 2025-04-01 18:20:37 7. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:256: DB::PipelineExecutor::execute(unsigned long, bool) @ 0x000000001190a78c 2025-04-01 18:20:37 8. ./build_docker/./src/Processors/Executors/CompletedPipelineExecutor.cpp:49: void std::__function::__policy_invoker::__call_impl::ThreadFromGlobalPoolImpl(DB::CompletedPipelineExecutor::execute()::$_0&&)::'lambda'(), void ()>>(std::__function::__policy_storage const*) @ 0x0000000011909850 2025-04-01 18:20:37 9. ./contrib/llvm-project/libcxx/include/__functional/function.h:848: ? @ 0x000000000c235528 2025-04-01 18:20:37 10. ./contrib/llvm-project/libcxx/include/__functional/invoke.h:359: ? @ 0x000000000c23be9c 2025-04-01 18:20:37 11. ? @ 0x000000000007d5c8 2025-04-01 18:20:37 12. ? @ 0x00000000000e5edc 2025-04-01 18:20:37 2025-04-01 18:20:37 Received exception from server (version 24.12.2): 2025-04-01 18:20:37 Code: 160. DB::Exception: Received from localhost:9000. DB::Exception: Estimated query execution time (1288.65552 seconds) is too long. Maximum: 600. Estimated rows to process: 1000000 (270336 read in 348.36998 seconds).: While executing MergeTreeSelect(pool: ReadPool, algorithm: Thread). (TOO_SLOW) 2025-04-01 18:20:37 (query: INSERT INTO test.hits_1m SELECT * FROM test.hits LIMIT 1000000 2025-04-01 18:20:37 SETTINGS min_insert_block_size_rows = 0, min_insert_block_size_bytes = 0, max_block_size = 8192, max_insert_threads = 1, max_threads = 1, max_parallel_replicas=1;) 2025-04-01 18:20:37 , result: 2025-04-01 18:20:37 2025-04-01 18:20:37 2025-04-01 18:20:37 2025-04-01 18:20:37 stdout: 2025-04-01 18:20:37 2025-04-01 18:20:37 2025-04-01 18:20:37 Settings used in the test: --max_insert_threads 2 --group_by_two_level_threshold 296819 --group_by_two_level_threshold_bytes 1 --distributed_aggregation_memory_efficient 1 --fsync_metadata 1 --output_format_parallel_formatting 0 --input_format_parallel_parsing 1 --min_chunk_bytes_for_parallel_parsing 16131381 --max_read_buffer_size 724055 --prefer_localhost_replica 0 --max_block_size 8175 --max_joined_block_size_rows 94324 --max_threads 3 --optimize_append_index 1 --optimize_if_chain_to_multiif 1 --optimize_if_transform_strings_to_enum 1 --optimize_read_in_order 1 --optimize_or_like_chain 0 --optimize_substitute_columns 1 --enable_multiple_prewhere_read_steps 1 --read_in_order_two_level_merge_threshold 71 --optimize_aggregation_in_order 0 --aggregation_in_order_max_block_bytes 22682655 --use_uncompressed_cache 1 --min_bytes_to_use_direct_io 10737418240 --min_bytes_to_use_mmap_io 10737418240 --local_filesystem_read_method io_uring --remote_filesystem_read_method read --local_filesystem_read_prefetch 1 --filesystem_cache_segments_batch_size 100 --read_from_filesystem_cache_if_exists_otherwise_bypass_cache 1 --throw_on_error_from_cache_on_write_operations 1 --remote_filesystem_read_prefetch 1 --allow_prefetched_read_pool_for_remote_filesystem 1 --filesystem_prefetch_max_memory_usage 128Mi --filesystem_prefetches_limit 0 --filesystem_prefetch_min_bytes_for_single_read_task 1Mi --filesystem_prefetch_step_marks 50 --filesystem_prefetch_step_bytes 100Mi --compile_aggregate_expressions 0 --compile_sort_description 1 --merge_tree_coarse_index_granularity 21 --optimize_distinct_in_order 1 --max_bytes_before_external_sort 10737418240 --max_bytes_before_external_group_by 10737418240 --max_bytes_before_remerge_sort 521546779 --min_compress_block_size 1968936 --max_compress_block_size 2887626 --merge_tree_compact_parts_min_granules_to_multibuffer_read 43 --optimize_sorting_by_input_stream_properties 0 --http_response_buffer_size 8266019 --http_wait_end_of_query True --enable_memory_bound_merging_of_aggregation_results 0 --min_count_to_compile_expression 3 --min_count_to_compile_aggregate_expression 0 --min_count_to_compile_sort_description 0 --session_timezone America/Hermosillo --use_page_cache_for_disks_without_file_cache False --page_cache_inject_eviction False --merge_tree_read_split_ranges_into_intersecting_and_non_intersecting_injection_probability 0.08 --prefer_external_sort_block_bytes 1 --cross_join_min_rows_to_compress 0 --cross_join_min_bytes_to_compress 0 --min_external_table_block_size_bytes 0 --max_parsing_threads 1 --optimize_functions_to_subcolumns 0 --parallel_replicas_local_plan 0 --query_plan_join_swap_table true --output_format_native_write_json_as_string 1 --enable_vertical_final 0 2025-04-01 18:20:37 2025-04-01 18:20:37 MergeTree settings used in test: --ratio_of_defaults_for_sparse_serialization 0.0 --prefer_fetch_merged_part_size_threshold 6348167235 --vertical_merge_algorithm_min_rows_to_activate 1000000 --vertical_merge_algorithm_min_columns_to_activate 1 --allow_vertical_merges_from_compact_to_wide_parts 1 --min_merge_bytes_to_use_direct_io 1 --index_granularity_bytes 30744927 --merge_max_block_size 20053 --index_granularity 65225 --min_bytes_for_wide_part 306096821 --marks_compress_block_size 50367 --primary_key_compress_block_size 82671 --replace_long_file_name_to_hash 0 --max_file_name_length 0 --min_bytes_for_full_part_storage 536870912 --compact_parts_max_bytes_to_buffer 144887033 --compact_parts_max_granules_to_buffer 176 --compact_parts_merge_max_bytes_to_prefetch_part 18244185 --cache_populated_by_fetch 1 --concurrent_part_removal_threshold 100 --old_parts_lifetime 264 --prewarm_mark_cache 1 --use_const_adaptive_granularity 1 --enable_index_granularity_compression 1 --use_primary_key_cache 0 --prewarm_primary_key_cache 0 2025-04-01 18:20:37 2025-04-01 18:20:37 Database: test_v8muq7zi 2025-04-01 18:22:59 00152_insert_different_granularity: [ OK ] 142.74 sec. 2025-04-01 18:23:03 00140_rename: [ OK ] 3.58 sec. 2025-04-01 18:23:03 2025-04-01 18:23:03 Having 1 errors! 5 tests passed. 0 tests skipped. 532.23 s elapsed (MainProcess). 2025-04-01 18:23:03 Checking the hung queries: done 2025-04-01 18:23:03 2025-04-01 18:23:03 No queries hung. 2025-04-01 18:23:03 All tests have finished.