2024-09-24 09:18:02 Using queries from '/usr/share/clickhouse-test/queries' directory
2024-09-24 09:18:02 Connecting to ClickHouse server... OK
2024-09-24 09:18:02 Won't run stateless tests because they were manually disabled.
2024-09-24 09:18:02 Found 126 parallel tests and 5 sequential tests
2024-09-24 09:18:02 
2024-09-24 09:18:02 Running about 63 stateful tests (ForkPoolWorker-2).
2024-09-24 09:18:02 
2024-09-24 09:18:02 00176_distinct_limit_by_limit_bug_43377:                                [ OK ] 0.57 sec.
2024-09-24 09:18:03 00176_bson_parallel_parsing:                                            [ SKIPPED ] 0.00 sec. - disabled
2024-09-24 09:18:06 
2024-09-24 09:18:06 Running about 63 stateful tests (ForkPoolWorker-3).
2024-09-24 09:18:06 
2024-09-24 09:18:06 00177_memory_bound_merging:                                             [ OK ] 4.12 sec.
2024-09-24 09:18:06 00175_obfuscator_schema_inference:                                      [ OK ] 3.42 sec.
2024-09-24 09:18:07 00175_counting_resources_in_subqueries:                                 [ OK ] 0.80 sec.
2024-09-24 09:18:09 00174_distinct_in_order:                                                [ OK ] 2.41 sec.
2024-09-24 09:18:10 00173_group_by_use_nulls:                                               [ OK ] 2.96 sec.
2024-09-24 09:18:11 00172_early_constant_folding:                                           [ OK ] 0.40 sec.
2024-09-24 09:18:17 00171_grouping_aggregated_transform_bug:                                [ OK ] 6.51 sec.
2024-09-24 09:18:34 00172_hits_joins:                                                       [ OK ] 25.62 sec.
2024-09-24 09:18:35 00169_contingency:                                                      [ OK ] 17.48 sec.
2024-09-24 09:18:53 00167_parallel_parsing_with_names_and_types:                            [ OK ] 18.14 sec.
2024-09-24 09:18:53 00167_read_bytes_from_fs:                                               [ OK ] 18.11 sec.
2024-09-24 09:18:53 00166_explain_estimate:                                                 [ OK ] 0.42 sec.
2024-09-24 09:18:57 00164_quantileBfloat16:                                                 [ OK ] 3.79 sec.
2024-09-24 09:18:59 00165_jit_aggregate_functions:                                          [ OK ] 5.51 sec.
2024-09-24 09:19:06 00163_column_oriented_formats:                                          [ OK ] 8.83 sec.
2024-09-24 09:19:07 00162_mmap_compression_none:                                            [ OK ] 8.63 sec.
2024-09-24 09:19:10 00160_decode_xml_component:                                             [ OK ] 2.85 sec.
2024-09-24 09:19:14 00161_parallel_parsing_with_names:                                      [ OK ] 8.12 sec.
2024-09-24 09:19:23 00159_parallel_formatting_http:                                         [ OK ] 12.80 sec.
2024-09-24 09:19:57 00159_parallel_formatting_tsv_and_friends:                              [ OK ] 33.35 sec.
2024-09-24 09:20:18 00159_parallel_formatting_json_and_friends:                             [ OK ] 63.82 sec.
2024-09-24 09:20:22 00159_parallel_formatting_csv_and_friends:                              [ OK ] 24.78 sec.
2024-09-24 09:20:23 00154_avro:                                                             [ OK ] 1.17 sec.
2024-09-24 09:20:23 00156_max_execution_speed_sample_merge:                                 [ OK ] 4.58 sec.
2024-09-24 09:20:24 00151_order_by_read_in_order:                                           [ OK ] 0.91 sec.
2024-09-24 09:20:25 00153_aggregate_arena_race:                                             [ OK ] 1.67 sec.
2024-09-24 09:20:25 00150_quantiles_timing_precision:                                       [ OK ] 0.81 sec.
2024-09-24 09:20:31 00149_quantiles_timing_distributed:                                     [ OK ] 6.43 sec.
2024-09-24 09:20:32 00148_monotonic_functions_and_index:                                    [ OK ] 7.16 sec.
2024-09-24 09:20:35 00147_global_in_aggregate_function:                                     [ OK ] 4.01 sec.
2024-09-24 09:20:38 00146_aggregate_function_uniq:                                          [ OK ] 4.99 sec.
2024-09-24 09:20:38 00145_aggregate_functions_statistics:                                   [ OK ] 2.04 sec.
2024-09-24 09:20:38 00144_functions_of_aggregation_states:                                  [ OK ] 0.77 sec.
2024-09-24 09:20:39 00143_transform_non_const_default:                                      [ OK ] 0.95 sec.
2024-09-24 09:20:39 00142_system_columns:                                                   [ OK ] 0.34 sec.
2024-09-24 09:20:39 00141_transform:                                                        [ OK ] 0.39 sec.
2024-09-24 09:20:40 00097_constexpr_in_index:                                               [ OK ] 0.42 sec.
2024-09-24 09:20:43 00096_obfuscator_save_load:                                             [ OK ] 3.07 sec.
2024-09-24 09:20:44 00139_like:                                                             [ OK ] 5.30 sec.
2024-09-24 09:20:47 00094_order_by_array_join_limit:                                        [ OK ] 2.85 sec.
2024-09-24 09:20:48 00095_hyperscan_profiler:                                               [ OK ] 5.11 sec.
2024-09-24 09:20:51 00093_prewhere_array_join:                                              [ OK ] 3.05 sec.
2024-09-24 09:20:52 00092_obfuscator:                                                       [ OK ] 3.51 sec.
2024-09-24 09:21:11 00091_prewhere_two_conditions:                                          [ OK ] 20.48 sec.
2024-09-24 09:21:14 00090_thread_pool_deadlock:                                             [ OK ] 22.22 sec.
2024-09-24 09:21:17 00088_global_in_one_shard_and_rows_before_limit:                        [ FAIL ] 2.29 sec. - return code: 241
2024-09-24 09:21:17 [aa08eedc8d2f] 2024.09.24 09:21:16.771636 [ 1776 ] {c36c4a19-9cf3-42ab-b35b-e940cc9f181d} <Error> executeQuery: Code: 241. DB::Exception: Memory limit (total) exceeded: would use 27.72 GiB (attempt to allocate chunk of 1114397 bytes), maximum: 27.55 GiB. OvercommitTracker decision: Memory overcommit has freed not enough memory.: (while reading column UserID): (while reading from part /var/lib/clickhouse/store/5f5/5f55316c-8657-4e60-b714-e6ae3b6e5743/201403_10_18_2/ in table test.hits (5f55316c-8657-4e60-b714-e6ae3b6e5743) located on disk default of type local, from mark 0 with max_rows_to_read = 19001): While executing MergeTreeThread. (MEMORY_LIMIT_EXCEEDED) (version 23.8.16.41.altinitystable (altinity build)) (from [::1]:54706) (comment: 00088_global_in_one_shard_and_rows_before_limit.sql) (in query: SELECT EventDate, count() FROM remote('127.0.0.1', test.hits) WHERE UserID GLOBAL IN (SELECT UserID FROM test.hits) GROUP BY EventDate ORDER BY EventDate LIMIT 5 FORMAT JSONCompact;), Stack trace (when copying this message, always include the lines below):
2024-09-24 09:21:17 
2024-09-24 09:21:17 0. ./build_docker/./contrib/llvm-project/libcxx/include/exception:134: Poco::Exception::Exception(String const&, int) @ 0x000000003e077d33 in /usr/bin/clickhouse
2024-09-24 09:21:17 1. ./build_docker/./src/Common/Exception.cpp:98: DB::Exception::Exception(DB::Exception::MessageMasked&&, int, bool) @ 0x000000001d5c5dd0 in /usr/bin/clickhouse
2024-09-24 09:21:17 2. ./build_docker/./contrib/llvm-project/libcxx/include/string:1499: DB::Exception::Exception<char const*, char const*, String, long&, String, char const*, std::basic_string_view<char, std::char_traits<char>>>(int, FormatStringHelperImpl<std::type_identity<char const*>::type, std::type_identity<char const*>::type, std::type_identity<String>::type, std::type_identity<long&>::type, std::type_identity<String>::type, std::type_identity<char const*>::type, std::type_identity<std::basic_string_view<char, std::char_traits<char>>>::type>, char const*&&, char const*&&, String&&, long&, String&&, char const*&&, std::basic_string_view<char, std::char_traits<char>>&&) @ 0x000000001d60ab71 in /usr/bin/clickhouse
2024-09-24 09:21:17 3. ./build_docker/./src/Common/MemoryTracker.cpp:340: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d608239 in /usr/bin/clickhouse
2024-09-24 09:21:17 4. ./build_docker/./src/Common/MemoryTracker.cpp:0: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d607bf4 in /usr/bin/clickhouse
2024-09-24 09:21:17 5. ./build_docker/./src/Common/MemoryTracker.cpp:0: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d607bf4 in /usr/bin/clickhouse
2024-09-24 09:21:17 6. ./build_docker/./src/Common/MemoryTracker.cpp:0: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d607bf4 in /usr/bin/clickhouse
2024-09-24 09:21:17 7. ./build_docker/./src/Common/CurrentMemoryTracker.cpp:59: CurrentMemoryTracker::alloc(long) @ 0x000000001d534f9d in /usr/bin/clickhouse
2024-09-24 09:21:17 8. ./build_docker/./src/Common/Allocator.h:102: Allocator<false, false>::alloc(unsigned long, unsigned long) @ 0x000000001d52966f in /usr/bin/clickhouse
2024-09-24 09:21:17 9. void DB::PODArrayBase<8ul, 4096ul, Allocator<false, false>, 63ul, 64ul>::resize<>(unsigned long) @ 0x000000000bd861c5 in /usr/bin/clickhouse
2024-09-24 09:21:17 10. ./build_docker/./src/Common/PODArray.h:321: DB::SerializationNumber<unsigned long>::deserializeBinaryBulk(DB::IColumn&, DB::ReadBuffer&, unsigned long, double) const @ 0x000000002f211566 in /usr/bin/clickhouse
2024-09-24 09:21:17 11. ./build_docker/./src/DataTypes/Serializations/ISerialization.cpp:0: DB::ISerialization::deserializeBinaryBulkWithMultipleStreams(COW<DB::IColumn>::immutable_ptr<DB::IColumn>&, unsigned long, DB::ISerialization::DeserializeBinaryBulkSettings&, std::shared_ptr<DB::ISerialization::DeserializeBinaryBulkState>&, std::unordered_map<String, COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::hash<String>, std::equal_to<String>, std::allocator<std::pair<String const, COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>>*) const @ 0x000000002f1387fe in /usr/bin/clickhouse
2024-09-24 09:21:17 12. ./build_docker/./contrib/boost/boost/smart_ptr/intrusive_ptr.hpp:196: DB::MergeTreeReaderWide::readData(DB::NameAndTypePair const&, std::shared_ptr<DB::ISerialization const> const&, COW<DB::IColumn>::immutable_ptr<DB::IColumn>&, unsigned long, bool, unsigned long, unsigned long, std::unordered_map<String, COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::hash<String>, std::equal_to<String>, std::allocator<std::pair<String const, COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>>&, bool) @ 0x000000003443c4ea in /usr/bin/clickhouse
2024-09-24 09:21:17 13. ./build_docker/./src/Storages/MergeTree/MergeTreeReaderWide.cpp:159: DB::MergeTreeReaderWide::readRows(unsigned long, unsigned long, bool, unsigned long, std::vector<COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::allocator<COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>&) @ 0x000000003443ae0c in /usr/bin/clickhouse
2024-09-24 09:21:17 14. ./build_docker/./src/Storages/MergeTree/MergeTreeRangeReader.cpp:107: DB::MergeTreeRangeReader::DelayedStream::finalize(std::vector<COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::allocator<COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>&) @ 0x0000000034481a8b in /usr/bin/clickhouse
2024-09-24 09:21:17 15. ./build_docker/./src/Storages/MergeTree/MergeTreeRangeReader.cpp:0: DB::MergeTreeRangeReader::startReadingChain(unsigned long, DB::MarkRanges&) @ 0x000000003449f7ea in /usr/bin/clickhouse
2024-09-24 09:21:17 16. ./build_docker/./src/Storages/MergeTree/MergeTreeRangeReader.cpp:0: DB::MergeTreeRangeReader::read(unsigned long, DB::MarkRanges&) @ 0x000000003449a2a1 in /usr/bin/clickhouse
2024-09-24 09:21:17 17. ./build_docker/./src/Storages/MergeTree/MergeTreeBaseSelectProcessor.cpp:398: DB::IMergeTreeSelectAlgorithm::readFromPartImpl() @ 0x0000000034475d99 in /usr/bin/clickhouse
2024-09-24 09:21:17 18. ./build_docker/./src/Storages/MergeTree/MergeTreeBaseSelectProcessor.cpp:441: DB::IMergeTreeSelectAlgorithm::readFromPart() @ 0x00000000344775c4 in /usr/bin/clickhouse
2024-09-24 09:21:17 19. ./build_docker/./src/Storages/MergeTree/MergeTreeBaseSelectProcessor.cpp:0: DB::IMergeTreeSelectAlgorithm::read() @ 0x000000003446fc60 in /usr/bin/clickhouse
2024-09-24 09:21:17 20. ./build_docker/./src/Storages/MergeTree/MergeTreeSource.cpp:181: DB::MergeTreeSource::tryGenerate() @ 0x0000000035d28b78 in /usr/bin/clickhouse
2024-09-24 09:21:17 21. ./build_docker/./contrib/llvm-project/libcxx/include/optional:344: DB::ISource::work() @ 0x0000000034fcc465 in /usr/bin/clickhouse
2024-09-24 09:21:17 22. ./build_docker/./src/Processors/Executors/ExecutionThreadContext.cpp:0: DB::ExecutionThreadContext::executeTask() @ 0x0000000035012b2e in /usr/bin/clickhouse
2024-09-24 09:21:17 23. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:251: DB::PipelineExecutor::executeStepImpl(unsigned long, std::atomic<bool>*) @ 0x0000000034ff53dc in /usr/bin/clickhouse
2024-09-24 09:21:17 24. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:359: void std::__function::__policy_invoker<void ()>::__call_impl<std::__function::__default_alloc_func<DB::PipelineExecutor::spawnThreads()::$_0, void ()>>(std::__function::__policy_storage const*) @ 0x0000000034ff8262 in /usr/bin/clickhouse
2024-09-24 09:21:17 25. ./build_docker/./base/base/../base/wide_integer_impl.h:809: ThreadPoolImpl<ThreadFromGlobalPoolImpl<false>>::worker(std::__list_iterator<ThreadFromGlobalPoolImpl<false>, void*>) @ 0x000000001d8a9b9c in /usr/bin/clickhouse
2024-09-24 09:21:17 26. ./build_docker/./src/Common/ThreadPool.h:243: ThreadFromGlobalPoolImpl<false>::ThreadFromGlobalPoolImpl<void ThreadPoolImpl<ThreadFromGlobalPoolImpl<false>>::scheduleImpl<void>(std::function<void ()>, Priority, std::optional<unsigned long>, bool)::'lambda0'()>(void&&)::'lambda'()::operator()() @ 0x000000001d8b4000 in /usr/bin/clickhouse
2024-09-24 09:21:17 27. ./build_docker/./base/base/../base/wide_integer_impl.h:809: ThreadPoolImpl<std::thread>::worker(std::__list_iterator<std::thread, void*>) @ 0x000000001d8a0692 in /usr/bin/clickhouse
2024-09-24 09:21:17 28. ./build_docker/./contrib/llvm-project/libcxx/include/__memory/unique_ptr.h:302: void* std::__thread_proxy[abi:v15000]<std::tuple<std::unique_ptr<std::__thread_struct, std::default_delete<std::__thread_struct>>, void ThreadPoolImpl<std::thread>::scheduleImpl<void>(std::function<void ()>, Priority, std::optional<unsigned long>, bool)::'lambda0'()>>(void*) @ 0x000000001d8ae96d in /usr/bin/clickhouse
2024-09-24 09:21:17 29. ? @ 0x00007f9fadd0cac3 in ?
2024-09-24 09:21:17 30. ? @ 0x00007f9fadd9da04 in ?
2024-09-24 09:21:17 
2024-09-24 09:21:17 Received exception from server (version 23.8.16):
2024-09-24 09:21:17 Code: 241. DB::Exception: Received from localhost:9000. DB::Exception: Memory limit (total) exceeded: would use 27.72 GiB (attempt to allocate chunk of 1114397 bytes), maximum: 27.55 GiB. OvercommitTracker decision: Memory overcommit has freed not enough memory.: (while reading column UserID): (while reading from part /var/lib/clickhouse/store/5f5/5f55316c-8657-4e60-b714-e6ae3b6e5743/201403_10_18_2/ in table test.hits (5f55316c-8657-4e60-b714-e6ae3b6e5743) located on disk default of type local, from mark 0 with max_rows_to_read = 19001): While executing MergeTreeThread. (MEMORY_LIMIT_EXCEEDED)
2024-09-24 09:21:17 (query: SELECT EventDate, count() FROM remote('127.0.0.1', test.hits) WHERE UserID GLOBAL IN (SELECT UserID FROM test.hits) GROUP BY EventDate ORDER BY EventDate LIMIT 5 FORMAT JSONCompact;)
2024-09-24 09:21:17 , result:
2024-09-24 09:21:17 
2024-09-24 09:21:17 {
2024-09-24 09:21:17 	"meta":
2024-09-24 09:21:17 	[
2024-09-24 09:21:17 		{
2024-09-24 09:21:17 			"name": "EventDate",
2024-09-24 09:21:17 			"type": "Date"
2024-09-24 09:21:17 		},
2024-09-24 09:21:17 		{
2024-09-24 09:21:17 			"name": "count()",
2024-09-24 09:21:17 			"type": "UInt64"
2024-09-24 09:21:17 		}
2024-09-24 09:21:17 	],
2024-09-24 09:21:17 
2024-09-24 09:21:17 	"data":
2024-09-24 09:21:17 	[
2024-09-24 09:21:17 
2024-09-24 09:21:17 	],
2024-09-24 09:21:17 
2024-09-24 09:21:17 	"rows": 0
2024-09-24 09:21:17 }
2024-09-24 09:21:17 
2024-09-24 09:21:17 stdout:
2024-09-24 09:21:17 {
2024-09-24 09:21:17 	"meta":
2024-09-24 09:21:17 	[
2024-09-24 09:21:17 		{
2024-09-24 09:21:17 			"name": "EventDate",
2024-09-24 09:21:17 			"type": "Date"
2024-09-24 09:21:17 		},
2024-09-24 09:21:17 		{
2024-09-24 09:21:17 			"name": "count()",
2024-09-24 09:21:17 			"type": "UInt64"
2024-09-24 09:21:17 		}
2024-09-24 09:21:17 	],
2024-09-24 09:21:17 
2024-09-24 09:21:17 	"data":
2024-09-24 09:21:17 	[
2024-09-24 09:21:17 
2024-09-24 09:21:17 	],
2024-09-24 09:21:17 
2024-09-24 09:21:17 	"rows": 0
2024-09-24 09:21:17 }
2024-09-24 09:21:17 
2024-09-24 09:21:17 
2024-09-24 09:21:17 Settings used in the test: --max_insert_threads 15 --group_by_two_level_threshold 297654 --group_by_two_level_threshold_bytes 1 --distributed_aggregation_memory_efficient 0 --fsync_metadata 1 --output_format_parallel_formatting 0 --input_format_parallel_parsing 0 --min_chunk_bytes_for_parallel_parsing 6421804 --max_read_buffer_size 617210 --prefer_localhost_replica 0 --max_block_size 19001 --max_threads 13 --optimize_or_like_chain 0 --optimize_read_in_order 0 --enable_multiple_prewhere_read_steps 1 --read_in_order_two_level_merge_threshold 67 --optimize_aggregation_in_order 0 --aggregation_in_order_max_block_bytes 44251245 --min_compress_block_size 619213 --max_compress_block_size 466766 --use_uncompressed_cache 0 --min_bytes_to_use_direct_io 10737418240 --min_bytes_to_use_mmap_io 10737418240 --local_filesystem_read_method pread_threadpool --remote_filesystem_read_method read --local_filesystem_read_prefetch 1 --remote_filesystem_read_prefetch 0 --allow_prefetched_read_pool_for_remote_filesystem 0 --filesystem_prefetch_max_memory_usage 32Mi --filesystem_prefetches_limit 10 --filesystem_prefetch_min_bytes_for_single_read_task 1Mi --filesystem_prefetch_step_marks 0 --filesystem_prefetch_step_bytes 0 --compile_aggregate_expressions 1 --compile_sort_description 1 --merge_tree_coarse_index_granularity 12 --optimize_distinct_in_order 1 --optimize_sorting_by_input_stream_properties 0 --http_response_buffer_size 5812125 --http_wait_end_of_query True --enable_memory_bound_merging_of_aggregation_results 0 --min_count_to_compile_expression 0 --min_count_to_compile_aggregate_expression 0 --min_count_to_compile_sort_description 0 --session_timezone Australia/Melbourne
2024-09-24 09:21:17 
2024-09-24 09:21:17 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 1000000 --vertical_merge_algorithm_min_columns_to_activate 100 --allow_vertical_merges_from_compact_to_wide_parts 0 --min_merge_bytes_to_use_direct_io 1 --index_granularity_bytes 30212458 --merge_max_block_size 21020 --index_granularity 65047 --min_bytes_for_wide_part 1073741824 --marks_compress_block_size 82739 --primary_key_compress_block_size 13953
2024-09-24 09:21:17 
2024-09-24 09:21:17 Database: test_pctw3i74
2024-09-24 09:21:17 00089_position_functions_with_non_constant_arg:                         [ FAIL ] 6.16 sec. - return code: 241
2024-09-24 09:21:17 [aa08eedc8d2f] 2024.09.24 01:21:17.277583 [ 1778 ] {af48bfb0-7942-4f3a-a580-43d97bbe94c3} <Error> executeQuery: Code: 241. DB::Exception: Memory limit (total) exceeded: would use 27.55 GiB (attempt to allocate chunk of 2883584 bytes), maximum: 27.55 GiB. OvercommitTracker decision: Memory overcommit has freed not enough memory.: (while reading column URL): (while reading from part /var/lib/clickhouse/store/5f5/5f55316c-8657-4e60-b714-e6ae3b6e5743/201403_10_18_2/ in table test.hits (5f55316c-8657-4e60-b714-e6ae3b6e5743) located on disk default of type local, from mark 40 with max_rows_to_read = 8192): While executing MergeTreeThread. (MEMORY_LIMIT_EXCEEDED) (version 23.8.16.41.altinitystable (altinity build)) (from [::1]:54676) (comment: 00089_position_functions_with_non_constant_arg.sql) (in query: SELECT count() FROM test.hits WHERE position(URL, 'metrika') != position(URL, materialize('metrika'));), Stack trace (when copying this message, always include the lines below):
2024-09-24 09:21:17 
2024-09-24 09:21:17 0. ./build_docker/./contrib/llvm-project/libcxx/include/exception:134: Poco::Exception::Exception(String const&, int) @ 0x000000003e077d33 in /usr/bin/clickhouse
2024-09-24 09:21:17 1. ./build_docker/./src/Common/Exception.cpp:98: DB::Exception::Exception(DB::Exception::MessageMasked&&, int, bool) @ 0x000000001d5c5dd0 in /usr/bin/clickhouse
2024-09-24 09:21:17 2. ./build_docker/./contrib/llvm-project/libcxx/include/string:1499: DB::Exception::Exception<char const*, char const*, String, long&, String, char const*, std::basic_string_view<char, std::char_traits<char>>>(int, FormatStringHelperImpl<std::type_identity<char const*>::type, std::type_identity<char const*>::type, std::type_identity<String>::type, std::type_identity<long&>::type, std::type_identity<String>::type, std::type_identity<char const*>::type, std::type_identity<std::basic_string_view<char, std::char_traits<char>>>::type>, char const*&&, char const*&&, String&&, long&, String&&, char const*&&, std::basic_string_view<char, std::char_traits<char>>&&) @ 0x000000001d60ab71 in /usr/bin/clickhouse
2024-09-24 09:21:17 3. ./build_docker/./src/Common/MemoryTracker.cpp:340: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d608239 in /usr/bin/clickhouse
2024-09-24 09:21:17 4. ./build_docker/./src/Common/MemoryTracker.cpp:0: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d607bf4 in /usr/bin/clickhouse
2024-09-24 09:21:17 5. ./build_docker/./src/Common/MemoryTracker.cpp:0: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d607bf4 in /usr/bin/clickhouse
2024-09-24 09:21:17 6. ./build_docker/./src/Common/MemoryTracker.cpp:0: MemoryTracker::allocImpl(long, bool, MemoryTracker*, double) @ 0x000000001d607bf4 in /usr/bin/clickhouse
2024-09-24 09:21:17 7. ./build_docker/./src/Common/CurrentMemoryTracker.cpp:59: CurrentMemoryTracker::alloc(long) @ 0x000000001d534f9d in /usr/bin/clickhouse
2024-09-24 09:21:17 8. ./build_docker/./src/Common/Allocator.h:0: Allocator<false, false>::realloc(void*, unsigned long, unsigned long, unsigned long) @ 0x000000001d52b2c7 in /usr/bin/clickhouse
2024-09-24 09:21:17 9. void DB::PODArrayBase<1ul, 4096ul, Allocator<false, false>, 63ul, 64ul>::resize<>(unsigned long) @ 0x000000000bdbee29 in /usr/bin/clickhouse
2024-09-24 09:21:17 10. ./build_docker/./src/DataTypes/Serializations/SerializationString.cpp:176: void DB::deserializeBinarySSE2<4>(DB::PODArray<char8_t, 4096ul, Allocator<false, false>, 63ul, 64ul>&, DB::PODArray<unsigned long, 4096ul, Allocator<false, false>, 63ul, 64ul>&, DB::ReadBuffer&, unsigned long) @ 0x000000002f275ec4 in /usr/bin/clickhouse
2024-09-24 09:21:17 11. ./build_docker/./src/DataTypes/Serializations/SerializationString.cpp:0: DB::SerializationString::deserializeBinaryBulk(DB::IColumn&, DB::ReadBuffer&, unsigned long, double) const @ 0x000000002f274736 in /usr/bin/clickhouse
2024-09-24 09:21:17 12. ./build_docker/./src/DataTypes/Serializations/ISerialization.cpp:0: DB::ISerialization::deserializeBinaryBulkWithMultipleStreams(COW<DB::IColumn>::immutable_ptr<DB::IColumn>&, unsigned long, DB::ISerialization::DeserializeBinaryBulkSettings&, std::shared_ptr<DB::ISerialization::DeserializeBinaryBulkState>&, std::unordered_map<String, COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::hash<String>, std::equal_to<String>, std::allocator<std::pair<String const, COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>>*) const @ 0x000000002f1387fe in /usr/bin/clickhouse
2024-09-24 09:21:17 13. ./build_docker/./contrib/boost/boost/smart_ptr/intrusive_ptr.hpp:196: DB::MergeTreeReaderWide::readData(DB::NameAndTypePair const&, std::shared_ptr<DB::ISerialization const> const&, COW<DB::IColumn>::immutable_ptr<DB::IColumn>&, unsigned long, bool, unsigned long, unsigned long, std::unordered_map<String, COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::hash<String>, std::equal_to<String>, std::allocator<std::pair<String const, COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>>&, bool) @ 0x000000003443c4ea in /usr/bin/clickhouse
2024-09-24 09:21:17 14. ./build_docker/./src/Storages/MergeTree/MergeTreeReaderWide.cpp:159: DB::MergeTreeReaderWide::readRows(unsigned long, unsigned long, bool, unsigned long, std::vector<COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::allocator<COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>&) @ 0x000000003443ae0c in /usr/bin/clickhouse
2024-09-24 09:21:17 15. ./build_docker/./src/Storages/MergeTree/MergeTreeRangeReader.cpp:107: DB::MergeTreeRangeReader::DelayedStream::finalize(std::vector<COW<DB::IColumn>::immutable_ptr<DB::IColumn>, std::allocator<COW<DB::IColumn>::immutable_ptr<DB::IColumn>>>&) @ 0x0000000034481a8b in /usr/bin/clickhouse
2024-09-24 09:21:17 16. ./build_docker/./src/Storages/MergeTree/MergeTreeRangeReader.cpp:0: DB::MergeTreeRangeReader::startReadingChain(unsigned long, DB::MarkRanges&) @ 0x000000003449f7ea in /usr/bin/clickhouse
2024-09-24 09:21:17 17. ./build_docker/./src/Storages/MergeTree/MergeTreeRangeReader.cpp:0: DB::MergeTreeRangeReader::read(unsigned long, DB::MarkRanges&) @ 0x000000003449a2a1 in /usr/bin/clickhouse
2024-09-24 09:21:17 18. ./build_docker/./src/Storages/MergeTree/MergeTreeBaseSelectProcessor.cpp:398: DB::IMergeTreeSelectAlgorithm::readFromPartImpl() @ 0x0000000034475d99 in /usr/bin/clickhouse
2024-09-24 09:21:17 19. ./build_docker/./src/Storages/MergeTree/MergeTreeBaseSelectProcessor.cpp:441: DB::IMergeTreeSelectAlgorithm::readFromPart() @ 0x00000000344775c4 in /usr/bin/clickhouse
2024-09-24 09:21:17 20. ./build_docker/./src/Storages/MergeTree/MergeTreeBaseSelectProcessor.cpp:0: DB::IMergeTreeSelectAlgorithm::read() @ 0x000000003446fc60 in /usr/bin/clickhouse
2024-09-24 09:21:17 21. ./build_docker/./src/Storages/MergeTree/MergeTreeSource.cpp:181: DB::MergeTreeSource::tryGenerate() @ 0x0000000035d28b78 in /usr/bin/clickhouse
2024-09-24 09:21:17 22. ./build_docker/./contrib/llvm-project/libcxx/include/optional:344: DB::ISource::work() @ 0x0000000034fcc465 in /usr/bin/clickhouse
2024-09-24 09:21:17 23. ./build_docker/./src/Processors/Executors/ExecutionThreadContext.cpp:0: DB::ExecutionThreadContext::executeTask() @ 0x0000000035012b2e in /usr/bin/clickhouse
2024-09-24 09:21:17 24. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:251: DB::PipelineExecutor::executeStepImpl(unsigned long, std::atomic<bool>*) @ 0x0000000034ff53dc in /usr/bin/clickhouse
2024-09-24 09:21:17 25. ./build_docker/./src/Processors/Executors/PipelineExecutor.cpp:359: void std::__function::__policy_invoker<void ()>::__call_impl<std::__function::__default_alloc_func<DB::PipelineExecutor::spawnThreads()::$_0, void ()>>(std::__function::__policy_storage const*) @ 0x0000000034ff8262 in /usr/bin/clickhouse
2024-09-24 09:21:17 26. ./build_docker/./base/base/../base/wide_integer_impl.h:809: ThreadPoolImpl<ThreadFromGlobalPoolImpl<false>>::worker(std::__list_iterator<ThreadFromGlobalPoolImpl<false>, void*>) @ 0x000000001d8a9b9c in /usr/bin/clickhouse
2024-09-24 09:21:17 27. ./build_docker/./src/Common/ThreadPool.h:243: ThreadFromGlobalPoolImpl<false>::ThreadFromGlobalPoolImpl<void ThreadPoolImpl<ThreadFromGlobalPoolImpl<false>>::scheduleImpl<void>(std::function<void ()>, Priority, std::optional<unsigned long>, bool)::'lambda0'()>(void&&)::'lambda'()::operator()() @ 0x000000001d8b4000 in /usr/bin/clickhouse
2024-09-24 09:21:17 28. ./build_docker/./base/base/../base/wide_integer_impl.h:809: ThreadPoolImpl<std::thread>::worker(std::__list_iterator<std::thread, void*>) @ 0x000000001d8a0692 in /usr/bin/clickhouse
2024-09-24 09:21:17 29. ./build_docker/./contrib/llvm-project/libcxx/include/__memory/unique_ptr.h:302: void* std::__thread_proxy[abi:v15000]<std::tuple<std::unique_ptr<std::__thread_struct, std::default_delete<std::__thread_struct>>, void ThreadPoolImpl<std::thread>::scheduleImpl<void>(std::function<void ()>, Priority, std::optional<unsigned long>, bool)::'lambda0'()>>(void*) @ 0x000000001d8ae96d in /usr/bin/clickhouse
2024-09-24 09:21:17 30. ? @ 0x00007f9fadd0cac3 in ?
2024-09-24 09:21:17 31. ? @ 0x00007f9fadd9da04 in ?
2024-09-24 09:21:17 
2024-09-24 09:21:17 Received exception from server (version 23.8.16):
2024-09-24 09:21:17 Code: 241. DB::Exception: Received from localhost:9000. DB::Exception: Memory limit (total) exceeded: would use 27.55 GiB (attempt to allocate chunk of 2883584 bytes), maximum: 27.55 GiB. OvercommitTracker decision: Memory overcommit has freed not enough memory.: (while reading column URL): (while reading from part /var/lib/clickhouse/store/5f5/5f55316c-8657-4e60-b714-e6ae3b6e5743/201403_10_18_2/ in table test.hits (5f55316c-8657-4e60-b714-e6ae3b6e5743) located on disk default of type local, from mark 40 with max_rows_to_read = 8192): While executing MergeTreeThread. (MEMORY_LIMIT_EXCEEDED)
2024-09-24 09:21:17 (query: SELECT count() FROM test.hits WHERE position(URL, 'metrika') != position(URL, materialize('metrika'));)
2024-09-24 09:21:17 , result:
2024-09-24 09:21:17 
2024-09-24 09:21:17 
2024-09-24 09:21:17 
2024-09-24 09:21:17 stdout:
2024-09-24 09:21:17 
2024-09-24 09:21:17 
2024-09-24 09:21:17 Settings used in the test: --max_insert_threads 0 --group_by_two_level_threshold 445204 --group_by_two_level_threshold_bytes 50000000 --distributed_aggregation_memory_efficient 1 --fsync_metadata 1 --output_format_parallel_formatting 1 --input_format_parallel_parsing 0 --min_chunk_bytes_for_parallel_parsing 122533 --max_read_buffer_size 649041 --prefer_localhost_replica 1 --max_block_size 93275 --max_threads 49 --optimize_or_like_chain 1 --optimize_read_in_order 0 --enable_multiple_prewhere_read_steps 0 --read_in_order_two_level_merge_threshold 24 --optimize_aggregation_in_order 1 --aggregation_in_order_max_block_bytes 40812772 --min_compress_block_size 167392 --max_compress_block_size 2626849 --use_uncompressed_cache 1 --min_bytes_to_use_direct_io 10737418240 --min_bytes_to_use_mmap_io 8288923630 --local_filesystem_read_method pread --remote_filesystem_read_method threadpool --local_filesystem_read_prefetch 0 --remote_filesystem_read_prefetch 0 --allow_prefetched_read_pool_for_remote_filesystem 0 --filesystem_prefetch_max_memory_usage 128Mi --filesystem_prefetches_limit 0 --filesystem_prefetch_min_bytes_for_single_read_task 1Mi --filesystem_prefetch_step_marks 0 --filesystem_prefetch_step_bytes 0 --compile_aggregate_expressions 1 --compile_sort_description 1 --merge_tree_coarse_index_granularity 31 --optimize_distinct_in_order 1 --optimize_sorting_by_input_stream_properties 0 --http_response_buffer_size 2986268 --http_wait_end_of_query False --enable_memory_bound_merging_of_aggregation_results 0 --min_count_to_compile_expression 0 --min_count_to_compile_aggregate_expression 3 --min_count_to_compile_sort_description 3 --session_timezone Africa/Juba
2024-09-24 09:21:17 
2024-09-24 09:21:17 MergeTree settings used in test: --ratio_of_defaults_for_sparse_serialization 1.0 --prefer_fetch_merged_part_size_threshold 9034322353 --vertical_merge_algorithm_min_rows_to_activate 1 --vertical_merge_algorithm_min_columns_to_activate 100 --allow_vertical_merges_from_compact_to_wide_parts 0 --min_merge_bytes_to_use_direct_io 1 --index_granularity_bytes 15445134 --merge_max_block_size 10065 --index_granularity 4360 --min_bytes_for_wide_part 0 --marks_compress_block_size 78997 --primary_key_compress_block_size 87978
2024-09-24 09:21:17 
2024-09-24 09:21:17 Database: test_hytmakd2
2024-09-24 09:21:18 00087_where_0:                                                          [ OK ] 0.51 sec.
2024-09-24 09:21:20 00085_monotonic_evaluation_segfault:                                    [ OK ] 1.06 sec.
2024-09-24 09:21:22 00086_array_reduce:                                                     [ OK ] 3.89 sec.
2024-09-24 09:21:24 00083_array_filter:                                                     [ OK ] 1.74 sec.
2024-09-24 09:21:31 00082_quantiles:                                                        [ OK ] 6.85 sec.
2024-09-24 09:21:32 00081_group_by_without_key_and_totals:                                  [ OK ] 0.66 sec.
2024-09-24 09:21:33 00080_array_join_and_union:                                             [ OK ] 0.39 sec.
2024-09-24 09:21:34 00079_array_join_not_used_joined_column:                                [ OK ] 1.08 sec.
2024-09-24 09:21:37 00078_group_by_arrays:                                                  [ OK ] 2.97 sec.
2024-09-24 09:21:42 00084_external_aggregation:                                             [ OK ] 21.57 sec.
2024-09-24 09:21:42 00077_log_tinylog_stripelog:                                            [ OK ] 5.10 sec.
2024-09-24 09:21:42 00076_system_columns_bytes:                                             [ OK ] 0.35 sec.
2024-09-24 09:21:43 00075_left_array_join:                                                  [ OK ] 0.61 sec.
2024-09-24 09:21:43 00073_uniq_array:                                                       [ OK ] 0.40 sec.
2024-09-24 09:21:44 00074_full_join:                                                        [ OK ] 1.65 sec.
2024-09-24 09:21:49 00071_merge_tree_optimize_aio:                                          [ OK ] 4.75 sec.
2024-09-24 09:21:50 00069_duplicate_aggregation_keys:                                       [ OK ] 0.38 sec.
2024-09-24 09:21:50 00068_subquery_in_prewhere:                                             [ OK ] 0.49 sec.
2024-09-24 09:21:52 00067_union_all:                                                        [ OK ] 1.26 sec.
2024-09-24 09:21:52 00066_sorting_distributed_many_replicas:                                [ OK ] 0.36 sec.
2024-09-24 09:21:52 00072_compare_date_and_string_index:                                    [ OK ] 8.66 sec.
2024-09-24 09:21:53 00065_loyalty_with_storage_join:                                        [ OK ] 1.04 sec.
2024-09-24 09:21:54 00062_loyalty:                                                          [ OK ] 0.80 sec.
2024-09-24 09:21:55 00063_loyalty_joins:                                                    [ OK ] 2.60 sec.
2024-09-24 09:21:56 00060_move_to_prewhere_and_sets:                                        [ OK ] 0.57 sec.
2024-09-24 09:21:56 00061_storage_buffer:                                                   [ OK ] 1.72 sec.
2024-09-24 09:21:56 00059_merge_sorting_empty_array_joined:                                 [ OK ] 0.33 sec.
2024-09-24 09:21:57 00055_index_and_not:                                                    [ OK ] 0.49 sec.
2024-09-24 09:21:57 00056_view:                                                             [ OK ] 1.01 sec.
2024-09-24 09:21:58 00054_merge_tree_partitions:                                            [ OK ] 0.84 sec.
2024-09-24 09:21:58 00052_group_by_in:                                                      [ OK ] 0.35 sec.
2024-09-24 09:22:00 00053_replicate_segfault:                                               [ OK ] 2.94 sec.
2024-09-24 09:22:02 00050_min_max:                                                          [ OK ] 1.31 sec.
2024-09-24 09:22:02 00051_min_max_array:                                                    [ OK ] 3.55 sec.
2024-09-24 09:22:02 00048_min_max:                                                          [ OK ] 0.38 sec.
2024-09-24 09:22:03 00049_max_string_if:                                                    [ OK ] 1.41 sec.
2024-09-24 09:22:03 00047_bar:                                                              [ OK ] 0.89 sec.
2024-09-24 09:22:04 00046_uniq_upto_distributed:                                            [ OK ] 0.64 sec.
2024-09-24 09:22:04 00045_uniq_upto:                                                        [ OK ] 0.57 sec.
2024-09-24 09:22:05 00043_any_left_join:                                                    [ OK ] 0.91 sec.
2024-09-24 09:22:06 00042_any_left_join:                                                    [ OK ] 0.78 sec.
2024-09-24 09:22:07 00044_any_left_join_string:                                             [ OK ] 2.47 sec.
2024-09-24 09:22:08 00041_aggregating_materialized_view:                                    [ OK ] 1.93 sec.
2024-09-24 09:22:08 00040_aggregating_materialized_view:                                    [ OK ] 1.58 sec.
2024-09-24 09:22:09 00039_primary_key:                                                      [ OK ] 0.36 sec.
2024-09-24 09:22:11 00038_uniq_state_merge2:                                                [ OK ] 2.61 sec.
2024-09-24 09:22:12 00036_aggregate_hashed:                                                 [ OK ] 0.85 sec.
2024-09-24 09:22:12 00037_uniq_state_merge1:                                                [ OK ] 3.81 sec.
2024-09-24 09:22:13 00035_aggregate_keys128:                                                [ OK ] 0.46 sec.
2024-09-24 09:22:13 00034_aggregate_key_fixed_string:                                       [ OK ] 0.76 sec.
2024-09-24 09:22:14 00033_aggregate_key_string:                                             [ OK ] 0.79 sec.
2024-09-24 09:22:14 00032_aggregate_key64:                                                  [ OK ] 0.43 sec.
2024-09-24 09:22:14 00031_array_enumerate_uniq:                                             [ OK ] 0.43 sec.
2024-09-24 09:22:15 00030_array_enumerate_uniq:                                             [ OK ] 1.16 sec.
2024-09-24 09:22:16 00023_totals_limit:                                                     [ OK ] 0.35 sec.
2024-09-24 09:22:16 00022_merge_prewhere:                                                   [ OK ] 0.44 sec.
2024-09-24 09:22:17 00021_3_select_with_in:                                                 [ OK ] 0.34 sec.
2024-09-24 09:22:17 00021_2_select_with_in:                                                 [ OK ] 0.33 sec.
2024-09-24 09:22:18 00021_1_select_with_in:                                                 [ OK ] 0.34 sec.
2024-09-24 09:22:18 00020_distinct_order_by_distributed:                                    [ OK ] 0.44 sec.
2024-09-24 09:22:19 00017_aggregation_uninitialized_memory:                                 [ OK ] 0.34 sec.
2024-09-24 09:22:20 00016_any_if_distributed_cond_always_false:                             [ OK ] 0.72 sec.
2024-09-24 09:22:20 00015_totals_and_no_aggregate_functions:                                [ OK ] 0.33 sec.
2024-09-24 09:22:21 00014_filtering_arrays:                                                 [ OK ] 0.47 sec.
2024-09-24 09:22:21 00013_sorting_of_nested:                                                [ OK ] 0.71 sec.
2024-09-24 09:22:22 00012_sorting_distributed:                                              [ OK ] 0.57 sec.
2024-09-24 09:22:23 00011_sorting:                                                          [ OK ] 0.44 sec.
2024-09-24 09:22:23 00010_quantiles_segfault:                                               [ OK ] 0.68 sec.
2024-09-24 09:22:25 00009_uniq_distributed:                                                 [ OK ] 1.15 sec.
2024-09-24 09:22:26 00008_uniq:                                                             [ OK ] 0.91 sec.
2024-09-24 09:22:26 00007_uniq:                                                             [ OK ] 0.34 sec.
2024-09-24 09:22:27 00006_agregates:                                                        [ OK ] 0.46 sec.
2024-09-24 09:22:27 00005_filtering:                                                        [ OK ] 0.36 sec.
2024-09-24 09:22:28 00004_top_counters:                                                     [ OK ] 0.53 sec.
2024-09-24 09:22:28 00002_count_visits:                                                     [ OK ] 0.33 sec.
2024-09-24 09:22:29 00001_count_hits:                                                       [ OK ] 0.37 sec.
2024-09-24 09:22:29 
2024-09-24 09:22:29 Having 1 errors! 72 tests passed. 1 tests skipped. 267.16 s elapsed (ForkPoolWorker-2).
2024-09-24 09:22:43 00024_random_counters:                                                  [ OK ] 28.54 sec.
2024-09-24 09:22:43 
2024-09-24 09:22:43 Having 1 errors! 51 tests passed. 0 tests skipped. 280.91 s elapsed (ForkPoolWorker-3).
2024-09-24 09:22:43 
2024-09-24 09:22:43 Running 5 stateful tests (MainProcess).
2024-09-24 09:22:43 
2024-09-24 09:23:15 00170_s3_cache:                                                         [ OK ] 32.10 sec.
2024-09-24 09:23:17 00158_cache_dictionary_has:                                             [ OK ] 1.91 sec.
2024-09-24 09:23:26 00157_cache_dictionary:                                                 [ OK ] 8.86 sec.
2024-09-24 09:23:28 00152_insert_different_granularity:                                     [ OK ] 1.88 sec.
2024-09-24 09:23:29 00140_rename:                                                           [ OK ] 0.55 sec.
2024-09-24 09:23:29 
2024-09-24 09:23:29 5 tests passed. 0 tests skipped. 45.82 s elapsed (MainProcess).
2024-09-24 09:23:29 
2024-09-24 09:23:29 No queries hung.
2024-09-24 09:23:29 All tests have finished.