Matter SDK Example Conformance Report

Generated on 28/07/2026 09:37:44
SHA: 6dc072096eb03806431fc918ffd7191a20e7c3c1

'TC_DeviceConformance (0 / 0) examples passed

Application	Result	Errors	Test Command	Error Summary

'TC_DeviceBasicComposition (0 / 13) examples passed

Application	Result	Errors	Test Command	Error Summary
chip-air-purifier-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-air-purifier-no-ble/chip-air-purifier-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:31:53.541526][[32mTEST[0m][[33mSTDOUT[0m]* matter.exceptions.ChipStackError: src/lib/address_resolve/AddressResolve_DefaultImpl.cpp:124: CHIP Error 0x00000032: Timeout [2026-07-28 09:31:53.541530][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:31:53.541539][[32mTEST[0m][[33mSTDOUT[0m]* Test step: [2026-07-28 09:31:53.541564][[32mTEST[0m][[33mSTDOUT[0m]* UNKNOWN - no test steps provided in test script [2026-07-28 09:31:53.541568][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:31:53.541578][[32mTEST[0m][[33mSTDOUT[0m]* Endpoint: None [2026-07-28 09:31:53.541582][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:31:53.541612][[32mTEST[0m][[33mSTDOUT[0m]******************************************************************* [2026-07-28 09:31:53.541615][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:31:53.567481][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:31:53.567527][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO Config values: [2026-07-28 09:31:53.567557][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - admin_vendor_id: 65521 [2026-07-28 09:31:53.567585][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - app_pid: 0 [2026-07-28 09:31:53.567613][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - commission_only: False [2026-07-28 09:31:53.567644][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - controller_cat_tags: [65537] [2026-07-28 09:31:53.567689][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - controller_node_id: 112233 [2026-07-28 09:31:53.567715][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - debug: False [2026-07-28 09:31:53.567745][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - dut_node_ids: [305414945] [2026-07-28 09:31:53.567769][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - fabric_id: 1 [2026-07-28 09:31:53.567806][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - fail_on_skipped_tests: True [2026-07-28 09:31:53.567831][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - legacy: False [2026-07-28 09:31:53.567865][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:31:53.567900][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - maximize_cert_chains: True [2026-07-28 09:31:53.567932][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - no_wildcard_subscription: False [2026-07-28 09:31:53.567985][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:31:53.568021][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:31:53.568063][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - restart_flag_file: '/tmp/chip_test_restart_app_59e33e43' [2026-07-28 09:31:53.568091][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - root_of_trust_index: 1 [2026-07-28 09:31:53.568124][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:31:53.568141][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO [2026-07-28 09:31:53.568146][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:31:53.568153][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:31:53.568199][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:31:53.568251][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - certificate_authority_manager: '100bdd94-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:53.568296][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - default_controller: '100bdd91-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:53.568336][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.567 INFO - hooks: '100bdd93-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:53.568383][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.568 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:31:53.568422][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.568 INFO - matter_stack: '100bdd90-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:53.568464][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.568 INFO - matter_test_config: '100bdd92-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:53.568497][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.568 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:31:53.568558][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.568 INFO Summary for test class TC_DeviceBasicComposition: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:31:53.568647][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:53.568 INFO Summary for test run MatterTest@07-28-2026_09-31-08-202: [2026-07-28 09:31:53.568666][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 45.36556213100084s [2026-07-28 09:31:53.568712][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-31-08-202" [2026-07-28 09:31:53.568756][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-31-08-202/test_summary.yaml" [2026-07-28 09:31:53.568798][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:31:53.569769][[32mTEST[0m][[31mSTDERR[0m]Shutting down the stack... [2026-07-28 09:31:53.573962][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! [2026-07-28 09:31:53.617021][[32mTEST[0m][[31mSTDERR[0m]Task exception was never retrieved [2026-07-28 09:31:53.617228][[32mTEST[0m][[31mSTDERR[0m]future: exception=ChipStackError(3, 'src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state') created at /usr/lib/python3.11/asyncio/tasks.py:379> [2026-07-28 09:31:53.617270][[32mTEST[0m][[31mSTDERR[0m]source_traceback: Object created at (most recent call last): [2026-07-28 09:31:53.617326][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 1373, in [2026-07-28 09:31:53.617342][[32mTEST[0m][[31mSTDERR[0m] default_matter_test_main() [2026-07-28 09:31:53.617399][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 347, in default_matter_test_main [2026-07-28 09:31:53.617423][[32mTEST[0m][[31mSTDERR[0m] run_tests(test_class, matter_test_config, hooks) [2026-07-28 09:31:53.617474][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 528, in run_tests [2026-07-28 09:31:53.617489][[32mTEST[0m][[31mSTDERR[0m] if not run_tests_no_exit( [2026-07-28 09:31:53.617543][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 476, in run_tests_no_exit [2026-07-28 09:31:53.617552][[32mTEST[0m][[31mSTDERR[0m] runner.run() [2026-07-28 09:31:53.617599][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 515, in run [2026-07-28 09:31:53.617612][[32mTEST[0m][[31mSTDERR[0m] self._run_test_class( [2026-07-28 09:31:53.617663][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 458, in _run_test_class [2026-07-28 09:31:53.617704][[32mTEST[0m][[31mSTDERR[0m] cls_result = test_instance.run(tests) [2026-07-28 09:31:53.617752][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 1103, in run [2026-07-28 09:31:53.617773][[32mTEST[0m][[31mSTDERR[0m] setup_class_result = self._setup_class() [2026-07-28 09:31:53.617831][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 411, in _setup_class [2026-07-28 09:31:53.617843][[32mTEST[0m][[31mSTDERR[0m] self.setup_class() [2026-07-28 09:31:53.617897][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 270, in async_runner [2026-07-28 09:31:53.617920][[32mTEST[0m][[31mSTDERR[0m] return _async_runner(body, self, args, kwargs) [2026-07-28 09:31:53.617974][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 254, in _async_runner [2026-07-28 09:31:53.618026][[32mTEST[0m][[31mSTDERR[0m] return test_instance.event_loop.run_until_complete(asyncio.wait_for(body(test_instance, args, *kwargs), timeout=timeout)) [2026-07-28 09:31:53.618062][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 637, in run_until_complete [2026-07-28 09:31:53.618074][[32mTEST[0m][[31mSTDERR[0m] self.run_forever() [2026-07-28 09:31:53.618108][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 604, in run_forever [2026-07-28 09:31:53.618119][[32mTEST[0m][[31mSTDERR[0m] self._run_once() [2026-07-28 09:31:53.618152][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 1901, in _run_once [2026-07-28 09:31:53.618162][[32mTEST[0m][[31mSTDERR[0m] handle._run() [2026-07-28 09:31:53.618190][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/events.py", line 80, in _run [2026-07-28 09:31:53.618213][[32mTEST[0m][[31mSTDERR[0m] self._context.run(self._callback, self._args) [2026-07-28 09:31:53.618256][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 337, in setup_class [2026-07-28 09:31:53.618277][[32mTEST[0m][[31mSTDERR[0m] await self.setup_class_helper() [2026-07-28 09:31:53.618343][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/basic_composition.py", line 196, in setup_class_helper [2026-07-28 09:31:53.618368][[32mTEST[0m][[31mSTDERR[0m] task_list.append(asyncio.create_task(pase_future)) [2026-07-28 09:31:53.618399][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/tasks.py", line 379, in create_task [2026-07-28 09:31:53.618416][[32mTEST[0m][[31mSTDERR[0m] task = loop.create_task(coro) [2026-07-28 09:31:53.618433][[32mTEST[0m][[31mSTDERR[0m]Traceback (most recent call last): [2026-07-28 09:31:53.618490][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1555, in FindOrEstablishPASESession [2026-07-28 09:31:53.618515][[32mTEST[0m][[31mSTDERR[0m] await self.EstablishPASESession(setupCode, nodeId) [2026-07-28 09:31:53.618570][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1109, in EstablishPASESession [2026-07-28 09:31:53.618588][[32mTEST[0m][[31mSTDERR[0m] await self._establishPASESession( [2026-07-28 09:31:53.618644][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1018, in _establishPASESession [2026-07-28 09:31:53.618666][[32mTEST[0m][[31mSTDERR[0m] await asyncio.futures.wrap_future(ctx.future) [2026-07-28 09:31:53.618736][[32mTEST[0m][[31mSTDERR[0m]matter.exceptions.ChipStackError: src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state 2026-07-28 09:31:53 matter-build-coverage __main__[104807] ERROR Test script exited with returncode 1 2026-07-28 09:31:53 matter-build-coverage __main__[104807] INFO Stopping app restart monitor thread 2026-07-28 09:31:53 matter-build-coverage __main__[104807] INFO Stopping app with SIGTERM 2026-07-28 09:31:53 matter-build-coverage __main__[104807] ERROR SUBPROCESS failure: 2026-07-28 09:31:53 matter-build-coverage __main__[104807] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_59e33e43']) 2026-07-28 09:31:53 matter-build-coverage __main__[104807] ERROR APP: 0 (['./out/linux-x64-air-purifier-no-ble/chip-air-purifier-app', '--trace-to', 'json:log']) 2026-07-28 09:31:53 matter-build-coverage __main__[104807] INFO Cleaning up flag files
air-quality-sensor-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-air-quality-sensor-no-ble/air-quality-sensor-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:31:57.890894][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.875 INFO ***** Test Step 6 : Check flat lists include all sub ids [2026-07-28 09:31:57.890922][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.875 INFO Finished test in 2418.0ms [2026-07-28 09:31:57.890952][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.875 INFO [Test] test_TC_SM_1_2 PASS [2026-07-28 09:31:57.890998][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO ########################################################### [2026-07-28 09:31:57.891021][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO Problems found: [2026-07-28 09:31:57.891046][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO =============== [2026-07-28 09:31:57.891063][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO [2026-07-28 09:31:57.891073][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:31:57.891089][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:31:57.891098][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:31:57.891109][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:31:57.891126][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:31:57.891141][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65533 (0xfffd) [2026-07-28 09:31:57.891265][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute ClusterRevision 65533, 0xFFFD: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:31:57.891283][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:31:57.891287][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:31:57.891304][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO [2026-07-28 09:31:57.891314][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:31:57.891329][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:31:57.891338][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:31:57.891349][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:31:57.891366][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:31:57.891381][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:31:57.891504][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute FeatureMap 65532, 0xFFFC: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:31:57.891521][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:31:57.891524][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:31:57.891542][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO [2026-07-28 09:31:57.891551][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:31:57.891567][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:31:57.891576][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:31:57.891587][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:31:57.891603][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:31:57.891619][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:31:57.891661][[32mTEST[0m][[33mSTDOUT[0m] problem: Found a failure to read/decode FEATURE_MAP on Endpoint 1, Cluster Identify (3, 0x0003) [2026-07-28 09:31:57.891680][[32mTEST[0m][[33mSTDOUT[0m] spec_location: [2026-07-28 09:31:57.891689][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:31:57.891738][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO ########################################################### [2026-07-28 09:31:57.891773][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:31:57.891796][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO Config values: [2026-07-28 09:31:57.891827][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - admin_vendor_id: 65521 [2026-07-28 09:31:57.891850][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - app_pid: 0 [2026-07-28 09:31:57.891878][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - commission_only: False [2026-07-28 09:31:57.891909][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - controller_cat_tags: [65537] [2026-07-28 09:31:57.891938][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - controller_node_id: 112233 [2026-07-28 09:31:57.891964][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - debug: False [2026-07-28 09:31:57.891997][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - dut_node_ids: [305414945] [2026-07-28 09:31:57.892021][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - fabric_id: 1 [2026-07-28 09:31:57.892052][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - fail_on_skipped_tests: True [2026-07-28 09:31:57.892076][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.877 INFO - legacy: False [2026-07-28 09:31:57.892110][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:31:57.892140][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - maximize_cert_chains: True [2026-07-28 09:31:57.892171][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - no_wildcard_subscription: False [2026-07-28 09:31:57.892223][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:31:57.892259][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:31:57.892301][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - restart_flag_file: '/tmp/chip_test_restart_app_f22dc1c3' [2026-07-28 09:31:57.892329][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - root_of_trust_index: 1 [2026-07-28 09:31:57.892361][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:31:57.892379][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO [2026-07-28 09:31:57.892382][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:31:57.892390][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:31:57.892436][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:31:57.892483][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - certificate_authority_manager: '2cd16ffc-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:57.892525][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - default_controller: '2cd16ff9-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:57.892562][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - hooks: '2cd16ffb-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:57.892608][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:31:57.892648][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - matter_stack: '2cd16ff8-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:57.892699][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO - matter_test_config: '2cd16ffa-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:31:57.892734][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:31:57.892796][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO Summary for test class TC_DeviceBasicComposition: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 [2026-07-28 09:31:57.892838][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:31:57.878 INFO Summary for test run MatterTest@07-28-2026_09-31-56-401: [2026-07-28 09:31:57.892857][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 1.4695124990012118s [2026-07-28 09:31:57.892893][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-31-56-401" [2026-07-28 09:31:57.892936][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-31-56-401/test_summary.yaml" [2026-07-28 09:31:57.892969][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 2026-07-28 09:31:58 matter-build-coverage __main__[104824] ERROR Test script exited with returncode 1 2026-07-28 09:31:58 matter-build-coverage __main__[104824] INFO Stopping app restart monitor thread 2026-07-28 09:31:58 matter-build-coverage __main__[104824] INFO Stopping app with SIGTERM [2026-07-28 09:31:58.079662][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.079] [104826:104826] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:31:58.079797][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.079] [104826:104826] [EVL] LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA8110EFF[0m [2026-07-28 09:31:58.079844][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.079] [104826:104826] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:31:58.079891][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.079] [104826:104826] [IN] SecureSession[0x650197780cb0]: Released - Type:2 LSID:23590[0m [2026-07-28 09:31:58.080143][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.080] [104826:104826] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:31:58.080187][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.080] [104826:104826] [IM] Shutting down data model provider 0x65018b9db020[0m [2026-07-28 09:31:58.080222][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.080] [104826:104826] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:31:58.080263][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.080] [104826:104826] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:31:58.080312][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.080] [104826:104826] [IN] SecureSession[0x650197780130]: MarkForEviction Type:1 LSID:23589[0m [2026-07-28 09:31:58.080370][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.080] [104826:104826] [SC] SecureSession[0x650197780130, LSID:23589]: State change 'kActive' --> 'kPendingEviction'[0m [2026-07-28 09:31:58.080402][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.080] [104826:104826] [FS] Fail-safe timer expired[0m [2026-07-28 09:31:58.080448][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.080] [104826:104826] [IN] SecureSession[0x650197780130]: Released - Type:1 LSID:23589[0m [2026-07-28 09:31:58.080481][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.080] [104826:104826] [DMG] AccessControl: finishing[0m [2026-07-28 09:31:58.080520][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.080] [104826:104826] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:31:58.082397][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231118.082] [104826:104826] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:31:58.082453][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.082] [104826:104826] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:31:58.082485][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.082] [104826:104826] [DL] Inet Layer shutdown[0m [2026-07-28 09:31:58.082522][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.082] [104826:104826] [DL] WiFi-PAF Layer shutdown[0m [2026-07-28 09:31:58.082554][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231118.082] [104826:104826] [DL] System Layer shutdown[0m 2026-07-28 09:31:58 matter-build-coverage __main__[104824] ERROR SUBPROCESS failure: 2026-07-28 09:31:58 matter-build-coverage __main__[104824] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_f22dc1c3']) 2026-07-28 09:31:58 matter-build-coverage __main__[104824] ERROR APP: 0 (['./out/linux-x64-air-quality-sensor-no-ble/air-quality-sensor-app', '--trace-to', 'json:log']) 2026-07-28 09:31:58 matter-build-coverage __main__[104824] INFO Cleaning up flag files
chip-tv-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-tv-app-no-ble-clang-boringssl/chip-tv-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:37:08.981722][[32mTEST[0m][[33mSTDOUT[0m]* matter.exceptions.ChipStackError: src/lib/address_resolve/AddressResolve_DefaultImpl.cpp:124: CHIP Error 0x00000032: Timeout [2026-07-28 09:37:08.981727][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:37:08.981735][[32mTEST[0m][[33mSTDOUT[0m]* Test step: [2026-07-28 09:37:08.981760][[32mTEST[0m][[33mSTDOUT[0m]* UNKNOWN - no test steps provided in test script [2026-07-28 09:37:08.981763][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:37:08.981773][[32mTEST[0m][[33mSTDOUT[0m]* Endpoint: None [2026-07-28 09:37:08.981777][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:37:08.981806][[32mTEST[0m][[33mSTDOUT[0m]******************************************************************* [2026-07-28 09:37:08.981810][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:37:09.007253][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:37:09.007284][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO Config values: [2026-07-28 09:37:09.007312][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - admin_vendor_id: 65521 [2026-07-28 09:37:09.007335][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - app_pid: 0 [2026-07-28 09:37:09.007363][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - commission_only: False [2026-07-28 09:37:09.007394][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - controller_cat_tags: [65537] [2026-07-28 09:37:09.007424][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - controller_node_id: 112233 [2026-07-28 09:37:09.007448][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - debug: False [2026-07-28 09:37:09.007478][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - dut_node_ids: [305414945] [2026-07-28 09:37:09.007506][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - fabric_id: 1 [2026-07-28 09:37:09.007537][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - fail_on_skipped_tests: True [2026-07-28 09:37:09.007561][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - legacy: False [2026-07-28 09:37:09.007595][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:37:09.007624][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - maximize_cert_chains: True [2026-07-28 09:37:09.007656][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - no_wildcard_subscription: False [2026-07-28 09:37:09.007720][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:37:09.007757][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:37:09.007799][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - restart_flag_file: '/tmp/chip_test_restart_app_739d1b90' [2026-07-28 09:37:09.007827][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - root_of_trust_index: 1 [2026-07-28 09:37:09.007860][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:37:09.007878][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO [2026-07-28 09:37:09.007881][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:37:09.007889][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:37:09.007942][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:37:09.007989][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - certificate_authority_manager: 'cc1c23ea-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:37:09.008030][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - default_controller: 'cc1c23e7-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:37:09.008067][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - hooks: 'cc1c23e9-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:37:09.008113][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:37:09.008152][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - matter_stack: 'cc1c23e6-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:37:09.008193][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO - matter_test_config: 'cc1c23e8-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:37:09.008226][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.007 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:37:09.008288][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.008 INFO Summary for test class TC_DeviceBasicComposition: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:37:09.008443][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:37:09.008 INFO Summary for test run MatterTest@07-28-2026_09-36-23-648: [2026-07-28 09:37:09.008461][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 45.35946768000031s [2026-07-28 09:37:09.008498][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-36-23-648" [2026-07-28 09:37:09.008540][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-36-23-648/test_summary.yaml" [2026-07-28 09:37:09.008574][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:37:09.009432][[32mTEST[0m][[31mSTDERR[0m]Shutting down the stack... [2026-07-28 09:37:09.013495][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! [2026-07-28 09:37:09.055000][[32mTEST[0m][[31mSTDERR[0m]Task exception was never retrieved [2026-07-28 09:37:09.055202][[32mTEST[0m][[31mSTDERR[0m]future: exception=ChipStackError(3, 'src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state') created at /usr/lib/python3.11/asyncio/tasks.py:379> [2026-07-28 09:37:09.055231][[32mTEST[0m][[31mSTDERR[0m]source_traceback: Object created at (most recent call last): [2026-07-28 09:37:09.055274][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 1373, in [2026-07-28 09:37:09.055291][[32mTEST[0m][[31mSTDERR[0m] default_matter_test_main() [2026-07-28 09:37:09.055347][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 347, in default_matter_test_main [2026-07-28 09:37:09.055372][[32mTEST[0m][[31mSTDERR[0m] run_tests(test_class, matter_test_config, hooks) [2026-07-28 09:37:09.055423][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 528, in run_tests [2026-07-28 09:37:09.055438][[32mTEST[0m][[31mSTDERR[0m] if not run_tests_no_exit( [2026-07-28 09:37:09.055491][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 476, in run_tests_no_exit [2026-07-28 09:37:09.055501][[32mTEST[0m][[31mSTDERR[0m] runner.run() [2026-07-28 09:37:09.055548][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 515, in run [2026-07-28 09:37:09.055561][[32mTEST[0m][[31mSTDERR[0m] self._run_test_class( [2026-07-28 09:37:09.055612][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 458, in _run_test_class [2026-07-28 09:37:09.055632][[32mTEST[0m][[31mSTDERR[0m] cls_result = test_instance.run(tests) [2026-07-28 09:37:09.055695][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 1103, in run [2026-07-28 09:37:09.055717][[32mTEST[0m][[31mSTDERR[0m] setup_class_result = self._setup_class() [2026-07-28 09:37:09.055767][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 411, in _setup_class [2026-07-28 09:37:09.055780][[32mTEST[0m][[31mSTDERR[0m] self.setup_class() [2026-07-28 09:37:09.055833][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 270, in async_runner [2026-07-28 09:37:09.055857][[32mTEST[0m][[31mSTDERR[0m] return _async_runner(body, self, args, kwargs) [2026-07-28 09:37:09.055921][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 254, in _async_runner [2026-07-28 09:37:09.055974][[32mTEST[0m][[31mSTDERR[0m] return test_instance.event_loop.run_until_complete(asyncio.wait_for(body(test_instance, args, *kwargs), timeout=timeout)) [2026-07-28 09:37:09.056010][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 637, in run_until_complete [2026-07-28 09:37:09.056023][[32mTEST[0m][[31mSTDERR[0m] self.run_forever() [2026-07-28 09:37:09.056056][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 604, in run_forever [2026-07-28 09:37:09.056067][[32mTEST[0m][[31mSTDERR[0m] self._run_once() [2026-07-28 09:37:09.056100][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 1901, in _run_once [2026-07-28 09:37:09.056121][[32mTEST[0m][[31mSTDERR[0m] handle._run() [2026-07-28 09:37:09.056149][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/events.py", line 80, in _run [2026-07-28 09:37:09.056172][[32mTEST[0m][[31mSTDERR[0m] self._context.run(self._callback, self._args) [2026-07-28 09:37:09.056215][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 337, in setup_class [2026-07-28 09:37:09.056232][[32mTEST[0m][[31mSTDERR[0m] await self.setup_class_helper() [2026-07-28 09:37:09.056290][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/basic_composition.py", line 196, in setup_class_helper [2026-07-28 09:37:09.056315][[32mTEST[0m][[31mSTDERR[0m] task_list.append(asyncio.create_task(pase_future)) [2026-07-28 09:37:09.056346][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/tasks.py", line 379, in create_task [2026-07-28 09:37:09.056362][[32mTEST[0m][[31mSTDERR[0m] task = loop.create_task(coro) [2026-07-28 09:37:09.056379][[32mTEST[0m][[31mSTDERR[0m]Traceback (most recent call last): [2026-07-28 09:37:09.056437][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1555, in FindOrEstablishPASESession [2026-07-28 09:37:09.056461][[32mTEST[0m][[31mSTDERR[0m] await self.EstablishPASESession(setupCode, nodeId) [2026-07-28 09:37:09.056517][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1109, in EstablishPASESession [2026-07-28 09:37:09.056535][[32mTEST[0m][[31mSTDERR[0m] await self._establishPASESession( [2026-07-28 09:37:09.056591][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1018, in _establishPASESession [2026-07-28 09:37:09.056614][[32mTEST[0m][[31mSTDERR[0m] await asyncio.futures.wrap_future(ctx.future) [2026-07-28 09:37:09.056683][[32mTEST[0m][[31mSTDERR[0m]matter.exceptions.ChipStackError: src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state 2026-07-28 09:37:09 matter-build-coverage __main__[105141] ERROR Test script exited with returncode 1 2026-07-28 09:37:09 matter-build-coverage __main__[105141] INFO Stopping app restart monitor thread 2026-07-28 09:37:09 matter-build-coverage __main__[105141] INFO Stopping app with SIGTERM 2026-07-28 09:37:09 matter-build-coverage __main__[105141] ERROR SUBPROCESS failure: 2026-07-28 09:37:09 matter-build-coverage __main__[105141] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_739d1b90']) 2026-07-28 09:37:09 matter-build-coverage __main__[105141] ERROR APP: 0 (['./out/linux-x64-tv-app-no-ble-clang-boringssl/chip-tv-app', '--trace-to', 'json:log']) 2026-07-28 09:37:09 matter-build-coverage __main__[105141] INFO Cleaning up flag files
chip-dishwasher-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-dishwasher-no-ble/chip-dishwasher-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:33:15.231844][[32mTEST[0m][[33mSTDOUT[0m]* matter.exceptions.ChipStackError: src/lib/address_resolve/AddressResolve_DefaultImpl.cpp:124: CHIP Error 0x00000032: Timeout [2026-07-28 09:33:15.231849][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:33:15.231858][[32mTEST[0m][[33mSTDOUT[0m]* Test step: [2026-07-28 09:33:15.231883][[32mTEST[0m][[33mSTDOUT[0m]* UNKNOWN - no test steps provided in test script [2026-07-28 09:33:15.231887][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:33:15.231897][[32mTEST[0m][[33mSTDOUT[0m]* Endpoint: None [2026-07-28 09:33:15.231902][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:33:15.231932][[32mTEST[0m][[33mSTDOUT[0m]******************************************************************* [2026-07-28 09:33:15.231936][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:33:15.257650][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:33:15.257714][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO Config values: [2026-07-28 09:33:15.257745][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - admin_vendor_id: 65521 [2026-07-28 09:33:15.257769][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - app_pid: 0 [2026-07-28 09:33:15.257802][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - commission_only: False [2026-07-28 09:33:15.257834][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - controller_cat_tags: [65537] [2026-07-28 09:33:15.257864][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - controller_node_id: 112233 [2026-07-28 09:33:15.257889][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - debug: False [2026-07-28 09:33:15.257919][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - dut_node_ids: [305414945] [2026-07-28 09:33:15.257943][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - fabric_id: 1 [2026-07-28 09:33:15.257974][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - fail_on_skipped_tests: True [2026-07-28 09:33:15.257999][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - legacy: False [2026-07-28 09:33:15.258033][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:33:15.258063][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - maximize_cert_chains: True [2026-07-28 09:33:15.258095][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - no_wildcard_subscription: False [2026-07-28 09:33:15.258154][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.257 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:33:15.258192][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:33:15.258234][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - restart_flag_file: '/tmp/chip_test_restart_app_8d7ebb4f' [2026-07-28 09:33:15.258263][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - root_of_trust_index: 1 [2026-07-28 09:33:15.258308][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:33:15.258327][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO [2026-07-28 09:33:15.258331][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:33:15.258339][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:33:15.258386][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:33:15.258433][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - certificate_authority_manager: '40c8cc44-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:15.258480][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - default_controller: '40c8cc41-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:15.258518][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - hooks: '40c8cc43-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:15.258565][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:33:15.258605][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - matter_stack: '40c8cc40-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:15.258647][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO - matter_test_config: '40c8cc42-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:15.258688][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:33:15.258753][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO Summary for test class TC_DeviceBasicComposition: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:33:15.258880][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:15.258 INFO Summary for test run MatterTest@07-28-2026_09-32-29-899: [2026-07-28 09:33:15.258900][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 45.359165313999256s [2026-07-28 09:33:15.258937][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-29-899" [2026-07-28 09:33:15.258980][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-29-899/test_summary.yaml" [2026-07-28 09:33:15.259014][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:33:15.260020][[32mTEST[0m][[31mSTDERR[0m]Shutting down the stack... [2026-07-28 09:33:15.264186][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! [2026-07-28 09:33:15.307034][[32mTEST[0m][[31mSTDERR[0m]Task exception was never retrieved [2026-07-28 09:33:15.307242][[32mTEST[0m][[31mSTDERR[0m]future: exception=ChipStackError(3, 'src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state') created at /usr/lib/python3.11/asyncio/tasks.py:379> [2026-07-28 09:33:15.307273][[32mTEST[0m][[31mSTDERR[0m]source_traceback: Object created at (most recent call last): [2026-07-28 09:33:15.307332][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 1373, in [2026-07-28 09:33:15.307348][[32mTEST[0m][[31mSTDERR[0m] default_matter_test_main() [2026-07-28 09:33:15.307405][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 347, in default_matter_test_main [2026-07-28 09:33:15.307430][[32mTEST[0m][[31mSTDERR[0m] run_tests(test_class, matter_test_config, hooks) [2026-07-28 09:33:15.307481][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 528, in run_tests [2026-07-28 09:33:15.307496][[32mTEST[0m][[31mSTDERR[0m] if not run_tests_no_exit( [2026-07-28 09:33:15.307550][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 476, in run_tests_no_exit [2026-07-28 09:33:15.307560][[32mTEST[0m][[31mSTDERR[0m] runner.run() [2026-07-28 09:33:15.307607][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 515, in run [2026-07-28 09:33:15.307620][[32mTEST[0m][[31mSTDERR[0m] self._run_test_class( [2026-07-28 09:33:15.307691][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 458, in _run_test_class [2026-07-28 09:33:15.307713][[32mTEST[0m][[31mSTDERR[0m] cls_result = test_instance.run(tests) [2026-07-28 09:33:15.307763][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 1103, in run [2026-07-28 09:33:15.307789][[32mTEST[0m][[31mSTDERR[0m] setup_class_result = self._setup_class() [2026-07-28 09:33:15.307840][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 411, in _setup_class [2026-07-28 09:33:15.307852][[32mTEST[0m][[31mSTDERR[0m] self.setup_class() [2026-07-28 09:33:15.307906][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 270, in async_runner [2026-07-28 09:33:15.307931][[32mTEST[0m][[31mSTDERR[0m] return _async_runner(body, self, args, kwargs) [2026-07-28 09:33:15.307985][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 254, in _async_runner [2026-07-28 09:33:15.308037][[32mTEST[0m][[31mSTDERR[0m] return test_instance.event_loop.run_until_complete(asyncio.wait_for(body(test_instance, args, *kwargs), timeout=timeout)) [2026-07-28 09:33:15.308074][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 637, in run_until_complete [2026-07-28 09:33:15.308087][[32mTEST[0m][[31mSTDERR[0m] self.run_forever() [2026-07-28 09:33:15.308120][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 604, in run_forever [2026-07-28 09:33:15.308131][[32mTEST[0m][[31mSTDERR[0m] self._run_once() [2026-07-28 09:33:15.308167][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 1901, in _run_once [2026-07-28 09:33:15.308177][[32mTEST[0m][[31mSTDERR[0m] handle._run() [2026-07-28 09:33:15.308206][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/events.py", line 80, in _run [2026-07-28 09:33:15.308229][[32mTEST[0m][[31mSTDERR[0m] self._context.run(self._callback, self._args) [2026-07-28 09:33:15.308272][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 337, in setup_class [2026-07-28 09:33:15.308295][[32mTEST[0m][[31mSTDERR[0m] await self.setup_class_helper() [2026-07-28 09:33:15.308353][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/basic_composition.py", line 196, in setup_class_helper [2026-07-28 09:33:15.308381][[32mTEST[0m][[31mSTDERR[0m] task_list.append(asyncio.create_task(pase_future)) [2026-07-28 09:33:15.308412][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/tasks.py", line 379, in create_task [2026-07-28 09:33:15.308429][[32mTEST[0m][[31mSTDERR[0m] task = loop.create_task(coro) [2026-07-28 09:33:15.308445][[32mTEST[0m][[31mSTDERR[0m]Traceback (most recent call last): [2026-07-28 09:33:15.308503][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1555, in FindOrEstablishPASESession [2026-07-28 09:33:15.308528][[32mTEST[0m][[31mSTDERR[0m] await self.EstablishPASESession(setupCode, nodeId) [2026-07-28 09:33:15.308583][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1109, in EstablishPASESession [2026-07-28 09:33:15.308601][[32mTEST[0m][[31mSTDERR[0m] await self._establishPASESession( [2026-07-28 09:33:15.308657][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1018, in _establishPASESession [2026-07-28 09:33:15.308687][[32mTEST[0m][[31mSTDERR[0m] await asyncio.futures.wrap_future(ctx.future) [2026-07-28 09:33:15.308751][[32mTEST[0m][[31mSTDERR[0m]matter.exceptions.ChipStackError: src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state 2026-07-28 09:33:15 matter-build-coverage __main__[104906] ERROR Test script exited with returncode 1 2026-07-28 09:33:15 matter-build-coverage __main__[104906] INFO Stopping app restart monitor thread 2026-07-28 09:33:15 matter-build-coverage __main__[104906] INFO Stopping app with SIGTERM 2026-07-28 09:33:15 matter-build-coverage __main__[104906] ERROR SUBPROCESS failure: 2026-07-28 09:33:15 matter-build-coverage __main__[104906] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_8d7ebb4f']) 2026-07-28 09:33:15 matter-build-coverage __main__[104906] ERROR APP: 0 (['./out/linux-x64-dishwasher-no-ble/chip-dishwasher-app', '--trace-to', 'json:log']) 2026-07-28 09:33:15 matter-build-coverage __main__[104906] INFO Cleaning up flag files
chip-all-clusters-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-all-clusters-no-ble-clang-boringssl/chip-all-clusters-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:32:18.401995][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 4293984256 (0xfff10000) Unknown cluster [2026-07-28 09:32:18.402019][[32mTEST[0m][[33mSTDOUT[0m] problem: Cluster 0xfff10000 with bad prefix 0xfff1 [2026-07-28 09:32:18.402046][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Manufacturer Extensible Identifier (MEI) [2026-07-28 09:32:18.402050][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:18.402068][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.382 INFO [2026-07-28 09:32:18.402077][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:32:18.402093][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:32:18.402102][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:32:18.402113][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:32:18.402138][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 4293984256 (0xfff10000) Unknown cluster [2026-07-28 09:32:18.402164][[32mTEST[0m][[33mSTDOUT[0m] problem: Cluster 0xfff10000 with bad prefix 0xfff1 [2026-07-28 09:32:18.402191][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Manufacturer Extensible Identifier (MEI) [2026-07-28 09:32:18.402194][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:18.402235][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.382 INFO ########################################################### [2026-07-28 09:32:18.402272][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:32:18.402300][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO Config values: [2026-07-28 09:32:18.402329][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - admin_vendor_id: 65521 [2026-07-28 09:32:18.402353][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - app_pid: 0 [2026-07-28 09:32:18.402381][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - commission_only: False [2026-07-28 09:32:18.402412][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - controller_cat_tags: [65537] [2026-07-28 09:32:18.402442][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - controller_node_id: 112233 [2026-07-28 09:32:18.402467][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - debug: False [2026-07-28 09:32:18.402497][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - dut_node_ids: [305414945] [2026-07-28 09:32:18.402521][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - fabric_id: 1 [2026-07-28 09:32:18.402552][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - fail_on_skipped_tests: True [2026-07-28 09:32:18.402577][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - legacy: False [2026-07-28 09:32:18.402611][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:32:18.402641][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - maximize_cert_chains: True [2026-07-28 09:32:18.402679][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - no_wildcard_subscription: False [2026-07-28 09:32:18.402733][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:32:18.402771][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:32:18.402813][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - restart_flag_file: '/tmp/chip_test_restart_app_d1875f4b' [2026-07-28 09:32:18.402842][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - root_of_trust_index: 1 [2026-07-28 09:32:18.402875][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:32:18.402894][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO [2026-07-28 09:32:18.402898][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:18.402906][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:32:18.402952][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:18.403000][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - certificate_authority_manager: '37a1eec0-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:18.403043][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - default_controller: '37a1eebd-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:18.403080][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - hooks: '37a1eebf-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:18.403128][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:18.403168][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - matter_stack: '37a1eebc-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:18.403211][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO - matter_test_config: '37a1eebe-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:18.403245][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:32:18.403328][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.383 INFO Summary for test class TC_DeviceBasicComposition: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 [2026-07-28 09:32:18.403370][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:18.384 INFO Summary for test run MatterTest@07-28-2026_09-32-14-545: [2026-07-28 09:32:18.403389][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 3.8382639789997484s [2026-07-28 09:32:18.403426][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-14-545" [2026-07-28 09:32:18.403469][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-14-545/test_summary.yaml" [2026-07-28 09:32:18.403504][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 2026-07-28 09:32:18 matter-build-coverage __main__[104857] ERROR Test script exited with returncode 1 2026-07-28 09:32:18 matter-build-coverage __main__[104857] INFO Stopping app restart monitor thread 2026-07-28 09:32:18 matter-build-coverage __main__[104857] INFO Stopping app with SIGTERM [2026-07-28 09:32:18.632695][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.632] [104859:104859] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:32:18.632817][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.632] [104859:104859] [EVL] LogEvent event number: 0x0000000000000004 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA8115F48[0m [2026-07-28 09:32:18.632864][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.632] [104859:104859] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:32:18.632919][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.632] [104859:104859] [SVR] OperationalState::Instance destroyed without Shutdown(); shutting down now.[0m [2026-07-28 09:32:18.632973][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.632] [104859:104859] [SVR] OperationalState::Instance destroyed without Shutdown(); shutting down now.[0m [2026-07-28 09:32:18.633027][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.632] [104859:104859] [SVR] OperationalState::Instance destroyed without Shutdown(); shutting down now.[0m [2026-07-28 09:32:18.633074][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.632] [104859:104859] [IN] SecureSession[0x588952114300]: Released - Type:2 LSID:11799[0m [2026-07-28 09:32:18.633117][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.632] [104859:104859] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:32:18.633159][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [IM] Shutting down data model provider 0x588912bcb338[0m [2026-07-28 09:32:18.633195][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:32:18.633235][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [DMG] TLSCertificateManagementCluster: shutdown[0m [2026-07-28 09:32:18.633273][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [DMG] TLSClientManagementCluster: shutdown[0m [2026-07-28 09:32:18.633328][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [ZCL] Shuting down on/off server cluster on endpoint 1[0m [2026-07-28 09:32:18.633374][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [ZCL] Shuting down level control server cluster on endpoint 1[0m [2026-07-28 09:32:18.633419][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [ZCL] Shutting down thermostat server cluster on endpoint 1[0m [2026-07-28 09:32:18.633464][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [ZCL] Shuting down color control server cluster on endpoint 1[0m [2026-07-28 09:32:18.633507][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [ZCL] Shuting down on/off server cluster on endpoint 2[0m [2026-07-28 09:32:18.633569][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:32:18.633619][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.632] [104859:104859] [IN] SecureSession[0x5889521192d0]: MarkForEviction Type:1 LSID:11798[0m [2026-07-28 09:32:18.633691][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [SC] SecureSession[0x5889521192d0, LSID:11798]: State change 'kActive' --> 'kPendingEviction'[0m [2026-07-28 09:32:18.633728][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.632] [104859:104859] [FS] Fail-safe timer expired[0m [2026-07-28 09:32:18.633776][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.632] [104859:104859] [IN] SecureSession[0x5889521192d0]: Released - Type:1 LSID:11798[0m [2026-07-28 09:32:18.633813][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.633] [104859:104859] [DMG] AccessControl: finishing[0m [2026-07-28 09:32:18.633868][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.633] [104859:104859] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:32:18.635388][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231138.635] [104859:104859] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:32:18.635476][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.635] [104859:104859] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:32:18.635510][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.635] [104859:104859] [DL] Inet Layer shutdown[0m [2026-07-28 09:32:18.635545][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.635] [104859:104859] [DL] WiFi-PAF Layer shutdown[0m [2026-07-28 09:32:18.635577][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.635] [104859:104859] [DL] System Layer shutdown[0m [2026-07-28 09:32:18.635611][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231138.635] [104859:104859] [BDX] Stop polling for messages[0m [2026-07-28 09:32:18.635737][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.635862][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.635973][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636096][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636277][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636408][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636515][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636627][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636760][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636872][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [-] src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found at src/app/clusters/concentration-measurement-server/CodegenIntegration.h:78[0m [2026-07-28 09:32:18.636925][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [SVR] ActionsServer destroyed without Shutdown() being called; shutting down now.[0m [2026-07-28 09:32:18.637020][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231138.635] [104859:104859] [SVR] Failed to unregister cluster 1/0x0000_0025: src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found[0m 2026-07-28 09:32:18 matter-build-coverage __main__[104857] ERROR SUBPROCESS failure: 2026-07-28 09:32:18 matter-build-coverage __main__[104857] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_d1875f4b']) 2026-07-28 09:32:18 matter-build-coverage __main__[104857] ERROR APP: 0 (['./out/linux-x64-all-clusters-no-ble-clang-boringssl/chip-all-clusters-app', '--trace-to', 'json:log']) 2026-07-28 09:32:18 matter-build-coverage __main__[104857] INFO Cleaning up flag files
thermostat-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-thermostat-no-ble/thermostat-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:36:20.804982][[32mTEST[0m][[33mSTDOUT[0m]* asserts.fail(msg=self.problems[-1].problem) [2026-07-28 09:36:20.804986][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:36:20.804995][[32mTEST[0m][[33mSTDOUT[0m]* Test step: [2026-07-28 09:36:20.805030][[32mTEST[0m][[33mSTDOUT[0m]* UNKNOWN - no test steps provided in test script [2026-07-28 09:36:20.805034][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:36:20.805044][[32mTEST[0m][[33mSTDOUT[0m]* Endpoint: None [2026-07-28 09:36:20.805048][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:36:20.805078][[32mTEST[0m][[33mSTDOUT[0m]***************************************************************** [2026-07-28 09:36:20.805081][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:20.805110][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.787 INFO [Test] test_TC_SM_1_1 FAIL [2026-07-28 09:36:20.805141][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.788 INFO [Test] test_TC_SM_1_2 [2026-07-28 09:36:20.805203][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.790 INFO Starting test from /tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py: test_TC_SM_1_2 - 1 steps [2026-07-28 09:36:20.805235][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.790 INFO * Test Step 1 : Run entire test [2026-07-28 09:36:20.805268][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO * Test Step 1 : Run entire test [2026-07-28 09:36:20.805325][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO * Test Step 1 : Wildcard read of device - already done [2026-07-28 09:36:20.805394][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO * Test Step 2 : Verify the Descriptor cluster PartsList on endpoint 0 exactly lists all the other (non-0) endpoints on the DUT [2026-07-28 09:36:20.805472][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO * Test Step 3 : For each endpoint on the DUT (including EP 0), verify the PartsList in the Descriptor cluster on that endpoint does not include itself [2026-07-28 09:36:20.805515][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO * Test Step 4 : Separate endpoints into flat and tree style [2026-07-28 09:36:20.805555][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO * Test Step 5 : Check for cycles in the tree endpoints [2026-07-28 09:36:20.805596][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO *** Test Step 6 : Check flat lists include all sub ids [2026-07-28 09:36:20.805623][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO Finished test in 2532.0ms [2026-07-28 09:36:20.805652][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.791 INFO [Test] test_TC_SM_1_2 PASS [2026-07-28 09:36:20.805700][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.792 INFO ########################################################### [2026-07-28 09:36:20.805725][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.792 INFO Problems found: [2026-07-28 09:36:20.805749][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.792 INFO =============== [2026-07-28 09:36:20.805767][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.792 INFO [2026-07-28 09:36:20.805776][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:36:20.805791][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_SM_1_1 [2026-07-28 09:36:20.805800][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:36:20.805813][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 0, [2026-07-28 09:36:20.805831][[32mTEST[0m][[33mSTDOUT[0m] Cluster: None Unknown cluster [2026-07-28 09:36:20.805843][[32mTEST[0m][[33mSTDOUT[0m] Attribute:None [2026-07-28 09:36:20.805897][[32mTEST[0m][[33mSTDOUT[0m] problem: Groups server found on an endpoint but Groupcast cluster with Listener feature is not present on the root node (EP0) [2026-07-28 09:36:20.805925][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Root node device type - GroupcastListenerCond [2026-07-28 09:36:20.805928][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:20.805969][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.792 INFO ########################################################### [2026-07-28 09:36:20.806004][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:36:20.806027][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO Config values: [2026-07-28 09:36:20.806055][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - admin_vendor_id: 65521 [2026-07-28 09:36:20.806079][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - app_pid: 0 [2026-07-28 09:36:20.806107][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - commission_only: False [2026-07-28 09:36:20.806137][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - controller_cat_tags: [65537] [2026-07-28 09:36:20.806168][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - controller_node_id: 112233 [2026-07-28 09:36:20.806192][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - debug: False [2026-07-28 09:36:20.806221][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - dut_node_ids: [305414945] [2026-07-28 09:36:20.806246][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - fabric_id: 1 [2026-07-28 09:36:20.806281][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - fail_on_skipped_tests: True [2026-07-28 09:36:20.806306][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - legacy: False [2026-07-28 09:36:20.806340][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:36:20.806370][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - maximize_cert_chains: True [2026-07-28 09:36:20.806402][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - no_wildcard_subscription: False [2026-07-28 09:36:20.806453][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:36:20.806490][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:36:20.806532][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - restart_flag_file: '/tmp/chip_test_restart_app_bda5ed2e' [2026-07-28 09:36:20.806560][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - root_of_trust_index: 1 [2026-07-28 09:36:20.806593][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:36:20.806612][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO [2026-07-28 09:36:20.806615][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:20.806623][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:36:20.806669][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:36:20.806726][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - certificate_authority_manager: 'c9996d94-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:20.806768][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - default_controller: 'c9996d91-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:20.806808][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - hooks: 'c9996d93-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:20.806855][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:36:20.806895][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - matter_stack: 'c9996d90-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:20.806937][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO - matter_test_config: 'c9996d92-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:20.806971][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.793 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:36:20.807033][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.794 INFO Summary for test class TC_DeviceBasicComposition: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 [2026-07-28 09:36:20.807073][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:20.794 INFO Summary for test run MatterTest@07-28-2026_09-36-19-436: [2026-07-28 09:36:20.807092][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 1.3576506719982717s [2026-07-28 09:36:20.807129][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-36-19-436" [2026-07-28 09:36:20.807172][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-36-19-436/test_summary.yaml" [2026-07-28 09:36:20.807206][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 2026-07-28 09:36:20 matter-build-coverage __main__[105125] ERROR Test script exited with returncode 1 2026-07-28 09:36:20 matter-build-coverage __main__[105125] INFO Stopping app restart monitor thread 2026-07-28 09:36:20 matter-build-coverage __main__[105125] INFO Stopping app with SIGTERM [2026-07-28 09:36:20.993934][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.993] [105127:105127] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:36:20.994039][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.993] [105127:105127] [EVL] LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA8151201[0m [2026-07-28 09:36:20.994085][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.993] [105127:105127] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:36:20.994133][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.993] [105127:105127] [IN] SecureSession[0x5d8d76c0f270]: Released - Type:2 LSID:6531[0m [2026-07-28 09:36:20.994177][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.994] [105127:105127] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:36:20.994220][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [IM] Shutting down data model provider 0x5d8d3ac28080[0m [2026-07-28 09:36:20.994256][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:36:20.994311][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [ZCL] Shutting down thermostat server cluster on endpoint 1[0m [2026-07-28 09:36:20.994352][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:36:20.994401][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.994] [105127:105127] [IN] SecureSession[0x5d8d76c0ee20]: MarkForEviction Type:1 LSID:6530[0m [2026-07-28 09:36:20.994458][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [SC] SecureSession[0x5d8d76c0ee20, LSID:6530]: State change 'kActive' --> 'kPendingEviction'[0m [2026-07-28 09:36:20.994490][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [FS] Fail-safe timer expired[0m [2026-07-28 09:36:20.994536][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.994] [105127:105127] [IN] SecureSession[0x5d8d76c0ee20]: Released - Type:1 LSID:6530[0m [2026-07-28 09:36:20.994575][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [DMG] AccessControl: finishing[0m [2026-07-28 09:36:20.994614][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.994] [105127:105127] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:36:20.996758][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231380.996] [105127:105127] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:36:20.996834][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.996] [105127:105127] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:36:20.996870][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.996] [105127:105127] [DL] Inet Layer shutdown[0m [2026-07-28 09:36:20.996905][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.996] [105127:105127] [DL] WiFi-PAF Layer shutdown[0m [2026-07-28 09:36:20.996939][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231380.996] [105127:105127] [DL] System Layer shutdown[0m 2026-07-28 09:36:20 matter-build-coverage __main__[105125] ERROR SUBPROCESS failure: 2026-07-28 09:36:20 matter-build-coverage __main__[105125] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_bda5ed2e']) 2026-07-28 09:36:20 matter-build-coverage __main__[105125] ERROR APP: 0 (['./out/linux-x64-thermostat-no-ble/thermostat-app', '--trace-to', 'json:log']) 2026-07-28 09:36:20 matter-build-coverage __main__[105125] INFO Cleaning up flag files
chip-bridge-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-bridge-no-ble-clang-boringssl/chip-bridge-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:32:22.911704][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:32:22.911754][[32mTEST[0m][[33mSTDOUT[0m] problem: Did not find mandatory global Attribute FeatureMap 65532, 0xFFFC on Endpoint 12, Cluster OnOff (6, 0x0006) [2026-07-28 09:32:22.911771][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:32:22.911774][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:22.911793][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO [2026-07-28 09:32:22.911802][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:32:22.911818][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:32:22.911827][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:32:22.911838][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:32:22.911855][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:32:22.911870][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65533 (0xfffd) [2026-07-28 09:32:22.911996][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute ClusterRevision 65533, 0xFFFD: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:32:22.912014][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:32:22.912017][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:22.912035][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO [2026-07-28 09:32:22.912045][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:32:22.912061][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:32:22.912070][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:32:22.912081][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:32:22.912097][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:32:22.912113][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:32:22.912238][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute FeatureMap 65532, 0xFFFC: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:32:22.912258][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:32:22.912262][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:22.912280][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO [2026-07-28 09:32:22.912289][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:32:22.912305][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:32:22.912314][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:32:22.912325][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:32:22.912342][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:32:22.912357][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:32:22.912400][[32mTEST[0m][[33mSTDOUT[0m] problem: Found a failure to read/decode FEATURE_MAP on Endpoint 1, Cluster Identify (3, 0x0003) [2026-07-28 09:32:22.912412][[32mTEST[0m][[33mSTDOUT[0m] spec_location: [2026-07-28 09:32:22.912416][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:22.912461][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO ########################################################### [2026-07-28 09:32:22.912497][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:32:22.912520][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO Config values: [2026-07-28 09:32:22.912549][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - admin_vendor_id: 65521 [2026-07-28 09:32:22.912573][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - app_pid: 0 [2026-07-28 09:32:22.912602][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - commission_only: False [2026-07-28 09:32:22.912632][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - controller_cat_tags: [65537] [2026-07-28 09:32:22.912663][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - controller_node_id: 112233 [2026-07-28 09:32:22.912694][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - debug: False [2026-07-28 09:32:22.912725][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - dut_node_ids: [305414945] [2026-07-28 09:32:22.912750][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - fabric_id: 1 [2026-07-28 09:32:22.912781][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - fail_on_skipped_tests: True [2026-07-28 09:32:22.912806][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - legacy: False [2026-07-28 09:32:22.912840][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:32:22.912870][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - maximize_cert_chains: True [2026-07-28 09:32:22.912902][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.896 INFO - no_wildcard_subscription: False [2026-07-28 09:32:22.912955][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:32:22.912992][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:32:22.913034][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - restart_flag_file: '/tmp/chip_test_restart_app_26d15376' [2026-07-28 09:32:22.913063][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - root_of_trust_index: 1 [2026-07-28 09:32:22.913096][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:32:22.913117][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO [2026-07-28 09:32:22.913121][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:22.913129][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:32:22.913176][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:22.913224][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - certificate_authority_manager: '3ba6fd26-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:22.913266][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - default_controller: '3ba6fd23-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:22.913304][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - hooks: '3ba6fd25-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:22.913351][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:22.913391][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - matter_stack: '3ba6fd22-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:22.913434][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO - matter_test_config: '3ba6fd24-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:22.913472][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:32:22.913535][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO Summary for test class TC_DeviceBasicComposition: Error 1, Executed 9, Failed 1, Passed 7, Requested 9, Skipped 0 [2026-07-28 09:32:22.913575][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:22.897 INFO Summary for test run MatterTest@07-28-2026_09-32-21-288: [2026-07-28 09:32:22.913594][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 1.608635205999235s [2026-07-28 09:32:22.913630][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-21-288" [2026-07-28 09:32:22.913686][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-21-288/test_summary.yaml" [2026-07-28 09:32:22.913728][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 1, Executed 9, Failed 1, Passed 7, Requested 9, Skipped 0 2026-07-28 09:32:23 matter-build-coverage __main__[104873] ERROR Test script exited with returncode 1 2026-07-28 09:32:23 matter-build-coverage __main__[104873] INFO Stopping app restart monitor thread 2026-07-28 09:32:23 matter-build-coverage __main__[104873] INFO Stopping app with SIGTERM [2026-07-28 09:32:23.104277][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.104] [104875:104875] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:32:23.104380][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.104] [104875:104875] [EVL] LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA81170C0[0m [2026-07-28 09:32:23.104424][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.104] [104875:104875] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:32:23.104472][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.104] [104875:104875] [IN] SecureSession[0x5a84dd2b3300]: Released - Type:2 LSID:65112[0m [2026-07-28 09:32:23.104518][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.104] [104875:104875] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:32:23.104559][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.104] [104875:104875] [IM] Shutting down data model provider 0x5a84a3657ed8[0m [2026-07-28 09:32:23.104594][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.104] [104875:104875] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:32:23.104634][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.104] [104875:104875] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:32:23.104700][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.104] [104875:104875] [IN] SecureSession[0x5a84dd2b7e00]: MarkForEviction Type:1 LSID:65111[0m [2026-07-28 09:32:23.104775][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.104] [104875:104875] [SC] SecureSession[0x5a84dd2b7e00, LSID:65111]: State change 'kActive' --> 'kPendingEviction'[0m [2026-07-28 09:32:23.104807][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.104] [104875:104875] [FS] Fail-safe timer expired[0m [2026-07-28 09:32:23.104853][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.104] [104875:104875] [IN] SecureSession[0x5a84dd2b7e00]: Released - Type:1 LSID:65111[0m [2026-07-28 09:32:23.104885][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.104] [104875:104875] [DMG] AccessControl: finishing[0m [2026-07-28 09:32:23.104923][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.104] [104875:104875] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:32:23.106726][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231143.106] [104875:104875] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:32:23.106781][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.106] [104875:104875] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:32:23.106813][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.106] [104875:104875] [DL] Inet Layer shutdown[0m [2026-07-28 09:32:23.106845][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.106] [104875:104875] [DL] WiFi-PAF Layer shutdown[0m [2026-07-28 09:32:23.106876][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231143.106] [104875:104875] [DL] System Layer shutdown[0m [2026-07-28 09:32:23.106939][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231143.106] [104875:104875] [SVR] ActionsServer destroyed without Shutdown() being called; shutting down now.[0m [2026-07-28 09:32:23.107060][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231143.106] [104875:104875] [SVR] Failed to unregister cluster 1/0x0000_0025: src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found[0m 2026-07-28 09:32:23 matter-build-coverage __main__[104873] ERROR SUBPROCESS failure: 2026-07-28 09:32:23 matter-build-coverage __main__[104873] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_26d15376']) 2026-07-28 09:32:23 matter-build-coverage __main__[104873] ERROR APP: 0 (['./out/linux-x64-bridge-no-ble-clang-boringssl/chip-bridge-app', '--trace-to', 'json:log']) 2026-07-28 09:32:23 matter-build-coverage __main__[104873] INFO Cleaning up flag files
chip-ota-requestor-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-ota-requestor-no-ble/chip-ota-requestor-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:36:08.633639][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:36:08.633655][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65533 (0xfffd) [2026-07-28 09:36:08.633792][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute ClusterRevision 65533, 0xFFFD: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:36:08.633812][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:36:08.633816][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:08.633834][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.627 INFO [2026-07-28 09:36:08.633843][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:36:08.633859][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:36:08.633868][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:36:08.633880][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:36:08.633897][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:36:08.633912][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:36:08.634038][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute FeatureMap 65532, 0xFFFC: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:36:08.634056][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:36:08.634059][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:08.634078][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.627 INFO [2026-07-28 09:36:08.634087][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:36:08.634103][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:36:08.634111][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:36:08.634123][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:36:08.634139][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:36:08.634155][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:36:08.634197][[32mTEST[0m][[33mSTDOUT[0m] problem: Found a failure to read/decode FEATURE_MAP on Endpoint 1, Cluster Identify (3, 0x0003) [2026-07-28 09:36:08.634208][[32mTEST[0m][[33mSTDOUT[0m] spec_location: [2026-07-28 09:36:08.634211][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:08.634229][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.627 INFO [2026-07-28 09:36:08.634238][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:36:08.634254][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_SM_1_1 [2026-07-28 09:36:08.634263][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:36:08.634273][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 0, [2026-07-28 09:36:08.634291][[32mTEST[0m][[33mSTDOUT[0m] Cluster: None Unknown cluster [2026-07-28 09:36:08.634303][[32mTEST[0m][[33mSTDOUT[0m] Attribute:None [2026-07-28 09:36:08.634356][[32mTEST[0m][[33mSTDOUT[0m] problem: Groups server found on an endpoint but Groupcast cluster with Listener feature is not present on the root node (EP0) [2026-07-28 09:36:08.634434][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Root node device type - GroupcastListenerCond [2026-07-28 09:36:08.634442][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:08.634458][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! [2026-07-28 09:36:08.634548][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.627 INFO ########################################################### [2026-07-28 09:36:08.634585][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.627 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:36:08.634609][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.627 INFO Config values: [2026-07-28 09:36:08.634637][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - admin_vendor_id: 65521 [2026-07-28 09:36:08.634661][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - app_pid: 0 [2026-07-28 09:36:08.634698][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - commission_only: False [2026-07-28 09:36:08.634731][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - controller_cat_tags: [65537] [2026-07-28 09:36:08.634760][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - controller_node_id: 112233 [2026-07-28 09:36:08.634785][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - debug: False [2026-07-28 09:36:08.634815][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - dut_node_ids: [305414945] [2026-07-28 09:36:08.634839][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - fabric_id: 1 [2026-07-28 09:36:08.634869][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - fail_on_skipped_tests: True [2026-07-28 09:36:08.634894][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - legacy: False [2026-07-28 09:36:08.634931][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:36:08.634961][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - maximize_cert_chains: True [2026-07-28 09:36:08.634993][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - no_wildcard_subscription: False [2026-07-28 09:36:08.635045][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:36:08.635081][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:36:08.635123][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - restart_flag_file: '/tmp/chip_test_restart_app_adddc43c' [2026-07-28 09:36:08.635151][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - root_of_trust_index: 1 [2026-07-28 09:36:08.635184][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:36:08.635202][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO [2026-07-28 09:36:08.635205][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:08.635213][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:36:08.635259][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:36:08.635306][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - certificate_authority_manager: 'c2818d7a-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:08.635348][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - default_controller: 'c2818d77-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:08.635391][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - hooks: 'c2818d79-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:08.635437][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:36:08.635477][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - matter_stack: 'c2818d76-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:08.635520][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO - matter_test_config: 'c2818d78-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:08.635553][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:36:08.635615][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.628 INFO Summary for test class TC_DeviceBasicComposition: Error 0, Executed 9, Failed 2, Passed 7, Requested 9, Skipped 0 [2026-07-28 09:36:08.635655][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:08.629 INFO Summary for test run MatterTest@07-28-2026_09-36-07-535: [2026-07-28 09:36:08.635679][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 1.092958520999673s [2026-07-28 09:36:08.635717][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-36-07-535" [2026-07-28 09:36:08.635760][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-36-07-535/test_summary.yaml" [2026-07-28 09:36:08.635794][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 0, Executed 9, Failed 2, Passed 7, Requested 9, Skipped 0 2026-07-28 09:36:08 matter-build-coverage __main__[105070] ERROR Test script exited with returncode 1 2026-07-28 09:36:08 matter-build-coverage __main__[105070] INFO Stopping app restart monitor thread 2026-07-28 09:36:08 matter-build-coverage __main__[105070] INFO Stopping app with SIGTERM [2026-07-28 09:36:08.834548][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.834] [105072:105072] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:36:08.834649][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.834] [105072:105072] [EVL] LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA814E282[0m [2026-07-28 09:36:08.834714][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.834] [105072:105072] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:36:08.834771][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.834] [105072:105072] [IN] SecureSession[0x64b6ca1acaa0]: Released - Type:2 LSID:14255[0m [2026-07-28 09:36:08.834819][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.834] [105072:105072] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:36:08.834861][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [IM] Shutting down data model provider 0x64b693aca240[0m [2026-07-28 09:36:08.834896][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:36:08.834939][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [ZCL] Shuting down on/off server cluster on endpoint 1[0m [2026-07-28 09:36:08.834980][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:36:08.835028][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.834] [105072:105072] [IN] SecureSession[0x64b6ca1abf80]: MarkForEviction Type:1 LSID:14254[0m [2026-07-28 09:36:08.835086][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [SC] SecureSession[0x64b6ca1abf80, LSID:14254]: State change 'kActive' --> 'kPendingEviction'[0m [2026-07-28 09:36:08.835118][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [FS] Fail-safe timer expired[0m [2026-07-28 09:36:08.835164][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.834] [105072:105072] [IN] SecureSession[0x64b6ca1abf80]: Released - Type:1 LSID:14254[0m [2026-07-28 09:36:08.835197][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [DMG] AccessControl: finishing[0m [2026-07-28 09:36:08.835236][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.834] [105072:105072] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:36:08.837056][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231368.836] [105072:105072] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:36:08.837111][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.837] [105072:105072] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:36:08.837142][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.837] [105072:105072] [DL] Inet Layer shutdown[0m [2026-07-28 09:36:08.837174][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231368.837] [105072:105072] [DL] System Layer shutdown[0m 2026-07-28 09:36:08 matter-build-coverage __main__[105070] ERROR SUBPROCESS failure: 2026-07-28 09:36:08 matter-build-coverage __main__[105070] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_adddc43c']) 2026-07-28 09:36:08 matter-build-coverage __main__[105070] ERROR APP: 0 (['./out/linux-x64-ota-requestor-no-ble/chip-ota-requestor-app', '--trace-to', 'json:log']) 2026-07-28 09:36:08 matter-build-coverage __main__[105070] INFO Cleaning up flag files
matter-network-manager-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-network-manager-ipv6only-no-ble-clang-boringssl/matter-network-manager-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:34:28.310929][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - fail_on_skipped_tests: True [2026-07-28 09:34:28.310953][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - legacy: False [2026-07-28 09:34:28.310987][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:34:28.311016][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - maximize_cert_chains: True [2026-07-28 09:34:28.311047][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - no_wildcard_subscription: False [2026-07-28 09:34:28.311101][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:34:28.311139][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:34:28.311180][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - restart_flag_file: '/tmp/chip_test_restart_app_3c4a3ec0' [2026-07-28 09:34:28.311208][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - root_of_trust_index: 1 [2026-07-28 09:34:28.311240][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:34:28.311258][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.310 INFO [2026-07-28 09:34:28.311262][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:34:28.311270][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:34:28.311321][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:34:28.311368][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO - certificate_authority_manager: '6c545d6a-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:34:28.311410][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO - default_controller: '6c545d67-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:34:28.311447][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO - hooks: '6c545d69-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:34:28.311492][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:34:28.311532][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO - matter_stack: '6c545d66-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:34:28.311574][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO - matter_test_config: '6c545d68-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:34:28.311612][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:34:28.311683][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO Summary for test class TC_DeviceBasicComposition: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:34:28.311727][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:34:28.311 INFO Summary for test run MatterTest@07-28-2026_09-33-42-955: [2026-07-28 09:34:28.311749][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 45.35534326299967s [2026-07-28 09:34:28.311789][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-33-42-955" [2026-07-28 09:34:28.311839][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-33-42-955/test_summary.yaml" [2026-07-28 09:34:28.311872][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:34:28.312767][[32mTEST[0m][[31mSTDERR[0m]Shutting down the stack... [2026-07-28 09:34:28.316936][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! [2026-07-28 09:34:28.355572][[32mTEST[0m][[31mSTDERR[0m]Task exception was never retrieved [2026-07-28 09:34:28.355822][[32mTEST[0m][[31mSTDERR[0m]future: exception=ChipStackError(3, 'src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state') created at /usr/lib/python3.11/asyncio/tasks.py:379> [2026-07-28 09:34:28.355858][[32mTEST[0m][[31mSTDERR[0m]source_traceback: Object created at (most recent call last): [2026-07-28 09:34:28.355902][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 1373, in [2026-07-28 09:34:28.355918][[32mTEST[0m][[31mSTDERR[0m] default_matter_test_main() [2026-07-28 09:34:28.355975][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 347, in default_matter_test_main [2026-07-28 09:34:28.356000][[32mTEST[0m][[31mSTDERR[0m] run_tests(test_class, matter_test_config, hooks) [2026-07-28 09:34:28.356054][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 528, in run_tests [2026-07-28 09:34:28.356069][[32mTEST[0m][[31mSTDERR[0m] if not run_tests_no_exit( [2026-07-28 09:34:28.356123][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 476, in run_tests_no_exit [2026-07-28 09:34:28.356133][[32mTEST[0m][[31mSTDERR[0m] runner.run() [2026-07-28 09:34:28.356180][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 515, in run [2026-07-28 09:34:28.356194][[32mTEST[0m][[31mSTDERR[0m] self._run_test_class( [2026-07-28 09:34:28.356245][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 458, in _run_test_class [2026-07-28 09:34:28.356265][[32mTEST[0m][[31mSTDERR[0m] cls_result = test_instance.run(tests) [2026-07-28 09:34:28.356318][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 1103, in run [2026-07-28 09:34:28.356339][[32mTEST[0m][[31mSTDERR[0m] setup_class_result = self._setup_class() [2026-07-28 09:34:28.356389][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 411, in _setup_class [2026-07-28 09:34:28.356402][[32mTEST[0m][[31mSTDERR[0m] self.setup_class() [2026-07-28 09:34:28.356455][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 270, in async_runner [2026-07-28 09:34:28.356480][[32mTEST[0m][[31mSTDERR[0m] return _async_runner(body, self, args, kwargs) [2026-07-28 09:34:28.356534][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 254, in _async_runner [2026-07-28 09:34:28.356597][[32mTEST[0m][[31mSTDERR[0m] return test_instance.event_loop.run_until_complete(asyncio.wait_for(body(test_instance, args, *kwargs), timeout=timeout)) [2026-07-28 09:34:28.356633][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 637, in run_until_complete [2026-07-28 09:34:28.356646][[32mTEST[0m][[31mSTDERR[0m] self.run_forever() [2026-07-28 09:34:28.356687][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 604, in run_forever [2026-07-28 09:34:28.356700][[32mTEST[0m][[31mSTDERR[0m] self._run_once() [2026-07-28 09:34:28.356733][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 1901, in _run_once [2026-07-28 09:34:28.356743][[32mTEST[0m][[31mSTDERR[0m] handle._run() [2026-07-28 09:34:28.356771][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/events.py", line 80, in _run [2026-07-28 09:34:28.356801][[32mTEST[0m][[31mSTDERR[0m] self._context.run(self._callback, self._args) [2026-07-28 09:34:28.356845][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 337, in setup_class [2026-07-28 09:34:28.356862][[32mTEST[0m][[31mSTDERR[0m] await self.setup_class_helper() [2026-07-28 09:34:28.356920][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/basic_composition.py", line 196, in setup_class_helper [2026-07-28 09:34:28.356945][[32mTEST[0m][[31mSTDERR[0m] task_list.append(asyncio.create_task(pase_future)) [2026-07-28 09:34:28.356976][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/tasks.py", line 379, in create_task [2026-07-28 09:34:28.356992][[32mTEST[0m][[31mSTDERR[0m] task = loop.create_task(coro) [2026-07-28 09:34:28.357009][[32mTEST[0m][[31mSTDERR[0m]Traceback (most recent call last): [2026-07-28 09:34:28.357066][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1555, in FindOrEstablishPASESession [2026-07-28 09:34:28.357091][[32mTEST[0m][[31mSTDERR[0m] await self.EstablishPASESession(setupCode, nodeId) [2026-07-28 09:34:28.357146][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1109, in EstablishPASESession [2026-07-28 09:34:28.357163][[32mTEST[0m][[31mSTDERR[0m] await self._establishPASESession( [2026-07-28 09:34:28.357219][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1018, in _establishPASESession [2026-07-28 09:34:28.357241][[32mTEST[0m][[31mSTDERR[0m] await asyncio.futures.wrap_future(ctx.future) [2026-07-28 09:34:28.357307][[32mTEST[0m][[31mSTDERR[0m]matter.exceptions.ChipStackError: src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state 2026-07-28 09:34:28 matter-build-coverage __main__[105018] ERROR Test script exited with returncode 1 2026-07-28 09:34:28 matter-build-coverage __main__[105018] INFO Stopping app restart monitor thread 2026-07-28 09:34:28 matter-build-coverage __main__[105018] INFO Stopping app with SIGTERM [2026-07-28 09:34:28.473788][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.473] [105020:105020] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:34:28.473898][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.473] [105020:105020] [EVL] LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA8135A79[0m [2026-07-28 09:34:28.473943][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.473] [105020:105020] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:34:28.473995][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.473] [105020:105020] [IN] SecureSession[0x6183fd64af20]: Released - Type:2 LSID:9880[0m [2026-07-28 09:34:28.474051][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.474] [105020:105020] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:34:28.474094][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.474] [105020:105020] [IM] Shutting down data model provider 0x6183fc0b9fc8[0m [2026-07-28 09:34:28.474134][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.474] [105020:105020] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:34:28.474176][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.474] [105020:105020] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:34:28.474225][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.474] [105020:105020] [IN] SecureSession[0x6183fd64a9f0]: MarkForEviction Type:1 LSID:9879[0m [2026-07-28 09:34:28.474297][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.474] [105020:105020] [SC] SecureSession[0x6183fd64a9f0, LSID:9879]: State change 'kEstablishing' --> 'kPendingEviction'[0m [2026-07-28 09:34:28.474344][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.474] [105020:105020] [IN] SecureSession[0x6183fd64a9f0]: Released - Type:1 LSID:9879[0m [2026-07-28 09:34:28.474377][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.474] [105020:105020] [DMG] AccessControl: finishing[0m [2026-07-28 09:34:28.474416][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.474] [105020:105020] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:34:28.476382][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231268.476] [105020:105020] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:34:28.476449][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.476] [105020:105020] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:34:28.476483][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.476] [105020:105020] [DL] Inet Layer shutdown[0m [2026-07-28 09:34:28.476515][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231268.476] [105020:105020] [DL] System Layer shutdown[0m [2026-07-28 09:34:28.476612][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231268.476] [105020:105020] [SVR] Failed to unregister cluster 1/0x0000_0452: src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found[0m [2026-07-28 09:34:28.476794][[32mAPP [0m][[33mSTDOUT[0m][1;31m[1785231268.476] [105020:105020] [SVR] Failed to unregister cluster on endpoint 1: src/app/server-cluster/ServerClusterInterfaceRegistry.cpp:115: CHIP Error 0x000000D8: The item referenced in the function call was not found[0m 2026-07-28 09:34:28 matter-build-coverage __main__[105018] ERROR SUBPROCESS failure: 2026-07-28 09:34:28 matter-build-coverage __main__[105018] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_3c4a3ec0']) 2026-07-28 09:34:28 matter-build-coverage __main__[105018] ERROR APP: 0 (['./out/linux-x64-network-manager-ipv6only-no-ble-clang-boringssl/matter-network-manager-app', '--trace-to', 'json:log']) 2026-07-28 09:34:28 matter-build-coverage __main__[105018] INFO Cleaning up flag files
chip-all-clusters-minimal-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-all-clusters-minimal-no-ble/chip-all-clusters-minimal-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:32:02.623192][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:02.623 INFO ??4 [E:7941i S:31052 M:113325058] (S) Msg Retransmission to 0:FFFFFFFB00000000 scheduled for 899ms from now [State:Active II:500 AI:300 AT:4000] [2026-07-28 09:32:03.523513][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:03.523 INFO <<4 [E:7941i S:31052 M:113325058] (S) Msg Retransmission to 0:FFFFFFFB00000000 [2026-07-28 09:32:03.523984][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:03.523 INFO ??5 [E:7941i S:31052 M:113325058] (S) Msg Retransmission to 0:FFFFFFFB00000000 scheduled for 1626ms from now [State:Active II:500 AI:300 AT:4000] [2026-07-28 09:32:05.151444][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:05.151 ERROR <<5 [E:7941i S:31052 M:113325058] (S) Msg Retransmission to 0:FFFFFFFB00000000 failure (max retries:4) [2026-07-28 09:32:11.703951][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.703 ERROR Time out! failed to receive report data from Exchange: 7941i [2026-07-28 09:32:11.705523][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.704 ERROR Error in TC_DeviceBasicComposition#setup_class. [2026-07-28 09:32:11.705564][[32mTEST[0m][[33mSTDOUT[0m]Traceback (most recent call last): [2026-07-28 09:32:11.705618][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 411, in _setup_class [2026-07-28 09:32:11.705633][[32mTEST[0m][[33mSTDOUT[0m] self.setup_class() [2026-07-28 09:32:11.705725][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 270, in async_runner [2026-07-28 09:32:11.705754][[32mTEST[0m][[33mSTDOUT[0m] return _async_runner(body, self, args, kwargs) [2026-07-28 09:32:11.705778][[32mTEST[0m][[33mSTDOUT[0m] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-07-28 09:32:11.705835][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 254, in _async_runner [2026-07-28 09:32:11.705889][[32mTEST[0m][[33mSTDOUT[0m] return test_instance.event_loop.run_until_complete(asyncio.wait_for(body(test_instance, args, kwargs), timeout=timeout)) [2026-07-28 09:32:11.705942][[32mTEST[0m][[33mSTDOUT[0m] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-07-28 09:32:11.705979][[32mTEST[0m][[33mSTDOUT[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 650, in run_until_complete [2026-07-28 09:32:11.705993][[32mTEST[0m][[33mSTDOUT[0m] return future.result() [2026-07-28 09:32:11.706007][[32mTEST[0m][[33mSTDOUT[0m] ^^^^^^^^^^^^^^^ [2026-07-28 09:32:11.706037][[32mTEST[0m][[33mSTDOUT[0m] File "/usr/lib/python3.11/asyncio/tasks.py", line 484, in wait_for [2026-07-28 09:32:11.706050][[32mTEST[0m][[33mSTDOUT[0m] return fut.result() [2026-07-28 09:32:11.706063][[32mTEST[0m][[33mSTDOUT[0m] ^^^^^^^^^^^^ [2026-07-28 09:32:11.706107][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 337, in setup_class [2026-07-28 09:32:11.706125][[32mTEST[0m][[33mSTDOUT[0m] await self.setup_class_helper() [2026-07-28 09:32:11.706186][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/basic_composition.py", line 213, in setup_class_helper [2026-07-28 09:32:11.706223][[32mTEST[0m][[33mSTDOUT[0m] wildcard_read = (await dev_ctrl.Read(node_id, [()])) # type: ignore[list-item] [2026-07-28 09:32:11.706248][[32mTEST[0m][[33mSTDOUT[0m] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-07-28 09:32:11.706308][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 2404, in Read [2026-07-28 09:32:11.706337][[32mTEST[0m][[33mSTDOUT[0m] return await self._run_with_session_retry(nodeId, _read_impl) [2026-07-28 09:32:11.706367][[32mTEST[0m][[33mSTDOUT[0m] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-07-28 09:32:11.706424][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 2262, in _run_with_session_retry [2026-07-28 09:32:11.706436][[32mTEST[0m][[33mSTDOUT[0m] return await fn() [2026-07-28 09:32:11.706448][[32mTEST[0m][[33mSTDOUT[0m] ^^^^^^^^^^ [2026-07-28 09:32:11.706500][[32mTEST[0m][[33mSTDOUT[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 2399, in _read_impl [2026-07-28 09:32:11.706510][[32mTEST[0m][[33mSTDOUT[0m] await future [2026-07-28 09:32:11.706550][[32mTEST[0m][[33mSTDOUT[0m]matter.exceptions.ChipStackError: src/app/ReadClient.cpp:756: CHIP Error 0x00000032: Timeout [2026-07-28 09:32:11.706577][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.706 INFO * Test Failure : [2026-07-28 09:32:11.706603][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.706 INFO Finished test in 0ms [2026-07-28 09:32:11.708863][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.708 ERROR [2026-07-28 09:32:11.708876][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:11.708908][[32mTEST[0m][[33mSTDOUT[0m]**************************************************************** [2026-07-28 09:32:11.708919][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:32:11.708943][[32mTEST[0m][[33mSTDOUT[0m]* Test setup_class failed for the following reason: [2026-07-28 09:32:11.708971][[32mTEST[0m][[33mSTDOUT[0m]* src/app/ReadClient.cpp:756: CHIP Error 0x00000032: Timeout [2026-07-28 09:32:11.708975][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:32:11.709028][[32mTEST[0m][[33mSTDOUT[0m]* File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 2399, in _read_impl [2026-07-28 09:32:11.709069][[32mTEST[0m][[33mSTDOUT[0m]* matter.exceptions.ChipStackError: src/app/ReadClient.cpp:756: CHIP Error 0x00000032: Timeout [2026-07-28 09:32:11.709074][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:32:11.709082][[32mTEST[0m][[33mSTDOUT[0m]* Test step: [2026-07-28 09:32:11.709106][[32mTEST[0m][[33mSTDOUT[0m]* UNKNOWN - no test steps provided in test script [2026-07-28 09:32:11.709110][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:32:11.709120][[32mTEST[0m][[33mSTDOUT[0m]* Endpoint: None [2026-07-28 09:32:11.709124][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:32:11.709154][[32mTEST[0m][[33mSTDOUT[0m]******************************************************************* [2026-07-28 09:32:11.709157][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:11.733164][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:32:11.733216][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO Config values: [2026-07-28 09:32:11.733246][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - admin_vendor_id: 65521 [2026-07-28 09:32:11.733270][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - app_pid: 0 [2026-07-28 09:32:11.733301][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - commission_only: False [2026-07-28 09:32:11.733333][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - controller_cat_tags: [65537] [2026-07-28 09:32:11.733363][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - controller_node_id: 112233 [2026-07-28 09:32:11.733388][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - debug: False [2026-07-28 09:32:11.733418][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - dut_node_ids: [305414945] [2026-07-28 09:32:11.733442][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - fabric_id: 1 [2026-07-28 09:32:11.733473][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - fail_on_skipped_tests: True [2026-07-28 09:32:11.733498][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - legacy: False [2026-07-28 09:32:11.733533][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:32:11.733563][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - maximize_cert_chains: True [2026-07-28 09:32:11.733595][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - no_wildcard_subscription: False [2026-07-28 09:32:11.733648][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:32:11.733703][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:32:11.733747][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - restart_flag_file: '/tmp/chip_test_restart_app_b2ffafce' [2026-07-28 09:32:11.733775][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - root_of_trust_index: 1 [2026-07-28 09:32:11.733813][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:32:11.733831][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO [2026-07-28 09:32:11.733835][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:11.733851][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:32:11.733900][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:11.733947][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - certificate_authority_manager: '2f64ac5c-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:11.733989][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - default_controller: '2f64ac59-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:11.734026][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - hooks: '2f64ac5b-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:11.734072][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:11.734112][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - matter_stack: '2f64ac58-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:11.734154][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO - matter_test_config: '2f64ac5a-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:11.734186][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:32:11.734248][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.733 INFO Summary for test class TC_DeviceBasicComposition: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:32:11.734335][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:11.734 INFO Summary for test run MatterTest@07-28-2026_09-32-00-721: [2026-07-28 09:32:11.734355][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 11.011946939001064s [2026-07-28 09:32:11.734391][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-00-721" [2026-07-28 09:32:11.734434][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-00-721/test_summary.yaml" [2026-07-28 09:32:11.734467][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:32:11.735595][[32mTEST[0m][[31mSTDERR[0m]Shutting down the stack... [2026-07-28 09:32:11.739288][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! 2026-07-28 09:32:11 matter-build-coverage __main__[104840] ERROR Test script exited with returncode 1 2026-07-28 09:32:11 matter-build-coverage __main__[104840] INFO Stopping app restart monitor thread 2026-07-28 09:32:11 matter-build-coverage __main__[104840] INFO Stopping app with SIGTERM 2026-07-28 09:32:11 matter-build-coverage __main__[104840] ERROR SUBPROCESS failure: 2026-07-28 09:32:11 matter-build-coverage __main__[104840] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_b2ffafce']) 2026-07-28 09:32:11 matter-build-coverage __main__[104840] ERROR APP: 0 (['./out/linux-x64-all-clusters-minimal-no-ble/chip-all-clusters-minimal-app', '--trace-to', 'json:log']) 2026-07-28 09:32:11 matter-build-coverage __main__[104840] INFO Cleaning up flag files
contact-sensor-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-contact-sensor-no-ble/contact-sensor-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:32:27.015619][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.015 INFO [Test] test_TC_SM_1_2 PASS [2026-07-28 09:32:27.017011][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.016 INFO ########################################################### [2026-07-28 09:32:27.017061][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.016 INFO Problems found: [2026-07-28 09:32:27.017087][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.016 INFO =============== [2026-07-28 09:32:27.017105][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO [2026-07-28 09:32:27.017114][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:32:27.017131][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:32:27.017140][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:32:27.017151][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:32:27.017168][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:32:27.017183][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65533 (0xfffd) [2026-07-28 09:32:27.017318][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute ClusterRevision 65533, 0xFFFD: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:32:27.017337][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:32:27.017340][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:27.017359][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO [2026-07-28 09:32:27.017368][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:32:27.017383][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:32:27.017392][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:32:27.017403][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:32:27.017420][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:32:27.017435][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:32:27.017558][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute FeatureMap 65532, 0xFFFC: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:32:27.017582][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:32:27.017586][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:27.017604][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO [2026-07-28 09:32:27.017613][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:32:27.017628][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:32:27.017637][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:32:27.017648][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:32:27.017665][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:32:27.017700][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:32:27.017745][[32mTEST[0m][[33mSTDOUT[0m] problem: Found a failure to read/decode FEATURE_MAP on Endpoint 1, Cluster Identify (3, 0x0003) [2026-07-28 09:32:27.017756][[32mTEST[0m][[33mSTDOUT[0m] spec_location: [2026-07-28 09:32:27.017760][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:27.017808][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO ########################################################### [2026-07-28 09:32:27.017842][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:32:27.017866][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO Config values: [2026-07-28 09:32:27.017894][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - admin_vendor_id: 65521 [2026-07-28 09:32:27.017917][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - app_pid: 0 [2026-07-28 09:32:27.017945][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - commission_only: False [2026-07-28 09:32:27.017976][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - controller_cat_tags: [65537] [2026-07-28 09:32:27.018005][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - controller_node_id: 112233 [2026-07-28 09:32:27.018029][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - debug: False [2026-07-28 09:32:27.018059][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - dut_node_ids: [305414945] [2026-07-28 09:32:27.018083][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - fabric_id: 1 [2026-07-28 09:32:27.018113][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - fail_on_skipped_tests: True [2026-07-28 09:32:27.018137][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - legacy: False [2026-07-28 09:32:27.018171][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:32:27.018200][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - maximize_cert_chains: True [2026-07-28 09:32:27.018232][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - no_wildcard_subscription: False [2026-07-28 09:32:27.018286][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:32:27.018323][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:32:27.018364][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - restart_flag_file: '/tmp/chip_test_restart_app_0a3371b9' [2026-07-28 09:32:27.018392][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - root_of_trust_index: 1 [2026-07-28 09:32:27.018425][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:32:27.018445][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO [2026-07-28 09:32:27.018449][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:32:27.018456][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:32:27.018503][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:27.018549][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - certificate_authority_manager: '3e510288-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:27.018593][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - default_controller: '3e510285-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:27.018630][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.017 INFO - hooks: '3e510287-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:27.018683][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.018 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:32:27.018724][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.018 INFO - matter_stack: '3e510284-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:27.018770][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.018 INFO - matter_test_config: '3e510286-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:32:27.018803][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.018 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:32:27.018866][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.018 INFO Summary for test class TC_DeviceBasicComposition: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 [2026-07-28 09:32:27.018906][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:32:27.018 INFO Summary for test run MatterTest@07-28-2026_09-32-25-758: [2026-07-28 09:32:27.018924][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 1.2593456430004153s [2026-07-28 09:32:27.018963][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-25-758" [2026-07-28 09:32:27.019006][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-32-25-758/test_summary.yaml" [2026-07-28 09:32:27.019042][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 [2026-07-28 09:32:27.019896][[32mTEST[0m][[31mSTDERR[0m]Shutting down the stack... [2026-07-28 09:32:27.024137][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! 2026-07-28 09:32:27 matter-build-coverage __main__[104890] ERROR Test script exited with returncode 1 2026-07-28 09:32:27 matter-build-coverage __main__[104890] INFO Stopping app restart monitor thread 2026-07-28 09:32:27 matter-build-coverage __main__[104890] INFO Stopping app with SIGTERM [2026-07-28 09:32:27.216393][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.216] [104892:104892] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:32:27.216490][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.216] [104892:104892] [EVL] LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA81180D0[0m [2026-07-28 09:32:27.216535][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.216] [104892:104892] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:32:27.216582][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.216] [104892:104892] [IN] SecureSession[0x5afe8675ecb0]: Released - Type:2 LSID:47695[0m [2026-07-28 09:32:27.216897][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.216] [104892:104892] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:32:27.216965][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.216] [104892:104892] [IM] Shutting down data model provider 0x5afe65209020[0m [2026-07-28 09:32:27.217002][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.216] [104892:104892] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:32:27.217052][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.216] [104892:104892] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:32:27.217101][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.216] [104892:104892] [IN] SecureSession[0x5afe8675e130]: MarkForEviction Type:1 LSID:47694[0m [2026-07-28 09:32:27.217159][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.216] [104892:104892] [SC] SecureSession[0x5afe8675e130, LSID:47694]: State change 'kActive' --> 'kPendingEviction'[0m [2026-07-28 09:32:27.217191][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.216] [104892:104892] [FS] Fail-safe timer expired[0m [2026-07-28 09:32:27.217237][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.216] [104892:104892] [IN] SecureSession[0x5afe8675e130]: Released - Type:1 LSID:47694[0m [2026-07-28 09:32:27.217270][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.216] [104892:104892] [DMG] AccessControl: finishing[0m [2026-07-28 09:32:27.217320][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.216] [104892:104892] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:32:27.219290][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231147.219] [104892:104892] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:32:27.219362][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.219] [104892:104892] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:32:27.219395][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.219] [104892:104892] [DL] Inet Layer shutdown[0m [2026-07-28 09:32:27.219427][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.219] [104892:104892] [DL] WiFi-PAF Layer shutdown[0m [2026-07-28 09:32:27.219459][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231147.219] [104892:104892] [DL] System Layer shutdown[0m 2026-07-28 09:32:27 matter-build-coverage __main__[104890] ERROR SUBPROCESS failure: 2026-07-28 09:32:27 matter-build-coverage __main__[104890] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_0a3371b9']) 2026-07-28 09:32:27 matter-build-coverage __main__[104890] ERROR APP: 0 (['./out/linux-x64-contact-sensor-no-ble/contact-sensor-app', '--trace-to', 'json:log']) 2026-07-28 09:32:27 matter-build-coverage __main__[104890] INFO Cleaning up flag files
chip-ota-provider-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-ota-provider-no-ble-clang-boringssl/chip-ota-provider-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:36:04.611471][[32mTEST[0m][[33mSTDOUT[0m]* matter.exceptions.ChipStackError: src/lib/address_resolve/AddressResolve_DefaultImpl.cpp:124: CHIP Error 0x00000032: Timeout [2026-07-28 09:36:04.611475][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:36:04.611484][[32mTEST[0m][[33mSTDOUT[0m]* Test step: [2026-07-28 09:36:04.611508][[32mTEST[0m][[33mSTDOUT[0m]* UNKNOWN - no test steps provided in test script [2026-07-28 09:36:04.611512][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:36:04.611522][[32mTEST[0m][[33mSTDOUT[0m]* Endpoint: None [2026-07-28 09:36:04.611526][[32mTEST[0m][[33mSTDOUT[0m]* [2026-07-28 09:36:04.611556][[32mTEST[0m][[33mSTDOUT[0m]******************************************************************* [2026-07-28 09:36:04.611559][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:04.637366][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:36:04.637403][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO Config values: [2026-07-28 09:36:04.637432][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - admin_vendor_id: 65521 [2026-07-28 09:36:04.637457][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - app_pid: 0 [2026-07-28 09:36:04.637486][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - commission_only: False [2026-07-28 09:36:04.637518][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - controller_cat_tags: [65537] [2026-07-28 09:36:04.637549][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - controller_node_id: 112233 [2026-07-28 09:36:04.637574][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - debug: False [2026-07-28 09:36:04.637604][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - dut_node_ids: [305414945] [2026-07-28 09:36:04.637628][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - fabric_id: 1 [2026-07-28 09:36:04.637659][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - fail_on_skipped_tests: True [2026-07-28 09:36:04.637698][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - legacy: False [2026-07-28 09:36:04.637734][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:36:04.637768][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - maximize_cert_chains: True [2026-07-28 09:36:04.637800][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - no_wildcard_subscription: False [2026-07-28 09:36:04.637853][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:36:04.637890][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:36:04.637940][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - restart_flag_file: '/tmp/chip_test_restart_app_28795494' [2026-07-28 09:36:04.637969][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - root_of_trust_index: 1 [2026-07-28 09:36:04.638002][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:36:04.638021][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO [2026-07-28 09:36:04.638024][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:36:04.638032][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:36:04.638078][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:36:04.638125][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - certificate_authority_manager: 'a5bf05f0-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:04.638168][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - default_controller: 'a5bf05ed-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:04.638206][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - hooks: 'a5bf05ef-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:04.638252][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:36:04.638292][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - matter_stack: 'a5bf05ec-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:04.638335][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.637 INFO - matter_test_config: 'a5bf05ee-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:36:04.638368][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.638 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:36:04.638431][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.638 INFO Summary for test class TC_DeviceBasicComposition: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:36:04.638562][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:36:04.638 INFO Summary for test run MatterTest@07-28-2026_09-35-19-284: [2026-07-28 09:36:04.638581][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 45.35310883300008s [2026-07-28 09:36:04.638618][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-35-19-284" [2026-07-28 09:36:04.638662][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-35-19-284/test_summary.yaml" [2026-07-28 09:36:04.638705][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 1, Executed 0, Failed 0, Passed 0, Requested 9, Skipped 9 [2026-07-28 09:36:04.639691][[32mTEST[0m][[31mSTDERR[0m]Shutting down the stack... [2026-07-28 09:36:04.643885][[32mTEST[0m][[31mSTDERR[0m]Final result: FAIL ! [2026-07-28 09:36:04.689214][[32mTEST[0m][[31mSTDERR[0m]Task exception was never retrieved [2026-07-28 09:36:04.689425][[32mTEST[0m][[31mSTDERR[0m]future: exception=ChipStackError(3, 'src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state') created at /usr/lib/python3.11/asyncio/tasks.py:379> [2026-07-28 09:36:04.689466][[32mTEST[0m][[31mSTDERR[0m]source_traceback: Object created at (most recent call last): [2026-07-28 09:36:04.689510][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 1373, in [2026-07-28 09:36:04.689527][[32mTEST[0m][[31mSTDERR[0m] default_matter_test_main() [2026-07-28 09:36:04.689584][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 347, in default_matter_test_main [2026-07-28 09:36:04.689609][[32mTEST[0m][[31mSTDERR[0m] run_tests(test_class, matter_test_config, hooks) [2026-07-28 09:36:04.689660][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 528, in run_tests [2026-07-28 09:36:04.689693][[32mTEST[0m][[31mSTDERR[0m] if not run_tests_no_exit( [2026-07-28 09:36:04.689749][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/runner.py", line 476, in run_tests_no_exit [2026-07-28 09:36:04.689759][[32mTEST[0m][[31mSTDERR[0m] runner.run() [2026-07-28 09:36:04.689807][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 515, in run [2026-07-28 09:36:04.689820][[32mTEST[0m][[31mSTDERR[0m] self._run_test_class( [2026-07-28 09:36:04.689872][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/test_runner.py", line 458, in _run_test_class [2026-07-28 09:36:04.689892][[32mTEST[0m][[31mSTDERR[0m] cls_result = test_instance.run(tests) [2026-07-28 09:36:04.689947][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 1103, in run [2026-07-28 09:36:04.689968][[32mTEST[0m][[31mSTDERR[0m] setup_class_result = self._setup_class() [2026-07-28 09:36:04.690018][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/mobly/base_test.py", line 411, in _setup_class [2026-07-28 09:36:04.690030][[32mTEST[0m][[31mSTDERR[0m] self.setup_class() [2026-07-28 09:36:04.690084][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 270, in async_runner [2026-07-28 09:36:04.690108][[32mTEST[0m][[31mSTDERR[0m] return _async_runner(body, self, args, kwargs) [2026-07-28 09:36:04.690162][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/decorators.py", line 254, in _async_runner [2026-07-28 09:36:04.690215][[32mTEST[0m][[31mSTDERR[0m] return test_instance.event_loop.run_until_complete(asyncio.wait_for(body(test_instance, args, *kwargs), timeout=timeout)) [2026-07-28 09:36:04.690251][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 637, in run_until_complete [2026-07-28 09:36:04.690264][[32mTEST[0m][[31mSTDERR[0m] self.run_forever() [2026-07-28 09:36:04.690298][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 604, in run_forever [2026-07-28 09:36:04.690309][[32mTEST[0m][[31mSTDERR[0m] self._run_once() [2026-07-28 09:36:04.690343][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/base_events.py", line 1901, in _run_once [2026-07-28 09:36:04.690353][[32mTEST[0m][[31mSTDERR[0m] handle._run() [2026-07-28 09:36:04.690381][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/events.py", line 80, in _run [2026-07-28 09:36:04.690404][[32mTEST[0m][[31mSTDERR[0m] self._context.run(self._callback, self._args) [2026-07-28 09:36:04.690450][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/src/python_testing/TC_DeviceBasicComposition.py", line 337, in setup_class [2026-07-28 09:36:04.690471][[32mTEST[0m][[31mSTDERR[0m] await self.setup_class_helper() [2026-07-28 09:36:04.690530][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/testing/basic_composition.py", line 196, in setup_class_helper [2026-07-28 09:36:04.690555][[32mTEST[0m][[31mSTDERR[0m] task_list.append(asyncio.create_task(pase_future)) [2026-07-28 09:36:04.690586][[32mTEST[0m][[31mSTDERR[0m] File "/usr/lib/python3.11/asyncio/tasks.py", line 379, in create_task [2026-07-28 09:36:04.690603][[32mTEST[0m][[31mSTDERR[0m] task = loop.create_task(coro) [2026-07-28 09:36:04.690620][[32mTEST[0m][[31mSTDERR[0m]Traceback (most recent call last): [2026-07-28 09:36:04.690685][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1555, in FindOrEstablishPASESession [2026-07-28 09:36:04.690711][[32mTEST[0m][[31mSTDERR[0m] await self.EstablishPASESession(setupCode, nodeId) [2026-07-28 09:36:04.690767][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1109, in EstablishPASESession [2026-07-28 09:36:04.690785][[32mTEST[0m][[31mSTDERR[0m] await self._establishPASESession( [2026-07-28 09:36:04.690841][[32mTEST[0m][[31mSTDERR[0m] File "/tmp/connectedhomeip/out/python_env/lib/python3.11/site-packages/matter/ChipDeviceCtrl.py", line 1018, in _establishPASESession [2026-07-28 09:36:04.690864][[32mTEST[0m][[31mSTDERR[0m] await asyncio.futures.wrap_future(ctx.future) [2026-07-28 09:36:04.690931][[32mTEST[0m][[31mSTDERR[0m]matter.exceptions.ChipStackError: src/controller/python/ChipDeviceController-ScriptDevicePairingDelegate.cpp:101: CHIP Error 0x00000003: Incorrect state 2026-07-28 09:36:04 matter-build-coverage __main__[105051] ERROR Test script exited with returncode 1 2026-07-28 09:36:04 matter-build-coverage __main__[105051] INFO Stopping app restart monitor thread 2026-07-28 09:36:04 matter-build-coverage __main__[105051] INFO Stopping app with SIGTERM 2026-07-28 09:36:04 matter-build-coverage __main__[105051] ERROR SUBPROCESS failure: 2026-07-28 09:36:04 matter-build-coverage __main__[105051] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_28795494']) 2026-07-28 09:36:04 matter-build-coverage __main__[105051] ERROR APP: 0 (['./out/linux-x64-ota-provider-no-ble-clang-boringssl/chip-ota-provider-app', '--trace-to', 'json:log']) 2026-07-28 09:36:04 matter-build-coverage __main__[105051] INFO Cleaning up flag files
chip-lighting-app	INVALID	2	Show/Hide run_python_test.py --app ./out/linux-x64-light-no-ble/chip-lighting-app --factory-reset --app-args "--trace-to json:log" --script src/python_testing/TC_DeviceBasicComposition.py --script-args "--qr-code MT:-24J0AFN00KA0648G00 --bool-arg ignore_in_progress_test_event_only_disallowed_for_certification:True allow_provisional_test_event_only_disallowed_for_certification:True"	Show/Hide Test didn't complete. Possible timeout or crash. Last log lines: [2026-07-28 09:33:27.784488][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.769 INFO Problems found: [2026-07-28 09:33:27.784512][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.769 INFO =============== [2026-07-28 09:33:27.784530][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO [2026-07-28 09:33:27.784540][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:33:27.784555][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:33:27.784565][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:33:27.784576][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:33:27.784593][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:33:27.784608][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65533 (0xfffd) [2026-07-28 09:33:27.784739][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute ClusterRevision 65533, 0xFFFD: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:33:27.784758][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:33:27.784762][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:33:27.784780][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO [2026-07-28 09:33:27.784789][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:33:27.784805][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:33:27.784814][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:33:27.784824][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:33:27.784841][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:33:27.784857][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:33:27.784979][[32mTEST[0m][[33mSTDOUT[0m] problem: Failed validation of value on Endpoint 1, Cluster Identify (3, 0x0003), Attribute FeatureMap 65532, 0xFFFC: Value ValueDecodeFailure(TLVValue=None, Reason=InteractionModelError()) is not an integer or uint (decoded type: ) [2026-07-28 09:33:27.784997][[32mTEST[0m][[33mSTDOUT[0m] spec_location: Global Elements [2026-07-28 09:33:27.785000][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:33:27.785026][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO [2026-07-28 09:33:27.785035][[32mTEST[0m][[33mSTDOUT[0m]Problem: ERROR [2026-07-28 09:33:27.785051][[32mTEST[0m][[33mSTDOUT[0m] test_name: test_TC_IDM_10_1 [2026-07-28 09:33:27.785060][[32mTEST[0m][[33mSTDOUT[0m] location: [2026-07-28 09:33:27.785071][[32mTEST[0m][[33mSTDOUT[0m] Endpoint: 1, [2026-07-28 09:33:27.785088][[32mTEST[0m][[33mSTDOUT[0m] Cluster: 3 (0x03) Identify [2026-07-28 09:33:27.785103][[32mTEST[0m][[33mSTDOUT[0m] Attribute:65532 (0xfffc) [2026-07-28 09:33:27.785145][[32mTEST[0m][[33mSTDOUT[0m] problem: Found a failure to read/decode FEATURE_MAP on Endpoint 1, Cluster Identify (3, 0x0003) [2026-07-28 09:33:27.785159][[32mTEST[0m][[33mSTDOUT[0m] spec_location: [2026-07-28 09:33:27.785162][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:33:27.785203][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO ########################################################### [2026-07-28 09:33:27.785237][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO ===== EXECUTION FLAGS SUMMARY BEGIN ===== [2026-07-28 09:33:27.785260][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO Config values: [2026-07-28 09:33:27.785292][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - admin_vendor_id: 65521 [2026-07-28 09:33:27.785317][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - app_pid: 0 [2026-07-28 09:33:27.785345][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - commission_only: False [2026-07-28 09:33:27.785376][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - controller_cat_tags: [65537] [2026-07-28 09:33:27.785406][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - controller_node_id: 112233 [2026-07-28 09:33:27.785431][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - debug: False [2026-07-28 09:33:27.785460][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - dut_node_ids: [305414945] [2026-07-28 09:33:27.785485][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - fabric_id: 1 [2026-07-28 09:33:27.785515][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - fail_on_skipped_tests: True [2026-07-28 09:33:27.785540][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - legacy: False [2026-07-28 09:33:27.785574][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - logs_path: '/tmp/matter_testing/logs' [2026-07-28 09:33:27.785603][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - maximize_cert_chains: True [2026-07-28 09:33:27.785635][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - no_wildcard_subscription: False [2026-07-28 09:33:27.785693][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - paa_trust_store_path: '/tmp/connectedhomeip/credentials/development/paa-root-certs' [2026-07-28 09:33:27.785732][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - qr_code_content: ['MT:-24J0AFN00KA0648G00'] [2026-07-28 09:33:27.785773][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - restart_flag_file: '/tmp/chip_test_restart_app_85507d52' [2026-07-28 09:33:27.785802][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - root_of_trust_index: 1 [2026-07-28 09:33:27.785835][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - storage_path: 'admin_storage.json' [2026-07-28 09:33:27.785853][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO [2026-07-28 09:33:27.785856][[32mTEST[0m][[33mSTDOUT[0m] [2026-07-28 09:33:27.785864][[32mTEST[0m][[33mSTDOUT[0m]Named args: [2026-07-28 09:33:27.785910][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - allow_provisional_test_event_only_disallowed_for_certification: True [2026-07-28 09:33:27.785957][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - certificate_authority_manager: '627da86e-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:27.785999][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.770 INFO - default_controller: '627da86b-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:27.786036][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.771 INFO - hooks: '627da86d-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:27.786082][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.771 INFO - ignore_in_progress_test_event_only_disallowed_for_certification: True [2026-07-28 09:33:27.786122][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.771 INFO - matter_stack: '627da86a-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:27.786166][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.771 INFO - matter_test_config: '627da86c-8a67-11f1-baaa-67a83015cac2' [2026-07-28 09:33:27.786200][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.771 INFO ===== EXECUTION FLAGS SUMMARY END ===== [2026-07-28 09:33:27.786262][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.771 INFO Summary for test class TC_DeviceBasicComposition: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 [2026-07-28 09:33:27.786306][[32mTEST[0m][[33mSTDOUT[0m][MatterTest] 07-28 09:33:27.771 INFO Summary for test run MatterTest@07-28-2026_09-33-26-448: [2026-07-28 09:33:27.786324][[32mTEST[0m][[33mSTDOUT[0m]Total time elapsed 1.322308979999434s [2026-07-28 09:33:27.786360][[32mTEST[0m][[33mSTDOUT[0m]Artifacts are saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-33-26-448" [2026-07-28 09:33:27.786403][[32mTEST[0m][[33mSTDOUT[0m]Test summary saved in "/tmp/matter_testing/logs/MatterTest/07-28-2026_09-33-26-448/test_summary.yaml" [2026-07-28 09:33:27.786437][[32mTEST[0m][[33mSTDOUT[0m]Test results: Error 0, Executed 9, Failed 1, Passed 8, Requested 9, Skipped 0 2026-07-28 09:33:27 matter-build-coverage __main__[104954] ERROR Test script exited with returncode 1 2026-07-28 09:33:27 matter-build-coverage __main__[104954] INFO Stopping app restart monitor thread 2026-07-28 09:33:27 matter-build-coverage __main__[104954] INFO Stopping app with SIGTERM [2026-07-28 09:33:27.974740][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.974] [104956:104956] [ZCL] Emitting ShutDown event[0m [2026-07-28 09:33:27.974856][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.974] [104956:104956] [EVL] LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x1 Epoch timestamp: 0x0000019FA8126E26[0m [2026-07-28 09:33:27.974902][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.974] [104956:104956] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:33:27.974949][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.974] [104956:104956] [IN] SecureSession[0x5eb38a92b250]: Released - Type:2 LSID:55629[0m [2026-07-28 09:33:27.975201][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.975] [104956:104956] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet[0m [2026-07-28 09:33:27.975245][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [IM] Shutting down data model provider 0x5eb37d8c3020[0m [2026-07-28 09:33:27.975286][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [DMG] AccessControlCluster: shutdown[0m [2026-07-28 09:33:27.975328][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [ZCL] Shuting down on/off server cluster on endpoint 1[0m [2026-07-28 09:33:27.975373][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [ZCL] Shuting down level control server cluster on endpoint 1[0m [2026-07-28 09:33:27.975418][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [ZCL] Shuting down color control server cluster on endpoint 1[0m [2026-07-28 09:33:27.975460][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [DMG] CodegenDataModelProvider::Shutdown() complete[0m [2026-07-28 09:33:27.975508][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.975] [104956:104956] [IN] SecureSession[0x5eb38a92ae20]: MarkForEviction Type:1 LSID:55628[0m [2026-07-28 09:33:27.975566][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [SC] SecureSession[0x5eb38a92ae20, LSID:55628]: State change 'kActive' --> 'kPendingEviction'[0m [2026-07-28 09:33:27.975598][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [FS] Fail-safe timer expired[0m [2026-07-28 09:33:27.975644][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.975] [104956:104956] [IN] SecureSession[0x5eb38a92ae20]: Released - Type:1 LSID:55628[0m [2026-07-28 09:33:27.975695][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [DMG] AccessControl: finishing[0m [2026-07-28 09:33:27.975745][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.975] [104956:104956] [DMG] Examples::AccessControlDelegate::Finish[0m [2026-07-28 09:33:27.977485][[32mAPP [0m][[33mSTDOUT[0m][0;34m[1785231207.977] [104956:104956] [DL] Wrote settings to /tmp/chip_counters.ini[0m [2026-07-28 09:33:27.977550][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.977] [104956:104956] [DL] NVS set: chip-counters/total-operational-hours = 0 (0x0)[0m [2026-07-28 09:33:27.977582][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.977] [104956:104956] [DL] Inet Layer shutdown[0m [2026-07-28 09:33:27.977615][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.977] [104956:104956] [DL] WiFi-PAF Layer shutdown[0m [2026-07-28 09:33:27.977647][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.977] [104956:104956] [DL] System Layer shutdown[0m [2026-07-28 09:33:27.978224][[32mAPP [0m][[33mSTDOUT[0m][0;32m[1785231207.978] [104956:104956] [BDX] Stop polling for messages[0m 2026-07-28 09:33:27 matter-build-coverage __main__[104954] ERROR SUBPROCESS failure: 2026-07-28 09:33:27 matter-build-coverage __main__[104954] ERROR TEST SCRIPT: 1 (['/usr/bin/env', 'python3', '-X', 'faulthandler', 'src/python_testing/TC_DeviceBasicComposition.py', '--fail-on-skipped', '--paa-trust-store-path', '/tmp/connectedhomeip/credentials/development/paa-root-certs', '--qr-code', 'MT:-24J0AFN00KA0648G00', '--bool-arg', 'ignore_in_progress_test_event_only_disallowed_for_certification:True', 'allow_provisional_test_event_only_disallowed_for_certification:True', '--restart-flag-file', '/tmp/chip_test_restart_app_85507d52']) 2026-07-28 09:33:27 matter-build-coverage __main__[104954] ERROR APP: 0 (['./out/linux-x64-light-no-ble/chip-lighting-app', '--trace-to', 'json:log']) 2026-07-28 09:33:27 matter-build-coverage __main__[104954] INFO Cleaning up flag files