[
https://issues.apache.org/jira/browse/KAFKA-17978?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
PoAn Yang resolved KAFKA-17978.
-------------------------------
Resolution: Fixed
> StreamsUpgradeTest#test_rolling_upgrade_with_2_bounces system tests fail
> ------------------------------------------------------------------------
>
> Key: KAFKA-17978
> URL: https://issues.apache.org/jira/browse/KAFKA-17978
> Project: Kafka
> Issue Type: Test
> Reporter: PoAn Yang
> Assignee: Nicholas Telford
> Priority: Major
>
> Run `TC_PATHS="tests/kafkatest/tests/streams/streams_upgrade_test.py"
> /bin/bash tests/docker/run_tests.sh` on trunk branch. The versions which can
> support fk_joins can't pass `test_rolling_upgrade_with_2_bounces`.
>
> {noformat}
> [INFO:2024-11-09 22:24:00,601]: Triggering test 10 of 19...
> [INFO:2024-11-09 22:24:00,611]: RunnerClient: Loading test {'directory':
> '/opt/kafka-dev/tests/kafkatest/tests/streams', 'file_name':
> 'streams_upgrade_test.py', 'cls_name': 'StreamsUpgradeTest', 'method_name':
> 'test_rolling_upgrade_with_2_bounces', 'injected_args': {'from_version':
> '3.4.1', 'metadata_quorum': 'COMBINED_KRAFT'}}
> [INFO:2024-11-09 22:24:00,619]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.4.1.metadata_quorum=COMBINED_KRAFT:
> on run 1/1
> [INFO:2024-11-09 22:24:00,621]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.4.1.metadata_quorum=COMBINED_KRAFT:
> Setting up...
> [INFO:2024-11-09 22:24:00,623]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.4.1.metadata_quorum=COMBINED_KRAFT:
> Running...
> [INFO:2024-11-09 22:26:26,343]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.4.1.metadata_quorum=COMBINED_KRAFT:
> Tearing down...
> [INFO:2024-11-09 22:27:47,017]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.4.1.metadata_quorum=COMBINED_KRAFT:
> FAIL: TimeoutError("Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker07")
> Traceback (most recent call last):
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 351, in _do_run
> data = self.run_test()
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 411, in run_test
> return self.test_context.function(self.test)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/mark/_mark.py", line
> 438, in wrapper
> return functools.partial(f, *args, **kwargs)(*w_args, **w_kwargs)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 137, in test_rolling_upgrade_with_2_bounces
> self.do_stop_start_bounce(p, from_version[:-2], to_version, counter,
> extra_properties)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 402, in do_stop_start_bounce
> err_msg="Never saw output '%s' on " % self.processed_data_msg +
> str(node.account))
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/cluster/remoteaccount.py",
> line 754, in wait_until
> allow_fail=True) == 0, **kwargs)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/utils/util.py", line
> 58, in wait_until
> raise TimeoutError(err_msg() if callable(err_msg) else err_msg) from
> last_exception
> ducktape.errors.TimeoutError: Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker07
> [WARNING:2024-11-09 22:27:47,017]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.4.1.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [INFO:2024-11-09 22:27:47,017]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.4.1.metadata_quorum=COMBINED_KRAFT:
> Data: None
> [INFO:2024-11-09 22:27:47,124]:
> ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
> [INFO:2024-11-09 22:27:47,125]: Triggering test 11 of 19...
> [INFO:2024-11-09 22:27:47,134]: RunnerClient: Loading test {'directory':
> '/opt/kafka-dev/tests/kafkatest/tests/streams', 'file_name':
> 'streams_upgrade_test.py', 'cls_name': 'StreamsUpgradeTest', 'method_name':
> 'test_rolling_upgrade_with_2_bounces', 'injected_args': {'from_version':
> '3.5.2', 'metadata_quorum': 'COMBINED_KRAFT'}}
> [INFO:2024-11-09 22:27:47,142]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> on run 1/1
> [INFO:2024-11-09 22:27:47,144]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> Setting up...
> [INFO:2024-11-09 22:27:47,146]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> Running...
> [INFO:2024-11-09 22:30:12,455]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> Tearing down...
> [INFO:2024-11-09 22:31:34,101]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> FAIL: TimeoutError("Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker13")
> Traceback (most recent call last):
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 351, in _do_run
> data = self.run_test()
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 411, in run_test
> return self.test_context.function(self.test)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/mark/_mark.py", line
> 438, in wrapper
> return functools.partial(f, *args, **kwargs)(*w_args, **w_kwargs)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 137, in test_rolling_upgrade_with_2_bounces
> self.do_stop_start_bounce(p, from_version[:-2], to_version, counter,
> extra_properties)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 402, in do_stop_start_bounce
> err_msg="Never saw output '%s' on " % self.processed_data_msg +
> str(node.account))
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/cluster/remoteaccount.py",
> line 754, in wait_until
> allow_fail=True) == 0, **kwargs)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/utils/util.py", line
> 58, in wait_until
> raise TimeoutError(err_msg() if callable(err_msg) else err_msg) from
> last_exception
> ducktape.errors.TimeoutError: Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker13
> [WARNING - 2024-11-09 22:31:34,101 - runner_client - log - lineno:459]:
> RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [WARNING:2024-11-09 22:31:34,101]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [INFO:2024-11-09 22:31:34,101]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.5.2.metadata_quorum=COMBINED_KRAFT:
> Data: None
> [INFO:2024-11-09 22:31:34,208]:
> ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
> [INFO:2024-11-09 22:31:34,208]: Triggering test 12 of 19...
> [INFO:2024-11-09 22:31:34,218]: RunnerClient: Loading test {'directory':
> '/opt/kafka-dev/tests/kafkatest/tests/streams', 'file_name':
> 'streams_upgrade_test.py', 'cls_name': 'StreamsUpgradeTest', 'method_name':
> 'test_rolling_upgrade_with_2_bounces', 'injected_args': {'from_version':
> '3.6.2', 'metadata_quorum': 'COMBINED_KRAFT'}}
> [INFO:2024-11-09 22:31:34,226]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> on run 1/1
> [INFO:2024-11-09 22:31:34,228]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> Setting up...
> [INFO:2024-11-09 22:31:34,229]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> Running...
> [INFO:2024-11-09 22:33:58,400]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> Tearing down...
> [INFO:2024-11-09 22:35:19,548]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> FAIL: TimeoutError("Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker07")
> Traceback (most recent call last):
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 351, in _do_run
> data = self.run_test()
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 411, in run_test
> return self.test_context.function(self.test)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/mark/_mark.py", line
> 438, in wrapper
> return functools.partial(f, *args, **kwargs)(*w_args, **w_kwargs)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 137, in test_rolling_upgrade_with_2_bounces
> self.do_stop_start_bounce(p, from_version[:-2], to_version, counter,
> extra_properties)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 402, in do_stop_start_bounce
> err_msg="Never saw output '%s' on " % self.processed_data_msg +
> str(node.account))
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/cluster/remoteaccount.py",
> line 754, in wait_until
> allow_fail=True) == 0, **kwargs)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/utils/util.py", line
> 58, in wait_until
> raise TimeoutError(err_msg() if callable(err_msg) else err_msg) from
> last_exception
> ducktape.errors.TimeoutError: Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker07
> [WARNING - 2024-11-09 22:35:19,549 - runner_client - log - lineno:459]:
> RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [WARNING:2024-11-09 22:35:19,550]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [INFO:2024-11-09 22:35:19,551]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.6.2.metadata_quorum=COMBINED_KRAFT:
> Data: None
> [INFO:2024-11-09 22:35:19,660]:
> ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
> [INFO:2024-11-09 22:35:19,660]: Triggering test 13 of 19...
> [INFO:2024-11-09 22:35:19,670]: RunnerClient: Loading test {'directory':
> '/opt/kafka-dev/tests/kafkatest/tests/streams', 'file_name':
> 'streams_upgrade_test.py', 'cls_name': 'StreamsUpgradeTest', 'method_name':
> 'test_rolling_upgrade_with_2_bounces', 'injected_args': {'from_version':
> '3.7.1', 'metadata_quorum': 'COMBINED_KRAFT'}}
> [INFO:2024-11-09 22:35:19,678]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> on run 1/1
> [INFO:2024-11-09 22:35:19,680]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> Setting up...
> [INFO:2024-11-09 22:35:19,681]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> Running...
> [INFO:2024-11-09 22:38:00,197]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> Tearing down...
> [INFO:2024-11-09 22:39:21,823]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> FAIL: TimeoutError("Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker12")
> Traceback (most recent call last):
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 351, in _do_run
> data = self.run_test()
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 411, in run_test
> return self.test_context.function(self.test)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/mark/_mark.py", line
> 438, in wrapper
> return functools.partial(f, *args, **kwargs)(*w_args, **w_kwargs)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 137, in test_rolling_upgrade_with_2_bounces
> self.do_stop_start_bounce(p, from_version[:-2], to_version, counter,
> extra_properties)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 402, in do_stop_start_bounce
> err_msg="Never saw output '%s' on " % self.processed_data_msg +
> str(node.account))
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/cluster/remoteaccount.py",
> line 754, in wait_until
> allow_fail=True) == 0, **kwargs)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/utils/util.py", line
> 58, in wait_until
> raise TimeoutError(err_msg() if callable(err_msg) else err_msg) from
> last_exception
> ducktape.errors.TimeoutError: Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker12
> [WARNING - 2024-11-09 22:39:21,823 - runner_client - log - lineno:459]:
> RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [WARNING:2024-11-09 22:39:21,823]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [INFO:2024-11-09 22:39:21,824]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.7.1.metadata_quorum=COMBINED_KRAFT:
> Data: None
> [INFO:2024-11-09 22:39:21,931]:
> ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
> [INFO:2024-11-09 22:39:21,931]: Triggering test 14 of 19...
> [INFO:2024-11-09 22:39:21,940]: RunnerClient: Loading test {'directory':
> '/opt/kafka-dev/tests/kafkatest/tests/streams', 'file_name':
> 'streams_upgrade_test.py', 'cls_name': 'StreamsUpgradeTest', 'method_name':
> 'test_rolling_upgrade_with_2_bounces', 'injected_args': {'from_version':
> '3.8.1', 'metadata_quorum': 'COMBINED_KRAFT'}}
> [INFO:2024-11-09 22:39:21,948]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.8.1.metadata_quorum=COMBINED_KRAFT:
> on run 1/1
> [INFO:2024-11-09 22:39:21,950]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.8.1.metadata_quorum=COMBINED_KRAFT:
> Setting up...
> [INFO:2024-11-09 22:39:21,952]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.8.1.metadata_quorum=COMBINED_KRAFT:
> Running...
> [INFO:2024-11-09 22:41:49,029]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.8.1.metadata_quorum=COMBINED_KRAFT:
> Tearing down...
> Traceback (most recent call last):
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 351, in _do_run
> data = self.run_test()
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/tests/runner_client.py",
> line 411, in run_test
> return self.test_context.function(self.test)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/mark/_mark.py", line
> 438, in wrapper
> return functools.partial(f, *args, **kwargs)(*w_args, **w_kwargs)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 137, in test_rolling_upgrade_with_2_bounces
> self.do_stop_start_bounce(p, from_version[:-2], to_version, counter,
> extra_properties)
> File
> "/opt/kafka-dev/tests/kafkatest/tests/streams/streams_upgrade_test.py", line
> 402, in do_stop_start_bounce
> err_msg="Never saw output '%s' on " % self.processed_data_msg +
> str(node.account))
> File
> "/usr/local/lib/python3.7/dist-packages/ducktape/cluster/remoteaccount.py",
> line 754, in wait_until
> allow_fail=True) == 0, **kwargs)
> File "/usr/local/lib/python3.7/dist-packages/ducktape/utils/util.py", line
> 58, in wait_until
> raise TimeoutError(err_msg() if callable(err_msg) else err_msg) from
> last_exception
> ducktape.errors.TimeoutError: Never saw output 'processed [0-9]* records from
> topic=data' on ducker@ducker04
> [WARNING - 2024-11-09 22:43:10,413 - runner_client - log - lineno:459]:
> RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.8.1.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [WARNING:2024-11-09 22:43:10,414]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.8.1.metadata_quorum=COMBINED_KRAFT:
> Test requested 6 nodes, used only 5
> [INFO:2024-11-09 22:43:10,414]: RunnerClient:
> kafkatest.tests.streams.streams_upgrade_test.StreamsUpgradeTest.test_rolling_upgrade_with_2_bounces.from_version=3.8.1.metadata_quorum=COMBINED_KRAFT:
> Data: None
> [INFO:2024-11-09 22:43:10,521]:
> ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
> {noformat}
--
This message was sent by Atlassian Jira
(v8.20.10#820010)