01514_distributed_cancel_query_on_error

log

2021.09.27 12:15:47.443980 [ 18303 ] {7fb7c9f0-7501-4dfd-b00f-b584719f571c} <Debug> executeQuery: (from [::1]:45826) SELECT 'Running test <__main__.TestSuite object at 0x7fe690e551f0>/01514_distributed_cancel_query_on_error.sh from pid=666';
2021.09.27 12:15:47.444059 [ 18318 ] {3865b870-b48f-4e01-8d0d-c8899dcaafcc} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_4170337A2E2D4E5E2D4F405C2622547D2A6B672F472B675C385E35376872655B3645292F5A765644
2021.09.27 12:15:47.444060 [ 2483 ] {5441cbd3-3a41-4934-8c69-445f627fcf46} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_5B2B414A4740704177565D67323B22547D4C26705C747A752E303F5E68366A2D26352E436B555838
2021.09.27 12:15:47.444087 [ 5339 ] {fe90f0e3-a3ab-4176-938e-e76f6799014d} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_7D2977612D2E32796A7060242C682856342B78494A7967722A356544643B2438265E39227B743267
2021.09.27 12:15:47.444261 [ 18303 ] {7fb7c9f0-7501-4dfd-b00f-b584719f571c} <Trace> ContextAccess (default): Access granted: SELECT(dummy) ON system.one
2021.09.27 12:15:47.444319 [ 18303 ] {7fb7c9f0-7501-4dfd-b00f-b584719f571c} <Trace> InterpreterSelectQuery: FetchColumns -> Complete
2021.09.27 12:15:47.444979 [ 18303 ] {7fb7c9f0-7501-4dfd-b00f-b584719f571c} <Information> executeQuery: Read 1 rows, 1.00 B in 0.000951337 sec., 1051 rows/sec., 1.03 KiB/sec.
2021.09.27 12:15:47.444998 [ 18303 ] {7fb7c9f0-7501-4dfd-b00f-b584719f571c} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.445115 [ 18303 ] {} <Debug> TCPHandler: Processed in 0.001373055 sec.
2021.09.27 12:15:47.445449 [ 18303 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:47.455909 [ 18314 ] {} <Trace> TCPHandlerFactory: TCP Request. Address: [::1]:45828
2021.09.27 12:15:47.455958 [ 18314 ] {} <Debug> TCPHandler: Connected ClickHouse client version 21.11.0, revision: 54449, database: test_3gma5f, user: default.
2021.09.27 12:15:47.456433 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Debug> executeQuery: (from [::1]:45828) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01516_drop_table_stress_long.sh') CREATE DATABASE IF NOT EXISTS test_01516_test_3gma5f;
2021.09.27 12:15:47.456525 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Trace> ContextAccess (default): Access granted: CREATE DATABASE ON test_01516_test_3gma5f.*
2021.09.27 12:15:47.477603 [ 5347 ] {24d9bde0-5e61-4b9d-b384-0823cd59d5a3} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477612 [ 18355 ] {97f1f5ea-3f79-4ebd-a672-d8183733e056} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477620 [ 18299 ] {1a4c3641-6ecf-4355-81a4-2739a873c396} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477665 [ 18369 ] {3a132b93-4f13-43a8-a51b-7b3b72c8deca} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477652 [ 726 ] {891d0678-7606-413d-ae2c-52eca61b7e75} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477693 [ 18349 ] {bfd396d3-41bb-49c3-b3e8-e1a7ead8b5c2} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477694 [ 1224 ] {689fa25e-21f8-4c17-8731-71e80d90f23b} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477719 [ 1225 ] {ee90dc8e-dfde-4630-8a79-878faaae92e8} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477713 [ 18316 ] {60f19974-ffa2-449a-9cdc-638ef8fe4d31} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477713 [ 18357 ] {42cefef0-582a-404a-8f3c-fd71a0c28046} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477715 [ 685 ] {f8b4b989-feaa-4b6c-9156-9a7a623dcb61} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477725 [ 18292 ] {37a2cb91-e94d-4ea1-8cc0-35912c7df28b} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477641 [ 684 ] {80f0ec7d-ad0b-41b7-b111-b1dfef8d6db2} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.477813 [ 18323 ] {cd2e304d-1827-436b-84b9-9b6df6ea3884} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
--
2021.09.27 12:15:47.488244 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Debug> executeQuery: (from [::1]:45832) (comment: 01514_distributed_cancel_query_on_error.sh) CREATE DATABASE test_8fczje
2021.09.27 12:15:47.488328 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Trace> ContextAccess (default): Access granted: CREATE DATABASE ON test_8fczje.*
2021.09.27 12:15:47.488447 [ 18303 ] {35a07929-6907-42e0-ae9f-fa0c1929a272} <Debug> executeQuery: (from [::1]:45834) (comment: 01514_parallel_formatting.sql) drop table if exists tsv;
2021.09.27 12:15:47.488595 [ 18303 ] {35a07929-6907-42e0-ae9f-fa0c1929a272} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.488697 [ 18303 ] {} <Debug> TCPHandler: Processed in 0.00041761 sec.
2021.09.27 12:15:47.489027 [ 18303 ] {a0f2eb5c-6fda-43d4-ba35-6a7135fba346} <Debug> executeQuery: (from [::1]:45834) (comment: 01514_parallel_formatting.sql) set output_format_parallel_formatting=1;
2021.09.27 12:15:47.489152 [ 18303 ] {a0f2eb5c-6fda-43d4-ba35-6a7135fba346} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.489251 [ 18303 ] {} <Debug> TCPHandler: Processed in 0.000354606 sec.
2021.09.27 12:15:47.489662 [ 18303 ] {c61045a2-2c67-42a7-b402-c32a4b69405e} <Debug> executeQuery: (from [::1]:45834) (comment: 01514_parallel_formatting.sql) create table tsv(a int, b int default 7) engine File(TSV);
2021.09.27 12:15:47.489752 [ 18303 ] {c61045a2-2c67-42a7-b402-c32a4b69405e} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_w45sxy.tsv
2021.09.27 12:15:47.489766 [ 18303 ] {c61045a2-2c67-42a7-b402-c32a4b69405e} <Trace> ContextAccess (default): Access granted: FILE ON *.*
2021.09.27 12:15:47.511270 [ 2483 ] {5441cbd3-3a41-4934-8c69-445f627fcf46} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.511279 [ 5339 ] {fe90f0e3-a3ab-4176-938e-e76f6799014d} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.511317 [ 18318 ] {3865b870-b48f-4e01-8d0d-c8899dcaafcc} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.511430 [ 2483 ] {} <Debug> TCPHandler: Processed in 0.067672917 sec.
2021.09.27 12:15:47.511450 [ 5339 ] {} <Debug> TCPHandler: Processed in 0.067711639 sec.
2021.09.27 12:15:47.511524 [ 18318 ] {} <Debug> TCPHandler: Processed in 0.067785634 sec.
2021.09.27 12:15:47.511717 [ 5339 ] {9e7f7c74-3dda-4027-a97c-8cca09fd80ed} <Debug> executeQuery: (from [::1]:45530) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_252B4E7847424D346E54605C513C5C7A5859464B612C57682C5944437650253B3E23424A4762215E(x UInt8) Engine=Memory;
2021.09.27 12:15:47.511744 [ 2483 ] {5e6c971b-2ce7-4d1f-9d50-ea60b05fc5bb} <Debug> executeQuery: (from [::1]:45556) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_78302F502D2B31264644486D70285C447B4662377E78254A4939746A267D2851345878277D542E2D(x UInt8) Engine=Memory;
2021.09.27 12:15:47.511782 [ 18318 ] {224d7a9a-5ab1-4085-ab83-69e8982d6a42} <Debug> executeQuery: (from [::1]:45536) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_766C36584060762C672951783449667A7B2978316F37274F785A2844316473722527414C273E2464(x UInt8) Engine=Memory;
2021.09.27 12:15:47.511832 [ 5339 ] {9e7f7c74-3dda-4027-a97c-8cca09fd80ed} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_252B4E7847424D346E54605C513C5C7A5859464B612C57682C5944437650253B3E23424A4762215E
2021.09.27 12:15:47.511866 [ 2483 ] {5e6c971b-2ce7-4d1f-9d50-ea60b05fc5bb} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_78302F502D2B31264644486D70285C447B4662377E78254A4939746A267D2851345878277D542E2D
--
2021.09.27 12:15:47.575646 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Information> DatabaseOrdinary (test_8fczje): Metadata processed, database test_8fczje has 0 tables and 0 dictionaries in total.
2021.09.27 12:15:47.575652 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Information> TablesLoader: Parsed metadata of 0 tables in 1 databases in 0.000126209 sec
2021.09.27 12:15:47.575674 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Information> TablesLoader: Parsed metadata of 0 tables in 1 databases in 0.000106048 sec
2021.09.27 12:15:47.575679 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:47.575696 [ 18303 ] {c61045a2-2c67-42a7-b402-c32a4b69405e} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.575689 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:47.575701 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:47.575727 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:47.575738 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Information> TablesLoader: Loading 0 tables with 0 dependency level
2021.09.27 12:15:47.575744 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Information> TablesLoader: Loading 0 tables with 0 dependency level
2021.09.27 12:15:47.575748 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Information> DatabaseOrdinary (test_01516_test_3gma5f): Starting up tables.
2021.09.27 12:15:47.575754 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Information> DatabaseOrdinary (test_8fczje): Starting up tables.
2021.09.27 12:15:47.575833 [ 18314 ] {0c96a428-b5f3-426a-843b-1b241c205218} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.575838 [ 18303 ] {} <Debug> TCPHandler: Processed in 0.086353561 sec.
2021.09.27 12:15:47.575851 [ 18374 ] {a74f3ed2-26d7-457f-a188-b22a76fe0589} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.575954 [ 18314 ] {} <Debug> TCPHandler: Processed in 0.119685574 sec.
2021.09.27 12:15:47.576022 [ 18374 ] {} <Debug> TCPHandler: Processed in 0.087902061 sec.
2021.09.27 12:15:47.576102 [ 18314 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:47.576184 [ 18374 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:47.576444 [ 18303 ] {c7eea622-d293-4117-bdca-a0c5a93a39ba} <Debug> executeQuery: (from [::1]:45834) (comment: 01514_parallel_formatting.sql) insert into tsv(a) select number from numbers(10000000);
2021.09.27 12:15:47.576597 [ 18303 ] {c7eea622-d293-4117-bdca-a0c5a93a39ba} <Trace> ContextAccess (default): Access granted: INSERT(a) ON test_w45sxy.tsv
2021.09.27 12:15:47.576673 [ 18303 ] {c7eea622-d293-4117-bdca-a0c5a93a39ba} <Trace> ContextAccess (default): Access granted: CREATE TEMPORARY TABLE ON *.*
2021.09.27 12:15:47.576967 [ 18303 ] {c7eea622-d293-4117-bdca-a0c5a93a39ba} <Trace> InterpreterSelectQuery: FetchColumns -> Complete
2021.09.27 12:15:47.577112 [ 1224 ] {01e6eb82-8fd6-4ba8-b78e-10b8fe283a25} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577123 [ 18316 ] {ffcd3d87-fb66-4c4a-aa79-57ba9f7bb2f5} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577146 [ 18328 ] {d02a45ff-929c-45d8-972f-d52522598c24} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577180 [ 1231 ] {7366b566-be41-45e8-b831-cb74543668c1} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577197 [ 18303 ] {c7eea622-d293-4117-bdca-a0c5a93a39ba} <Trace> ParallelFormattingOutputFormat: Parallel formatting is being used
2021.09.27 12:15:47.577209 [ 2497 ] {e579172a-b1d6-4d0d-93f0-46075414e853} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577220 [ 18370 ] {8196de03-20b8-465d-9802-ba38f2d1bed2} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577235 [ 18299 ] {e79f0c6e-b681-4704-8834-bd034e22715e} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577250 [ 18355 ] {177f055b-2018-4e75-9438-7706c9a295ee} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577262 [ 18316 ] {} <Debug> TCPHandler: Processed in 0.099110098 sec.
2021.09.27 12:15:47.577201 [ 5347 ] {e0d5026a-8ef4-4f78-98ac-2e93f5ce635b} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.577230 [ 18292 ] {95861fcc-15b9-4c5d-93be-7c8a86ce20f5} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
--
2021.09.27 12:15:47.794237 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Debug> executeQuery: (from [::1]:45850) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01514_distributed_cancel_query_on_error.sh') SELECT groupArray(repeat('a', if(_shard_num == 2, 100000, 1))), number%100000 k from remote('127.{2,3}', system.numbers) GROUP BY k LIMIT 10e6
2021.09.27 12:15:47.794669 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> ContextAccess (default): Access granted: CREATE TEMPORARY TABLE, REMOTE ON *.*
2021.09.27 12:15:47.794783 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> Connection (127.2:9000): Connecting. Database: (not specified). User: default
2021.09.27 12:15:47.794954 [ 18373 ] {} <Trace> TCPHandlerFactory: TCP Request. Address: [::ffff:127.0.0.1]:60224
2021.09.27 12:15:47.795014 [ 18373 ] {} <Debug> TCPHandler: Connected ClickHouse server version 21.11.0, revision: 54449, user: default.
2021.09.27 12:15:47.795075 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> Connection (127.2:9000): Connected to ClickHouse server version 21.11.1.
2021.09.27 12:15:47.795532 [ 18373 ] {be3adefb-2260-4f69-970b-38a0f16ae5e0} <Debug> executeQuery: (from [::ffff:127.0.0.1]:60224, initial_query_id: b0364447-5e5c-4478-9623-186323c4f8ed) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01514_distributed_cancel_query_on_error.sh') DESC TABLE system.numbers
2021.09.27 12:15:47.795651 [ 18373 ] {be3adefb-2260-4f69-970b-38a0f16ae5e0} <Trace> ContextAccess (default): Access granted: SHOW COLUMNS ON system.numbers
2021.09.27 12:15:47.796342 [ 18373 ] {be3adefb-2260-4f69-970b-38a0f16ae5e0} <Information> executeQuery: Read 1 rows, 75.00 B in 0.000759787 sec., 1316 rows/sec., 96.40 KiB/sec.
2021.09.27 12:15:47.796360 [ 18373 ] {be3adefb-2260-4f69-970b-38a0f16ae5e0} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.796471 [ 18373 ] {} <Debug> TCPHandler: Processed in 0.001168819 sec.
2021.09.27 12:15:47.796699 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> ContextAccess (default): Access granted: CREATE TEMPORARY TABLE, REMOTE ON *.*
2021.09.27 12:15:47.797036 [ 18373 ] {f426bb57-30c6-4565-8dae-183af4fc278a} <Debug> executeQuery: (from [::ffff:127.0.0.1]:60224, initial_query_id: b0364447-5e5c-4478-9623-186323c4f8ed) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01514_distributed_cancel_query_on_error.sh') DESC TABLE system.numbers
2021.09.27 12:15:47.797138 [ 18373 ] {f426bb57-30c6-4565-8dae-183af4fc278a} <Trace> ContextAccess (default): Access granted: SHOW COLUMNS ON system.numbers
2021.09.27 12:15:47.797659 [ 18373 ] {f426bb57-30c6-4565-8dae-183af4fc278a} <Information> executeQuery: Read 1 rows, 75.00 B in 0.000591266 sec., 1691 rows/sec., 123.87 KiB/sec.
2021.09.27 12:15:47.797676 [ 18373 ] {f426bb57-30c6-4565-8dae-183af4fc278a} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.797779 [ 18373 ] {} <Debug> TCPHandler: Processed in 0.000859763 sec.
2021.09.27 12:15:47.798660 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> InterpreterSelectQuery: WithMergeableState -> Complete
2021.09.27 12:15:47.799370 [ 1273 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> Connection (127.3:9000): Connecting. Database: (not specified). User: default
2021.09.27 12:15:47.799567 [ 18509 ] {} <Trace> TCPHandlerFactory: TCP Request. Address: [::ffff:127.0.0.1]:33716
2021.09.27 12:15:47.799607 [ 1279 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Debug> Connection (127.2:9000): Sent data for 2 scalars, total 2 rows in 3.9693e-05 sec., 49370 rows/sec., 66.00 B (1.55 MiB/sec.), compressed 0.4520547945205479 times to 146.00 B (3.42 MiB/sec.)
2021.09.27 12:15:47.799624 [ 18509 ] {} <Debug> TCPHandler: Connected ClickHouse server version 21.11.0, revision: 54449, user: default.
2021.09.27 12:15:47.799685 [ 1273 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> Connection (127.3:9000): Connected to ClickHouse server version 21.11.1.
2021.09.27 12:15:47.800039 [ 1273 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Debug> Connection (127.3:9000): Sent data for 2 scalars, total 2 rows in 4.0082e-05 sec., 49256 rows/sec., 66.00 B (1.55 MiB/sec.), compressed 0.4520547945205479 times to 146.00 B (3.42 MiB/sec.)
2021.09.27 12:15:47.800091 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Debug> executeQuery: (from [::ffff:127.0.0.1]:60224, initial_query_id: b0364447-5e5c-4478-9623-186323c4f8ed) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01514_distributed_cancel_query_on_error.sh') WITH toUInt32(1) AS _shard_num SELECT groupArray(repeat('a', if(_shard_num = 2, 100000, 1))), number % 100000 AS k FROM system.numbers GROUP BY k LIMIT 10000000.
2021.09.27 12:15:47.800114 [ 18324 ] {d3a45aac-b51c-439d-870a-ed33f1189f6d} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.800267 [ 2488 ] {97ac66f4-79e8-4df5-a6b2-b9ec78b2fe84} <Information> DatabaseOrdinary (test_a5qoz8): Metadata processed, database test_a5qoz8 has 0 tables and 0 dictionaries in total.
2021.09.27 12:15:47.800374 [ 2488 ] {97ac66f4-79e8-4df5-a6b2-b9ec78b2fe84} <Information> TablesLoader: Parsed metadata of 0 tables in 1 databases in 0.000162813 sec
2021.09.27 12:15:47.800383 [ 2488 ] {97ac66f4-79e8-4df5-a6b2-b9ec78b2fe84} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:47.800390 [ 2488 ] {97ac66f4-79e8-4df5-a6b2-b9ec78b2fe84} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:47.800398 [ 2488 ] {97ac66f4-79e8-4df5-a6b2-b9ec78b2fe84} <Information> TablesLoader: Loading 0 tables with 0 dependency level
2021.09.27 12:15:47.800406 [ 2488 ] {97ac66f4-79e8-4df5-a6b2-b9ec78b2fe84} <Information> DatabaseOrdinary (test_a5qoz8): Starting up tables.
2021.09.27 12:15:47.800473 [ 18324 ] {} <Debug> TCPHandler: Processed in 0.145964428 sec.
2021.09.27 12:15:47.800477 [ 2488 ] {97ac66f4-79e8-4df5-a6b2-b9ec78b2fe84} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.800486 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Debug> executeQuery: (from [::ffff:127.0.0.1]:33716, initial_query_id: b0364447-5e5c-4478-9623-186323c4f8ed) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01514_distributed_cancel_query_on_error.sh') WITH toUInt32(2) AS _shard_num SELECT groupArray(repeat('a', if(_shard_num = 2, 100000, 1))), number % 100000 AS k FROM system.numbers GROUP BY k LIMIT 10000000.
2021.09.27 12:15:47.800606 [ 2488 ] {} <Debug> TCPHandler: Processed in 0.040682221 sec.
2021.09.27 12:15:47.800769 [ 2488 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:47.801078 [ 18324 ] {fab87d8e-1443-4288-b0b6-44c1bd925304} <Debug> executeQuery: (from [::1]:45842) (comment: 01514_empty_buffer_different_types.sql) CREATE TABLE buffer_table1 ( `s` String , x UInt32) ENGINE = Buffer(currentDatabase(), 'merge_tree_table1', 16, 10, 60, 10, 1000, 1048576, 2097152);
2021.09.27 12:15:47.801081 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Trace> ContextAccess (default): Access granted: SELECT(number) ON system.numbers
2021.09.27 12:15:47.801157 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Trace> ContextAccess (default): Access granted: SELECT(number) ON system.numbers
2021.09.27 12:15:47.801181 [ 18324 ] {fab87d8e-1443-4288-b0b6-44c1bd925304} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_r84xxb.buffer_table1
2021.09.27 12:15:47.801199 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Trace> InterpreterSelectQuery: FetchColumns -> WithMergeableState
2021.09.27 12:15:47.801239 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Trace> InterpreterSelectQuery: FetchColumns -> WithMergeableState
2021.09.27 12:15:47.801409 [ 18371 ] {47242bb2-b7b4-402d-9a64-64768b77bfdc} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801410 [ 18353 ] {5d665ab7-60b7-4285-8228-9dd5e13fa41a} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801448 [ 18370 ] {6b3b6435-3d12-4ae6-991b-a316a2415aff} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801448 [ 18311 ] {0826105d-82dc-4e9d-8a55-a9c795159a66} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801491 [ 18299 ] {8f95e4d7-de86-4b23-92f0-18ab93f4926f} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801494 [ 18377 ] {9a7ce28d-b56c-41b3-909d-dcdd44459e89} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801518 [ 697 ] {0e78247f-64b7-4a17-9b0b-5ed7199c8bed} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801511 [ 18316 ] {e5ad2208-0177-403e-b2cd-e50776d1e0cb} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801540 [ 684 ] {28d4e30f-b50b-4e5b-9720-bb0a78aaf92c} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801554 [ 685 ] {8c4a8c1a-55e1-4495-9c59-a9029c752840} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801565 [ 13163 ] {0df8bd5e-38db-41c0-865b-747b4cad0b86} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801530 [ 18369 ] {22c1bc5b-bf01-4b21-8162-3d282b6568f9} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801570 [ 18353 ] {} <Debug> TCPHandler: Processed in 0.06990221 sec.
2021.09.27 12:15:47.801620 [ 18311 ] {} <Debug> TCPHandler: Processed in 0.070411239 sec.
2021.09.27 12:15:47.801588 [ 18355 ] {86362e06-13d7-4617-8f89-b7f784c4d354} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801652 [ 18310 ] {8693b989-f9d8-4f9b-8a64-3352722fa429} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801605 [ 5347 ] {7a91eebe-3a6c-4871-b89e-2e466de62307} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801684 [ 18351 ] {02df58f4-16ee-4f3f-9639-fa518ad1dd83} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801644 [ 18299 ] {} <Debug> TCPHandler: Processed in 0.070038763 sec.
2021.09.27 12:15:47.801716 [ 13163 ] {} <Debug> TCPHandler: Processed in 0.070458574 sec.
--
2021.09.27 12:15:47.801986 [ 1419 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Trace> AggregatingTransform: Aggregating
2021.09.27 12:15:47.802003 [ 1231 ] {} <Debug> TCPHandler: Processed in 0.071096094 sec.
2021.09.27 12:15:47.802017 [ 1419 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Trace> Aggregator: Aggregation method: key32
2021.09.27 12:15:47.801560 [ 18371 ] {} <Debug> TCPHandler: Processed in 0.069980444 sec.
2021.09.27 12:15:47.802041 [ 1224 ] {} <Debug> TCPHandler: Processed in 0.07072685 sec.
2021.09.27 12:15:47.801682 [ 18296 ] {0e6d1b0c-3fc5-43ae-8941-b843fd0800b8} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801838 [ 18323 ] {820934b0-4524-42f9-9c37-3f5e29abdad7} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801843 [ 18292 ] {e8891c1f-f0c9-4a2d-bb53-743d81d52ccc} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.801692 [ 684 ] {} <Debug> TCPHandler: Processed in 0.070857508 sec.
2021.09.27 12:15:47.802103 [ 697 ] {0079cbf1-0e0b-432a-89eb-00935a99b607} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_2B4B786273247C4F444D3E503F40675D407D3A405D23256C74644641364B294F215058796B774B76
2021.09.27 12:15:47.802115 [ 5347 ] {a2688b77-1007-4477-93d1-2b49f29be094} <Debug> executeQuery: (from [::1]:45540) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_4A34595F797E48792F51377668256C5E5F656834363143546A21683224375D205A23536B505C3B5B(x UInt8) Engine=Memory;
2021.09.27 12:15:47.801896 [ 18311 ] {b49cc26a-237b-4894-9d32-9d427ae740b7} <Debug> executeQuery: (from [::1]:45534) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_665626256B226429342D4648543152392F574D656A7971305F504864654939746D4540602D383042(x UInt8) Engine=Memory;
2021.09.27 12:15:47.801898 [ 18353 ] {f28feee2-610c-4bbc-a7cf-cd43d2a097ea} <Debug> executeQuery: (from [::1]:45518) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_3B4F22754C4B702B785C2C2E3B224378302B3778555760792820456F51522E533F3C22766E2C4868(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802155 [ 18351 ] {7cea6813-f586-4c03-8459-446b387c9d90} <Debug> executeQuery: (from [::1]:45526) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_6E2D65387878224D484D44583A2474243B474B414722333E2C666C2622494B4F773D365062796C65(x UInt8) Engine=Memory;
2021.09.27 12:15:47.801654 [ 18357 ] {877bc40f-6a35-41f5-afe0-9ac9b8935fd2} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.802179 [ 18369 ] {8387e1c5-2df0-4ae1-9375-746174792d77} <Debug> executeQuery: (from [::1]:45502) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_2A4B5E3969433445714F3D5D6B363C6B44457C206E2D46483F3B6E4E6E285D534C22362D37444D49(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802202 [ 18323 ] {} <Debug> TCPHandler: Processed in 0.070859863 sec.
2021.09.27 12:15:47.801784 [ 410 ] {82ac98de-f213-4621-8b2d-13052cf4810d} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.802229 [ 5347 ] {a2688b77-1007-4477-93d1-2b49f29be094} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_4A34595F797E48792F51377668256C5E5F656834363143546A21683224375D205A23536B505C3B5B
2021.09.27 12:15:47.801990 [ 18464 ] {} <Debug> TCPHandler: Processed in 0.071156162 sec.
2021.09.27 12:15:47.801787 [ 2497 ] {fdfdcbfb-b242-469c-a817-55dce9cc9c47} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:47.802278 [ 18353 ] {f28feee2-610c-4bbc-a7cf-cd43d2a097ea} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_3B4F22754C4B702B785C2C2E3B224378302B3778555760792820456F51522E533F3C22766E2C4868
2021.09.27 12:15:47.802005 [ 18316 ] {43b88dc0-acc4-4946-82fd-1abbedb1671f} <Debug> executeQuery: (from [::1]:45548) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_5C4D247B6E712C6556265F545F4E7B724839665F3E5B70756623394D56416A736E4C7054413F3222(x UInt8) Engine=Memory;
--
2021.09.27 12:15:47.801760 [ 1345 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Trace> AggregatingTransform: Aggregating
2021.09.27 12:15:47.802496 [ 18328 ] {} <Debug> TCPHandler: Processed in 0.070765485 sec.
2021.09.27 12:15:47.802233 [ 1231 ] {d4a3b4d8-540e-4acd-bd53-99de901cfbef} <Debug> executeQuery: (from [::1]:45508) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_5B2B515F34654922575C3479497647745B77282B2B6A7233303B64323A3E5F6D2F78752E696C2F6C(x UInt8) Engine=Memory;
2021.09.27 12:15:47.801975 [ 13163 ] {8db9dc76-d014-486e-8741-017133b163e8} <Debug> executeQuery: (from [::1]:45564) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_6D443E456024383C3C3E5E5D304F2658437876286E77723B264B465E393E4E41265B7A5F7C4C7D4E(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802535 [ 685 ] {95156d3f-eb36-4d10-958f-7f8fbf3faad9} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_344C3B5A6D59647755525D65207E484B365B6A56743D78296F4B797C387E5D21537B536669223760
2021.09.27 12:15:47.802235 [ 18311 ] {b49cc26a-237b-4894-9d32-9d427ae740b7} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_665626256B226429342D4648543152392F574D656A7971305F504864654939746D4540602D383042
2021.09.27 12:15:47.802550 [ 18370 ] {ef285f48-0b75-4707-a736-595cb1eb0ca2} <Debug> executeQuery: (from [::1]:45560) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_372D5A512C26254944344F3332217C454F783C752D65237B7579243F6C5B7D402722514D7B692D34(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802562 [ 726 ] {debdbcc9-fa16-4b05-917d-3dbf117f8794} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_292A6A337A792E58716C48794355522F56324E267B5D2670236F282A4F6C4A687D6A24256F492E29
2021.09.27 12:15:47.802311 [ 18369 ] {8387e1c5-2df0-4ae1-9375-746174792d77} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_2A4B5E3969433445714F3D5D6B363C6B44457C206E2D46483F3B6E4E6E285D534C22362D37444D49
2021.09.27 12:15:47.802312 [ 684 ] {725165f2-995b-4af5-8145-da56268a9581} <Debug> executeQuery: (from [::1]:45538) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_60225C28382A2676274E4F3D2472297829306730215544425D5B2129624D6221722560287C6C3A32(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802598 [ 18357 ] {80df92f3-ca08-4dfb-adc9-5929401aa381} <Debug> executeQuery: (from [::1]:45506) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_206F5E2A3D7C47323F2D38454466722D45647B22232D5E214E5662754D62623C477C726E28203125(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802053 [ 18355 ] {bef2fa54-e6e5-4061-9def-a5f91e5620e7} <Debug> executeQuery: (from [::1]:45528) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_52523D5B6F47553F75427C39214E517754577C79367170575233293B354C6029702C5567567B4C53(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802325 [ 1224 ] {54f7c6b2-2f1f-47c4-9357-dbcd8142b7c8} <Debug> executeQuery: (from [::1]:45512) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_3D552F573E283D573A6071707D582E2229694779484B55657A4E2C2B573228765A30567370363441(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802400 [ 2497 ] {} <Debug> TCPHandler: Processed in 0.070854838 sec.
2021.09.27 12:15:47.802645 [ 18296 ] {f4e323a2-f797-4ba1-a158-5fe6e82f3e62} <Debug> executeQuery: (from [::1]:45514) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_26662E274A227B426B402E333E2B5957302E762D2B3E356A6B2D7E6C3763375D5A4D6F3A493B4E32(x UInt8) Engine=Memory;
2021.09.27 12:15:47.801891 [ 1225 ] {} <Debug> TCPHandler: Processed in 0.070688245 sec.
2021.09.27 12:15:47.802207 [ 18371 ] {852c6287-7670-4ae3-82da-5f532e8f50b0} <Debug> executeQuery: (from [::1]:45516) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_327C713B702B2A4D3F743067267D717D5C442A3D70532564337C723F4E796E2F5839554A5C39267D(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802699 [ 684 ] {725165f2-995b-4af5-8145-da56268a9581} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_60225C28382A2676274E4F3D2472297829306730215544425D5B2129624D6221722560287C6C3A32
2021.09.27 12:15:47.802513 [ 1345 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Trace> Aggregator: Aggregation method: key32
2021.09.27 12:15:47.802728 [ 18355 ] {bef2fa54-e6e5-4061-9def-a5f91e5620e7} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_52523D5B6F47553F75427C39214E517754577C79367170575233293B354C6029702C5567567B4C53
2021.09.27 12:15:47.802738 [ 1224 ] {54f7c6b2-2f1f-47c4-9357-dbcd8142b7c8} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_3D552F573E283D573A6071707D582E2229694779484B55657A4E2C2B573228765A30567370363441
2021.09.27 12:15:47.802750 [ 18296 ] {f4e323a2-f797-4ba1-a158-5fe6e82f3e62} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_26662E274A227B426B402E333E2B5957302E762D2B3E356A6B2D7E6C3763375D5A4D6F3A493B4E32
2021.09.27 12:15:47.802624 [ 1231 ] {d4a3b4d8-540e-4acd-bd53-99de901cfbef} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_5B2B515F34654922575C3479497647745B77282B2B6A7233303B64323A3E5F6D2F78752E696C2F6C
2021.09.27 12:15:47.802074 [ 18349 ] {} <Debug> TCPHandler: Processed in 0.070418478 sec.
2021.09.27 12:15:47.802643 [ 18292 ] {008c6713-5bfb-4561-b281-78b207b18670} <Debug> executeQuery: (from [::1]:45542) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_465030342E7239302F5827497E703C775C4D3B3F22796B5437334B45563427376A7C385B493D6F5A(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802808 [ 18371 ] {852c6287-7670-4ae3-82da-5f532e8f50b0} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_327C713B702B2A4D3F743067267D717D5C442A3D70532564337C723F4E796E2F5839554A5C39267D
2021.09.27 12:15:47.802444 [ 18323 ] {e1915d4f-757b-4d1b-942c-70ffbccf58a6} <Debug> executeQuery: (from [::1]:45532) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_487560365A724F713D26465D34473E656774283B58394D49527E2F29446343277E42745045304C57(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802672 [ 18370 ] {ef285f48-0b75-4707-a736-595cb1eb0ca2} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_372D5A512C26254944344F3332217C454F783C752D65237B7579243F6C5B7D402722514D7B692D34
2021.09.27 12:15:47.802699 [ 410 ] {b074f503-1c48-4bb8-b005-0b5c809b4f74} <Debug> executeQuery: (from [::1]:45520) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_3C4972243E446C6F4C7E7522724356616C72323D4E5E36275245416579344428433C446D305E4A36(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802510 [ 18464 ] {84a47987-57eb-43c6-93e4-4a03c3c96b36} <Debug> executeQuery: (from [::1]:45504) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_59217330702A3E6041662C6C6D3C3B45384C274B53295D565823637948777E7D576B642E6E787071(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802882 [ 1225 ] {bf21a599-bf95-4bae-9111-14276a7a0694} <Debug> executeQuery: (from [::1]:45546) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_503C76617741407B4C304C5F205C546E432623676626777E4D403737787C6D582333367D582B723F(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802537 [ 18299 ] {5ca4553a-f881-4b9d-8e26-85ae511d77f5} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_79587B3A54294C58436D42735C6B2E5D5E4B2C2741433845515963226C322E562A5A785F554D2372
2021.09.27 12:15:47.802911 [ 18292 ] {008c6713-5bfb-4561-b281-78b207b18670} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_465030342E7239302F5827497E703C775C4D3B3F22796B5437334B45563427376A7C385B493D6F5A
2021.09.27 12:15:47.802749 [ 18328 ] {17b18d76-9d6d-40de-bb72-50c8acf72b83} <Debug> executeQuery: (from [::1]:45558) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_5072654A547C3F5A674F6A53733E217E32774E322F253F647267393432294B465A23547D5B397D6F(x UInt8) Engine=Memory;
2021.09.27 12:15:47.802937 [ 18323 ] {e1915d4f-757b-4d1b-942c-70ffbccf58a6} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_487560365A724F713D26465D34473E656774283B58394D49527E2F29446343277E42745045304C57
2021.09.27 12:15:47.802647 [ 13163 ] {8db9dc76-d014-486e-8741-017133b163e8} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_6D443E456024383C3C3E5E5D304F2658437876286E77723B264B465E393E4E41265B7A5F7C4C7D4E
2021.09.27 12:15:47.802967 [ 410 ] {b074f503-1c48-4bb8-b005-0b5c809b4f74} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_3C4972243E446C6F4C7E7522724356616C72323D4E5E36275245416579344428433C446D305E4A36
2021.09.27 12:15:47.802706 [ 18357 ] {80df92f3-ca08-4dfb-adc9-5929401aa381} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_206F5E2A3D7C47323F2D38454466722D45647B22232D5E214E5662754D62623C477C726E28203125
2021.09.27 12:15:47.803001 [ 1225 ] {bf21a599-bf95-4bae-9111-14276a7a0694} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_503C76617741407B4C304C5F205C546E432623676626777E4D403737787C6D582333367D582B723F
--
2021.09.27 12:15:48.299980 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Information> TCPHandler: Query was cancelled.
2021.09.27 12:15:48.302669 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> StorageDistributed (remote): (127.2:9000) Cancelling query
2021.09.27 12:15:48.302814 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Trace> StorageDistributed (remote): (127.3:9000) Cancelling query
2021.09.27 12:15:48.303036 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Information> executeQuery: Read 1517800 rows, 11.58 MiB in 0.508746614 sec., 2983410 rows/sec., 22.76 MiB/sec.
2021.09.27 12:15:48.303064 [ 18374 ] {b0364447-5e5c-4478-9623-186323c4f8ed} <Debug> MemoryTracker: Peak memory usage (for query): 4.31 MiB.
2021.09.27 12:15:48.303533 [ 18374 ] {} <Debug> MemoryTracker: Peak memory usage (for query): 4.31 MiB.
2021.09.27 12:15:48.303548 [ 18374 ] {} <Debug> TCPHandler: Processed in 0.50977332 sec.
2021.09.27 12:15:48.303622 [ 18374 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.311489 [ 18374 ] {} <Trace> TCPHandlerFactory: TCP Request. Address: [::1]:45888
2021.09.27 12:15:48.311541 [ 18374 ] {} <Debug> TCPHandler: Connected ClickHouse client version 21.11.0, revision: 54449, database: test_3gma5f, user: default.
2021.09.27 12:15:48.312157 [ 18374 ] {e71bdcb7-f74f-45e2-acf7-6068800edb64} <Debug> executeQuery: (from [::1]:45888) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01516_drop_table_stress_long.sh') DROP TABLE IF EXISTS test_01516_test_3gma5f.data1;
2021.09.27 12:15:48.312324 [ 18374 ] {e71bdcb7-f74f-45e2-acf7-6068800edb64} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.312462 [ 18374 ] {} <Debug> TCPHandler: Processed in 0.000518352 sec.
2021.09.27 12:15:48.312568 [ 18374 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.316133 [ 2488 ] {b6fdd949-9549-4d45-a956-c0113823aeb4} <Information> DatabaseOrdinary (test_sc0own): Metadata processed, database test_sc0own has 0 tables and 0 dictionaries in total.
2021.09.27 12:15:48.316169 [ 2488 ] {b6fdd949-9549-4d45-a956-c0113823aeb4} <Information> TablesLoader: Parsed metadata of 0 tables in 1 databases in 0.000134591 sec
2021.09.27 12:15:48.316178 [ 2488 ] {b6fdd949-9549-4d45-a956-c0113823aeb4} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:48.316186 [ 2488 ] {b6fdd949-9549-4d45-a956-c0113823aeb4} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:48.316194 [ 2488 ] {b6fdd949-9549-4d45-a956-c0113823aeb4} <Information> TablesLoader: Loading 0 tables with 0 dependency level
2021.09.27 12:15:48.316202 [ 2488 ] {b6fdd949-9549-4d45-a956-c0113823aeb4} <Information> DatabaseOrdinary (test_sc0own): Starting up tables.
2021.09.27 12:15:48.316278 [ 2488 ] {b6fdd949-9549-4d45-a956-c0113823aeb4} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.316287 [ 5339 ] {5b845b19-4e96-4eb5-a2a8-a30db95a5efa} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.316288 [ 18318 ] {b3263fed-be47-4725-877e-0f5fb11c4271} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.316292 [ 2483 ] {d36aae89-d1b8-4f5c-a5a1-58b2555ff66f} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.316439 [ 18318 ] {} <Debug> TCPHandler: Processed in 0.098035179 sec.
--
2021.09.27 12:15:48.353182 [ 18374 ] {2d354b3f-4aa8-4797-a275-4bd5f6c6d8e3} <Debug> executeQuery: (from [::1]:45890) (comment: 01514_distributed_cancel_query_on_error.sh) DROP DATABASE test_8fczje
2021.09.27 12:15:48.353298 [ 18374 ] {2d354b3f-4aa8-4797-a275-4bd5f6c6d8e3} <Trace> ContextAccess (default): Access granted: DROP DATABASE ON test_8fczje.*
2021.09.27 12:15:48.353543 [ 18374 ] {2d354b3f-4aa8-4797-a275-4bd5f6c6d8e3} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.353653 [ 18374 ] {} <Debug> TCPHandler: Processed in 0.000684747 sec.
2021.09.27 12:15:48.353791 [ 18374 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.356689 [ 18374 ] {} <Trace> TCPHandlerFactory: TCP Request. Address: [::1]:45892
2021.09.27 12:15:48.356737 [ 18374 ] {} <Debug> TCPHandler: Connected ClickHouse client version 21.11.0, revision: 54449, database: test_3gma5f, user: default.
2021.09.27 12:15:48.357371 [ 18374 ] {8431ff94-f53f-404f-9121-81026898c5d6} <Debug> executeQuery: (from [::1]:45892) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01516_drop_table_stress_long.sh') DROP TABLE IF EXISTS test_01516_test_3gma5f.data2;
2021.09.27 12:15:48.357522 [ 18374 ] {8431ff94-f53f-404f-9121-81026898c5d6} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.357626 [ 18374 ] {} <Debug> TCPHandler: Processed in 0.000434086 sec.
2021.09.27 12:15:48.357769 [ 18374 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.363511 [ 18374 ] {} <Trace> TCPHandlerFactory: TCP Request. Address: [::1]:45894
2021.09.27 12:15:48.363556 [ 18374 ] {} <Debug> TCPHandler: Connected ClickHouse client version 21.11.0, revision: 54449, database: test_sc0own, user: default.
2021.09.27 12:15:48.363675 [ 18374 ] {} <Trace> ContextAccess (default): Settings: readonly=0, allow_ddl=true, allow_introspection_functions=false
2021.09.27 12:15:48.363697 [ 18374 ] {} <Trace> ContextAccess (default): List of all grants: GRANT ALL ON *.* WITH GRANT OPTION
2021.09.27 12:15:48.363707 [ 18374 ] {} <Trace> ContextAccess (default): List of all grants including implicit: GRANT ALL ON *.* WITH GRANT OPTION
2021.09.27 12:15:48.364326 [ 18374 ] {5b7e164b-0bcf-4ff7-a44e-ffeeb937009d} <Debug> executeQuery: (from [::1]:45894) (comment: 01513_count_without_select_sequence_consistency_zookeeper_long.sql) SET send_logs_level = 'fatal';
2021.09.27 12:15:48.364477 [ 18374 ] {5b7e164b-0bcf-4ff7-a44e-ffeeb937009d} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.364590 [ 18374 ] {} <Debug> TCPHandler: Processed in 0.000483767 sec.
2021.09.27 12:15:48.364849 [ 18374 ] {daae5054-3123-4880-bf97-be09521ea0e6} <Debug> executeQuery: (from [::1]:45894) (comment: 01513_count_without_select_sequence_consistency_zookeeper_long.sql) DROP TABLE IF EXISTS quorum1 SYNC;
2021.09.27 12:15:48.364994 [ 18374 ] {daae5054-3123-4880-bf97-be09521ea0e6} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
--
2021.09.27 12:15:48.402631 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Information> TCPHandler: Query was cancelled.
2021.09.27 12:15:48.402644 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Information> TCPHandler: Query was cancelled.
2021.09.27 12:15:48.402733 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Debug> executeQuery: (from [::1]:45896) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01516_drop_table_stress_long.sh') CREATE DATABASE IF NOT EXISTS test_01516_test_3gma5f;
2021.09.27 12:15:48.402834 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Trace> ContextAccess (default): Access granted: CREATE DATABASE ON test_01516_test_3gma5f.*
2021.09.27 12:15:48.402958 [ 13162 ] {a5b37c95-836b-4796-b578-99da6c732f41} <Debug> executeQuery: (from [::1]:45898) SELECT zookeeperSessionUptime()
2021.09.27 12:15:48.403248 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Error> executeQuery: Code: 210. DB::NetException: I/O error: Broken pipe, while writing to socket ([::ffff:127.0.0.1]:60224). (NETWORK_ERROR) (version 21.11.1.8214 (official build)) (from [::ffff:127.0.0.1]:60224) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01514_distributed_cancel_query_on_error.sh') (in query: WITH toUInt32(1) AS _shard_num SELECT groupArray(repeat('a', if(_shard_num = 2, 100000, 1))), number % 100000 AS k FROM system.numbers GROUP BY k LIMIT 10000000.), Stack trace (when copying this message, always include the lines below):

0. DB::Exception::Exception(std::__1::basic_string<char, std::__1::char_traits<char>, std::__1::allocator<char> > const&, int, bool) @ 0x94ef994 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
1. DB::WriteBufferFromPocoSocket::nextImpl() @ 0x10dfa61c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
2. DB::TCPHandler::sendProgress() @ 0x11f0cad8 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
3. DB::TCPHandler::processOrdinaryQueryWithProcessors() @ 0x11f09e19 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
4. DB::TCPHandler::runImpl() @ 0x11f03520 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
5. DB::TCPHandler::run() @ 0x11f11ff9 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
6. Poco::Net::TCPServerConnection::start() @ 0x14b1e8cf in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
7. Poco::Net::TCPServerDispatcher::run() @ 0x14b20cc1 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
8. Poco::PooledThread::run() @ 0x14c35469 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
9. Poco::ThreadImpl::runnableEntry(void*) @ 0x14c32ba0 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
10. start_thread @ 0x9609 in /usr/lib/x86_64-linux-gnu/libpthread-2.31.so
11. __clone @ 0x122293 in /usr/lib/x86_64-linux-gnu/libc-2.31.so

2021.09.27 12:15:48.403278 [ 13162 ] {a5b37c95-836b-4796-b578-99da6c732f41} <Trace> ContextAccess (default): Access granted: SELECT(dummy) ON system.one
2021.09.27 12:15:48.403346 [ 13162 ] {a5b37c95-836b-4796-b578-99da6c732f41} <Trace> InterpreterSelectQuery: FetchColumns -> Complete
2021.09.27 12:15:48.403647 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Error> TCPHandler: Can't send logs to client: Code: 210. DB::NetException: I/O error: Broken pipe, while writing to socket ([::ffff:127.0.0.1]:60224). (NETWORK_ERROR), Stack trace (when copying this message, always include the lines below):

0. DB::Exception::Exception(std::__1::basic_string<char, std::__1::char_traits<char>, std::__1::allocator<char> > const&, int, bool) @ 0x94ef994 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
1. DB::WriteBufferFromPocoSocket::nextImpl() @ 0x10dfa61c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
2. DB::TCPHandler::sendLogData(DB::Block const&) @ 0x11f11eb8 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
3. DB::TCPHandler::sendLogs() @ 0x11f0a79c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
4. DB::TCPHandler::runImpl() @ 0x11f0333e in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
5. DB::TCPHandler::run() @ 0x11f11ff9 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
6. Poco::Net::TCPServerConnection::start() @ 0x14b1e8cf in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
7. Poco::Net::TCPServerDispatcher::run() @ 0x14b20cc1 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
8. Poco::PooledThread::run() @ 0x14c35469 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
9. Poco::ThreadImpl::runnableEntry(void*) @ 0x14c32ba0 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
10. start_thread @ 0x9609 in /usr/lib/x86_64-linux-gnu/libpthread-2.31.so
11. __clone @ 0x122293 in /usr/lib/x86_64-linux-gnu/libc-2.31.so
 (version 21.11.1.8214 (official build))
2021.09.27 12:15:48.403695 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Error> TCPHandler: Code: 210. DB::Exception: I/O error: Broken pipe, while writing to socket ([::ffff:127.0.0.1]:60224). (NETWORK_ERROR), Stack trace (when copying this message, always include the lines below):

0. DB::Exception::Exception(std::__1::basic_string<char, std::__1::char_traits<char>, std::__1::allocator<char> > const&, int, bool) @ 0x94ef994 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
1. DB::WriteBufferFromPocoSocket::nextImpl() @ 0x10dfa61c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
2. DB::TCPHandler::sendProgress() @ 0x11f0cad8 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
3. DB::TCPHandler::processOrdinaryQueryWithProcessors() @ 0x11f09e19 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
4. DB::TCPHandler::runImpl() @ 0x11f03520 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
5. DB::TCPHandler::run() @ 0x11f11ff9 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
6. Poco::Net::TCPServerConnection::start() @ 0x14b1e8cf in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
7. Poco::Net::TCPServerDispatcher::run() @ 0x14b20cc1 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
8. Poco::PooledThread::run() @ 0x14c35469 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
9. Poco::ThreadImpl::runnableEntry(void*) @ 0x14c32ba0 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
10. start_thread @ 0x9609 in /usr/lib/x86_64-linux-gnu/libpthread-2.31.so
11. __clone @ 0x122293 in /usr/lib/x86_64-linux-gnu/libc-2.31.so

2021.09.27 12:15:48.403874 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Warning> TCPHandler: Client has gone away.
2021.09.27 12:15:48.403944 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Trace> Aggregator: Destroying aggregate states
2021.09.27 12:15:48.403960 [ 13162 ] {a5b37c95-836b-4796-b578-99da6c732f41} <Information> executeQuery: Read 1 rows, 1.00 B in 0.000963901 sec., 1037 rows/sec., 1.01 KiB/sec.
2021.09.27 12:15:48.403983 [ 13162 ] {a5b37c95-836b-4796-b578-99da6c732f41} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.404111 [ 13162 ] {} <Debug> TCPHandler: Processed in 0.00140687 sec.
2021.09.27 12:15:48.404423 [ 13162 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.405489 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Error> executeQuery: Code: 210. DB::NetException: I/O error: Broken pipe, while writing to socket ([::ffff:127.0.0.1]:33716). (NETWORK_ERROR) (version 21.11.1.8214 (official build)) (from [::ffff:127.0.0.1]:33716) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01514_distributed_cancel_query_on_error.sh') (in query: WITH toUInt32(2) AS _shard_num SELECT groupArray(repeat('a', if(_shard_num = 2, 100000, 1))), number % 100000 AS k FROM system.numbers GROUP BY k LIMIT 10000000.), Stack trace (when copying this message, always include the lines below):

0. DB::Exception::Exception(std::__1::basic_string<char, std::__1::char_traits<char>, std::__1::allocator<char> > const&, int, bool) @ 0x94ef994 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
1. DB::WriteBufferFromPocoSocket::nextImpl() @ 0x10dfa61c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
2. DB::TCPHandler::sendProgress() @ 0x11f0cad8 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
3. DB::TCPHandler::processOrdinaryQueryWithProcessors() @ 0x11f09e19 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
4. DB::TCPHandler::runImpl() @ 0x11f03520 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
5. DB::TCPHandler::run() @ 0x11f11ff9 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
6. Poco::Net::TCPServerConnection::start() @ 0x14b1e8cf in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
7. Poco::Net::TCPServerDispatcher::run() @ 0x14b20cc1 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
8. Poco::PooledThread::run() @ 0x14c35469 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
9. Poco::ThreadImpl::runnableEntry(void*) @ 0x14c32ba0 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
10. start_thread @ 0x9609 in /usr/lib/x86_64-linux-gnu/libpthread-2.31.so
11. __clone @ 0x122293 in /usr/lib/x86_64-linux-gnu/libc-2.31.so

2021.09.27 12:15:48.405846 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Error> TCPHandler: Can't send logs to client: Code: 210. DB::NetException: I/O error: Broken pipe, while writing to socket ([::ffff:127.0.0.1]:33716). (NETWORK_ERROR), Stack trace (when copying this message, always include the lines below):

0. DB::Exception::Exception(std::__1::basic_string<char, std::__1::char_traits<char>, std::__1::allocator<char> > const&, int, bool) @ 0x94ef994 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
1. DB::WriteBufferFromPocoSocket::nextImpl() @ 0x10dfa61c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
2. DB::TCPHandler::sendLogData(DB::Block const&) @ 0x11f11eb8 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
3. DB::TCPHandler::sendLogs() @ 0x11f0a79c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
4. DB::TCPHandler::runImpl() @ 0x11f0333e in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
5. DB::TCPHandler::run() @ 0x11f11ff9 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
6. Poco::Net::TCPServerConnection::start() @ 0x14b1e8cf in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
7. Poco::Net::TCPServerDispatcher::run() @ 0x14b20cc1 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
8. Poco::PooledThread::run() @ 0x14c35469 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
9. Poco::ThreadImpl::runnableEntry(void*) @ 0x14c32ba0 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
10. start_thread @ 0x9609 in /usr/lib/x86_64-linux-gnu/libpthread-2.31.so
11. __clone @ 0x122293 in /usr/lib/x86_64-linux-gnu/libc-2.31.so
 (version 21.11.1.8214 (official build))
2021.09.27 12:15:48.405872 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Error> TCPHandler: Code: 210. DB::Exception: I/O error: Broken pipe, while writing to socket ([::ffff:127.0.0.1]:33716). (NETWORK_ERROR), Stack trace (when copying this message, always include the lines below):

0. DB::Exception::Exception(std::__1::basic_string<char, std::__1::char_traits<char>, std::__1::allocator<char> > const&, int, bool) @ 0x94ef994 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
1. DB::WriteBufferFromPocoSocket::nextImpl() @ 0x10dfa61c in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
2. DB::TCPHandler::sendProgress() @ 0x11f0cad8 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
3. DB::TCPHandler::processOrdinaryQueryWithProcessors() @ 0x11f09e19 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
4. DB::TCPHandler::runImpl() @ 0x11f03520 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
5. DB::TCPHandler::run() @ 0x11f11ff9 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
6. Poco::Net::TCPServerConnection::start() @ 0x14b1e8cf in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
7. Poco::Net::TCPServerDispatcher::run() @ 0x14b20cc1 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
8. Poco::PooledThread::run() @ 0x14c35469 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
9. Poco::ThreadImpl::runnableEntry(void*) @ 0x14c32ba0 in /usr/lib/debug/.build-id/aa/4297f9d3a82fbc22662e92b21dbc02504478cf.debug
10. start_thread @ 0x9609 in /usr/lib/x86_64-linux-gnu/libpthread-2.31.so
11. __clone @ 0x122293 in /usr/lib/x86_64-linux-gnu/libc-2.31.so

2021.09.27 12:15:48.406072 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Warning> TCPHandler: Client has gone away.
2021.09.27 12:15:48.406137 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Trace> Aggregator: Destroying aggregate states
2021.09.27 12:15:48.407736 [ 18373 ] {1c5c3e26-5396-40e1-9ef5-215722652bdc} <Debug> MemoryTracker: Peak memory usage (for query): 132.00 MiB.
2021.09.27 12:15:48.407772 [ 18373 ] {} <Debug> MemoryTracker: Peak memory usage (for query): 132.00 MiB.
2021.09.27 12:15:48.407783 [ 18373 ] {} <Debug> TCPHandler: Processed in 0.608145181 sec.
2021.09.27 12:15:48.407808 [ 18373 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.427563 [ 18374 ] {52a979b3-209e-46bc-b340-a6aca549d20e} <Debug> test_sc0own.quorum1: Loading data parts
2021.09.27 12:15:48.428280 [ 18374 ] {52a979b3-209e-46bc-b340-a6aca549d20e} <Debug> test_sc0own.quorum1: There are no data parts
2021.09.27 12:15:48.428433 [ 2483 ] {a4ec167e-b8a1-413c-815b-3f78f21803aa} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.428465 [ 5339 ] {8299ce1d-03cb-44c5-9c6c-7451f7be4405} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.428491 [ 446 ] {} <Test> KeeperStateMachine: Commit request for session 1 with type Create, log id 7861, path /clickhouse
2021.09.27 12:15:48.428590 [ 2483 ] {} <Debug> TCPHandler: Processed in 0.111989607 sec.
2021.09.27 12:15:48.428668 [ 5339 ] {} <Debug> TCPHandler: Processed in 0.112076748 sec.
2021.09.27 12:15:48.428716 [ 446 ] {} <Test> KeeperStateMachine: Commit request for session 1 with type Create, log id 7862, path /clickhouse/tables
2021.09.27 12:15:48.428891 [ 446 ] {} <Test> KeeperStateMachine: Commit request for session 1 with type Create, log id 7863, path /clickhouse/tables/test_sc0own
2021.09.27 12:15:48.428965 [ 2483 ] {91c04f20-b20a-40e1-9f71-54381a689ebd} <Debug> executeQuery: (from [::1]:45556) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_505A37294E6D512921225C35276B34405527396B41705B7D5A4F6D74326D336457456E4D27373357(x UInt8) Engine=Memory;
2021.09.27 12:15:48.428977 [ 5339 ] {fc678ca9-3f20-49a4-a678-59c81601a0fa} <Debug> executeQuery: (from [::1]:45530) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_5A5B28337E7A6B4276294B766F232E3548697E7148237B3E22542F4B33586D375F4A4F383B63532F(x UInt8) Engine=Memory;
2021.09.27 12:15:48.429073 [ 446 ] {} <Test> KeeperStateMachine: Commit request for session 1 with type Create, log id 7864, path /clickhouse/tables/test_sc0own/test_01513
2021.09.27 12:15:48.429088 [ 2483 ] {91c04f20-b20a-40e1-9f71-54381a689ebd} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_505A37294E6D512921225C35276B34405527396B41705B7D5A4F6D74326D336457456E4D27373357
2021.09.27 12:15:48.429098 [ 5339 ] {fc678ca9-3f20-49a4-a678-59c81601a0fa} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_5A5B28337E7A6B4276294B766F232E3548697E7148237B3E22542F4B33586D375F4A4F383B63532F
2021.09.27 12:15:48.429334 [ 18374 ] {52a979b3-209e-46bc-b340-a6aca549d20e} <Debug> test_sc0own.quorum1: Creating table /clickhouse/tables/test_sc0own/test_01513/sequence_consistency
2021.09.27 12:15:48.429626 [ 446 ] {} <Test> KeeperStateMachine: Commit request for session 1 with type Multi, log id 7865
2021.09.27 12:15:48.430486 [ 446 ] {} <Test> KeeperStateMachine: Commit request for session 1 with type Create, log id 7866, path /clickhouse/tables/test_sc0own/test_01513/sequence_consistency/quorum
--
2021.09.27 12:15:48.455617 [ 18509 ] {0ae7d39f-d2e0-43a7-ae89-bf2681d997ce} <Debug> MemoryTracker: Peak memory usage (for query): 920.91 MiB.
2021.09.27 12:15:48.455641 [ 18509 ] {} <Debug> MemoryTracker: Peak memory usage (for query): 920.91 MiB.
2021.09.27 12:15:48.455650 [ 18509 ] {} <Debug> TCPHandler: Processed in 0.655602183 sec.
2021.09.27 12:15:48.455672 [ 18509 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.455808 [ 18318 ] {45202779-ca39-47c3-9efd-f256590880c8} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.455936 [ 18318 ] {} <Debug> TCPHandler: Processed in 0.139336283 sec.
2021.09.27 12:15:48.456239 [ 18318 ] {03d056ce-810f-4ae4-8656-f482e27bdc00} <Debug> executeQuery: (from [::1]:45536) (comment: '/usr/share/clickhouse-test/queries/0_stateless/01526_client_start_and_exit.sh') CREATE TABLE test_49532340467743234541567D29604B78704F797A5964426E734868424B72747342557E2945426C2D(x UInt8) Engine=Memory;
2021.09.27 12:15:48.456364 [ 18318 ] {03d056ce-810f-4ae4-8656-f482e27bdc00} <Trace> ContextAccess (default): Access granted: CREATE TABLE ON test_xwyba8.test_49532340467743234541567D29604B78704F797A5964426E734868424B72747342557E2945426C2D
2021.09.27 12:15:48.472939 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Information> DatabaseOrdinary (test_01516_test_3gma5f): Metadata processed, database test_01516_test_3gma5f has 0 tables and 0 dictionaries in total.
2021.09.27 12:15:48.472972 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Information> TablesLoader: Parsed metadata of 0 tables in 1 databases in 0.000143574 sec
2021.09.27 12:15:48.472981 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:48.472989 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Test> TablesLoader: Have 0 independent tables:
2021.09.27 12:15:48.472998 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Information> TablesLoader: Loading 0 tables with 0 dependency level
2021.09.27 12:15:48.473007 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Information> DatabaseOrdinary (test_01516_test_3gma5f): Starting up tables.
2021.09.27 12:15:48.473123 [ 2488 ] {00979370-2691-4644-9ca1-c4fb4a8497bd} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.473265 [ 2488 ] {} <Debug> TCPHandler: Processed in 0.070698486 sec.
2021.09.27 12:15:48.473409 [ 2488 ] {} <Debug> TCPHandler: Done processing connection.
2021.09.27 12:15:48.474026 [ 18369 ] {c61a6f50-d774-420e-9eba-b5a9d6b935b3} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.474051 [ 18311 ] {0ae597f6-6b3e-4377-a781-c212cb35aa94} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.474084 [ 18464 ] {212cad4d-f507-4922-bd87-3568c14a49bd} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.
2021.09.27 12:15:48.474114 [ 18310 ] {e0f98e15-3bb0-4e0b-b1c0-22fabfe9dab0} <Debug> MemoryTracker: Peak memory usage (for query): 0.00 B.