0s autopkgtest [10:37:04]: starting date and time: 2024-11-13 10:37:04+0000 0s autopkgtest [10:37:04]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [10:37:04]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.9xhdhee6/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 python-llfuse --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 autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-2.secgroup --name adt-plucky-arm64-python-llfuse-20241113-103703-juju-7f2275-prod-proposed-migration-environment-2-33b2a48c-dbd7-4165-821c-221ebc30e656 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 87s autopkgtest [10:38:31]: testbed dpkg architecture: arm64 87s autopkgtest [10:38:31]: testbed apt version: 2.9.8 87s autopkgtest [10:38:31]: @@@@@@@@@@@@@@@@@@@@ test bed setup 88s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 88s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 88s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 88s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.4 kB] 88s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [849 kB] 89s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [104 kB] 89s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [50.3 kB] 89s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [601 kB] 89s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [17.1 kB] 89s Fetched 1794 kB in 1s (2040 kB/s) 89s Reading package lists... 92s Reading package lists... 92s Building dependency tree... 92s Reading state information... 93s Calculating upgrade... 93s The following NEW packages will be installed: 93s python3.13-gdbm 93s The following packages will be upgraded: 93s libpython3-stdlib python3 python3-gdbm python3-minimal 94s 4 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 94s Need to get 101 kB of archives. 94s After this operation, 141 kB of additional disk space will be used. 94s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3-minimal arm64 3.12.7-1 [27.4 kB] 94s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3 arm64 3.12.7-1 [24.0 kB] 94s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libpython3-stdlib arm64 3.12.7-1 [10.0 kB] 94s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 python3.13-gdbm arm64 3.13.0-2 [30.7 kB] 94s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3-gdbm arm64 3.12.7-1 [8642 B] 94s Fetched 101 kB in 0s (289 kB/s) 95s (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 ... 79924 files and directories currently installed.) 95s Preparing to unpack .../python3-minimal_3.12.7-1_arm64.deb ... 95s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 95s Setting up python3-minimal (3.12.7-1) ... 95s (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 ... 79924 files and directories currently installed.) 95s Preparing to unpack .../python3_3.12.7-1_arm64.deb ... 95s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 95s Preparing to unpack .../libpython3-stdlib_3.12.7-1_arm64.deb ... 95s Unpacking libpython3-stdlib:arm64 (3.12.7-1) over (3.12.6-0ubuntu1) ... 95s Selecting previously unselected package python3.13-gdbm. 95s Preparing to unpack .../python3.13-gdbm_3.13.0-2_arm64.deb ... 95s Unpacking python3.13-gdbm (3.13.0-2) ... 95s Preparing to unpack .../python3-gdbm_3.12.7-1_arm64.deb ... 95s Unpacking python3-gdbm:arm64 (3.12.7-1) over (3.12.6-1ubuntu1) ... 95s Setting up python3.13-gdbm (3.13.0-2) ... 95s Setting up libpython3-stdlib:arm64 (3.12.7-1) ... 95s Setting up python3 (3.12.7-1) ... 95s Setting up python3-gdbm:arm64 (3.12.7-1) ... 95s Processing triggers for man-db (2.12.1-3) ... 96s Reading package lists... 97s Building dependency tree... 97s Reading state information... 97s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 98s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 98s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 98s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 98s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 99s Reading package lists... 99s Reading package lists... 99s Building dependency tree... 99s Reading state information... 100s Calculating upgrade... 100s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 100s Reading package lists... 101s Building dependency tree... 101s Reading state information... 101s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 105s autopkgtest [10:38:49]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 14:19:41 UTC 2024 105s autopkgtest [10:38:49]: @@@@@@@@@@@@@@@@@@@@ apt-source python-llfuse 107s Get:1 http://ftpmaster.internal/ubuntu plucky/universe python-llfuse 1.5.0+dfsg-1 (dsc) [2360 B] 107s Get:2 http://ftpmaster.internal/ubuntu plucky/universe python-llfuse 1.5.0+dfsg-1 (tar) [218 kB] 107s Get:3 http://ftpmaster.internal/ubuntu plucky/universe python-llfuse 1.5.0+dfsg-1 (diff) [145 kB] 108s gpgv: Signature made Sat Sep 14 23:39:23 2024 UTC 108s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 108s gpgv: issuer "tchet@debian.org" 108s gpgv: Can't check signature: No public key 108s dpkg-source: warning: cannot verify inline signature for ./python-llfuse_1.5.0+dfsg-1.dsc: no acceptable signature found 108s autopkgtest [10:38:52]: testing package python-llfuse version 1.5.0+dfsg-1 108s autopkgtest [10:38:52]: build not needed 109s autopkgtest [10:38:53]: test upstream-standard: preparing testbed 110s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s Starting pkgProblemResolver with broken count: 0 111s Starting 2 pkgProblemResolver with broken count: 0 111s Done 112s The following additional packages will be installed: 112s libfuse2t64 python3-iniconfig python3-llfuse python3-packaging 112s python3-pluggy python3-pytest 112s Suggested packages: 112s python-llfuse-doc 112s The following NEW packages will be installed: 112s autopkgtest-satdep libfuse2t64 python3-iniconfig python3-llfuse 112s python3-packaging python3-pluggy python3-pytest 112s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 112s Need to get 597 kB/598 kB of archives. 112s After this operation, 2599 kB of additional disk space will be used. 112s Get:1 /tmp/autopkgtest.VhAIcq/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [716 B] 112s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 libfuse2t64 arm64 2.9.9-9 [90.4 kB] 112s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-iniconfig all 1.1.1-2 [6024 B] 112s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-llfuse arm64 1.5.0+dfsg-1 [187 kB] 112s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-packaging all 24.1-1 [41.4 kB] 112s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pluggy all 1.5.0-1 [21.0 kB] 112s Get:7 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pytest all 8.3.3-1 [251 kB] 113s Fetched 597 kB in 1s (1147 kB/s) 113s Selecting previously unselected package libfuse2t64:arm64. 113s (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 ... 79931 files and directories currently installed.) 113s Preparing to unpack .../0-libfuse2t64_2.9.9-9_arm64.deb ... 113s Adding 'diversion of /lib/aarch64-linux-gnu/libfuse.so.2 to /lib/aarch64-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64' 113s Adding 'diversion of /lib/aarch64-linux-gnu/libfuse.so.2.9.9 to /lib/aarch64-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64' 113s Adding 'diversion of /lib/aarch64-linux-gnu/libulockmgr.so.1 to /lib/aarch64-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64' 113s Adding 'diversion of /lib/aarch64-linux-gnu/libulockmgr.so.1.0.1 to /lib/aarch64-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64' 113s Unpacking libfuse2t64:arm64 (2.9.9-9) ... 113s Selecting previously unselected package python3-iniconfig. 113s Preparing to unpack .../1-python3-iniconfig_1.1.1-2_all.deb ... 113s Unpacking python3-iniconfig (1.1.1-2) ... 113s Selecting previously unselected package python3-llfuse:arm64. 113s Preparing to unpack .../2-python3-llfuse_1.5.0+dfsg-1_arm64.deb ... 113s Unpacking python3-llfuse:arm64 (1.5.0+dfsg-1) ... 113s Selecting previously unselected package python3-packaging. 113s Preparing to unpack .../3-python3-packaging_24.1-1_all.deb ... 113s Unpacking python3-packaging (24.1-1) ... 113s Selecting previously unselected package python3-pluggy. 113s Preparing to unpack .../4-python3-pluggy_1.5.0-1_all.deb ... 113s Unpacking python3-pluggy (1.5.0-1) ... 113s Selecting previously unselected package python3-pytest. 113s Preparing to unpack .../5-python3-pytest_8.3.3-1_all.deb ... 113s Unpacking python3-pytest (8.3.3-1) ... 113s Selecting previously unselected package autopkgtest-satdep. 113s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 113s Unpacking autopkgtest-satdep (0) ... 113s Setting up python3-iniconfig (1.1.1-2) ... 113s Setting up python3-packaging (24.1-1) ... 114s Setting up python3-pluggy (1.5.0-1) ... 114s Setting up libfuse2t64:arm64 (2.9.9-9) ... 114s Removing 'diversion of /lib/aarch64-linux-gnu/libfuse.so.2 to /lib/aarch64-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64' 114s Removing 'diversion of /lib/aarch64-linux-gnu/libfuse.so.2.9.9 to /lib/aarch64-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64' 114s Removing 'diversion of /lib/aarch64-linux-gnu/libulockmgr.so.1 to /lib/aarch64-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64' 114s Removing 'diversion of /lib/aarch64-linux-gnu/libulockmgr.so.1.0.1 to /lib/aarch64-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64' 114s Setting up python3-pytest (8.3.3-1) ... 114s Setting up python3-llfuse:arm64 (1.5.0+dfsg-1) ... 114s Setting up autopkgtest-satdep (0) ... 114s Processing triggers for man-db (2.12.1-3) ... 114s Processing triggers for libc-bin (2.40-1ubuntu3) ... 118s (Reading database ... 80118 files and directories currently installed.) 118s Removing autopkgtest-satdep (0) ... 119s autopkgtest [10:39:03]: test upstream-standard: [----------------------- 119s ============================= test session starts ============================== 119s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 -- /usr/bin/python3 119s cachedir: .pytest_cache 119s rootdir: /tmp/autopkgtest.VhAIcq/build.RIm/src/test 119s configfile: pytest.ini 119s plugins: typeguard-4.4.1 119s collecting ... collected 15 items 119s 119s test/test_api.py::test_inquire_bits PASSED [ 6%] 119s test/test_api.py::test_listdir PASSED [ 13%] 119s test/test_api.py::test_sup_groups PASSED [ 20%] 119s test/test_api.py::test_entry_res PASSED [ 26%] 119s test/test_api.py::test_xattr PASSED [ 33%] 120s test/test_api.py::test_copy PASSED [ 40%] 120s test/test_examples.py::test_lltest PASSED [ 46%] 120s test/test_examples.py::test_tmpfs PASSED [ 53%] 120s test/test_examples.py::test_passthroughfs PASSED [ 60%] 121s test/test_fs.py::test_invalidate_entry PASSED [ 66%] 121s test/test_fs.py::test_invalidate_inode PASSED [ 73%] 121s test/test_fs.py::test_notify_store PASSED [ 80%] 122s test/test_fs.py::test_entry_timeout PASSED [ 86%] 124s test/test_fs.py::test_attr_timeout PASSED [ 93%] 124s test/test_rounding.py::test_rounding PASSED [100%] 124s 124s ============================== 15 passed in 4.57s ============================== 124s autopkgtest [10:39:08]: test upstream-standard: -----------------------] 125s upstream-standard PASS 125s autopkgtest [10:39:09]: test upstream-standard: - - - - - - - - - - results - - - - - - - - - - 125s autopkgtest [10:39:09]: test upstream-with-fuse: preparing testbed 127s Reading package lists... 128s Building dependency tree... 128s Reading state information... 128s Starting pkgProblemResolver with broken count: 0 128s Starting 2 pkgProblemResolver with broken count: 0 128s Done 129s The following NEW packages will be installed: 129s autopkgtest-satdep 129s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 129s Need to get 0 B/716 B of archives. 129s After this operation, 0 B of additional disk space will be used. 129s Get:1 /tmp/autopkgtest.VhAIcq/2-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [716 B] 129s Selecting previously unselected package autopkgtest-satdep. 129s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 80118 files and directories currently installed.) 129s Preparing to unpack .../2-autopkgtest-satdep.deb ... 129s Unpacking autopkgtest-satdep (0) ... 129s Setting up autopkgtest-satdep (0) ... 132s (Reading database ... 80118 files and directories currently installed.) 132s Removing autopkgtest-satdep (0) ... 133s autopkgtest [10:39:17]: test upstream-with-fuse: [----------------------- 133s ============================= test session starts ============================== 133s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 -- /usr/bin/python3 133s cachedir: .pytest_cache 133s rootdir: /tmp/autopkgtest.VhAIcq/build.RIm/src/test 133s configfile: pytest.ini 133s plugins: typeguard-4.4.1 133s collecting ... collected 15 items 133s 133s test/test_api.py::test_inquire_bits PASSED [ 6%] 133s test/test_api.py::test_listdir PASSED [ 13%] 133s test/test_api.py::test_sup_groups PASSED [ 20%] 133s test/test_api.py::test_entry_res PASSED [ 26%] 133s test/test_api.py::test_xattr PASSED [ 33%] 133s test/test_api.py::test_copy PASSED [ 40%] 134s test/test_examples.py::test_lltest PASSED [ 46%] 134s test/test_examples.py::test_tmpfs PASSED [ 53%] 134s test/test_examples.py::test_passthroughfs PASSED [ 60%] 134s test/test_fs.py::test_invalidate_entry PASSED [ 66%] 135s test/test_fs.py::test_invalidate_inode PASSED [ 73%] 135s test/test_fs.py::test_notify_store PASSED [ 80%] 136s test/test_fs.py::test_entry_timeout PASSED [ 86%] 138s test/test_fs.py::test_attr_timeout PASSED [ 93%] 138s test/test_rounding.py::test_rounding PASSED [100%] 138s 138s ============================== 15 passed in 4.40s ============================== 138s autopkgtest [10:39:22]: test upstream-with-fuse: -----------------------] 139s upstream-with-fuse PASS 139s autopkgtest [10:39:23]: test upstream-with-fuse: - - - - - - - - - - results - - - - - - - - - - 139s autopkgtest [10:39:23]: @@@@@@@@@@@@@@@@@@@@ summary 139s upstream-standard PASS 139s upstream-with-fuse PASS 162s virt: nova [W] Skipping flock in bos03-arm64 162s virt: Creating nova instance adt-plucky-arm64-python-llfuse-20241113-103703-juju-7f2275-prod-proposed-migration-environment-2-33b2a48c-dbd7-4165-821c-221ebc30e656 from image adt/ubuntu-plucky-arm64-server-20241113.img (UUID 2d7760e6-2439-4200-89d6-5ed33e5c6330)...