0s autopkgtest [10:34:22]: starting date and time: 2024-11-13 10:34:22+0000 0s autopkgtest [10:34:22]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [10:34:22]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.v4oihrwc/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults,src:python3-stdlib-extensions --apt-upgrade pyreflink --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python3-defaults/3.12.7-1 python3-stdlib-extensions/3.12.7-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-19.secgroup --name adt-plucky-amd64-pyreflink-20241113-094740-juju-7f2275-prod-proposed-migration-environment-2-a0a68bc5-abd6-4974-81db-b98cf30e2151 --image adt/ubuntu-plucky-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 367s autopkgtest [10:40:29]: testbed dpkg architecture: amd64 367s autopkgtest [10:40:29]: testbed apt version: 2.9.8 367s autopkgtest [10:40:29]: @@@@@@@@@@@@@@@@@@@@ test bed setup 369s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 369s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 369s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 369s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [849 kB] 369s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.4 kB] 369s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [65.2 kB] 369s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [111 kB] 369s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [32.6 kB] 369s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [255 kB] 369s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [639 kB] 369s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [37.7 kB] 369s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [13.0 kB] 369s Fetched 2175 kB in 1s (2510 kB/s) 370s Reading package lists... 373s Reading package lists... 373s Building dependency tree... 373s Reading state information... 373s Calculating upgrade... 373s The following NEW packages will be installed: 373s python3.13-gdbm 373s The following packages will be upgraded: 373s libgpgme11t64 libpython3-stdlib python3 python3-gdbm python3-minimal 374s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 374s Need to get 253 kB of archives. 374s After this operation, 147 kB of additional disk space will be used. 374s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3-minimal amd64 3.12.7-1 [27.4 kB] 374s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3 amd64 3.12.7-1 [24.0 kB] 374s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 libpython3-stdlib amd64 3.12.7-1 [10.0 kB] 374s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.13-gdbm amd64 3.13.0-2 [31.3 kB] 374s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3-gdbm amd64 3.12.7-1 [8642 B] 374s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 libgpgme11t64 amd64 1.23.2-5ubuntu4 [152 kB] 374s Fetched 253 kB in 0s (607 kB/s) 374s (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 ... 75541 files and directories currently installed.) 374s Preparing to unpack .../python3-minimal_3.12.7-1_amd64.deb ... 374s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 374s Setting up python3-minimal (3.12.7-1) ... 375s (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 ... 75541 files and directories currently installed.) 375s Preparing to unpack .../python3_3.12.7-1_amd64.deb ... 375s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 375s Preparing to unpack .../libpython3-stdlib_3.12.7-1_amd64.deb ... 375s Unpacking libpython3-stdlib:amd64 (3.12.7-1) over (3.12.6-0ubuntu1) ... 375s Selecting previously unselected package python3.13-gdbm. 375s Preparing to unpack .../python3.13-gdbm_3.13.0-2_amd64.deb ... 375s Unpacking python3.13-gdbm (3.13.0-2) ... 375s Preparing to unpack .../python3-gdbm_3.12.7-1_amd64.deb ... 375s Unpacking python3-gdbm:amd64 (3.12.7-1) over (3.12.6-1ubuntu1) ... 375s Preparing to unpack .../libgpgme11t64_1.23.2-5ubuntu4_amd64.deb ... 375s Unpacking libgpgme11t64:amd64 (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ... 375s Setting up libgpgme11t64:amd64 (1.23.2-5ubuntu4) ... 375s Setting up python3.13-gdbm (3.13.0-2) ... 375s Setting up libpython3-stdlib:amd64 (3.12.7-1) ... 375s Setting up python3 (3.12.7-1) ... 375s Setting up python3-gdbm:amd64 (3.12.7-1) ... 375s Processing triggers for man-db (2.12.1-3) ... 376s Processing triggers for libc-bin (2.40-1ubuntu3) ... 376s Reading package lists... 376s Building dependency tree... 376s Reading state information... 376s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 377s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 377s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 377s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 377s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 378s Reading package lists... 378s Reading package lists... 378s Building dependency tree... 378s Reading state information... 378s Calculating upgrade... 378s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 378s Reading package lists... 378s Building dependency tree... 378s Reading state information... 379s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 382s autopkgtest [10:40:44]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 13:41:20 UTC 2024 383s autopkgtest [10:40:45]: @@@@@@@@@@@@@@@@@@@@ apt-source pyreflink 385s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pyreflink 0.2.2-1 (dsc) [1556 B] 385s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pyreflink 0.2.2-1 (tar) [22.0 kB] 385s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pyreflink 0.2.2-1 (diff) [2580 B] 385s gpgv: Signature made Fri Sep 22 08:19:56 2023 UTC 385s gpgv: using EDDSA key EE9AD6F90520FA11F69F4824477B0DB0263A54D8 385s gpgv: issuer "stefanor@debian.org" 385s gpgv: Can't check signature: No public key 385s dpkg-source: warning: cannot verify inline signature for ./pyreflink_0.2.2-1.dsc: no acceptable signature found 385s autopkgtest [10:40:47]: testing package pyreflink version 0.2.2-1 385s autopkgtest [10:40:47]: build not needed 386s autopkgtest [10:40:48]: test unittests3: preparing testbed 388s Reading package lists... 388s Building dependency tree... 388s Reading state information... 388s Starting pkgProblemResolver with broken count: 0 388s Starting 2 pkgProblemResolver with broken count: 0 388s Done 388s The following additional packages will be installed: 388s libpython3.13-minimal libpython3.13-stdlib python3-all python3-iniconfig 388s python3-packaging python3-pluggy python3-pytest python3-reflink python3.13 388s python3.13-minimal 388s Suggested packages: 388s python3.13-venv python3.13-doc binfmt-support 388s The following NEW packages will be installed: 388s autopkgtest-satdep libpython3.13-minimal libpython3.13-stdlib python3-all 388s python3-iniconfig python3-packaging python3-pluggy python3-pytest 388s python3-reflink python3.13 python3.13-minimal 388s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 388s Need to get 6224 kB/6224 kB of archives. 388s After this operation, 24.1 MB of additional disk space will be used. 388s Get:1 /tmp/autopkgtest.uDkbmX/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [720 B] 388s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 libpython3.13-minimal amd64 3.13.0-2 [879 kB] 389s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.13-minimal amd64 3.13.0-2 [2188 kB] 389s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 libpython3.13-stdlib amd64 3.13.0-2 [2107 kB] 389s Get:5 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.13 amd64 3.13.0-2 [719 kB] 389s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3-all amd64 3.12.7-1 [890 B] 389s Get:7 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-iniconfig all 1.1.1-2 [6024 B] 389s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-packaging all 24.1-1 [41.4 kB] 389s Get:9 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pluggy all 1.5.0-1 [21.0 kB] 389s Get:10 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pytest all 8.3.3-1 [251 kB] 389s Get:11 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-reflink amd64 0.2.2-1 [10.3 kB] 390s Fetched 6224 kB in 1s (6270 kB/s) 390s Selecting previously unselected package libpython3.13-minimal:amd64. 390s (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 ... 75548 files and directories currently installed.) 390s Preparing to unpack .../00-libpython3.13-minimal_3.13.0-2_amd64.deb ... 390s Unpacking libpython3.13-minimal:amd64 (3.13.0-2) ... 390s Selecting previously unselected package python3.13-minimal. 390s Preparing to unpack .../01-python3.13-minimal_3.13.0-2_amd64.deb ... 390s Unpacking python3.13-minimal (3.13.0-2) ... 390s Selecting previously unselected package libpython3.13-stdlib:amd64. 390s Preparing to unpack .../02-libpython3.13-stdlib_3.13.0-2_amd64.deb ... 390s Unpacking libpython3.13-stdlib:amd64 (3.13.0-2) ... 390s Selecting previously unselected package python3.13. 390s Preparing to unpack .../03-python3.13_3.13.0-2_amd64.deb ... 390s Unpacking python3.13 (3.13.0-2) ... 390s Selecting previously unselected package python3-all. 390s Preparing to unpack .../04-python3-all_3.12.7-1_amd64.deb ... 390s Unpacking python3-all (3.12.7-1) ... 390s Selecting previously unselected package python3-iniconfig. 390s Preparing to unpack .../05-python3-iniconfig_1.1.1-2_all.deb ... 390s Unpacking python3-iniconfig (1.1.1-2) ... 390s Selecting previously unselected package python3-packaging. 390s Preparing to unpack .../06-python3-packaging_24.1-1_all.deb ... 390s Unpacking python3-packaging (24.1-1) ... 390s Selecting previously unselected package python3-pluggy. 390s Preparing to unpack .../07-python3-pluggy_1.5.0-1_all.deb ... 390s Unpacking python3-pluggy (1.5.0-1) ... 390s Selecting previously unselected package python3-pytest. 390s Preparing to unpack .../08-python3-pytest_8.3.3-1_all.deb ... 390s Unpacking python3-pytest (8.3.3-1) ... 390s Selecting previously unselected package python3-reflink. 390s Preparing to unpack .../09-python3-reflink_0.2.2-1_amd64.deb ... 390s Unpacking python3-reflink (0.2.2-1) ... 390s Selecting previously unselected package autopkgtest-satdep. 390s Preparing to unpack .../10-1-autopkgtest-satdep.deb ... 390s Unpacking autopkgtest-satdep (0) ... 390s Setting up python3-iniconfig (1.1.1-2) ... 390s Setting up libpython3.13-minimal:amd64 (3.13.0-2) ... 390s Setting up python3-packaging (24.1-1) ... 390s Setting up python3-pluggy (1.5.0-1) ... 391s Setting up python3.13-minimal (3.13.0-2) ... 391s Setting up libpython3.13-stdlib:amd64 (3.13.0-2) ... 391s Setting up python3-reflink (0.2.2-1) ... 391s Setting up python3.13 (3.13.0-2) ... 392s Setting up python3-pytest (8.3.3-1) ... 393s Setting up python3-all (3.12.7-1) ... 393s Setting up autopkgtest-satdep (0) ... 393s Processing triggers for man-db (2.12.1-3) ... 393s Processing triggers for systemd (256.5-2ubuntu4) ... 396s (Reading database ... 76466 files and directories currently installed.) 396s Removing autopkgtest-satdep (0) ... 397s autopkgtest [10:40:59]: test unittests3: [----------------------- 397s === python3.13 === 398s ============================= test session starts ============================== 398s platform linux -- Python 3.13.0, pytest-8.3.3, pluggy-1.5.0 398s rootdir: /tmp/autopkgtest.uDkbmX/autopkgtest_tmp 398s plugins: typeguard-4.4.1 398s collected 0 items / 2 errors 398s 398s ==================================== ERRORS ==================================== 398s ____________________ ERROR collecting tests/test_reflink.py ____________________ 398s ImportError while importing test module '/tmp/autopkgtest.uDkbmX/autopkgtest_tmp/tests/test_reflink.py'. 398s Hint: make sure your test modules/packages have valid Python names. 398s Traceback: 398s /usr/lib/python3.13/importlib/__init__.py:88: in import_module 398s return _bootstrap._gcd_import(name[level:], package, level) 398s tests/test_reflink.py:15: in 398s from reflink import reflink 398s /usr/lib/python3/dist-packages/reflink/__init__.py:10: in 398s from .reflink import reflink 398s /usr/lib/python3/dist-packages/reflink/reflink.py:7: in 398s from . import backend 398s /usr/lib/python3/dist-packages/reflink/backend.py:4: in 398s from ._backend import ffi # Ignore PyLintBear (E0611) 398s E ModuleNotFoundError: No module named '_cffi_backend' 398s ____________________ ERROR collecting tests/test_reflink.py ____________________ 398s ImportError while importing test module '/tmp/autopkgtest.uDkbmX/autopkgtest_tmp/tests/test_reflink.py'. 398s Hint: make sure your test modules/packages have valid Python names. 398s Traceback: 398s /usr/lib/python3.13/importlib/__init__.py:88: in import_module 398s return _bootstrap._gcd_import(name[level:], package, level) 398s tests/test_reflink.py:15: in 398s from reflink import reflink 398s /usr/lib/python3/dist-packages/reflink/__init__.py:10: in 398s from .reflink import reflink 398s /usr/lib/python3/dist-packages/reflink/reflink.py:7: in 398s from . import backend 398s /usr/lib/python3/dist-packages/reflink/backend.py:4: in 398s from ._backend import ffi # Ignore PyLintBear (E0611) 398s E ModuleNotFoundError: No module named '_cffi_backend' 398s =========================== short test summary info ============================ 398s ERROR tests/test_reflink.py 398s ERROR tests/test_reflink.py 398s !!!!!!!!!!!!!!!!!!! Interrupted: 2 errors during collection !!!!!!!!!!!!!!!!!!!! 398s ============================== 2 errors in 0.10s =============================== 398s autopkgtest [10:41:00]: test unittests3: -----------------------] 399s autopkgtest [10:41:01]: test unittests3: - - - - - - - - - - results - - - - - - - - - - 399s unittests3 FAIL non-zero exit status 2 399s autopkgtest [10:41:01]: test root-tests: preparing testbed 400s Reading package lists... 401s Building dependency tree... 401s Reading state information... 401s Starting pkgProblemResolver with broken count: 0 401s Starting 2 pkgProblemResolver with broken count: 0 401s Done 401s The following NEW packages will be installed: 401s autopkgtest-satdep 401s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 401s Need to get 0 B/732 B of archives. 401s After this operation, 0 B of additional disk space will be used. 401s Get:1 /tmp/autopkgtest.uDkbmX/2-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [732 B] 402s Selecting previously unselected package autopkgtest-satdep. 402s (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 ... 76466 files and directories currently installed.) 402s Preparing to unpack .../2-autopkgtest-satdep.deb ... 402s Unpacking autopkgtest-satdep (0) ... 402s Setting up autopkgtest-satdep (0) ... 404s (Reading database ... 76466 files and directories currently installed.) 404s Removing autopkgtest-satdep (0) ... 404s autopkgtest [10:41:06]: test root-tests: [----------------------- 404s === python3.13 === 405s ============================= test session starts ============================== 405s platform linux -- Python 3.13.0, pytest-8.3.3, pluggy-1.5.0 405s rootdir: /tmp/autopkgtest.uDkbmX/autopkgtest_tmp 405s plugins: typeguard-4.4.1 405s collected 0 items / 2 errors 405s 405s ==================================== ERRORS ==================================== 405s ____________________ ERROR collecting tests/test_reflink.py ____________________ 405s ImportError while importing test module '/tmp/autopkgtest.uDkbmX/autopkgtest_tmp/tests/test_reflink.py'. 405s Hint: make sure your test modules/packages have valid Python names. 405s Traceback: 405s /usr/lib/python3.13/importlib/__init__.py:88: in import_module 405s return _bootstrap._gcd_import(name[level:], package, level) 405s tests/test_reflink.py:15: in 405s from reflink import reflink 405s /usr/lib/python3/dist-packages/reflink/__init__.py:10: in 405s from .reflink import reflink 405s /usr/lib/python3/dist-packages/reflink/reflink.py:7: in 405s from . import backend 405s /usr/lib/python3/dist-packages/reflink/backend.py:4: in 405s from ._backend import ffi # Ignore PyLintBear (E0611) 405s E ModuleNotFoundError: No module named '_cffi_backend' 405s ____________________ ERROR collecting tests/test_reflink.py ____________________ 405s ImportError while importing test module '/tmp/autopkgtest.uDkbmX/autopkgtest_tmp/tests/test_reflink.py'. 405s Hint: make sure your test modules/packages have valid Python names. 405s Traceback: 405s /usr/lib/python3.13/importlib/__init__.py:88: in import_module 405s return _bootstrap._gcd_import(name[level:], package, level) 405s tests/test_reflink.py:15: in 405s from reflink import reflink 405s /usr/lib/python3/dist-packages/reflink/__init__.py:10: in 405s from .reflink import reflink 405s /usr/lib/python3/dist-packages/reflink/reflink.py:7: in 405s from . import backend 405s /usr/lib/python3/dist-packages/reflink/backend.py:4: in 405s from ._backend import ffi # Ignore PyLintBear (E0611) 405s E ModuleNotFoundError: No module named '_cffi_backend' 405s =========================== short test summary info ============================ 405s ERROR tests/test_reflink.py 405s ERROR tests/test_reflink.py 405s !!!!!!!!!!!!!!!!!!! Interrupted: 2 errors during collection !!!!!!!!!!!!!!!!!!!! 405s ============================== 2 errors in 0.09s =============================== 405s autopkgtest [10:41:07]: test root-tests: -----------------------] 406s root-tests FAIL non-zero exit status 2 406s autopkgtest [10:41:08]: test root-tests: - - - - - - - - - - results - - - - - - - - - - 406s autopkgtest [10:41:08]: @@@@@@@@@@@@@@@@@@@@ summary 406s unittests3 FAIL non-zero exit status 2 406s root-tests FAIL non-zero exit status 2 422s virt: nova [W] Skipping flock for amd64 422s virt: Creating nova instance adt-plucky-amd64-pyreflink-20241113-094740-juju-7f2275-prod-proposed-migration-environment-2-a0a68bc5-abd6-4974-81db-b98cf30e2151 from image adt/ubuntu-plucky-amd64-server-20241113.img (UUID 62c21ac4-2290-4c8d-8313-dddd18eacff4)... 422s virt: nova [W] nova quota exceeded (attempt #0)