0s autopkgtest [13:36:02]: starting date and time: 2025-05-06 13:36:02+0000 0s autopkgtest [13:36:02]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [13:36:02]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.a8bbwvjs/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:ucf,src:dropbear --apt-upgrade openssh --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=ucf/3.0051 dropbear/2025.87-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@sto01-s390x-5.secgroup --name adt-questing-s390x-openssh-20250506-114524-juju-7f2275-prod-proposed-migration-environment-21-72b92a04-72c6-438b-83e4-4efa947d284d --image adt/ubuntu-questing-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-21 --net-id=net_prod-autopkgtest-workers-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 59s autopkgtest [13:37:01]: testbed dpkg architecture: s390x 59s autopkgtest [13:37:01]: testbed apt version: 3.0.0 60s autopkgtest [13:37:02]: @@@@@@@@@@@@@@@@@@@@ test bed setup 60s autopkgtest [13:37:02]: testbed release detected to be: None 60s autopkgtest [13:37:02]: updating testbed package index (apt update) 61s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 61s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 61s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 61s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 61s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [27.3 kB] 61s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [71.6 kB] 61s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [605 kB] 61s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [134 kB] 61s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [612 kB] 61s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.0 kB] 61s Fetched 1575 kB in 1s (2525 kB/s) 62s Reading package lists... 63s autopkgtest [13:37:05]: upgrading testbed (apt dist-upgrade and autopurge) 63s Reading package lists... 63s Building dependency tree... 63s Reading state information... 63s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 63s Starting 2 pkgProblemResolver with broken count: 0 63s Done 63s Entering ResolveByKeep 63s 64s Calculating upgrade... 64s The following packages will be upgraded: 64s libdebuginfod-common libdebuginfod1t64 libdw1t64 libelf1t64 libperl5.40 64s lto-disabled-list perl perl-base perl-modules-5.40 python3-dbus ucf 64s 11 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 64s Need to get 11.0 MB of archives. 64s After this operation, 21.5 kB of additional disk space will be used. 64s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x libperl5.40 s390x 5.40.1-3 [4972 kB] 64s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x perl s390x 5.40.1-3 [262 kB] 64s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x perl-base s390x 5.40.1-3 [1954 kB] 64s Get:4 http://ftpmaster.internal/ubuntu questing/main s390x perl-modules-5.40 all 5.40.1-3 [3217 kB] 65s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ucf all 3.0051 [43.6 kB] 65s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x libdebuginfod-common all 0.193-1 [15.6 kB] 65s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x libdebuginfod1t64 s390x 0.193-1 [22.5 kB] 65s Get:8 http://ftpmaster.internal/ubuntu questing/main s390x libdw1t64 s390x 0.193-1 [305 kB] 65s Get:9 http://ftpmaster.internal/ubuntu questing/main s390x libelf1t64 s390x 0.193-1 [70.4 kB] 65s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x python3-dbus s390x 1.4.0-1 [102 kB] 65s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x lto-disabled-list all 58 [12.4 kB] 65s Preconfiguring packages ... 65s Fetched 11.0 MB in 1s (9618 kB/s) 65s (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 ... 59837 files and directories currently installed.) 65s Preparing to unpack .../libperl5.40_5.40.1-3_s390x.deb ... 65s Unpacking libperl5.40:s390x (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 65s Preparing to unpack .../perl_5.40.1-3_s390x.deb ... 65s Unpacking perl (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 65s Preparing to unpack .../perl-base_5.40.1-3_s390x.deb ... 65s Unpacking perl-base (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 65s Setting up perl-base (5.40.1-3) ... 65s (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 ... 59837 files and directories currently installed.) 65s Preparing to unpack .../0-perl-modules-5.40_5.40.1-3_all.deb ... 65s Unpacking perl-modules-5.40 (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 66s Preparing to unpack .../1-ucf_3.0051_all.deb ... 66s Unpacking ucf (3.0051) over (3.0050) ... 66s Preparing to unpack .../2-libdebuginfod-common_0.193-1_all.deb ... 66s Unpacking libdebuginfod-common (0.193-1) over (0.192-4ubuntu1) ... 66s Preparing to unpack .../3-libdebuginfod1t64_0.193-1_s390x.deb ... 66s Unpacking libdebuginfod1t64:s390x (0.193-1) over (0.192-4ubuntu1) ... 66s Preparing to unpack .../4-libdw1t64_0.193-1_s390x.deb ... 66s Unpacking libdw1t64:s390x (0.193-1) over (0.192-4ubuntu1) ... 66s Preparing to unpack .../5-libelf1t64_0.193-1_s390x.deb ... 66s Unpacking libelf1t64:s390x (0.193-1) over (0.192-4ubuntu1) ... 66s Preparing to unpack .../6-python3-dbus_1.4.0-1_s390x.deb ... 66s Unpacking python3-dbus (1.4.0-1) over (1.3.2-5build5) ... 66s Preparing to unpack .../7-lto-disabled-list_58_all.deb ... 66s Unpacking lto-disabled-list (58) over (57) ... 66s Setting up python3-dbus (1.4.0-1) ... 66s Setting up lto-disabled-list (58) ... 66s Setting up libelf1t64:s390x (0.193-1) ... 66s Setting up libdw1t64:s390x (0.193-1) ... 66s Setting up ucf (3.0051) ... 66s Setting up perl-modules-5.40 (5.40.1-3) ... 66s Setting up libdebuginfod-common (0.193-1) ... 66s Setting up libperl5.40:s390x (5.40.1-3) ... 66s Setting up perl (5.40.1-3) ... 66s Setting up libdebuginfod1t64:s390x (0.193-1) ... 66s Processing triggers for man-db (2.13.1-1) ... 67s Processing triggers for libc-bin (2.41-6ubuntu1) ... 67s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s Starting pkgProblemResolver with broken count: 0 67s Starting 2 pkgProblemResolver with broken count: 0 67s Done 67s Solving dependencies... 67s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 69s autopkgtest [13:37:11]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr 6 13:39:00 UTC 2025 70s autopkgtest [13:37:12]: @@@@@@@@@@@@@@@@@@@@ apt-source openssh 74s Get:1 http://ftpmaster.internal/ubuntu questing/main openssh 1:9.9p1-3ubuntu3.1 (dsc) [3488 B] 74s Get:2 http://ftpmaster.internal/ubuntu questing/main openssh 1:9.9p1-3ubuntu3.1 (tar) [1965 kB] 74s Get:3 http://ftpmaster.internal/ubuntu questing/main openssh 1:9.9p1-3ubuntu3.1 (asc) [833 B] 74s Get:4 http://ftpmaster.internal/ubuntu questing/main openssh 1:9.9p1-3ubuntu3.1 (diff) [212 kB] 74s gpgv: Signature made Fri Apr 11 11:58:21 2025 UTC 74s gpgv: using RSA key 50C4A0DDCF31E452CEB19B516569D855A744BE93 74s gpgv: Can't check signature: No public key 74s dpkg-source: warning: cannot verify inline signature for ./openssh_9.9p1-3ubuntu3.1.dsc: no acceptable signature found 75s autopkgtest [13:37:17]: testing package openssh version 1:9.9p1-3ubuntu3.1 76s autopkgtest [13:37:18]: build not needed 78s autopkgtest [13:37:20]: test regress: preparing testbed 78s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s Starting pkgProblemResolver with broken count: 0 79s Starting 2 pkgProblemResolver with broken count: 0 79s Done 79s The following NEW packages will be installed: 79s devscripts dropbear dropbear-bin haveged libb-hooks-op-check-perl 79s libclass-method-modifiers-perl libclass-xsaccessor-perl libclone-perl 79s libdevel-callchecker-perl libdynaloader-functions-perl libencode-locale-perl 79s libfile-dirlist-perl libfile-homedir-perl libfile-listing-perl 79s libfile-touch-perl libfile-which-perl libhavege2 libhtml-parser-perl 79s libhtml-tagset-perl libhtml-tree-perl libhttp-cookies-perl libhttp-date-perl 79s libhttp-message-perl libhttp-negotiate-perl libimport-into-perl 79s libio-html-perl libio-socket-ssl-perl liblwp-mediatypes-perl 79s liblwp-protocol-https-perl libmodule-runtime-perl libmoo-perl 79s libnet-http-perl libnet-ssleay-perl libparams-classify-perl 79s librole-tiny-perl libsub-quote-perl libtimedate-perl libtomcrypt1 79s libtommath1 libtry-tiny-perl liburi-perl libwww-perl libwww-robotrules-perl 79s openssh-tests patchutils perl-openssl-defaults putty-tools python3-automat 79s python3-constantly python3-hamcrest python3-hyperlink python3-incremental 79s python3-pyasn1 python3-pyasn1-modules python3-service-identity 79s python3-twisted python3-zope.interface wdiff 79s 0 upgraded, 58 newly installed, 0 to remove and 0 not upgraded. 79s Need to get 8216 kB of archives. 79s After this operation, 37.7 MB of additional disk space will be used. 79s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x libtommath1 s390x 1.3.0-1 [57.1 kB] 79s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x libtomcrypt1 s390x 1.18.2+dfsg-7build1 [432 kB] 79s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x dropbear-bin s390x 2025.87-1 [185 kB] 79s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x dropbear all 2025.87-1 [8668 B] 79s Get:5 http://ftpmaster.internal/ubuntu questing/main s390x libfile-dirlist-perl all 0.05-3 [7286 B] 79s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x libfile-which-perl all 1.27-2 [12.5 kB] 79s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x libfile-homedir-perl all 1.006-2 [37.0 kB] 79s Get:8 http://ftpmaster.internal/ubuntu questing/main s390x libfile-touch-perl all 0.12-2 [7498 B] 79s Get:9 http://ftpmaster.internal/ubuntu questing/main s390x libclass-method-modifiers-perl all 2.15-1 [16.1 kB] 79s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x libclass-xsaccessor-perl s390x 1.19-4build6 [34.2 kB] 79s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x libb-hooks-op-check-perl s390x 0.22-3build2 [9566 B] 79s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x libdynaloader-functions-perl all 0.004-2 [11.5 kB] 79s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x libdevel-callchecker-perl s390x 0.009-2 [14.1 kB] 79s Get:14 http://ftpmaster.internal/ubuntu questing/main s390x libparams-classify-perl s390x 0.015-2build6 [20.6 kB] 79s Get:15 http://ftpmaster.internal/ubuntu questing/main s390x libmodule-runtime-perl all 0.018-1 [15.2 kB] 79s Get:16 http://ftpmaster.internal/ubuntu questing/main s390x libimport-into-perl all 1.002005-2 [10.7 kB] 79s Get:17 http://ftpmaster.internal/ubuntu questing/main s390x librole-tiny-perl all 2.002004-1 [16.3 kB] 79s Get:18 http://ftpmaster.internal/ubuntu questing/main s390x libsub-quote-perl all 2.006008-1ubuntu1 [20.7 kB] 79s Get:19 http://ftpmaster.internal/ubuntu questing/main s390x libmoo-perl all 2.005005-1 [47.4 kB] 79s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libencode-locale-perl all 1.05-3 [11.6 kB] 79s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x libtimedate-perl all 2.3300-2 [34.0 kB] 79s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-date-perl all 6.06-1 [10.2 kB] 79s Get:23 http://ftpmaster.internal/ubuntu questing/main s390x libfile-listing-perl all 6.16-1 [11.3 kB] 79s Get:24 http://ftpmaster.internal/ubuntu questing/main s390x libhtml-tagset-perl all 3.24-1 [14.1 kB] 79s Get:25 http://ftpmaster.internal/ubuntu questing/main s390x liburi-perl all 5.30-1 [94.4 kB] 79s Get:26 http://ftpmaster.internal/ubuntu questing/main s390x libhtml-parser-perl s390x 3.83-1build1 [87.8 kB] 79s Get:27 http://ftpmaster.internal/ubuntu questing/main s390x libhtml-tree-perl all 5.07-3 [200 kB] 79s Get:28 http://ftpmaster.internal/ubuntu questing/main s390x libclone-perl s390x 0.47-1 [10.7 kB] 79s Get:29 http://ftpmaster.internal/ubuntu questing/main s390x libio-html-perl all 1.004-3 [15.9 kB] 79s Get:30 http://ftpmaster.internal/ubuntu questing/main s390x liblwp-mediatypes-perl all 6.04-2 [20.1 kB] 79s Get:31 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-message-perl all 7.00-2ubuntu1 [75.9 kB] 79s Get:32 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-cookies-perl all 6.11-1 [18.2 kB] 79s Get:33 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-negotiate-perl all 6.01-2 [12.4 kB] 79s Get:34 http://ftpmaster.internal/ubuntu questing/main s390x perl-openssl-defaults s390x 7build3 [6628 B] 79s Get:35 http://ftpmaster.internal/ubuntu questing/main s390x libnet-ssleay-perl s390x 1.94-3 [320 kB] 79s Get:36 http://ftpmaster.internal/ubuntu questing/main s390x libio-socket-ssl-perl all 2.089-1 [200 kB] 79s Get:37 http://ftpmaster.internal/ubuntu questing/main s390x libnet-http-perl all 6.23-1 [22.3 kB] 79s Get:38 http://ftpmaster.internal/ubuntu questing/main s390x liblwp-protocol-https-perl all 6.14-1 [9040 B] 79s Get:39 http://ftpmaster.internal/ubuntu questing/main s390x libtry-tiny-perl all 0.32-1 [21.2 kB] 79s Get:40 http://ftpmaster.internal/ubuntu questing/main s390x libwww-robotrules-perl all 6.02-1 [12.6 kB] 79s Get:41 http://ftpmaster.internal/ubuntu questing/main s390x libwww-perl all 6.78-1 [139 kB] 79s Get:42 http://ftpmaster.internal/ubuntu questing/main s390x patchutils s390x 0.4.2-1build3 [79.2 kB] 79s Get:43 http://ftpmaster.internal/ubuntu questing/main s390x wdiff s390x 1.2.2-9 [29.7 kB] 79s Get:44 http://ftpmaster.internal/ubuntu questing/main s390x devscripts all 2.25.11 [1066 kB] 79s Get:45 http://ftpmaster.internal/ubuntu questing/universe s390x libhavege2 s390x 1.9.19-11ubuntu1 [27.3 kB] 79s Get:46 http://ftpmaster.internal/ubuntu questing/universe s390x putty-tools s390x 0.83-2 [741 kB] 79s Get:47 http://ftpmaster.internal/ubuntu questing/main s390x python3-hamcrest all 2.1.0-1 [28.1 kB] 79s Get:48 http://ftpmaster.internal/ubuntu questing/main s390x python3-pyasn1 all 0.6.1-1 [56.4 kB] 79s Get:49 http://ftpmaster.internal/ubuntu questing/main s390x python3-pyasn1-modules all 0.4.1-2 [80.3 kB] 79s Get:50 http://ftpmaster.internal/ubuntu questing/main s390x python3-service-identity all 24.2.0-1 [11.0 kB] 79s Get:51 http://ftpmaster.internal/ubuntu questing/main s390x python3-automat all 25.4.16-1 [35.7 kB] 79s Get:52 http://ftpmaster.internal/ubuntu questing/main s390x python3-constantly all 23.10.4-2 [13.9 kB] 79s Get:53 http://ftpmaster.internal/ubuntu questing/main s390x python3-hyperlink all 21.0.0-6 [68.0 kB] 79s Get:54 http://ftpmaster.internal/ubuntu questing/main s390x python3-incremental all 24.7.2-3 [18.6 kB] 79s Get:55 http://ftpmaster.internal/ubuntu questing/main s390x python3-zope.interface s390x 7.2-1build1 [141 kB] 79s Get:56 http://ftpmaster.internal/ubuntu questing/main s390x python3-twisted all 24.11.0-1 [2066 kB] 79s Get:57 http://ftpmaster.internal/ubuntu questing/universe s390x openssh-tests s390x 1:9.9p1-3ubuntu3.1 [1409 kB] 79s Get:58 http://ftpmaster.internal/ubuntu questing/universe s390x haveged s390x 1.9.19-11ubuntu1 [32.7 kB] 80s Fetched 8216 kB in 0s (16.6 MB/s) 80s Selecting previously unselected package libtommath1:s390x. 80s (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 ... 59837 files and directories currently installed.) 80s Preparing to unpack .../00-libtommath1_1.3.0-1_s390x.deb ... 80s Unpacking libtommath1:s390x (1.3.0-1) ... 80s Selecting previously unselected package libtomcrypt1:s390x. 80s Preparing to unpack .../01-libtomcrypt1_1.18.2+dfsg-7build1_s390x.deb ... 80s Unpacking libtomcrypt1:s390x (1.18.2+dfsg-7build1) ... 80s Selecting previously unselected package dropbear-bin. 80s Preparing to unpack .../02-dropbear-bin_2025.87-1_s390x.deb ... 80s Unpacking dropbear-bin (2025.87-1) ... 80s Selecting previously unselected package dropbear. 80s Preparing to unpack .../03-dropbear_2025.87-1_all.deb ... 80s Unpacking dropbear (2025.87-1) ... 80s Selecting previously unselected package libfile-dirlist-perl. 80s Preparing to unpack .../04-libfile-dirlist-perl_0.05-3_all.deb ... 80s Unpacking libfile-dirlist-perl (0.05-3) ... 80s Selecting previously unselected package libfile-which-perl. 80s Preparing to unpack .../05-libfile-which-perl_1.27-2_all.deb ... 80s Unpacking libfile-which-perl (1.27-2) ... 80s Selecting previously unselected package libfile-homedir-perl. 80s Preparing to unpack .../06-libfile-homedir-perl_1.006-2_all.deb ... 80s Unpacking libfile-homedir-perl (1.006-2) ... 80s Selecting previously unselected package libfile-touch-perl. 80s Preparing to unpack .../07-libfile-touch-perl_0.12-2_all.deb ... 80s Unpacking libfile-touch-perl (0.12-2) ... 80s Selecting previously unselected package libclass-method-modifiers-perl. 80s Preparing to unpack .../08-libclass-method-modifiers-perl_2.15-1_all.deb ... 80s Unpacking libclass-method-modifiers-perl (2.15-1) ... 80s Selecting previously unselected package libclass-xsaccessor-perl. 80s Preparing to unpack .../09-libclass-xsaccessor-perl_1.19-4build6_s390x.deb ... 80s Unpacking libclass-xsaccessor-perl (1.19-4build6) ... 80s Selecting previously unselected package libb-hooks-op-check-perl:s390x. 80s Preparing to unpack .../10-libb-hooks-op-check-perl_0.22-3build2_s390x.deb ... 80s Unpacking libb-hooks-op-check-perl:s390x (0.22-3build2) ... 80s Selecting previously unselected package libdynaloader-functions-perl. 80s Preparing to unpack .../11-libdynaloader-functions-perl_0.004-2_all.deb ... 80s Unpacking libdynaloader-functions-perl (0.004-2) ... 80s Selecting previously unselected package libdevel-callchecker-perl:s390x. 80s Preparing to unpack .../12-libdevel-callchecker-perl_0.009-2_s390x.deb ... 80s Unpacking libdevel-callchecker-perl:s390x (0.009-2) ... 80s Selecting previously unselected package libparams-classify-perl:s390x. 80s Preparing to unpack .../13-libparams-classify-perl_0.015-2build6_s390x.deb ... 80s Unpacking libparams-classify-perl:s390x (0.015-2build6) ... 80s Selecting previously unselected package libmodule-runtime-perl. 80s Preparing to unpack .../14-libmodule-runtime-perl_0.018-1_all.deb ... 80s Unpacking libmodule-runtime-perl (0.018-1) ... 80s Selecting previously unselected package libimport-into-perl. 80s Preparing to unpack .../15-libimport-into-perl_1.002005-2_all.deb ... 80s Unpacking libimport-into-perl (1.002005-2) ... 80s Selecting previously unselected package librole-tiny-perl. 80s Preparing to unpack .../16-librole-tiny-perl_2.002004-1_all.deb ... 80s Unpacking librole-tiny-perl (2.002004-1) ... 80s Selecting previously unselected package libsub-quote-perl. 80s Preparing to unpack .../17-libsub-quote-perl_2.006008-1ubuntu1_all.deb ... 80s Unpacking libsub-quote-perl (2.006008-1ubuntu1) ... 80s Selecting previously unselected package libmoo-perl. 80s Preparing to unpack .../18-libmoo-perl_2.005005-1_all.deb ... 80s Unpacking libmoo-perl (2.005005-1) ... 80s Selecting previously unselected package libencode-locale-perl. 80s Preparing to unpack .../19-libencode-locale-perl_1.05-3_all.deb ... 80s Unpacking libencode-locale-perl (1.05-3) ... 80s Selecting previously unselected package libtimedate-perl. 80s Preparing to unpack .../20-libtimedate-perl_2.3300-2_all.deb ... 80s Unpacking libtimedate-perl (2.3300-2) ... 80s Selecting previously unselected package libhttp-date-perl. 80s Preparing to unpack .../21-libhttp-date-perl_6.06-1_all.deb ... 80s Unpacking libhttp-date-perl (6.06-1) ... 80s Selecting previously unselected package libfile-listing-perl. 80s Preparing to unpack .../22-libfile-listing-perl_6.16-1_all.deb ... 80s Unpacking libfile-listing-perl (6.16-1) ... 80s Selecting previously unselected package libhtml-tagset-perl. 80s Preparing to unpack .../23-libhtml-tagset-perl_3.24-1_all.deb ... 80s Unpacking libhtml-tagset-perl (3.24-1) ... 80s Selecting previously unselected package liburi-perl. 80s Preparing to unpack .../24-liburi-perl_5.30-1_all.deb ... 80s Unpacking liburi-perl (5.30-1) ... 80s Selecting previously unselected package libhtml-parser-perl:s390x. 80s Preparing to unpack .../25-libhtml-parser-perl_3.83-1build1_s390x.deb ... 80s Unpacking libhtml-parser-perl:s390x (3.83-1build1) ... 80s Selecting previously unselected package libhtml-tree-perl. 80s Preparing to unpack .../26-libhtml-tree-perl_5.07-3_all.deb ... 80s Unpacking libhtml-tree-perl (5.07-3) ... 80s Selecting previously unselected package libclone-perl:s390x. 80s Preparing to unpack .../27-libclone-perl_0.47-1_s390x.deb ... 80s Unpacking libclone-perl:s390x (0.47-1) ... 80s Selecting previously unselected package libio-html-perl. 80s Preparing to unpack .../28-libio-html-perl_1.004-3_all.deb ... 80s Unpacking libio-html-perl (1.004-3) ... 80s Selecting previously unselected package liblwp-mediatypes-perl. 80s Preparing to unpack .../29-liblwp-mediatypes-perl_6.04-2_all.deb ... 80s Unpacking liblwp-mediatypes-perl (6.04-2) ... 80s Selecting previously unselected package libhttp-message-perl. 80s Preparing to unpack .../30-libhttp-message-perl_7.00-2ubuntu1_all.deb ... 80s Unpacking libhttp-message-perl (7.00-2ubuntu1) ... 80s Selecting previously unselected package libhttp-cookies-perl. 80s Preparing to unpack .../31-libhttp-cookies-perl_6.11-1_all.deb ... 80s Unpacking libhttp-cookies-perl (6.11-1) ... 80s Selecting previously unselected package libhttp-negotiate-perl. 80s Preparing to unpack .../32-libhttp-negotiate-perl_6.01-2_all.deb ... 80s Unpacking libhttp-negotiate-perl (6.01-2) ... 80s Selecting previously unselected package perl-openssl-defaults:s390x. 80s Preparing to unpack .../33-perl-openssl-defaults_7build3_s390x.deb ... 80s Unpacking perl-openssl-defaults:s390x (7build3) ... 80s Selecting previously unselected package libnet-ssleay-perl:s390x. 80s Preparing to unpack .../34-libnet-ssleay-perl_1.94-3_s390x.deb ... 80s Unpacking libnet-ssleay-perl:s390x (1.94-3) ... 80s Selecting previously unselected package libio-socket-ssl-perl. 80s Preparing to unpack .../35-libio-socket-ssl-perl_2.089-1_all.deb ... 80s Unpacking libio-socket-ssl-perl (2.089-1) ... 80s Selecting previously unselected package libnet-http-perl. 80s Preparing to unpack .../36-libnet-http-perl_6.23-1_all.deb ... 80s Unpacking libnet-http-perl (6.23-1) ... 80s Selecting previously unselected package liblwp-protocol-https-perl. 80s Preparing to unpack .../37-liblwp-protocol-https-perl_6.14-1_all.deb ... 80s Unpacking liblwp-protocol-https-perl (6.14-1) ... 80s Selecting previously unselected package libtry-tiny-perl. 80s Preparing to unpack .../38-libtry-tiny-perl_0.32-1_all.deb ... 80s Unpacking libtry-tiny-perl (0.32-1) ... 80s Selecting previously unselected package libwww-robotrules-perl. 80s Preparing to unpack .../39-libwww-robotrules-perl_6.02-1_all.deb ... 80s Unpacking libwww-robotrules-perl (6.02-1) ... 80s Selecting previously unselected package libwww-perl. 80s Preparing to unpack .../40-libwww-perl_6.78-1_all.deb ... 80s Unpacking libwww-perl (6.78-1) ... 80s Selecting previously unselected package patchutils. 80s Preparing to unpack .../41-patchutils_0.4.2-1build3_s390x.deb ... 80s Unpacking patchutils (0.4.2-1build3) ... 80s Selecting previously unselected package wdiff. 80s Preparing to unpack .../42-wdiff_1.2.2-9_s390x.deb ... 80s Unpacking wdiff (1.2.2-9) ... 80s Selecting previously unselected package devscripts. 80s Preparing to unpack .../43-devscripts_2.25.11_all.deb ... 80s Unpacking devscripts (2.25.11) ... 80s Selecting previously unselected package libhavege2:s390x. 80s Preparing to unpack .../44-libhavege2_1.9.19-11ubuntu1_s390x.deb ... 80s Unpacking libhavege2:s390x (1.9.19-11ubuntu1) ... 80s Selecting previously unselected package putty-tools. 80s Preparing to unpack .../45-putty-tools_0.83-2_s390x.deb ... 80s Unpacking putty-tools (0.83-2) ... 80s Selecting previously unselected package python3-hamcrest. 80s Preparing to unpack .../46-python3-hamcrest_2.1.0-1_all.deb ... 80s Unpacking python3-hamcrest (2.1.0-1) ... 80s Selecting previously unselected package python3-pyasn1. 80s Preparing to unpack .../47-python3-pyasn1_0.6.1-1_all.deb ... 80s Unpacking python3-pyasn1 (0.6.1-1) ... 80s Selecting previously unselected package python3-pyasn1-modules. 80s Preparing to unpack .../48-python3-pyasn1-modules_0.4.1-2_all.deb ... 80s Unpacking python3-pyasn1-modules (0.4.1-2) ... 80s Selecting previously unselected package python3-service-identity. 80s Preparing to unpack .../49-python3-service-identity_24.2.0-1_all.deb ... 80s Unpacking python3-service-identity (24.2.0-1) ... 80s Selecting previously unselected package python3-automat. 80s Preparing to unpack .../50-python3-automat_25.4.16-1_all.deb ... 80s Unpacking python3-automat (25.4.16-1) ... 80s Selecting previously unselected package python3-constantly. 80s Preparing to unpack .../51-python3-constantly_23.10.4-2_all.deb ... 80s Unpacking python3-constantly (23.10.4-2) ... 80s Selecting previously unselected package python3-hyperlink. 80s Preparing to unpack .../52-python3-hyperlink_21.0.0-6_all.deb ... 80s Unpacking python3-hyperlink (21.0.0-6) ... 80s Selecting previously unselected package python3-incremental. 80s Preparing to unpack .../53-python3-incremental_24.7.2-3_all.deb ... 80s Unpacking python3-incremental (24.7.2-3) ... 80s Selecting previously unselected package python3-zope.interface. 80s Preparing to unpack .../54-python3-zope.interface_7.2-1build1_s390x.deb ... 80s Unpacking python3-zope.interface (7.2-1build1) ... 80s Selecting previously unselected package python3-twisted. 80s Preparing to unpack .../55-python3-twisted_24.11.0-1_all.deb ... 80s Unpacking python3-twisted (24.11.0-1) ... 80s Selecting previously unselected package openssh-tests. 80s Preparing to unpack .../56-openssh-tests_1%3a9.9p1-3ubuntu3.1_s390x.deb ... 80s Unpacking openssh-tests (1:9.9p1-3ubuntu3.1) ... 81s Selecting previously unselected package haveged. 81s Preparing to unpack .../57-haveged_1.9.19-11ubuntu1_s390x.deb ... 81s Unpacking haveged (1.9.19-11ubuntu1) ... 81s Setting up wdiff (1.2.2-9) ... 81s Setting up libfile-which-perl (1.27-2) ... 81s Setting up libdynaloader-functions-perl (0.004-2) ... 81s Setting up libclass-method-modifiers-perl (2.15-1) ... 81s Setting up python3-zope.interface (7.2-1build1) ... 81s Setting up libclone-perl:s390x (0.47-1) ... 81s Setting up libtommath1:s390x (1.3.0-1) ... 81s Setting up libhtml-tagset-perl (3.24-1) ... 81s Setting up python3-automat (25.4.16-1) ... 81s Setting up liblwp-mediatypes-perl (6.04-2) ... 81s Setting up libtry-tiny-perl (0.32-1) ... 81s Setting up perl-openssl-defaults:s390x (7build3) ... 81s Setting up libencode-locale-perl (1.05-3) ... 81s Setting up python3-hamcrest (2.1.0-1) ... 81s Setting up putty-tools (0.83-2) ... 81s Setting up libhavege2:s390x (1.9.19-11ubuntu1) ... 81s Setting up patchutils (0.4.2-1build3) ... 81s Setting up python3-incremental (24.7.2-3) ... 81s Setting up python3-hyperlink (21.0.0-6) ... 81s Setting up libio-html-perl (1.004-3) ... 81s Setting up libb-hooks-op-check-perl:s390x (0.22-3build2) ... 81s Setting up libtimedate-perl (2.3300-2) ... 81s Setting up librole-tiny-perl (2.002004-1) ... 81s Setting up python3-pyasn1 (0.6.1-1) ... 81s Setting up python3-constantly (23.10.4-2) ... 81s Setting up libsub-quote-perl (2.006008-1ubuntu1) ... 81s Setting up libclass-xsaccessor-perl (1.19-4build6) ... 81s Setting up libfile-dirlist-perl (0.05-3) ... 81s Setting up libfile-homedir-perl (1.006-2) ... 81s Setting up liburi-perl (5.30-1) ... 81s Setting up libfile-touch-perl (0.12-2) ... 81s Setting up libnet-ssleay-perl:s390x (1.94-3) ... 81s Setting up libtomcrypt1:s390x (1.18.2+dfsg-7build1) ... 81s Setting up libhttp-date-perl (6.06-1) ... 81s Setting up haveged (1.9.19-11ubuntu1) ... 81s Created symlink '/etc/systemd/system/sysinit.target.wants/haveged.service' → '/usr/lib/systemd/system/haveged.service'. 82s Setting up dropbear-bin (2025.87-1) ... 82s Setting up libfile-listing-perl (6.16-1) ... 82s Setting up libnet-http-perl (6.23-1) ... 82s Setting up libdevel-callchecker-perl:s390x (0.009-2) ... 82s Setting up dropbear (2025.87-1) ... 82s Converting existing OpenSSH RSA host key to Dropbear format. 82s Key is a ssh-rsa key 82s Wrote key to '/etc/dropbear/dropbear_rsa_host_key' 82s 3072 SHA256:5tYLG5rHJeDTq7u/cw/GyH60N8+W/I6RLfhVWPfRJBg /etc/dropbear/dropbear_rsa_host_key (RSA) 82s +---[RSA 3072]----+ 82s | Eo. .| 82s | . o.| 82s | .+| 82s | . o+| 82s | . oS . o| 82s | o+o+o . o.| 82s | oB==...+.o| 82s | ===+ooo+= | 82s | **==.o.+=oo| 82s +----[SHA256]-----+ 82s Converting existing OpenSSH ECDSA host key to Dropbear format. 82s Key is a ecdsa-sha2-nistp256 key 82s Wrote key to '/etc/dropbear/dropbear_ecdsa_host_key' 82s 256 SHA256:+G+++4qc6Gjum+mcOHvf4tT4ZBndSIbAsQu6c458oY8 /etc/dropbear/dropbear_ecdsa_host_key (ECDSA) 82s +---[ECDSA 256]---+ 82s | .o. | 82s | .o . | 82s | . . . o | 82s | . . o + o | 82s | . o S o . | 82s | .. + o | 82s | o...o * | 82s | .oO+*.B +. | 82s | E@&==.*o*=. | 82s +----[SHA256]-----+ 82s Converting existing OpenSSH ED25519 host key to Dropbear format. 82s Key is a ssh-ed25519 key 82s Wrote key to '/etc/dropbear/dropbear_ed25519_host_key' 82s 256 SHA256:WuT4wiGJI3g1wK2I+OsCZwLAPzQZDjZKedFViMWcYUM /etc/dropbear/dropbear_ed25519_host_key (ED25519) 82s +--[ED25519 256]--+ 82s |.*o+= BE=. | 82s |=o=*.o.=. | 82s |=.+o+ . | 82s |* .= o + | 82s |+.+ + o S | 82s |oo+. o = | 82s |.+ . + . | 82s |. . . | 82s | o. | 82s +----[SHA256]-----+ 82s Created symlink '/etc/systemd/system/multi-user.target.wants/dropbear.service' → '/usr/lib/systemd/system/dropbear.service'. 82s Setting up python3-pyasn1-modules (0.4.1-2) ... 83s Setting up python3-service-identity (24.2.0-1) ... 83s Setting up libwww-robotrules-perl (6.02-1) ... 83s Setting up libhtml-parser-perl:s390x (3.83-1build1) ... 83s Setting up libio-socket-ssl-perl (2.089-1) ... 83s Setting up libhttp-message-perl (7.00-2ubuntu1) ... 83s Setting up libhttp-negotiate-perl (6.01-2) ... 83s Setting up libhttp-cookies-perl (6.11-1) ... 83s Setting up libhtml-tree-perl (5.07-3) ... 83s Setting up libparams-classify-perl:s390x (0.015-2build6) ... 83s Setting up libmodule-runtime-perl (0.018-1) ... 83s Setting up python3-twisted (24.11.0-1) ... 85s Setting up libimport-into-perl (1.002005-2) ... 85s Setting up libmoo-perl (2.005005-1) ... 85s Setting up openssh-tests (1:9.9p1-3ubuntu3.1) ... 85s Setting up liblwp-protocol-https-perl (6.14-1) ... 85s Setting up libwww-perl (6.78-1) ... 85s Setting up devscripts (2.25.11) ... 85s Processing triggers for install-info (7.1.1-1) ... 85s Processing triggers for libc-bin (2.41-6ubuntu1) ... 85s Processing triggers for man-db (2.13.1-1) ... 87s autopkgtest [13:37:29]: test regress: [----------------------- 87s info: Adding user `openssh-tests' ... 87s info: Selecting UID/GID from range 1000 to 59999 ... 87s info: Adding new group `openssh-tests' (1001) ... 87s info: Adding new user `openssh-tests' (1001) with group `openssh-tests (1001)' ... 87s info: Creating home directory `/home/openssh-tests' ... 87s info: Copying files from `/etc/skel' ... 87s info: Adding new user `openssh-tests' to supplemental / extra groups `users' ... 87s info: Adding user `openssh-tests' to group `users' ... 87s I: annotate-output 2.25.11 87s I: prefix='%H:%M:%S.%N ' 87s 13:38:50.747063880 I: Started /usr/lib/openssh/regress/run-tests /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user 87s 13:38:50.763007635 O: make: Entering directory '/tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress' 87s 13:38:50.763513249 O: test "x" = "x" || mkdir -p /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/valgrind-out 87s 13:38:50.764262361 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 87s 13:38:50.764299491 E: + /usr/bin/ssh -Q key 87s 13:38:50.765104392 E: + grep -q ^ssh-rsa 87s 13:38:50.765261412 O: ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2.prv | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 87s 13:38:50.765783842 O: tr '\n' '\r' /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv ; \ 87s 13:38:50.766618192 O: ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 87s 13:38:50.767132322 O: awk '{print $0 "\r"}' /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2.prv > /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv ; \ 87s 13:38:50.767644056 O: ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 87s 13:38:50.768125893 O: fi 87s 13:38:50.771559299 E: + ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2.prv 87s 13:38:50.772048672 E: + diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv 87s 13:38:50.775825327 E: + tr \n \r 87s 13:38:50.776821226 E: + ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv 87s 13:38:50.777305867 E: + diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv 87s 13:38:50.780265944 E: + awk {print $0 "\r"} /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2.prv 87s 13:38:50.781924218 E: + ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv 87s 13:38:50.782491803 E: + diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv 87s 13:38:50.785290393 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 87s 13:38:50.785802203 O: cat /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv > /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t2.out ; \ 87s 13:38:50.786280706 O: chmod 600 /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t2.out ; \ 87s 13:38:50.786776795 O: ssh-keygen -yf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t2.out | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub ; \ 87s 13:38:50.787233336 O: fi 87s 13:38:50.788669302 E: + /usr/bin/ssh -Q key 87s 13:38:50.789181197 E: + grep -q ^ssh-rsa 87s 13:38:50.789687349 E: + cat /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.prv 87s 13:38:50.790722819 E: + chmod 600 /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t2.out 87s 13:38:50.791237241 E: + ssh-keygen -yf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t2.out 87s 13:38:50.791736445 E: + diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub 87s 13:38:50.793729131 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 87s 13:38:50.794398942 O: ssh-keygen -ef /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub >/tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t3.out ; \ 87s 13:38:50.795140717 E: + /usr/bin/ssh -Q key 87s 13:38:50.795215610 O: ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t3.out | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub ; \ 87s 13:38:50.798066180 O: fi 87s 13:38:50.798112450 E: + grep -q ^ssh-rsa 87s 13:38:50.798825147 E: + ssh-keygen -ef /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub 87s 13:38:50.802060119 E: + ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t3.out 87s 13:38:50.802643648 E: + diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub 87s 13:38:50.804792725 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 87s 13:38:50.805277520 E: + /usr/bin/ssh -Q key 87s 13:38:50.806281353 O: ssh-keygen -E md5 -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 87s 13:38:50.806861482 E: + grep -q ^ssh-rsa 87s 13:38:50.807420966 O: awk '{print $2}' | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t4.ok ; \ 87s 13:38:50.807973061 O: fi 87s 13:38:50.808504070 E: + diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t4.ok 87s 13:38:50.809985718 E: + ssh-keygen -E md5 -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub 87s 13:38:50.810463220 E: + awk {print $2} 87s 13:38:50.811934154 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 87s 13:38:50.812455914 O: ssh-keygen -Bf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 87s 13:38:50.812964131 O: awk '{print $2}' | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t5.ok ; \ 87s 13:38:50.813507614 E: + /usr/bin/ssh -Q key 87s 13:38:50.814045307 E: + grep -q ^ssh-rsa 87s 13:38:50.814447568 O: fi 87s 13:38:50.816099525 E: + ssh-keygen -Bf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub 87s 13:38:50.817779858 E: + awk {print $2} 87s 13:38:50.819392845 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 87s 13:38:50.819916143 O: ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/dsa_ssh2.prv > /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t6.out1 ; \ 87s 13:38:50.818919208 E: + diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t5.ok 87s 13:38:50.820880028 E: + /usr/bin/ssh -Q key 87s 13:38:50.820461977 O: ssh-keygen -if /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/dsa_ssh2.pub > /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t6.out2 ; \ 87s 13:38:50.821362775 E: + grep -q ^ssh-dss 87s 13:38:50.821802944 O: chmod 600 /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t6.out1 ; \ 87s 13:38:50.822305997 O: ssh-keygen -yf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t6.out1 | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t6.out2 ; \ 87s 13:38:50.822783275 O: fi 87s 13:38:50.823302021 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 87s 13:38:50.823859681 O: ssh-keygen -q -t rsa -N '' -f /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t7.out ; \ 87s 13:38:50.824365885 O: fi 87s 13:38:50.824862905 E: + /usr/bin/ssh -Q key 87s 13:38:50.825340114 E: + grep -q ^ssh-dss 87s 13:38:50.827350912 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 87s 13:38:50.827850192 O: ssh-keygen -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t7.out > /dev/null ; \ 87s 13:38:50.828791409 O: ssh-keygen -Bf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t7.out > /dev/null ; \ 87s 13:38:50.828380767 E: + /usr/bin/ssh -Q key+ 87s 13:38:50.829297606 O: fi 87s 13:38:50.829738961 E: grep -q ^ssh-dss 87s 13:38:50.831442369 O: set -xe ; if ssh -Q key | grep -q "^ssh-dss" ; then \ 87s 13:38:50.831908368 E: + ssh -Q key 87s 13:38:50.832394095 O: ssh-keygen -q -t dsa -N '' -f /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t8.out ; \ 87s 13:38:50.832870392 O: fi 87s 13:38:50.833845598 E: + grep -q ^ssh-dss 87s 13:38:50.834828459 O: set -xe ; if ssh -Q key | grep -q "^ssh-dss" ; then \ 87s 13:38:50.835829034 O: ssh-keygen -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t8.out > /dev/null ; \ 87s 13:38:50.836345970 O: ssh-keygen -Bf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t8.out > /dev/null ; \ 87s 13:38:50.835314404 E: + ssh -Q key 87s 13:38:50.836852467 O: fi 87s 13:38:50.837897478 E: + grep -q ^ssh-dss 87s 13:38:50.838491760 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 87s 13:38:50.838980424 O: ssh-keygen -q -t ecdsa -N '' -f /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t9.out 87s 13:38:50.844783552 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 87s 13:38:50.845346935 O: ssh-keygen -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t9.out > /dev/null 87s 13:38:50.852946279 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 87s 13:38:50.853511508 O: ssh-keygen -Bf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t9.out > /dev/null 87s 13:38:50.861155570 O: ssh-keygen -q -t ed25519 -N '' -f /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t10.out 87s 13:38:50.865057286 O: ssh-keygen -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t10.out > /dev/null 87s 13:38:50.868066260 O: ssh-keygen -Bf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t10.out > /dev/null 87s 13:38:50.871016694 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 87s 13:38:50.871475092 E: + /usr/bin/ssh -Q key 87s 13:38:50.871954413 O: ssh-keygen -E sha256 -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 87s 13:38:50.872494859 O: awk '{print $2}' | diff - /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t11.ok ; \ 87s 13:38:50.872977288 O: fi 87s 13:38:50.873979633 E: + grep -q ^ssh-dss 87s 13:38:50.874634306 O: ssh-keygen -q -t ed25519 -N '' -C 'test-comment-1234' -f /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t12.out 87s 13:38:50.878044634 O: ssh-keygen -lf /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/t12.out.pub | grep test-comment-1234 >/dev/null 87s 13:38:50.882150196 E: run test connect.sh ... 93s 13:38:56.641969709 E: run test proxy-connect.sh ... 93s 13:38:56.641429854 O: ok simple connect 94s 13:38:57.232331945 O: plain username comp=no 96s 13:38:59.327097341 O: plain username comp=yes 97s 13:39:00.471252694 O: username with style 98s 13:39:01.593752220 E: run test sshfp-connect.sh ... 98s 13:39:01.595078865 O: ok proxy connect 99s 13:39:02.270558907 E: run test connect-privsep.sh ... 99s 13:39:02.272402156 O: SKIPPED: TEST_SSH_SSHFP_DOMAIN not set. 104s 13:39:06.917026675 O: ok proxy connect with privsep 104s 13:39:06.917530845 E: run test connect-uri.sh ... 104s 13:39:07.203310999 O: uri connect: no trailing slash 104s 13:39:07.547398927 O: uri connect: trailing slash 105s 13:39:07.907821279 O: uri connect: with path name 105s 13:39:07.921847547 E: run test proto-version.sh ... 105s 13:39:07.922308784 O: ok uri connect 105s 13:39:08.180919429 E: run test proto-mismatch.sh ... 105s 13:39:08.181421247 O: ok sshd version with different protocol combinations 105s 13:39:08.514919268 O: ok protocol version mismatch 105s 13:39:08.515485727 E: run test exit-status.sh ... 106s 13:39:09.026936967 O: test remote exit status: status 0 111s 13:39:14.672614603 O: test remote exit status: status 1 117s 13:39:20.581261869 O: test remote exit status: status 4 123s 13:39:26.230231561 O: test remote exit status: status 5 128s 13:39:31.879945454 O: test remote exit status: status 44 135s 13:39:38.875380060 O: ok remote exit status 135s 13:39:38.876096024 E: run test exit-status-signal.sh ... 137s 13:39:40.512043532 O: ok exit status on signal 137s 13:39:40.512911118 E: run test envpass.sh ... 137s 13:39:40.658735463 O: test environment passing: pass env, don't accept 138s 13:39:41.275763744 O: test environment passing: setenv, don't accept 138s 13:39:41.725385310 O: test environment passing: don't pass env, accept 139s 13:39:42.615550549 O: test environment passing: pass single env, accept single env 140s 13:39:43.012704994 O: test environment passing: pass multiple env, accept multiple env 140s 13:39:43.407204954 O: test environment passing: setenv, accept 140s 13:39:43.734400944 O: test environment passing: setenv, first match wins 141s 13:39:44.134310771 O: test environment passing: server setenv wins 141s 13:39:44.454583421 O: test environment passing: server setenv wins 141s 13:39:44.771102831 E: run test transfer.sh ... 141s 13:39:44.771935116 O: ok environment passing 145s 13:39:48.082410237 E: run test banner.sh ... 145s 13:39:48.083109979 O: ok transfer data 145s 13:39:48.223799041 O: test banner: missing banner file 145s 13:39:48.680144038 O: test banner: size 0 146s 13:39:49.004419934 O: test banner: size 10 146s 13:39:49.333452458 O: test banner: size 100 146s 13:39:49.660883518 O: test banner: size 1000 147s 13:39:49.988689467 O: test banner: size 10000 147s 13:39:50.316220772 O: test banner: size 100000 147s 13:39:50.644176014 O: test banner: suppress banner (-q) 148s 13:39:50.965554794 E: run test rekey.sh ... 148s 13:39:50.966288760 O: ok banner 148s 13:39:51.120384052 O: client rekey KexAlgorithms=diffie-hellman-group1-sha1 148s 13:39:51.505622852 O: client rekey KexAlgorithms=diffie-hellman-group14-sha1 149s 13:39:51.970317106 O: client rekey KexAlgorithms=diffie-hellman-group14-sha256 149s 13:39:52.270252732 O: client rekey KexAlgorithms=diffie-hellman-group16-sha512 149s 13:39:52.761125885 O: client rekey KexAlgorithms=diffie-hellman-group18-sha512 150s 13:39:53.677733547 O: client rekey KexAlgorithms=diffie-hellman-group-exchange-sha1 151s 13:39:54.529107929 O: client rekey KexAlgorithms=diffie-hellman-group-exchange-sha256 152s 13:39:55.501204779 O: client rekey KexAlgorithms=ecdh-sha2-nistp256 152s 13:39:55.826190351 O: client rekey KexAlgorithms=ecdh-sha2-nistp384 153s 13:39:56.098372973 O: client rekey KexAlgorithms=ecdh-sha2-nistp521 153s 13:39:56.397034773 O: client rekey KexAlgorithms=curve25519-sha256 153s 13:39:56.685802810 O: client rekey KexAlgorithms=sntrup761x25519-sha512 154s 13:39:57.208866963 O: client rekey KexAlgorithms=sntrup761x25519-sha512@openssh.com 154s 13:39:57.728622771 O: client rekey KexAlgorithms=mlkem768x25519-sha256 155s 13:39:58.014272009 O: client rekey Ciphers=3des-cbc 155s 13:39:58.304568239 O: client rekey Ciphers=aes128-cbc 155s 13:39:58.593330718 O: client rekey Ciphers=aes192-cbc 155s 13:39:58.880063352 O: client rekey Ciphers=aes256-cbc 156s 13:39:59.179968506 O: client rekey Ciphers=aes128-ctr 156s 13:39:59.471219406 O: client rekey Ciphers=aes192-ctr 156s 13:39:59.763917280 O: client rekey Ciphers=aes256-ctr 157s 13:40:00.090236797 O: client rekey Ciphers=aes128-gcm@openssh.com 162s 13:40:05.460616740 O: client rekey Ciphers=aes256-gcm@openssh.com 169s 13:40:12.713808640 O: client rekey Ciphers=chacha20-poly1305@openssh.com 185s 13:40:28.661529456 O: client rekey MACs=hmac-sha1 186s 13:40:28.954527727 O: client rekey MACs=hmac-sha1-96 186s 13:40:29.240454287 O: client rekey MACs=hmac-sha2-256 186s 13:40:29.532586648 O: client rekey MACs=hmac-sha2-512 187s 13:40:29.901358284 O: client rekey MACs=hmac-md5 187s 13:40:30.537861772 O: client rekey MACs=hmac-md5-96 188s 13:40:31.051337330 O: client rekey MACs=umac-64@openssh.com 188s 13:40:31.362359984 O: client rekey MACs=umac-128@openssh.com 188s 13:40:31.849222608 O: client rekey MACs=hmac-sha1-etm@openssh.com 189s 13:40:32.135913618 O: client rekey MACs=hmac-sha1-96-etm@openssh.com 189s 13:40:32.639587381 O: client rekey MACs=hmac-sha2-256-etm@openssh.com 190s 13:40:33.000939537 O: client rekey MACs=hmac-sha2-512-etm@openssh.com 190s 13:40:33.381597196 O: client rekey MACs=hmac-md5-etm@openssh.com 190s 13:40:33.667846451 O: client rekey MACs=hmac-md5-96-etm@openssh.com 191s 13:40:34.063602321 O: client rekey MACs=umac-64-etm@openssh.com 191s 13:40:34.493194361 O: client rekey MACs=umac-128-etm@openssh.com 192s 13:40:35.006592531 O: client rekeylimit 16 192s 13:40:35.321456487 O: client rekeylimit 1k 192s 13:40:35.676800799 O: client rekeylimit 128k 193s 13:40:36.274530474 O: client rekeylimit 256k 193s 13:40:36.778990075 O: client rekeylimit default 5 209s 13:40:52.408265905 O: client rekeylimit default 10 231s 13:41:13.927806432 O: client rekeylimit default 5 no data 246s 13:41:29.180657870 O: client rekeylimit default 10 no data 266s 13:41:49.441975041 O: server rekeylimit 16 267s 13:41:50.296384709 O: server rekeylimit 1k 268s 13:41:51.686573017 O: server rekeylimit 128k 270s 13:41:53.677041533 O: server rekeylimit 256k 273s 13:41:55.946009396 O: server rekeylimit default 5 no data 288s 13:42:11.552776760 O: server rekeylimit default 10 no data 308s 13:42:31.822603310 O: rekeylimit parsing: bytes 308s 13:42:31.870540030 O: rekeylimit parsing: time 309s 13:42:31.939194723 E: run test dhgex.sh ... 309s 13:42:31.938665657 O: ok rekey 309s 13:42:32.279609602 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 3des-cbc 310s 13:42:33.089791223 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 3des-cbc 311s 13:42:34.103013968 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-cbc 311s 13:42:34.866828080 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-cbc 312s 13:42:35.193600539 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-ctr 312s 13:42:35.573207162 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-ctr 313s 13:42:36.025994198 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-gcm@openssh.com 313s 13:42:36.336885185 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-gcm@openssh.com 313s 13:42:36.720221212 O: dhgex bits 7680 diffie-hellman-group-exchange-sha1 aes192-cbc 314s 13:42:37.103729843 O: dhgex bits 7680 diffie-hellman-group-exchange-sha256 aes192-cbc 314s 13:42:37.480943380 O: dhgex bits 7680 diffie-hellman-group-exchange-sha1 aes192-ctr 315s 13:42:37.966526843 O: dhgex bits 7680 diffie-hellman-group-exchange-sha256 aes192-ctr 315s 13:42:38.307332889 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-cbc 315s 13:42:38.642727036 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-cbc 316s 13:42:38.984883658 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-ctr 316s 13:42:39.328737149 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-ctr 316s 13:42:39.720997255 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-gcm@openssh.com 317s 13:42:40.162464446 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-gcm@openssh.com 317s 13:42:40.555324407 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 chacha20-poly1305@openssh.com 318s 13:42:40.993334594 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 chacha20-poly1305@openssh.com 318s 13:42:41.550869489 E: run test stderr-data.sh ... 318s 13:42:41.550363572 O: ok dhgex 318s 13:42:41.690880654 O: test stderr data transfer: () 325s 13:42:48.358360717 O: test stderr data transfer: (-n) 332s 13:42:55.027621859 O: ok stderr data transfer 332s 13:42:55.028556275 E: run test stderr-after-eof.sh ... 334s 13:42:57.501536525 O: ok stderr data after eof 334s 13:42:57.502453141 E: run test broken-pipe.sh ... 334s 13:42:57.660091966 E: run test try-ciphers.sh ... 334s 13:42:57.659609936 O: ok broken pipe test 334s 13:42:57.803661334 O: test try ciphers: cipher 3des-cbc mac hmac-sha1 335s 13:42:58.125174903 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-96 335s 13:42:58.446605425 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-256 335s 13:42:58.767656553 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-512 336s 13:42:59.095052030 O: test try ciphers: cipher 3des-cbc mac hmac-md5 336s 13:42:59.425544959 O: test try ciphers: cipher 3des-cbc mac hmac-md5-96 336s 13:42:59.756366365 O: test try ciphers: cipher 3des-cbc mac umac-64@openssh.com 337s 13:43:00.085494930 O: test try ciphers: cipher 3des-cbc mac umac-128@openssh.com 337s 13:43:00.409538104 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-etm@openssh.com 337s 13:43:00.738694372 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-96-etm@openssh.com 338s 13:43:01.066724360 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-256-etm@openssh.com 338s 13:43:01.397510092 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-512-etm@openssh.com 338s 13:43:01.722659258 O: test try ciphers: cipher 3des-cbc mac hmac-md5-etm@openssh.com 339s 13:43:02.046140468 O: test try ciphers: cipher 3des-cbc mac hmac-md5-96-etm@openssh.com 339s 13:43:02.371225415 O: test try ciphers: cipher 3des-cbc mac umac-64-etm@openssh.com 339s 13:43:02.695099166 O: test try ciphers: cipher 3des-cbc mac umac-128-etm@openssh.com 340s 13:43:03.031688873 O: test try ciphers: cipher aes128-cbc mac hmac-sha1 340s 13:43:03.359768095 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-96 340s 13:43:03.685276948 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-256 341s 13:43:04.018572971 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-512 342s 13:43:05.792416885 O: test try ciphers: cipher aes128-cbc mac hmac-md5 344s 13:43:07.599498493 O: test try ciphers: cipher aes128-cbc mac hmac-md5-96 346s 13:43:09.672549461 O: test try ciphers: cipher aes128-cbc mac umac-64@openssh.com 348s 13:43:11.738783909 O: test try ciphers: cipher aes128-cbc mac umac-128@openssh.com 351s 13:43:13.972538549 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-etm@openssh.com 351s 13:43:14.800350908 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-96-etm@openssh.com 352s 13:43:15.370233682 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-256-etm@openssh.com 352s 13:43:15.864347719 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-512-etm@openssh.com 353s 13:43:16.206056450 O: test try ciphers: cipher aes128-cbc mac hmac-md5-etm@openssh.com 353s 13:43:16.538982451 O: test try ciphers: cipher aes128-cbc mac hmac-md5-96-etm@openssh.com 354s 13:43:16.918849476 O: test try ciphers: cipher aes128-cbc mac umac-64-etm@openssh.com 354s 13:43:17.262463850 O: test try ciphers: cipher aes128-cbc mac umac-128-etm@openssh.com 355s 13:43:17.896883969 O: test try ciphers: cipher aes192-cbc mac hmac-sha1 355s 13:43:18.232293647 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-96 355s 13:43:18.568213499 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-256 356s 13:43:19.108777381 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-512 356s 13:43:19.434591811 O: test try ciphers: cipher aes192-cbc mac hmac-md5 356s 13:43:19.763215685 O: test try ciphers: cipher aes192-cbc mac hmac-md5-96 357s 13:43:20.104842506 O: test try ciphers: cipher aes192-cbc mac umac-64@openssh.com 357s 13:43:20.438119081 O: test try ciphers: cipher aes192-cbc mac umac-128@openssh.com 357s 13:43:20.847621714 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-etm@openssh.com 358s 13:43:21.322551295 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-96-etm@openssh.com 358s 13:43:21.655457295 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-256-etm@openssh.com 359s 13:43:21.983859846 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-512-etm@openssh.com 359s 13:43:22.311912549 O: test try ciphers: cipher aes192-cbc mac hmac-md5-etm@openssh.com 359s 13:43:22.637211632 O: test try ciphers: cipher aes192-cbc mac hmac-md5-96-etm@openssh.com 360s 13:43:22.964114602 O: test try ciphers: cipher aes192-cbc mac umac-64-etm@openssh.com 360s 13:43:23.298786392 O: test try ciphers: cipher aes192-cbc mac umac-128-etm@openssh.com 360s 13:43:23.635886979 O: test try ciphers: cipher aes256-cbc mac hmac-sha1 361s 13:43:23.969913326 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-96 361s 13:43:24.301089920 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-256 361s 13:43:24.664818329 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-512 362s 13:43:24.989725291 O: test try ciphers: cipher aes256-cbc mac hmac-md5 362s 13:43:25.317010741 O: test try ciphers: cipher aes256-cbc mac hmac-md5-96 362s 13:43:25.647419561 O: test try ciphers: cipher aes256-cbc mac umac-64@openssh.com 363s 13:43:25.991058092 O: test try ciphers: cipher aes256-cbc mac umac-128@openssh.com 363s 13:43:26.471996257 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-etm@openssh.com 364s 13:43:26.922916229 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-96-etm@openssh.com 364s 13:43:27.265071459 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-256-etm@openssh.com 364s 13:43:27.597739588 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-512-etm@openssh.com 365s 13:43:27.948035658 O: test try ciphers: cipher aes256-cbc mac hmac-md5-etm@openssh.com 365s 13:43:28.270772615 O: test try ciphers: cipher aes256-cbc mac hmac-md5-96-etm@openssh.com 365s 13:43:28.598619649 O: test try ciphers: cipher aes256-cbc mac umac-64-etm@openssh.com 366s 13:43:28.927743094 O: test try ciphers: cipher aes256-cbc mac umac-128-etm@openssh.com 366s 13:43:29.263601330 O: test try ciphers: cipher aes128-ctr mac hmac-sha1 366s 13:43:29.589734039 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-96 367s 13:43:29.918605659 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-256 367s 13:43:30.240775702 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-512 367s 13:43:30.565086319 O: test try ciphers: cipher aes128-ctr mac hmac-md5 368s 13:43:30.897529052 O: test try ciphers: cipher aes128-ctr mac hmac-md5-96 368s 13:43:31.223383411 O: test try ciphers: cipher aes128-ctr mac umac-64@openssh.com 368s 13:43:31.555106032 O: test try ciphers: cipher aes128-ctr mac umac-128@openssh.com 368s 13:43:31.885801075 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-etm@openssh.com 369s 13:43:32.214736010 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-96-etm@openssh.com 369s 13:43:32.538160155 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-256-etm@openssh.com 369s 13:43:32.861035817 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-512-etm@openssh.com 370s 13:43:33.191171961 O: test try ciphers: cipher aes128-ctr mac hmac-md5-etm@openssh.com 370s 13:43:33.519756425 O: test try ciphers: cipher aes128-ctr mac hmac-md5-96-etm@openssh.com 370s 13:43:33.843462022 O: test try ciphers: cipher aes128-ctr mac umac-64-etm@openssh.com 371s 13:43:34.172244155 O: test try ciphers: cipher aes128-ctr mac umac-128-etm@openssh.com 371s 13:43:34.505082008 O: test try ciphers: cipher aes192-ctr mac hmac-sha1 371s 13:43:34.828731767 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-96 372s 13:43:35.154637279 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-256 372s 13:43:35.482059554 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-512 372s 13:43:35.806954945 O: test try ciphers: cipher aes192-ctr mac hmac-md5 373s 13:43:36.137609213 O: test try ciphers: cipher aes192-ctr mac hmac-md5-96 373s 13:43:36.463470811 O: test try ciphers: cipher aes192-ctr mac umac-64@openssh.com 373s 13:43:36.791528906 O: test try ciphers: cipher aes192-ctr mac umac-128@openssh.com 374s 13:43:37.120720578 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-etm@openssh.com 374s 13:43:37.442160534 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-96-etm@openssh.com 374s 13:43:37.764772093 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-256-etm@openssh.com 375s 13:43:38.090485380 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-512-etm@openssh.com 375s 13:43:38.412884954 O: test try ciphers: cipher aes192-ctr mac hmac-md5-etm@openssh.com 375s 13:43:38.743681130 O: test try ciphers: cipher aes192-ctr mac hmac-md5-96-etm@openssh.com 376s 13:43:39.066182666 O: test try ciphers: cipher aes192-ctr mac umac-64-etm@openssh.com 376s 13:43:39.394054032 O: test try ciphers: cipher aes192-ctr mac umac-128-etm@openssh.com 376s 13:43:39.720884604 O: test try ciphers: cipher aes256-ctr mac hmac-sha1 377s 13:43:40.043273888 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-96 377s 13:43:40.366505532 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-256 377s 13:43:40.690007345 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-512 378s 13:43:41.018953866 O: test try ciphers: cipher aes256-ctr mac hmac-md5 378s 13:43:41.343364327 O: test try ciphers: cipher aes256-ctr mac hmac-md5-96 378s 13:43:41.670598962 O: test try ciphers: cipher aes256-ctr mac umac-64@openssh.com 379s 13:43:41.994411167 O: test try ciphers: cipher aes256-ctr mac umac-128@openssh.com 379s 13:43:42.322066960 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-etm@openssh.com 379s 13:43:42.647588266 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-96-etm@openssh.com 380s 13:43:42.975275202 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-256-etm@openssh.com 380s 13:43:43.302066107 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-512-etm@openssh.com 380s 13:43:43.626094679 O: test try ciphers: cipher aes256-ctr mac hmac-md5-etm@openssh.com 381s 13:43:43.950163080 O: test try ciphers: cipher aes256-ctr mac hmac-md5-96-etm@openssh.com 381s 13:43:44.279972382 O: test try ciphers: cipher aes256-ctr mac umac-64-etm@openssh.com 381s 13:43:44.608108079 O: test try ciphers: cipher aes256-ctr mac umac-128-etm@openssh.com 382s 13:43:44.949186609 O: test try ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1 382s 13:43:45.286452664 O: test try ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1 382s 13:43:45.623248969 O: test try ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1 383s 13:43:45.954127632 O: ok try ciphers 383s 13:43:45.954158056 E: run test yes-head.sh ... 386s 13:43:49.098085989 O: ok yes pipe head 386s 13:43:49.098682380 E: run test login-timeout.sh ... 401s 13:44:04.836715859 O: ok connect after login grace timeout 401s 13:44:04.836699154 E: run test agent.sh ... 414s 13:44:16.923648468 O: ok simple agent test 414s 13:44:16.924344881 E: run test agent-getpeereid.sh ... 414s 13:44:17.078712218 O: ok disallow agent attach from other uid 414s 13:44:17.079668018 E: run test agent-timeout.sh ... 434s 13:44:37.327938054 E: run test agent-ptrace.sh ... 434s 13:44:37.328590335 O: ok agent timeout test 434s 13:44:37.466729819 O: skipped (gdb not found) 434s 13:44:37.466752789 E: run test agent-subprocess.sh ... 444s 13:44:47.668606726 E: run test keyscan.sh ... 444s 13:44:47.669291846 O: ok agent subprocess 447s 13:44:50.286547430 E: run test keygen-change.sh ... 447s 13:44:50.286026219 O: ok keyscan 452s 13:44:55.203323899 O: ok change passphrase for key 452s 13:44:55.203546117 E: run test keygen-comment.sh ... 455s 13:44:58.714809945 E: run test keygen-convert.sh ... 455s 13:44:58.714279492 O: ok Comment extraction from private key 460s 13:45:03.100857884 O: ok convert keys 460s 13:45:03.101697244 E: run test keygen-knownhosts.sh ... 460s 13:45:03.440584841 O: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts updated. 460s 13:45:03.491937888 O: Original contents retained as /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts.old 460s 13:45:03.504278265 O: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts updated. 460s 13:45:03.504781076 O: Original contents retained as /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts.old 460s 13:45:03.508809908 O: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts updated. 460s 13:45:03.509398912 O: Original contents retained as /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts.old 460s 13:45:03.517282249 O: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts updated. 460s 13:45:03.517965985 O: Original contents retained as /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hosts.old 460s 13:45:03.532341140 O: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hashed updated. 460s 13:45:03.532863146 O: Original contents retained as /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/kh.hashed.old 460s 13:45:03.536037764 O: ok ssh-keygen known_hosts 460s 13:45:03.536220339 E: run test keygen-moduli.sh ... 475s 13:45:18.772109276 O: ok keygen moduli 475s 13:45:18.772320758 E: run test keygen-sshfp.sh ... 476s 13:45:18.943889862 O: ok keygen-sshfp 476s 13:45:18.944626797 E: run test key-options.sh ... 476s 13:45:19.086623606 O: key option command="echo bar" 476s 13:45:19.470868983 O: key option no-pty,command="echo bar" 476s 13:45:19.850159385 O: key option pty default 477s 13:45:20.178588228 O: key option pty no-pty 477s 13:45:20.503931079 O: key option pty restrict 477s 13:45:20.831233068 O: key option pty restrict,pty 478s 13:45:21.290247038 O: key option environment 479s 13:45:22.228444982 O: key option from="127.0.0.1" 480s 13:45:23.312475646 O: key option from="127.0.0.0/8" 481s 13:45:24.068478720 O: key option expiry-time default 481s 13:45:24.394947584 O: key option expiry-time invalid 481s 13:45:24.820987693 O: key option expiry-time expired 482s 13:45:25.246004943 O: key option expiry-time valid 482s 13:45:25.579539298 E: run test scp.sh ... 482s 13:45:25.580150640 O: ok key options 482s 13:45:25.721527349 O: scp: scp mode: simple copy local file to local file 482s 13:45:25.727666038 O: scp: scp mode: simple copy local file to remote file 482s 13:45:25.733046661 O: scp: scp mode: simple copy remote file to local file 482s 13:45:25.738393865 O: scp: scp mode: copy local file to remote file in place 482s 13:45:25.744566898 O: scp: scp mode: copy remote file to local file in place 482s 13:45:25.750288181 O: scp: scp mode: copy local file to remote file clobber 482s 13:45:25.755870774 O: -rw-r--r-- 1 openssh-tests openssh-tests 945112 May 6 13:45 /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/copy 482s 13:45:25.756426646 O: -rw-rw-r-- 1 openssh-tests openssh-tests 945112 May 6 13:45 /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/data 482s 13:45:25.757194459 O: scp: scp mode: copy remote file to local file clobber 482s 13:45:25.763212172 O: scp: scp mode: simple copy local file to remote dir 482s 13:45:25.769463468 O: scp: scp mode: simple copy local file to local dir 482s 13:45:25.775205505 O: scp: scp mode: simple copy remote file to local dir 482s 13:45:25.781482819 O: scp: scp mode: recursive local dir to remote dir 482s 13:45:25.792366786 O: scp: scp mode: recursive local dir to local dir 482s 13:45:25.803725606 O: scp: scp mode: recursive remote dir to local dir 482s 13:45:25.817435915 O: scp: scp mode: unmatched glob file local->remote 482s 13:45:25.823380327 O: scp: scp mode: unmatched glob file remote->local 482s 13:45:25.827040149 O: scp: scp mode: unmatched glob dir recursive local->remote 482s 13:45:25.835574762 O: scp: scp mode: unmatched glob dir recursive remote->local 482s 13:45:25.840232202 O: scp: scp mode: shell metacharacters 482s 13:45:25.845038899 O: scp: scp mode: skipped file after scp -p with failed chown+utimes 482s 13:45:25.866022507 O: scp: scp mode: disallow bad server #0 482s 13:45:25.879371826 O: scp: scp mode: disallow bad server #1 482s 13:45:25.892372762 O: scp: scp mode: disallow bad server #2 483s 13:45:25.905367295 O: scp: scp mode: disallow bad server #3 483s 13:45:25.918872579 O: scp: scp mode: disallow bad server #4 483s 13:45:25.931920085 O: scp: scp mode: disallow bad server #5 483s 13:45:25.944564193 O: scp: scp mode: disallow bad server #6 483s 13:45:25.956693945 O: scp: scp mode: disallow bad server #7 483s 13:45:25.969012177 O: scp: scp mode: detect non-directory target 483s 13:45:25.971481637 E: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/copy2: Not a directory 483s 13:45:25.972449802 O: scp: sftp mode: simple copy local file to local file 483s 13:45:25.977640221 O: scp: sftp mode: simple copy local file to remote file 483s 13:45:25.984716952 O: scp: sftp mode: simple copy remote file to local file 483s 13:45:25.990667538 O: scp: sftp mode: copy local file to remote file in place 483s 13:45:25.997329768 O: scp: sftp mode: copy remote file to local file in place 483s 13:45:26.003949384 O: scp: sftp mode: copy local file to remote file clobber 483s 13:45:26.010312611 O: -rw-r--r-- 1 openssh-tests openssh-tests 945112 May 6 13:45 /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/copy 483s 13:45:26.010910991 O: -rw-rw-r-- 1 openssh-tests openssh-tests 945112 May 6 13:45 /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/data 483s 13:45:26.011671047 O: scp: sftp mode: copy remote file to local file clobber 483s 13:45:26.018360225 O: scp: sftp mode: simple copy local file to remote dir 483s 13:45:26.025213173 O: scp: sftp mode: simple copy local file to local dir 483s 13:45:26.030796705 O: scp: sftp mode: simple copy remote file to local dir 483s 13:45:26.037843226 O: scp: sftp mode: recursive local dir to remote dir 483s 13:45:26.051856671 O: scp: sftp mode: recursive local dir to local dir 483s 13:45:26.063171799 O: scp: sftp mode: recursive remote dir to local dir 483s 13:45:26.079151580 O: scp: sftp mode: unmatched glob file local->remote 483s 13:45:26.086579210 O: scp: sftp mode: unmatched glob file remote->local 483s 13:45:26.091558036 O: scp: sftp mode: unmatched glob dir recursive local->remote 483s 13:45:26.101686424 O: scp: sftp mode: unmatched glob dir recursive remote->local 483s 13:45:26.108594249 O: scp: sftp mode: shell metacharacters 483s 13:45:26.113402054 O: scp: sftp mode: skipped file after scp -p with failed chown+utimes 483s 13:45:26.135508838 O: scp: sftp mode: disallow bad server #0 483s 13:45:26.153852784 O: scp: sftp mode: disallow bad server #1 483s 13:45:26.172598060 O: scp: sftp mode: disallow bad server #2 483s 13:45:26.191899635 O: scp: sftp mode: disallow bad server #3 483s 13:45:26.210372109 O: scp: sftp mode: disallow bad server #4 483s 13:45:26.230033712 O: scp: sftp mode: disallow bad server #5 483s 13:45:26.249888273 O: scp: sftp mode: disallow bad server #6 483s 13:45:26.269938697 O: scp: sftp mode: disallow bad server #7 483s 13:45:26.288559485 O: scp: sftp mode: detect non-directory target 483s 13:45:26.291084658 E: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/copy2: Not a directory 483s 13:45:26.295002087 O: ok scp 483s 13:45:26.295654132 E: run test scp3.sh ... 483s 13:45:26.436200654 O: scp3: scp mode: simple copy remote file to remote file 483s 13:45:26.810444099 O: scp3: scp mode: simple copy remote file to remote dir 484s 13:45:27.179631414 O: scp3: scp mode: recursive remote dir to remote dir 484s 13:45:27.581211654 O: scp3: scp mode: detect non-directory target 485s 13:45:28.312717218 O: scp3: sftp mode: simple copy remote file to remote file 485s 13:45:28.319050072 O: scp3: sftp mode: simple copy remote file to remote dir 485s 13:45:28.326498091 O: scp3: sftp mode: recursive remote dir to remote dir 485s 13:45:28.342639633 O: scp3: sftp mode: detect non-directory target 485s 13:45:28.346396162 E: scp: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/copy2: destination is not a directory 485s 13:45:28.347157923 E: scp: /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/copy2: destination is not a directory 485s 13:45:28.350315593 O: ok scp3 485s 13:45:28.351113585 E: run test scp-uri.sh ... 485s 13:45:28.489790272 O: scp-uri: scp mode: simple copy local file to remote file 485s 13:45:28.494037468 O: scp-uri: scp mode: simple copy remote file to local file 485s 13:45:28.498138781 O: scp-uri: scp mode: simple copy local file to remote dir 485s 13:45:28.503183159 O: scp-uri: scp mode: simple copy remote file to local dir 485s 13:45:28.508396237 O: scp-uri: scp mode: recursive local dir to remote dir 485s 13:45:28.514339219 O: scp-uri: scp mode: recursive remote dir to local dir 485s 13:45:28.520283510 O: scp-uri: sftp mode: simple copy local file to remote file 485s 13:45:28.525803759 O: scp-uri: sftp mode: simple copy remote file to local file 485s 13:45:28.530966351 O: scp-uri: sftp mode: simple copy local file to remote dir 485s 13:45:28.537655243 O: scp-uri: sftp mode: simple copy remote file to local dir 485s 13:45:28.543954326 O: scp-uri: sftp mode: recursive local dir to remote dir 485s 13:45:28.551795560 O: scp-uri: sftp mode: recursive remote dir to local dir 485s 13:45:28.560532603 O: ok scp-uri 485s 13:45:28.560599093 E: run test sftp.sh ... 485s 13:45:28.700707604 O: test basic sftp put/get: buffer_size 5 num_requests 1 494s 13:45:37.526243694 O: test basic sftp put/get: buffer_size 5 num_requests 2 497s 13:45:40.686586330 O: test basic sftp put/get: buffer_size 5 num_requests 10 499s 13:45:42.479677485 O: test basic sftp put/get: buffer_size 1000 num_requests 1 499s 13:45:42.569122459 O: test basic sftp put/get: buffer_size 1000 num_requests 2 499s 13:45:42.584825923 O: test basic sftp put/get: buffer_size 1000 num_requests 10 499s 13:45:42.594924885 O: test basic sftp put/get: buffer_size 32000 num_requests 1 499s 13:45:42.601154979 O: test basic sftp put/get: buffer_size 32000 num_requests 2 499s 13:45:42.612653714 O: test basic sftp put/get: buffer_size 32000 num_requests 10 499s 13:45:42.618863955 O: test basic sftp put/get: buffer_size 64000 num_requests 1 499s 13:45:42.625193698 O: test basic sftp put/get: buffer_size 64000 num_requests 2 499s 13:45:42.631043153 O: test basic sftp put/get: buffer_size 64000 num_requests 10 499s 13:45:42.637953724 O: ok basic sftp put/get 499s 13:45:42.638788721 E: run test sftp-chroot.sh ... 500s 13:45:42.929480281 O: test sftp in chroot: get 500s 13:45:43.288394343 O: test sftp in chroot: match 500s 13:45:43.788618174 O: ok sftp in chroot 500s 13:45:43.792845990 E: run test sftp-cmds.sh ... 501s 13:45:43.937614236 O: sftp commands: lls 501s 13:45:43.941177468 O: sftp commands: lls w/path 501s 13:45:43.944531599 O: sftp commands: ls 501s 13:45:43.948719526 O: sftp commands: shell 501s 13:45:43.951566336 O: sftp commands: pwd 501s 13:45:43.953458400 O: sftp commands: lpwd 501s 13:45:43.955069255 O: sftp commands: quit 501s 13:45:43.957012295 O: sftp commands: help 501s 13:45:43.959647549 O: sftp commands: get 501s 13:45:43.963780297 O: sftp commands: get quoted 501s 13:45:43.969522956 O: sftp commands: get filename with quotes 501s 13:45:43.976694865 O: sftp commands: get filename with spaces 501s 13:45:43.981885310 O: sftp commands: get filename with glob metacharacters 501s 13:45:43.986827200 O: sftp commands: get to directory 501s 13:45:43.991543151 O: sftp commands: glob get to directory 501s 13:45:44.039826632 O: sftp commands: get to local dir 501s 13:45:44.044370131 O: sftp commands: glob get to local dir 501s 13:45:44.061070524 O: sftp commands: put 501s 13:45:44.066134987 O: sftp commands: put filename with quotes 501s 13:45:44.070749236 O: sftp commands: put filename with spaces 501s 13:45:44.077143162 O: sftp commands: put to directory 501s 13:45:44.082590862 O: sftp commands: glob put to directory 501s 13:45:44.087744775 O: sftp commands: put to local dir 501s 13:45:44.092597966 O: sftp commands: glob put to local dir 501s 13:45:44.104522036 O: sftp commands: rename 501s 13:45:44.107549721 O: sftp commands: rename directory 501s 13:45:44.109271405 O: sftp commands: ln 501s 13:45:44.111379509 O: sftp commands: ln -s 501s 13:45:44.113884915 O: sftp commands: cp 501s 13:45:44.117625741 O: sftp commands: mkdir 501s 13:45:44.119467674 O: sftp commands: chdir 501s 13:45:44.121140470 O: sftp commands: rmdir 501s 13:45:44.122803361 O: sftp commands: lmkdir 501s 13:45:44.124777461 O: sftp commands: lchdir 501s 13:45:44.129360547 O: ok sftp commands 501s 13:45:44.129920323 E: run test sftp-badcmds.sh ... 501s 13:45:44.271031852 O: sftp invalid commands: get nonexistent 501s 13:45:44.273358821 O: sftp invalid commands: glob get to nonexistent directory 501s 13:45:44.280865220 O: sftp invalid commands: put nonexistent 501s 13:45:44.282857423 O: sftp invalid commands: glob put to nonexistent directory 501s 13:45:44.285577622 O: sftp invalid commands: rename nonexistent 501s 13:45:44.289086924 O: sftp invalid commands: rename target exists (directory) 501s 13:45:44.293312368 O: sftp invalid commands: glob put files to local file 501s 13:45:44.296666108 O: ok sftp invalid commands 501s 13:45:44.297242540 E: run test sftp-batch.sh ... 501s 13:45:44.447050395 O: sftp batchfile: good commands 501s 13:45:44.451498842 O: sftp batchfile: bad commands 501s 13:45:44.457326032 O: sftp batchfile: comments and blanks 501s 13:45:44.461475275 O: sftp batchfile: junk command 501s 13:45:44.464671366 E: run test sftp-glob.sh ... 501s 13:45:44.464160196 O: ok sftp batchfile 501s 13:45:44.605379915 O: sftp glob: file glob 501s 13:45:44.609854157 O: sftp glob: dir glob 501s 13:45:44.613182154 O: sftp glob: quoted glob 501s 13:45:44.616966593 O: sftp glob: escaped glob 501s 13:45:44.620780860 O: sftp glob: escaped quote 501s 13:45:44.623992622 O: sftp glob: quoted quote 501s 13:45:44.627191606 O: sftp glob: single-quoted quote 501s 13:45:44.630258015 O: sftp glob: escaped space 501s 13:45:44.633196044 O: sftp glob: quoted space 501s 13:45:44.636300061 O: sftp glob: escaped slash 501s 13:45:44.639881041 O: sftp glob: quoted slash 501s 13:45:44.643284518 O: sftp glob: escaped slash at EOL 501s 13:45:44.646891537 O: sftp glob: quoted slash at EOL 501s 13:45:44.650047778 O: sftp glob: escaped slash+quote 501s 13:45:44.653195616 O: sftp glob: quoted slash+quote 501s 13:45:44.656682576 O: ok sftp glob 501s 13:45:44.657212548 E: run test sftp-perm.sh ... 501s 13:45:44.795214716 O: sftp permissions: read-only upload 501s 13:45:44.804620858 O: sftp permissions: read-only setstat 501s 13:45:44.813865280 O: sftp permissions: read-only rm 501s 13:45:44.822142186 O: sftp permissions: read-only mkdir 501s 13:45:44.830150518 O: sftp permissions: read-only rmdir 501s 13:45:44.839082384 O: sftp permissions: read-only posix-rename 501s 13:45:44.847770995 O: sftp permissions: read-only oldrename 502s 13:45:44.906109108 O: sftp permissions: read-only symlink 502s 13:45:44.915841955 O: sftp permissions: read-only hardlink 502s 13:45:44.925170663 O: sftp permissions: explicit open 502s 13:45:44.946944741 O: sftp permissions: explicit read 502s 13:45:45.204904718 O: sftp permissions: explicit write 502s 13:45:45.226577309 O: sftp permissions: explicit lstat 502s 13:45:45.245846843 O: sftp permissions: explicit opendir 502s 13:45:45.265918044 O: sftp permissions: explicit readdir 502s 13:45:45.344839095 O: sftp permissions: explicit setstat 502s 13:45:45.363830883 O: sftp permissions: explicit remove 502s 13:45:45.381677763 O: sftp permissions: explicit mkdir 504s 13:45:46.984012635 O: sftp permissions: explicit rmdir 504s 13:45:47.003927606 O: sftp permissions: explicit rename 504s 13:45:47.022892979 O: sftp permissions: explicit symlink 504s 13:45:47.040789619 O: sftp permissions: explicit hardlink 504s 13:45:47.060691893 O: sftp permissions: explicit statvfs 504s 13:45:47.076085577 O: ok sftp permissions 504s 13:45:47.076927775 E: run test sftp-uri.sh ... 506s 13:45:49.399651185 O: sftp-uri: non-interactive fetch to local file 508s 13:45:51.306157201 O: sftp-uri: non-interactive fetch to local dir 510s 13:45:53.135266383 O: sftp-uri: put to remote directory (trailing slash) 511s 13:45:53.915098960 O: sftp-uri: put to remote directory (no slash) 511s 13:45:54.401839281 O: ok sftp-uri 511s 13:45:54.643910979 E: run test reconfigure.sh ... 526s 13:46:08.937967422 E: run test dynamic-forward.sh ... 526s 13:46:08.938467221 O: ok simple connect after reconfigure 526s 13:46:09.236782424 O: test -D forwarding 528s 13:46:11.350985300 O: test -R forwarding 530s 13:46:13.571606202 O: PermitRemoteOpen=any 532s 13:46:15.442582044 O: PermitRemoteOpen=none 533s 13:46:15.950175647 O: PermitRemoteOpen=explicit 536s 13:46:18.982474484 O: PermitRemoteOpen=disallowed 536s 13:46:19.500345974 O: ok dynamic forwarding 536s 13:46:19.500358059 E: run test forwarding.sh ... 543s 13:46:26.536161648 O: ok local and remote forwarding 543s 13:46:26.536857570 E: run test multiplex.sh ... 544s 13:46:27.843329720 O: test connection multiplexing: setenv 544s 13:46:27.852127335 O: test connection multiplexing: envpass 544s 13:46:27.860322050 O: test connection multiplexing: transfer 544s 13:46:27.888117262 O: test connection multiplexing: transfer -Oproxy 545s 13:46:27.949086078 O: test connection multiplexing: forward 547s 13:46:30.083858459 O: test connection multiplexing: status 0 () 552s 13:46:35.197939577 O: test connection multiplexing: status 0 (-Oproxy) 557s 13:46:40.218204820 O: test connection multiplexing: status 1 () 562s 13:46:45.237262643 O: test connection multiplexing: status 1 (-Oproxy) 567s 13:46:50.257205737 O: test connection multiplexing: status 4 () 572s 13:46:55.276412516 O: test connection multiplexing: status 4 (-Oproxy) 577s 13:47:00.295901580 O: test connection multiplexing: status 5 () 582s 13:47:05.314831435 O: test connection multiplexing: status 5 (-Oproxy) 587s 13:47:10.347946911 O: test connection multiplexing: status 44 () 592s 13:47:15.393352283 O: test connection multiplexing: status 44 (-Oproxy) 597s 13:47:20.412929798 O: test connection multiplexing: cmd check 597s 13:47:20.418767732 O: test connection multiplexing: cmd forward local (TCP) 598s 13:47:21.828644760 O: test connection multiplexing: cmd forward remote (TCP) 600s 13:47:23.188318671 O: test connection multiplexing: cmd forward local (UNIX) 601s 13:47:24.254806720 O: test connection multiplexing: cmd forward remote (UNIX) 602s 13:47:25.321184944 O: test connection multiplexing: cmd exit 602s 13:47:25.327791460 O: test connection multiplexing: cmd stop 613s 13:47:36.710278318 O: ok connection multiplexing 613s 13:47:36.710945977 E: run test reexec.sh ... 614s 13:47:36.898842271 O: test config passing 614s 13:47:37.606098570 O: test reexec fallback 614s 13:47:37.606572889 E: ln: failed to create hard link '/tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/sshd' => '/usr/sbin/sshd': Operation not permitted 615s 13:47:38.113223134 O: ok reexec tests 615s 13:47:38.113263607 E: run test brokenkeys.sh ... 615s 13:47:38.748687290 E: run test sshcfgparse.sh ... 615s 13:47:38.748164084 O: ok broken keys 615s 13:47:38.888324826 O: reparse minimal config 616s 13:47:38.899865893 O: ssh -W opts 616s 13:47:38.933288194 O: user first match 616s 13:47:38.956568116 O: pubkeyacceptedalgorithms 616s 13:47:38.989001159 O: agentforwarding 616s 13:47:39.014974913 O: command line override 616s 13:47:39.029288945 O: ok ssh config parse 616s 13:47:39.029894117 E: run test cfgparse.sh ... 616s 13:47:39.172772828 O: reparse minimal config 616s 13:47:39.324712994 O: reparse regress config 616s 13:47:39.477520006 O: listenaddress order 616s 13:47:39.633622146 E: run test cfgmatch.sh ... 616s 13:47:39.633097451 O: ok sshd config parse 624s 13:47:47.776027225 O: ok sshd_config match 624s 13:47:47.776726086 E: run test cfgmatchlisten.sh ... 644s 13:48:07.426881570 O: ok sshd_config matchlisten 644s 13:48:07.427399678 E: run test percent.sh ... 644s 13:48:07.620282643 O: percent expansions matchexec percent 649s 13:48:12.304719588 O: percent expansions localcommand percent 653s 13:48:16.340913161 O: percent expansions remotecommand percent 653s 13:48:16.431917737 O: percent expansions controlpath percent 653s 13:48:16.517983182 O: percent expansions identityagent percent 653s 13:48:16.604882453 O: percent expansions forwardagent percent 653s 13:48:16.697518531 O: percent expansions localforward percent 653s 13:48:16.785779773 O: percent expansions remoteforward percent 653s 13:48:16.873770970 O: percent expansions revokedhostkeys percent 654s 13:48:16.961754385 O: percent expansions userknownhostsfile percent 657s 13:48:20.350831767 O: percent expansions controlpath dollar 657s 13:48:20.358405540 O: percent expansions identityagent dollar 657s 13:48:20.366216179 O: percent expansions forwardagent dollar 657s 13:48:20.373646306 O: percent expansions localforward dollar 657s 13:48:20.381348599 O: percent expansions remoteforward dollar 657s 13:48:20.388992288 O: percent expansions userknownhostsfile dollar 657s 13:48:20.694174985 O: percent expansions controlpath tilde 657s 13:48:20.708536968 O: percent expansions identityagent tilde 657s 13:48:20.723270083 O: percent expansions forwardagent tilde 657s 13:48:20.738414834 O: ok percent expansions 657s 13:48:20.739221921 E: run test addrmatch.sh ... 657s 13:48:20.879742158 O: test first entry for user 192.168.0.1 somehost 658s 13:48:20.951588445 O: test negative match for user 192.168.30.1 somehost 658s 13:48:21.023585970 O: test no match for user 19.0.0.1 somehost 658s 13:48:21.095334713 O: test list middle for user 10.255.255.254 somehost 658s 13:48:21.167402102 O: test faked IP in hostname for user 192.168.30.1 192.168.0.1 658s 13:48:21.239396611 O: test bare IP4 address for user 1.1.1.1 somehost.example.com 658s 13:48:21.311555998 O: test localaddress for user 19.0.0.1 somehost 658s 13:48:21.383098826 O: test localport for user 19.0.0.1 somehost 658s 13:48:21.454806638 O: test bare IP6 address for user ::1 somehost.example.com 658s 13:48:21.633805922 O: test deny IPv6 for user ::2 somehost.example.com 658s 13:48:21.714725553 O: test IP6 negated for user ::3 somehost 658s 13:48:21.786368452 O: test IP6 no match for user ::4 somehost 659s 13:48:21.958636174 O: test IP6 network for user 2000::1 somehost 659s 13:48:22.032221359 O: test IP6 network for user 2001::1 somehost 659s 13:48:22.104273263 O: test IP6 localaddress for user ::5 somehost 659s 13:48:22.250909009 O: test IP6 localport for user ::5 somehost 659s 13:48:22.385959181 O: test invalid Match address 10.0.1.0/8 659s 13:48:22.392985552 O: test invalid Match localaddress 10.0.1.0/8 659s 13:48:22.399661494 O: test invalid Match address 10.0.0.1/24 659s 13:48:22.406317149 O: test invalid Match localaddress 10.0.0.1/24 659s 13:48:22.413034559 O: test invalid Match address 2000:aa:bb:01::/56 659s 13:48:22.419694353 O: test invalid Match localaddress 2000:aa:bb:01::/56 659s 13:48:22.427439267 O: ok address match 659s 13:48:22.427747259 E: run test localcommand.sh ... 659s 13:48:22.567533288 O: test localcommand: proto localcommand 660s 13:48:22.899805388 E: run test forcecommand.sh ... 660s 13:48:22.899092858 O: ok localcommand 661s 13:48:24.562554805 E: Connection closed 661s 13:48:24.563181775 E: Connection closed. 662s 13:48:25.197895341 E: Connection closed. 662s 13:48:25.198663033 E: Connection closed 662s 13:48:25.527728593 O: ok forced command 662s 13:48:25.528482576 E: run test portnum.sh ... 662s 13:48:25.666685383 O: port number parsing: invalid port 0 662s 13:48:25.671898887 O: port number parsing: invalid port 65536 662s 13:48:25.677063180 O: port number parsing: invalid port 131073 662s 13:48:25.682378357 O: port number parsing: invalid port 2000blah 662s 13:48:25.687620786 O: port number parsing: invalid port blah2000 662s 13:48:25.692742569 O: port number parsing: valid port 1 663s 13:48:26.017587167 O: port number parsing: valid port 22 663s 13:48:26.342224704 O: port number parsing: valid port 2222 663s 13:48:26.666982485 O: port number parsing: valid port 22222 664s 13:48:26.993682775 O: port number parsing: valid port 65535 664s 13:48:27.321760150 O: ok port number parsing 664s 13:48:27.322317961 E: run test keytype.sh ... 664s 13:48:27.462672526 O: keygen ed25519, 512 bits 664s 13:48:27.469594583 O: keygen ed25519-sk, n/a bits 664s 13:48:27.478858455 O: keygen ecdsa, 256 bits 664s 13:48:27.484917241 O: keygen ecdsa, 384 bits 664s 13:48:27.490940998 O: keygen ecdsa, 521 bits 664s 13:48:27.497044028 O: keygen ecdsa-sk, n/a bits 664s 13:48:27.510143070 O: keygen rsa, 2048 bits 664s 13:48:27.827692893 O: keygen rsa, 3072 bits 665s 13:48:28.549242842 O: userkey ed25519-512, hostkey ed25519-512 665s 13:48:28.686934372 O: userkey ed25519-512, hostkey ed25519-512 665s 13:48:28.823531664 O: userkey ed25519-512, hostkey ed25519-512 666s 13:48:28.963890076 O: userkey ed25519-sk, hostkey ed25519-sk 666s 13:48:29.104557673 O: userkey ed25519-sk, hostkey ed25519-sk 666s 13:48:29.245067095 O: userkey ed25519-sk, hostkey ed25519-sk 666s 13:48:29.389753530 O: userkey ecdsa-256, hostkey ecdsa-256 666s 13:48:29.563346272 O: userkey ecdsa-256, hostkey ecdsa-256 666s 13:48:29.823832600 O: userkey ecdsa-256, hostkey ecdsa-256 667s 13:48:30.869293218 O: userkey ecdsa-384, hostkey ecdsa-384 668s 13:48:31.282169604 O: userkey ecdsa-384, hostkey ecdsa-384 669s 13:48:32.444039561 O: userkey ecdsa-384, hostkey ecdsa-384 670s 13:48:33.460408109 O: userkey ecdsa-521, hostkey ecdsa-521 672s 13:48:34.909914868 O: userkey ecdsa-521, hostkey ecdsa-521 673s 13:48:36.308377794 O: userkey ecdsa-521, hostkey ecdsa-521 674s 13:48:37.078041657 O: userkey ecdsa-sk, hostkey ecdsa-sk 676s 13:48:38.964658423 O: userkey ecdsa-sk, hostkey ecdsa-sk 676s 13:48:39.553259677 O: userkey ecdsa-sk, hostkey ecdsa-sk 677s 13:48:40.426355575 O: userkey rsa-2048, hostkey rsa-2048 677s 13:48:40.698953592 O: userkey rsa-2048, hostkey rsa-2048 678s 13:48:40.959008374 O: userkey rsa-2048, hostkey rsa-2048 678s 13:48:41.191167213 O: userkey rsa-3072, hostkey rsa-3072 678s 13:48:41.356259908 O: userkey rsa-3072, hostkey rsa-3072 678s 13:48:41.630481571 O: userkey rsa-3072, hostkey rsa-3072 679s 13:48:41.926762959 O: ok login with different key types 679s 13:48:41.928239268 E: run test kextype.sh ... 679s 13:48:42.082244005 O: kex diffie-hellman-group1-sha1 680s 13:48:43.194092432 O: kex diffie-hellman-group14-sha1 681s 13:48:44.181655389 O: kex diffie-hellman-group14-sha256 682s 13:48:45.240590079 O: kex diffie-hellman-group16-sha512 683s 13:48:46.389172184 O: kex diffie-hellman-group18-sha512 685s 13:48:48.098872577 O: kex diffie-hellman-group-exchange-sha1 687s 13:48:49.995453827 O: kex diffie-hellman-group-exchange-sha256 688s 13:48:51.795918587 O: kex ecdh-sha2-nistp256 689s 13:48:52.735510693 O: kex ecdh-sha2-nistp384 690s 13:48:53.693328909 O: kex ecdh-sha2-nistp521 691s 13:48:54.689824135 O: kex curve25519-sha256 693s 13:48:55.925206810 O: kex curve25519-sha256@libssh.org 694s 13:48:56.915786559 O: kex sntrup761x25519-sha512 695s 13:48:58.225077280 O: kex sntrup761x25519-sha512@openssh.com 696s 13:48:59.770127349 O: kex mlkem768x25519-sha256 697s 13:49:00.799011572 O: ok login with different key exchange algorithms 697s 13:49:00.800115274 E: run test cert-hostkey.sh ... 698s 13:49:01.548669186 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/host_ca_key.pub 698s 13:49:01.549477546 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/host_ca_key2.pub 698s 13:49:01.550169337 O: certified host keys: sign host ed25519 cert 698s 13:49:01.556286134 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ed25519.pub 698s 13:49:01.566213094 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ed25519-cert.pub 698s 13:49:01.568462306 O: certified host keys: sign host sk-ssh-ed25519@openssh.com cert 698s 13:49:01.577738085 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_sk-ssh-ed25519@openssh.com.pub 698s 13:49:01.587797049 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_sk-ssh-ed25519@openssh.com-cert.pub 698s 13:49:01.589585737 O: certified host keys: sign host ecdsa-sha2-nistp256 cert 698s 13:49:01.597745221 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp256.pub 698s 13:49:01.611067716 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp256-cert.pub 698s 13:49:01.612702516 O: certified host keys: sign host ecdsa-sha2-nistp384 cert 698s 13:49:01.622762967 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp384.pub 698s 13:49:01.640614131 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp384-cert.pub 698s 13:49:01.642240258 O: certified host keys: sign host ecdsa-sha2-nistp521 cert 698s 13:49:01.656225881 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp521.pub 698s 13:49:01.682488479 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp521-cert.pub 698s 13:49:01.684196262 O: certified host keys: sign host sk-ecdsa-sha2-nistp256@openssh.com cert 698s 13:49:01.698840411 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_sk-ecdsa-sha2-nistp256@openssh.com.pub 698s 13:49:01.712359670 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_sk-ecdsa-sha2-nistp256@openssh.com-cert.pub 698s 13:49:01.714128217 O: certified host keys: sign host rsa cert 699s 13:49:02.691621740 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_rsa.pub 699s 13:49:02.701261070 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_rsa-cert.pub 699s 13:49:02.702997320 O: certified host keys: sign host rsa-sha2-256 cert 700s 13:49:03.489392843 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-256.pub 700s 13:49:03.506736623 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-256-cert.pub 700s 13:49:03.508589474 O: certified host keys: sign host rsa-sha2-512 cert 700s 13:49:03.602258320 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-512.pub 700s 13:49:03.619235977 O: Revoking from /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-512-cert.pub 700s 13:49:03.620909612 O: certified host keys: host ed25519 cert connect 700s 13:49:03.622037179 O: certified host keys: ed25519 basic connect expect success yes 701s 13:49:03.893488532 O: certified host keys: ed25519 empty KRL expect success yes 701s 13:49:04.170133384 O: certified host keys: ed25519 KRL w/ plain key revoked expect success no 701s 13:49:04.401319554 O: certified host keys: ed25519 KRL w/ cert revoked expect success no 701s 13:49:04.716182755 O: certified host keys: ed25519 KRL w/ CA revoked expect success no 702s 13:49:05.039423686 O: certified host keys: ed25519 empty plaintext revocation expect success yes 702s 13:49:05.311507408 O: certified host keys: ed25519 plain key plaintext revocation expect success no 702s 13:49:05.550032034 O: certified host keys: ed25519 cert plaintext revocation expect success no 702s 13:49:05.790312148 O: certified host keys: ed25519 CA plaintext revocation expect success no 703s 13:49:06.017370122 O: certified host keys: host sk-ssh-ed25519@openssh.com cert connect 703s 13:49:06.018687481 O: certified host keys: sk-ssh-ed25519@openssh.com basic connect expect success yes 703s 13:49:06.288770735 O: certified host keys: sk-ssh-ed25519@openssh.com empty KRL expect success yes 703s 13:49:06.557299026 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ plain key revoked expect success no 703s 13:49:06.787580311 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ cert revoked expect success no 704s 13:49:07.017487760 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ CA revoked expect success no 704s 13:49:07.248775675 O: certified host keys: sk-ssh-ed25519@openssh.com empty plaintext revocation expect success yes 704s 13:49:07.525215704 O: certified host keys: sk-ssh-ed25519@openssh.com plain key plaintext revocation expect success no 704s 13:49:07.756127117 O: certified host keys: sk-ssh-ed25519@openssh.com cert plaintext revocation expect success no 705s 13:49:07.990892102 O: certified host keys: sk-ssh-ed25519@openssh.com CA plaintext revocation expect success no 705s 13:49:08.220744037 O: certified host keys: host ecdsa-sha2-nistp256 cert connect 705s 13:49:08.222239137 O: certified host keys: ecdsa-sha2-nistp256 basic connect expect success yes 705s 13:49:08.518360850 O: certified host keys: ecdsa-sha2-nistp256 empty KRL expect success yes 705s 13:49:08.815957977 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ plain key revoked expect success no 706s 13:49:09.062398818 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ cert revoked expect success no 706s 13:49:09.308591349 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ CA revoked expect success no 706s 13:49:09.723198655 O: certified host keys: ecdsa-sha2-nistp256 empty plaintext revocation expect success yes 707s 13:49:10.019497891 O: certified host keys: ecdsa-sha2-nistp256 plain key plaintext revocation expect success no 707s 13:49:10.268498205 O: certified host keys: ecdsa-sha2-nistp256 cert plaintext revocation expect success no 707s 13:49:10.525794639 O: certified host keys: ecdsa-sha2-nistp256 CA plaintext revocation expect success no 707s 13:49:10.771173737 O: certified host keys: host ecdsa-sha2-nistp384 cert connect 707s 13:49:10.772507739 O: certified host keys: ecdsa-sha2-nistp384 basic connect expect success yes 708s 13:49:11.094846154 O: certified host keys: ecdsa-sha2-nistp384 empty KRL expect success yes 708s 13:49:11.418430156 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ plain key revoked expect success no 708s 13:49:11.687160844 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ cert revoked expect success no 709s 13:49:11.956516225 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ CA revoked expect success no 709s 13:49:12.226836634 O: certified host keys: ecdsa-sha2-nistp384 empty plaintext revocation expect success yes 709s 13:49:12.548938451 O: certified host keys: ecdsa-sha2-nistp384 plain key plaintext revocation expect success no 709s 13:49:12.823965195 O: certified host keys: ecdsa-sha2-nistp384 cert plaintext revocation expect success no 710s 13:49:13.109130050 O: certified host keys: ecdsa-sha2-nistp384 CA plaintext revocation expect success no 710s 13:49:13.378455901 O: certified host keys: host ecdsa-sha2-nistp521 cert connect 710s 13:49:13.379523889 O: certified host keys: ecdsa-sha2-nistp521 basic connect expect success yes 710s 13:49:13.755210424 O: certified host keys: ecdsa-sha2-nistp521 empty KRL expect success yes 711s 13:49:14.127770615 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ plain key revoked expect success no 711s 13:49:14.435966360 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ cert revoked expect success no 711s 13:49:14.742911617 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ CA revoked expect success no 712s 13:49:15.049874899 O: certified host keys: ecdsa-sha2-nistp521 empty plaintext revocation expect success yes 712s 13:49:15.426542889 O: certified host keys: ecdsa-sha2-nistp521 plain key plaintext revocation expect success no 712s 13:49:15.748381150 O: certified host keys: ecdsa-sha2-nistp521 cert plaintext revocation expect success no 713s 13:49:16.142828494 O: certified host keys: ecdsa-sha2-nistp521 CA plaintext revocation expect success no 713s 13:49:16.450847619 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com cert connect 713s 13:49:16.452053631 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com basic connect expect success yes 713s 13:49:16.751108643 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com empty KRL expect success yes 714s 13:49:17.052019174 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ plain key revoked expect success no 714s 13:49:17.302917300 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ cert revoked expect success no 714s 13:49:17.554099637 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ CA revoked expect success no 714s 13:49:17.804714602 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com empty plaintext revocation expect success yes 715s 13:49:18.103597319 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com plain key plaintext revocation expect success no 715s 13:49:18.369511177 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com cert plaintext revocation expect success no 715s 13:49:18.652408490 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com CA plaintext revocation expect success no 716s 13:49:18.902791943 O: certified host keys: host rsa cert connect 716s 13:49:18.904124541 O: certified host keys: rsa basic connect expect success yes 716s 13:49:19.186507692 O: certified host keys: rsa empty KRL expect success yes 716s 13:49:19.467272925 O: certified host keys: rsa KRL w/ plain key revoked expect success no 716s 13:49:19.708488263 O: certified host keys: rsa KRL w/ cert revoked expect success no 717s 13:49:19.948464240 O: certified host keys: rsa KRL w/ CA revoked expect success no 717s 13:49:20.188730672 O: certified host keys: rsa empty plaintext revocation expect success yes 717s 13:49:20.470244194 O: certified host keys: rsa plain key plaintext revocation expect success no 717s 13:49:20.739114406 O: certified host keys: rsa cert plaintext revocation expect success no 718s 13:49:21.014330712 O: certified host keys: rsa CA plaintext revocation expect success no 718s 13:49:21.255084326 O: certified host keys: host rsa-sha2-256 cert connect 718s 13:49:21.256541977 O: certified host keys: rsa-sha2-256 basic connect expect success yes 718s 13:49:21.526101493 O: certified host keys: rsa-sha2-256 empty KRL expect success yes 718s 13:49:21.795093758 O: certified host keys: rsa-sha2-256 KRL w/ plain key revoked expect success no 719s 13:49:22.028977451 O: certified host keys: rsa-sha2-256 KRL w/ cert revoked expect success no 719s 13:49:22.262609423 O: certified host keys: rsa-sha2-256 KRL w/ CA revoked expect success no 719s 13:49:22.495990999 O: certified host keys: rsa-sha2-256 empty plaintext revocation expect success yes 719s 13:49:22.763306217 O: certified host keys: rsa-sha2-256 plain key plaintext revocation expect success no 720s 13:49:23.011664614 O: certified host keys: rsa-sha2-256 cert plaintext revocation expect success no 720s 13:49:23.280148478 O: certified host keys: rsa-sha2-256 CA plaintext revocation expect success no 720s 13:49:23.513257162 O: certified host keys: host rsa-sha2-512 cert connect 720s 13:49:23.514442098 O: certified host keys: rsa-sha2-512 basic connect expect success yes 720s 13:49:23.791220179 O: certified host keys: rsa-sha2-512 empty KRL expect success yes 721s 13:49:24.065712904 O: certified host keys: rsa-sha2-512 KRL w/ plain key revoked expect success no 721s 13:49:24.298915080 O: certified host keys: rsa-sha2-512 KRL w/ cert revoked expect success no 721s 13:49:24.533141970 O: certified host keys: rsa-sha2-512 KRL w/ CA revoked expect success no 721s 13:49:24.766774452 O: certified host keys: rsa-sha2-512 empty plaintext revocation expect success yes 722s 13:49:25.040873897 O: certified host keys: rsa-sha2-512 plain key plaintext revocation expect success no 722s 13:49:25.289890036 O: certified host keys: rsa-sha2-512 cert plaintext revocation expect success no 722s 13:49:25.558196408 O: certified host keys: rsa-sha2-512 CA plaintext revocation expect success no 722s 13:49:25.798072259 O: certified host keys: host ed25519 revoked cert 723s 13:49:26.059305225 O: certified host keys: host sk-ssh-ed25519@openssh.com revoked cert 723s 13:49:26.321911828 O: certified host keys: host ecdsa-sha2-nistp256 revoked cert 723s 13:49:26.599263275 O: certified host keys: host ecdsa-sha2-nistp384 revoked cert 724s 13:49:26.900608846 O: certified host keys: host ecdsa-sha2-nistp521 revoked cert 724s 13:49:27.239976587 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com revoked cert 724s 13:49:27.524285953 O: certified host keys: host rsa revoked cert 724s 13:49:27.795890517 O: certified host keys: host rsa-sha2-256 revoked cert 725s 13:49:28.062232172 O: certified host keys: host rsa-sha2-512 revoked cert 725s 13:49:28.329844993 O: certified host keys: host ed25519 revoked cert 725s 13:49:28.558563294 O: certified host keys: host sk-ssh-ed25519@openssh.com revoked cert 725s 13:49:28.789697178 O: certified host keys: host ecdsa-sha2-nistp256 revoked cert 726s 13:49:29.036582642 O: certified host keys: host ecdsa-sha2-nistp384 revoked cert 726s 13:49:29.305113034 O: certified host keys: host ecdsa-sha2-nistp521 revoked cert 726s 13:49:29.675906732 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com revoked cert 727s 13:49:29.991986584 O: certified host keys: host rsa revoked cert 727s 13:49:30.233864757 O: certified host keys: host rsa-sha2-256 revoked cert 727s 13:49:30.468114360 O: certified host keys: host rsa-sha2-512 revoked cert 758s 13:50:01.816583844 O: certified host keys: host ed25519 cert downgrade to raw key 759s 13:50:02.380701664 O: certified host keys: host sk-ssh-ed25519@openssh.com cert downgrade to raw key 760s 13:50:02.949855091 O: certified host keys: host ecdsa-sha2-nistp256 cert downgrade to raw key 760s 13:50:03.549317421 O: certified host keys: host ecdsa-sha2-nistp384 cert downgrade to raw key 761s 13:50:04.216512635 O: certified host keys: host ecdsa-sha2-nistp521 cert downgrade to raw key 762s 13:50:04.988780705 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com cert downgrade to raw key 762s 13:50:05.605600961 O: certified host keys: host rsa cert downgrade to raw key 763s 13:50:06.427242523 O: certified host keys: host rsa-sha2-256 cert downgrade to raw key 764s 13:50:07.473831914 O: certified host keys: host rsa-sha2-512 cert downgrade to raw key 765s 13:50:08.308397169 O: certified host keys: host ed25519 connect wrong cert 765s 13:50:08.550975603 O: certified host keys: host sk-ssh-ed25519@openssh.com connect wrong cert 765s 13:50:08.794837521 O: certified host keys: host ecdsa-sha2-nistp256 connect wrong cert 766s 13:50:09.052432225 O: certified host keys: host ecdsa-sha2-nistp384 connect wrong cert 766s 13:50:09.350967906 O: certified host keys: host ecdsa-sha2-nistp521 connect wrong cert 766s 13:50:09.710672977 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com connect wrong cert 767s 13:50:09.994351588 O: certified host keys: host rsa connect wrong cert 767s 13:50:10.480719700 O: certified host keys: host rsa-sha2-256 connect wrong cert 768s 13:50:11.041371662 O: certified host keys: host rsa-sha2-512 connect wrong cert 769s 13:50:12.469792935 O: ok certified host keys 769s 13:50:12.470747741 E: run test cert-userkey.sh ... 770s 13:50:13.015913888 O: certified user keys: sign user ed25519 cert 770s 13:50:13.033599298 O: certified user keys: sign user sk-ssh-ed25519@openssh.com cert 770s 13:50:13.053434530 O: certified user keys: sign user ecdsa-sha2-nistp256 cert 770s 13:50:13.071933515 O: certified user keys: sign user ecdsa-sha2-nistp384 cert 770s 13:50:13.092659463 O: certified user keys: sign user ecdsa-sha2-nistp521 cert 770s 13:50:13.117357025 O: certified user keys: sign user sk-ecdsa-sha2-nistp256@openssh.com cert 770s 13:50:13.142528221 O: certified user keys: sign user rsa cert 771s 13:50:13.960686295 O: certified user keys: sign user rsa-sha2-256 cert 771s 13:50:14.805650389 O: certified user keys: sign user rsa-sha2-512 cert 772s 13:50:15.687971132 O: certified user keys: ed25519 missing authorized_principals 773s 13:50:16.040091664 O: certified user keys: ed25519 empty authorized_principals 773s 13:50:16.386846525 O: certified user keys: ed25519 wrong authorized_principals 773s 13:50:16.721105338 O: certified user keys: ed25519 correct authorized_principals 774s 13:50:17.060677295 O: certified user keys: ed25519 authorized_principals bad key opt 774s 13:50:17.408459013 O: certified user keys: ed25519 authorized_principals command=false 774s 13:50:17.774947645 O: certified user keys: ed25519 authorized_principals command=true 775s 13:50:18.390017368 O: certified user keys: ed25519 wrong principals key option 775s 13:50:18.830198618 O: certified user keys: ed25519 correct principals key option 776s 13:50:19.179932756 O: certified user keys: sk-ssh-ed25519@openssh.com missing authorized_principals 776s 13:50:19.514581819 O: certified user keys: sk-ssh-ed25519@openssh.com empty authorized_principals 776s 13:50:19.837950523 O: certified user keys: sk-ssh-ed25519@openssh.com wrong authorized_principals 777s 13:50:20.162079148 O: certified user keys: sk-ssh-ed25519@openssh.com correct authorized_principals 777s 13:50:20.486269107 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals bad key opt 777s 13:50:20.808768961 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals command=false 778s 13:50:21.134721579 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals command=true 779s 13:50:22.429284052 O: certified user keys: sk-ssh-ed25519@openssh.com wrong principals key option 780s 13:50:23.798003134 O: certified user keys: sk-ssh-ed25519@openssh.com correct principals key option 783s 13:50:26.386004338 O: certified user keys: ecdsa-sha2-nistp256 missing authorized_principals 785s 13:50:28.235443927 O: certified user keys: ecdsa-sha2-nistp256 empty authorized_principals 786s 13:50:29.879550118 O: certified user keys: ecdsa-sha2-nistp256 wrong authorized_principals 788s 13:50:31.315585561 O: certified user keys: ecdsa-sha2-nistp256 correct authorized_principals 789s 13:50:32.273513458 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals bad key opt 790s 13:50:32.979079552 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals command=false 790s 13:50:33.596043921 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals command=true 791s 13:50:33.949210732 O: certified user keys: ecdsa-sha2-nistp256 wrong principals key option 791s 13:50:34.336388978 O: certified user keys: ecdsa-sha2-nistp256 correct principals key option 791s 13:50:34.860222648 O: certified user keys: ecdsa-sha2-nistp384 missing authorized_principals 792s 13:50:35.348904807 O: certified user keys: ecdsa-sha2-nistp384 empty authorized_principals 792s 13:50:35.774594998 O: certified user keys: ecdsa-sha2-nistp384 wrong authorized_principals 793s 13:50:36.124312569 O: certified user keys: ecdsa-sha2-nistp384 correct authorized_principals 793s 13:50:36.487295086 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals bad key opt 793s 13:50:36.825026275 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals command=false 794s 13:50:37.188328069 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals command=true 794s 13:50:37.550859359 O: certified user keys: ecdsa-sha2-nistp384 wrong principals key option 795s 13:50:37.903892885 O: certified user keys: ecdsa-sha2-nistp384 correct principals key option 795s 13:50:38.268923093 O: certified user keys: ecdsa-sha2-nistp521 missing authorized_principals 795s 13:50:38.670364273 O: certified user keys: ecdsa-sha2-nistp521 empty authorized_principals 796s 13:50:39.203700320 O: certified user keys: ecdsa-sha2-nistp521 wrong authorized_principals 796s 13:50:39.605922510 O: certified user keys: ecdsa-sha2-nistp521 correct authorized_principals 797s 13:50:40.019403498 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals bad key opt 797s 13:50:40.424605427 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals command=false 797s 13:50:40.847695678 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals command=true 798s 13:50:41.258451006 O: certified user keys: ecdsa-sha2-nistp521 wrong principals key option 798s 13:50:41.641891475 O: certified user keys: ecdsa-sha2-nistp521 correct principals key option 799s 13:50:42.062579743 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com missing authorized_principals 799s 13:50:42.412353592 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com empty authorized_principals 799s 13:50:42.800551760 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com wrong authorized_principals 800s 13:50:43.232351776 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com correct authorized_principals 800s 13:50:43.641226860 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals bad key opt 801s 13:50:44.094243461 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals command=false 801s 13:50:44.474649431 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals command=true 801s 13:50:44.883087305 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com wrong principals key option 802s 13:50:45.466546633 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com correct principals key option 802s 13:50:45.813282932 O: certified user keys: rsa missing authorized_principals 803s 13:50:46.157676678 O: certified user keys: rsa empty authorized_principals 803s 13:50:46.535823638 O: certified user keys: rsa wrong authorized_principals 804s 13:50:46.986473460 O: certified user keys: rsa correct authorized_principals 804s 13:50:47.324009703 O: certified user keys: rsa authorized_principals bad key opt 804s 13:50:47.720800013 O: certified user keys: rsa authorized_principals command=false 805s 13:50:48.124835265 O: certified user keys: rsa authorized_principals command=true 805s 13:50:48.562434642 O: certified user keys: rsa wrong principals key option 806s 13:50:48.896286173 O: certified user keys: rsa correct principals key option 806s 13:50:49.235722239 O: certified user keys: rsa-sha2-256 missing authorized_principals 806s 13:50:49.569853679 O: certified user keys: rsa-sha2-256 empty authorized_principals 807s 13:50:49.894245529 O: certified user keys: rsa-sha2-256 wrong authorized_principals 807s 13:50:50.237556164 O: certified user keys: rsa-sha2-256 correct authorized_principals 807s 13:50:50.569809396 O: certified user keys: rsa-sha2-256 authorized_principals bad key opt 808s 13:50:50.938524522 O: certified user keys: rsa-sha2-256 authorized_principals command=false 808s 13:50:51.401344757 O: certified user keys: rsa-sha2-256 authorized_principals command=true 808s 13:50:51.874408929 O: certified user keys: rsa-sha2-256 wrong principals key option 809s 13:50:52.352564017 O: certified user keys: rsa-sha2-256 correct principals key option 809s 13:50:52.775173167 O: certified user keys: rsa-sha2-512 missing authorized_principals 810s 13:50:53.129660864 O: certified user keys: rsa-sha2-512 empty authorized_principals 810s 13:50:53.484624338 O: certified user keys: rsa-sha2-512 wrong authorized_principals 811s 13:50:53.895614030 O: certified user keys: rsa-sha2-512 correct authorized_principals 811s 13:50:54.278100922 O: certified user keys: rsa-sha2-512 authorized_principals bad key opt 811s 13:50:54.730186538 O: certified user keys: rsa-sha2-512 authorized_principals command=false 812s 13:50:55.174169677 O: certified user keys: rsa-sha2-512 authorized_principals command=true 812s 13:50:55.661600462 O: certified user keys: rsa-sha2-512 wrong principals key option 813s 13:50:56.028544163 O: certified user keys: rsa-sha2-512 correct principals key option 813s 13:50:56.361429362 O: certified user keys: ed25519 authorized_keys connect 813s 13:50:56.699531833 O: certified user keys: ed25519 authorized_keys revoked key 814s 13:50:57.020447499 O: certified user keys: ed25519 authorized_keys revoked via KRL 814s 13:50:57.343858338 O: certified user keys: ed25519 authorized_keys empty KRL 814s 13:50:57.673921345 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys connect 815s 13:50:58.013139729 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys revoked key 815s 13:50:58.342440677 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys revoked via KRL 815s 13:50:58.676785506 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys empty KRL 816s 13:50:59.007112291 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys connect 816s 13:50:59.344428552 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys revoked key 816s 13:50:59.687966492 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys revoked via KRL 817s 13:51:00.027664399 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys empty KRL 817s 13:51:00.383551419 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys connect 817s 13:51:00.777821994 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys revoked key 818s 13:51:01.147249367 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys revoked via KRL 818s 13:51:01.546310195 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys empty KRL 819s 13:51:01.918975163 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys connect 819s 13:51:02.335256663 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys revoked key 819s 13:51:02.820991883 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys revoked via KRL 821s 13:51:04.791666468 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys empty KRL 823s 13:51:06.462403431 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys connect 825s 13:51:08.358801515 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys revoked key 826s 13:51:09.571201303 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys revoked via KRL 827s 13:51:10.424953353 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys empty KRL 829s 13:51:12.636827281 O: certified user keys: rsa authorized_keys connect 830s 13:51:13.670440276 O: certified user keys: rsa authorized_keys revoked key 831s 13:51:14.726871508 O: certified user keys: rsa authorized_keys revoked via KRL 832s 13:51:15.100378414 O: certified user keys: rsa authorized_keys empty KRL 832s 13:51:15.541293468 O: certified user keys: rsa-sha2-256 authorized_keys connect 833s 13:51:15.896745888 O: certified user keys: rsa-sha2-256 authorized_keys revoked key 833s 13:51:16.234743132 O: certified user keys: rsa-sha2-256 authorized_keys revoked via KRL 833s 13:51:16.558789396 O: certified user keys: rsa-sha2-256 authorized_keys empty KRL 833s 13:51:16.892798143 O: certified user keys: rsa-sha2-512 authorized_keys connect 834s 13:51:17.229055669 O: certified user keys: rsa-sha2-512 authorized_keys revoked key 834s 13:51:17.549867131 O: certified user keys: rsa-sha2-512 authorized_keys revoked via KRL 834s 13:51:17.872278898 O: certified user keys: rsa-sha2-512 authorized_keys empty KRL 835s 13:51:18.203870745 O: certified user keys: rsa-sha2-512 authorized_keys revoked CA key 835s 13:51:18.543597854 O: certified user keys: authorized_keys CA does not authenticate 835s 13:51:18.544869486 O: certified user keys: ensure CA key does not authenticate user 835s 13:51:18.862334514 O: certified user keys: ed25519 TrustedUserCAKeys connect 836s 13:51:19.198089458 O: certified user keys: ed25519 TrustedUserCAKeys revoked key 836s 13:51:19.563090446 O: certified user keys: ed25519 TrustedUserCAKeys revoked via KRL 836s 13:51:19.888323872 O: certified user keys: ed25519 TrustedUserCAKeys empty KRL 837s 13:51:20.218280869 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys connect 837s 13:51:20.554277678 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys revoked key 837s 13:51:20.890269424 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys revoked via KRL 838s 13:51:21.340811541 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys empty KRL 838s 13:51:21.674583365 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys connect 839s 13:51:22.027239533 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys revoked key 839s 13:51:22.372970685 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys revoked via KRL 839s 13:51:22.702724772 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys empty KRL 840s 13:51:23.042027372 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys connect 840s 13:51:23.499430231 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys revoked key 841s 13:51:23.937853123 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys revoked via KRL 841s 13:51:24.347800544 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys empty KRL 841s 13:51:24.805551225 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys connect 842s 13:51:25.241183650 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys revoked key 842s 13:51:25.741604950 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys revoked via KRL 843s 13:51:26.146027710 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys empty KRL 843s 13:51:26.694249274 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys connect 844s 13:51:27.054211932 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys revoked key 844s 13:51:27.399716112 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys revoked via KRL 844s 13:51:27.748990943 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys empty KRL 845s 13:51:28.165341717 O: certified user keys: rsa TrustedUserCAKeys connect 845s 13:51:28.604557483 O: certified user keys: rsa TrustedUserCAKeys revoked key 846s 13:51:29.017497155 O: certified user keys: rsa TrustedUserCAKeys revoked via KRL 846s 13:51:29.365761899 O: certified user keys: rsa TrustedUserCAKeys empty KRL 846s 13:51:29.847066351 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys connect 847s 13:51:30.179908177 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys revoked key 847s 13:51:30.513385950 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys revoked via KRL 847s 13:51:30.850189867 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys empty KRL 848s 13:51:31.206622470 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys connect 848s 13:51:31.563212711 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked key 849s 13:51:31.898889622 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked via KRL 849s 13:51:32.246386920 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys empty KRL 849s 13:51:32.586922928 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked CA key 850s 13:51:32.924539349 O: certified user keys: TrustedUserCAKeys CA does not authenticate 850s 13:51:32.925511169 O: certified user keys: ensure CA key does not authenticate user 850s 13:51:33.255453487 O: certified user keys: correct principal auth authorized_keys expect success rsa 850s 13:51:33.613803572 O: certified user keys: correct principal auth authorized_keys expect success ed25519 851s 13:51:33.968232257 O: certified user keys: correct principal auth TrustedUserCAKeys expect success rsa 851s 13:51:34.317858404 O: certified user keys: correct principal auth TrustedUserCAKeys expect success ed25519 851s 13:51:34.674205772 O: certified user keys: host-certificate auth authorized_keys expect failure rsa 852s 13:51:35.015258744 O: certified user keys: host-certificate auth authorized_keys expect failure ed25519 852s 13:51:35.351094735 O: certified user keys: host-certificate auth TrustedUserCAKeys expect failure rsa 852s 13:51:35.681729231 O: certified user keys: host-certificate auth TrustedUserCAKeys expect failure ed25519 853s 13:51:36.013443612 O: certified user keys: wrong principals auth authorized_keys expect failure rsa 853s 13:51:36.361191544 O: certified user keys: wrong principals auth authorized_keys expect failure ed25519 853s 13:51:36.706832260 O: certified user keys: wrong principals auth TrustedUserCAKeys expect failure rsa 854s 13:51:37.042211383 O: certified user keys: wrong principals auth TrustedUserCAKeys expect failure ed25519 854s 13:51:37.379389107 O: certified user keys: cert not yet valid auth authorized_keys expect failure rsa 854s 13:51:37.887328146 O: certified user keys: cert not yet valid auth authorized_keys expect failure ed25519 855s 13:51:38.276621857 O: certified user keys: cert not yet valid auth TrustedUserCAKeys expect failure rsa 855s 13:51:38.614457786 O: certified user keys: cert not yet valid auth TrustedUserCAKeys expect failure ed25519 856s 13:51:38.951363388 O: certified user keys: cert expired auth authorized_keys expect failure rsa 856s 13:51:39.297971198 O: certified user keys: cert expired auth authorized_keys expect failure ed25519 856s 13:51:39.654056779 O: certified user keys: cert expired auth TrustedUserCAKeys expect failure rsa 857s 13:51:39.990152017 O: certified user keys: cert expired auth TrustedUserCAKeys expect failure ed25519 857s 13:51:40.325535169 O: certified user keys: cert valid interval auth authorized_keys expect success rsa 857s 13:51:40.676494505 O: certified user keys: cert valid interval auth authorized_keys expect success ed25519 858s 13:51:41.036013774 O: certified user keys: cert valid interval auth TrustedUserCAKeys expect success rsa 858s 13:51:41.385735993 O: certified user keys: cert valid interval auth TrustedUserCAKeys expect success ed25519 858s 13:51:41.744499040 O: certified user keys: wrong source-address auth authorized_keys expect failure rsa 859s 13:51:42.084180366 O: certified user keys: wrong source-address auth authorized_keys expect failure ed25519 859s 13:51:42.441027833 O: certified user keys: wrong source-address auth TrustedUserCAKeys expect failure rsa 859s 13:51:42.776266917 O: certified user keys: wrong source-address auth TrustedUserCAKeys expect failure ed25519 860s 13:51:43.112456756 O: certified user keys: force-command auth authorized_keys expect failure rsa 860s 13:51:43.462407711 O: certified user keys: force-command auth authorized_keys expect failure ed25519 861s 13:51:44.864551083 O: certified user keys: force-command auth TrustedUserCAKeys expect failure rsa 864s 13:51:47.757883271 O: certified user keys: force-command auth TrustedUserCAKeys expect failure ed25519 865s 13:51:48.671470077 O: certified user keys: empty principals auth authorized_keys expect success rsa 867s 13:51:50.418341103 O: certified user keys: empty principals auth authorized_keys expect success ed25519 868s 13:51:51.362296484 O: certified user keys: empty principals auth TrustedUserCAKeys expect failure rsa 869s 13:51:52.663735046 O: certified user keys: empty principals auth TrustedUserCAKeys expect failure ed25519 870s 13:51:53.635554575 O: certified user keys: AuthorizedPrincipalsFile principals auth TrustedUserCAKeys expect success rsa 871s 13:51:54.178242080 O: certified user keys: AuthorizedPrincipalsFile principals auth TrustedUserCAKeys expect success ed25519 871s 13:51:54.634143155 O: certified user keys: AuthorizedPrincipalsFile no principals auth TrustedUserCAKeys expect failure rsa 872s 13:51:55.019090163 O: certified user keys: AuthorizedPrincipalsFile no principals auth TrustedUserCAKeys expect failure ed25519 872s 13:51:55.359207052 O: certified user keys: principals key option principals auth authorized_keys expect success rsa 872s 13:51:55.723149561 O: certified user keys: principals key option principals auth authorized_keys expect success ed25519 873s 13:51:56.080080985 O: certified user keys: principals key option no principals auth authorized_keys expect failure rsa 873s 13:51:56.437468544 O: certified user keys: principals key option no principals auth authorized_keys expect failure ed25519 873s 13:51:56.784708385 O: certified user keys: force-command match true auth authorized_keys expect success rsa 874s 13:51:57.136446669 O: certified user keys: force-command match true auth authorized_keys expect success ed25519 874s 13:51:57.498252524 O: certified user keys: force-command match true auth authorized_keys expect failure rsa 874s 13:51:57.861627295 O: certified user keys: force-command match true auth authorized_keys expect failure ed25519 875s 13:51:58.209691134 O: certified user keys: force-command mismatch 1 auth authorized_keys expect failure rsa 875s 13:51:58.565865288 O: certified user keys: force-command mismatch 1 auth authorized_keys expect failure ed25519 876s 13:51:58.981917927 O: certified user keys: force-command mismatch 2 auth authorized_keys expect failure rsa 876s 13:51:59.328267469 O: certified user keys: force-command mismatch 2 auth authorized_keys expect failure ed25519 876s 13:51:59.725651544 O: certified user keys: user ed25519 connect wrong cert 877s 13:52:00.064841615 O: certified user keys: user sk-ssh-ed25519@openssh.com connect wrong cert 877s 13:52:00.388682909 O: certified user keys: user ecdsa-sha2-nistp256 connect wrong cert 877s 13:52:00.718905725 O: certified user keys: user ecdsa-sha2-nistp384 connect wrong cert 878s 13:52:01.061611713 O: certified user keys: user ecdsa-sha2-nistp521 connect wrong cert 878s 13:52:01.404719655 O: certified user keys: user sk-ecdsa-sha2-nistp256@openssh.com connect wrong cert 878s 13:52:01.734411921 O: certified user keys: user rsa connect wrong cert 879s 13:52:02.078446447 O: certified user keys: user rsa-sha2-256 connect wrong cert 879s 13:52:02.426073530 O: certified user keys: user rsa-sha2-512 connect wrong cert 879s 13:52:02.766946881 O: ok certified user keys 879s 13:52:02.767775307 E: run test host-expand.sh ... 880s 13:52:03.249718550 O: ok expand %h and %n 880s 13:52:03.250622795 E: run test keys-command.sh ... 880s 13:52:03.630906306 O: SKIPPED: /var/run/keycommand_openssh-tests.43475 not executable (/var/run mounted noexec?) 880s 13:52:03.635168247 E: run test forward-control.sh ... 882s 13:52:05.073187071 O: check_lfwd done (expecting Y): default configuration 883s 13:52:06.768646320 O: check_rfwd done (expecting Y): default configuration 884s 13:52:07.575957929 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes 886s 13:52:09.358295765 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes 887s 13:52:10.809437986 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, !PermitOpen 888s 13:52:11.484139977 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, !PermitOpen 890s 13:52:13.182049195 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, PermitOpen 891s 13:52:14.866171149 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, PermitOpen 893s 13:52:16.220524468 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, !permitopen 894s 13:52:16.915662461 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, !permitopen 895s 13:52:18.408547390 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, permitopen 896s 13:52:19.165797225 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, permitopen 896s 13:52:19.606103112 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, no-port-forwarding 897s 13:52:19.979402408 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, no-port-forwarding 898s 13:52:21.362628388 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, restrict 898s 13:52:21.772749009 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, restrict 902s 13:52:25.413259830 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, restrict,port-forwarding 906s 13:52:29.015174898 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, restrict,port-forwarding 908s 13:52:31.362996146 O: check_lfwd done (expecting Y): AllowTcpForwarding=local 910s 13:52:32.976549792 O: check_rfwd done (expecting N): AllowTcpForwarding=local 910s 13:52:33.499821202 O: check_lfwd done (expecting N): AllowTcpForwarding=local, !PermitOpen 911s 13:52:34.391616404 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !PermitOpen 912s 13:52:35.080968797 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, PermitOpen 912s 13:52:35.484957398 O: check_rfwd done (expecting N): AllowTcpForwarding=local, PermitOpen 914s 13:52:36.990650054 O: check_lfwd done (expecting N): AllowTcpForwarding=local, !permitopen 914s 13:52:37.360529971 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !permitopen 916s 13:52:39.052309763 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, permitopen 916s 13:52:39.381774718 O: check_rfwd done (expecting N): AllowTcpForwarding=local, permitopen 917s 13:52:40.733634138 O: check_lfwd done (expecting N): AllowTcpForwarding=local, no-port-forwarding 918s 13:52:41.061436275 O: check_rfwd done (expecting N): AllowTcpForwarding=local, no-port-forwarding 918s 13:52:41.423075014 O: check_lfwd done (expecting N): AllowTcpForwarding=local, restrict 918s 13:52:41.749346468 O: check_rfwd done (expecting N): AllowTcpForwarding=local, restrict 919s 13:52:42.430513537 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, restrict,port-forwarding 919s 13:52:42.827603182 O: check_rfwd done (expecting N): AllowTcpForwarding=local, restrict,port-forwarding 920s 13:52:43.227686069 O: check_lfwd done (expecting N): AllowTcpForwarding=remote 922s 13:52:44.916062581 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote 923s 13:52:46.272295979 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !PermitOpen 925s 13:52:47.966373303 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, !PermitOpen 925s 13:52:48.322531419 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, PermitOpen 927s 13:52:50.005584286 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, PermitOpen 928s 13:52:51.567805162 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !permitopen 930s 13:52:53.406383486 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, !permitopen 931s 13:52:54.773524385 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, permitopen 932s 13:52:55.464492796 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, permitopen 932s 13:52:55.823747298 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, no-port-forwarding 933s 13:52:56.168065859 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, no-port-forwarding 934s 13:52:57.521832739 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, restrict 934s 13:52:57.869531029 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, restrict 935s 13:52:58.348381383 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, restrict,port-forwarding 936s 13:52:59.045033947 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, restrict,port-forwarding 936s 13:52:59.406222345 O: check_lfwd done (expecting N): AllowTcpForwarding=no 936s 13:52:59.749019221 O: check_rfwd done (expecting N): AllowTcpForwarding=no 938s 13:53:01.412265775 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !PermitOpen 940s 13:53:03.393490993 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !PermitOpen 942s 13:53:05.482549338 O: check_lfwd done (expecting N): AllowTcpForwarding=no, PermitOpen 944s 13:53:07.658615484 O: check_rfwd done (expecting N): AllowTcpForwarding=no, PermitOpen 947s 13:53:09.998573428 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !permitopen 948s 13:53:11.378793609 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !permitopen 949s 13:53:12.264954477 O: check_lfwd done (expecting N): AllowTcpForwarding=no, permitopen 949s 13:53:12.871770538 O: check_rfwd done (expecting N): AllowTcpForwarding=no, permitopen 950s 13:53:13.542077017 O: check_lfwd done (expecting N): AllowTcpForwarding=no, no-port-forwarding 951s 13:53:14.010998412 O: check_rfwd done (expecting N): AllowTcpForwarding=no, no-port-forwarding 952s 13:53:15.416067405 O: check_lfwd done (expecting N): AllowTcpForwarding=no, restrict 952s 13:53:15.744985236 O: check_rfwd done (expecting N): AllowTcpForwarding=no, restrict 954s 13:53:17.097267603 O: check_lfwd done (expecting N): AllowTcpForwarding=no, restrict,port-forwarding 954s 13:53:17.424912818 O: check_rfwd done (expecting N): AllowTcpForwarding=no, restrict,port-forwarding 956s 13:53:19.112776884 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, !PermitListen 956s 13:53:19.493804083 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, !PermitListen 958s 13:53:21.217637786 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, PermitListen 959s 13:53:22.045543072 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, PermitListen 960s 13:53:23.814237276 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, !PermitListen 961s 13:53:24.145081470 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !PermitListen 962s 13:53:25.842182510 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, PermitListen 963s 13:53:26.175690697 O: check_rfwd done (expecting N): AllowTcpForwarding=local, PermitListen 963s 13:53:26.535223294 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !PermitListen 963s 13:53:26.862728157 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, !PermitListen 964s 13:53:27.219238448 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, PermitListen 965s 13:53:28.887331888 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, PermitListen 967s 13:53:30.244395788 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !PermitListen 967s 13:53:30.579283217 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !PermitListen 969s 13:53:31.979121475 O: check_lfwd done (expecting N): AllowTcpForwarding=no, PermitListen 969s 13:53:32.309565742 O: check_rfwd done (expecting N): AllowTcpForwarding=no, PermitListen 969s 13:53:32.318886216 O: ok sshd control of local and remote forwarding 969s 13:53:32.319864420 E: run test integrity.sh ... 969s 13:53:32.475000739 O: test integrity: hmac-sha1 @2900 969s 13:53:32.814677296 O: test integrity: hmac-sha1 @2901 970s 13:53:33.154766775 O: test integrity: hmac-sha1 @2902 970s 13:53:33.776454735 O: test integrity: hmac-sha1 @2903 971s 13:53:34.133176987 O: test integrity: hmac-sha1 @2904 971s 13:53:34.484256483 O: test integrity: hmac-sha1 @2905 971s 13:53:34.825272853 O: test integrity: hmac-sha1 @2906 972s 13:53:35.169241100 O: test integrity: hmac-sha1 @2907 972s 13:53:35.513098795 O: test integrity: hmac-sha1 @2908 972s 13:53:35.884267431 O: test integrity: hmac-sha1 @2909 973s 13:53:36.247141455 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 973s 13:53:36.256263460 O: test integrity: hmac-sha1-96 @2900 974s 13:53:36.935783533 O: test integrity: hmac-sha1-96 @2901 975s 13:53:38.346757967 O: test integrity: hmac-sha1-96 @2902 976s 13:53:39.789510927 O: test integrity: hmac-sha1-96 @2903 978s 13:53:41.355379276 O: test integrity: hmac-sha1-96 @2904 980s 13:53:43.765051533 O: test integrity: hmac-sha1-96 @2905 982s 13:53:45.165745985 O: test integrity: hmac-sha1-96 @2906 984s 13:53:47.181256624 O: test integrity: hmac-sha1-96 @2907 985s 13:53:48.673466260 O: test integrity: hmac-sha1-96 @2908 986s 13:53:49.086298468 O: test integrity: hmac-sha1-96 @2909 986s 13:53:49.520010993 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 986s 13:53:49.529088428 O: test integrity: hmac-sha2-256 @2900 986s 13:53:49.884234166 O: test integrity: hmac-sha2-256 @2901 987s 13:53:50.225313505 O: test integrity: hmac-sha2-256 @2902 987s 13:53:50.613439174 O: test integrity: hmac-sha2-256 @2903 988s 13:53:50.986602961 O: test integrity: hmac-sha2-256 @2904 988s 13:53:51.410674698 O: test integrity: hmac-sha2-256 @2905 988s 13:53:51.782449664 O: test integrity: hmac-sha2-256 @2906 989s 13:53:52.348343985 O: test integrity: hmac-sha2-256 @2907 989s 13:53:52.814991547 O: test integrity: hmac-sha2-256 @2908 990s 13:53:53.423296552 O: test integrity: hmac-sha2-256 @2909 990s 13:53:53.815878726 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 990s 13:53:53.824524732 O: test integrity: hmac-sha2-512 @2900 991s 13:53:54.162695873 O: test integrity: hmac-sha2-512 @2901 991s 13:53:54.482367614 O: test integrity: hmac-sha2-512 @2902 991s 13:53:54.801697640 O: test integrity: hmac-sha2-512 @2903 992s 13:53:55.122472335 O: test integrity: hmac-sha2-512 @2904 992s 13:53:55.443686804 O: test integrity: hmac-sha2-512 @2905 992s 13:53:55.865658397 O: test integrity: hmac-sha2-512 @2906 993s 13:53:56.345803342 O: test integrity: hmac-sha2-512 @2907 993s 13:53:56.667803142 O: test integrity: hmac-sha2-512 @2908 994s 13:53:57.025876036 O: test integrity: hmac-sha2-512 @2909 994s 13:53:57.458651145 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 994s 13:53:57.468344175 O: test integrity: hmac-md5 @2900 994s 13:53:57.812886759 O: test integrity: hmac-md5 @2901 995s 13:53:58.188070656 O: test integrity: hmac-md5 @2902 995s 13:53:58.754972119 O: test integrity: hmac-md5 @2903 996s 13:53:59.150269091 O: test integrity: hmac-md5 @2904 996s 13:53:59.569647921 O: test integrity: hmac-md5 @2905 997s 13:53:59.965232539 O: test integrity: hmac-md5 @2906 997s 13:54:00.309325053 O: test integrity: hmac-md5 @2907 997s 13:54:00.654437774 O: test integrity: hmac-md5 @2908 998s 13:54:00.998841747 O: test integrity: hmac-md5 @2909 998s 13:54:01.336898018 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 998s 13:54:01.346068342 O: test integrity: hmac-md5-96 @2900 998s 13:54:01.687420033 O: test integrity: hmac-md5-96 @2901 999s 13:54:02.025369226 O: test integrity: hmac-md5-96 @2902 999s 13:54:02.366516147 O: test integrity: hmac-md5-96 @2903 999s 13:54:02.706719674 O: test integrity: hmac-md5-96 @2904 1000s 13:54:03.046728232 O: test integrity: hmac-md5-96 @2905 1000s 13:54:03.386583323 O: test integrity: hmac-md5-96 @2906 1000s 13:54:03.726760672 O: test integrity: hmac-md5-96 @2907 1001s 13:54:04.068202560 O: test integrity: hmac-md5-96 @2908 1001s 13:54:04.410087848 O: test integrity: hmac-md5-96 @2909 1001s 13:54:04.745690052 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1001s 13:54:04.754867248 O: test integrity: umac-64@openssh.com @2900 1002s 13:54:05.100998798 O: test integrity: umac-64@openssh.com @2901 1002s 13:54:05.449157357 O: test integrity: umac-64@openssh.com @2902 1002s 13:54:05.795336241 O: test integrity: umac-64@openssh.com @2903 1003s 13:54:06.183661656 O: test integrity: umac-64@openssh.com @2904 1003s 13:54:06.604715009 O: test integrity: umac-64@openssh.com @2905 1004s 13:54:06.950131842 O: test integrity: umac-64@openssh.com @2906 1004s 13:54:07.337026306 O: test integrity: umac-64@openssh.com @2907 1005s 13:54:07.904579896 O: test integrity: umac-64@openssh.com @2908 1005s 13:54:08.265280647 O: test integrity: umac-64@openssh.com @2909 1005s 13:54:08.602551827 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1005s 13:54:08.611472737 O: test integrity: umac-128@openssh.com @2900 1006s 13:54:08.956675577 O: test integrity: umac-128@openssh.com @2901 1006s 13:54:09.301362720 O: test integrity: umac-128@openssh.com @2902 1006s 13:54:09.805385397 O: test integrity: umac-128@openssh.com @2903 1007s 13:54:10.149706289 O: test integrity: umac-128@openssh.com @2904 1007s 13:54:10.536711025 O: test integrity: umac-128@openssh.com @2905 1008s 13:54:10.969337023 O: test integrity: umac-128@openssh.com @2906 1008s 13:54:11.313337874 O: test integrity: umac-128@openssh.com @2907 1008s 13:54:11.656850647 O: test integrity: umac-128@openssh.com @2908 1009s 13:54:12.038885935 O: test integrity: umac-128@openssh.com @2909 1009s 13:54:12.437563227 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1009s 13:54:12.447028962 O: test integrity: hmac-sha1-etm@openssh.com @2900 1009s 13:54:12.792197339 O: test integrity: hmac-sha1-etm@openssh.com @2901 1010s 13:54:13.136808576 O: test integrity: hmac-sha1-etm@openssh.com @2902 1010s 13:54:13.482040470 O: test integrity: hmac-sha1-etm@openssh.com @2903 1010s 13:54:13.816885218 O: test integrity: hmac-sha1-etm@openssh.com @2904 1011s 13:54:14.222352463 O: test integrity: hmac-sha1-etm@openssh.com @2905 1011s 13:54:14.565682541 O: test integrity: hmac-sha1-etm@openssh.com @2906 1012s 13:54:14.908825138 O: test integrity: hmac-sha1-etm@openssh.com @2907 1012s 13:54:15.251496132 O: test integrity: hmac-sha1-etm@openssh.com @2908 1013s 13:54:16.520861924 O: test integrity: hmac-sha1-etm@openssh.com @2909 1015s 13:54:18.165667421 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1015s 13:54:18.544626436 O: test integrity: hmac-sha1-96-etm@openssh.com @2900 1017s 13:54:20.073598692 O: test integrity: hmac-sha1-96-etm@openssh.com @2901 1018s 13:54:21.801652615 O: test integrity: hmac-sha1-96-etm@openssh.com @2902 1020s 13:54:23.720635267 O: test integrity: hmac-sha1-96-etm@openssh.com @2903 1022s 13:54:25.300386029 O: test integrity: hmac-sha1-96-etm@openssh.com @2904 1023s 13:54:26.029499669 O: test integrity: hmac-sha1-96-etm@openssh.com @2905 1024s 13:54:26.922173037 O: test integrity: hmac-sha1-96-etm@openssh.com @2906 1024s 13:54:27.402429695 O: test integrity: hmac-sha1-96-etm@openssh.com @2907 1024s 13:54:27.738194016 O: test integrity: hmac-sha1-96-etm@openssh.com @2908 1025s 13:54:28.073182578 O: test integrity: hmac-sha1-96-etm@openssh.com @2909 1025s 13:54:28.448001364 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1025s 13:54:28.457151837 O: test integrity: hmac-sha2-256-etm@openssh.com @2900 1025s 13:54:28.793666544 O: test integrity: hmac-sha2-256-etm@openssh.com @2901 1026s 13:54:29.131337112 O: test integrity: hmac-sha2-256-etm@openssh.com @2902 1026s 13:54:29.470761809 O: test integrity: hmac-sha2-256-etm@openssh.com @2903 1026s 13:54:29.809216452 O: test integrity: hmac-sha2-256-etm@openssh.com @2904 1027s 13:54:30.146626006 O: test integrity: hmac-sha2-256-etm@openssh.com @2905 1027s 13:54:30.485992820 O: test integrity: hmac-sha2-256-etm@openssh.com @2906 1027s 13:54:30.823078381 O: test integrity: hmac-sha2-256-etm@openssh.com @2907 1028s 13:54:31.159468547 O: test integrity: hmac-sha2-256-etm@openssh.com @2908 1028s 13:54:31.495639092 O: test integrity: hmac-sha2-256-etm@openssh.com @2909 1028s 13:54:31.828528093 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1028s 13:54:31.837518837 O: test integrity: hmac-sha2-512-etm@openssh.com @2900 1029s 13:54:32.153826096 O: test integrity: hmac-sha2-512-etm@openssh.com @2901 1029s 13:54:32.470545303 O: test integrity: hmac-sha2-512-etm@openssh.com @2902 1029s 13:54:32.788496037 O: test integrity: hmac-sha2-512-etm@openssh.com @2903 1030s 13:54:33.106592781 O: test integrity: hmac-sha2-512-etm@openssh.com @2904 1030s 13:54:33.422871858 O: test integrity: hmac-sha2-512-etm@openssh.com @2905 1030s 13:54:33.741031839 O: test integrity: hmac-sha2-512-etm@openssh.com @2906 1031s 13:54:34.058684151 O: test integrity: hmac-sha2-512-etm@openssh.com @2907 1031s 13:54:34.437077575 O: test integrity: hmac-sha2-512-etm@openssh.com @2908 1031s 13:54:34.853018458 O: test integrity: hmac-sha2-512-etm@openssh.com @2909 1032s 13:54:35.467597905 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1032s 13:54:35.477960334 O: test integrity: hmac-md5-etm@openssh.com @2900 1032s 13:54:35.869170430 O: test integrity: hmac-md5-etm@openssh.com @2901 1033s 13:54:36.282497417 O: test integrity: hmac-md5-etm@openssh.com @2902 1034s 13:54:36.941791712 O: test integrity: hmac-md5-etm@openssh.com @2903 1034s 13:54:37.655612010 O: test integrity: hmac-md5-etm@openssh.com @2904 1035s 13:54:38.015659696 O: test integrity: hmac-md5-etm@openssh.com @2905 1035s 13:54:38.357273685 O: test integrity: hmac-md5-etm@openssh.com @2906 1035s 13:54:38.696860158 O: test integrity: hmac-md5-etm@openssh.com @2907 1036s 13:54:39.036685012 O: test integrity: hmac-md5-etm@openssh.com @2908 1036s 13:54:39.523303554 O: test integrity: hmac-md5-etm@openssh.com @2909 1037s 13:54:39.969596838 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1037s 13:54:39.979195561 O: test integrity: hmac-md5-96-etm@openssh.com @2900 1037s 13:54:40.345566826 O: test integrity: hmac-md5-96-etm@openssh.com @2901 1037s 13:54:40.707889284 O: test integrity: hmac-md5-96-etm@openssh.com @2902 1038s 13:54:41.052088342 O: test integrity: hmac-md5-96-etm@openssh.com @2903 1038s 13:54:41.391038616 O: test integrity: hmac-md5-96-etm@openssh.com @2904 1038s 13:54:41.733087575 O: test integrity: hmac-md5-96-etm@openssh.com @2905 1039s 13:54:42.073404635 O: test integrity: hmac-md5-96-etm@openssh.com @2906 1039s 13:54:42.416122601 O: test integrity: hmac-md5-96-etm@openssh.com @2907 1039s 13:54:42.755753576 O: test integrity: hmac-md5-96-etm@openssh.com @2908 1040s 13:54:43.093199489 O: test integrity: hmac-md5-96-etm@openssh.com @2909 1040s 13:54:43.424963858 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1040s 13:54:43.433958448 O: test integrity: umac-64-etm@openssh.com @2900 1040s 13:54:43.778377241 O: test integrity: umac-64-etm@openssh.com @2901 1041s 13:54:44.123417971 O: test integrity: umac-64-etm@openssh.com @2902 1041s 13:54:44.467197303 O: test integrity: umac-64-etm@openssh.com @2903 1041s 13:54:44.811242609 O: test integrity: umac-64-etm@openssh.com @2904 1042s 13:54:45.157186733 O: test integrity: umac-64-etm@openssh.com @2905 1042s 13:54:45.502180060 O: test integrity: umac-64-etm@openssh.com @2906 1042s 13:54:45.853374656 O: test integrity: umac-64-etm@openssh.com @2907 1043s 13:54:46.358581523 O: test integrity: umac-64-etm@openssh.com @2908 1043s 13:54:46.711519633 O: test integrity: umac-64-etm@openssh.com @2909 1044s 13:54:47.111062383 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1044s 13:54:47.130645202 O: test integrity: umac-128-etm@openssh.com @2900 1044s 13:54:47.514399021 O: test integrity: umac-128-etm@openssh.com @2901 1044s 13:54:47.857867991 O: test integrity: umac-128-etm@openssh.com @2902 1045s 13:54:48.352948593 O: test integrity: umac-128-etm@openssh.com @2903 1045s 13:54:48.766776054 O: test integrity: umac-128-etm@openssh.com @2904 1046s 13:54:49.418454782 O: test integrity: umac-128-etm@openssh.com @2905 1046s 13:54:49.762225109 O: test integrity: umac-128-etm@openssh.com @2906 1047s 13:54:50.104377907 O: test integrity: umac-128-etm@openssh.com @2907 1047s 13:54:50.449063601 O: test integrity: umac-128-etm@openssh.com @2908 1047s 13:54:50.792530925 O: test integrity: umac-128-etm@openssh.com @2909 1048s 13:54:51.129618209 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1048s 13:54:51.138811579 O: test integrity: aes128-gcm@openssh.com @2900 1048s 13:54:51.653280291 O: test integrity: aes128-gcm@openssh.com @2901 1049s 13:54:52.073813425 O: test integrity: aes128-gcm@openssh.com @2902 1049s 13:54:52.390493218 O: test integrity: aes128-gcm@openssh.com @2903 1049s 13:54:52.741092370 O: test integrity: aes128-gcm@openssh.com @2904 1050s 13:54:53.056527492 O: test integrity: aes128-gcm@openssh.com @2905 1050s 13:54:53.371579885 O: test integrity: aes128-gcm@openssh.com @2906 1050s 13:54:53.692975510 O: test integrity: aes128-gcm@openssh.com @2907 1051s 13:54:54.010144978 O: test integrity: aes128-gcm@openssh.com @2908 1051s 13:54:54.326534385 O: test integrity: aes128-gcm@openssh.com @2909 1051s 13:54:54.636649249 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1051s 13:54:54.645800242 O: test integrity: aes256-gcm@openssh.com @2900 1052s 13:54:54.963713368 O: test integrity: aes256-gcm@openssh.com @2901 1052s 13:54:55.281535775 O: test integrity: aes256-gcm@openssh.com @2902 1052s 13:54:55.597360700 O: test integrity: aes256-gcm@openssh.com @2903 1053s 13:54:55.902606859 O: test integrity: aes256-gcm@openssh.com @2904 1053s 13:54:56.219346903 O: test integrity: aes256-gcm@openssh.com @2905 1053s 13:54:56.534636141 O: test integrity: aes256-gcm@openssh.com @2906 1053s 13:54:56.851269890 O: test integrity: aes256-gcm@openssh.com @2907 1054s 13:54:57.165549521 O: test integrity: aes256-gcm@openssh.com @2908 1054s 13:54:57.480632281 O: test integrity: aes256-gcm@openssh.com @2909 1054s 13:54:57.791030114 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1054s 13:54:57.799603935 O: test integrity: chacha20-poly1305@openssh.com @2900 1055s 13:54:58.117191380 O: test integrity: chacha20-poly1305@openssh.com @2901 1055s 13:54:58.476339021 O: test integrity: chacha20-poly1305@openssh.com @2902 1056s 13:54:59.591421346 O: test integrity: chacha20-poly1305@openssh.com @2903 1057s 13:55:00.851215165 O: test integrity: chacha20-poly1305@openssh.com @2904 1059s 13:55:02.418399098 O: test integrity: chacha20-poly1305@openssh.com @2905 1061s 13:55:04.031500281 O: test integrity: chacha20-poly1305@openssh.com @2906 1063s 13:55:06.747829576 O: test integrity: chacha20-poly1305@openssh.com @2907 1065s 13:55:08.402829159 O: test integrity: chacha20-poly1305@openssh.com @2908 1066s 13:55:09.319346737 O: test integrity: chacha20-poly1305@openssh.com @2909 1066s 13:55:09.854787094 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1066s 13:55:09.856230383 O: ok integrity 1066s 13:55:09.856942798 E: run test krl.sh ... 1067s 13:55:10.307943665 O: key revocation lists: generating test keys 1068s 13:55:11.642026021 O: key revocation lists: generating KRLs 1068s 13:55:11.781165654 O: key revocation lists: checking revocations for revoked keys 1069s 13:55:12.329704680 O: key revocation lists: checking revocations for unrevoked keys 1070s 13:55:13.634422703 O: key revocation lists: checking revocations for revoked certs 1072s 13:55:15.219219651 O: key revocation lists: checking revocations for unrevoked certs 1073s 13:55:16.637227924 O: key revocation lists: testing KRL update 1075s 13:55:18.268486920 O: key revocation lists: checking revocations for revoked keys 1075s 13:55:18.854149776 O: key revocation lists: checking revocations for unrevoked keys 1077s 13:55:20.226230592 O: key revocation lists: checking revocations for revoked certs 1078s 13:55:21.628362358 O: key revocation lists: checking revocations for unrevoked certs 1079s 13:55:22.780348056 O: ok key revocation lists 1079s 13:55:22.781884034 E: run test multipubkey.sh ... 1082s 13:55:25.874388978 O: ok multiple pubkey 1082s 13:55:25.874463236 E: run test limit-keytype.sh ... 1085s 13:55:28.635222893 O: allow rsa,ed25519 1086s 13:55:29.733470170 O: allow ed25519 1087s 13:55:30.654516892 O: allow cert only 1089s 13:55:32.087856123 O: match w/ no match 1090s 13:55:33.323072397 O: match w/ matching 1091s 13:55:34.450344778 O: ok restrict pubkey type 1091s 13:55:34.451372828 E: run test hostkey-agent.sh ... 1092s 13:55:35.254479300 O: key type ssh-ed25519 1092s 13:55:35.400397484 O: key type sk-ssh-ed25519@openssh.com 1092s 13:55:35.548948154 O: key type ecdsa-sha2-nistp256 1092s 13:55:35.813784693 O: key type ecdsa-sha2-nistp384 1093s 13:55:36.054911172 O: key type ecdsa-sha2-nistp521 1093s 13:55:36.265500546 O: key type sk-ecdsa-sha2-nistp256@openssh.com 1093s 13:55:36.433431635 O: key type ssh-rsa 1093s 13:55:36.597177037 O: cert type ssh-ed25519-cert-v01@openssh.com 1093s 13:55:36.839765732 O: cert type sk-ssh-ed25519-cert-v01@openssh.com 1094s 13:55:37.095077661 O: cert type ecdsa-sha2-nistp256-cert-v01@openssh.com 1094s 13:55:37.349314663 O: cert type ecdsa-sha2-nistp384-cert-v01@openssh.com 1094s 13:55:37.611381608 O: cert type ecdsa-sha2-nistp521-cert-v01@openssh.com 1095s 13:55:37.915477726 O: cert type sk-ecdsa-sha2-nistp256-cert-v01@openssh.com 1095s 13:55:38.220929362 O: cert type ssh-rsa-cert-v01@openssh.com 1095s 13:55:38.530564428 O: cert type rsa-sha2-256-cert-v01@openssh.com 1095s 13:55:38.792915868 O: cert type rsa-sha2-512-cert-v01@openssh.com 1096s 13:55:39.046585811 O: ok hostkey agent 1096s 13:55:39.046947092 E: run test hostkey-rotate.sh ... 1096s 13:55:39.671175032 O: learn hostkey with StrictHostKeyChecking=no 1097s 13:55:39.942031572 O: learn additional hostkeys 1097s 13:55:40.276081725 O: learn additional hostkeys, type=ssh-ed25519 1097s 13:55:40.686817776 O: learn additional hostkeys, type=sk-ssh-ed25519@openssh.com 1098s 13:55:40.999727747 O: learn additional hostkeys, type=ecdsa-sha2-nistp256 1098s 13:55:41.352770424 O: learn additional hostkeys, type=ecdsa-sha2-nistp384 1098s 13:55:41.766186630 O: learn additional hostkeys, type=ecdsa-sha2-nistp521 1099s 13:55:42.204327164 O: learn additional hostkeys, type=sk-ecdsa-sha2-nistp256@openssh.com 1099s 13:55:42.627278956 O: learn additional hostkeys, type=ssh-rsa 1100s 13:55:42.952601198 O: learn changed non-primary hostkey type=ssh-rsa 1100s 13:55:43.777337159 O: learn new primary hostkey 1101s 13:55:44.232264075 O: rotate primary hostkey 1101s 13:55:44.600083366 O: check rotate primary hostkey 1102s 13:55:44.987696212 O: ok hostkey rotate 1102s 13:55:44.988503920 E: run test principals-command.sh ... 1109s 13:55:52.509014510 O: SKIPPED: /var/run/principals_command_openssh-tests.59503 not executable (/var/run mounted noexec?) 1109s 13:55:52.514232428 E: run test cert-file.sh ... 1110s 13:55:53.681932775 O: identity cert with no plain public file 1112s 13:55:55.068383713 O: CertificateFile with no plain public file 1113s 13:55:56.058627014 O: plain keys 1113s 13:55:56.791386396 O: untrusted cert 1114s 13:55:57.158500549 O: good cert, bad key 1114s 13:55:57.588139684 O: single trusted 1115s 13:55:57.928224044 O: multiple trusted 1116s 13:55:59.343671724 O: ok ssh with certificates 1116s 13:55:59.344529686 E: run test cfginclude.sh ... 1116s 13:55:59.493069966 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.499432475 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.506469068 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.512765656 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.518999415 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.525552248 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.531853695 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.538231960 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.544774042 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.558332765 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.564051037 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.569956522 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.579381819 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.586258591 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.592681794 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.599335586 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.606448281 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.612780842 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.619244143 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.626089896 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.632331267 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.647265335 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.653093509 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.658818382 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.668447306 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.674418915 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1116s 13:55:59.677793851 O: ok config include 1116s 13:55:59.678663873 E: run test servcfginclude.sh ... 1118s 13:56:01.361485794 E: run test allow-deny-users.sh ... 1118s 13:56:01.362013059 O: ok server config include 1121s 13:56:04.585141549 O: ok AllowUsers/DenyUsers 1121s 13:56:04.585456224 E: run test authinfo.sh ... 1121s 13:56:04.727526282 O: ExposeAuthInfo=no 1122s 13:56:05.097779177 O: ExposeAuthInfo=yes 1122s 13:56:05.515097329 O: ok authinfo 1122s 13:56:05.516425490 E: run test sshsig.sh ... 1122s 13:56:05.671945581 O: sshsig: make certificates 1122s 13:56:05.714924124 O: sshsig: check signature for ssh-ed25519 1123s 13:56:06.086237264 O: sshsig: check signature for sk-ssh-ed25519@openssh.com 1123s 13:56:06.426204275 O: sshsig: check signature for ecdsa-sha2-nistp256 1124s 13:56:07.040631471 O: sshsig: check signature for ecdsa-sha2-nistp384 1124s 13:56:07.809496928 O: sshsig: check signature for ecdsa-sha2-nistp521 1126s 13:56:09.078754116 O: sshsig: check signature for sk-ecdsa-sha2-nistp256@openssh.com 1126s 13:56:09.800040403 O: sshsig: check signature for ssh-rsa 1127s 13:56:10.060837476 O: sshsig: check signature for ssh-ed25519-cert.pub 1127s 13:56:10.721365476 O: sshsig: check signature for sk-ssh-ed25519@openssh.com-cert.pub 1128s 13:56:11.299834853 O: sshsig: check signature for ecdsa-sha2-nistp256-cert.pub 1129s 13:56:12.515263499 O: sshsig: check signature for ecdsa-sha2-nistp384-cert.pub 1130s 13:56:13.884796477 O: sshsig: check signature for ecdsa-sha2-nistp521-cert.pub 1132s 13:56:15.525216991 O: sshsig: check signature for sk-ecdsa-sha2-nistp256@openssh.com-cert.pub 1133s 13:56:16.366055455 O: sshsig: check signature for ssh-rsa-cert.pub 1134s 13:56:17.454106800 O: sshsig: match principals 1134s 13:56:17.472695987 O: sshsig: nomatch principals 1134s 13:56:17.484556102 O: ok sshsig 1134s 13:56:17.485392060 E: run test knownhosts.sh ... 1136s 13:56:19.820074237 O: ok known hosts 1136s 13:56:19.820068969 E: run test knownhosts-command.sh ... 1137s 13:56:20.058730273 O: simple connection 1137s 13:56:20.687589811 O: no keys 1138s 13:56:21.079569571 O: bad exit status 1138s 13:56:21.238303093 O: keytype ssh-ed25519 1138s 13:56:21.511518616 O: keytype sk-ssh-ed25519@openssh.com 1138s 13:56:21.779691913 O: keytype ecdsa-sha2-nistp256 1139s 13:56:22.046797985 O: keytype ecdsa-sha2-nistp384 1139s 13:56:22.352788391 O: keytype ecdsa-sha2-nistp521 1139s 13:56:22.658772212 O: keytype sk-ecdsa-sha2-nistp256@openssh.com 1140s 13:56:22.929984055 O: keytype ssh-rsa 1140s 13:56:23.200627031 O: ok known hosts command 1140s 13:56:23.201145526 E: run test agent-restrict.sh ... 1140s 13:56:23.343201533 O: generate keys 1140s 13:56:23.400199233 O: prepare client config 1140s 13:56:23.408532459 O: prepare known_hosts 1140s 13:56:23.411548055 O: prepare server configs 1140s 13:56:23.421696159 O: authentication w/o agent 1142s 13:56:24.984167389 O: start agent 1146s 13:56:28.988353079 O: authentication with agent (no restrict) 1147s 13:56:30.462689077 O: unrestricted keylist 1148s 13:56:31.232570703 O: authentication with agent (basic restrict) 1149s 13:56:31.983092336 O: authentication with agent incorrect key (basic restrict) 1149s 13:56:32.645596478 O: keylist (basic restrict) 1150s 13:56:33.469344256 O: username 1153s 13:56:36.566041763 O: username wildcard 1158s 13:56:40.980289696 O: username incorrect 1158s 13:56:41.469339624 O: agent restriction honours certificate principal 1158s 13:56:41.578345220 O: multihop without agent 1162s 13:56:45.239090593 O: multihop agent unrestricted 1163s 13:56:46.565982758 O: multihop restricted 1164s 13:56:47.505597431 O: multihop username 1165s 13:56:48.363440650 O: multihop wildcard username 1166s 13:56:49.219040464 O: multihop wrong username 1166s 13:56:49.831863704 O: multihop cycle no agent 1168s 13:56:51.070363694 O: multihop cycle agent unrestricted 1169s 13:56:52.339650642 O: multihop cycle restricted deny 1169s 13:56:52.796948497 O: multihop cycle restricted allow 1171s 13:56:54.273613741 O: ok agent restrictions 1171s 13:56:54.274352711 E: run test hostbased.sh ... 1171s 13:56:54.412920581 O: SKIPPED: TEST_SSH_HOSTBASED_AUTH not set. 1171s 13:56:54.413945411 E: run test channel-timeout.sh ... 1171s 13:56:54.554381085 O: no timeout 1176s 13:56:59.891448165 O: command timeout 1177s 13:57:00.256772971 O: command long timeout 1177s 13:57:00.577881396 O: command wildcard timeout 1178s 13:57:01.257265767 O: command irrelevant timeout 1183s 13:57:06.582029018 O: multiplexed command timeout 1194s 13:57:17.328440843 O: irrelevant multiplexed command timeout 1210s 13:57:33.274403513 O: global command timeout 1232s 13:57:55.306620423 O: sftp no timeout 1237s 13:58:00.746009273 O: sftp timeout 1238s 13:58:01.255688587 E: Connection closed 1238s 13:58:01.257255450 O: sftp irrelevant timeout 1243s 13:58:06.684327466 E: run test connection-timeout.sh ... 1243s 13:58:06.684869924 O: ok channel timeout 1243s 13:58:06.826923396 O: no timeout 1249s 13:58:12.161719619 O: timeout 1257s 13:58:20.529480046 O: session inhibits timeout 1265s 13:58:28.864672615 O: timeout after session 1274s 13:58:36.990403544 O: timeout with listeners 1283s 13:58:46.620879887 E: run test match-subsystem.sh ... 1283s 13:58:46.621410165 O: ok unused connection timeout 1287s 13:58:50.282664231 E: run test agent-pkcs11-restrict.sh ... 1287s 13:58:50.282151115 O: ok sshd_config match subsystem 1287s 13:58:50.428340674 O: SKIPPED: No PKCS#11 library found 1287s 13:58:50.428448577 E: run test agent-pkcs11-cert.sh ... 1287s 13:58:50.568679827 O: SKIPPED: No PKCS#11 library found 1287s 13:58:50.568857747 E: run test penalty.sh ... 1287s 13:58:50.862379036 O: test connect 1288s 13:58:51.237745783 O: penalty for authentication failure 1296s 13:58:59.000286956 O: penalty for no authentication 1298s 13:59:01.151500192 O: ok penalties 1298s 13:59:01.151512211 E: run test penalty-expire.sh ... 1298s 13:59:01.444075571 O: test connect 1298s 13:59:01.808373512 O: penalty expiry 1312s 13:59:15.548417532 O: ok penalties 1312s 13:59:15.549153869 O: set -e ; if test -z "" ; then \ 1312s 13:59:15.554523896 O: V="" ; \ 1312s 13:59:15.555030387 O: test "x" = "x" || \ 1312s 13:59:15.555581088 O: V=/tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/valgrind-unit.sh ; \ 1312s 13:59:15.556101584 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/sshbuf/test_sshbuf ; \ 1312s 13:59:15.556668953 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/sshkey/test_sshkey \ 1312s 13:59:15.557220399 O: -d /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/sshkey/testdata ; \ 1312s 13:59:15.557817206 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/sshsig/test_sshsig \ 1312s 13:59:15.558457401 O: -d /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/sshsig/testdata ; \ 1312s 13:59:15.558988455 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/authopt/test_authopt \ 1312s 13:59:15.559507883 O: -d /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/authopt/testdata ; \ 1312s 13:59:15.560027197 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/bitmap/test_bitmap ; \ 1312s 13:59:15.560549258 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/conversion/test_conversion ; \ 1312s 13:59:15.561060556 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/kex/test_kex ; \ 1312s 13:59:15.561563489 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/hostkeys/test_hostkeys \ 1312s 13:59:15.562080372 O: -d /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/hostkeys/testdata ; \ 1312s 13:59:15.562592155 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/match/test_match ; \ 1312s 13:59:15.563102655 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/misc/test_misc ; \ 1312s 13:59:15.563606631 O: if test "x" = "xyes" ; then \ 1312s 13:59:15.564114407 O: $V /tmp/autopkgtest.zK6HBn/autopkgtest_tmp/user/regress/unittests/utf8/test_utf8 ; \ 1312s 13:59:15.564609922 O: fi \ 1312s 13:59:15.565102650 O: fi 1342s 13:59:45.832076989 O: test_sshbuf: ...................................................................................................... 103 tests ok 1515s 14:02:38.617266328 O: test_sshkey: .................................................................................... 84 tests ok 1515s 14:02:38.638594118 O: test_sshsig: ....... 7 tests ok 1516s 14:02:39.018479033 O: test_authopt: .................................................................................................................................................. 146 tests ok 1542s 14:03:05.014107499 O: test_bitmap: .. 2 tests ok 1542s 14:03:05.016989666 O: test_conversion: . 1 tests ok 1553s 14:03:16.109816757 O: test_kex: ........................................................................................................................................................................................................................................................................................................................................... 332 tests ok 1554s 14:03:17.012970112 O: test_hostkeys: .................. 18 tests ok 1554s 14:03:17.015975733 O: test_match: ...... 6 tests ok 1554s 14:03:17.018687890 O: test_misc: ........................................... 43 tests ok 1554s 14:03:17.019920603 E: run test putty-transfer.sh ... 1555s 14:03:18.888246603 O: plink version 0.83 major 0 minor 83 1556s 14:03:18.894658810 O: putty transfer data: compression 0 1558s 14:03:21.788290857 O: putty transfer data: compression 1 1561s 14:03:24.481208670 O: ok putty transfer data 1561s 14:03:24.482176927 E: run test putty-ciphers.sh ... 1563s 14:03:26.152276851 O: plink version 0.83 major 0 minor 83 1563s 14:03:26.428146110 O: putty ciphers: cipher default mac default 1563s 14:03:26.738393025 O: putty ciphers: cipher default mac hmac-sha1 1564s 14:03:27.041243593 O: putty ciphers: cipher default mac hmac-sha1-96 1564s 14:03:27.353497767 O: putty ciphers: cipher default mac hmac-sha2-256 1564s 14:03:27.651537953 O: putty ciphers: cipher default mac hmac-sha2-512 1565s 14:03:27.957001612 O: putty ciphers: cipher default mac hmac-md5 1565s 14:03:28.261595795 O: putty ciphers: cipher default mac hmac-sha1-etm@openssh.com 1565s 14:03:28.565935344 O: putty ciphers: cipher default mac hmac-sha1-96-etm@openssh.com 1565s 14:03:28.863018526 O: putty ciphers: cipher default mac hmac-sha2-256-etm@openssh.com 1566s 14:03:29.169335247 O: putty ciphers: cipher default mac hmac-sha2-512-etm@openssh.com 1566s 14:03:29.474501905 O: putty ciphers: cipher default mac hmac-md5-etm@openssh.com 1566s 14:03:29.771356646 O: putty ciphers: cipher 3des-cbc mac default 1567s 14:03:30.074442295 O: putty ciphers: cipher 3des-cbc mac hmac-sha1 1567s 14:03:30.377052094 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-96 1567s 14:03:30.684216483 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-256 1568s 14:03:31.043547358 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-512 1568s 14:03:31.341917979 O: putty ciphers: cipher 3des-cbc mac hmac-md5 1568s 14:03:31.640528297 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-etm@openssh.com 1569s 14:03:31.943204818 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-96-etm@openssh.com 1569s 14:03:32.247237067 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-256-etm@openssh.com 1569s 14:03:32.548753869 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-512-etm@openssh.com 1569s 14:03:32.854417810 O: putty ciphers: cipher 3des-cbc mac hmac-md5-etm@openssh.com 1570s 14:03:33.153695357 O: putty ciphers: cipher aes128-cbc mac default 1570s 14:03:33.460929405 O: putty ciphers: cipher aes128-cbc mac hmac-sha1 1570s 14:03:33.761149455 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-96 1571s 14:03:34.068979573 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-256 1571s 14:03:34.366985977 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-512 1571s 14:03:34.667931891 O: putty ciphers: cipher aes128-cbc mac hmac-md5 1572s 14:03:34.995525428 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-etm@openssh.com 1572s 14:03:35.292951924 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-96-etm@openssh.com 1572s 14:03:35.593208925 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-256-etm@openssh.com 1572s 14:03:35.892757841 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-512-etm@openssh.com 1573s 14:03:36.197021760 O: putty ciphers: cipher aes128-cbc mac hmac-md5-etm@openssh.com 1574s 14:03:37.536777642 O: putty ciphers: cipher aes192-cbc mac default 1576s 14:03:39.219018999 O: putty ciphers: cipher aes192-cbc mac hmac-sha1 1577s 14:03:40.651927114 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-96 1579s 14:03:42.085567387 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-256 1579s 14:03:42.704479150 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-512 1581s 14:03:44.231698931 O: putty ciphers: cipher aes192-cbc mac hmac-md5 1582s 14:03:45.118398007 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-etm@openssh.com 1583s 14:03:45.956985177 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-96-etm@openssh.com 1584s 14:03:47.154108360 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-256-etm@openssh.com 1584s 14:03:47.454964185 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-512-etm@openssh.com 1584s 14:03:47.755319734 O: putty ciphers: cipher aes192-cbc mac hmac-md5-etm@openssh.com 1585s 14:03:48.053529617 O: putty ciphers: cipher aes256-cbc mac default 1585s 14:03:48.354918509 O: putty ciphers: cipher aes256-cbc mac hmac-sha1 1585s 14:03:48.654293571 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-96 1586s 14:03:49.038841858 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-256 1586s 14:03:49.339323568 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-512 1586s 14:03:49.637715981 O: putty ciphers: cipher aes256-cbc mac hmac-md5 1587s 14:03:49.942933866 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-etm@openssh.com 1587s 14:03:50.240003235 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-96-etm@openssh.com 1587s 14:03:50.558064147 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-256-etm@openssh.com 1587s 14:03:50.863490286 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-512-etm@openssh.com 1588s 14:03:51.161795366 O: putty ciphers: cipher aes256-cbc mac hmac-md5-etm@openssh.com 1588s 14:03:51.474583610 O: putty ciphers: cipher aes128-ctr mac default 1588s 14:03:51.800922784 O: putty ciphers: cipher aes128-ctr mac hmac-sha1 1589s 14:03:52.105874666 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-96 1589s 14:03:52.407754455 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-256 1589s 14:03:52.717033951 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-512 1590s 14:03:53.022437275 O: putty ciphers: cipher aes128-ctr mac hmac-md5 1590s 14:03:53.327968572 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-etm@openssh.com 1590s 14:03:53.635444142 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-96-etm@openssh.com 1591s 14:03:53.943527013 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-256-etm@openssh.com 1591s 14:03:54.245120719 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-512-etm@openssh.com 1591s 14:03:54.549492819 O: putty ciphers: cipher aes128-ctr mac hmac-md5-etm@openssh.com 1591s 14:03:54.863532556 O: putty ciphers: cipher aes192-ctr mac default 1592s 14:03:55.165376148 O: putty ciphers: cipher aes192-ctr mac hmac-sha1 1592s 14:03:55.463932399 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-96 1592s 14:03:55.763290317 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-256 1593s 14:03:56.069075327 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-512 1593s 14:03:56.374823389 O: putty ciphers: cipher aes192-ctr mac hmac-md5 1593s 14:03:56.671831709 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-etm@openssh.com 1594s 14:03:56.976442826 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-96-etm@openssh.com 1594s 14:03:57.274731101 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-256-etm@openssh.com 1594s 14:03:57.574589520 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-512-etm@openssh.com 1594s 14:03:57.873743577 O: putty ciphers: cipher aes192-ctr mac hmac-md5-etm@openssh.com 1595s 14:03:58.172009576 O: putty ciphers: cipher aes256-ctr mac default 1595s 14:03:58.480573427 O: putty ciphers: cipher aes256-ctr mac hmac-sha1 1595s 14:03:58.848317432 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-96 1596s 14:03:59.304613341 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-256 1596s 14:03:59.605841212 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-512 1597s 14:03:59.970018031 O: putty ciphers: cipher aes256-ctr mac hmac-md5 1597s 14:04:00.275730407 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-etm@openssh.com 1597s 14:04:00.578022602 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-96-etm@openssh.com 1598s 14:04:01.064147224 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-256-etm@openssh.com 1598s 14:04:01.374256381 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-512-etm@openssh.com 1598s 14:04:01.675222383 O: putty ciphers: cipher aes256-ctr mac hmac-md5-etm@openssh.com 1599s 14:04:01.991396822 O: putty ciphers: cipher aes128-gcm@openssh.com mac default 1599s 14:04:02.467496931 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1 1599s 14:04:02.876817200 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-96 1600s 14:04:03.196968226 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-256 1600s 14:04:03.500190018 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-512 1601s 14:04:04.038339223 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-md5 1601s 14:04:04.522797695 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-etm@openssh.com 1601s 14:04:04.879296774 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-96-etm@openssh.com 1602s 14:04:05.178794166 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-256-etm@openssh.com 1602s 14:04:05.487360781 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-512-etm@openssh.com 1602s 14:04:05.864428014 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-md5-etm@openssh.com 1603s 14:04:06.332494649 O: putty ciphers: cipher aes256-gcm@openssh.com mac default 1603s 14:04:06.709744024 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1 1604s 14:04:07.024996391 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-96 1604s 14:04:07.350621304 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-256 1604s 14:04:07.748512297 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-512 1605s 14:04:08.056715356 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-md5 1605s 14:04:08.374682724 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-etm@openssh.com 1606s 14:04:09.164342323 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-96-etm@openssh.com 1606s 14:04:09.514315419 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-256-etm@openssh.com 1606s 14:04:09.855000665 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-512-etm@openssh.com 1607s 14:04:10.171752630 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-md5-etm@openssh.com 1607s 14:04:10.483888088 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac default 1607s 14:04:10.851269158 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1 1608s 14:04:11.353907381 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-96 1608s 14:04:11.673720593 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-256 1609s 14:04:11.973682512 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-512 1609s 14:04:12.271319374 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-md5 1609s 14:04:12.570613740 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-etm@openssh.com 1609s 14:04:12.873727755 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-96-etm@openssh.com 1610s 14:04:13.173711729 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-256-etm@openssh.com 1610s 14:04:13.491445306 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-512-etm@openssh.com 1610s 14:04:13.791615553 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-md5-etm@openssh.com 1611s 14:04:14.093876675 E: run test putty-kex.sh ... 1611s 14:04:14.094461414 O: ok putty ciphers 1619s 14:04:22.275585948 O: plink version 0.83 major 0 minor 83 1620s 14:04:23.563277584 O: putty KEX: kex diffie-hellman-group1-sha1 1622s 14:04:25.160136555 O: putty KEX: kex diffie-hellman-group14-sha1 2825s autopkgtest-virt-ssh [14:23:07]: ------- nova console-log 58588e35-0dca-4374-a5b5-ebd0640bedf0 (adt-questing-s390x-openssh-20250506-114524-juju-7f2275-prod-proposed-migration-environment-21-72b92a04-72c6-438b-83e4-4efa947d284d) ------ 2825s ERROR (CommandError): No server with a name or ID of '58588e35-0dca-4374-a5b5-ebd0640bedf0' exists. 2825s --------------------------------------------------- 2825s ------- nova show 58588e35-0dca-4374-a5b5-ebd0640bedf0 (adt-questing-s390x-openssh-20250506-114524-juju-7f2275-prod-proposed-migration-environment-21-72b92a04-72c6-438b-83e4-4efa947d284d) ------ 2825s ERROR (CommandError): No server with a name or ID of '58588e35-0dca-4374-a5b5-ebd0640bedf0' exists. 2825s --------------------------------------------------- 2825s 3369s nova [W] Using flock in prodstack7-s390x 3369s Creating nova instance adt-questing-s390x-openssh-20250506-114524-juju-7f2275-prod-proposed-migration-environment-21-72b92a04-72c6-438b-83e4-4efa947d284d from image adt/ubuntu-questing-s390x-server-20250506.img (UUID fef1f145-d219-47e4-a2ed-77b44eac0376)... 3369s nova [W] Timed out waiting for 58588e35-0dca-4374-a5b5-ebd0640bedf0 to get deleted. 3369s autopkgtest [14:32:11]: ERROR: testbed failure: testbed auxverb failed with exit code 255