0s autopkgtest [17:00:25]: starting date and time: 2024-11-15 17:00:25+0000 0s autopkgtest [17:00:25]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [17:00:25]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.jbf0v9qs/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python-aiohttp,src:yarl --apt-upgrade zwave-js-server-python --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python-aiohttp/3.10.10-2build1 yarl/1.13.1-1build1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-41.secgroup --name adt-plucky-arm64-zwave-js-server-python-20241115-170025-juju-7f2275-prod-proposed-migration-environment-2-106e88ca-ea31-4dbf-8946-05e36e12ca08 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 102s autopkgtest [17:02:07]: testbed dpkg architecture: arm64 103s autopkgtest [17:02:08]: testbed apt version: 2.9.8 103s autopkgtest [17:02:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup 104s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 104s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [94.2 kB] 104s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 104s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 104s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1052 kB] 104s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [172 kB] 104s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [50.3 kB] 104s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [793 kB] 104s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [6404 B] 105s Fetched 2263 kB in 1s (2276 kB/s) 105s Reading package lists... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 109s Calculating upgrade... 110s The following packages will be upgraded: 110s python3-markupsafe 110s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 110s Need to get 13.0 kB of archives. 110s After this operation, 69.6 kB of additional disk space will be used. 110s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-markupsafe arm64 2.1.5-1build3 [13.0 kB] 111s Fetched 13.0 kB in 0s (79.4 kB/s) 111s (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 ... 79957 files and directories currently installed.) 111s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_arm64.deb ... 111s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 111s Setting up python3-markupsafe (2.1.5-1build3) ... 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 113s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 113s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 113s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 113s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 115s Reading package lists... 115s Reading package lists... 115s Building dependency tree... 115s Reading state information... 116s Calculating upgrade... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s Reading package lists... 117s Building dependency tree... 117s Reading state information... 118s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s autopkgtest [17:02:26]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 14:19:41 UTC 2024 121s autopkgtest [17:02:26]: @@@@@@@@@@@@@@@@@@@@ apt-source zwave-js-server-python 123s Get:1 http://ftpmaster.internal/ubuntu plucky/universe zwave-js-server-python 0.58.1-1 (dsc) [2568 B] 123s Get:2 http://ftpmaster.internal/ubuntu plucky/universe zwave-js-server-python 0.58.1-1 (tar) [179 kB] 123s Get:3 http://ftpmaster.internal/ubuntu plucky/universe zwave-js-server-python 0.58.1-1 (diff) [2272 B] 123s gpgv: Signature made Fri Oct 4 15:10:42 2024 UTC 123s gpgv: using RSA key FB8ACFA78C726089C38AD0269605A1098C63B92A 123s gpgv: Can't check signature: No public key 123s dpkg-source: warning: cannot verify inline signature for ./zwave-js-server-python_0.58.1-1.dsc: no acceptable signature found 123s autopkgtest [17:02:28]: testing package zwave-js-server-python version 0.58.1-1 123s autopkgtest [17:02:28]: build not needed 124s autopkgtest [17:02:29]: test run-tests: preparing testbed 125s Reading package lists... 126s Building dependency tree... 126s Reading state information... 126s Starting pkgProblemResolver with broken count: 0 127s Starting 2 pkgProblemResolver with broken count: 0 127s Done 128s The following additional packages will be installed: 128s python3-aiohappyeyeballs python3-aiohttp python3-aiosignal python3-all 128s python3-annotated-types python3-async-generator python3-async-timeout 128s python3-dnspython python3-email-validator python3-frozenlist 128s python3-iniconfig python3-multidict python3-packaging python3-pluggy 128s python3-pydantic python3-pydantic-core python3-pytest python3-pytest-aiohttp 128s python3-pytest-asyncio python3-pytest-timeout python3-yarl 128s python3-zwave-js-server-python 128s Suggested packages: 128s python3-trio python3-aioquic python3-h2 python3-httpx python3-httpcore 128s Recommended packages: 128s libjs-jquery python3-aiodns 128s The following NEW packages will be installed: 128s autopkgtest-satdep python3-aiohappyeyeballs python3-aiohttp 128s python3-aiosignal python3-all python3-annotated-types 128s python3-async-generator python3-async-timeout python3-dnspython 128s python3-email-validator python3-frozenlist python3-iniconfig 128s python3-multidict python3-packaging python3-pluggy python3-pydantic 128s python3-pydantic-core python3-pytest python3-pytest-aiohttp 128s python3-pytest-asyncio python3-pytest-timeout python3-yarl 128s python3-zwave-js-server-python 128s 0 upgraded, 23 newly installed, 0 to remove and 0 not upgraded. 128s Need to get 3244 kB/3245 kB of archives. 128s After this operation, 17.4 MB of additional disk space will be used. 128s Get:1 /tmp/autopkgtest.8WojYH/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [752 B] 128s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-aiohappyeyeballs all 2.4.3-1 [10.5 kB] 128s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-multidict arm64 6.1.0-1 [34.0 kB] 128s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 python3-yarl arm64 1.13.1-1build1 [110 kB] 128s Get:5 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-async-timeout all 4.0.3-1 [6412 B] 128s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-frozenlist arm64 1.5.0-1 [46.8 kB] 129s Get:7 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-aiosignal all 1.3.1-1 [5172 B] 129s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 python3-aiohttp arm64 3.10.10-2build1 [334 kB] 129s Get:9 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-all arm64 3.12.6-0ubuntu1 [886 B] 129s Get:10 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-annotated-types all 0.7.0-1 [19.4 kB] 129s Get:11 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-async-generator all 1.10-4 [17.5 kB] 129s Get:12 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 129s Get:13 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-email-validator all 2.2.0-1 [28.5 kB] 129s Get:14 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-iniconfig all 1.1.1-2 [6024 B] 129s Get:15 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-packaging all 24.1-1 [41.4 kB] 129s Get:16 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pluggy all 1.5.0-1 [21.0 kB] 129s Get:17 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pydantic-core arm64 2.23.4-2build1 [1753 kB] 129s Get:18 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pydantic arm64 2.9.1-1 [290 kB] 129s Get:19 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest all 8.3.3-1 [251 kB] 129s Get:20 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest-asyncio all 0.20.3-1.3 [10.7 kB] 129s Get:21 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest-aiohttp all 1.0.5-1 [4974 B] 129s Get:22 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest-timeout all 2.3.1-1 [22.1 kB] 129s Get:23 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-zwave-js-server-python all 0.58.1-1 [67.2 kB] 129s Fetched 3244 kB in 1s (4537 kB/s) 129s Selecting previously unselected package python3-aiohappyeyeballs. 129s (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 ... 79958 files and directories currently installed.) 129s Preparing to unpack .../00-python3-aiohappyeyeballs_2.4.3-1_all.deb ... 129s Unpacking python3-aiohappyeyeballs (2.4.3-1) ... 129s Selecting previously unselected package python3-multidict. 130s Preparing to unpack .../01-python3-multidict_6.1.0-1_arm64.deb ... 130s Unpacking python3-multidict (6.1.0-1) ... 130s Selecting previously unselected package python3-yarl. 130s Preparing to unpack .../02-python3-yarl_1.13.1-1build1_arm64.deb ... 130s Unpacking python3-yarl (1.13.1-1build1) ... 130s Selecting previously unselected package python3-async-timeout. 130s Preparing to unpack .../03-python3-async-timeout_4.0.3-1_all.deb ... 130s Unpacking python3-async-timeout (4.0.3-1) ... 130s Selecting previously unselected package python3-frozenlist. 130s Preparing to unpack .../04-python3-frozenlist_1.5.0-1_arm64.deb ... 130s Unpacking python3-frozenlist (1.5.0-1) ... 130s Selecting previously unselected package python3-aiosignal. 130s Preparing to unpack .../05-python3-aiosignal_1.3.1-1_all.deb ... 130s Unpacking python3-aiosignal (1.3.1-1) ... 130s Selecting previously unselected package python3-aiohttp. 130s Preparing to unpack .../06-python3-aiohttp_3.10.10-2build1_arm64.deb ... 130s Unpacking python3-aiohttp (3.10.10-2build1) ... 130s Selecting previously unselected package python3-all. 130s Preparing to unpack .../07-python3-all_3.12.6-0ubuntu1_arm64.deb ... 130s Unpacking python3-all (3.12.6-0ubuntu1) ... 130s Selecting previously unselected package python3-annotated-types. 130s Preparing to unpack .../08-python3-annotated-types_0.7.0-1_all.deb ... 130s Unpacking python3-annotated-types (0.7.0-1) ... 130s Selecting previously unselected package python3-async-generator. 130s Preparing to unpack .../09-python3-async-generator_1.10-4_all.deb ... 130s Unpacking python3-async-generator (1.10-4) ... 130s Selecting previously unselected package python3-dnspython. 130s Preparing to unpack .../10-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 130s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 130s Selecting previously unselected package python3-email-validator. 130s Preparing to unpack .../11-python3-email-validator_2.2.0-1_all.deb ... 130s Unpacking python3-email-validator (2.2.0-1) ... 130s Selecting previously unselected package python3-iniconfig. 130s Preparing to unpack .../12-python3-iniconfig_1.1.1-2_all.deb ... 130s Unpacking python3-iniconfig (1.1.1-2) ... 130s Selecting previously unselected package python3-packaging. 130s Preparing to unpack .../13-python3-packaging_24.1-1_all.deb ... 130s Unpacking python3-packaging (24.1-1) ... 130s Selecting previously unselected package python3-pluggy. 130s Preparing to unpack .../14-python3-pluggy_1.5.0-1_all.deb ... 130s Unpacking python3-pluggy (1.5.0-1) ... 130s Selecting previously unselected package python3-pydantic-core. 130s Preparing to unpack .../15-python3-pydantic-core_2.23.4-2build1_arm64.deb ... 130s Unpacking python3-pydantic-core (2.23.4-2build1) ... 131s Selecting previously unselected package python3-pydantic. 131s Preparing to unpack .../16-python3-pydantic_2.9.1-1_arm64.deb ... 131s Unpacking python3-pydantic (2.9.1-1) ... 131s Selecting previously unselected package python3-pytest. 131s Preparing to unpack .../17-python3-pytest_8.3.3-1_all.deb ... 131s Unpacking python3-pytest (8.3.3-1) ... 131s Selecting previously unselected package python3-pytest-asyncio. 131s Preparing to unpack .../18-python3-pytest-asyncio_0.20.3-1.3_all.deb ... 131s Unpacking python3-pytest-asyncio (0.20.3-1.3) ... 131s Selecting previously unselected package python3-pytest-aiohttp. 131s Preparing to unpack .../19-python3-pytest-aiohttp_1.0.5-1_all.deb ... 131s Unpacking python3-pytest-aiohttp (1.0.5-1) ... 131s Selecting previously unselected package python3-pytest-timeout. 131s Preparing to unpack .../20-python3-pytest-timeout_2.3.1-1_all.deb ... 131s Unpacking python3-pytest-timeout (2.3.1-1) ... 131s Selecting previously unselected package python3-zwave-js-server-python. 131s Preparing to unpack .../21-python3-zwave-js-server-python_0.58.1-1_all.deb ... 131s Unpacking python3-zwave-js-server-python (0.58.1-1) ... 131s Selecting previously unselected package autopkgtest-satdep. 131s Preparing to unpack .../22-1-autopkgtest-satdep.deb ... 131s Unpacking autopkgtest-satdep (0) ... 131s Setting up python3-iniconfig (1.1.1-2) ... 131s Setting up python3-pydantic-core (2.23.4-2build1) ... 132s Setting up python3-async-generator (1.10-4) ... 132s Setting up python3-all (3.12.6-0ubuntu1) ... 132s Setting up python3-annotated-types (0.7.0-1) ... 132s Setting up python3-multidict (6.1.0-1) ... 132s Setting up python3-frozenlist (1.5.0-1) ... 132s Setting up python3-aiosignal (1.3.1-1) ... 133s Setting up python3-async-timeout (4.0.3-1) ... 133s Setting up python3-packaging (24.1-1) ... 133s Setting up python3-aiohappyeyeballs (2.4.3-1) ... 133s Setting up python3-pluggy (1.5.0-1) ... 133s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 134s Setting up python3-email-validator (2.2.0-1) ... 134s Setting up python3-yarl (1.13.1-1build1) ... 134s Setting up python3-pytest (8.3.3-1) ... 135s Setting up python3-aiohttp (3.10.10-2build1) ... 135s Setting up python3-pydantic (2.9.1-1) ... 136s Setting up python3-pytest-asyncio (0.20.3-1.3) ... 136s Setting up python3-zwave-js-server-python (0.58.1-1) ... 136s Setting up python3-pytest-aiohttp (1.0.5-1) ... 136s Setting up python3-pytest-timeout (2.3.1-1) ... 136s Setting up autopkgtest-satdep (0) ... 136s Processing triggers for man-db (2.13.0-1) ... 142s (Reading database ... 80798 files and directories currently installed.) 142s Removing autopkgtest-satdep (0) ... 143s autopkgtest [17:02:48]: test run-tests: [----------------------- 144s ============================= test session starts ============================== 144s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 -- /usr/bin/python3.12 144s cachedir: .pytest_cache 144s rootdir: /tmp/autopkgtest.8WojYH/autopkgtest_tmp 144s plugins: typeguard-4.4.1, timeout-2.3.1, aiohttp-1.0.5, asyncio-0.20.3 144s asyncio: mode=Mode.AUTO 146s collecting ... collected 271 items 146s 146s test/const/command_class/test_multilevel_sensor.py::test_multilevel_sensor_constants PASSED [ 0%] 146s test/model/test_controller.py::test_from_state PASSED [ 0%] 146s test/model/test_controller.py::test_controller_mods PASSED [ 1%] 146s test/model/test_controller.py::test_controller_status PASSED [ 1%] 146s test/model/test_controller.py::test_begin_inclusion PASSED [ 1%] 146s test/model/test_controller.py::test_begin_inclusion_default PASSED [ 2%] 146s test/model/test_controller.py::test_begin_inclusion_default_force_security PASSED [ 2%] 146s test/model/test_controller.py::test_begin_inclusion_s2_no_input PASSED [ 2%] 146s test/model/test_controller.py::test_begin_inclusion_s2_qr_code_string PASSED [ 3%] 146s test/model/test_controller.py::test_begin_inclusion_s2_provisioning_entry PASSED [ 3%] 146s test/model/test_controller.py::test_begin_inclusion_s2_qr_info PASSED [ 4%] 146s test/model/test_controller.py::test_begin_inclusion_s2_dsk PASSED [ 4%] 146s test/model/test_controller.py::test_begin_inclusion_errors PASSED [ 4%] 146s test/model/test_controller.py::test_provision_smart_start_node_qr_code_string PASSED [ 5%] 146s test/model/test_controller.py::test_provision_smart_start_node_provisioning_entry PASSED [ 5%] 146s test/model/test_controller.py::test_provision_smart_start_node_qr_info PASSED [ 5%] 146s test/model/test_controller.py::test_unprovision_smart_start_node PASSED [ 6%] 146s test/model/test_controller.py::test_get_provisioning_entry PASSED [ 6%] 146s test/model/test_controller.py::test_get_provisioning_entry_undefined PASSED [ 7%] 146s test/model/test_controller.py::test_get_provisioning_entries PASSED [ 7%] 146s test/model/test_controller.py::test_stop_inclusion PASSED [ 7%] 146s test/model/test_controller.py::test_begin_exclusion PASSED [ 8%] 146s test/model/test_controller.py::test_begin_exclusion_unprovision PASSED [ 8%] 146s test/model/test_controller.py::test_stop_exclusion PASSED [ 8%] 146s test/model/test_controller.py::test_hash PASSED [ 9%] 146s test/model/test_controller.py::test_remove_failed_node PASSED [ 9%] 146s test/model/test_controller.py::test_replace_failed_node PASSED [ 9%] 146s test/model/test_controller.py::test_replace_failed_node_default PASSED [ 10%] 146s test/model/test_controller.py::test_replace_failed_node_default_force_security PASSED [ 10%] 146s test/model/test_controller.py::test_replace_failed_node_s2_no_input PASSED [ 11%] 146s test/model/test_controller.py::test_replace_failed_node_s2_qr_code_string PASSED [ 11%] 146s test/model/test_controller.py::test_replace_failed_node_s2_provisioning_entry PASSED [ 11%] 146s test/model/test_controller.py::test_replace_failed_node_s2_qr_info PASSED [ 12%] 147s test/model/test_controller.py::test_replace_failed_node_errors PASSED [ 12%] 147s test/model/test_controller.py::test_rebuild_node_routes PASSED [ 12%] 147s test/model/test_controller.py::test_begin_rebuilding_routes PASSED [ 13%] 147s test/model/test_controller.py::test_stop_rebuilding_routes PASSED [ 13%] 147s test/model/test_controller.py::test_is_failed_node PASSED [ 14%] 147s test/model/test_controller.py::test_get_association_groups PASSED [ 14%] 147s test/model/test_controller.py::test_get_associations PASSED [ 14%] 147s test/model/test_controller.py::test_assoc_addr_model PASSED [ 15%] 147s test/model/test_controller.py::test_check_association PASSED [ 15%] 147s test/model/test_controller.py::test_add_associations PASSED [ 15%] 147s test/model/test_controller.py::test_remove_associations PASSED [ 16%] 147s test/model/test_controller.py::test_remove_node_from_all_associations PASSED [ 16%] 147s test/model/test_controller.py::test_get_node_neighbors PASSED [ 16%] 147s test/model/test_controller.py::test_rebuild_routes_active PASSED [ 17%] 147s test/model/test_controller.py::test_statistics_updated PASSED [ 17%] 147s test/model/test_controller.py::test_grant_security_classes PASSED [ 18%] 147s test/model/test_controller.py::test_validate_dsk_and_enter_pin PASSED [ 18%] 147s test/model/test_controller.py::test_supports_feature PASSED [ 18%] 147s test/model/test_controller.py::test_get_state PASSED [ 19%] 147s test/model/test_controller.py::test_backup_nvm_raw PASSED [ 19%] 147s test/model/test_controller.py::test_restore_nvm PASSED [ 19%] 147s test/model/test_controller.py::test_set_power_level PASSED [ 20%] 147s test/model/test_controller.py::test_get_power_level PASSED [ 20%] 147s test/model/test_controller.py::test_set_rf_region PASSED [ 21%] 147s test/model/test_controller.py::test_get_rf_region PASSED [ 21%] 147s test/model/test_controller.py::test_get_known_lifeline_routes PASSED [ 21%] 147s test/model/test_controller.py::test_get_known_lifeline_routes_bad_protocol_data_rates PASSED [ 22%] 147s test/model/test_controller.py::test_is_any_ota_firmware_update_in_progress PASSED [ 22%] 147s test/model/test_controller.py::test_get_available_firmware_updates PASSED [ 22%] 147s test/model/test_controller.py::test_begin_ota_firmware_update PASSED [ 23%] 147s test/model/test_controller.py::test_get_known_lifeline_routes_rssi_error PASSED [ 23%] 147s test/model/test_controller.py::test_is_firmware_update_in_progress PASSED [ 23%] 147s test/model/test_controller.py::test_nvm_events PASSED [ 24%] 147s test/model/test_controller.py::test_node_found PASSED [ 24%] 147s test/model/test_controller.py::test_node_added PASSED [ 25%] 147s test/model/test_controller.py::test_node_removed PASSED [ 25%] 147s test/model/test_controller.py::test_inclusion_aborted PASSED [ 25%] 147s test/model/test_controller.py::test_firmware_events PASSED [ 26%] 147s test/model/test_controller.py::test_unknown_event PASSED [ 26%] 147s test/model/test_controller.py::test_additional_events PASSED [ 26%] 147s test/model/test_controller.py::test_identify PASSED [ 27%] 147s test/model/test_driver.py::test_from_state PASSED [ 27%] 147s test/model/test_driver.py::test_update_log_config PASSED [ 28%] 147s test/model/test_driver.py::test_get_log_config PASSED [ 28%] 147s test/model/test_driver.py::test_listening_logs PASSED [ 28%] 148s test/model/test_driver.py::test_statistics PASSED [ 29%] 148s test/model/test_driver.py::test_log_config_updated PASSED [ 29%] 148s test/model/test_driver.py::test_check_for_config_updates PASSED [ 29%] 148s test/model/test_driver.py::test_install_config_update PASSED [ 30%] 148s test/model/test_driver.py::test_set_preferred_scales PASSED [ 30%] 148s test/model/test_driver.py::test_hard_reset PASSED [ 30%] 148s test/model/test_driver.py::test_try_soft_reset PASSED [ 31%] 148s test/model/test_driver.py::test_soft_reset PASSED [ 31%] 148s test/model/test_driver.py::test_shutdown PASSED [ 32%] 148s test/model/test_driver.py::test_unknown_event PASSED [ 32%] 148s test/model/test_driver.py::test_all_nodes_ready_event PASSED [ 32%] 148s test/model/test_node.py::test_firmware PASSED [ 33%] 148s test/model/test_node.py::test_from_state PASSED [ 33%] 148s test/model/test_node.py::test_last_seen PASSED [ 33%] 148s test/model/test_node.py::test_highest_security_value PASSED [ 34%] 148s test/model/test_node.py::test_command_classes PASSED [ 34%] 148s test/model/test_node.py::test_device_config PASSED [ 35%] 148s test/model/test_node.py::test_protocol PASSED [ 35%] 148s test/model/test_node.py::test_endpoint_no_device_class PASSED [ 35%] 148s test/model/test_node.py::test_unknown_values PASSED [ 36%] 148s test/model/test_node.py::test_device_database_url PASSED [ 36%] 148s test/model/test_node.py::test_values_without_property_key_name PASSED [ 36%] 148s test/model/test_node.py::test_hash PASSED [ 37%] 148s test/model/test_node.py::test_command_class_values PASSED [ 37%] 148s test/model/test_node.py::test_set_value PASSED [ 38%] 148s test/model/test_node.py::test_set_value_node_status_change PASSED [ 38%] 148s test/model/test_node.py::test_poll_value PASSED [ 38%] 148s test/model/test_node.py::test_ping PASSED [ 39%] 148s test/model/test_node.py::test_refresh_info PASSED [ 39%] 148s test/model/test_node.py::test_value_added_event PASSED [ 39%] 148s test/model/test_node.py::test_get_defined_value_ids PASSED [ 40%] 148s test/model/test_node.py::test_get_value_metadata PASSED [ 40%] 148s test/model/test_node.py::test_abort_firmware_update PASSED [ 40%] 148s test/model/test_node.py::test_node_inclusion PASSED [ 41%] 148s test/model/test_node.py::test_node_ready_event PASSED [ 41%] 148s test/model/test_node.py::test_node_status_events PASSED [ 42%] 148s test/model/test_node.py::test_value_added_events PASSED [ 42%] 148s test/model/test_node.py::test_value_updated_events PASSED [ 42%] 148s test/model/test_node.py::test_value_removed_events PASSED [ 43%] 148s test/model/test_node.py::test_value_notification PASSED [ 43%] 148s test/model/test_node.py::test_metadata_updated PASSED [ 43%] 148s test/model/test_node.py::test_notification PASSED [ 44%] 148s test/model/test_node.py::test_notification_unknown PASSED [ 44%] 148s test/model/test_node.py::test_entry_control_notification PASSED [ 45%] 148s test/model/test_node.py::test_interview_events PASSED [ 45%] 148s test/model/test_node.py::test_refresh_values PASSED [ 45%] 148s test/model/test_node.py::test_firmware_events PASSED [ 46%] 148s test/model/test_node.py::test_value_added_value_exists PASSED [ 46%] 148s test/model/test_node.py::test_value_added_new_value PASSED [ 46%] 148s test/model/test_node.py::test_invoke_cc_api PASSED [ 47%] 149s test/model/test_node.py::test_supports_cc_api PASSED [ 47%] 149s test/model/test_node.py::test_supports_cc PASSED [ 47%] 149s test/model/test_node.py::test_controls_cc PASSED [ 48%] 149s test/model/test_node.py::test_is_cc_secure PASSED [ 48%] 149s test/model/test_node.py::test_get_cc_version PASSED [ 49%] 149s test/model/test_node.py::test_get_node_unsafe PASSED [ 49%] 149s test/model/test_node.py::test_statistics_updated PASSED [ 49%] 149s test/model/test_node.py::test_statistics_updated_rssi_error PASSED [ 50%] 149s test/model/test_node.py::test_has_security_class PASSED [ 50%] 149s test/model/test_node.py::test_has_security_class_undefined PASSED [ 50%] 149s test/model/test_node.py::test_get_highest_security_class PASSED [ 51%] 149s test/model/test_node.py::test_get_highest_security_class_undefined PASSED [ 51%] 149s test/model/test_node.py::test_test_power_level PASSED [ 52%] 149s test/model/test_node.py::test_test_power_level_progress_event PASSED [ 52%] 149s test/model/test_node.py::test_check_lifeline_health PASSED [ 52%] 149s test/model/test_node.py::test_check_lifeline_health_progress_event PASSED [ 53%] 149s test/model/test_node.py::test_check_route_health PASSED [ 53%] 149s test/model/test_node.py::test_check_route_health_progress_event PASSED [ 53%] 149s test/model/test_node.py::test_get_state PASSED [ 54%] 149s test/model/test_node.py::test_set_name PASSED [ 54%] 149s test/model/test_node.py::test_set_location PASSED [ 54%] 149s test/model/test_node.py::test_set_keep_awake PASSED [ 55%] 149s test/model/test_node.py::test_get_firmware_update_capabilities PASSED [ 55%] 149s test/model/test_node.py::test_get_firmware_update_capabilities_false PASSED [ 56%] 149s test/model/test_node.py::test_get_firmware_update_capabilities_string PASSED [ 56%] 149s test/model/test_node.py::test_get_firmware_update_capabilities_cached PASSED [ 56%] 149s test/model/test_node.py::test_is_firmware_update_in_progress PASSED [ 57%] 149s test/model/test_node.py::test_interview PASSED [ 57%] 149s test/model/test_node.py::test_manually_idle_notification_value PASSED [ 57%] 149s test/model/test_node.py::test_set_date_and_time_no_wait PASSED [ 58%] 149s test/model/test_node.py::test_set_date_and_time PASSED [ 58%] 149s test/model/test_node.py::test_get_date_and_time PASSED [ 59%] 149s test/model/test_node.py::test_get_value_timestamp PASSED [ 59%] 149s test/model/test_node.py::test_is_health_check_in_progress PASSED [ 59%] 149s test/model/test_node.py::test_abort_health_check PASSED [ 60%] 149s test/model/test_node.py::test_unknown_event PASSED [ 60%] 149s test/model/test_node.py::test_default_volume PASSED [ 60%] 149s test/model/test_node.py::test_default_transition_duration PASSED [ 61%] 150s test/model/test_node.py::test_has_device_config_changed PASSED [ 61%] 150s test/model/test_node.py::test_has_device_config_changed_undefined PASSED [ 61%] 150s test/model/test_node.py::test_is_secure_none PASSED [ 62%] 150s test/model/test_node.py::test_set_raw_config_parameter_value PASSED [ 62%] 150s test/model/test_node.py::test_supervision_result PASSED [ 63%] 150s test/model/test_node.py::test_supervision_result_invalid PASSED [ 63%] 150s test/model/test_utils.py::test_parse_qr_code_string PASSED [ 63%] 150s test/model/test_utils.py::test_async_try_parse_dsk_from_qr_code_string PASSED [ 64%] 150s test/model/test_utils.py::test_async_try_parse_dsk_from_qr_code_string_fails PASSED [ 64%] 150s test/model/test_value.py::test_value_size PASSED [ 64%] 150s test/model/test_value.py::test_buffer_dict PASSED [ 65%] 150s test/model/test_value.py::test_unparseable_value PASSED [ 65%] 150s test/model/test_value.py::test_allow_manual_entry PASSED [ 66%] 150s test/model/test_value.py::test_stateful PASSED [ 66%] 150s test/model/test_value.py::test_secret PASSED [ 66%] 150s test/model/test_value.py::test_configuration_value_type PASSED [ 67%] 150s test/model/test_value.py::test_set_value_result_str PASSED [ 67%] 150s test/model/test_value.py::test_configuration_value_metadata PASSED [ 67%] 150s test/test_client.py::test_connect_disconnect PASSED [ 68%] 150s test/test_client.py::test_cannot_connect[ClientError] PASSED [ 68%] 150s test/test_client.py::test_cannot_connect[error1] PASSED [ 69%] 150s test/test_client.py::test_send_command_schema PASSED [ 69%] 150s test/test_client.py::test_min_schema_version PASSED [ 69%] 150s test/test_client.py::test_max_schema_version PASSED [ 70%] 150s test/test_client.py::test_send_json_when_disconnected PASSED [ 70%] 150s test/test_client.py::test_listen PASSED [ 70%] 150s test/test_client.py::test_listen_client_error PASSED [ 71%] 150s test/test_client.py::test_listen_error_message_types[258-ConnectionFailed] PASSED [ 71%] 150s test/test_client.py::test_listen_error_message_types[2-InvalidMessage] PASSED [ 71%] 150s test/test_client.py::test_listen_disconnect_message_types[8] PASSED [ 72%] 150s test/test_client.py::test_listen_disconnect_message_types[257] PASSED [ 72%] 150s test/test_client.py::test_listen_disconnect_message_types[256] PASSED [ 73%] 150s test/test_client.py::test_listen_invalid_message_data PASSED [ 73%] 150s test/test_client.py::test_listen_not_success PASSED [ 73%] 150s test/test_client.py::test_initialize_not_success PASSED [ 74%] 150s test/test_client.py::test_get_log_config_not_success PASSED [ 74%] 150s test/test_client.py::test_listen_without_connect PASSED [ 74%] 150s test/test_client.py::test_listen_event PASSED [ 75%] 150s test/test_client.py::test_listen_unknown_result_type PASSED [ 75%] 150s test/test_client.py::test_command_error_handling PASSED [ 76%] 150s test/test_client.py::test_record_messages PASSED [ 76%] 150s test/test_client.py::test_additional_user_agent_components PASSED [ 76%] 150s test/test_client.py::test_pop_future_none PASSED [ 77%] 150s test/test_client.py::test_log_server PASSED [ 77%] 150s test/test_dump.py::test_dump PASSED [ 77%] 150s test/test_dump.py::test_dump_timeout PASSED [ 78%] 151s test/test_dump.py::test_dump_additional_user_agent_components PASSED [ 78%] 151s test/test_event.py::test_once PASSED [ 78%] 151s test/test_event.py::test_exception_on_emit PASSED [ 79%] 151s test/test_firmware.py::test_update_firmware_guess_format PASSED [ 79%] 151s test/test_firmware.py::test_update_firmware_known_format_and_target PASSED [ 80%] 151s test/test_firmware.py::test_controller_firmware_update_otw_guess_format PASSED [ 80%] 151s test/test_firmware.py::test_controller_firmware_update_otw_known_format_and_target PASSED [ 80%] 151s test/test_main.py::test_server_version PASSED [ 81%] 151s test/test_main.py::test_dump_state[test_result] PASSED [ 81%] 151s test/test_main.py::test_connect PASSED [ 81%] 151s test/test_version.py::test_get_server_version PASSED [ 82%] 151s test/test_version.py::test_missing_server_schema_version PASSED [ 82%] 151s test/util/command_class/test_energy_production.py::test_get_energy_production_parameter PASSED [ 83%] 151s test/util/command_class/test_energy_production.py::test_invalid_get_energy_production_parameter PASSED [ 83%] 151s test/util/command_class/test_energy_production.py::test_get_energy_production_scale_type PASSED [ 83%] 151s test/util/command_class/test_energy_production.py::test_invalid_get_energy_production_scale_type PASSED [ 84%] 151s test/util/command_class/test_meter.py::test_get_meter_type PASSED [ 84%] 151s test/util/command_class/test_meter.py::test_get_invalid_meter_type PASSED [ 84%] 151s test/util/command_class/test_meter.py::test_get_meter_scale_type PASSED [ 85%] 151s test/util/command_class/test_meter.py::test_get_invalid_meter_scale_type PASSED [ 85%] 151s test/util/command_class/test_multilevel_sensor.py::test_get_multilevel_sensor_type PASSED [ 85%] 151s test/util/command_class/test_multilevel_sensor.py::test_get_invalid_multilevel_sensor_type PASSED [ 86%] 151s test/util/command_class/test_multilevel_sensor.py::test_get_multilevel_sensor_scale_type PASSED [ 86%] 151s test/util/command_class/test_multilevel_sensor.py::test_get_invalid_multilevel_sensor_scale_type PASSED [ 87%] 151s test/util/test_lock.py::test_get_code_slots PASSED [ 87%] 151s test/util/test_lock.py::test_get_usercode PASSED [ 87%] 151s test/util/test_lock.py::test_get_usercodes PASSED [ 88%] 151s test/util/test_lock.py::test_set_usercode PASSED [ 88%] 151s test/util/test_lock.py::test_clear_usercode PASSED [ 88%] 151s test/util/test_lock.py::test_get_usercode_from_node PASSED [ 89%] 151s test/util/test_lock.py::test_set_configuration_empty_response PASSED [ 89%] 151s test/util/test_lock.py::test_set_configuration_with_response PASSED [ 90%] 151s test/util/test_lock.py::test_set_configuration_v4 PASSED [ 90%] 151s test/util/test_lock.py::test_set_configuration_timed_lock PASSED [ 90%] 151s test/util/test_multicast.py::test_endpoint_get_cc_version_multicast PASSED [ 91%] 151s test/util/test_multicast.py::test_endpoint_get_cc_version_broadcast PASSED [ 91%] 151s test/util/test_multicast.py::test_endpoint_supports_cc_broadcast PASSED [ 91%] 151s test/util/test_multicast.py::test_endpoint_supports_cc_multicast PASSED [ 92%] 151s test/util/test_multicast.py::test_get_endpoint_count_broadcast PASSED [ 92%] 151s test/util/test_multicast.py::test_get_endpoint_count_multicast PASSED [ 92%] 151s test/util/test_multicast.py::test_set_value_broadcast PASSED [ 93%] 151s test/util/test_multicast.py::test_set_value_multicast PASSED [ 93%] 151s test/util/test_multicast.py::test_set_value_multicast_basic PASSED [ 94%] 151s test/util/test_multicast.py::test_invoke_cc_api_broadcast PASSED [ 94%] 151s test/util/test_multicast.py::test_invoke_cc_api_multicast PASSED [ 94%] 151s test/util/test_multicast.py::test_supports_cc_api_broadcast PASSED [ 95%] 151s test/util/test_multicast.py::test_supports_cc_api_multicast PASSED [ 95%] 151s test/util/test_multicast.py::test_set_value_broadcast_missing_value PASSED [ 95%] 151s test/util/test_node.py::test_configuration_parameter_values[0] PASSED [ 96%] 151s test/util/test_node.py::test_configuration_parameter_values[1] PASSED [ 96%] 151s test/util/test_node.py::test_bulk_set_partial_config_parameters[0] PASSED [ 97%] 151s test/util/test_node.py::test_bulk_set_partial_config_parameters[1] PASSED [ 97%] 152s test/util/test_node.py::test_bulk_set_with_full_and_partial_parameters[0] PASSED [ 97%] 152s test/util/test_node.py::test_bulk_set_with_full_and_partial_parameters[1] PASSED [ 98%] 152s test/util/test_node.py::test_failures[0] PASSED [ 98%] 152s test/util/test_node.py::test_failures[1] PASSED [ 98%] 152s test/util/test_node.py::test_returned_values[0] PASSED [ 99%] 152s test/util/test_node.py::test_returned_values[1] PASSED [ 99%] 152s test/util/test_node.py::test_dump_node_state PASSED [100%] 152s 152s ============================= 271 passed in 7.45s ============================== 152s autopkgtest [17:02:57]: test run-tests: -----------------------] 153s run-tests PASS 153s autopkgtest [17:02:58]: test run-tests: - - - - - - - - - - results - - - - - - - - - - 153s autopkgtest [17:02:58]: @@@@@@@@@@@@@@@@@@@@ summary 153s run-tests PASS 166s virt: nova [W] Skipping flock in bos03-arm64 166s virt: Creating nova instance adt-plucky-arm64-zwave-js-server-python-20241115-170025-juju-7f2275-prod-proposed-migration-environment-2-106e88ca-ea31-4dbf-8946-05e36e12ca08 from image adt/ubuntu-plucky-arm64-server-20241115.img (UUID bf337bb2-b8c9-4fc7-87ba-f6e99408dba6)...