0s autopkgtest [21:33:38]: starting date and time: 2024-11-14 21:33:38+0000 0s autopkgtest [21:33:38]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [21:33:38]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.lc5sa3az/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python-llfuse --apt-upgrade python-llfuse --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python-llfuse/1.5.0+dfsg-1build1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-31.secgroup --name adt-plucky-s390x-python-llfuse-20241114-213338-juju-7f2275-prod-proposed-migration-environment-15-e214a157-ee94-4384-b098-a6f69cbd6fd9 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-s390x -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/ 113s autopkgtest [21:35:31]: testbed dpkg architecture: s390x 113s autopkgtest [21:35:31]: testbed apt version: 2.9.8 113s autopkgtest [21:35:31]: @@@@@@@@@@@@@@@@@@@@ test bed setup 114s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 114s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 114s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1037 kB] 114s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [16.1 kB] 114s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [106 kB] 114s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [126 kB] 114s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [745 kB] 114s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [4648 B] 114s Fetched 2117 kB in 1s (2519 kB/s) 114s Reading package lists... 116s Reading package lists... 117s Building dependency tree... 117s Reading state information... 117s Calculating upgrade... 117s The following packages will be upgraded: 117s libcap-ng0 pastebinit python3-systemd 117s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s Need to get 77.8 kB of archives. 117s After this operation, 123 kB of additional disk space will be used. 117s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libcap-ng0 s390x 0.8.5-3build1 [15.9 kB] 117s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pastebinit all 1.7.1-1 [14.9 kB] 117s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-systemd s390x 235-1build5 [46.9 kB] 117s Fetched 77.8 kB in 0s (223 kB/s) 117s (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 ... 55511 files and directories currently installed.) 117s Preparing to unpack .../libcap-ng0_0.8.5-3build1_s390x.deb ... 117s Unpacking libcap-ng0:s390x (0.8.5-3build1) over (0.8.5-1) ... 118s Setting up libcap-ng0:s390x (0.8.5-3build1) ... 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 ... 55511 files and directories currently installed.) 118s Preparing to unpack .../pastebinit_1.7.1-1_all.deb ... 118s Unpacking pastebinit (1.7.1-1) over (1.7.0-1) ... 118s Preparing to unpack .../python3-systemd_235-1build5_s390x.deb ... 118s Unpacking python3-systemd (235-1build5) over (235-1build4) ... 118s Setting up pastebinit (1.7.1-1) ... 118s Setting up python3-systemd (235-1build5) ... 118s Processing triggers for man-db (2.12.1-3) ... 118s Processing triggers for libc-bin (2.40-1ubuntu3) ... 118s Reading package lists... 118s Building dependency tree... 118s Reading state information... 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 119s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 119s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 119s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 120s Reading package lists... 120s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s Calculating upgrade... 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s autopkgtest [21:35:41]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 123s autopkgtest [21:35:41]: @@@@@@@@@@@@@@@@@@@@ apt-source python-llfuse 125s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/universe python-llfuse 1.5.0+dfsg-1build1 (dsc) [2359 B] 125s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe python-llfuse 1.5.0+dfsg-1build1 (tar) [218 kB] 125s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe python-llfuse 1.5.0+dfsg-1build1 (diff) [145 kB] 125s gpgv: Signature made Thu Nov 14 18:30:15 2024 UTC 125s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 125s gpgv: Can't check signature: No public key 125s dpkg-source: warning: cannot verify inline signature for ./python-llfuse_1.5.0+dfsg-1build1.dsc: no acceptable signature found 125s autopkgtest [21:35:43]: testing package python-llfuse version 1.5.0+dfsg-1build1 125s autopkgtest [21:35:43]: build not needed 126s autopkgtest [21:35:44]: test upstream-standard: preparing testbed 129s Reading package lists... 130s Building dependency tree... 130s Reading state information... 130s Starting pkgProblemResolver with broken count: 0 130s Starting 2 pkgProblemResolver with broken count: 0 130s Done 130s The following additional packages will be installed: 130s libfuse2t64 python3-iniconfig python3-llfuse python3-packaging 130s python3-pluggy python3-pytest 130s Suggested packages: 130s python-llfuse-doc 130s The following NEW packages will be installed: 130s autopkgtest-satdep libfuse2t64 python3-iniconfig python3-llfuse 130s python3-packaging python3-pluggy python3-pytest 130s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 130s Need to get 711 kB/712 kB of archives. 130s After this operation, 3208 kB of additional disk space will be used. 130s Get:1 /tmp/autopkgtest.AC4ZQ8/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [720 B] 130s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x libfuse2t64 s390x 2.9.9-9 [89.9 kB] 130s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 130s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x python3-llfuse s390x 1.5.0+dfsg-1build1 [302 kB] 130s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x python3-packaging all 24.1-1 [41.4 kB] 130s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pluggy all 1.5.0-1 [21.0 kB] 130s Get:7 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pytest all 8.3.3-1 [251 kB] 131s Fetched 711 kB in 0s (1462 kB/s) 131s Selecting previously unselected package libfuse2t64:s390x. 131s (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 ... 55516 files and directories currently installed.) 131s Preparing to unpack .../0-libfuse2t64_2.9.9-9_s390x.deb ... 131s Adding 'diversion of /lib/s390x-linux-gnu/libfuse.so.2 to /lib/s390x-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64' 131s Adding 'diversion of /lib/s390x-linux-gnu/libfuse.so.2.9.9 to /lib/s390x-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64' 131s Adding 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64' 131s Adding 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1.0.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64' 131s Unpacking libfuse2t64:s390x (2.9.9-9) ... 131s Selecting previously unselected package python3-iniconfig. 131s Preparing to unpack .../1-python3-iniconfig_1.1.1-2_all.deb ... 131s Unpacking python3-iniconfig (1.1.1-2) ... 131s Selecting previously unselected package python3-llfuse:s390x. 131s Preparing to unpack .../2-python3-llfuse_1.5.0+dfsg-1build1_s390x.deb ... 131s Unpacking python3-llfuse:s390x (1.5.0+dfsg-1build1) ... 131s Selecting previously unselected package python3-packaging. 131s Preparing to unpack .../3-python3-packaging_24.1-1_all.deb ... 131s Unpacking python3-packaging (24.1-1) ... 131s Selecting previously unselected package python3-pluggy. 131s Preparing to unpack .../4-python3-pluggy_1.5.0-1_all.deb ... 131s Unpacking python3-pluggy (1.5.0-1) ... 131s Selecting previously unselected package python3-pytest. 131s Preparing to unpack .../5-python3-pytest_8.3.3-1_all.deb ... 131s Unpacking python3-pytest (8.3.3-1) ... 131s Selecting previously unselected package autopkgtest-satdep. 131s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 131s Unpacking autopkgtest-satdep (0) ... 131s Setting up python3-iniconfig (1.1.1-2) ... 131s Setting up python3-packaging (24.1-1) ... 131s Setting up python3-pluggy (1.5.0-1) ... 131s Setting up libfuse2t64:s390x (2.9.9-9) ... 131s Removing 'diversion of /lib/s390x-linux-gnu/libfuse.so.2 to /lib/s390x-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64' 131s Removing 'diversion of /lib/s390x-linux-gnu/libfuse.so.2.9.9 to /lib/s390x-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64' 131s Removing 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64' 131s Removing 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1.0.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64' 131s Setting up python3-pytest (8.3.3-1) ... 131s Setting up python3-llfuse:s390x (1.5.0+dfsg-1build1) ... 131s Setting up autopkgtest-satdep (0) ... 131s Processing triggers for man-db (2.12.1-3) ... 132s Processing triggers for libc-bin (2.40-1ubuntu3) ... 133s (Reading database ... 55704 files and directories currently installed.) 133s Removing autopkgtest-satdep (0) ... 134s autopkgtest [21:35:52]: test upstream-standard: [----------------------- 134s ============================= test session starts ============================== 134s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 -- /usr/bin/python3 134s cachedir: .pytest_cache 134s rootdir: /tmp/autopkgtest.AC4ZQ8/build.Aik/src/test 134s configfile: pytest.ini 134s plugins: typeguard-4.4.1 134s collecting ... collected 15 items 134s 134s test/test_api.py::test_inquire_bits PASSED [ 6%] 134s test/test_api.py::test_listdir PASSED [ 13%] 134s test/test_api.py::test_sup_groups PASSED [ 20%] 134s test/test_api.py::test_entry_res PASSED [ 26%] 134s test/test_api.py::test_xattr PASSED [ 33%] 134s test/test_api.py::test_copy PASSED [ 40%] 134s test/test_examples.py::test_lltest PASSED [ 46%] 135s test/test_examples.py::test_tmpfs PASSED [ 53%] 135s test/test_examples.py::test_passthroughfs PASSED [ 60%] 135s 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%] 137s 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 3.96s ============================== 138s autopkgtest [21:35:56]: test upstream-standard: -----------------------] 139s upstream-standard PASS 139s autopkgtest [21:35:57]: test upstream-standard: - - - - - - - - - - results - - - - - - - - - - 139s autopkgtest [21:35:57]: test upstream-with-fuse: preparing testbed 140s Reading package lists... 140s Building dependency tree... 140s Reading state information... 141s Starting pkgProblemResolver with broken count: 0 141s Starting 2 pkgProblemResolver with broken count: 0 141s Done 141s The following NEW packages will be installed: 141s autopkgtest-satdep 141s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 141s Need to get 0 B/720 B of archives. 141s After this operation, 0 B of additional disk space will be used. 141s Get:1 /tmp/autopkgtest.AC4ZQ8/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [720 B] 141s Selecting previously unselected package autopkgtest-satdep. 141s (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 ... 55704 files and directories currently installed.) 141s Preparing to unpack .../2-autopkgtest-satdep.deb ... 141s Unpacking autopkgtest-satdep (0) ... 141s Setting up autopkgtest-satdep (0) ... 142s (Reading database ... 55704 files and directories currently installed.) 142s Removing autopkgtest-satdep (0) ... 143s autopkgtest [21:36:01]: test upstream-with-fuse: [----------------------- 143s ============================= test session starts ============================== 143s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 -- /usr/bin/python3 143s cachedir: .pytest_cache 143s rootdir: /tmp/autopkgtest.AC4ZQ8/build.Aik/src/test 143s configfile: pytest.ini 143s plugins: typeguard-4.4.1 143s collecting ... collected 15 items 143s 143s test/test_api.py::test_inquire_bits PASSED [ 6%] 143s test/test_api.py::test_listdir PASSED [ 13%] 143s test/test_api.py::test_sup_groups PASSED [ 20%] 143s test/test_api.py::test_entry_res PASSED [ 26%] 143s test/test_api.py::test_xattr PASSED [ 33%] 143s test/test_api.py::test_copy PASSED [ 40%] 144s test/test_examples.py::test_lltest PASSED [ 46%] 144s test/test_examples.py::test_tmpfs PASSED [ 53%] 145s test/test_examples.py::test_passthroughfs FAILED [ 60%] 145s test/test_examples.py::test_passthroughfs ERROR [ 60%] 145s 145s ==================================== ERRORS ==================================== 145s ___________________ ERROR at teardown of test_passthroughfs ____________________ 145s Traceback (most recent call last): 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 341, in from_call 145s result: TResult | None = func() 145s ^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 242, in 145s lambda: runtest_hook(item=item, **kwds), when=when, reraise=reraise 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 513, in __call__ 145s return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 120, in _hookexec 145s return self._inner_hookexec(hook_name, methods, kwargs, firstresult) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 139, in _multicall 145s raise exception.with_traceback(exception.__traceback__) 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/threadexception.py", line 97, in pytest_runtest_teardown 145s yield from thread_exception_runtest_hook() 145s File "/usr/lib/python3/dist-packages/_pytest/threadexception.py", line 68, in thread_exception_runtest_hook 145s yield 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 100, in pytest_runtest_teardown 145s yield from unraisable_exception_runtest_hook() 145s File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 70, in unraisable_exception_runtest_hook 145s yield 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/logging.py", line 853, in pytest_runtest_teardown 145s yield from self._runtest_for(item, "teardown") 145s File "/usr/lib/python3/dist-packages/_pytest/logging.py", line 829, in _runtest_for 145s yield 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/capture.py", line 885, in pytest_runtest_teardown 145s return (yield) 145s ^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 103, in _multicall 145s res = hook_impl.function(*args) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 189, in pytest_runtest_teardown 145s item.session._setupstate.teardown_exact(nextitem) 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 557, in teardown_exact 145s raise exceptions[0] 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 546, in teardown_exact 145s fin() 145s File "/usr/lib/python3/dist-packages/_pytest/fixtures.py", line 1032, in finish 145s raise exceptions[0] 145s File "/usr/lib/python3/dist-packages/_pytest/fixtures.py", line 1021, in finish 145s fin() 145s File "/usr/lib/python3/dist-packages/_pytest/fixtures.py", line 907, in _teardown_yield_fixture 145s next(it) 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/pytest_checklogs.py", line 117, in check_output 145s check_test_output(capfd, request.node) 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/pytest_checklogs.py", line 87, in check_test_output 145s pytest.fail('Suspicious output to stderr (matched "%s")' % hit.group(0)) 145s File "/usr/lib/python3/dist-packages/_pytest/outcomes.py", line 178, in fail 145s raise Failed(msg=reason, pytrace=pytrace) 145s Failed: Suspicious output to stderr (matched "exception") 145s ----------------------------- Captured stderr call ----------------------------- 145s 2024-11-14 21:36:02.216 fuse-worker-23: [llfuse] handler raised exception ([Errno 9] Bad file descriptor), terminating main loop. 145s Traceback (most recent call last): 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/../examples/passthroughfs.py", line 470, in 145s main() 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/../examples/passthroughfs.py", line 461, in main 145s llfuse.main() 145s File "src/handlers.pxi", line 323, in llfuse.fuse_read 145s buf = operations.read(fi.fh, off, size) 145s File "src/handlers.pxi", line 322, in llfuse.fuse_read 145s with lock: 145s File "src/handlers.pxi", line 323, in llfuse.fuse_read 145s buf = operations.read(fi.fh, off, size) 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/../examples/passthroughfs.py", line 390, in read 145s return os.read(fd, length) 145s ^^^^^^^^^^^^^^^^^^^ 145s OSError: [Errno 9] Bad file descriptor 145s =================================== FAILURES =================================== 145s ______________________________ test_passthroughfs ______________________________ 145s Traceback (most recent call last): 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 341, in from_call 145s result: TResult | None = func() 145s ^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 242, in 145s lambda: runtest_hook(item=item, **kwds), when=when, reraise=reraise 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 513, in __call__ 145s return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 120, in _hookexec 145s return self._inner_hookexec(hook_name, methods, kwargs, firstresult) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 139, in _multicall 145s raise exception.with_traceback(exception.__traceback__) 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/threadexception.py", line 92, in pytest_runtest_call 145s yield from thread_exception_runtest_hook() 145s File "/usr/lib/python3/dist-packages/_pytest/threadexception.py", line 68, in thread_exception_runtest_hook 145s yield 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 95, in pytest_runtest_call 145s yield from unraisable_exception_runtest_hook() 145s File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 70, in unraisable_exception_runtest_hook 145s yield 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/logging.py", line 846, in pytest_runtest_call 145s yield from self._runtest_for(item, "call") 145s File "/usr/lib/python3/dist-packages/_pytest/logging.py", line 829, in _runtest_for 145s yield 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/capture.py", line 880, in pytest_runtest_call 145s return (yield) 145s ^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 122, in _multicall 145s teardown.throw(exception) # type: ignore[union-attr] 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/skipping.py", line 257, in pytest_runtest_call 145s return (yield) 145s ^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 103, in _multicall 145s res = hook_impl.function(*args) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/runner.py", line 174, in pytest_runtest_call 145s item.runtest() 145s File "/usr/lib/python3/dist-packages/_pytest/python.py", line 1627, in runtest 145s self.ihook.pytest_pyfunc_call(pyfuncitem=self) 145s File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 513, in __call__ 145s return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 120, in _hookexec 145s return self._inner_hookexec(hook_name, methods, kwargs, firstresult) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 182, in _multicall 145s return outcome.get_result() 145s ^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/pluggy/_result.py", line 100, in get_result 145s raise exc.with_traceback(exc.__traceback__) 145s File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 103, in _multicall 145s res = hook_impl.function(*args) 145s ^^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3/dist-packages/_pytest/python.py", line 159, in pytest_pyfunc_call 145s result = testfunction(**testargs) 145s ^^^^^^^^^^^^^^^^^^^^^^^^ 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/test_examples.py", line 105, in test_passthroughfs 145s tst_write(mnt_dir) 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/test_examples.py", line 209, in tst_write 145s assert filecmp.cmp(name, TEST_FILE, False) 145s File "/usr/lib/python3.12/filecmp.py", line 64, in cmp 145s outcome = _do_cmp(f1, f2) 145s ^^^^^^^^^^^^^^^ 145s File "/usr/lib/python3.12/filecmp.py", line 79, in _do_cmp 145s b1 = fp1.read(bufsize) 145s ^^^^^^^^^^^^^^^^^ 145s OSError: [Errno 5] Input/output error 145s ----------------------------- Captured stderr call ----------------------------- 145s 2024-11-14 21:36:02.216 fuse-worker-23: [llfuse] handler raised exception ([Errno 9] Bad file descriptor), terminating main loop. 145s Traceback (most recent call last): 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/../examples/passthroughfs.py", line 470, in 145s main() 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/../examples/passthroughfs.py", line 461, in main 145s llfuse.main() 145s File "src/handlers.pxi", line 323, in llfuse.fuse_read 145s buf = operations.read(fi.fh, off, size) 145s File "src/handlers.pxi", line 322, in llfuse.fuse_read 145s with lock: 145s File "src/handlers.pxi", line 323, in llfuse.fuse_read 145s buf = operations.read(fi.fh, off, size) 145s File "/tmp/autopkgtest.AC4ZQ8/build.Aik/src/test/../examples/passthroughfs.py", line 390, in read 145s return os.read(fd, length) 145s ^^^^^^^^^^^^^^^^^^^ 145s OSError: [Errno 9] Bad file descriptor 145s =========================== short test summary info ============================ 145s FAILED test/test_examples.py::test_passthroughfs - OSError: [Errno 5] Input/o... 145s ERROR test/test_examples.py::test_passthroughfs - Failed: Suspicious output t... 145s !!!!!!!!!!!!!!!!!!!!!!!!!! stopping after 2 failures !!!!!!!!!!!!!!!!!!!!!!!!!!! 145s ===================== 1 failed, 8 passed, 1 error in 1.51s ===================== 145s autopkgtest [21:36:03]: test upstream-with-fuse: -----------------------] 146s upstream-with-fuse FAIL non-zero exit status 1 146s autopkgtest [21:36:04]: test upstream-with-fuse: - - - - - - - - - - results - - - - - - - - - - 146s autopkgtest [21:36:04]: @@@@@@@@@@@@@@@@@@@@ summary 146s upstream-standard PASS 146s upstream-with-fuse FAIL non-zero exit status 1 158s nova [W] Using flock in prodstack6-s390x 158s Creating nova instance adt-plucky-s390x-python-llfuse-20241114-213338-juju-7f2275-prod-proposed-migration-environment-15-e214a157-ee94-4384-b098-a6f69cbd6fd9 from image adt/ubuntu-plucky-s390x-server-20241114.img (UUID 41a907ef-1f3c-4685-a0eb-228b0d61c6b5)...