0s autopkgtest [10:17:04]: starting date and time: 2025-02-20 10:17:04+0000 0s autopkgtest [10:17:04]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [10:17:04]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.zezcc32h/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:zigpy-zigate,src:zigpy --apt-upgrade zigpy-zigate --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=zigpy-zigate/0.13.2-1 zigpy/0.76.1-2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-arm64-14.secgroup --name adt-plucky-arm64-zigpy-zigate-20250220-101703-juju-7f2275-prod-proposed-migration-environment-15-a18c4a05-6e46-4adb-a233-9f34780457cf --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 116s autopkgtest [10:19:00]: testbed dpkg architecture: arm64 116s autopkgtest [10:19:00]: testbed apt version: 2.9.30 116s autopkgtest [10:19:00]: @@@@@@@@@@@@@@@@@@@@ test bed setup 117s autopkgtest [10:19:01]: testbed release detected to be: None 117s autopkgtest [10:19:01]: updating testbed package index (apt update) 118s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 118s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 118s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 118s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 118s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [87.1 kB] 118s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 118s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [782 kB] 118s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 118s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [115 kB] 118s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [7960 B] 118s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [666 kB] 118s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [11.3 kB] 119s Fetched 1798 kB in 1s (1993 kB/s) 119s Reading package lists... 120s + lsb_release --codename --short 120s + RELEASE=plucky 120s + cat 120s + [ plucky != trusty ] 120s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 120s Reading package lists... 120s Building dependency tree... 120s Reading state information... 121s Calculating upgrade... 121s The following package was automatically installed and is no longer required: 121s libapt-pkg6.0t64 121s Use 'sudo apt autoremove' to remove it. 121s The following packages will be upgraded: 121s fwupd libfwupd3 ubuntu-pro-client ubuntu-pro-client-l10n 122s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 122s Need to get 5675 kB of archives. 122s After this operation, 11.3 kB of additional disk space will be used. 122s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 ubuntu-pro-client-l10n arm64 34.1.3 [18.3 kB] 122s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 ubuntu-pro-client arm64 34.1.3 [240 kB] 122s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 fwupd arm64 2.0.6-3 [5288 kB] 122s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libfwupd3 arm64 2.0.6-3 [129 kB] 123s Fetched 5675 kB in 1s (6504 kB/s) 123s (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 ... 116718 files and directories currently installed.) 123s Preparing to unpack .../ubuntu-pro-client-l10n_34.1.3_arm64.deb ... 123s Unpacking ubuntu-pro-client-l10n (34.1.3) over (34.1.2) ... 123s Preparing to unpack .../ubuntu-pro-client_34.1.3_arm64.deb ... 123s /usr/bin/py3clean:101: DeprecationWarning: glob.glob1 is deprecated and will be removed in Python 3.15. Use glob.glob and pass a directory to its root_dir argument instead. 123s for fn in glob1(directory, "%s.*" % fname): 123s Unpacking ubuntu-pro-client (34.1.3) over (34.1.2) ... 124s Preparing to unpack .../fwupd_2.0.6-3_arm64.deb ... 124s Unpacking fwupd (2.0.6-3) over (2.0.5-1) ... 124s Preparing to unpack .../libfwupd3_2.0.6-3_arm64.deb ... 124s Unpacking libfwupd3:arm64 (2.0.6-3) over (2.0.5-1) ... 124s Setting up libfwupd3:arm64 (2.0.6-3) ... 124s Setting up ubuntu-pro-client (34.1.3) ... 126s Setting up fwupd (2.0.6-3) ... 126s fwupd-refresh.service is a disabled or a static unit not running, not starting it. 127s fwupd.service is a disabled or a static unit not running, not starting it. 127s Setting up ubuntu-pro-client-l10n (34.1.3) ... 127s Processing triggers for man-db (2.13.0-1) ... 128s Processing triggers for dbus (1.16.0-1ubuntu1) ... 128s Processing triggers for libc-bin (2.40-4ubuntu1) ... 128s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 128s + /usr/lib/apt/apt-helper analyze-pattern ?true 128s + uname -r 128s + sed s/\./\\./g 128s + running_kernel_pattern=^linux-.*6\.12\.0-15-generic.* 128s + apt list ?obsolete 128s + tail -n+2 128s + + grep -v ^linux-.*6\.12\.0-15-generic.* 128s cut -d/ -f1 129s + true 129s + obsolete_pkgs= 129s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 130s The following packages will be REMOVED: 130s libapt-pkg6.0t64* 130s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded. 130s After this operation, 3410 kB disk space will be freed. 130s (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 ... 116718 files and directories currently installed.) 130s Removing libapt-pkg6.0t64:arm64 (2.9.29) ... 130s Processing triggers for libc-bin (2.40-4ubuntu1) ... 130s + grep -q trusty /etc/lsb-release 130s + [ ! -d /usr/share/doc/unattended-upgrades ] 130s + [ ! -d /usr/share/doc/lxd ] 130s + [ ! -d /usr/share/doc/lxd-client ] 130s + [ ! -d /usr/share/doc/snapd ] 130s + type iptables 130s + cat 130s + chmod 755 /etc/rc.local 130s + . /etc/rc.local 130s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 130s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 130s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 130s + uname -m 130s + [ aarch64 = ppc64le ] 130s + [ -d /run/systemd/system ] 130s + systemd-detect-virt --quiet --vm 130s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 130s + cat 130s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 130s + echo COMPRESS=lz4 130s autopkgtest [10:19:14]: upgrading testbed (apt dist-upgrade and autopurge) 131s Reading package lists... 131s Building dependency tree... 131s Reading state information... 132s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 132s Starting 2 pkgProblemResolver with broken count: 0 132s Done 132s Entering ResolveByKeep 133s 133s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 134s Reading package lists... 134s Building dependency tree... 134s Reading state information... 135s Starting pkgProblemResolver with broken count: 0 135s Starting 2 pkgProblemResolver with broken count: 0 135s Done 135s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 136s autopkgtest [10:19:20]: rebooting testbed after setup commands that affected boot 159s autopkgtest [10:19:43]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Tue Feb 4 15:49:33 UTC 2025 162s autopkgtest [10:19:46]: @@@@@@@@@@@@@@@@@@@@ apt-source zigpy-zigate 164s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/universe zigpy-zigate 0.13.2-1 (dsc) [2520 B] 164s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe zigpy-zigate 0.13.2-1 (tar) [41.3 kB] 164s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe zigpy-zigate 0.13.2-1 (diff) [2468 B] 164s gpgv: Signature made Wed Feb 19 16:17:50 2025 UTC 164s gpgv: using RSA key FB8ACFA78C726089C38AD0269605A1098C63B92A 164s gpgv: Can't check signature: No public key 164s dpkg-source: warning: cannot verify inline signature for ./zigpy-zigate_0.13.2-1.dsc: no acceptable signature found 164s autopkgtest [10:19:48]: testing package zigpy-zigate version 0.13.2-1 164s autopkgtest [10:19:48]: build not needed 165s autopkgtest [10:19:49]: test run-tests: preparing testbed 165s Reading package lists... 165s Building dependency tree... 165s Reading state information... 165s Starting pkgProblemResolver with broken count: 0 166s Starting 2 pkgProblemResolver with broken count: 0 166s Done 166s The following NEW packages will be installed: 166s python3-all python3-async-generator python3-iniconfig python3-packaging 166s python3-pluggy python3-pytest python3-pytest-asyncio python3-pytest-mock 166s python3-pytest-timeout python3-zigpy-zigate python3.12 python3.12-minimal 167s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded. 167s Need to get 3330 kB of archives. 167s After this operation, 10.7 MB of additional disk space will be used. 167s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 python3.12-minimal arm64 3.12.9-1 [2236 kB] 167s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 python3.12 arm64 3.12.9-1 [671 kB] 167s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-all arm64 3.13.1-1~exp2 [894 B] 167s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-async-generator all 1.10-4 [17.5 kB] 167s Get:5 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-iniconfig all 1.1.1-2 [6024 B] 167s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-packaging all 24.2-1 [51.5 kB] 167s Get:7 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pluggy all 1.5.0-1 [21.0 kB] 167s Get:8 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest all 8.3.4-1 [252 kB] 167s Get:9 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest-asyncio all 0.25.1-1 [17.0 kB] 167s Get:10 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest-mock all 3.14.0-2 [11.7 kB] 167s Get:11 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest-timeout all 2.3.1-1 [22.1 kB] 167s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 python3-zigpy-zigate all 0.13.2-1 [24.1 kB] 168s Fetched 3330 kB in 1s (4007 kB/s) 168s Selecting previously unselected package python3.12-minimal. 168s (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 ... 116668 files and directories currently installed.) 168s Preparing to unpack .../00-python3.12-minimal_3.12.9-1_arm64.deb ... 168s Unpacking python3.12-minimal (3.12.9-1) ... 168s Selecting previously unselected package python3.12. 168s Preparing to unpack .../01-python3.12_3.12.9-1_arm64.deb ... 168s Unpacking python3.12 (3.12.9-1) ... 168s Selecting previously unselected package python3-all. 168s Preparing to unpack .../02-python3-all_3.13.1-1~exp2_arm64.deb ... 168s Unpacking python3-all (3.13.1-1~exp2) ... 168s Selecting previously unselected package python3-async-generator. 168s Preparing to unpack .../03-python3-async-generator_1.10-4_all.deb ... 168s Unpacking python3-async-generator (1.10-4) ... 168s Selecting previously unselected package python3-iniconfig. 168s Preparing to unpack .../04-python3-iniconfig_1.1.1-2_all.deb ... 168s Unpacking python3-iniconfig (1.1.1-2) ... 168s Selecting previously unselected package python3-packaging. 168s Preparing to unpack .../05-python3-packaging_24.2-1_all.deb ... 168s Unpacking python3-packaging (24.2-1) ... 168s Selecting previously unselected package python3-pluggy. 168s Preparing to unpack .../06-python3-pluggy_1.5.0-1_all.deb ... 168s Unpacking python3-pluggy (1.5.0-1) ... 168s Selecting previously unselected package python3-pytest. 168s Preparing to unpack .../07-python3-pytest_8.3.4-1_all.deb ... 168s Unpacking python3-pytest (8.3.4-1) ... 168s Selecting previously unselected package python3-pytest-asyncio. 168s Preparing to unpack .../08-python3-pytest-asyncio_0.25.1-1_all.deb ... 168s Unpacking python3-pytest-asyncio (0.25.1-1) ... 169s Selecting previously unselected package python3-pytest-mock. 169s Preparing to unpack .../09-python3-pytest-mock_3.14.0-2_all.deb ... 169s Unpacking python3-pytest-mock (3.14.0-2) ... 169s Selecting previously unselected package python3-pytest-timeout. 169s Preparing to unpack .../10-python3-pytest-timeout_2.3.1-1_all.deb ... 169s Unpacking python3-pytest-timeout (2.3.1-1) ... 169s Selecting previously unselected package python3-zigpy-zigate. 169s Preparing to unpack .../11-python3-zigpy-zigate_0.13.2-1_all.deb ... 169s Unpacking python3-zigpy-zigate (0.13.2-1) ... 169s Setting up python3-iniconfig (1.1.1-2) ... 169s Setting up python3.12-minimal (3.12.9-1) ... 170s Setting up python3-async-generator (1.10-4) ... 171s Setting up python3.12 (3.12.9-1) ... 172s Setting up python3-all (3.13.1-1~exp2) ... 172s Setting up python3-zigpy-zigate (0.13.2-1) ... 172s Setting up python3-packaging (24.2-1) ... 172s Setting up python3-pluggy (1.5.0-1) ... 173s Setting up python3-pytest (8.3.4-1) ... 173s Setting up python3-pytest-asyncio (0.25.1-1) ... 174s Setting up python3-pytest-mock (3.14.0-2) ... 174s Setting up python3-pytest-timeout (2.3.1-1) ... 174s Processing triggers for man-db (2.13.0-1) ... 175s Processing triggers for systemd (257.2-3ubuntu1) ... 176s autopkgtest [10:20:00]: test run-tests: [----------------------- 177s /usr/lib/python3/dist-packages/pytest_asyncio/plugin.py:207: PytestDeprecationWarning: The configuration option "asyncio_default_fixture_loop_scope" is unset. 177s 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" 177s 177s warnings.warn(PytestDeprecationWarning(_DEFAULT_FIXTURE_LOOP_SCOPE_UNSET)) 177s ============================= test session starts ============================== 177s platform linux -- Python 3.12.9, pytest-8.3.4, pluggy-1.5.0 -- /usr/bin/python3.12 177s cachedir: .pytest_cache 177s rootdir: /tmp/autopkgtest.zEBQsO/autopkgtest_tmp 177s plugins: mock-3.14.0, asyncio-0.25.1, typeguard-4.4.1, timeout-2.3.1 177s asyncio: mode=Mode.AUTO, asyncio_default_fixture_loop_scope=None 177s collecting ... collected 0 items / 1 error 177s 177s ==================================== ERRORS ==================================== 177s ______________________ ERROR collecting tests/test_api.py ______________________ 177s ImportError while importing test module '/tmp/autopkgtest.zEBQsO/autopkgtest_tmp/tests/test_api.py'. 177s Hint: make sure your test modules/packages have valid Python names. 177s Traceback: 177s /usr/lib/python3.12/importlib/__init__.py:90: in import_module 177s return _bootstrap._gcd_import(name[level:], package, level) 177s tests/test_api.py:5: in 177s import serial_asyncio 177s E ModuleNotFoundError: No module named 'serial_asyncio' 177s =========================== short test summary info ============================ 177s ERROR tests/test_api.py 177s !!!!!!!!!!!!!!!!!!!!!!!!!! stopping after 1 failures !!!!!!!!!!!!!!!!!!!!!!!!!!! 177s =============================== 1 error in 0.03s =============================== 177s autopkgtest [10:20:01]: test run-tests: -----------------------] 178s autopkgtest [10:20:02]: test run-tests: - - - - - - - - - - results - - - - - - - - - - 178s run-tests FAIL non-zero exit status 1 178s autopkgtest [10:20:02]: @@@@@@@@@@@@@@@@@@@@ summary 178s run-tests FAIL non-zero exit status 1 196s nova [W] Using flock in prodstack6-arm64 196s Creating nova instance adt-plucky-arm64-zigpy-zigate-20250220-101703-juju-7f2275-prod-proposed-migration-environment-15-a18c4a05-6e46-4adb-a233-9f34780457cf from image adt/ubuntu-plucky-arm64-server-20250220.img (UUID 397b70ef-022d-4aca-a546-c65dd921737c)... 196s nova [W] Timed out waiting for 048325b9-4dc6-48cb-aadf-144175fceebd to get deleted.