0s autopkgtest [17:04:19]: starting date and time: 2024-11-15 17:04:19+0000 0s autopkgtest [17:04:19]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [17:04:19]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.wgb81z4r/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-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-28.secgroup --name adt-plucky-s390x-zwave-js-server-python-20241115-170419-juju-7f2275-prod-proposed-migration-environment-2-fc5112f1-b273-4ba3-b516-c96ab704df49 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -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/ 112s autopkgtest [17:06:11]: testbed dpkg architecture: s390x 112s autopkgtest [17:06:11]: testbed apt version: 2.9.8 112s autopkgtest [17:06:11]: @@@@@@@@@@@@@@@@@@@@ test bed setup 112s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 113s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 113s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 113s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [94.2 kB] 113s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1052 kB] 113s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [153 kB] 113s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [751 kB] 113s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [4940 B] 113s Fetched 2150 kB in 1s (2611 kB/s) 113s Reading package lists... 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s Calculating upgrade... 116s The following packages will be upgraded: 116s python3-markupsafe 116s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 116s Need to get 12.9 kB of archives. 116s After this operation, 16.4 kB of additional disk space will be used. 116s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x python3-markupsafe s390x 2.1.5-1build3 [12.9 kB] 116s Fetched 12.9 kB in 0s (95.0 kB/s) 116s (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 ... 55517 files and directories currently installed.) 116s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_s390x.deb ... 116s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 116s Setting up python3-markupsafe (2.1.5-1build3) ... 117s Reading package lists... 117s Building dependency tree... 117s Reading state information... 117s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 117s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 117s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 117s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 118s Reading package lists... 118s Reading package lists... 118s Building dependency tree... 118s Reading state information... 118s Calculating upgrade... 118s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s autopkgtest [17:06:20]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 122s autopkgtest [17:06:21]: @@@@@@@@@@@@@@@@@@@@ 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:06:22]: testing package zwave-js-server-python version 0.58.1-1 123s autopkgtest [17:06:22]: build not needed 125s autopkgtest [17:06:24]: test run-tests: preparing testbed 126s Reading package lists... 126s Building dependency tree... 126s Reading state information... 126s Starting pkgProblemResolver with broken count: 0 126s Starting 2 pkgProblemResolver with broken count: 0 126s Done 127s The following additional packages will be installed: 127s python3-aiohappyeyeballs python3-aiohttp python3-aiosignal python3-all 127s python3-annotated-types python3-async-generator python3-async-timeout 127s python3-dnspython python3-email-validator python3-frozenlist 127s python3-iniconfig python3-multidict python3-packaging python3-pluggy 127s python3-pydantic python3-pydantic-core python3-pytest python3-pytest-aiohttp 127s python3-pytest-asyncio python3-pytest-timeout python3-yarl 127s python3-zwave-js-server-python 127s Suggested packages: 127s python3-trio python3-aioquic python3-h2 python3-httpx python3-httpcore 127s Recommended packages: 127s libjs-jquery python3-aiodns 127s The following NEW packages will be installed: 127s autopkgtest-satdep python3-aiohappyeyeballs python3-aiohttp 127s python3-aiosignal python3-all python3-annotated-types 127s python3-async-generator python3-async-timeout python3-dnspython 127s python3-email-validator python3-frozenlist python3-iniconfig 127s python3-multidict python3-packaging python3-pluggy python3-pydantic 127s python3-pydantic-core python3-pytest python3-pytest-aiohttp 127s python3-pytest-asyncio python3-pytest-timeout python3-yarl 127s python3-zwave-js-server-python 127s 0 upgraded, 23 newly installed, 0 to remove and 0 not upgraded. 127s Need to get 3893 kB/3893 kB of archives. 127s After this operation, 22.2 MB of additional disk space will be used. 127s Get:1 /tmp/autopkgtest.Vq197r/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [752 B] 127s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-aiohappyeyeballs all 2.4.3-1 [10.5 kB] 127s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-multidict s390x 6.1.0-1 [34.1 kB] 127s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x python3-yarl s390x 1.13.1-1build1 [122 kB] 127s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-async-timeout all 4.0.3-1 [6412 B] 127s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-frozenlist s390x 1.5.0-1 [49.7 kB] 127s Get:7 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-aiosignal all 1.3.1-1 [5172 B] 127s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x python3-aiohttp s390x 3.10.10-2build1 [358 kB] 127s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x python3-all s390x 3.12.6-0ubuntu1 [890 B] 127s Get:10 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-annotated-types all 0.7.0-1 [19.4 kB] 127s Get:11 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-async-generator all 1.10-4 [17.5 kB] 127s Get:12 http://ftpmaster.internal/ubuntu plucky/main s390x python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 127s Get:13 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-email-validator all 2.2.0-1 [28.5 kB] 127s Get:14 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 127s Get:15 http://ftpmaster.internal/ubuntu plucky/main s390x python3-packaging all 24.1-1 [41.4 kB] 127s Get:16 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pluggy all 1.5.0-1 [21.0 kB] 127s Get:17 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pydantic-core s390x 2.23.4-2build1 [2362 kB] 128s Get:18 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pydantic s390x 2.9.1-1 [290 kB] 128s Get:19 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pytest all 8.3.3-1 [251 kB] 128s Get:20 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pytest-asyncio all 0.20.3-1.3 [10.7 kB] 128s Get:21 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pytest-aiohttp all 1.0.5-1 [4974 B] 128s Get:22 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pytest-timeout all 2.3.1-1 [22.1 kB] 128s Get:23 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-zwave-js-server-python all 0.58.1-1 [67.2 kB] 128s Fetched 3893 kB in 2s (2378 kB/s) 128s Selecting previously unselected package python3-aiohappyeyeballs. 128s (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 ... 55518 files and directories currently installed.) 128s Preparing to unpack .../00-python3-aiohappyeyeballs_2.4.3-1_all.deb ... 128s Unpacking python3-aiohappyeyeballs (2.4.3-1) ... 128s Selecting previously unselected package python3-multidict. 128s Preparing to unpack .../01-python3-multidict_6.1.0-1_s390x.deb ... 128s Unpacking python3-multidict (6.1.0-1) ... 128s Selecting previously unselected package python3-yarl. 128s Preparing to unpack .../02-python3-yarl_1.13.1-1build1_s390x.deb ... 128s Unpacking python3-yarl (1.13.1-1build1) ... 128s Selecting previously unselected package python3-async-timeout. 128s Preparing to unpack .../03-python3-async-timeout_4.0.3-1_all.deb ... 128s Unpacking python3-async-timeout (4.0.3-1) ... 128s Selecting previously unselected package python3-frozenlist. 128s Preparing to unpack .../04-python3-frozenlist_1.5.0-1_s390x.deb ... 129s Unpacking python3-frozenlist (1.5.0-1) ... 129s Selecting previously unselected package python3-aiosignal. 129s Preparing to unpack .../05-python3-aiosignal_1.3.1-1_all.deb ... 129s Unpacking python3-aiosignal (1.3.1-1) ... 129s Selecting previously unselected package python3-aiohttp. 129s Preparing to unpack .../06-python3-aiohttp_3.10.10-2build1_s390x.deb ... 129s Unpacking python3-aiohttp (3.10.10-2build1) ... 129s Selecting previously unselected package python3-all. 129s Preparing to unpack .../07-python3-all_3.12.6-0ubuntu1_s390x.deb ... 129s Unpacking python3-all (3.12.6-0ubuntu1) ... 129s Selecting previously unselected package python3-annotated-types. 129s Preparing to unpack .../08-python3-annotated-types_0.7.0-1_all.deb ... 129s Unpacking python3-annotated-types (0.7.0-1) ... 129s Selecting previously unselected package python3-async-generator. 129s Preparing to unpack .../09-python3-async-generator_1.10-4_all.deb ... 129s Unpacking python3-async-generator (1.10-4) ... 129s Selecting previously unselected package python3-dnspython. 129s Preparing to unpack .../10-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 129s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 129s Selecting previously unselected package python3-email-validator. 129s Preparing to unpack .../11-python3-email-validator_2.2.0-1_all.deb ... 129s Unpacking python3-email-validator (2.2.0-1) ... 129s Selecting previously unselected package python3-iniconfig. 129s Preparing to unpack .../12-python3-iniconfig_1.1.1-2_all.deb ... 129s Unpacking python3-iniconfig (1.1.1-2) ... 129s Selecting previously unselected package python3-packaging. 129s Preparing to unpack .../13-python3-packaging_24.1-1_all.deb ... 129s Unpacking python3-packaging (24.1-1) ... 129s Selecting previously unselected package python3-pluggy. 129s Preparing to unpack .../14-python3-pluggy_1.5.0-1_all.deb ... 129s Unpacking python3-pluggy (1.5.0-1) ... 129s Selecting previously unselected package python3-pydantic-core. 129s Preparing to unpack .../15-python3-pydantic-core_2.23.4-2build1_s390x.deb ... 129s Unpacking python3-pydantic-core (2.23.4-2build1) ... 129s Selecting previously unselected package python3-pydantic. 129s Preparing to unpack .../16-python3-pydantic_2.9.1-1_s390x.deb ... 129s Unpacking python3-pydantic (2.9.1-1) ... 129s Selecting previously unselected package python3-pytest. 129s Preparing to unpack .../17-python3-pytest_8.3.3-1_all.deb ... 129s Unpacking python3-pytest (8.3.3-1) ... 129s Selecting previously unselected package python3-pytest-asyncio. 129s Preparing to unpack .../18-python3-pytest-asyncio_0.20.3-1.3_all.deb ... 129s Unpacking python3-pytest-asyncio (0.20.3-1.3) ... 129s Selecting previously unselected package python3-pytest-aiohttp. 129s Preparing to unpack .../19-python3-pytest-aiohttp_1.0.5-1_all.deb ... 129s Unpacking python3-pytest-aiohttp (1.0.5-1) ... 129s Selecting previously unselected package python3-pytest-timeout. 129s Preparing to unpack .../20-python3-pytest-timeout_2.3.1-1_all.deb ... 129s Unpacking python3-pytest-timeout (2.3.1-1) ... 129s Selecting previously unselected package python3-zwave-js-server-python. 129s Preparing to unpack .../21-python3-zwave-js-server-python_0.58.1-1_all.deb ... 129s Unpacking python3-zwave-js-server-python (0.58.1-1) ... 129s Selecting previously unselected package autopkgtest-satdep. 129s Preparing to unpack .../22-1-autopkgtest-satdep.deb ... 129s Unpacking autopkgtest-satdep (0) ... 129s Setting up python3-iniconfig (1.1.1-2) ... 129s Setting up python3-pydantic-core (2.23.4-2build1) ... 129s Setting up python3-async-generator (1.10-4) ... 129s Setting up python3-all (3.12.6-0ubuntu1) ... 129s Setting up python3-annotated-types (0.7.0-1) ... 129s Setting up python3-multidict (6.1.0-1) ... 129s Setting up python3-frozenlist (1.5.0-1) ... 129s Setting up python3-aiosignal (1.3.1-1) ... 129s Setting up python3-async-timeout (4.0.3-1) ... 129s Setting up python3-packaging (24.1-1) ... 129s Setting up python3-aiohappyeyeballs (2.4.3-1) ... 130s Setting up python3-pluggy (1.5.0-1) ... 130s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 130s Setting up python3-email-validator (2.2.0-1) ... 130s Setting up python3-yarl (1.13.1-1build1) ... 130s Setting up python3-pytest (8.3.3-1) ... 130s Setting up python3-aiohttp (3.10.10-2build1) ... 131s Setting up python3-pydantic (2.9.1-1) ... 131s Setting up python3-pytest-asyncio (0.20.3-1.3) ... 131s Setting up python3-zwave-js-server-python (0.58.1-1) ... 131s Setting up python3-pytest-aiohttp (1.0.5-1) ... 131s Setting up python3-pytest-timeout (2.3.1-1) ... 131s Setting up autopkgtest-satdep (0) ... 131s Processing triggers for man-db (2.13.0-1) ... 134s (Reading database ... 56358 files and directories currently installed.) 134s Removing autopkgtest-satdep (0) ... 134s autopkgtest [17:06:33]: test run-tests: [----------------------- 135s ============================= test session starts ============================== 135s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 -- /usr/bin/python3.12 135s cachedir: .pytest_cache 135s rootdir: /tmp/autopkgtest.Vq197r/autopkgtest_tmp 135s plugins: aiohttp-1.0.5, typeguard-4.4.1, timeout-2.3.1, asyncio-0.20.3 135s asyncio: mode=Mode.AUTO 136s collecting ... collected 271 items 136s 136s test/const/command_class/test_multilevel_sensor.py::test_multilevel_sensor_constants PASSED [ 0%] 136s test/model/test_controller.py::test_from_state PASSED [ 0%] 136s test/model/test_controller.py::test_controller_mods PASSED [ 1%] 136s test/model/test_controller.py::test_controller_status PASSED [ 1%] 136s test/model/test_controller.py::test_begin_inclusion PASSED [ 1%] 136s test/model/test_controller.py::test_begin_inclusion_default PASSED [ 2%] 136s test/model/test_controller.py::test_begin_inclusion_default_force_security PASSED [ 2%] 136s test/model/test_controller.py::test_begin_inclusion_s2_no_input PASSED [ 2%] 136s test/model/test_controller.py::test_begin_inclusion_s2_qr_code_string PASSED [ 3%] 136s test/model/test_controller.py::test_begin_inclusion_s2_provisioning_entry PASSED [ 3%] 136s test/model/test_controller.py::test_begin_inclusion_s2_qr_info PASSED [ 4%] 136s test/model/test_controller.py::test_begin_inclusion_s2_dsk PASSED [ 4%] 136s test/model/test_controller.py::test_begin_inclusion_errors PASSED [ 4%] 136s test/model/test_controller.py::test_provision_smart_start_node_qr_code_string PASSED [ 5%] 136s test/model/test_controller.py::test_provision_smart_start_node_provisioning_entry PASSED [ 5%] 136s test/model/test_controller.py::test_provision_smart_start_node_qr_info PASSED [ 5%] 136s test/model/test_controller.py::test_unprovision_smart_start_node PASSED [ 6%] 136s test/model/test_controller.py::test_get_provisioning_entry PASSED [ 6%] 136s test/model/test_controller.py::test_get_provisioning_entry_undefined PASSED [ 7%] 136s test/model/test_controller.py::test_get_provisioning_entries PASSED [ 7%] 136s test/model/test_controller.py::test_stop_inclusion PASSED [ 7%] 136s test/model/test_controller.py::test_begin_exclusion PASSED [ 8%] 136s test/model/test_controller.py::test_begin_exclusion_unprovision PASSED [ 8%] 136s test/model/test_controller.py::test_stop_exclusion PASSED [ 8%] 136s test/model/test_controller.py::test_hash PASSED [ 9%] 136s test/model/test_controller.py::test_remove_failed_node PASSED [ 9%] 136s test/model/test_controller.py::test_replace_failed_node PASSED [ 9%] 136s test/model/test_controller.py::test_replace_failed_node_default PASSED [ 10%] 136s test/model/test_controller.py::test_replace_failed_node_default_force_security PASSED [ 10%] 136s test/model/test_controller.py::test_replace_failed_node_s2_no_input PASSED [ 11%] 136s test/model/test_controller.py::test_replace_failed_node_s2_qr_code_string PASSED [ 11%] 136s test/model/test_controller.py::test_replace_failed_node_s2_provisioning_entry PASSED [ 11%] 136s test/model/test_controller.py::test_replace_failed_node_s2_qr_info PASSED [ 12%] 136s test/model/test_controller.py::test_replace_failed_node_errors PASSED [ 12%] 136s test/model/test_controller.py::test_rebuild_node_routes PASSED [ 12%] 136s test/model/test_controller.py::test_begin_rebuilding_routes PASSED [ 13%] 136s test/model/test_controller.py::test_stop_rebuilding_routes PASSED [ 13%] 136s test/model/test_controller.py::test_is_failed_node PASSED [ 14%] 136s test/model/test_controller.py::test_get_association_groups PASSED [ 14%] 136s test/model/test_controller.py::test_get_associations PASSED [ 14%] 136s test/model/test_controller.py::test_assoc_addr_model PASSED [ 15%] 136s test/model/test_controller.py::test_check_association PASSED [ 15%] 136s test/model/test_controller.py::test_add_associations PASSED [ 15%] 136s test/model/test_controller.py::test_remove_associations PASSED [ 16%] 136s test/model/test_controller.py::test_remove_node_from_all_associations PASSED [ 16%] 136s test/model/test_controller.py::test_get_node_neighbors PASSED [ 16%] 136s test/model/test_controller.py::test_rebuild_routes_active PASSED [ 17%] 136s test/model/test_controller.py::test_statistics_updated PASSED [ 17%] 136s test/model/test_controller.py::test_grant_security_classes PASSED [ 18%] 136s test/model/test_controller.py::test_validate_dsk_and_enter_pin PASSED [ 18%] 136s test/model/test_controller.py::test_supports_feature PASSED [ 18%] 136s test/model/test_controller.py::test_get_state PASSED [ 19%] 136s test/model/test_controller.py::test_backup_nvm_raw PASSED [ 19%] 136s test/model/test_controller.py::test_restore_nvm PASSED [ 19%] 136s test/model/test_controller.py::test_set_power_level PASSED [ 20%] 136s test/model/test_controller.py::test_get_power_level PASSED [ 20%] 136s test/model/test_controller.py::test_set_rf_region PASSED [ 21%] 136s test/model/test_controller.py::test_get_rf_region PASSED [ 21%] 136s test/model/test_controller.py::test_get_known_lifeline_routes PASSED [ 21%] 136s test/model/test_controller.py::test_get_known_lifeline_routes_bad_protocol_data_rates PASSED [ 22%] 136s test/model/test_controller.py::test_is_any_ota_firmware_update_in_progress PASSED [ 22%] 136s test/model/test_controller.py::test_get_available_firmware_updates PASSED [ 22%] 136s test/model/test_controller.py::test_begin_ota_firmware_update PASSED [ 23%] 136s test/model/test_controller.py::test_get_known_lifeline_routes_rssi_error PASSED [ 23%] 136s test/model/test_controller.py::test_is_firmware_update_in_progress PASSED [ 23%] 136s test/model/test_controller.py::test_nvm_events PASSED [ 24%] 136s test/model/test_controller.py::test_node_found PASSED [ 24%] 136s test/model/test_controller.py::test_node_added PASSED [ 25%] 136s test/model/test_controller.py::test_node_removed PASSED [ 25%] 136s test/model/test_controller.py::test_inclusion_aborted PASSED [ 25%] 136s test/model/test_controller.py::test_firmware_events PASSED [ 26%] 136s test/model/test_controller.py::test_unknown_event PASSED [ 26%] 136s test/model/test_controller.py::test_additional_events PASSED [ 26%] 136s test/model/test_controller.py::test_identify PASSED [ 27%] 136s test/model/test_driver.py::test_from_state PASSED [ 27%] 136s test/model/test_driver.py::test_update_log_config PASSED [ 28%] 136s test/model/test_driver.py::test_get_log_config PASSED [ 28%] 136s test/model/test_driver.py::test_listening_logs PASSED [ 28%] 136s test/model/test_driver.py::test_statistics PASSED [ 29%] 136s test/model/test_driver.py::test_log_config_updated PASSED [ 29%] 136s test/model/test_driver.py::test_check_for_config_updates PASSED [ 29%] 136s test/model/test_driver.py::test_install_config_update PASSED [ 30%] 136s test/model/test_driver.py::test_set_preferred_scales PASSED [ 30%] 136s test/model/test_driver.py::test_hard_reset PASSED [ 30%] 136s test/model/test_driver.py::test_try_soft_reset PASSED [ 31%] 136s test/model/test_driver.py::test_soft_reset PASSED [ 31%] 136s test/model/test_driver.py::test_shutdown PASSED [ 32%] 136s test/model/test_driver.py::test_unknown_event PASSED [ 32%] 136s test/model/test_driver.py::test_all_nodes_ready_event PASSED [ 32%] 136s test/model/test_node.py::test_firmware PASSED [ 33%] 136s test/model/test_node.py::test_from_state PASSED [ 33%] 136s test/model/test_node.py::test_last_seen PASSED [ 33%] 136s test/model/test_node.py::test_highest_security_value PASSED [ 34%] 136s test/model/test_node.py::test_command_classes PASSED [ 34%] 136s test/model/test_node.py::test_device_config PASSED [ 35%] 136s test/model/test_node.py::test_protocol PASSED [ 35%] 136s test/model/test_node.py::test_endpoint_no_device_class PASSED [ 35%] 136s test/model/test_node.py::test_unknown_values PASSED [ 36%] 136s test/model/test_node.py::test_device_database_url PASSED [ 36%] 136s test/model/test_node.py::test_values_without_property_key_name PASSED [ 36%] 136s test/model/test_node.py::test_hash PASSED [ 37%] 136s test/model/test_node.py::test_command_class_values PASSED [ 37%] 136s test/model/test_node.py::test_set_value PASSED [ 38%] 136s test/model/test_node.py::test_set_value_node_status_change PASSED [ 38%] 136s test/model/test_node.py::test_poll_value PASSED [ 38%] 136s test/model/test_node.py::test_ping PASSED [ 39%] 136s test/model/test_node.py::test_refresh_info PASSED [ 39%] 136s test/model/test_node.py::test_value_added_event PASSED [ 39%] 136s test/model/test_node.py::test_get_defined_value_ids PASSED [ 40%] 136s test/model/test_node.py::test_get_value_metadata PASSED [ 40%] 136s test/model/test_node.py::test_abort_firmware_update PASSED [ 40%] 136s test/model/test_node.py::test_node_inclusion PASSED [ 41%] 136s test/model/test_node.py::test_node_ready_event PASSED [ 41%] 136s test/model/test_node.py::test_node_status_events PASSED [ 42%] 136s test/model/test_node.py::test_value_added_events PASSED [ 42%] 136s test/model/test_node.py::test_value_updated_events PASSED [ 42%] 136s test/model/test_node.py::test_value_removed_events PASSED [ 43%] 136s test/model/test_node.py::test_value_notification PASSED [ 43%] 136s test/model/test_node.py::test_metadata_updated PASSED [ 43%] 136s test/model/test_node.py::test_notification PASSED [ 44%] 136s test/model/test_node.py::test_notification_unknown PASSED [ 44%] 136s test/model/test_node.py::test_entry_control_notification PASSED [ 45%] 136s test/model/test_node.py::test_interview_events PASSED [ 45%] 136s test/model/test_node.py::test_refresh_values PASSED [ 45%] 136s test/model/test_node.py::test_firmware_events PASSED [ 46%] 136s test/model/test_node.py::test_value_added_value_exists PASSED [ 46%] 136s test/model/test_node.py::test_value_added_new_value PASSED [ 46%] 136s test/model/test_node.py::test_invoke_cc_api PASSED [ 47%] 136s test/model/test_node.py::test_supports_cc_api PASSED [ 47%] 136s test/model/test_node.py::test_supports_cc PASSED [ 47%] 136s test/model/test_node.py::test_controls_cc PASSED [ 48%] 136s test/model/test_node.py::test_is_cc_secure PASSED [ 48%] 136s test/model/test_node.py::test_get_cc_version PASSED [ 49%] 136s test/model/test_node.py::test_get_node_unsafe PASSED [ 49%] 136s test/model/test_node.py::test_statistics_updated PASSED [ 49%] 136s test/model/test_node.py::test_statistics_updated_rssi_error PASSED [ 50%] 136s test/model/test_node.py::test_has_security_class PASSED [ 50%] 136s test/model/test_node.py::test_has_security_class_undefined PASSED [ 50%] 136s test/model/test_node.py::test_get_highest_security_class PASSED [ 51%] 136s test/model/test_node.py::test_get_highest_security_class_undefined PASSED [ 51%] 136s test/model/test_node.py::test_test_power_level PASSED [ 52%] 136s test/model/test_node.py::test_test_power_level_progress_event PASSED [ 52%] 137s test/model/test_node.py::test_check_lifeline_health PASSED [ 52%] 137s test/model/test_node.py::test_check_lifeline_health_progress_event PASSED [ 53%] 137s test/model/test_node.py::test_check_route_health PASSED [ 53%] 137s test/model/test_node.py::test_check_route_health_progress_event PASSED [ 53%] 137s test/model/test_node.py::test_get_state PASSED [ 54%] 137s test/model/test_node.py::test_set_name PASSED [ 54%] 137s test/model/test_node.py::test_set_location PASSED [ 54%] 137s test/model/test_node.py::test_set_keep_awake PASSED [ 55%] 137s test/model/test_node.py::test_get_firmware_update_capabilities PASSED [ 55%] 137s test/model/test_node.py::test_get_firmware_update_capabilities_false PASSED [ 56%] 137s test/model/test_node.py::test_get_firmware_update_capabilities_string PASSED [ 56%] 137s test/model/test_node.py::test_get_firmware_update_capabilities_cached PASSED [ 56%] 137s test/model/test_node.py::test_is_firmware_update_in_progress PASSED [ 57%] 137s test/model/test_node.py::test_interview PASSED [ 57%] 137s test/model/test_node.py::test_manually_idle_notification_value PASSED [ 57%] 137s test/model/test_node.py::test_set_date_and_time_no_wait PASSED [ 58%] 137s test/model/test_node.py::test_set_date_and_time PASSED [ 58%] 137s test/model/test_node.py::test_get_date_and_time PASSED [ 59%] 137s test/model/test_node.py::test_get_value_timestamp PASSED [ 59%] 137s test/model/test_node.py::test_is_health_check_in_progress PASSED [ 59%] 137s test/model/test_node.py::test_abort_health_check PASSED [ 60%] 137s test/model/test_node.py::test_unknown_event PASSED [ 60%] 137s test/model/test_node.py::test_default_volume PASSED [ 60%] 137s test/model/test_node.py::test_default_transition_duration PASSED [ 61%] 137s test/model/test_node.py::test_has_device_config_changed PASSED [ 61%] 137s test/model/test_node.py::test_has_device_config_changed_undefined PASSED [ 61%] 137s test/model/test_node.py::test_is_secure_none PASSED [ 62%] 137s test/model/test_node.py::test_set_raw_config_parameter_value PASSED [ 62%] 137s test/model/test_node.py::test_supervision_result PASSED [ 63%] 137s test/model/test_node.py::test_supervision_result_invalid PASSED [ 63%] 137s test/model/test_utils.py::test_parse_qr_code_string PASSED [ 63%] 137s test/model/test_utils.py::test_async_try_parse_dsk_from_qr_code_string PASSED [ 64%] 137s test/model/test_utils.py::test_async_try_parse_dsk_from_qr_code_string_fails PASSED [ 64%] 137s test/model/test_value.py::test_value_size PASSED [ 64%] 137s test/model/test_value.py::test_buffer_dict PASSED [ 65%] 137s test/model/test_value.py::test_unparseable_value PASSED [ 65%] 137s test/model/test_value.py::test_allow_manual_entry PASSED [ 66%] 137s test/model/test_value.py::test_stateful PASSED [ 66%] 137s test/model/test_value.py::test_secret PASSED [ 66%] 137s test/model/test_value.py::test_configuration_value_type PASSED [ 67%] 137s test/model/test_value.py::test_set_value_result_str PASSED [ 67%] 137s test/model/test_value.py::test_configuration_value_metadata PASSED [ 67%] 137s test/test_client.py::test_connect_disconnect PASSED [ 68%] 137s test/test_client.py::test_cannot_connect[ClientError] PASSED [ 68%] 137s test/test_client.py::test_cannot_connect[error1] PASSED [ 69%] 137s test/test_client.py::test_send_command_schema PASSED [ 69%] 137s test/test_client.py::test_min_schema_version PASSED [ 69%] 137s test/test_client.py::test_max_schema_version PASSED [ 70%] 137s test/test_client.py::test_send_json_when_disconnected PASSED [ 70%] 137s test/test_client.py::test_listen PASSED [ 70%] 137s test/test_client.py::test_listen_client_error PASSED [ 71%] 137s test/test_client.py::test_listen_error_message_types[258-ConnectionFailed] PASSED [ 71%] 137s test/test_client.py::test_listen_error_message_types[2-InvalidMessage] PASSED [ 71%] 137s test/test_client.py::test_listen_disconnect_message_types[8] PASSED [ 72%] 137s test/test_client.py::test_listen_disconnect_message_types[257] PASSED [ 72%] 137s test/test_client.py::test_listen_disconnect_message_types[256] PASSED [ 73%] 137s test/test_client.py::test_listen_invalid_message_data PASSED [ 73%] 137s test/test_client.py::test_listen_not_success PASSED [ 73%] 137s test/test_client.py::test_initialize_not_success PASSED [ 74%] 137s test/test_client.py::test_get_log_config_not_success PASSED [ 74%] 137s test/test_client.py::test_listen_without_connect PASSED [ 74%] 137s test/test_client.py::test_listen_event PASSED [ 75%] 137s test/test_client.py::test_listen_unknown_result_type PASSED [ 75%] 137s test/test_client.py::test_command_error_handling PASSED [ 76%] 137s test/test_client.py::test_record_messages PASSED [ 76%] 137s test/test_client.py::test_additional_user_agent_components PASSED [ 76%] 137s test/test_client.py::test_pop_future_none PASSED [ 77%] 137s test/test_client.py::test_log_server PASSED [ 77%] 137s test/test_dump.py::test_dump PASSED [ 77%] 137s test/test_dump.py::test_dump_timeout PASSED [ 78%] 137s test/test_dump.py::test_dump_additional_user_agent_components PASSED [ 78%] 137s test/test_event.py::test_once PASSED [ 78%] 137s test/test_event.py::test_exception_on_emit PASSED [ 79%] 137s test/test_firmware.py::test_update_firmware_guess_format PASSED [ 79%] 137s test/test_firmware.py::test_update_firmware_known_format_and_target PASSED [ 80%] 137s test/test_firmware.py::test_controller_firmware_update_otw_guess_format PASSED [ 80%] 137s test/test_firmware.py::test_controller_firmware_update_otw_known_format_and_target PASSED [ 80%] 137s test/test_main.py::test_server_version PASSED [ 81%] 137s test/test_main.py::test_dump_state[test_result] PASSED [ 81%] 137s test/test_main.py::test_connect PASSED [ 81%] 137s test/test_version.py::test_get_server_version PASSED [ 82%] 137s test/test_version.py::test_missing_server_schema_version PASSED [ 82%] 137s test/util/command_class/test_energy_production.py::test_get_energy_production_parameter PASSED [ 83%] 137s test/util/command_class/test_energy_production.py::test_invalid_get_energy_production_parameter PASSED [ 83%] 137s test/util/command_class/test_energy_production.py::test_get_energy_production_scale_type PASSED [ 83%] 137s test/util/command_class/test_energy_production.py::test_invalid_get_energy_production_scale_type PASSED [ 84%] 137s test/util/command_class/test_meter.py::test_get_meter_type PASSED [ 84%] 137s test/util/command_class/test_meter.py::test_get_invalid_meter_type PASSED [ 84%] 137s test/util/command_class/test_meter.py::test_get_meter_scale_type PASSED [ 85%] 137s test/util/command_class/test_meter.py::test_get_invalid_meter_scale_type PASSED [ 85%] 137s test/util/command_class/test_multilevel_sensor.py::test_get_multilevel_sensor_type PASSED [ 85%] 137s test/util/command_class/test_multilevel_sensor.py::test_get_invalid_multilevel_sensor_type PASSED [ 86%] 137s test/util/command_class/test_multilevel_sensor.py::test_get_multilevel_sensor_scale_type PASSED [ 86%] 137s test/util/command_class/test_multilevel_sensor.py::test_get_invalid_multilevel_sensor_scale_type PASSED [ 87%] 137s test/util/test_lock.py::test_get_code_slots PASSED [ 87%] 137s test/util/test_lock.py::test_get_usercode PASSED [ 87%] 137s test/util/test_lock.py::test_get_usercodes PASSED [ 88%] 137s test/util/test_lock.py::test_set_usercode PASSED [ 88%] 137s test/util/test_lock.py::test_clear_usercode PASSED [ 88%] 137s test/util/test_lock.py::test_get_usercode_from_node PASSED [ 89%] 137s test/util/test_lock.py::test_set_configuration_empty_response PASSED [ 89%] 137s test/util/test_lock.py::test_set_configuration_with_response PASSED [ 90%] 137s test/util/test_lock.py::test_set_configuration_v4 PASSED [ 90%] 137s test/util/test_lock.py::test_set_configuration_timed_lock PASSED [ 90%] 137s test/util/test_multicast.py::test_endpoint_get_cc_version_multicast PASSED [ 91%] 137s test/util/test_multicast.py::test_endpoint_get_cc_version_broadcast PASSED [ 91%] 137s test/util/test_multicast.py::test_endpoint_supports_cc_broadcast PASSED [ 91%] 137s test/util/test_multicast.py::test_endpoint_supports_cc_multicast PASSED [ 92%] 137s test/util/test_multicast.py::test_get_endpoint_count_broadcast PASSED [ 92%] 137s test/util/test_multicast.py::test_get_endpoint_count_multicast PASSED [ 92%] 137s test/util/test_multicast.py::test_set_value_broadcast PASSED [ 93%] 137s test/util/test_multicast.py::test_set_value_multicast PASSED [ 93%] 137s test/util/test_multicast.py::test_set_value_multicast_basic PASSED [ 94%] 137s test/util/test_multicast.py::test_invoke_cc_api_broadcast PASSED [ 94%] 137s test/util/test_multicast.py::test_invoke_cc_api_multicast PASSED [ 94%] 137s test/util/test_multicast.py::test_supports_cc_api_broadcast PASSED [ 95%] 137s test/util/test_multicast.py::test_supports_cc_api_multicast PASSED [ 95%] 137s test/util/test_multicast.py::test_set_value_broadcast_missing_value PASSED [ 95%] 137s test/util/test_node.py::test_configuration_parameter_values[0] PASSED [ 96%] 137s test/util/test_node.py::test_configuration_parameter_values[1] PASSED [ 96%] 137s test/util/test_node.py::test_bulk_set_partial_config_parameters[0] PASSED [ 97%] 137s test/util/test_node.py::test_bulk_set_partial_config_parameters[1] PASSED [ 97%] 137s test/util/test_node.py::test_bulk_set_with_full_and_partial_parameters[0] PASSED [ 97%] 137s test/util/test_node.py::test_bulk_set_with_full_and_partial_parameters[1] PASSED [ 98%] 137s test/util/test_node.py::test_failures[0] PASSED [ 98%] 137s test/util/test_node.py::test_failures[1] PASSED [ 98%] 137s test/util/test_node.py::test_returned_values[0] PASSED [ 99%] 137s test/util/test_node.py::test_returned_values[1] PASSED [ 99%] 137s test/util/test_node.py::test_dump_node_state PASSED [100%] 137s 137s ============================= 271 passed in 2.47s ============================== 138s autopkgtest [17:06:37]: test run-tests: -----------------------] 138s autopkgtest [17:06:37]: test run-tests: - - - - - - - - - - results - - - - - - - - - - 138s run-tests PASS 138s autopkgtest [17:06:37]: @@@@@@@@@@@@@@@@@@@@ summary 138s run-tests PASS 150s virt: nova [W] Using flock in prodstack6-s390x 150s virt: flock: timeout while waiting to get lock 150s virt: Creating nova instance adt-plucky-s390x-zwave-js-server-python-20241115-170419-juju-7f2275-prod-proposed-migration-environment-2-fc5112f1-b273-4ba3-b516-c96ab704df49 from image adt/ubuntu-plucky-s390x-server-20241115.img (UUID c94000c6-8e8d-4693-8d37-fa9d34cd2414)...