🧑🌾 ros2topic.pytest.missing_result failure in Kilted and Rolling Connext #1129
Description
Generated by Generative AI
No response
Operating System:
Ubuntu Noble
ROS version or commit hash:
kilted, rolling
RMW implementation (if applicable):
Connext
RMW Configuration (if applicable):
No response
Client library (if applicable):
No response
'ros2 doctor --report' output
ros2 doctor --report
<COPY OUTPUT HERE>Steps to reproduce issue
- Run a build in Kilted or Rolling with Connext enabled
- See test regression fail
Expected behavior
Test should pass
Actual behavior
Test is failing
Additional information
Reference builds:
- Kci__nightly-connext_ubuntu_noble_amd64#70
- Kci__nightly-debug_ubuntu_noble_amd64#72
- Kci__nightly-release_ubuntu_noble_amd64#71
- Rci__nightly-connext_ubuntu_noble_amd64#617
- Rci__nightly-debug_ubuntu_noble_amd64#596
- Rci__nightly-release_ubuntu_noble_amd64#613
Test regression:
Log output:
04:53:13.033 NO TESTS RAN
04:53:13.033 test_csv_topic_echo[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_csv_topic_echo[rmw_connextdds]) ... FAIL
04:53:13.033 test_filtered_topic_hz[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_filtered_topic_hz[rmw_connextdds]) ... FAIL
04:53:13.033 test_find_not_a_topic_typename[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_find_not_a_topic_typename[rmw_connextdds]) ... ok
04:53:13.033 test_find_topic_type[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_find_topic_type[rmw_connextdds]) ... ok
04:53:13.033 test_hidden_topic_type[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_hidden_topic_type[rmw_connextdds]) ... ok
04:53:13.033 test_info_on_unknown_topic[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_info_on_unknown_topic[rmw_connextdds]) ... ok
04:53:13.033 test_list_all_topics[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_list_all_topics[rmw_connextdds]) ... ok
04:53:13.033 test_list_count[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_list_count[rmw_connextdds]) ... ok
04:53:13.033 test_list_topics[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_list_topics[rmw_connextdds]) ... ok
04:53:13.033 test_list_with_types[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_list_with_types[rmw_connextdds]) ... ok
04:53:13.033 test_list_with_verbose[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_list_with_verbose[rmw_connextdds]) ... ok
04:53:13.033 test_multiple_topics_hz[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_multiple_topics_hz[rmw_connextdds]) ... FAIL
04:53:13.033 test_no_arr_topic_echo_on_array_message[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_no_arr_topic_echo_on_array_message[rmw_connextdds]) ... ok
04:53:13.033 test_no_arr_topic_echo_on_bounded_seq_message[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_no_arr_topic_echo_on_bounded_seq_message[rmw_connextdds]) ... FAIL
04:53:13.033 test_no_arr_topic_echo_on_seq_message[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_no_arr_topic_echo_on_seq_message[rmw_connextdds]) ... FAIL
04:53:13.033 test_no_str_topic_echo[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_no_str_topic_echo[rmw_connextdds]) ... FAIL
04:53:13.033 test_topic_bw[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_topic_bw[rmw_connextdds]) ... FAIL
04:53:13.033 test_topic_delay[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_topic_delay[rmw_connextdds]) ... FAIL
04:53:13.033 test_topic_echo[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_topic_echo[rmw_connextdds]) ... FAIL
04:53:13.033 test_topic_echo_field[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_topic_echo_field[rmw_connextdds]) ... FAIL
04:53:13.033 test_topic_echo_field_array[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_topic_echo_field_array[rmw_connextdds]) ... FAIL
04:53:13.033 test_topic_echo_field_array_index_out_of_bounds[rmw_connextdds] (test_cli.TestROS2TopicCLI.test_topic_echo_field_array_index_out_of_bounds[rmw_connextdds]) ...
04:53:13.033 ~~~~~~~~~~~~~~~~ Stack of test_runner_thread (127017676695232) ~~~~~~~~~~~~~~~~~
04:53:13.033 File "/usr/lib/python3.12/threading.py", line 1030, in _bootstrap
04:53:13.033 self._bootstrap_inner()
04:53:13.033 File "/usr/lib/python3.12/threading.py", line 1073, in _bootstrap_inner
04:53:13.033 self.run()
04:53:13.033 File "/usr/lib/python3.12/threading.py", line 1010, in run
04:53:13.033 self._target(*self._args, **self._kwargs)
04:53:13.033 File "/tmp/ws/install_isolated/launch_testing/lib/python3.12/site-packages/launch_testing/test_runner.py", line 199, in _run_test
04:53:13.033 ).run(self._test_run.pre_shutdown_tests)
04:53:13.033 File "/usr/lib/python3.12/unittest/runner.py", line 240, in run
04:53:13.033 test(result)
04:53:13.033 File "/usr/lib/python3.12/unittest/suite.py", line 84, in __call__
04:53:13.033 return self.run(*args, **kwds)
04:53:13.033 File "/usr/lib/python3.12/unittest/suite.py", line 122, in run
04:53:13.033 test(result)
04:53:13.033 File "/usr/lib/python3.12/unittest/suite.py", line 84, in __call__
04:53:13.033 return self.run(*args, **kwds)
04:53:13.033 File "/usr/lib/python3.12/unittest/suite.py", line 122, in run
04:53:13.033 test(result)
04:53:13.033 File "/usr/lib/python3.12/unittest/case.py", line 690, in __call__
04:53:13.033 return self.run(*args, **kwds)
04:53:13.033 File "/usr/lib/python3.12/unittest/case.py", line 634, in run
04:53:13.033 self._callTestMethod(testMethod)
04:53:13.033 File "/usr/lib/python3.12/unittest/case.py", line 589, in _callTestMethod
04:53:13.033 if method() is not None:
04:53:13.033 File "/tmp/ws/install_isolated/launch_testing/lib/python3.12/site-packages/launch_testing/markers.py", line 61, in _wrapper
04:53:13.033 return func(self, *args, **kwargs)
04:53:13.033 File "/tmp/ws/src/ros2/ros2cli/ros2topic/test/test_cli.py", line 699, in test_topic_echo_field_array_index_out_of_bounds
04:53:13.033 assert topic_command.wait_for_output(functools.partial(
04:53:13.033 File "/tmp/ws/install_isolated/launch_testing/lib/python3.12/site-packages/launch_testing/tools/process.py", line 100, in wait_for_output
04:53:13.033 bool_result = self._proc_output.io_event.wait_for(
04:53:13.033 File "/usr/lib/python3.12/threading.py", line 390, in wait_for
04:53:13.033 self.wait(waittime)
04:53:13.033 File "/usr/lib/python3.12/threading.py", line 359, in wait
04:53:13.033 gotit = waiter.acquire(True, timeout)
04:53:13.033
04:53:13.033 ~~~~~~~~~~~~~~~~~~~~ Stack of MainThread (127017850976064) ~~~~~~~~~~~~~~~~~~~~~
04:53:13.033 File "<frozen runpy>", line 198, in _run_module_as_main
04:53:13.033 File "<frozen runpy>", line 88, in _run_code
04:53:13.033 File "/usr/lib/python3/dist-packages/pytest/__main__.py", line 5, in <module>
04:53:13.033 raise SystemExit(pytest.console_main())
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 192, in console_main
04:53:13.033 code = main()
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 169, in main
04:53:13.033 ret: Union[ExitCode, int] = config.hook.pytest_cmdline_main(
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 501, in __call__
04:53:13.033 return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 119, in _hookexec
04:53:13.033 return self._inner_hookexec(hook_name, methods, kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 102, in _multicall
04:53:13.033 res = hook_impl.function(*args)
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/main.py", line 318, in pytest_cmdline_main
04:53:13.033 return wrap_session(config, _main)
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/main.py", line 271, in wrap_session
04:53:13.033 session.exitstatus = doit(config, session) or 0
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/main.py", line 325, in _main
04:53:13.033 config.hook.pytest_runtestloop(session=session)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 501, in __call__
04:53:13.033 return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 119, in _hookexec
04:53:13.033 return self._inner_hookexec(hook_name, methods, kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 102, in _multicall
04:53:13.033 res = hook_impl.function(*args)
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/main.py", line 350, in pytest_runtestloop
04:53:13.033 item.config.hook.pytest_runtest_protocol(item=item, nextitem=nextitem)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 501, in __call__
04:53:13.033 return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 119, in _hookexec
04:53:13.033 return self._inner_hookexec(hook_name, methods, kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 102, in _multicall
04:53:13.033 res = hook_impl.function(*args)
04:53:13.033 File "/usr/lib/python3/dist-packages/pytest_rerunfailures.py", line 608, in pytest_runtest_protocol
04:53:13.033 reports = runtestprotocol(item, nextitem=nextitem, log=False)
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 133, in runtestprotocol
04:53:13.033 reports.append(call_and_report(item, "call", log))
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 222, in call_and_report
04:53:13.033 call = call_runtest_hook(item, when, **kwds)
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 261, in call_runtest_hook
04:53:13.033 return CallInfo.from_call(
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 341, in from_call
04:53:13.033 result: Optional[TResult] = func()
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 262, in <lambda>
04:53:13.033 lambda: ihook(item=item, **kwds), when=when, reraise=reraise
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 501, in __call__
04:53:13.033 return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 119, in _hookexec
04:53:13.033 return self._inner_hookexec(hook_name, methods, kwargs, firstresult)
04:53:13.033 File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 102, in _multicall
04:53:13.033 res = hook_impl.function(*args)
04:53:13.033 File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 169, in pytest_runtest_call
04:53:13.033 item.runtest()
04:53:13.033 File "/tmp/ws/install_isolated/launch_testing/lib/python3.12/site-packages/launch_testing/pytest/hooks.py", line 112, in runtest
04:53:13.033 results_per_run = runner.run()
04:53:13.033 File "/tmp/ws/install_isolated/launch_testing/lib/python3.12/site-packages/launch_testing/test_runner.py", line 260, in run
04:53:13.033 results[run] = worker.run()
04:53:13.033 File "/tmp/ws/install_isolated/launch_testing/lib/python3.12/site-packages/launch_testing/test_runner.py", line 162, in run
04:53:13.033 self._launch_service.run(
04:53:13.033 File "/tmp/ws/install_isolated/launch/lib/python3.12/site-packages/launch/launch_service.py", line 394, in run
04:53:13.033 return loop.run_until_complete(run_async_task)
04:53:13.033 File "/usr/lib/python3.12/asyncio/base_events.py", line 674, in run_until_complete
04:53:13.033 self.run_forever()
04:53:13.033 File "/usr/lib/python3.12/asyncio/base_events.py", line 641, in run_forever
04:53:13.033 self._run_once()
04:53:13.033 File "/usr/lib/python3.12/asyncio/base_events.py", line 1949, in _run_once
04:53:13.033 event_list = self._selector.select(timeout)
04:53:13.033 File "/usr/lib/python3.12/selectors.py", line 468, in select
04:53:13.033 fd_event_list = self._selector.poll(timeout, max_ev)
04:53:13.033
04:53:13.033 +++++++++++++++++++++++++++++++++++ Timeout ++++++++++++++++++++++++++++++++++++
04:53:13.033 ---
04:53:13.033 Finished <<< ros2topic [18min 14s] [ with test failures ]
Full test log output: output.txt
It seems like the timeout, although there are a lot of test failures in the log.
CC: @miguelgonrod