0s autopkgtest [09:12:20]: starting date and time: 2025-05-03 09:12:20+0000 0s autopkgtest [09:12:20]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [09:12:20]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.rcwc0sqs/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pydantic --apt-upgrade zwave-js-server-python --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pydantic/2.10.6-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-arm64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@sto01-arm64-6.secgroup --name adt-questing-arm64-zwave-js-server-python-20250503-091220-juju-7f2275-prod-proposed-migration-environment-21-a6c2c7e5-af87-414b-9a86-3790a2f34742 --image adt/ubuntu-questing-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-21 --net-id=net_prod-autopkgtest-workers-arm64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 107s autopkgtest [09:14:07]: testbed dpkg architecture: arm64 108s autopkgtest [09:14:08]: testbed apt version: 3.0.0 108s autopkgtest [09:14:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup 108s autopkgtest [09:14:08]: testbed release detected to be: None 109s autopkgtest [09:14:09]: updating testbed package index (apt update) 109s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 109s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 109s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 109s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 109s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.6 kB] 109s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [155 kB] 109s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [1664 kB] 109s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 Packages [188 kB] 109s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe arm64 Packages [1340 kB] 109s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse arm64 Packages [14.5 kB] 110s Fetched 3516 kB in 1s (5028 kB/s) 110s Reading package lists... 111s autopkgtest [09:14:11]: upgrading testbed (apt dist-upgrade and autopurge) 111s Reading package lists... 111s Building dependency tree... 111s Reading state information... 112s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 112s Starting 2 pkgProblemResolver with broken count: 0 112s Done 112s Entering ResolveByKeep 113s 113s Calculating upgrade... 113s The following packages will be upgraded: 113s debianutils ed libnftnl11 libnvme1t64 libperl5.40 perl perl-base 113s perl-modules-5.40 python3-lazr.restfulclient 113s 9 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s Need to get 10.4 MB of archives. 113s After this operation, 66.6 kB of additional disk space will be used. 113s Get:1 http://ftpmaster.internal/ubuntu questing/main arm64 debianutils arm64 5.22 [93.1 kB] 113s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libperl5.40 arm64 5.40.1-3 [4780 kB] 113s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 perl arm64 5.40.1-3 [262 kB] 114s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 perl-base arm64 5.40.1-3 [1786 kB] 114s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 perl-modules-5.40 all 5.40.1-3 [3217 kB] 114s Get:6 http://ftpmaster.internal/ubuntu questing/main arm64 ed arm64 1.21.1-1 [56.9 kB] 114s Get:7 http://ftpmaster.internal/ubuntu questing/main arm64 libnftnl11 arm64 1.2.9-1 [68.0 kB] 114s Get:8 http://ftpmaster.internal/ubuntu questing/main arm64 libnvme1t64 arm64 1.13-2 [84.6 kB] 114s Get:9 http://ftpmaster.internal/ubuntu questing/main arm64 python3-lazr.restfulclient all 0.14.6-3 [51.0 kB] 114s Fetched 10.4 MB in 1s (20.7 MB/s) 114s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 85225 files and directories currently installed.) 114s Preparing to unpack .../debianutils_5.22_arm64.deb ... 114s Unpacking debianutils (5.22) over (5.21) ... 114s Setting up debianutils (5.22) ... 114s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 85225 files and directories currently installed.) 114s Preparing to unpack .../libperl5.40_5.40.1-3_arm64.deb ... 114s Unpacking libperl5.40:arm64 (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 115s Preparing to unpack .../perl_5.40.1-3_arm64.deb ... 115s Unpacking perl (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 115s Preparing to unpack .../perl-base_5.40.1-3_arm64.deb ... 115s Unpacking perl-base (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 115s Setting up perl-base (5.40.1-3) ... 115s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 85225 files and directories currently installed.) 115s Preparing to unpack .../perl-modules-5.40_5.40.1-3_all.deb ... 115s Unpacking perl-modules-5.40 (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 115s Preparing to unpack .../archives/ed_1.21.1-1_arm64.deb ... 115s Unpacking ed (1.21.1-1) over (1.21-1) ... 115s Preparing to unpack .../libnftnl11_1.2.9-1_arm64.deb ... 115s Unpacking libnftnl11:arm64 (1.2.9-1) over (1.2.8-1) ... 115s Preparing to unpack .../libnvme1t64_1.13-2_arm64.deb ... 115s Unpacking libnvme1t64 (1.13-2) over (1.11.1-2) ... 115s Preparing to unpack .../python3-lazr.restfulclient_0.14.6-3_all.deb ... 115s Unpacking python3-lazr.restfulclient (0.14.6-3) over (0.14.6-2) ... 115s Setting up libnftnl11:arm64 (1.2.9-1) ... 115s Setting up libnvme1t64 (1.13-2) ... 115s Setting up ed (1.21.1-1) ... 116s Setting up perl-modules-5.40 (5.40.1-3) ... 116s Setting up python3-lazr.restfulclient (0.14.6-3) ... 116s Setting up libperl5.40:arm64 (5.40.1-3) ... 116s Setting up perl (5.40.1-3) ... 116s Processing triggers for libc-bin (2.41-6ubuntu1) ... 116s Processing triggers for man-db (2.13.0-1) ... 117s Processing triggers for install-info (7.1.1-1) ... 117s Reading package lists... 117s Building dependency tree... 117s Reading state information... 118s Starting pkgProblemResolver with broken count: 0 118s Starting 2 pkgProblemResolver with broken count: 0 118s Done 118s Solving dependencies... 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s autopkgtest [09:14:21]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Sun Apr 6 14:37:51 UTC 2025 121s autopkgtest [09:14:21]: @@@@@@@@@@@@@@@@@@@@ apt-source zwave-js-server-python 122s Get:1 http://ftpmaster.internal/ubuntu questing/universe zwave-js-server-python 0.62.0-1 (dsc) [2569 B] 122s Get:2 http://ftpmaster.internal/ubuntu questing/universe zwave-js-server-python 0.62.0-1 (tar) [181 kB] 122s Get:3 http://ftpmaster.internal/ubuntu questing/universe zwave-js-server-python 0.62.0-1 (diff) [2296 B] 122s gpgv: Signature made Fri Mar 21 05:38:43 2025 UTC 122s gpgv: using RSA key FB8ACFA78C726089C38AD0269605A1098C63B92A 122s gpgv: Can't check signature: No public key 122s dpkg-source: warning: cannot verify inline signature for ./zwave-js-server-python_0.62.0-1.dsc: no acceptable signature found 122s autopkgtest [09:14:22]: testing package zwave-js-server-python version 0.62.0-1 122s autopkgtest [09:14:22]: build not needed 122s autopkgtest [09:14:22]: test run-tests: preparing testbed 123s Reading package lists... 123s Building dependency tree... 123s Reading state information... 123s Starting pkgProblemResolver with broken count: 0 123s Starting 2 pkgProblemResolver with broken count: 0 123s Done 124s The following NEW packages will be installed: 124s python3-aiohappyeyeballs python3-aiohttp python3-aiosignal python3-all 124s python3-annotated-types python3-async-generator python3-async-timeout 124s python3-dnspython python3-email-validator python3-frozenlist 124s python3-iniconfig python3-multidict python3-pluggy python3-pydantic 124s python3-pydantic-core python3-pytest python3-pytest-aiohttp 124s python3-pytest-asyncio python3-pytest-timeout python3-yarl 124s python3-zwave-js-server-python 124s 0 upgraded, 21 newly installed, 0 to remove and 0 not upgraded. 124s Need to get 2896 kB of archives. 124s After this operation, 12.1 MB of additional disk space will be used. 124s Get:1 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-aiohappyeyeballs all 2.6.1-1 [11.1 kB] 124s Get:2 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-multidict arm64 6.2.0-2 [35.4 kB] 124s Get:3 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-yarl arm64 1.13.1-1build2 [93.8 kB] 124s Get:4 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-async-timeout all 5.0.1-1 [6830 B] 124s Get:5 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-frozenlist arm64 1.5.0-1build2 [48.2 kB] 124s Get:6 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-aiosignal all 1.3.2-1 [5182 B] 124s Get:7 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-aiohttp arm64 3.10.11-1build1 [298 kB] 124s Get:8 http://ftpmaster.internal/ubuntu questing/main arm64 python3-all arm64 3.13.3-1 [880 B] 124s Get:9 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-annotated-types all 0.7.0-1 [19.4 kB] 124s Get:10 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-async-generator all 1.10-4 [17.5 kB] 124s Get:11 http://ftpmaster.internal/ubuntu questing/main arm64 python3-dnspython all 2.7.0-1ubuntu1 [167 kB] 124s Get:12 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-email-validator all 2.2.0-1 [28.5 kB] 124s Get:13 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-iniconfig all 1.1.1-2 [6024 B] 124s Get:14 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-pluggy all 1.5.0-1 [21.0 kB] 124s Get:15 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-pydantic-core arm64 2.27.2-1build1 [1489 kB] 124s Get:16 http://ftpmaster.internal/ubuntu questing-proposed/universe arm64 python3-pydantic arm64 2.10.6-2 [288 kB] 124s Get:17 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-pytest all 8.3.5-1 [252 kB] 124s Get:18 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-pytest-asyncio all 0.25.1-1 [17.0 kB] 124s Get:19 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-pytest-aiohttp all 1.0.5-1 [4974 B] 124s Get:20 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-pytest-timeout all 2.3.1-1 [22.1 kB] 124s Get:21 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-zwave-js-server-python all 0.62.0-1 [64.6 kB] 125s Fetched 2896 kB in 0s (11.1 MB/s) 125s Selecting previously unselected package python3-aiohappyeyeballs. 125s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 85225 files and directories currently installed.) 125s Preparing to unpack .../00-python3-aiohappyeyeballs_2.6.1-1_all.deb ... 125s Unpacking python3-aiohappyeyeballs (2.6.1-1) ... 125s Selecting previously unselected package python3-multidict. 125s Preparing to unpack .../01-python3-multidict_6.2.0-2_arm64.deb ... 125s Unpacking python3-multidict (6.2.0-2) ... 125s Selecting previously unselected package python3-yarl. 125s Preparing to unpack .../02-python3-yarl_1.13.1-1build2_arm64.deb ... 125s Unpacking python3-yarl (1.13.1-1build2) ... 125s Selecting previously unselected package python3-async-timeout. 125s Preparing to unpack .../03-python3-async-timeout_5.0.1-1_all.deb ... 125s Unpacking python3-async-timeout (5.0.1-1) ... 125s Selecting previously unselected package python3-frozenlist. 125s Preparing to unpack .../04-python3-frozenlist_1.5.0-1build2_arm64.deb ... 125s Unpacking python3-frozenlist (1.5.0-1build2) ... 125s Selecting previously unselected package python3-aiosignal. 125s Preparing to unpack .../05-python3-aiosignal_1.3.2-1_all.deb ... 125s Unpacking python3-aiosignal (1.3.2-1) ... 125s Selecting previously unselected package python3-aiohttp. 125s Preparing to unpack .../06-python3-aiohttp_3.10.11-1build1_arm64.deb ... 125s Unpacking python3-aiohttp (3.10.11-1build1) ... 125s Selecting previously unselected package python3-all. 125s Preparing to unpack .../07-python3-all_3.13.3-1_arm64.deb ... 125s Unpacking python3-all (3.13.3-1) ... 125s Selecting previously unselected package python3-annotated-types. 125s Preparing to unpack .../08-python3-annotated-types_0.7.0-1_all.deb ... 125s Unpacking python3-annotated-types (0.7.0-1) ... 125s Selecting previously unselected package python3-async-generator. 125s Preparing to unpack .../09-python3-async-generator_1.10-4_all.deb ... 125s Unpacking python3-async-generator (1.10-4) ... 125s Selecting previously unselected package python3-dnspython. 125s Preparing to unpack .../10-python3-dnspython_2.7.0-1ubuntu1_all.deb ... 125s Unpacking python3-dnspython (2.7.0-1ubuntu1) ... 125s Selecting previously unselected package python3-email-validator. 125s Preparing to unpack .../11-python3-email-validator_2.2.0-1_all.deb ... 125s Unpacking python3-email-validator (2.2.0-1) ... 125s Selecting previously unselected package python3-iniconfig. 125s Preparing to unpack .../12-python3-iniconfig_1.1.1-2_all.deb ... 125s Unpacking python3-iniconfig (1.1.1-2) ... 125s Selecting previously unselected package python3-pluggy. 125s Preparing to unpack .../13-python3-pluggy_1.5.0-1_all.deb ... 125s Unpacking python3-pluggy (1.5.0-1) ... 125s Selecting previously unselected package python3-pydantic-core. 125s Preparing to unpack .../14-python3-pydantic-core_2.27.2-1build1_arm64.deb ... 125s Unpacking python3-pydantic-core (2.27.2-1build1) ... 125s Selecting previously unselected package python3-pydantic. 125s Preparing to unpack .../15-python3-pydantic_2.10.6-2_arm64.deb ... 125s Unpacking python3-pydantic (2.10.6-2) ... 125s Selecting previously unselected package python3-pytest. 125s Preparing to unpack .../16-python3-pytest_8.3.5-1_all.deb ... 125s Unpacking python3-pytest (8.3.5-1) ... 125s Selecting previously unselected package python3-pytest-asyncio. 125s Preparing to unpack .../17-python3-pytest-asyncio_0.25.1-1_all.deb ... 125s Unpacking python3-pytest-asyncio (0.25.1-1) ... 125s Selecting previously unselected package python3-pytest-aiohttp. 125s Preparing to unpack .../18-python3-pytest-aiohttp_1.0.5-1_all.deb ... 125s Unpacking python3-pytest-aiohttp (1.0.5-1) ... 125s Selecting previously unselected package python3-pytest-timeout. 125s Preparing to unpack .../19-python3-pytest-timeout_2.3.1-1_all.deb ... 125s Unpacking python3-pytest-timeout (2.3.1-1) ... 125s Selecting previously unselected package python3-zwave-js-server-python. 125s Preparing to unpack .../20-python3-zwave-js-server-python_0.62.0-1_all.deb ... 125s Unpacking python3-zwave-js-server-python (0.62.0-1) ... 125s Setting up python3-iniconfig (1.1.1-2) ... 125s Setting up python3-pydantic-core (2.27.2-1build1) ... 125s Setting up python3-async-generator (1.10-4) ... 126s Setting up python3-all (3.13.3-1) ... 126s Setting up python3-annotated-types (0.7.0-1) ... 126s Setting up python3-multidict (6.2.0-2) ... 126s Setting up python3-frozenlist (1.5.0-1build2) ... 126s Setting up python3-aiosignal (1.3.2-1) ... 126s Setting up python3-async-timeout (5.0.1-1) ... 126s Setting up python3-aiohappyeyeballs (2.6.1-1) ... 126s Setting up python3-pluggy (1.5.0-1) ... 126s Setting up python3-dnspython (2.7.0-1ubuntu1) ... 127s Setting up python3-email-validator (2.2.0-1) ... 127s Setting up python3-yarl (1.13.1-1build2) ... 127s Setting up python3-pytest (8.3.5-1) ... 127s Setting up python3-aiohttp (3.10.11-1build1) ... 127s Setting up python3-pydantic (2.10.6-2) ... 128s Setting up python3-pytest-asyncio (0.25.1-1) ... 128s Setting up python3-zwave-js-server-python (0.62.0-1) ... 128s Setting up python3-pytest-aiohttp (1.0.5-1) ... 128s Setting up python3-pytest-timeout (2.3.1-1) ... 128s Processing triggers for man-db (2.13.0-1) ... 129s autopkgtest [09:14:29]: test run-tests: [----------------------- 130s /usr/lib/python3/dist-packages/pytest_asyncio/plugin.py:207: PytestDeprecationWarning: The configuration option "asyncio_default_fixture_loop_scope" is unset. 130s The event loop scope for asynchronous fixtures will default to the fixture caching scope. Future versions of pytest-asyncio will default the loop scope for asynchronous fixtures to function scope. Set the default fixture loop scope explicitly in order to avoid unexpected behavior in the future. Valid fixture loop scopes are: "function", "class", "module", "package", "session" 130s 130s warnings.warn(PytestDeprecationWarning(_DEFAULT_FIXTURE_LOOP_SCOPE_UNSET)) 130s ============================= test session starts ============================== 130s platform linux -- Python 3.13.3, pytest-8.3.5, pluggy-1.5.0 -- /usr/bin/python3.13 130s cachedir: .pytest_cache 130s rootdir: /tmp/autopkgtest.zno2by/autopkgtest_tmp 130s plugins: aiohttp-1.0.5, typeguard-4.4.2, asyncio-0.25.1, timeout-2.3.1 130s asyncio: mode=Mode.AUTO, asyncio_default_fixture_loop_scope=None 131s collecting ... collected 280 items 131s 131s test/const/command_class/test_multilevel_sensor.py::test_multilevel_sensor_constants PASSED [ 0%] 131s test/model/test_config_manager.py::test_lookup_device PASSED [ 0%] 131s test/model/test_controller.py::test_from_state PASSED [ 1%] 131s test/model/test_controller.py::test_controller_mods PASSED [ 1%] 131s test/model/test_controller.py::test_controller_status PASSED [ 1%] 131s test/model/test_controller.py::test_begin_inclusion PASSED [ 2%] 131s test/model/test_controller.py::test_begin_inclusion_default PASSED [ 2%] 131s test/model/test_controller.py::test_begin_inclusion_default_force_security PASSED [ 2%] 131s test/model/test_controller.py::test_begin_inclusion_s2_no_input PASSED [ 3%] 131s test/model/test_controller.py::test_begin_inclusion_s2_qr_code_string PASSED [ 3%] 131s test/model/test_controller.py::test_begin_inclusion_s2_provisioning_entry PASSED [ 3%] 131s test/model/test_controller.py::test_begin_inclusion_s2_qr_info PASSED [ 4%] 131s test/model/test_controller.py::test_begin_inclusion_s2_dsk PASSED [ 4%] 131s test/model/test_controller.py::test_begin_inclusion_errors PASSED [ 5%] 131s test/model/test_controller.py::test_provision_smart_start_node_qr_code_string PASSED [ 5%] 131s test/model/test_controller.py::test_provision_smart_start_node_provisioning_entry PASSED [ 5%] 131s test/model/test_controller.py::test_provision_smart_start_node_qr_info PASSED [ 6%] 131s test/model/test_controller.py::test_unprovision_smart_start_node PASSED [ 6%] 131s test/model/test_controller.py::test_get_provisioning_entry PASSED [ 6%] 131s test/model/test_controller.py::test_get_provisioning_entry_undefined PASSED [ 7%] 131s test/model/test_controller.py::test_get_provisioning_entries PASSED [ 7%] 131s test/model/test_controller.py::test_stop_inclusion PASSED [ 7%] 131s test/model/test_controller.py::test_cancel_secure_bootstrap_s2 PASSED [ 8%] 131s test/model/test_controller.py::test_begin_exclusion PASSED [ 8%] 131s test/model/test_controller.py::test_begin_exclusion_unprovision PASSED [ 8%] 131s test/model/test_controller.py::test_stop_exclusion PASSED [ 9%] 131s test/model/test_controller.py::test_hash PASSED [ 9%] 131s test/model/test_controller.py::test_remove_failed_node PASSED [ 10%] 131s test/model/test_controller.py::test_replace_failed_node PASSED [ 10%] 131s test/model/test_controller.py::test_replace_failed_node_default PASSED [ 10%] 131s test/model/test_controller.py::test_replace_failed_node_default_force_security PASSED [ 11%] 131s test/model/test_controller.py::test_replace_failed_node_s2_no_input PASSED [ 11%] 131s test/model/test_controller.py::test_replace_failed_node_s2_qr_code_string PASSED [ 11%] 131s test/model/test_controller.py::test_replace_failed_node_s2_provisioning_entry PASSED [ 12%] 131s test/model/test_controller.py::test_replace_failed_node_s2_qr_info PASSED [ 12%] 131s test/model/test_controller.py::test_replace_failed_node_errors PASSED [ 12%] 131s test/model/test_controller.py::test_rebuild_node_routes PASSED [ 13%] 131s test/model/test_controller.py::test_begin_rebuilding_routes PASSED [ 13%] 131s test/model/test_controller.py::test_stop_rebuilding_routes PASSED [ 13%] 131s test/model/test_controller.py::test_is_failed_node PASSED [ 14%] 131s test/model/test_controller.py::test_get_association_groups PASSED [ 14%] 131s test/model/test_controller.py::test_get_associations PASSED [ 15%] 131s test/model/test_controller.py::test_assoc_addr_model PASSED [ 15%] 131s test/model/test_controller.py::test_check_association PASSED [ 15%] 131s test/model/test_controller.py::test_add_associations PASSED [ 16%] 131s test/model/test_controller.py::test_remove_associations PASSED [ 16%] 131s test/model/test_controller.py::test_remove_node_from_all_associations PASSED [ 16%] 131s test/model/test_controller.py::test_get_node_neighbors PASSED [ 17%] 131s test/model/test_controller.py::test_rebuild_routes_active PASSED [ 17%] 131s test/model/test_controller.py::test_statistics_updated PASSED [ 17%] 131s test/model/test_controller.py::test_grant_security_classes PASSED [ 18%] 131s test/model/test_controller.py::test_validate_dsk_and_enter_pin PASSED [ 18%] 131s test/model/test_controller.py::test_supports_feature PASSED [ 18%] 131s test/model/test_controller.py::test_get_state PASSED [ 19%] 131s test/model/test_controller.py::test_backup_nvm_raw PASSED [ 19%] 131s test/model/test_controller.py::test_restore_nvm PASSED [ 20%] 131s test/model/test_controller.py::test_backup_nvm_raw_base64 PASSED [ 20%] 131s test/model/test_controller.py::test_restore_nvm_base64 PASSED [ 20%] 131s test/model/test_controller.py::test_set_power_level PASSED [ 21%] 131s test/model/test_controller.py::test_get_power_level PASSED [ 21%] 131s test/model/test_controller.py::test_set_rf_region PASSED [ 21%] 131s test/model/test_controller.py::test_get_rf_region PASSED [ 22%] 132s test/model/test_controller.py::test_get_known_lifeline_routes PASSED [ 22%] 132s test/model/test_controller.py::test_get_known_lifeline_routes_bad_protocol_data_rates PASSED [ 22%] 132s test/model/test_controller.py::test_is_any_ota_firmware_update_in_progress PASSED [ 23%] 132s test/model/test_controller.py::test_get_available_firmware_updates PASSED [ 23%] 132s test/model/test_controller.py::test_begin_ota_firmware_update PASSED [ 23%] 132s test/model/test_controller.py::test_get_known_lifeline_routes_rssi_error PASSED [ 24%] 132s test/model/test_controller.py::test_is_firmware_update_in_progress PASSED [ 24%] 132s test/model/test_controller.py::test_nvm_events PASSED [ 25%] 132s test/model/test_controller.py::test_node_found PASSED [ 25%] 132s test/model/test_controller.py::test_node_added PASSED [ 25%] 132s test/model/test_controller.py::test_node_removed PASSED [ 26%] 132s test/model/test_controller.py::test_inclusion_aborted PASSED [ 26%] 132s test/model/test_controller.py::test_firmware_events PASSED [ 26%] 132s test/model/test_controller.py::test_unknown_event PASSED [ 27%] 132s test/model/test_controller.py::test_additional_events PASSED [ 27%] 132s test/model/test_controller.py::test_identify PASSED [ 27%] 132s test/model/test_controller.py::test_inclusion_state_changed PASSED [ 28%] 132s test/model/test_driver.py::test_from_state PASSED [ 28%] 132s test/model/test_driver.py::test_update_log_config PASSED [ 28%] 132s test/model/test_driver.py::test_get_log_config PASSED [ 29%] 132s test/model/test_driver.py::test_listening_logs PASSED [ 29%] 132s test/model/test_driver.py::test_statistics PASSED [ 30%] 132s test/model/test_driver.py::test_log_config_updated PASSED [ 30%] 132s test/model/test_driver.py::test_check_for_config_updates PASSED [ 30%] 132s test/model/test_driver.py::test_install_config_update PASSED [ 31%] 132s test/model/test_driver.py::test_set_preferred_scales PASSED [ 31%] 132s test/model/test_driver.py::test_hard_reset PASSED [ 31%] 132s test/model/test_driver.py::test_try_soft_reset PASSED [ 32%] 132s test/model/test_driver.py::test_soft_reset PASSED [ 32%] 132s test/model/test_driver.py::test_shutdown PASSED [ 32%] 132s test/model/test_driver.py::test_unknown_event PASSED [ 33%] 132s test/model/test_driver.py::test_all_nodes_ready_event PASSED [ 33%] 132s test/model/test_driver.py::test_config_manager PASSED [ 33%] 132s test/model/test_node.py::test_firmware PASSED [ 34%] 132s test/model/test_node.py::test_from_state PASSED [ 34%] 132s test/model/test_node.py::test_last_seen PASSED [ 35%] 132s test/model/test_node.py::test_highest_security_value PASSED [ 35%] 132s test/model/test_node.py::test_command_classes PASSED [ 35%] 132s test/model/test_node.py::test_device_config PASSED [ 36%] 132s test/model/test_node.py::test_protocol PASSED [ 36%] 132s test/model/test_node.py::test_endpoint_no_device_class PASSED [ 36%] 132s test/model/test_node.py::test_unknown_values PASSED [ 37%] 132s test/model/test_node.py::test_device_database_url PASSED [ 37%] 132s test/model/test_node.py::test_values_without_property_key_name PASSED [ 37%] 132s test/model/test_node.py::test_hash PASSED [ 38%] 132s test/model/test_node.py::test_command_class_values PASSED [ 38%] 132s test/model/test_node.py::test_set_value PASSED [ 38%] 132s test/model/test_node.py::test_set_value_node_status_change PASSED [ 39%] 132s test/model/test_node.py::test_poll_value PASSED [ 39%] 132s test/model/test_node.py::test_ping PASSED [ 40%] 132s test/model/test_node.py::test_refresh_info PASSED [ 40%] 132s test/model/test_node.py::test_value_added_event PASSED [ 40%] 132s test/model/test_node.py::test_get_defined_value_ids PASSED [ 41%] 132s test/model/test_node.py::test_get_value_metadata PASSED [ 41%] 132s test/model/test_node.py::test_abort_firmware_update PASSED [ 41%] 132s test/model/test_node.py::test_node_inclusion PASSED [ 42%] 132s test/model/test_node.py::test_node_ready_event PASSED [ 42%] 132s test/model/test_node.py::test_node_status_events PASSED [ 42%] 132s test/model/test_node.py::test_value_added_events PASSED [ 43%] 132s test/model/test_node.py::test_value_updated_events PASSED [ 43%] 132s test/model/test_node.py::test_value_removed_events PASSED [ 43%] 132s test/model/test_node.py::test_value_notification PASSED [ 44%] 132s test/model/test_node.py::test_metadata_updated PASSED [ 44%] 132s test/model/test_node.py::test_notification PASSED [ 45%] 132s test/model/test_node.py::test_notification_unknown PASSED [ 45%] 132s test/model/test_node.py::test_entry_control_notification PASSED [ 45%] 132s test/model/test_node.py::test_interview_events PASSED [ 46%] 132s test/model/test_node.py::test_refresh_values PASSED [ 46%] 132s test/model/test_node.py::test_firmware_events PASSED [ 46%] 132s test/model/test_node.py::test_value_added_value_exists PASSED [ 47%] 132s test/model/test_node.py::test_value_added_new_value PASSED [ 47%] 132s test/model/test_node.py::test_invoke_cc_api PASSED [ 47%] 132s test/model/test_node.py::test_supports_cc_api PASSED [ 48%] 132s test/model/test_node.py::test_supports_cc PASSED [ 48%] 132s test/model/test_node.py::test_controls_cc PASSED [ 48%] 132s test/model/test_node.py::test_is_cc_secure PASSED [ 49%] 132s test/model/test_node.py::test_get_cc_version PASSED [ 49%] 132s test/model/test_node.py::test_get_node_unsafe PASSED [ 50%] 132s test/model/test_node.py::test_statistics_updated PASSED [ 50%] 132s test/model/test_node.py::test_statistics_updated_rssi_error PASSED [ 50%] 132s test/model/test_node.py::test_has_security_class PASSED [ 51%] 132s test/model/test_node.py::test_has_security_class_undefined PASSED [ 51%] 132s test/model/test_node.py::test_get_highest_security_class PASSED [ 51%] 132s test/model/test_node.py::test_get_highest_security_class_undefined PASSED [ 52%] 132s test/model/test_node.py::test_test_power_level PASSED [ 52%] 132s test/model/test_node.py::test_test_power_level_progress_event PASSED [ 52%] 132s test/model/test_node.py::test_check_lifeline_health PASSED [ 53%] 132s test/model/test_node.py::test_check_lifeline_health_progress_event PASSED [ 53%] 132s test/model/test_node.py::test_check_route_health PASSED [ 53%] 132s test/model/test_node.py::test_check_route_health_progress_event PASSED [ 54%] 132s test/model/test_node.py::test_get_state PASSED [ 54%] 132s test/model/test_node.py::test_set_name PASSED [ 55%] 132s test/model/test_node.py::test_set_location PASSED [ 55%] 133s test/model/test_node.py::test_set_keep_awake PASSED [ 55%] 133s test/model/test_node.py::test_get_firmware_update_capabilities PASSED [ 56%] 133s test/model/test_node.py::test_get_firmware_update_capabilities_false PASSED [ 56%] 133s test/model/test_node.py::test_get_firmware_update_capabilities_string PASSED [ 56%] 133s test/model/test_node.py::test_get_firmware_update_capabilities_cached PASSED [ 57%] 133s test/model/test_node.py::test_is_firmware_update_in_progress PASSED [ 57%] 133s test/model/test_node.py::test_interview PASSED [ 57%] 133s test/model/test_node.py::test_manually_idle_notification_value PASSED [ 58%] 133s test/model/test_node.py::test_set_date_and_time_no_wait PASSED [ 58%] 133s test/model/test_node.py::test_set_date_and_time PASSED [ 58%] 133s test/model/test_node.py::test_get_date_and_time PASSED [ 59%] 133s test/model/test_node.py::test_get_value_timestamp PASSED [ 59%] 133s test/model/test_node.py::test_is_health_check_in_progress PASSED [ 60%] 133s test/model/test_node.py::test_abort_health_check PASSED [ 60%] 133s test/model/test_node.py::test_unknown_event PASSED [ 60%] 133s test/model/test_node.py::test_default_volume PASSED [ 61%] 133s test/model/test_node.py::test_default_transition_duration PASSED [ 61%] 133s test/model/test_node.py::test_has_device_config_changed PASSED [ 61%] 133s test/model/test_node.py::test_has_device_config_changed_undefined PASSED [ 62%] 133s test/model/test_node.py::test_is_secure_none PASSED [ 62%] 133s test/model/test_node.py::test_set_raw_config_parameter_value PASSED [ 62%] 133s test/model/test_node.py::test_get_raw_config_parameter_value PASSED [ 63%] 133s test/model/test_node.py::test_supervision_result PASSED [ 63%] 133s test/model/test_node.py::test_supervision_result_invalid PASSED [ 63%] 133s test/model/test_utils.py::test_parse_qr_code_string PASSED [ 64%] 133s test/model/test_utils.py::test_async_try_parse_dsk_from_qr_code_string PASSED [ 64%] 133s test/model/test_utils.py::test_async_try_parse_dsk_from_qr_code_string_fails PASSED [ 65%] 133s test/model/test_value.py::test_value_size PASSED [ 65%] 133s test/model/test_value.py::test_buffer_dict PASSED [ 65%] 133s test/model/test_value.py::test_unparseable_value PASSED [ 66%] 133s test/model/test_value.py::test_allow_manual_entry PASSED [ 66%] 133s test/model/test_value.py::test_stateful PASSED [ 66%] 133s test/model/test_value.py::test_secret PASSED [ 67%] 133s test/model/test_value.py::test_configuration_value_type PASSED [ 67%] 133s test/model/test_value.py::test_set_value_result_str PASSED [ 67%] 133s test/model/test_value.py::test_configuration_value_metadata PASSED [ 68%] 133s test/test_client.py::test_connect_disconnect PASSED [ 68%] 133s test/test_client.py::test_cannot_connect[ClientError] PASSED [ 68%] 133s test/test_client.py::test_cannot_connect[error1] PASSED [ 69%] 133s test/test_client.py::test_send_command_schema PASSED [ 69%] 133s test/test_client.py::test_min_schema_version PASSED [ 70%] 133s test/test_client.py::test_max_schema_version PASSED [ 70%] 133s test/test_client.py::test_send_json_when_disconnected PASSED [ 70%] 133s test/test_client.py::test_listen PASSED [ 71%] 133s test/test_client.py::test_listen_client_error PASSED [ 71%] 133s test/test_client.py::test_listen_error_message_types[258-ConnectionFailed] PASSED [ 71%] 133s test/test_client.py::test_listen_error_message_types[2-InvalidMessage] PASSED [ 72%] 133s test/test_client.py::test_listen_disconnect_message_types[8] PASSED [ 72%] 133s test/test_client.py::test_listen_disconnect_message_types[257] PASSED [ 72%] 133s test/test_client.py::test_listen_disconnect_message_types[256] PASSED [ 73%] 133s test/test_client.py::test_listen_invalid_message_data PASSED [ 73%] 133s test/test_client.py::test_listen_not_success PASSED [ 73%] 133s test/test_client.py::test_initialize_not_success PASSED [ 74%] 133s test/test_client.py::test_get_log_config_not_success PASSED [ 74%] 133s test/test_client.py::test_listen_without_connect PASSED [ 75%] 133s test/test_client.py::test_listen_event PASSED [ 75%] 133s test/test_client.py::test_listen_unknown_result_type PASSED [ 75%] 133s test/test_client.py::test_command_error_handling PASSED [ 76%] 133s test/test_client.py::test_record_messages PASSED [ 76%] 133s test/test_client.py::test_additional_user_agent_components PASSED [ 76%] 133s test/test_client.py::test_pop_future_none PASSED [ 77%] 133s test/test_client.py::test_log_server PASSED [ 77%] 133s test/test_dump.py::test_dump PASSED [ 77%] 133s test/test_dump.py::test_dump_timeout PASSED [ 78%] 133s test/test_dump.py::test_dump_additional_user_agent_components PASSED [ 78%] 133s test/test_event.py::test_once PASSED [ 78%] 133s test/test_event.py::test_exception_on_emit PASSED [ 79%] 133s test/test_firmware.py::test_update_firmware_guess_format PASSED [ 79%] 133s test/test_firmware.py::test_update_firmware_known_format_and_target PASSED [ 80%] 133s test/test_firmware.py::test_controller_firmware_update_otw_guess_format PASSED [ 80%] 133s test/test_firmware.py::test_controller_firmware_update_otw_known_format_and_target PASSED [ 80%] 133s test/test_main.py::test_server_version PASSED [ 81%] 133s test/test_main.py::test_dump_state[test_result] PASSED [ 81%] 133s test/test_main.py::test_connect PASSED [ 81%] 133s test/test_version.py::test_get_server_version PASSED [ 82%] 133s test/test_version.py::test_missing_server_schema_version PASSED [ 82%] 133s test/util/command_class/test_energy_production.py::test_get_energy_production_parameter PASSED [ 82%] 133s test/util/command_class/test_energy_production.py::test_invalid_get_energy_production_parameter PASSED [ 83%] 133s test/util/command_class/test_energy_production.py::test_get_energy_production_scale_type PASSED [ 83%] 133s test/util/command_class/test_energy_production.py::test_invalid_get_energy_production_scale_type PASSED [ 83%] 133s test/util/command_class/test_meter.py::test_get_meter_type PASSED [ 84%] 133s test/util/command_class/test_meter.py::test_get_invalid_meter_type PASSED [ 84%] 133s test/util/command_class/test_meter.py::test_get_meter_scale_type PASSED [ 85%] 133s test/util/command_class/test_meter.py::test_get_invalid_meter_scale_type PASSED [ 85%] 133s test/util/command_class/test_multilevel_sensor.py::test_get_multilevel_sensor_type PASSED [ 85%] 133s test/util/command_class/test_multilevel_sensor.py::test_get_invalid_multilevel_sensor_type PASSED [ 86%] 133s test/util/command_class/test_multilevel_sensor.py::test_get_multilevel_sensor_scale_type PASSED [ 86%] 133s test/util/command_class/test_multilevel_sensor.py::test_get_invalid_multilevel_sensor_scale_type PASSED [ 86%] 133s test/util/test_lock.py::test_get_code_slots PASSED [ 87%] 133s test/util/test_lock.py::test_get_usercode PASSED [ 87%] 133s test/util/test_lock.py::test_get_usercodes PASSED [ 87%] 133s test/util/test_lock.py::test_set_usercode PASSED [ 88%] 133s test/util/test_lock.py::test_set_usercodes PASSED [ 88%] 133s test/util/test_lock.py::test_set_usercodes_invalid PASSED [ 88%] 133s test/util/test_lock.py::test_clear_usercode PASSED [ 89%] 133s test/util/test_lock.py::test_get_usercode_from_node PASSED [ 89%] 133s test/util/test_lock.py::test_set_configuration_empty_response PASSED [ 90%] 133s test/util/test_lock.py::test_set_configuration_with_response PASSED [ 90%] 133s test/util/test_lock.py::test_set_configuration_v4 PASSED [ 90%] 133s test/util/test_lock.py::test_set_configuration_timed_lock PASSED [ 91%] 133s test/util/test_multicast.py::test_endpoint_get_cc_version_multicast PASSED [ 91%] 133s test/util/test_multicast.py::test_endpoint_get_cc_version_broadcast PASSED [ 91%] 133s test/util/test_multicast.py::test_endpoint_supports_cc_broadcast PASSED [ 92%] 133s test/util/test_multicast.py::test_endpoint_supports_cc_multicast PASSED [ 92%] 133s test/util/test_multicast.py::test_get_endpoint_count_broadcast PASSED [ 92%] 133s test/util/test_multicast.py::test_get_endpoint_count_multicast PASSED [ 93%] 133s test/util/test_multicast.py::test_set_value_broadcast PASSED [ 93%] 134s test/util/test_multicast.py::test_set_value_multicast PASSED [ 93%] 134s test/util/test_multicast.py::test_set_value_multicast_basic PASSED [ 94%] 134s test/util/test_multicast.py::test_invoke_cc_api_broadcast PASSED [ 94%] 134s test/util/test_multicast.py::test_invoke_cc_api_multicast PASSED [ 95%] 134s test/util/test_multicast.py::test_supports_cc_api_broadcast PASSED [ 95%] 134s test/util/test_multicast.py::test_supports_cc_api_multicast PASSED [ 95%] 134s test/util/test_multicast.py::test_set_value_broadcast_missing_value PASSED [ 96%] 134s test/util/test_node.py::test_configuration_parameter_values[0] PASSED [ 96%] 134s test/util/test_node.py::test_configuration_parameter_values[1] PASSED [ 96%] 134s test/util/test_node.py::test_bulk_set_partial_config_parameters[0] PASSED [ 97%] 134s test/util/test_node.py::test_bulk_set_partial_config_parameters[1] PASSED [ 97%] 134s test/util/test_node.py::test_bulk_set_with_full_and_partial_parameters[0] PASSED [ 97%] 134s test/util/test_node.py::test_bulk_set_with_full_and_partial_parameters[1] PASSED [ 98%] 134s test/util/test_node.py::test_failures[0] PASSED [ 98%] 134s test/util/test_node.py::test_failures[1] PASSED [ 98%] 134s test/util/test_node.py::test_returned_values[0] PASSED [ 99%] 134s test/util/test_node.py::test_returned_values[1] PASSED [ 99%] 134s test/util/test_node.py::test_dump_node_state PASSED [100%] 134s 134s ============================= 280 passed in 3.64s ============================== 134s autopkgtest [09:14:34]: test run-tests: -----------------------] 135s autopkgtest [09:14:35]: test run-tests: - - - - - - - - - - results - - - - - - - - - - 135s run-tests PASS 135s autopkgtest [09:14:35]: @@@@@@@@@@@@@@@@@@@@ summary 135s run-tests PASS 138s nova [W] Using flock in prodstack7-arm64 138s flock: timeout while waiting to get lock 138s Creating nova instance adt-questing-arm64-zwave-js-server-python-20250503-091220-juju-7f2275-prod-proposed-migration-environment-21-a6c2c7e5-af87-414b-9a86-3790a2f34742 from image adt/ubuntu-questing-arm64-server-20250502.img (UUID 8e5d326b-32f5-49da-83ce-e406e786e537)... 138s nova [W] Timed out waiting for 8180c97e-4ea8-4190-84bd-2939909c32b0 to get deleted.