ClickHouse/tests/integration/test_lost_part/test.py

Ignoring revisions in .git-blame-ignore-revs. Click here to bypass and see the normal blame view.

296 lines
10 KiB
Python
Raw Normal View History

2021-06-29 19:47:54 +00:00
#!/usr/bin/env python3
import pytest
import time
import ast
import random
from helpers.cluster import ClickHouseCluster
from helpers.test_tools import assert_eq_with_retry
cluster = ClickHouseCluster(__file__)
node1 = cluster.add_instance("node1", with_zookeeper=True)
node2 = cluster.add_instance("node2", with_zookeeper=True)
2021-06-29 19:47:54 +00:00
@pytest.fixture(scope="module")
def start_cluster():
try:
cluster.start()
yield cluster
finally:
cluster.shutdown()
def remove_part_from_disk(node, table, part_name):
part_path = node.query(
2023-01-04 20:28:03 +00:00
f"SELECT path FROM system.parts WHERE table = '{table}' and name = '{part_name}'"
).strip()
2021-06-29 19:47:54 +00:00
if not part_path:
raise Exception("Part " + part_name + "doesn't exist")
node.exec_in_container(
["bash", "-c", "rm -r {p}/*".format(p=part_path)], privileged=True
)
2021-06-29 19:47:54 +00:00
def test_lost_part_same_replica(start_cluster):
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt0 SYNC")
node2.query("DROP TABLE IF EXISTS mt0 SYNC")
2021-06-29 19:47:54 +00:00
for node in [node1, node2]:
node.query(
2023-01-04 20:28:03 +00:00
f"CREATE TABLE mt0 (id UInt64, date Date) ENGINE ReplicatedMergeTree('/clickhouse/tables/t', '{node.name}') ORDER BY tuple() PARTITION BY date "
2023-05-30 16:46:49 +00:00
"SETTINGS cleanup_delay_period=1, cleanup_delay_period_random_add=1, cleanup_thread_preferred_points_per_iteration=0,"
"merge_selecting_sleep_ms=100, max_merge_selecting_sleep_ms=1000"
)
2021-06-29 19:47:54 +00:00
node1.query("SYSTEM STOP MERGES mt0")
node2.query("SYSTEM STOP REPLICATION QUEUES")
for i in range(5):
2023-01-04 20:28:03 +00:00
node1.query(f"INSERT INTO mt0 VALUES ({i}, toDate('2020-10-01'))")
2021-06-29 19:47:54 +00:00
for i in range(20):
parts_to_merge = node1.query(
2023-01-04 20:28:03 +00:00
"SELECT parts_to_merge FROM system.replication_queue WHERE table='mt0' AND length(parts_to_merge) > 0"
)
2021-06-29 19:47:54 +00:00
if parts_to_merge:
parts_list = list(sorted(ast.literal_eval(parts_to_merge)))
print("Got parts list", parts_list)
if len(parts_list) < 3:
2023-01-04 20:28:03 +00:00
raise Exception(f"Got too small parts list {parts_list}")
2021-06-29 19:47:54 +00:00
break
time.sleep(1)
victim_part_from_the_middle = random.choice(parts_list[1:-1])
print("Will corrupt part", victim_part_from_the_middle)
remove_part_from_disk(node1, "mt0", victim_part_from_the_middle)
2021-06-29 19:47:54 +00:00
node1.query("DETACH TABLE mt0")
node1.query("ATTACH TABLE mt0")
node1.query("SYSTEM START MERGES mt0")
2022-10-02 12:50:24 +00:00
res, err = node1.query_and_get_answer_with_error("SYSTEM SYNC REPLICA mt0")
2022-09-27 15:34:24 +00:00
print("result: ", res)
print("error: ", res)
2021-06-29 19:47:54 +00:00
for i in range(10):
result = node1.query("SELECT count() FROM system.replication_queue")
if int(result) == 0:
break
time.sleep(1)
else:
assert False, "Still have something in replication queue:\n" + node1.query(
"SELECT count() FROM system.replication_queue FORMAT Vertical"
)
2021-06-29 19:47:54 +00:00
assert node1.contains_in_log(
"Created empty part"
2023-01-04 20:28:03 +00:00
), f"Seems like empty part {victim_part_from_the_middle} is not created or log message changed"
2021-06-29 19:47:54 +00:00
2021-06-30 09:35:09 +00:00
assert node1.query("SELECT COUNT() FROM mt0") == "4\n"
2021-06-29 19:47:54 +00:00
node2.query("SYSTEM START REPLICATION QUEUES")
2021-06-30 09:35:09 +00:00
assert_eq_with_retry(node2, "SELECT COUNT() FROM mt0", "4")
assert_eq_with_retry(node2, "SELECT COUNT() FROM system.replication_queue", "0")
2021-06-29 19:47:54 +00:00
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt0 SYNC")
node2.query("DROP TABLE IF EXISTS mt0 SYNC")
2021-06-29 19:47:54 +00:00
def test_lost_part_other_replica(start_cluster):
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt1 SYNC")
node2.query("DROP TABLE IF EXISTS mt1 SYNC")
2021-06-29 19:47:54 +00:00
for node in [node1, node2]:
node.query(
2023-01-04 20:28:03 +00:00
f"CREATE TABLE mt1 (id UInt64) ENGINE ReplicatedMergeTree('/clickhouse/tables/t1', '{node.name}') ORDER BY tuple() "
2023-05-30 16:46:49 +00:00
"SETTINGS cleanup_delay_period=1, cleanup_delay_period_random_add=1, cleanup_thread_preferred_points_per_iteration=0,"
"merge_selecting_sleep_ms=100, max_merge_selecting_sleep_ms=1000"
)
2021-06-29 19:47:54 +00:00
node1.query("SYSTEM STOP MERGES mt1")
node2.query("SYSTEM STOP REPLICATION QUEUES")
for i in range(5):
2023-01-04 20:28:03 +00:00
node1.query(f"INSERT INTO mt1 VALUES ({i})")
2021-06-29 19:47:54 +00:00
for i in range(20):
parts_to_merge = node1.query(
2023-01-04 20:28:03 +00:00
"SELECT parts_to_merge FROM system.replication_queue WHERE table='mt1' AND length(parts_to_merge) > 0"
)
2021-06-29 19:47:54 +00:00
if parts_to_merge:
parts_list = list(sorted(ast.literal_eval(parts_to_merge)))
print("Got parts list", parts_list)
if len(parts_list) < 3:
raise Exception("Got too small parts list {}".format(parts_list))
break
time.sleep(1)
victim_part_from_the_middle = random.choice(parts_list[1:-1])
print("Will corrupt part", victim_part_from_the_middle)
remove_part_from_disk(node1, "mt1", victim_part_from_the_middle)
2021-06-29 19:47:54 +00:00
# other way to detect broken parts
node1.query("CHECK TABLE mt1")
node2.query("SYSTEM START REPLICATION QUEUES")
2022-10-02 12:50:24 +00:00
res, err = node1.query_and_get_answer_with_error("SYSTEM SYNC REPLICA mt1")
2022-09-27 15:34:24 +00:00
print("result: ", res)
print("error: ", res)
2021-06-29 19:47:54 +00:00
for i in range(10):
result = node2.query("SELECT count() FROM system.replication_queue")
if int(result) == 0:
break
time.sleep(1)
else:
assert False, "Still have something in replication queue:\n" + node2.query(
"SELECT * FROM system.replication_queue FORMAT Vertical"
)
2021-06-29 19:47:54 +00:00
assert node1.contains_in_log(
"Created empty part"
), "Seems like empty part {} is not created or log message changed".format(
victim_part_from_the_middle
)
2021-06-29 19:47:54 +00:00
2021-06-30 09:35:09 +00:00
assert_eq_with_retry(node2, "SELECT COUNT() FROM mt1", "4")
assert_eq_with_retry(node2, "SELECT COUNT() FROM system.replication_queue", "0")
2021-06-29 19:47:54 +00:00
node1.query("SYSTEM START MERGES mt1")
2021-06-30 09:35:09 +00:00
assert_eq_with_retry(node1, "SELECT COUNT() FROM mt1", "4")
assert_eq_with_retry(node1, "SELECT COUNT() FROM system.replication_queue", "0")
2021-06-29 19:47:54 +00:00
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt1 SYNC")
node2.query("DROP TABLE IF EXISTS mt1 SYNC")
2021-06-29 19:47:54 +00:00
def test_lost_part_mutation(start_cluster):
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt2 SYNC")
node2.query("DROP TABLE IF EXISTS mt2 SYNC")
2021-06-29 19:47:54 +00:00
for node in [node1, node2]:
node.query(
2023-01-04 20:28:03 +00:00
f"CREATE TABLE mt2 (id UInt64) ENGINE ReplicatedMergeTree('/clickhouse/tables/t2', '{node.name}') ORDER BY tuple() "
2023-05-30 16:46:49 +00:00
"SETTINGS cleanup_delay_period=1, cleanup_delay_period_random_add=1, cleanup_thread_preferred_points_per_iteration=0,"
"merge_selecting_sleep_ms=100, max_merge_selecting_sleep_ms=1000"
)
2021-06-29 19:47:54 +00:00
node1.query("SYSTEM STOP MERGES mt2")
node2.query("SYSTEM STOP REPLICATION QUEUES")
for i in range(2):
2023-01-04 20:28:03 +00:00
node1.query(f"INSERT INTO mt2 VALUES ({i})")
2021-06-29 19:47:54 +00:00
node1.query(
"ALTER TABLE mt2 UPDATE id = 777 WHERE 1", settings={"mutations_sync": "0"}
)
2021-06-29 19:47:54 +00:00
for i in range(20):
2023-01-04 20:30:52 +00:00
parts_to_mutate = node1.query(
"SELECT count() FROM system.replication_queue WHERE table='mt2'"
)
2021-06-29 19:47:54 +00:00
# two mutations for both replicas
if int(parts_to_mutate) == 4:
break
time.sleep(1)
remove_part_from_disk(node1, "mt2", "all_1_1_0")
2021-06-29 19:47:54 +00:00
# other way to detect broken parts
node1.query("CHECK TABLE mt2")
node1.query("SYSTEM START MERGES mt2")
2022-10-02 12:50:24 +00:00
res, err = node1.query_and_get_answer_with_error("SYSTEM SYNC REPLICA mt2")
2022-09-27 15:34:24 +00:00
print("result: ", res)
print("error: ", res)
2021-06-29 19:47:54 +00:00
for i in range(10):
result = node1.query("SELECT count() FROM system.replication_queue")
if int(result) == 0:
break
time.sleep(1)
else:
assert False, "Still have something in replication queue:\n" + node1.query(
"SELECT * FROM system.replication_queue FORMAT Vertical"
)
2021-06-29 19:47:54 +00:00
assert_eq_with_retry(node1, "SELECT COUNT() FROM mt2", "1")
assert_eq_with_retry(node1, "SELECT SUM(id) FROM mt2", "777")
2021-06-30 09:35:09 +00:00
assert_eq_with_retry(node1, "SELECT COUNT() FROM system.replication_queue", "0")
2021-06-29 19:47:54 +00:00
node2.query("SYSTEM START REPLICATION QUEUES")
assert_eq_with_retry(node2, "SELECT COUNT() FROM mt2", "1")
assert_eq_with_retry(node2, "SELECT SUM(id) FROM mt2", "777")
2021-06-30 09:35:09 +00:00
assert_eq_with_retry(node2, "SELECT COUNT() FROM system.replication_queue", "0")
2021-06-29 19:47:54 +00:00
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt2 SYNC")
node2.query("DROP TABLE IF EXISTS mt2 SYNC")
2021-06-29 19:47:54 +00:00
def test_lost_last_part(start_cluster):
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt3 SYNC")
node2.query("DROP TABLE IF EXISTS mt3 SYNC")
2021-06-29 19:47:54 +00:00
for node in [node1, node2]:
node.query(
2023-01-04 20:28:03 +00:00
f"CREATE TABLE mt3 (id UInt64, p String) ENGINE ReplicatedMergeTree('/clickhouse/tables/t3', '{node.name}') "
2023-05-30 16:46:49 +00:00
"ORDER BY tuple() PARTITION BY p SETTINGS cleanup_delay_period=1, cleanup_delay_period_random_add=1, cleanup_thread_preferred_points_per_iteration=0,"
"merge_selecting_sleep_ms=100, max_merge_selecting_sleep_ms=1000"
)
2021-06-29 19:47:54 +00:00
node1.query("SYSTEM STOP MERGES mt3")
node2.query("SYSTEM STOP REPLICATION QUEUES")
for i in range(1):
2023-01-04 20:28:03 +00:00
node1.query(f"INSERT INTO mt3 VALUES ({i}, 'x')")
2021-06-29 19:47:54 +00:00
# actually not important
node1.query(
"ALTER TABLE mt3 UPDATE id = 777 WHERE 1", settings={"mutations_sync": "0"}
)
2021-06-29 19:47:54 +00:00
2021-11-30 10:22:37 +00:00
partition_id = node1.query("select partitionId('x')").strip()
2023-01-04 20:28:03 +00:00
remove_part_from_disk(node1, "mt3", f"{partition_id}_0_0_0")
2021-06-29 19:47:54 +00:00
# other way to detect broken parts
node1.query("CHECK TABLE mt3")
node1.query("SYSTEM START MERGES mt3")
for i in range(10):
2023-01-04 20:30:52 +00:00
result = node1.query(
"SELECT count() FROM system.replication_queue WHERE table='mt3'"
)
2022-09-27 15:42:36 +00:00
assert int(result) <= 2, "Have a lot of entries in queue {}".format(
node1.query("SELECT * FROM system.replication_queue FORMAT Vertical")
)
if node1.contains_in_log("Cannot create empty part") and node1.contains_in_log(
"DROP/DETACH PARTITION"
):
2021-06-29 19:47:54 +00:00
break
2022-10-02 12:57:04 +00:00
if node1.contains_in_log(
"Created empty part 8b8f0fede53df97513a9fb4cb19dc1e4_0_0_0 "
):
2022-10-02 12:50:24 +00:00
break
2021-06-29 19:47:54 +00:00
time.sleep(1)
else:
assert False, "Don't have required messages in node1 log"
2023-01-04 20:28:03 +00:00
node1.query(f"ALTER TABLE mt3 DROP PARTITION ID '{partition_id}'")
2021-06-29 19:47:54 +00:00
assert_eq_with_retry(node1, "SELECT COUNT() FROM mt3", "0")
2021-06-30 09:35:09 +00:00
assert_eq_with_retry(node1, "SELECT COUNT() FROM system.replication_queue", "0")
2023-01-04 20:28:03 +00:00
node1.query("DROP TABLE IF EXISTS mt3 SYNC")
node2.query("DROP TABLE IF EXISTS mt3 SYNC")