0s autopkgtest [17:08:28]: starting date and time: 2025-11-17 17:08:28+0000 0s autopkgtest [17:08:28]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [17:08:28]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.fa12sqpu/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_proxy=127.0.0.1,127.0.1.1,localhost,localdomain,internal,login.ubuntu.com,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com\n" >> /etc/environment' --apt-pocket=proposed=src:pytest --apt-upgrade terminado --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pytest/8.4.2-1 -- lxd -r lxd-armhf-10.145.243.240 lxd-armhf-10.145.243.240:autopkgtest/ubuntu/resolute/armhf 22s autopkgtest [17:08:50]: testbed dpkg architecture: armhf 24s autopkgtest [17:08:52]: testbed apt version: 3.1.11 28s autopkgtest [17:08:56]: @@@@@@@@@@@@@@@@@@@@ test bed setup 31s autopkgtest [17:08:58]: testbed release detected to be: None 39s autopkgtest [17:09:07]: updating testbed package index (apt update) 41s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 41s Get:2 http://ftpmaster.internal/ubuntu resolute InRelease [87.8 kB] 41s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 41s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 41s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [779 kB] 42s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [22.9 kB] 42s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [73.2 kB] 42s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [9852 B] 42s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf Packages [134 kB] 42s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted armhf Packages [940 B] 42s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe armhf Packages [474 kB] 42s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse armhf Packages [9684 B] 42s Get:13 http://ftpmaster.internal/ubuntu resolute/universe Sources [21.3 MB] 45s Get:14 http://ftpmaster.internal/ubuntu resolute/main Sources [1416 kB] 45s Get:15 http://ftpmaster.internal/ubuntu resolute/main armhf Packages [1369 kB] 46s Get:16 http://ftpmaster.internal/ubuntu resolute/universe armhf Packages [15.4 MB] 50s Fetched 41.2 MB in 9s (4527 kB/s) 51s Reading package lists... 58s autopkgtest [17:09:26]: upgrading testbed (apt dist-upgrade and autopurge) 59s Reading package lists... 60s Building dependency tree... 60s Reading state information... 60s Calculating upgrade... 61s The following packages will be upgraded: 61s apt libapt-pkg7.0 libcrypt1 usbutils 61s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 61s Need to get 2774 kB of archives. 61s After this operation, 8192 B of additional disk space will be used. 61s Get:1 http://ftpmaster.internal/ubuntu resolute/main armhf libapt-pkg7.0 armhf 3.1.12 [1157 kB] 61s Get:2 http://ftpmaster.internal/ubuntu resolute/main armhf apt armhf 3.1.12 [1440 kB] 62s Get:3 http://ftpmaster.internal/ubuntu resolute/main armhf libcrypt1 armhf 1:4.5.1-1 [98.9 kB] 62s Get:4 http://ftpmaster.internal/ubuntu resolute/main armhf usbutils armhf 1:019-1 [77.7 kB] 62s Fetched 2774 kB in 1s (3773 kB/s) 62s (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 ... 65904 files and directories currently installed.) 62s Preparing to unpack .../libapt-pkg7.0_3.1.12_armhf.deb ... 62s Unpacking libapt-pkg7.0:armhf (3.1.12) over (3.1.11) ... 62s Setting up libapt-pkg7.0:armhf (3.1.12) ... 62s (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 ... 65904 files and directories currently installed.) 62s Preparing to unpack .../archives/apt_3.1.12_armhf.deb ... 63s Unpacking apt (3.1.12) over (3.1.11) ... 63s Setting up apt (3.1.12) ... 64s (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 ... 65904 files and directories currently installed.) 64s Preparing to unpack .../libcrypt1_1%3a4.5.1-1_armhf.deb ... 64s Unpacking libcrypt1:armhf (1:4.5.1-1) over (1:4.4.38-1build1) ... 64s Setting up libcrypt1:armhf (1:4.5.1-1) ... 64s (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 ... 65904 files and directories currently installed.) 64s Preparing to unpack .../usbutils_1%3a019-1_armhf.deb ... 64s Unpacking usbutils (1:019-1) over (1:018-2) ... 64s Setting up usbutils (1:019-1) ... 64s Processing triggers for man-db (2.13.1-1) ... 65s Processing triggers for libc-bin (2.42-2ubuntu2) ... 69s Reading package lists... 70s Building dependency tree... 70s Reading state information... 70s Solving dependencies... 72s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 74s autopkgtest [17:09:42]: rebooting testbed after setup commands that affected boot 117s autopkgtest [17:10:25]: testbed running kernel: Linux 6.8.0-86-generic #87~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 29 09:26:46 UTC 2 143s autopkgtest [17:10:51]: @@@@@@@@@@@@@@@@@@@@ apt-source terminado 157s Get:1 http://ftpmaster.internal/ubuntu resolute/universe terminado 0.18.1-1 (dsc) [2406 B] 157s Get:2 http://ftpmaster.internal/ubuntu resolute/universe terminado 0.18.1-1 (tar) [32.4 kB] 157s Get:3 http://ftpmaster.internal/ubuntu resolute/universe terminado 0.18.1-1 (diff) [3964 B] 158s gpgv: Signature made Sun Jun 9 08:49:00 2024 UTC 158s gpgv: using RSA key 812EEFD8A3FBA4ACE4DF114B04C53BD7FE030551 158s gpgv: issuer "jpuydt@debian.org" 158s gpgv: Can't check signature: No public key 158s dpkg-source: warning: cannot verify inline signature for ./terminado_0.18.1-1.dsc: no acceptable signature found 158s autopkgtest [17:11:06]: testing package terminado version 0.18.1-1 160s autopkgtest [17:11:08]: build not needed 162s autopkgtest [17:11:10]: test runtestsuite3: preparing testbed 164s Reading package lists... 164s Building dependency tree... 164s Reading state information... 164s Solving dependencies... 165s The following NEW packages will be installed: 165s python3-iniconfig python3-pluggy python3-pytest python3-pytest-timeout 165s python3-terminado python3-tornado 165s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 165s Need to get 636 kB of archives. 165s After this operation, 3427 kB of additional disk space will be used. 165s Get:1 http://ftpmaster.internal/ubuntu resolute/universe armhf python3-iniconfig all 2.1.0-1 [6840 B] 165s Get:2 http://ftpmaster.internal/ubuntu resolute/universe armhf python3-pluggy all 1.6.0-1 [21.0 kB] 165s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/universe armhf python3-pytest all 8.4.2-1 [268 kB] 166s Get:4 http://ftpmaster.internal/ubuntu resolute/universe armhf python3-pytest-timeout all 2.3.1-2 [22.2 kB] 166s Get:5 http://ftpmaster.internal/ubuntu resolute/main armhf python3-tornado armhf 6.5.2-3 [304 kB] 166s Get:6 http://ftpmaster.internal/ubuntu resolute/universe armhf python3-terminado all 0.18.1-1 [13.2 kB] 166s Fetched 636 kB in 1s (608 kB/s) 166s Selecting previously unselected package python3-iniconfig. 166s (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 ... 65904 files and directories currently installed.) 166s Preparing to unpack .../0-python3-iniconfig_2.1.0-1_all.deb ... 166s Unpacking python3-iniconfig (2.1.0-1) ... 166s Selecting previously unselected package python3-pluggy. 166s Preparing to unpack .../1-python3-pluggy_1.6.0-1_all.deb ... 166s Unpacking python3-pluggy (1.6.0-1) ... 166s Selecting previously unselected package python3-pytest. 166s Preparing to unpack .../2-python3-pytest_8.4.2-1_all.deb ... 166s Unpacking python3-pytest (8.4.2-1) ... 166s Selecting previously unselected package python3-pytest-timeout. 166s Preparing to unpack .../3-python3-pytest-timeout_2.3.1-2_all.deb ... 166s Unpacking python3-pytest-timeout (2.3.1-2) ... 166s Selecting previously unselected package python3-tornado. 166s Preparing to unpack .../4-python3-tornado_6.5.2-3_armhf.deb ... 166s Unpacking python3-tornado (6.5.2-3) ... 167s Selecting previously unselected package python3-terminado. 167s Preparing to unpack .../5-python3-terminado_0.18.1-1_all.deb ... 167s Unpacking python3-terminado (0.18.1-1) ... 167s Setting up python3-iniconfig (2.1.0-1) ... 167s Setting up python3-tornado (6.5.2-3) ... 167s Setting up python3-pluggy (1.6.0-1) ... 167s Setting up python3-terminado (0.18.1-1) ... 168s Setting up python3-pytest (8.4.2-1) ... 168s Setting up python3-pytest-timeout (2.3.1-2) ... 168s Processing triggers for man-db (2.13.1-1) ... 177s autopkgtest [17:11:25]: test runtestsuite3: [----------------------- 179s ============================= test session starts ============================== 179s platform linux -- Python 3.13.9, pytest-8.4.2, pluggy-1.6.0 179s rootdir: /tmp/autopkgtest.SP0Dzs/build.mVo/src 179s configfile: pyproject.toml 179s testpaths: tests/ 179s plugins: typeguard-4.4.2, timeout-2.3.1 179s timeout: 300.0s 179s timeout method: signal 179s timeout func_only: False 179s collected 9 items 179s 218s tests/basic_test.py ......... [100%] 218s 218s ============================= slowest 10 durations ============================= 218s 8.27s call tests/basic_test.py::NamedTermTests::test_namespace 218s 6.52s call tests/basic_test.py::UniqueTermTests::test_max_terminals 218s 6.46s call tests/basic_test.py::CommonTests::test_basic_command 218s 6.39s call tests/basic_test.py::NamedTermTests::test_max_terminals 218s 4.28s call tests/basic_test.py::UniqueTermTests::test_unique_processes 218s 4.16s call tests/basic_test.py::SingleTermTests::test_single_process 218s 2.24s call tests/basic_test.py::UniqueTermTests::test_large_io_doesnt_hang 218s 0.46s call tests/basic_test.py::CommonTests::test_basic 218s 0.12s call tests/basic_test.py::NamedTermTests::test_new 218s 218s (1 durations < 0.005s hidden. Use -vv to show these durations.) 218s ============================== 9 passed in 39.10s ============================== 220s + Exception Group Traceback (most recent call last): 220s | File "/usr/bin/pytest", line 8, in 220s | sys.exit(console_main()) 220s | ~~~~~~~~~~~~^^ 220s | File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 201, in console_main 220s | code = main() 220s | File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 175, in main 220s | ret: ExitCode | int = config.hook.pytest_cmdline_main(config=config) 220s | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^ 220s | File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 512, in __call__ 220s | return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult) 220s | ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 120, in _hookexec 220s | return self._inner_hookexec(hook_name, methods, kwargs, firstresult) 220s | ~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 167, in _multicall 220s | raise exception 220s | File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 121, in _multicall 220s | res = hook_impl.function(*args) 220s | File "/usr/lib/python3/dist-packages/_pytest/main.py", line 336, in pytest_cmdline_main 220s | return wrap_session(config, _main) 220s | File "/usr/lib/python3/dist-packages/_pytest/main.py", line 331, in wrap_session 220s | config._ensure_unconfigure() 220s | ~~~~~~~~~~~~~~~~~~~~~~~~~~^^ 220s | File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 1131, in _ensure_unconfigure 220s | self._cleanup_stack.close() 220s | ~~~~~~~~~~~~~~~~~~~~~~~~~^^ 220s | File "/usr/lib/python3.13/contextlib.py", line 627, in close 220s | self.__exit__(None, None, None) 220s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^ 220s | File "/usr/lib/python3.13/contextlib.py", line 619, in __exit__ 220s | raise exc 220s | File "/usr/lib/python3.13/contextlib.py", line 604, in __exit__ 220s | if cb(*exc_details): 220s | ~~^^^^^^^^^^^^^^ 220s | File "/usr/lib/python3.13/contextlib.py", line 482, in _exit_wrapper 220s | callback(*args, **kwds) 220s | ~~~~~~~~^^^^^^^^^^^^^^^ 220s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 95, in cleanup 220s | collect_unraisable(config) 220s | ~~~~~~~~~~~~~~~~~~^^^^^^^^ 220s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 81, in collect_unraisable 220s | raise ExceptionGroup("multiple unraisable exception warnings", errors) 220s | ExceptionGroup: multiple unraisable exception warnings (3 sub-exceptions) 220s +-+---------------- 1 ---------------- 220s | Traceback (most recent call last): 220s | File "/usr/lib/python3/dist-packages/tornado/websocket.py", line 1466, in __del__ 220s | warnings.warn("Unclosed WebSocketClientConnection", ResourceWarning) 220s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | ResourceWarning: Unclosed WebSocketClientConnection 220s | 220s | The above exception was the direct cause of the following exception: 220s | 220s | Traceback (most recent call last): 220s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 67, in collect_unraisable 220s | warnings.warn(pytest.PytestUnraisableExceptionWarning(msg)) 220s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | pytest.PytestUnraisableExceptionWarning: Exception ignored in: 220s | Enable tracemalloc to get traceback where the object was allocated. 220s | See https://docs.pytest.org/en/stable/how-to/capture-warnings.html#resource-warnings for more info. 220s +---------------- 2 ---------------- 220s | Traceback (most recent call last): 220s | File "/usr/lib/python3/dist-packages/tornado/websocket.py", line 1466, in __del__ 220s | warnings.warn("Unclosed WebSocketClientConnection", ResourceWarning) 220s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | ResourceWarning: Unclosed WebSocketClientConnection 220s | 220s | The above exception was the direct cause of the following exception: 220s | 220s | Traceback (most recent call last): 220s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 67, in collect_unraisable 220s | warnings.warn(pytest.PytestUnraisableExceptionWarning(msg)) 220s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | pytest.PytestUnraisableExceptionWarning: Exception ignored in: 220s | Enable tracemalloc to get traceback where the object was allocated. 220s | See https://docs.pytest.org/en/stable/how-to/capture-warnings.html#resource-warnings for more info. 220s +---------------- 3 ---------------- 220s | Traceback (most recent call last): 220s | File "/usr/lib/python3/dist-packages/tornado/websocket.py", line 1466, in __del__ 220s | warnings.warn("Unclosed WebSocketClientConnection", ResourceWarning) 220s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | ResourceWarning: Unclosed WebSocketClientConnection 220s | 220s | The above exception was the direct cause of the following exception: 220s | 220s | Traceback (most recent call last): 220s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 67, in collect_unraisable 220s | warnings.warn(pytest.PytestUnraisableExceptionWarning(msg)) 220s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 220s | pytest.PytestUnraisableExceptionWarning: Exception ignored in: 220s | Enable tracemalloc to get traceback where the object was allocated. 220s | See https://docs.pytest.org/en/stable/how-to/capture-warnings.html#resource-warnings for more info. 220s +------------------------------------ 221s autopkgtest [17:12:09]: test runtestsuite3: -----------------------] 225s autopkgtest [17:12:13]: test runtestsuite3: - - - - - - - - - - results - - - - - - - - - - 225s runtestsuite3 FAIL non-zero exit status 1 229s autopkgtest [17:12:17]: @@@@@@@@@@@@@@@@@@@@ summary 229s runtestsuite3 FAIL non-zero exit status 1