0s autopkgtest [17:09:12]: starting date and time: 2025-11-17 17:09:12+0000 0s autopkgtest [17:09:12]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [17:09:12]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.krwe8_xv/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --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 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-8.secgroup --name adt-resolute-amd64-terminado-20251117-170912-juju-7f2275-prod-proposed-migration-environment-20-a332559f-d95d-4add-860c-3cde21061e6b --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-amd64-terminado-20251117-170912-juju-7f2275-prod-proposed-migration-environment-20-a332559f-d95d-4add-860c-3cde21061e6b from image adt/ubuntu-resolute-amd64-server-20251117.img (UUID 9762b0cc-7c5b-4854-acd5-cc74ad0de8c6)... 41s autopkgtest [17:09:53]: testbed dpkg architecture: amd64 42s autopkgtest [17:09:54]: testbed apt version: 3.1.11 42s autopkgtest [17:09:54]: @@@@@@@@@@@@@@@@@@@@ test bed setup 42s autopkgtest [17:09:54]: testbed release detected to be: None 43s autopkgtest [17:09:55]: updating testbed package index (apt update) 43s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 43s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 43s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 43s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 43s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [9852 B] 43s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [22.9 kB] 43s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [73.2 kB] 43s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [779 kB] 43s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [153 kB] 43s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [113 kB] 43s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 c-n-f Metadata [3236 B] 43s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [64.6 kB] 43s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [3744 B] 44s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 c-n-f Metadata [336 B] 44s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [543 kB] 44s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [254 kB] 44s Get:17 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 c-n-f Metadata [20.1 kB] 44s Get:18 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [6516 B] 44s Get:19 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [13.4 kB] 44s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 c-n-f Metadata [680 B] 45s Fetched 2149 kB in 1s (2391 kB/s) 46s Reading package lists... 46s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 46s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 46s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 46s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 47s Reading package lists... 47s Reading package lists... 47s Building dependency tree... 47s Reading state information... 47s Calculating upgrade... 47s The following packages will be upgraded: 47s apt libapt-pkg7.0 libcrypt-dev libcrypt1 libunwind8 usbutils 47s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 47s Need to get 2978 kB of archives. 47s After this operation, 46.1 kB of additional disk space will be used. 47s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 libcrypt-dev amd64 1:4.5.1-1 [122 kB] 47s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 libcrypt1 amd64 1:4.5.1-1 [90.7 kB] 48s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 libapt-pkg7.0 amd64 3.1.12 [1148 kB] 48s Get:4 http://ftpmaster.internal/ubuntu resolute/main amd64 apt amd64 3.1.12 [1474 kB] 48s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 usbutils amd64 1:019-1 [83.9 kB] 48s Get:6 http://ftpmaster.internal/ubuntu resolute/main amd64 libunwind8 amd64 1.8.3-0ubuntu1 [59.6 kB] 49s dpkg-preconfigure: unable to re-open stdin: No such file or directory 49s Fetched 2978 kB in 1s (3386 kB/s) 49s (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 ... 83372 files and directories currently installed.) 49s Preparing to unpack .../libcrypt-dev_1%3a4.5.1-1_amd64.deb ... 49s Unpacking libcrypt-dev:amd64 (1:4.5.1-1) over (1:4.4.38-1build1) ... 49s Preparing to unpack .../libcrypt1_1%3a4.5.1-1_amd64.deb ... 49s Unpacking libcrypt1:amd64 (1:4.5.1-1) over (1:4.4.38-1build1) ... 49s Setting up libcrypt1:amd64 (1:4.5.1-1) ... 49s (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 ... 83372 files and directories currently installed.) 49s Preparing to unpack .../libapt-pkg7.0_3.1.12_amd64.deb ... 49s Unpacking libapt-pkg7.0:amd64 (3.1.12) over (3.1.11) ... 49s Preparing to unpack .../archives/apt_3.1.12_amd64.deb ... 49s Unpacking apt (3.1.12) over (3.1.11) ... 49s Preparing to unpack .../usbutils_1%3a019-1_amd64.deb ... 49s Unpacking usbutils (1:019-1) over (1:018-2) ... 49s Preparing to unpack .../libunwind8_1.8.3-0ubuntu1_amd64.deb ... 49s Unpacking libunwind8:amd64 (1.8.3-0ubuntu1) over (1.8.1-0.1ubuntu1) ... 49s Setting up libunwind8:amd64 (1.8.3-0ubuntu1) ... 49s Setting up usbutils (1:019-1) ... 49s Setting up libcrypt-dev:amd64 (1:4.5.1-1) ... 49s Setting up libapt-pkg7.0:amd64 (3.1.12) ... 49s Setting up apt (3.1.12) ... 50s Processing triggers for man-db (2.13.1-1) ... 51s Processing triggers for libc-bin (2.42-2ubuntu2) ... 51s autopkgtest [17:10:03]: upgrading testbed (apt dist-upgrade and autopurge) 51s Reading package lists... 52s Building dependency tree... 52s Reading state information... 52s Calculating upgrade... 52s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 52s Reading package lists... 52s Building dependency tree... 52s Reading state information... 52s Solving dependencies... 52s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 53s autopkgtest [17:10:04]: rebooting testbed after setup commands that affected boot 80s autopkgtest [17:10:32]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:00:33 UTC 2025 82s autopkgtest [17:10:34]: @@@@@@@@@@@@@@@@@@@@ apt-source terminado 83s Get:1 http://ftpmaster.internal/ubuntu resolute/universe terminado 0.18.1-1 (dsc) [2406 B] 83s Get:2 http://ftpmaster.internal/ubuntu resolute/universe terminado 0.18.1-1 (tar) [32.4 kB] 83s Get:3 http://ftpmaster.internal/ubuntu resolute/universe terminado 0.18.1-1 (diff) [3964 B] 84s gpgv: Signature made Sun Jun 9 08:49:00 2024 UTC 84s gpgv: using RSA key 812EEFD8A3FBA4ACE4DF114B04C53BD7FE030551 84s gpgv: issuer "jpuydt@debian.org" 84s gpgv: Can't check signature: No public key 84s dpkg-source: warning: cannot verify inline signature for ./terminado_0.18.1-1.dsc: no acceptable signature found 84s autopkgtest [17:10:36]: testing package terminado version 0.18.1-1 84s autopkgtest [17:10:36]: build not needed 84s autopkgtest [17:10:36]: test runtestsuite3: preparing testbed 84s Reading package lists... 84s Building dependency tree... 84s Reading state information... 84s Solving dependencies... 84s The following NEW packages will be installed: 84s python3-iniconfig python3-pluggy python3-pytest python3-pytest-timeout 84s python3-terminado python3-tornado 84s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 84s Need to get 636 kB of archives. 84s After this operation, 3375 kB of additional disk space will be used. 84s Get:1 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-iniconfig all 2.1.0-1 [6840 B] 84s Get:2 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-pluggy all 1.6.0-1 [21.0 kB] 84s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 python3-pytest all 8.4.2-1 [268 kB] 84s Get:4 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-pytest-timeout all 2.3.1-2 [22.2 kB] 84s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-tornado amd64 6.5.2-3 [304 kB] 84s Get:6 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-terminado all 0.18.1-1 [13.2 kB] 85s Fetched 636 kB in 0s (49.7 MB/s) 85s Selecting previously unselected package python3-iniconfig. 85s (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 ... 83372 files and directories currently installed.) 85s Preparing to unpack .../0-python3-iniconfig_2.1.0-1_all.deb ... 85s Unpacking python3-iniconfig (2.1.0-1) ... 85s Selecting previously unselected package python3-pluggy. 85s Preparing to unpack .../1-python3-pluggy_1.6.0-1_all.deb ... 85s Unpacking python3-pluggy (1.6.0-1) ... 85s Selecting previously unselected package python3-pytest. 85s Preparing to unpack .../2-python3-pytest_8.4.2-1_all.deb ... 85s Unpacking python3-pytest (8.4.2-1) ... 85s Selecting previously unselected package python3-pytest-timeout. 85s Preparing to unpack .../3-python3-pytest-timeout_2.3.1-2_all.deb ... 85s Unpacking python3-pytest-timeout (2.3.1-2) ... 85s Selecting previously unselected package python3-tornado. 85s Preparing to unpack .../4-python3-tornado_6.5.2-3_amd64.deb ... 85s Unpacking python3-tornado (6.5.2-3) ... 85s Selecting previously unselected package python3-terminado. 85s Preparing to unpack .../5-python3-terminado_0.18.1-1_all.deb ... 85s Unpacking python3-terminado (0.18.1-1) ... 85s Setting up python3-iniconfig (2.1.0-1) ... 85s Setting up python3-tornado (6.5.2-3) ... 85s Setting up python3-pluggy (1.6.0-1) ... 85s Setting up python3-terminado (0.18.1-1) ... 85s Setting up python3-pytest (8.4.2-1) ... 86s Setting up python3-pytest-timeout (2.3.1-2) ... 86s Processing triggers for man-db (2.13.1-1) ... 87s autopkgtest [17:10:39]: test runtestsuite3: [----------------------- 87s ============================= test session starts ============================== 87s platform linux -- Python 3.13.9, pytest-8.4.2, pluggy-1.6.0 87s rootdir: /tmp/autopkgtest.R78KUU/build.mgO/src 87s configfile: pyproject.toml 87s testpaths: tests/ 87s plugins: timeout-2.3.1, typeguard-4.4.2 87s timeout: 300.0s 87s timeout method: signal 87s timeout func_only: False 87s collected 9 items 87s 125s tests/basic_test.py ......... [100%] 125s 125s ============================= slowest 10 durations ============================= 125s 8.24s call tests/basic_test.py::NamedTermTests::test_namespace 125s 6.46s call tests/basic_test.py::UniqueTermTests::test_max_terminals 125s 6.37s call tests/basic_test.py::CommonTests::test_basic_command 125s 6.34s call tests/basic_test.py::NamedTermTests::test_max_terminals 125s 4.23s call tests/basic_test.py::UniqueTermTests::test_unique_processes 125s 4.13s call tests/basic_test.py::SingleTermTests::test_single_process 125s 2.19s call tests/basic_test.py::UniqueTermTests::test_large_io_doesnt_hang 125s 0.36s call tests/basic_test.py::CommonTests::test_basic 125s 0.11s call tests/basic_test.py::NamedTermTests::test_new 125s 125s (1 durations < 0.005s hidden. Use -vv to show these durations.) 125s ============================== 9 passed in 38.48s ============================== 126s + Exception Group Traceback (most recent call last): 126s | File "/usr/bin/pytest", line 8, in 126s | sys.exit(console_main()) 126s | ~~~~~~~~~~~~^^ 126s | File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 201, in console_main 126s | code = main() 126s | File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 175, in main 126s | ret: ExitCode | int = config.hook.pytest_cmdline_main(config=config) 126s | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^ 126s | File "/usr/lib/python3/dist-packages/pluggy/_hooks.py", line 512, in __call__ 126s | return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult) 126s | ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | File "/usr/lib/python3/dist-packages/pluggy/_manager.py", line 120, in _hookexec 126s | return self._inner_hookexec(hook_name, methods, kwargs, firstresult) 126s | ~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 167, in _multicall 126s | raise exception 126s | File "/usr/lib/python3/dist-packages/pluggy/_callers.py", line 121, in _multicall 126s | res = hook_impl.function(*args) 126s | File "/usr/lib/python3/dist-packages/_pytest/main.py", line 336, in pytest_cmdline_main 126s | return wrap_session(config, _main) 126s | File "/usr/lib/python3/dist-packages/_pytest/main.py", line 331, in wrap_session 126s | config._ensure_unconfigure() 126s | ~~~~~~~~~~~~~~~~~~~~~~~~~~^^ 126s | File "/usr/lib/python3/dist-packages/_pytest/config/__init__.py", line 1131, in _ensure_unconfigure 126s | self._cleanup_stack.close() 126s | ~~~~~~~~~~~~~~~~~~~~~~~~~^^ 126s | File "/usr/lib/python3.13/contextlib.py", line 627, in close 126s | self.__exit__(None, None, None) 126s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^ 126s | File "/usr/lib/python3.13/contextlib.py", line 619, in __exit__ 126s | raise exc 126s | File "/usr/lib/python3.13/contextlib.py", line 604, in __exit__ 126s | if cb(*exc_details): 126s | ~~^^^^^^^^^^^^^^ 126s | File "/usr/lib/python3.13/contextlib.py", line 482, in _exit_wrapper 126s | callback(*args, **kwds) 126s | ~~~~~~~~^^^^^^^^^^^^^^^ 126s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 95, in cleanup 126s | collect_unraisable(config) 126s | ~~~~~~~~~~~~~~~~~~^^^^^^^^ 126s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 81, in collect_unraisable 126s | raise ExceptionGroup("multiple unraisable exception warnings", errors) 126s | ExceptionGroup: multiple unraisable exception warnings (3 sub-exceptions) 126s +-+---------------- 1 ---------------- 126s | Traceback (most recent call last): 126s | File "/usr/lib/python3/dist-packages/tornado/websocket.py", line 1466, in __del__ 126s | warnings.warn("Unclosed WebSocketClientConnection", ResourceWarning) 126s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | ResourceWarning: Unclosed WebSocketClientConnection 126s | 126s | The above exception was the direct cause of the following exception: 126s | 126s | Traceback (most recent call last): 126s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 67, in collect_unraisable 126s | warnings.warn(pytest.PytestUnraisableExceptionWarning(msg)) 126s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | pytest.PytestUnraisableExceptionWarning: Exception ignored in: 126s | Enable tracemalloc to get traceback where the object was allocated. 126s | See https://docs.pytest.org/en/stable/how-to/capture-warnings.html#resource-warnings for more info. 126s +---------------- 2 ---------------- 126s | Traceback (most recent call last): 126s | File "/usr/lib/python3/dist-packages/tornado/websocket.py", line 1466, in __del__ 126s | warnings.warn("Unclosed WebSocketClientConnection", ResourceWarning) 126s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | ResourceWarning: Unclosed WebSocketClientConnection 126s | 126s | The above exception was the direct cause of the following exception: 126s | 126s | Traceback (most recent call last): 126s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 67, in collect_unraisable 126s | warnings.warn(pytest.PytestUnraisableExceptionWarning(msg)) 126s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | pytest.PytestUnraisableExceptionWarning: Exception ignored in: 126s | Enable tracemalloc to get traceback where the object was allocated. 126s | See https://docs.pytest.org/en/stable/how-to/capture-warnings.html#resource-warnings for more info. 126s +---------------- 3 ---------------- 126s | Traceback (most recent call last): 126s | File "/usr/lib/python3/dist-packages/tornado/websocket.py", line 1466, in __del__ 126s | warnings.warn("Unclosed WebSocketClientConnection", ResourceWarning) 126s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | ResourceWarning: Unclosed WebSocketClientConnection 126s | 126s | The above exception was the direct cause of the following exception: 126s | 126s | Traceback (most recent call last): 126s | File "/usr/lib/python3/dist-packages/_pytest/unraisableexception.py", line 67, in collect_unraisable 126s | warnings.warn(pytest.PytestUnraisableExceptionWarning(msg)) 126s | ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 126s | pytest.PytestUnraisableExceptionWarning: Exception ignored in: 126s | Enable tracemalloc to get traceback where the object was allocated. 126s | See https://docs.pytest.org/en/stable/how-to/capture-warnings.html#resource-warnings for more info. 126s +------------------------------------ 126s autopkgtest [17:11:18]: test runtestsuite3: -----------------------] 126s runtestsuite3 FAIL non-zero exit status 1 126s autopkgtest [17:11:18]: test runtestsuite3: - - - - - - - - - - results - - - - - - - - - - 127s autopkgtest [17:11:19]: @@@@@@@@@@@@@@@@@@@@ summary 127s runtestsuite3 FAIL non-zero exit status 1