0s autopkgtest [13:41:34]: starting date and time: 2025-07-11 13:41:34+0000 0s autopkgtest [13:41:34]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [13:41:34]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.4hlkf39s/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:openssh --apt-upgrade remrun --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=openssh/1:10.0p1-5ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-arm64-2.secgroup --name adt-questing-arm64-remrun-20250711-134134-juju-7f2275-prod-proposed-migration-environment-20-86d75947-a45b-4483-a7ba-5ba22a6ead21 --image adt/ubuntu-questing-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-questing-arm64-remrun-20250711-134134-juju-7f2275-prod-proposed-migration-environment-20-86d75947-a45b-4483-a7ba-5ba22a6ead21 from image adt/ubuntu-questing-arm64-server-20250711.img (UUID 206595d5-c736-4a14-a20f-fc9659da5b85)... 62s autopkgtest [13:42:36]: testbed dpkg architecture: arm64 63s autopkgtest [13:42:37]: testbed apt version: 3.1.3 63s autopkgtest [13:42:37]: @@@@@@@@@@@@@@@@@@@@ test bed setup 63s autopkgtest [13:42:37]: testbed release detected to be: None 64s autopkgtest [13:42:38]: updating testbed package index (apt update) 64s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 64s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 65s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 65s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 65s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [15.4 kB] 65s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [179 kB] 65s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [36.9 kB] 65s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 Packages [55.0 kB] 65s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe arm64 Packages [178 kB] 65s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse arm64 Packages [15.7 kB] 65s Fetched 730 kB in 1s (915 kB/s) 66s Reading package lists... 66s autopkgtest [13:42:40]: upgrading testbed (apt dist-upgrade and autopurge) 66s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s Calculating upgrade... 67s The following packages will be upgraded: 67s openssh-client openssh-server openssh-sftp-server 67s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 67s Need to get 1567 kB of archives. 67s After this operation, 590 kB of additional disk space will be used. 67s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 openssh-sftp-server arm64 1:10.0p1-5ubuntu2 [36.8 kB] 67s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 openssh-server arm64 1:10.0p1-5ubuntu2 [603 kB] 68s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 openssh-client arm64 1:10.0p1-5ubuntu2 [927 kB] 68s Preconfiguring packages ... 68s Fetched 1567 kB in 1s (2851 kB/s) 68s (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 ... 127583 files and directories currently installed.) 68s Preparing to unpack .../openssh-sftp-server_1%3a10.0p1-5ubuntu2_arm64.deb ... 68s Unpacking openssh-sftp-server (1:10.0p1-5ubuntu2) over (1:9.9p1-3ubuntu3.1) ... 68s Preparing to unpack .../openssh-server_1%3a10.0p1-5ubuntu2_arm64.deb ... 68s Unpacking openssh-server (1:10.0p1-5ubuntu2) over (1:9.9p1-3ubuntu3.1) ... 69s Preparing to unpack .../openssh-client_1%3a10.0p1-5ubuntu2_arm64.deb ... 69s Unpacking openssh-client (1:10.0p1-5ubuntu2) over (1:9.9p1-3ubuntu3.1) ... 69s Setting up openssh-client (1:10.0p1-5ubuntu2) ... 69s Installing new version of config file /etc/ssh/ssh_config ... 69s Created symlink '/etc/systemd/user/sockets.target.wants/ssh-agent.socket' → '/usr/lib/systemd/user/ssh-agent.socket'. 69s Setting up openssh-sftp-server (1:10.0p1-5ubuntu2) ... 69s Setting up openssh-server (1:10.0p1-5ubuntu2) ... 69s Installing new version of config file /etc/ssh/moduli ... 69s Replacing config file /etc/ssh/sshd_config with new version 70s Created symlink '/etc/systemd/system/ssh.service.wants/sshd-keygen.service' → '/usr/lib/systemd/system/sshd-keygen.service'. 70s Created symlink '/etc/systemd/system/sshd.service.wants/sshd-keygen.service' → '/usr/lib/systemd/system/sshd-keygen.service'. 70s Created symlink '/etc/systemd/system/sshd@.service.wants/sshd-keygen.service' → '/usr/lib/systemd/system/sshd-keygen.service'. 70s Created symlink '/etc/systemd/system/ssh.socket.wants/sshd-keygen.service' → '/usr/lib/systemd/system/sshd-keygen.service'. 70s Processing triggers for man-db (2.13.1-1) ... 72s Processing triggers for ufw (0.36.2-9) ... 72s Reading package lists... 72s Building dependency tree... 72s Reading state information... 72s Solving dependencies... 73s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 73s autopkgtest [13:42:47]: rebooting testbed after setup commands that affected boot 100s autopkgtest [13:43:14]: testbed running kernel: Linux 6.15.0-4-generic #4-Ubuntu SMP PREEMPT_DYNAMIC Fri Jul 4 14:27:49 UTC 2025 103s autopkgtest [13:43:17]: @@@@@@@@@@@@@@@@@@@@ apt-source remrun 105s Get:1 http://ftpmaster.internal/ubuntu questing/universe remrun 0.2.4-2 (dsc) [2482 B] 105s Get:2 http://ftpmaster.internal/ubuntu questing/universe remrun 0.2.4-2 (tar) [26.1 kB] 105s Get:3 http://ftpmaster.internal/ubuntu questing/universe remrun 0.2.4-2 (asc) [833 B] 105s Get:4 http://ftpmaster.internal/ubuntu questing/universe remrun 0.2.4-2 (diff) [11.6 kB] 105s gpgv: Signature made Fri May 2 23:25:52 2025 UTC 105s gpgv: using RSA key 2EE7A7A517FC124CF115C354651EEFB02527DF13 105s gpgv: issuer "roam@debian.org" 105s gpgv: Can't check signature: No public key 105s dpkg-source: warning: cannot verify inline signature for ./remrun_0.2.4-2.dsc: no acceptable signature found 105s autopkgtest [13:43:19]: testing package remrun version 0.2.4-2 105s autopkgtest [13:43:19]: build not needed 106s autopkgtest [13:43:20]: test upstream-sshd-simple: preparing testbed 106s Reading package lists... 106s Building dependency tree... 106s Reading state information... 106s Solving dependencies... 107s The following NEW packages will be installed: 107s python3-all python3-utf8-locale remrun 107s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 107s Need to get 20.0 kB of archives. 107s After this operation, 78.8 kB of additional disk space will be used. 107s Get:1 http://ftpmaster.internal/ubuntu questing/main arm64 python3-all arm64 3.13.5-1 [884 B] 107s Get:2 http://ftpmaster.internal/ubuntu questing/universe arm64 python3-utf8-locale all 1.0.3-2 [9538 B] 107s Get:3 http://ftpmaster.internal/ubuntu questing/universe arm64 remrun all 0.2.4-2 [9582 B] 107s Fetched 20.0 kB in 0s (67.3 kB/s) 107s Selecting previously unselected package python3-all. 108s (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 ... 127584 files and directories currently installed.) 108s Preparing to unpack .../python3-all_3.13.5-1_arm64.deb ... 108s Unpacking python3-all (3.13.5-1) ... 108s Selecting previously unselected package python3-utf8-locale. 108s Preparing to unpack .../python3-utf8-locale_1.0.3-2_all.deb ... 108s Unpacking python3-utf8-locale (1.0.3-2) ... 108s Selecting previously unselected package remrun. 108s Preparing to unpack .../remrun_0.2.4-2_all.deb ... 108s Unpacking remrun (0.2.4-2) ... 108s Setting up python3-all (3.13.5-1) ... 108s Setting up remrun (0.2.4-2) ... 108s Setting up python3-utf8-locale (1.0.3-2) ... 108s Processing triggers for man-db (2.13.1-1) ... 109s autopkgtest [13:43:23]: test upstream-sshd-simple: set -e; for py in $(py3versions -i); do printf '\n\n=== %s\n\n' "$py"; env PYTHONPATH="$(pwd)/tests/python" "$py" -B -u -m run_sshd_test -v /usr/bin/remrun; done 109s autopkgtest [13:43:23]: test upstream-sshd-simple: [----------------------- 110s 110s 110s === python3.13 110s 110s Getting information about our own account, uid 0 110s Got username root, uid 0, home /root 110s Using /tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.2qy9wx06 as a temporary directory, initial uid 0 110s Looking for a port to listen on at 127.0.0.1 110s - got 127.0.0.1:8086 110s Generating the SSH host key at /tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.2qy9wx06/server/ssh_host_key 110s Generating public/private ed25519 key pair. 110s Saving key "/tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.2qy9wx06/server/ssh_host_key" failed: Permission denied 110s Removing /tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.2qy9wx06 in process 1418 110s Traceback (most recent call last): 110s File "", line 198, in _run_module_as_main 110s File "", line 88, in _run_code 110s File "/tmp/autopkgtest.9CZaOD/build.oK6/src/tests/python/run_sshd_test/__main__.py", line 717, in 110s main() 110s ~~~~^^ 110s File "/tmp/autopkgtest.9CZaOD/build.oK6/src/tests/python/run_sshd_test/__main__.py", line 704, in main 110s ssh_cfg: Final = create_ssh_config(cfg, addr, port, tempd) 110s ~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^ 110s File "/tmp/autopkgtest.9CZaOD/build.oK6/src/tests/python/run_sshd_test/__main__.py", line 188, in create_ssh_config 110s subprocess.check_call( # noqa: S603 110s ~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^ 110s ["ssh-keygen", "-f", srv_key, "-t", "ed25519", "-N", ""], # noqa: S607 110s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 110s env=cfg.utf8_env, 110s ^^^^^^^^^^^^^^^^^ 110s ) 110s ^ 110s File "/usr/lib/python3.13/subprocess.py", line 419, in check_call 110s raise CalledProcessError(retcode, cmd) 110s subprocess.CalledProcessError: Command '['ssh-keygen', '-f', PosixPath('/tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.2qy9wx06/server/ssh_host_key'), '-t', 'ed25519', '-N', '']' returned non-zero exit status 1. 110s autopkgtest [13:43:24]: test upstream-sshd-simple: -----------------------] 111s upstream-sshd-simple FAIL non-zero exit status 1 111s autopkgtest [13:43:25]: test upstream-sshd-simple: - - - - - - - - - - results - - - - - - - - - - 111s autopkgtest [13:43:25]: test upstream-sshd-suite: preparing testbed 111s Reading package lists... 111s Building dependency tree... 111s Reading state information... 112s Solving dependencies... 112s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s autopkgtest [13:43:27]: test upstream-sshd-suite: set -e; for py in $(py3versions -i); do printf '\n\n=== %s\n\n' "$py"; env PYTHONPATH="$(pwd)/tests/python" "$py" -B -u -m run_sshd_test -v -t tests/run-test.sh /usr/bin/remrun; done 113s autopkgtest [13:43:27]: test upstream-sshd-suite: [----------------------- 113s 113s 113s === python3.13 113s 113s Getting information about our own account, uid 0 113s Got username root, uid 0, home /root 113s Using /tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.oq586ucv as a temporary directory, initial uid 0 113s Looking for a port to listen on at 127.0.0.1 113s - got 127.0.0.1:8086 113s Generating the SSH host key at /tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.oq586ucv/server/ssh_host_key 113s Saving key "/tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.oq586ucv/server/ssh_host_key" failed: Permission denied 113s Generating public/private ed25519 key pair. 113s Removing /tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.oq586ucv in process 1577 113s Traceback (most recent call last): 113s File "", line 198, in _run_module_as_main 113s File "", line 88, in _run_code 113s File "/tmp/autopkgtest.9CZaOD/build.oK6/src/tests/python/run_sshd_test/__main__.py", line 717, in 113s main() 113s ~~~~^^ 113s File "/tmp/autopkgtest.9CZaOD/build.oK6/src/tests/python/run_sshd_test/__main__.py", line 704, in main 113s ssh_cfg: Final = create_ssh_config(cfg, addr, port, tempd) 113s ~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^ 113s File "/tmp/autopkgtest.9CZaOD/build.oK6/src/tests/python/run_sshd_test/__main__.py", line 188, in create_ssh_config 113s subprocess.check_call( # noqa: S603 113s ~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^ 113s ["ssh-keygen", "-f", srv_key, "-t", "ed25519", "-N", ""], # noqa: S607 113s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 113s env=cfg.utf8_env, 113s ^^^^^^^^^^^^^^^^^ 113s ) 113s ^ 113s File "/usr/lib/python3.13/subprocess.py", line 419, in check_call 113s raise CalledProcessError(retcode, cmd) 113s subprocess.CalledProcessError: Command '['ssh-keygen', '-f', PosixPath('/tmp/autopkgtest.9CZaOD/build.oK6/src/run_sshd_test.oq586ucv/server/ssh_host_key'), '-t', 'ed25519', '-N', '']' returned non-zero exit status 1. 113s autopkgtest [13:43:27]: test upstream-sshd-suite: -----------------------] 114s upstream-sshd-suite FAIL non-zero exit status 1 114s autopkgtest [13:43:28]: test upstream-sshd-suite: - - - - - - - - - - results - - - - - - - - - - 114s autopkgtest [13:43:28]: @@@@@@@@@@@@@@@@@@@@ summary 114s upstream-sshd-simple FAIL non-zero exit status 1 114s upstream-sshd-suite FAIL non-zero exit status 1