0s autopkgtest [10:17:02]: starting date and time: 2025-02-20 10:17:02+0000 0s autopkgtest [10:17:02]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [10:17:02]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8nrhp2xr/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 builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-23.secgroup --name adt-plucky-amd64-zigpy-zigate-20250220-101701-juju-7f2275-prod-proposed-migration-environment-20-18a52546-f014-4fe3-a99c-3de7060a3871 --image adt/ubuntu-plucky-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-amd64 -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/ 176s autopkgtest [10:19:58]: testbed dpkg architecture: amd64 176s autopkgtest [10:19:58]: testbed apt version: 2.9.30 176s autopkgtest [10:19:58]: @@@@@@@@@@@@@@@@@@@@ test bed setup 176s autopkgtest [10:19:58]: testbed release detected to be: None 177s autopkgtest [10:19:59]: updating testbed package index (apt update) 177s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 178s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 178s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 178s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 178s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [782 kB] 178s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 178s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [87.1 kB] 178s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 178s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [108 kB] 178s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [129 kB] 178s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [7984 B] 178s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/restricted i386 Packages [2412 B] 178s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [744 kB] 178s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [282 kB] 178s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [23.2 kB] 178s Get:16 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [3700 B] 178s Fetched 2299 kB in 1s (2415 kB/s) 179s Reading package lists... 180s Reading package lists... 180s Building dependency tree... 180s Reading state information... 181s Calculating upgrade... 181s The following package was automatically installed and is no longer required: 181s libapt-pkg6.0t64 181s Use 'sudo apt autoremove' to remove it. 181s The following packages will be upgraded: 181s fwupd libfwupd3 ubuntu-pro-client ubuntu-pro-client-l10n 181s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 181s Need to get 5804 kB of archives. 181s After this operation, 35.8 kB of additional disk space will be used. 181s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 ubuntu-pro-client-l10n amd64 34.1.3 [18.3 kB] 181s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 ubuntu-pro-client amd64 34.1.3 [241 kB] 181s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 fwupd amd64 2.0.6-3 [5408 kB] 182s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 libfwupd3 amd64 2.0.6-3 [136 kB] 182s Fetched 5804 kB in 1s (7566 kB/s) 182s (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 ... 109023 files and directories currently installed.) 182s Preparing to unpack .../ubuntu-pro-client-l10n_34.1.3_amd64.deb ... 182s Unpacking ubuntu-pro-client-l10n (34.1.3) over (34.1.2) ... 182s Preparing to unpack .../ubuntu-pro-client_34.1.3_amd64.deb ... 182s /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. 182s for fn in glob1(directory, "%s.*" % fname): 182s Unpacking ubuntu-pro-client (34.1.3) over (34.1.2) ... 183s Preparing to unpack .../fwupd_2.0.6-3_amd64.deb ... 183s Unpacking fwupd (2.0.6-3) over (2.0.5-1) ... 183s Preparing to unpack .../libfwupd3_2.0.6-3_amd64.deb ... 183s Unpacking libfwupd3:amd64 (2.0.6-3) over (2.0.5-1) ... 183s Setting up libfwupd3:amd64 (2.0.6-3) ... 183s Setting up ubuntu-pro-client (34.1.3) ... 184s Setting up fwupd (2.0.6-3) ... 185s fwupd-refresh.service is a disabled or a static unit not running, not starting it. 185s fwupd.service is a disabled or a static unit not running, not starting it. 185s Setting up ubuntu-pro-client-l10n (34.1.3) ... 185s Processing triggers for man-db (2.13.0-1) ... 186s Processing triggers for dbus (1.16.0-1ubuntu1) ... 186s Processing triggers for libc-bin (2.40-4ubuntu1) ... 187s Reading package lists... 187s Building dependency tree... 187s Reading state information... 187s The following packages will be REMOVED: 187s libapt-pkg6.0t64* 187s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded. 187s After this operation, 3725 kB disk space will be freed. 187s (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 ... 109023 files and directories currently installed.) 187s Removing libapt-pkg6.0t64:amd64 (2.9.29) ... 188s Processing triggers for libc-bin (2.40-4ubuntu1) ... 188s autopkgtest [10:20:10]: upgrading testbed (apt dist-upgrade and autopurge) 188s Reading package lists... 188s Building dependency tree... 188s Reading state information... 189s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 189s Starting 2 pkgProblemResolver with broken count: 0 189s Done 189s Entering ResolveByKeep 190s 190s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 190s Reading package lists... 190s Building dependency tree... 190s Reading state information... 191s Starting pkgProblemResolver with broken count: 0 191s Starting 2 pkgProblemResolver with broken count: 0 191s Done 191s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 191s autopkgtest [10:20:13]: rebooting testbed after setup commands that affected boot 214s autopkgtest [10:20:36]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Tue Feb 4 16:02:16 UTC 2025 217s autopkgtest [10:20:39]: @@@@@@@@@@@@@@@@@@@@ apt-source zigpy-zigate 219s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/universe zigpy-zigate 0.13.2-1 (dsc) [2520 B] 219s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe zigpy-zigate 0.13.2-1 (tar) [41.3 kB] 219s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe zigpy-zigate 0.13.2-1 (diff) [2468 B] 219s gpgv: Signature made Wed Feb 19 16:17:50 2025 UTC 219s gpgv: using RSA key FB8ACFA78C726089C38AD0269605A1098C63B92A 219s gpgv: Can't check signature: No public key 219s dpkg-source: warning: cannot verify inline signature for ./zigpy-zigate_0.13.2-1.dsc: no acceptable signature found 219s autopkgtest [10:20:41]: testing package zigpy-zigate version 0.13.2-1 219s autopkgtest [10:20:41]: build not needed 219s autopkgtest [10:20:41]: test run-tests: preparing testbed 220s Reading package lists... 220s Building dependency tree... 220s Reading state information... 220s Starting pkgProblemResolver with broken count: 0 220s Starting 2 pkgProblemResolver with broken count: 0 220s Done 221s The following NEW packages will be installed: 221s python3-all python3-async-generator python3-iniconfig python3-packaging 221s python3-pluggy python3-pytest python3-pytest-asyncio python3-pytest-mock 221s python3-pytest-timeout python3-zigpy-zigate python3.12 python3.12-minimal 221s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded. 221s Need to get 3443 kB of archives. 221s After this operation, 11.0 MB of additional disk space will be used. 221s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.12-minimal amd64 3.12.9-1 [2348 kB] 221s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.12 amd64 3.12.9-1 [671 kB] 221s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-all amd64 3.13.1-1~exp2 [894 B] 221s Get:4 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-async-generator all 1.10-4 [17.5 kB] 221s Get:5 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-iniconfig all 1.1.1-2 [6024 B] 221s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-packaging all 24.2-1 [51.5 kB] 221s Get:7 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pluggy all 1.5.0-1 [21.0 kB] 221s Get:8 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pytest all 8.3.4-1 [252 kB] 221s Get:9 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pytest-asyncio all 0.25.1-1 [17.0 kB] 221s Get:10 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pytest-mock all 3.14.0-2 [11.7 kB] 221s Get:11 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pytest-timeout all 2.3.1-1 [22.1 kB] 221s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 python3-zigpy-zigate all 0.13.2-1 [24.1 kB] 222s Fetched 3443 kB in 1s (4165 kB/s) 222s Selecting previously unselected package python3.12-minimal. 222s (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 ... 108973 files and directories currently installed.) 222s Preparing to unpack .../00-python3.12-minimal_3.12.9-1_amd64.deb ... 222s Unpacking python3.12-minimal (3.12.9-1) ... 222s Selecting previously unselected package python3.12. 222s Preparing to unpack .../01-python3.12_3.12.9-1_amd64.deb ... 222s Unpacking python3.12 (3.12.9-1) ... 222s Selecting previously unselected package python3-all. 222s Preparing to unpack .../02-python3-all_3.13.1-1~exp2_amd64.deb ... 222s Unpacking python3-all (3.13.1-1~exp2) ... 222s Selecting previously unselected package python3-async-generator. 222s Preparing to unpack .../03-python3-async-generator_1.10-4_all.deb ... 222s Unpacking python3-async-generator (1.10-4) ... 222s Selecting previously unselected package python3-iniconfig. 222s Preparing to unpack .../04-python3-iniconfig_1.1.1-2_all.deb ... 222s Unpacking python3-iniconfig (1.1.1-2) ... 222s Selecting previously unselected package python3-packaging. 222s Preparing to unpack .../05-python3-packaging_24.2-1_all.deb ... 222s Unpacking python3-packaging (24.2-1) ... 222s Selecting previously unselected package python3-pluggy. 222s Preparing to unpack .../06-python3-pluggy_1.5.0-1_all.deb ... 222s Unpacking python3-pluggy (1.5.0-1) ... 222s Selecting previously unselected package python3-pytest. 222s Preparing to unpack .../07-python3-pytest_8.3.4-1_all.deb ... 222s Unpacking python3-pytest (8.3.4-1) ... 222s Selecting previously unselected package python3-pytest-asyncio. 222s Preparing to unpack .../08-python3-pytest-asyncio_0.25.1-1_all.deb ... 222s Unpacking python3-pytest-asyncio (0.25.1-1) ... 222s Selecting previously unselected package python3-pytest-mock. 222s Preparing to unpack .../09-python3-pytest-mock_3.14.0-2_all.deb ... 222s Unpacking python3-pytest-mock (3.14.0-2) ... 222s Selecting previously unselected package python3-pytest-timeout. 222s Preparing to unpack .../10-python3-pytest-timeout_2.3.1-1_all.deb ... 222s Unpacking python3-pytest-timeout (2.3.1-1) ... 222s Selecting previously unselected package python3-zigpy-zigate. 222s Preparing to unpack .../11-python3-zigpy-zigate_0.13.2-1_all.deb ... 222s Unpacking python3-zigpy-zigate (0.13.2-1) ... 222s Setting up python3-iniconfig (1.1.1-2) ... 223s Setting up python3.12-minimal (3.12.9-1) ... 223s Setting up python3-async-generator (1.10-4) ... 223s Setting up python3.12 (3.12.9-1) ... 225s Setting up python3-all (3.13.1-1~exp2) ... 225s Setting up python3-zigpy-zigate (0.13.2-1) ... 225s Setting up python3-packaging (24.2-1) ... 225s Setting up python3-pluggy (1.5.0-1) ... 225s Setting up python3-pytest (8.3.4-1) ... 226s Setting up python3-pytest-asyncio (0.25.1-1) ... 226s Setting up python3-pytest-mock (3.14.0-2) ... 226s Setting up python3-pytest-timeout (2.3.1-1) ... 226s Processing triggers for man-db (2.13.0-1) ... 227s Processing triggers for systemd (257.2-3ubuntu1) ... 228s autopkgtest [10:20:50]: test run-tests: [----------------------- 229s /usr/lib/python3/dist-packages/pytest_asyncio/plugin.py:207: PytestDeprecationWarning: The configuration option "asyncio_default_fixture_loop_scope" is unset. 229s 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" 229s 229s warnings.warn(PytestDeprecationWarning(_DEFAULT_FIXTURE_LOOP_SCOPE_UNSET)) 229s ============================= test session starts ============================== 229s platform linux -- Python 3.12.9, pytest-8.3.4, pluggy-1.5.0 -- /usr/bin/python3.12 229s cachedir: .pytest_cache 229s rootdir: /tmp/autopkgtest.jAx5xL/autopkgtest_tmp 229s plugins: timeout-2.3.1, asyncio-0.25.1, typeguard-4.4.1, mock-3.14.0 229s asyncio: mode=Mode.AUTO, asyncio_default_fixture_loop_scope=None 229s collecting ... collected 0 items / 1 error 229s 229s ==================================== ERRORS ==================================== 229s ______________________ ERROR collecting tests/test_api.py ______________________ 229s ImportError while importing test module '/tmp/autopkgtest.jAx5xL/autopkgtest_tmp/tests/test_api.py'. 229s Hint: make sure your test modules/packages have valid Python names. 229s Traceback: 229s /usr/lib/python3.12/importlib/__init__.py:90: in import_module 229s return _bootstrap._gcd_import(name[level:], package, level) 229s tests/test_api.py:5: in 229s import serial_asyncio 229s E ModuleNotFoundError: No module named 'serial_asyncio' 229s =========================== short test summary info ============================ 229s ERROR tests/test_api.py 229s !!!!!!!!!!!!!!!!!!!!!!!!!! stopping after 1 failures !!!!!!!!!!!!!!!!!!!!!!!!!!! 229s =============================== 1 error in 0.03s =============================== 229s autopkgtest [10:20:51]: test run-tests: -----------------------] 230s autopkgtest [10:20:52]: test run-tests: - - - - - - - - - - results - - - - - - - - - - 230s run-tests FAIL non-zero exit status 1 230s autopkgtest [10:20:52]: @@@@@@@@@@@@@@@@@@@@ summary 230s run-tests FAIL non-zero exit status 1 236s nova [W] Skipping flock for amd64 236s Creating nova instance adt-plucky-amd64-zigpy-zigate-20250220-101701-juju-7f2275-prod-proposed-migration-environment-20-18a52546-f014-4fe3-a99c-3de7060a3871 from image adt/ubuntu-plucky-amd64-server-20250220.img (UUID 8ce549f8-ef4a-4335-bf9d-c468a6d98595)... 236s nova [W] Timed out waiting for ba6aeedd-8202-41cf-95b4-6d3351f704fa to get deleted.