2025-04-01 18:33:29 Using queries from '/repo/tests/queries' directory 2025-04-01 18:33:29 Connecting to ClickHouse server... OK 2025-04-01 18:33:29 Connected to server 24.12.2.20221.altinityantalya @ 82252d159dc02cab0f366aaa5691adc1545dd11d HEAD 2025-04-01 18:33:29 Won't run stateless tests because they were manually disabled. 2025-04-01 18:33:29 Found 133 parallel tests and 6 sequential tests 2025-04-01 18:33:30 Running about 66 stateful tests (Process-4). 2025-04-01 18:33:30 00086_array_reduce: [ OK ] 0.32 sec. 2025-04-01 18:33:30 Running about 66 stateful tests (Process-3). 2025-04-01 18:33:30 00096_obfuscator_save_load: [ OK ] 0.98 sec. 2025-04-01 18:33:31 00164_quantileBfloat16: [ OK ] 1.08 sec. 2025-04-01 18:33:31 00030_array_enumerate_uniq: [ OK ] 0.72 sec. 2025-04-01 18:33:33 00167_read_bytes_from_fs: [ OK ] 1.74 sec. 2025-04-01 18:33:35 00178_quantile_ddsketch: [ OK ] 2.27 sec. 2025-04-01 18:33:36 00038_uniq_state_merge2: [ OK ] 0.82 sec. 2025-04-01 18:33:36 00055_index_and_not: [ OK ] 0.22 sec. 2025-04-01 18:33:39 00184_parallel_hash_returns_same_res_as_hash: [ OK ] 2.88 sec. 2025-04-01 18:33:41 00020_distinct_order_by_distributed: [ OK ] 10.11 sec. 2025-04-01 18:33:41 00036_aggregate_hashed: [ OK ] 0.32 sec. 2025-04-01 18:33:42 00061_storage_buffer: [ OK ] 0.57 sec. 2025-04-01 18:33:42 00045_uniq_upto: [ OK ] 2.98 sec. 2025-04-01 18:33:43 00021_1_select_with_in: [ OK ] 0.47 sec. 2025-04-01 18:33:43 00171_grouping_aggregated_transform_bug: [ OK ] 0.77 sec. 2025-04-01 18:33:43 00047_bar: [ OK ] 0.32 sec. 2025-04-01 18:33:43 00009_uniq_distributed: [ OK ] 0.42 sec. 2025-04-01 18:33:43 00032_aggregate_key64: [ OK ] 0.27 sec. 2025-04-01 18:33:43 00022_merge_prewhere: [ OK ] 0.22 sec. 2025-04-01 18:33:44 00048_min_max: [ OK ] 0.17 sec. 2025-04-01 18:33:44 00175_counting_resources_in_subqueries: [ OK ] 0.32 sec. 2025-04-01 18:33:44 00153_aggregate_arena_race: [ OK ] 0.52 sec. 2025-04-01 18:33:44 00033_aggregate_key_string: [ OK ] 0.37 sec. 2025-04-01 18:33:47 00161_parallel_parsing_with_names: [ OK ] 2.58 sec. 2025-04-01 18:33:47 00031_array_enumerate_uniq: [ OK ] 0.22 sec. 2025-04-01 18:33:48 00159_parallel_formatting_http: [ OK ] 3.68 sec. 2025-04-01 18:33:48 00065_loyalty_with_storage_join: [ OK ] 0.67 sec. 2025-04-01 18:33:49 00072_compare_date_and_string_index: [ OK ] 1.37 sec. 2025-04-01 18:33:49 00143_transform_non_const_default: [ OK ] 0.27 sec. 2025-04-01 18:33:49 00151_order_by_read_in_order: [ OK ] 0.37 sec. 2025-04-01 18:33:49 00092_obfuscator: [ OK ] 1.16 sec. 2025-04-01 18:33:49 00015_totals_and_no_aggregate_functions: [ OK ] 0.27 sec. 2025-04-01 18:33:52 00077_log_tinylog_stripelog: [ OK ] 2.98 sec. 2025-04-01 18:33:53 00154_avro: [ OK ] 0.57 sec. 2025-04-01 18:33:55 00139_like: [ OK ] 2.43 sec. 2025-04-01 18:33:56 00004_top_counters: [ OK ] 0.22 sec. 2025-04-01 18:33:58 00146_aggregate_function_uniq: [ OK ] 1.82 sec. 2025-04-01 18:33:58 00094_order_by_array_join_limit: [ OK ] 0.87 sec. 2025-04-01 18:33:59 00174_distinct_in_order: [ OK ] 0.97 sec. 2025-04-01 18:34:01 00091_prewhere_two_conditions: [ OK ] 1.67 sec. 2025-04-01 18:34:01 00021_2_select_with_in: [ OK ] 0.17 sec. 2025-04-01 18:34:02 00148_monotonic_functions_and_index: [ OK ] 0.87 sec. 2025-04-01 18:34:02 00024_random_counters: [ OK ] 12.91 sec. 2025-04-01 18:34:03 00074_full_join: [ OK ] 0.77 sec. 2025-04-01 18:34:04 00095_hyperscan_profiler: [ OK ] 1.93 sec. 2025-04-01 18:34:05 00052_group_by_in: [ OK ] 1.82 sec. 2025-04-01 18:34:06 00147_global_in_aggregate_function: [ OK ] 0.87 sec. 2025-04-01 18:34:06 00013_sorting_of_nested: [ OK ] 1.37 sec. 2025-04-01 18:34:06 00142_system_columns: [ OK ] 0.22 sec. 2025-04-01 18:34:06 00006_agregates: [ OK ] 0.17 sec. 2025-04-01 18:34:07 00078_group_by_arrays: [ OK ] 1.22 sec. 2025-04-01 18:34:08 00089_position_functions_with_non_constant_arg: [ OK ] 1.87 sec. 2025-04-01 18:34:08 00051_min_max_array: [ OK ] 0.72 sec. 2025-04-01 18:34:08 00176_bson_parallel_parsing: [ SKIPPED ] 0.00 sec. 2025-04-01 18:34:08 Reason: disabled 2025-04-01 18:34:09 00011_sorting: [ OK ] 0.22 sec. 2025-04-01 18:34:10 00037_uniq_state_merge1: [ OK ] 0.97 sec. 2025-04-01 18:34:11 00169_contingency: [ OK ] 3.63 sec. 2025-04-01 18:34:15 00156_max_execution_speed_sample_merge: [ OK ] 4.33 sec. 2025-04-01 18:34:16 00167_parallel_parsing_with_names_and_types: [ OK ] 6.14 sec. 2025-04-01 18:34:16 00050_min_max: [ OK ] 0.42 sec. 2025-04-01 18:34:16 00098_primary_key_memory_allocated: [ OK ] 0.17 sec. 2025-04-01 18:34:18 00082_quantiles: [ OK ] 2.28 sec. 2025-04-01 18:34:18 00012_sorting_distributed: [ OK ] 0.27 sec. 2025-04-01 18:34:19 00163_column_oriented_formats: [ OK ] 3.08 sec. 2025-04-01 18:34:19 00059_merge_sorting_empty_array_joined: [ OK ] 1.07 sec. 2025-04-01 18:34:22 00046_uniq_upto_distributed: [ OK ] 2.68 sec. 2025-04-01 18:34:23 00040_aggregating_materialized_view: [ OK ] 0.77 sec. 2025-04-01 18:34:24 00080_array_join_and_union: [ OK ] 1.02 sec. 2025-04-01 18:34:27 00090_thread_pool_deadlock: [ OK ] 2.88 sec. 2025-04-01 18:34:27 00068_subquery_in_prewhere: [ OK ] 0.22 sec. 2025-04-01 18:34:28 00182_simple_squashing_transform_bug: [ OK ] 0.82 sec. 2025-04-01 18:34:28 00014_filtering_arrays: [ OK ] 0.22 sec. 2025-04-01 18:34:28 00097_constexpr_in_index: [ OK ] 0.12 sec. 2025-04-01 18:34:29 00087_where_0: [ OK ] 0.17 sec. 2025-04-01 18:34:29 00160_decode_xml_component: [ OK ] 0.87 sec. 2025-04-01 18:34:30 00067_union_all: [ OK ] 0.32 sec. 2025-04-01 18:34:30 00066_sorting_distributed_many_replicas: [ OK ] 0.12 sec. 2025-04-01 18:34:31 00145_aggregate_functions_statistics: [ OK ] 0.72 sec. 2025-04-01 18:34:31 00007_uniq: [ OK ] 0.17 sec. 2025-04-01 18:34:31 00017_aggregation_uninitialized_memory: [ OK ] 0.17 sec. 2025-04-01 18:34:31 00043_any_left_join: [ OK ] 0.32 sec. 2025-04-01 18:34:32 00001_count_hits: [ OK ] 0.17 sec. 2025-04-01 18:34:32 00081_group_by_without_key_and_totals: [ OK ] 0.27 sec. 2025-04-01 18:34:33 00172_hits_joins: [ OK ] 13.51 sec. 2025-04-01 18:34:33 00060_move_to_prewhere_and_sets: [ OK ] 0.27 sec. 2025-04-01 18:34:33 00181_cross_join_compression: [ OK ] 1.48 sec. 2025-04-01 18:34:34 00176_distinct_limit_by_limit_bug_43377: [ OK ] 0.22 sec. 2025-04-01 18:34:34 00088_global_in_one_shard_and_rows_before_limit: [ OK ] 0.47 sec. 2025-04-01 18:34:34 00021_3_select_with_in: [ OK ] 0.22 sec. 2025-04-01 18:34:40 00159_parallel_formatting_tsv_and_friends: [ OK ] 5.74 sec. 2025-04-01 18:34:40 00049_max_string_if: [ OK ] 0.42 sec. 2025-04-01 18:34:41 00034_aggregate_key_fixed_string: [ OK ] 0.42 sec. 2025-04-01 18:34:41 00141_transform: [ OK ] 0.22 sec. 2025-04-01 18:34:41 00083_array_filter: [ OK ] 0.32 sec. 2025-04-01 18:34:42 00063_loyalty_joins: [ OK ] 0.92 sec. 2025-04-01 18:34:43 00165_jit_aggregate_functions: [ OK ] 0.97 sec. 2025-04-01 18:34:43 00159_parallel_formatting_csv_and_friends: [ OK ] 10.51 sec. 2025-04-01 18:34:44 00085_monotonic_evaluation_segfault: [ OK ] 0.17 sec. 2025-04-01 18:34:48 00084_external_aggregation: [ OK ] 4.93 sec. 2025-04-01 18:34:49 00069_duplicate_aggregation_keys: [ OK ] 0.17 sec. 2025-04-01 18:34:49 00172_early_constant_folding: [ OK ] 0.17 sec. 2025-04-01 18:34:52 00044_any_left_join_string: [ OK ] 8.65 sec. 2025-04-01 18:34:53 00150_quantiles_timing_precision: [ OK ] 0.42 sec. 2025-04-01 18:34:53 00076_system_columns_bytes: [ OK ] 0.12 sec. 2025-04-01 18:34:54 00093_prewhere_array_join: [ OK ] 1.07 sec. 2025-04-01 18:34:54 00005_filtering: [ OK ] 0.17 sec. 2025-04-01 18:34:54 00144_functions_of_aggregation_states: [ OK ] 0.32 sec. 2025-04-01 18:34:55 00035_aggregate_keys128: [ OK ] 0.27 sec. 2025-04-01 18:34:55 00023_totals_limit: [ OK ] 0.17 sec. 2025-04-01 18:34:56 00041_aggregating_materialized_view: [ OK ] 0.77 sec. 2025-04-01 18:34:56 00042_any_left_join: [ OK ] 0.22 sec. 2025-04-01 18:34:56 00002_count_visits: [ OK ] 0.17 sec. 2025-04-01 18:34:56 00073_uniq_array: [ OK ] 0.18 sec. 2025-04-01 18:34:57 00062_loyalty: [ OK ] 0.22 sec. 2025-04-01 18:35:00 00159_parallel_formatting_json_and_friends_2: [ OK ] 11.40 sec. 2025-04-01 18:35:03 00177_memory_bound_merging: [ OK ] 2.52 sec. 2025-04-01 18:35:03 00079_array_join_not_used_joined_column: [ OK ] 0.62 sec. 2025-04-01 18:35:04 00075_left_array_join: [ OK ] 0.32 sec. 2025-04-01 18:35:04 00010_quantiles_segfault: [ OK ] 0.27 sec. 2025-04-01 18:35:05 00175_obfuscator_schema_inference: [ OK ] 1.27 sec. 2025-04-01 18:35:06 00039_primary_key: [ OK ] 0.17 sec. 2025-04-01 18:35:07 00162_mmap_compression_none: [ OK ] 1.17 sec. 2025-04-01 18:35:07 00056_view: [ OK ] 0.47 sec. 2025-04-01 18:35:08 00173_group_by_use_nulls: [ OK ] 0.77 sec. 2025-04-01 18:35:08 00016_any_if_distributed_cond_always_false: [ OK ] 0.32 sec. 2025-04-01 18:35:09 00054_merge_tree_partitions: [ OK ] 0.47 sec. 2025-04-01 18:35:09 00159_parallel_formatting_json_and_friends_1: [ OK ] 12.82 sec. 2025-04-01 18:35:10 00149_quantiles_timing_distributed: [ OK ] 0.72 sec. 2025-04-01 18:35:10 00166_explain_estimate: [ OK ] 0.17 sec. 2025-04-01 18:35:10 00183_prewhere_conditions_order: [ OK ] 0.17 sec. 2025-04-01 18:35:11 00071_merge_tree_optimize_aio: [ OK ] 1.07 sec. 2025-04-01 18:35:11 00008_uniq: [ OK ] 0.27 sec. 2025-04-01 18:35:11 2025-04-01 18:35:11 81 tests passed. 1 tests skipped. 101.58 s elapsed (Process-4). 2025-04-01 18:35:12 00053_replicate_segfault: [ OK ] 2.63 sec. 2025-04-01 18:35:12 2025-04-01 18:35:12 51 tests passed. 0 tests skipped. 102.98 s elapsed (Process-3). 2025-04-01 18:35:12 Running 6 stateful tests (MainProcess). 2025-04-01 18:35:20 00180_no_seek_avoiding_when_reading_from_cache: [ OK ] 7.75 sec. 2025-04-01 18:35:25 00170_s3_cache: [ OK ] 4.65 sec. 2025-04-01 18:36:18 00158_cache_dictionary_has: [ OK ] 52.94 sec. 2025-04-01 18:41:36 00157_cache_dictionary: [ FAIL ] 317.69 sec. 2025-04-01 18:41:36 Reason: return code: 160 2025-04-01 18:41:36 [a0aeba374f53] 2025.04.01 18:41:35.913657 [ 358 ] {53d3a29a-5f47-44ad-b74e-e288a4542854} executeQuery: Code: 160. DB::Exception: Estimated query execution time (679.89243 seconds) is too long. Maximum: 600. Estimated rows to process: 1000000 (466944 read in 317.47169 seconds).: While executing MergeTreeSelect(pool: ReadPool, algorithm: Thread). (TOO_SLOW) (version 24.12.2.20221.altinityantalya (altinity build)) (from [::1]:34500) (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:41:36 2025-04-01 18:41:36 0. ./build_docker/./src/Common/Exception.cpp:107: DB::Exception::Exception(DB::Exception::MessageMasked&&, int, bool) @ 0x000000000d78d79b 2025-04-01 18:41:36 1. DB::Exception::Exception(PreformattedMessage&&, int) @ 0x000000000867958c 2025-04-01 18:41:36 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&) @ 0x00000000112d8564 2025-04-01 18:41:36 3. ./build_docker/./src/QueryPipeline/ExecutionSpeedLimits.cpp:87: DB::ExecutionSpeedLimits::throttle(unsigned long, unsigned long, unsigned long, unsigned long, DB::OverflowMode) const @ 0x00000000112d7c8d 2025-04-01 18:41:36 4. ./build_docker/./src/QueryPipeline/ReadProgressCallback.cpp:131: DB::ReadProgressCallback::onProgress(unsigned long, unsigned long, std::list> const&) @ 0x00000000112d7149 2025-04-01 18:41:36 5. ./build_docker/./src/Processors/Executors/ExecutionThreadContext.cpp:64: DB::ExecutionThreadContext::executeTask() @ 0x00000000137a19a6 2025-04-01 18:41:36 6. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:290: DB::PipelineExecutor::executeStepImpl(unsigned long, std::atomic*) @ 0x0000000013794c25 2025-04-01 18:41:36 7. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:256: DB::PipelineExecutor::execute(unsigned long, bool) @ 0x0000000013793fb6 2025-04-01 18:41:36 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*) @ 0x00000000137930f7 2025-04-01 18:41:36 9. ./contrib/llvm-project/libcxx/include/__functional/function.h:848: ? @ 0x000000000d86a102 2025-04-01 18:41:36 10. ./contrib/llvm-project/libcxx/include/__functional/invoke.h:359: ? @ 0x000000000d8714ba 2025-04-01 18:41:36 11. ? @ 0x00007f4631733ac3 2025-04-01 18:41:36 12. ? @ 0x00007f46317c5850 2025-04-01 18:41:36 2025-04-01 18:41:36 Received exception from server (version 24.12.2): 2025-04-01 18:41:36 Code: 160. DB::Exception: Received from localhost:9000. DB::Exception: Estimated query execution time (679.89243 seconds) is too long. Maximum: 600. Estimated rows to process: 1000000 (466944 read in 317.47169 seconds).: While executing MergeTreeSelect(pool: ReadPool, algorithm: Thread). (TOO_SLOW) 2025-04-01 18:41:36 (query: INSERT INTO test.hits_1m SELECT * FROM test.hits LIMIT 1000000 2025-04-01 18:41:36 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:41:36 , result: 2025-04-01 18:41:36 2025-04-01 18:41:36 2025-04-01 18:41:36 2025-04-01 18:41:36 stdout: 2025-04-01 18:41:36 2025-04-01 18:41:36 2025-04-01 18:41:36 Settings used in the test: --max_insert_threads 3 --group_by_two_level_threshold 790818 --group_by_two_level_threshold_bytes 37869875 --distributed_aggregation_memory_efficient 1 --fsync_metadata 0 --output_format_parallel_formatting 0 --input_format_parallel_parsing 1 --min_chunk_bytes_for_parallel_parsing 12117072 --max_read_buffer_size 659232 --prefer_localhost_replica 0 --max_block_size 38090 --max_joined_block_size_rows 66467 --max_threads 3 --optimize_append_index 1 --optimize_if_chain_to_multiif 1 --optimize_if_transform_strings_to_enum 0 --optimize_read_in_order 0 --optimize_or_like_chain 0 --optimize_substitute_columns 0 --enable_multiple_prewhere_read_steps 1 --read_in_order_two_level_merge_threshold 32 --optimize_aggregation_in_order 1 --aggregation_in_order_max_block_bytes 19751245 --use_uncompressed_cache 1 --min_bytes_to_use_direct_io 10737418240 --min_bytes_to_use_mmap_io 10737418240 --local_filesystem_read_method mmap --remote_filesystem_read_method threadpool --local_filesystem_read_prefetch 0 --filesystem_cache_segments_batch_size 10 --read_from_filesystem_cache_if_exists_otherwise_bypass_cache 1 --throw_on_error_from_cache_on_write_operations 0 --remote_filesystem_read_prefetch 0 --allow_prefetched_read_pool_for_remote_filesystem 1 --filesystem_prefetch_max_memory_usage 64Mi --filesystem_prefetches_limit 0 --filesystem_prefetch_min_bytes_for_single_read_task 16Mi --filesystem_prefetch_step_marks 0 --filesystem_prefetch_step_bytes 100Mi --compile_aggregate_expressions 1 --compile_sort_description 1 --merge_tree_coarse_index_granularity 19 --optimize_distinct_in_order 1 --max_bytes_before_external_sort 10737418240 --max_bytes_before_external_group_by 10737418240 --max_bytes_before_remerge_sort 1949839215 --min_compress_block_size 1363597 --max_compress_block_size 3076398 --merge_tree_compact_parts_min_granules_to_multibuffer_read 68 --optimize_sorting_by_input_stream_properties 0 --http_response_buffer_size 2387489 --http_wait_end_of_query False --enable_memory_bound_merging_of_aggregation_results 1 --min_count_to_compile_expression 3 --min_count_to_compile_aggregate_expression 0 --min_count_to_compile_sort_description 0 --session_timezone America/Porto_Velho --use_page_cache_for_disks_without_file_cache True --page_cache_inject_eviction True --merge_tree_read_split_ranges_into_intersecting_and_non_intersecting_injection_probability 0.3 --prefer_external_sort_block_bytes 0 --cross_join_min_rows_to_compress 1 --cross_join_min_bytes_to_compress 100000000 --min_external_table_block_size_bytes 0 --max_parsing_threads 10 --optimize_functions_to_subcolumns 1 --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:41:36 2025-04-01 18:41:36 MergeTree settings used in test: --ratio_of_defaults_for_sparse_serialization 1.0 --prefer_fetch_merged_part_size_threshold 10737418240 --vertical_merge_algorithm_min_rows_to_activate 1 --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 5507071 --merge_max_block_size 17409 --index_granularity 3968 --min_bytes_for_wide_part 1073741824 --marks_compress_block_size 56498 --primary_key_compress_block_size 17851 --replace_long_file_name_to_hash 1 --max_file_name_length 128 --min_bytes_for_full_part_storage 536870912 --compact_parts_max_bytes_to_buffer 512707863 --compact_parts_max_granules_to_buffer 11 --compact_parts_merge_max_bytes_to_prefetch_part 9776071 --cache_populated_by_fetch 0 --concurrent_part_removal_threshold 100 --old_parts_lifetime 221 --prewarm_mark_cache 1 --use_const_adaptive_granularity 0 --enable_index_granularity_compression 1 --use_primary_key_cache 0 --prewarm_primary_key_cache 1 2025-04-01 18:41:36 2025-04-01 18:41:36 Database: test_2x9ug7ia 2025-04-01 18:43:12 00152_insert_different_granularity: [ OK ] 96.65 sec. 2025-04-01 18:43:13 00140_rename: [ OK ] 0.77 sec. 2025-04-01 18:43:13 2025-04-01 18:43:13 Having 1 errors! 5 tests passed. 0 tests skipped. 480.56 s elapsed (MainProcess). 2025-04-01 18:43:13 Checking the hung queries: done 2025-04-01 18:43:13 2025-04-01 18:43:13 No queries hung. 2025-04-01 18:43:13 All tests have finished.