0s autopkgtest [16:45:33]: starting date and time: 2025-02-19 16:45:33+0000 0s autopkgtest [16:45:33]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [16:45:33]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.jna7wl26/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:sphinx --apt-upgrade pyfuse3 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/8.1.3-5 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-ppc64el-13.secgroup --name adt-plucky-ppc64el-pyfuse3-20250219-164533-juju-7f2275-prod-proposed-migration-environment-2-0ab60de2-4e7f-496c-ac63-5aa98ad33b80 --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -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/ 110s autopkgtest [16:47:23]: testbed dpkg architecture: ppc64el 110s autopkgtest [16:47:23]: testbed apt version: 2.9.29 110s autopkgtest [16:47:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 110s autopkgtest [16:47:23]: testbed release detected to be: None 111s autopkgtest [16:47:24]: updating testbed package index (apt update) 112s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 112s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 112s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 112s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 112s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB] 112s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [73.1 kB] 112s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [732 kB] 112s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 112s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [96.5 kB] 112s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el Packages [760 B] 112s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [667 kB] 112s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [5760 B] 113s Fetched 1703 kB in 1s (1656 kB/s) 114s Reading package lists... 114s Reading package lists... 115s Building dependency tree... 115s Reading state information... 115s Calculating upgrade... 115s The following NEW packages will be installed: 115s libapt-pkg7.0 115s The following packages will be upgraded: 115s apt apt-utils dhcpcd-base iproute2 libgpgme11t64 liblsof0 libp11-kit0 lsof 115s rsyslog sysvinit-utils 116s 10 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 116s Need to get 5997 kB of archives. 116s After this operation, 3932 kB of additional disk space will be used. 116s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el sysvinit-utils ppc64el 3.14-1ubuntu1 [37.0 kB] 116s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libapt-pkg7.0 ppc64el 2.9.30 [1152 kB] 116s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el apt ppc64el 2.9.30 [1439 kB] 116s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el apt-utils ppc64el 2.9.30 [228 kB] 116s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el dhcpcd-base ppc64el 1:10.1.0-7 [280 kB] 116s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el iproute2 ppc64el 6.13.0-1ubuntu1 [1419 kB] 116s Get:7 http://ftpmaster.internal/ubuntu plucky/main ppc64el libp11-kit0 ppc64el 0.25.5-2ubuntu3 [309 kB] 116s Get:8 http://ftpmaster.internal/ubuntu plucky/main ppc64el rsyslog ppc64el 8.2412.0-2ubuntu1 [632 kB] 116s Get:9 http://ftpmaster.internal/ubuntu plucky/main ppc64el lsof ppc64el 4.99.4+dfsg-1 [255 kB] 116s Get:10 http://ftpmaster.internal/ubuntu plucky/main ppc64el liblsof0 ppc64el 4.99.4+dfsg-1 [68.4 kB] 116s Get:11 http://ftpmaster.internal/ubuntu plucky/main ppc64el libgpgme11t64 ppc64el 1.24.2-1ubuntu1 [177 kB] 117s Preconfiguring packages ... 117s Fetched 5997 kB in 1s (7253 kB/s) 118s (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 ... 106322 files and directories currently installed.) 118s Preparing to unpack .../sysvinit-utils_3.14-1ubuntu1_ppc64el.deb ... 118s Unpacking sysvinit-utils (3.14-1ubuntu1) over (3.08-6ubuntu3) ... 118s Setting up sysvinit-utils (3.14-1ubuntu1) ... 118s Selecting previously unselected package libapt-pkg7.0:ppc64el. 118s (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 ... 106322 files and directories currently installed.) 118s Preparing to unpack .../libapt-pkg7.0_2.9.30_ppc64el.deb ... 118s Unpacking libapt-pkg7.0:ppc64el (2.9.30) ... 118s Setting up libapt-pkg7.0:ppc64el (2.9.30) ... 118s (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 ... 106371 files and directories currently installed.) 118s Preparing to unpack .../apt_2.9.30_ppc64el.deb ... 118s Unpacking apt (2.9.30) over (2.9.29) ... 118s Setting up apt (2.9.30) ... 119s (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 ... 106371 files and directories currently installed.) 119s Preparing to unpack .../0-apt-utils_2.9.30_ppc64el.deb ... 119s Unpacking apt-utils (2.9.30) over (2.9.29) ... 120s Preparing to unpack .../1-dhcpcd-base_1%3a10.1.0-7_ppc64el.deb ... 120s Unpacking dhcpcd-base (1:10.1.0-7) over (1:10.1.0-6) ... 120s Preparing to unpack .../2-iproute2_6.13.0-1ubuntu1_ppc64el.deb ... 120s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ... 120s Preparing to unpack .../3-libp11-kit0_0.25.5-2ubuntu3_ppc64el.deb ... 120s Unpacking libp11-kit0:ppc64el (0.25.5-2ubuntu3) over (0.25.5-2ubuntu2) ... 120s Preparing to unpack .../4-rsyslog_8.2412.0-2ubuntu1_ppc64el.deb ... 120s Unpacking rsyslog (8.2412.0-2ubuntu1) over (8.2412.0-1ubuntu1) ... 120s Preparing to unpack .../5-lsof_4.99.4+dfsg-1_ppc64el.deb ... 120s Unpacking lsof (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ... 120s Preparing to unpack .../6-liblsof0_4.99.4+dfsg-1_ppc64el.deb ... 120s Unpacking liblsof0 (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ... 120s Preparing to unpack .../7-libgpgme11t64_1.24.2-1ubuntu1_ppc64el.deb ... 120s Unpacking libgpgme11t64:ppc64el (1.24.2-1ubuntu1) over (1.24.1-4ubuntu1) ... 120s Setting up apt-utils (2.9.30) ... 120s Setting up liblsof0 (4.99.4+dfsg-1) ... 120s Setting up iproute2 (6.13.0-1ubuntu1) ... 121s Setting up rsyslog (8.2412.0-2ubuntu1) ... 121s info: The user `syslog' is already a member of `adm'. 123s Setting up libp11-kit0:ppc64el (0.25.5-2ubuntu3) ... 123s Setting up dhcpcd-base (1:10.1.0-7) ... 123s Setting up lsof (4.99.4+dfsg-1) ... 123s Setting up libgpgme11t64:ppc64el (1.24.2-1ubuntu1) ... 123s Processing triggers for man-db (2.13.0-1) ... 127s Processing triggers for libc-bin (2.40-4ubuntu1) ... 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 130s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 130s autopkgtest [16:47:43]: 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 133s 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... 134s Starting pkgProblemResolver with broken count: 0 134s Starting 2 pkgProblemResolver with broken count: 0 134s Done 135s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 135s autopkgtest [16:47:48]: rebooting testbed after setup commands that affected boot 169s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 180s autopkgtest [16:48:33]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 16:32:08 UTC 2025 182s autopkgtest [16:48:35]: @@@@@@@@@@@@@@@@@@@@ apt-source pyfuse3 186s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pyfuse3 3.4.0-3build1 (dsc) [2336 B] 186s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pyfuse3 3.4.0-3build1 (tar) [963 kB] 186s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pyfuse3 3.4.0-3build1 (diff) [98.5 kB] 186s gpgv: Signature made Thu Nov 14 18:29:45 2024 UTC 186s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 186s gpgv: Can't check signature: No public key 186s dpkg-source: warning: cannot verify inline signature for ./pyfuse3_3.4.0-3build1.dsc: no acceptable signature found 187s autopkgtest [16:48:40]: testing package pyfuse3 version 3.4.0-3build1 187s autopkgtest [16:48:40]: build not needed 190s autopkgtest [16:48:43]: test upstream-standard: preparing testbed 190s Reading package lists... 191s Building dependency tree... 191s Reading state information... 191s Starting pkgProblemResolver with broken count: 0 191s Starting 2 pkgProblemResolver with broken count: 0 191s Done 191s The following NEW packages will be installed: 191s python3-iniconfig python3-outcome python3-packaging python3-pluggy 191s python3-pyfuse3 python3-pytest python3-sniffio python3-sortedcontainers 191s python3-trio 191s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 191s Need to get 962 kB of archives. 191s After this operation, 5182 kB of additional disk space will be used. 191s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-iniconfig all 1.1.1-2 [6024 B] 191s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-outcome all 1.2.0-1.1 [5968 B] 191s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-packaging all 24.2-1 [51.5 kB] 192s Get:4 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-pluggy all 1.5.0-1 [21.0 kB] 192s Get:5 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-sniffio all 1.3.1-1 [7262 B] 192s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-sortedcontainers all 2.4.0-2 [27.6 kB] 192s Get:7 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-trio all 0.27.0-1 [322 kB] 192s Get:8 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-pyfuse3 ppc64el 3.4.0-3build1 [269 kB] 192s Get:9 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-pytest all 8.3.4-1 [252 kB] 193s Fetched 962 kB in 1s (1472 kB/s) 193s Selecting previously unselected package python3-iniconfig. 193s (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 ... 106372 files and directories currently installed.) 193s Preparing to unpack .../0-python3-iniconfig_1.1.1-2_all.deb ... 193s Unpacking python3-iniconfig (1.1.1-2) ... 193s Selecting previously unselected package python3-outcome. 193s Preparing to unpack .../1-python3-outcome_1.2.0-1.1_all.deb ... 193s Unpacking python3-outcome (1.2.0-1.1) ... 193s Selecting previously unselected package python3-packaging. 193s Preparing to unpack .../2-python3-packaging_24.2-1_all.deb ... 193s Unpacking python3-packaging (24.2-1) ... 193s Selecting previously unselected package python3-pluggy. 193s Preparing to unpack .../3-python3-pluggy_1.5.0-1_all.deb ... 193s Unpacking python3-pluggy (1.5.0-1) ... 193s Selecting previously unselected package python3-sniffio. 193s Preparing to unpack .../4-python3-sniffio_1.3.1-1_all.deb ... 193s Unpacking python3-sniffio (1.3.1-1) ... 193s Selecting previously unselected package python3-sortedcontainers. 193s Preparing to unpack .../5-python3-sortedcontainers_2.4.0-2_all.deb ... 193s Unpacking python3-sortedcontainers (2.4.0-2) ... 193s Selecting previously unselected package python3-trio. 193s Preparing to unpack .../6-python3-trio_0.27.0-1_all.deb ... 193s Unpacking python3-trio (0.27.0-1) ... 193s Selecting previously unselected package python3-pyfuse3. 193s Preparing to unpack .../7-python3-pyfuse3_3.4.0-3build1_ppc64el.deb ... 193s Unpacking python3-pyfuse3 (3.4.0-3build1) ... 193s Selecting previously unselected package python3-pytest. 193s Preparing to unpack .../8-python3-pytest_8.3.4-1_all.deb ... 193s Unpacking python3-pytest (8.3.4-1) ... 194s Setting up python3-iniconfig (1.1.1-2) ... 194s Setting up python3-sniffio (1.3.1-1) ... 194s Setting up python3-outcome (1.2.0-1.1) ... 194s Setting up python3-sortedcontainers (2.4.0-2) ... 194s Setting up python3-packaging (24.2-1) ... 194s Setting up python3-trio (0.27.0-1) ... 195s Setting up python3-pluggy (1.5.0-1) ... 195s Setting up python3-pyfuse3 (3.4.0-3build1) ... 195s Setting up python3-pytest (8.3.4-1) ... 196s Processing triggers for man-db (2.13.0-1) ... 198s autopkgtest [16:48:51]: test upstream-standard: [----------------------- 199s ============================= test session starts ============================== 199s platform linux -- Python 3.13.2, pytest-8.3.4, pluggy-1.5.0 -- /usr/bin/python3 199s cachedir: .pytest_cache 199s rootdir: /tmp/autopkgtest.MaxydY/build.8RS/src/test 199s configfile: pytest.ini 199s plugins: typeguard-4.4.1 199s collecting ... collected 17 items 199s 199s test/test_api.py::test_listdir PASSED [ 5%] 199s test/test_api.py::test_sup_groups PASSED [ 11%] 200s test/test_api.py::test_syncfs PASSED [ 17%] 200s test/test_api.py::test_entry_res PASSED [ 23%] 200s test/test_api.py::test_xattr PASSED [ 29%] 200s test/test_api.py::test_copy PASSED [ 35%] 200s test/test_examples.py::test_hello[hello.py] PASSED [ 41%] 200s test/test_examples.py::test_hello[hello_asyncio.py] PASSED [ 47%] 200s test/test_examples.py::test_tmpfs PASSED [ 52%] 201s test/test_examples.py::test_passthroughfs PASSED [ 58%] 202s test/test_fs.py::test_invalidate_entry PASSED [ 64%] 202s test/test_fs.py::test_invalidate_inode PASSED [ 70%] 202s test/test_fs.py::test_notify_store PASSED [ 76%] 204s test/test_fs.py::test_entry_timeout PASSED [ 82%] 205s test/test_fs.py::test_attr_timeout PASSED [ 88%] 205s test/test_fs.py::test_terminate PASSED [ 94%] 205s test/test_rounding.py::test_rounding PASSED [100%] 205s 205s ============================== 17 passed in 6.14s ============================== 206s autopkgtest [16:48:59]: test upstream-standard: -----------------------] 206s autopkgtest [16:48:59]: test upstream-standard: - - - - - - - - - - results - - - - - - - - - - 206s upstream-standard PASS 206s autopkgtest [16:48:59]: test upstream-with-fuse: preparing testbed 207s Reading package lists... 207s Building dependency tree... 207s Reading state information... 207s Starting pkgProblemResolver with broken count: 0 207s Starting 2 pkgProblemResolver with broken count: 0 207s Done 208s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 209s autopkgtest [16:49:02]: test upstream-with-fuse: [----------------------- 209s ============================= test session starts ============================== 209s platform linux -- Python 3.13.2, pytest-8.3.4, pluggy-1.5.0 -- /usr/bin/python3 209s cachedir: .pytest_cache 209s rootdir: /tmp/autopkgtest.MaxydY/build.8RS/src/test 209s configfile: pytest.ini 209s plugins: typeguard-4.4.1 209s collecting ... collected 17 items 209s 209s test/test_api.py::test_listdir PASSED [ 5%] 209s test/test_api.py::test_sup_groups PASSED [ 11%] 209s test/test_api.py::test_syncfs PASSED [ 17%] 209s test/test_api.py::test_entry_res PASSED [ 23%] 209s test/test_api.py::test_xattr PASSED [ 29%] 209s test/test_api.py::test_copy PASSED [ 35%] 210s test/test_examples.py::test_hello[hello.py] PASSED [ 41%] 210s test/test_examples.py::test_hello[hello_asyncio.py] PASSED [ 47%] 210s test/test_examples.py::test_tmpfs PASSED [ 52%] 211s test/test_examples.py::test_passthroughfs PASSED [ 58%] 212s test/test_fs.py::test_invalidate_entry PASSED [ 64%] 212s test/test_fs.py::test_invalidate_inode PASSED [ 70%] 213s test/test_fs.py::test_notify_store PASSED [ 76%] 214s test/test_fs.py::test_entry_timeout PASSED [ 82%] 215s test/test_fs.py::test_attr_timeout PASSED [ 88%] 215s test/test_fs.py::test_terminate PASSED [ 94%] 215s test/test_rounding.py::test_rounding PASSED [100%] 215s 215s ============================== 17 passed in 6.10s ============================== 216s autopkgtest [16:49:09]: test upstream-with-fuse: -----------------------] 216s autopkgtest [16:49:09]: test upstream-with-fuse: - - - - - - - - - - results - - - - - - - - - - 216s upstream-with-fuse PASS 217s autopkgtest [16:49:10]: @@@@@@@@@@@@@@@@@@@@ summary 217s upstream-standard PASS 217s upstream-with-fuse PASS 222s nova [W] Using flock in prodstack6-ppc64el 222s Creating nova instance adt-plucky-ppc64el-pyfuse3-20250219-164533-juju-7f2275-prod-proposed-migration-environment-2-0ab60de2-4e7f-496c-ac63-5aa98ad33b80 from image adt/ubuntu-plucky-ppc64el-server-20250218.img (UUID 9318aa34-3d3c-43c5-86d2-aaf9390f2f5d)... 222s nova [W] Timed out waiting for 4b81e6c2-abb6-45c8-a60a-5b7295a019fd to get deleted.