0s autopkgtest [21:39:19]: starting date and time: 2024-11-15 21:39:19+0000 0s autopkgtest [21:39:19]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [21:39:19]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.uxbvcysn/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com\n" >> /etc/environment' --apt-pocket=proposed=src:gtk+3.0 --apt-upgrade openssh --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=gtk+3.0/3.24.43-4ubuntu1 -- lxd -r lxd-armhf-10.145.243.227 lxd-armhf-10.145.243.227:autopkgtest/ubuntu/plucky/armhf 53s autopkgtest [21:40:12]: testbed dpkg architecture: armhf 55s autopkgtest [21:40:14]: testbed apt version: 2.9.8 55s autopkgtest [21:40:14]: @@@@@@@@@@@@@@@@@@@@ test bed setup 63s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 63s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1044 kB] 63s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 63s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 63s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [93.0 kB] 63s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [145 kB] 63s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [748 kB] 63s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [4428 B] 64s Fetched 2130 kB in 1s (2043 kB/s) 64s Reading package lists... 81s tee: /proc/self/fd/2: Permission denied 104s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 104s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 104s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 104s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 106s Reading package lists... 106s Reading package lists... 107s Building dependency tree... 107s Reading state information... 108s Calculating upgrade... 109s The following NEW packages will be installed: 109s libassuan9 109s The following packages will be upgraded: 109s libgpgme11t64 libseccomp2 python3-cffi-backend python3-markupsafe 109s 4 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 109s Need to get 297 kB of archives. 109s After this operation, 224 kB of additional disk space will be used. 109s Get:1 http://ftpmaster.internal/ubuntu plucky/main armhf libseccomp2 armhf 2.5.5-1ubuntu5 [49.3 kB] 110s Get:2 http://ftpmaster.internal/ubuntu plucky/main armhf python3-cffi-backend armhf 1.17.1-2build1 [75.9 kB] 110s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libassuan9 armhf 3.0.1-2 [34.3 kB] 110s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf libgpgme11t64 armhf 1.24.0-2ubuntu1 [125 kB] 110s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf python3-markupsafe armhf 2.1.5-1build3 [12.5 kB] 110s Fetched 297 kB in 0s (603 kB/s) 110s (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 ... 59566 files and directories currently installed.) 110s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu5_armhf.deb ... 110s Unpacking libseccomp2:armhf (2.5.5-1ubuntu5) over (2.5.5-1ubuntu4) ... 111s Setting up libseccomp2:armhf (2.5.5-1ubuntu5) ... 111s (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 ... 59566 files and directories currently installed.) 111s Preparing to unpack .../python3-cffi-backend_1.17.1-2build1_armhf.deb ... 111s Unpacking python3-cffi-backend:armhf (1.17.1-2build1) over (1.17.1-2) ... 111s Selecting previously unselected package libassuan9:armhf. 111s Preparing to unpack .../libassuan9_3.0.1-2_armhf.deb ... 111s Unpacking libassuan9:armhf (3.0.1-2) ... 111s Preparing to unpack .../libgpgme11t64_1.24.0-2ubuntu1_armhf.deb ... 111s Unpacking libgpgme11t64:armhf (1.24.0-2ubuntu1) over (1.23.2-5ubuntu4) ... 111s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_armhf.deb ... 111s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 111s Setting up python3-markupsafe (2.1.5-1build3) ... 111s Setting up libassuan9:armhf (3.0.1-2) ... 111s Setting up libgpgme11t64:armhf (1.24.0-2ubuntu1) ... 111s Setting up python3-cffi-backend:armhf (1.17.1-2build1) ... 111s Processing triggers for libc-bin (2.40-1ubuntu3) ... 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 116s autopkgtest [21:41:15]: rebooting testbed after setup commands that affected boot 183s autopkgtest [21:42:22]: testbed running kernel: Linux 6.8.0-48-generic #48~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Mon Oct 7 11:49:53 UTC 2 211s autopkgtest [21:42:50]: @@@@@@@@@@@@@@@@@@@@ apt-source openssh 242s Get:1 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (dsc) [3327 B] 242s Get:2 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (tar) [1849 kB] 242s Get:3 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (asc) [833 B] 242s Get:4 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (diff) [208 kB] 242s gpgv: Signature made Wed Oct 30 12:49:43 2024 UTC 242s gpgv: using RSA key CED62F17BB727A48FC50762E2A15898770574541 242s gpgv: Can't check signature: No public key 242s dpkg-source: warning: cannot verify inline signature for ./openssh_9.7p1-7ubuntu5.dsc: no acceptable signature found 243s autopkgtest [21:43:22]: testing package openssh version 1:9.7p1-7ubuntu5 245s autopkgtest [21:43:24]: build not needed 248s autopkgtest [21:43:27]: test regress: preparing testbed 260s Reading package lists... 260s Building dependency tree... 260s Reading state information... 261s Starting pkgProblemResolver with broken count: 0 261s Starting 2 pkgProblemResolver with broken count: 0 261s Done 263s The following additional packages will be installed: 263s devscripts dropbear dropbear-bin haveged libb-hooks-op-check-perl 263s libclass-method-modifiers-perl libclass-xsaccessor-perl libclone-perl 263s libdevel-callchecker-perl libdynaloader-functions-perl libencode-locale-perl 263s libfile-dirlist-perl libfile-homedir-perl libfile-listing-perl 263s libfile-touch-perl libfile-which-perl libhavege2 libhtml-parser-perl 263s libhtml-tagset-perl libhtml-tree-perl libhttp-cookies-perl libhttp-date-perl 263s libhttp-message-perl libhttp-negotiate-perl libimport-into-perl 263s libio-html-perl libio-pty-perl libio-socket-ssl-perl libipc-run-perl 263s liblwp-mediatypes-perl liblwp-protocol-https-perl libmodule-runtime-perl 263s libmoo-perl libnet-http-perl libnet-ssleay-perl libparams-classify-perl 263s librole-tiny-perl libsub-quote-perl libtimedate-perl libtomcrypt1 263s libtommath1 libtry-tiny-perl liburi-perl libwww-perl libwww-robotrules-perl 263s openssh-tests patchutils perl-openssl-defaults putty-tools python3-automat 263s python3-bcrypt python3-constantly python3-hamcrest python3-hyperlink 263s python3-incremental python3-pyasn1 python3-pyasn1-modules 263s python3-service-identity python3-twisted python3-zope.interface wdiff 263s Suggested packages: 263s adequate at autopkgtest bls-standalone bsd-mailx | mailx build-essential 263s check-all-the-things cvs-buildpackage debhelper diffoscope disorderfs 263s docker.io dose-extra duck elpa-devscripts faketime gnuplot how-can-i-help 263s libauthen-sasl-perl libdbd-pg-perl libfile-desktopentry-perl 263s libterm-size-perl libyaml-syck-perl mmdebstrap mutt piuparts 263s postgresql-client pristine-lfs python3-debianbts python3-pycurl quilt ratt 263s reprotest svn-buildpackage w3m debian-keyring equivs libgitlab-api-v4-perl 263s libsoap-lite-perl pristine-tar dropbear-initramfs runit libdata-dump-perl 263s libio-compress-brotli-perl libcrypt-ssleay-perl libscalar-number-perl 263s libxstring-perl libsub-name-perl libbusiness-isbn-perl libregexp-ipv6-perl 263s libauthen-ntlm-perl putty-doc python3-pampy python3-tk python3-wxgtk4.0 263s wdiff-doc 263s Recommended packages: 263s dctrl-tools dput | dupload libdistro-info-perl libgit-wrapper-perl 263s libjson-perl liblist-compare-perl libstring-shellquote-perl licensecheck 263s lintian python3-debian python3-magic python3-unidiff python3-xdg unzip 263s libhtml-format-perl libnamespace-clean-perl libdata-dump-perl 263s libhtml-form-perl libhttp-daemon-perl libmailtools-perl python3-click 263s The following NEW packages will be installed: 263s autopkgtest-satdep devscripts dropbear dropbear-bin haveged 263s libb-hooks-op-check-perl libclass-method-modifiers-perl 263s libclass-xsaccessor-perl libclone-perl libdevel-callchecker-perl 263s libdynaloader-functions-perl libencode-locale-perl libfile-dirlist-perl 263s libfile-homedir-perl libfile-listing-perl libfile-touch-perl 263s libfile-which-perl libhavege2 libhtml-parser-perl libhtml-tagset-perl 263s libhtml-tree-perl libhttp-cookies-perl libhttp-date-perl 263s libhttp-message-perl libhttp-negotiate-perl libimport-into-perl 263s libio-html-perl libio-pty-perl libio-socket-ssl-perl libipc-run-perl 263s liblwp-mediatypes-perl liblwp-protocol-https-perl libmodule-runtime-perl 263s libmoo-perl libnet-http-perl libnet-ssleay-perl libparams-classify-perl 263s librole-tiny-perl libsub-quote-perl libtimedate-perl libtomcrypt1 263s libtommath1 libtry-tiny-perl liburi-perl libwww-perl libwww-robotrules-perl 263s openssh-tests patchutils perl-openssl-defaults putty-tools python3-automat 263s python3-bcrypt python3-constantly python3-hamcrest python3-hyperlink 263s python3-incremental python3-pyasn1 python3-pyasn1-modules 263s python3-service-identity python3-twisted python3-zope.interface wdiff 263s 0 upgraded, 62 newly installed, 0 to remove and 0 not upgraded. 263s Need to get 8149 kB/8150 kB of archives. 263s After this operation, 33.3 MB of additional disk space will be used. 263s Get:1 /tmp/autopkgtest.0dhFo8/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [772 B] 263s Get:2 http://ftpmaster.internal/ubuntu plucky/universe armhf libtommath1 armhf 1.3.0-1 [45.8 kB] 264s Get:3 http://ftpmaster.internal/ubuntu plucky/universe armhf libtomcrypt1 armhf 1.18.2+dfsg-7build1 [377 kB] 264s Get:4 http://ftpmaster.internal/ubuntu plucky/universe armhf dropbear-bin armhf 2024.85-3 [117 kB] 264s Get:5 http://ftpmaster.internal/ubuntu plucky/universe armhf dropbear all 2024.85-3 [8668 B] 264s Get:6 http://ftpmaster.internal/ubuntu plucky/universe armhf libhavege2 armhf 1.9.14-1ubuntu2 [23.6 kB] 264s Get:7 http://ftpmaster.internal/ubuntu plucky/universe armhf haveged armhf 1.9.14-1ubuntu2 [33.1 kB] 264s Get:8 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-dirlist-perl all 0.05-3 [7286 B] 264s Get:9 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-which-perl all 1.27-2 [12.5 kB] 264s Get:10 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-homedir-perl all 1.006-2 [37.0 kB] 264s Get:11 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-touch-perl all 0.12-2 [7498 B] 264s Get:12 http://ftpmaster.internal/ubuntu plucky/main armhf libio-pty-perl armhf 1:1.20-1build3 [31.0 kB] 264s Get:13 http://ftpmaster.internal/ubuntu plucky/main armhf libipc-run-perl all 20231003.0-2 [91.5 kB] 264s Get:14 http://ftpmaster.internal/ubuntu plucky/main armhf libclass-method-modifiers-perl all 2.15-1 [16.1 kB] 264s Get:15 http://ftpmaster.internal/ubuntu plucky/main armhf libclass-xsaccessor-perl armhf 1.19-4build5 [32.3 kB] 264s Get:16 http://ftpmaster.internal/ubuntu plucky/main armhf libb-hooks-op-check-perl armhf 0.22-3build2 [9174 B] 264s Get:17 http://ftpmaster.internal/ubuntu plucky/main armhf libdynaloader-functions-perl all 0.004-1 [11.4 kB] 264s Get:18 http://ftpmaster.internal/ubuntu plucky/main armhf libdevel-callchecker-perl armhf 0.009-1build1 [14.0 kB] 264s Get:19 http://ftpmaster.internal/ubuntu plucky/main armhf libparams-classify-perl armhf 0.015-2build6 [18.8 kB] 264s Get:20 http://ftpmaster.internal/ubuntu plucky/main armhf libmodule-runtime-perl all 0.016-2 [16.4 kB] 264s Get:21 http://ftpmaster.internal/ubuntu plucky/main armhf libimport-into-perl all 1.002005-2 [10.7 kB] 264s Get:22 http://ftpmaster.internal/ubuntu plucky/main armhf librole-tiny-perl all 2.002004-1 [16.3 kB] 264s Get:23 http://ftpmaster.internal/ubuntu plucky/main armhf libsub-quote-perl all 2.006008-1ubuntu1 [20.7 kB] 264s Get:24 http://ftpmaster.internal/ubuntu plucky/main armhf libmoo-perl all 2.005005-1 [47.4 kB] 264s Get:25 http://ftpmaster.internal/ubuntu plucky/main armhf libencode-locale-perl all 1.05-3 [11.6 kB] 264s Get:26 http://ftpmaster.internal/ubuntu plucky/main armhf libtimedate-perl all 2.3300-2 [34.0 kB] 264s Get:27 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-date-perl all 6.06-1 [10.2 kB] 264s Get:28 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-listing-perl all 6.16-1 [11.3 kB] 264s Get:29 http://ftpmaster.internal/ubuntu plucky/main armhf libhtml-tagset-perl all 3.24-1 [14.1 kB] 264s Get:30 http://ftpmaster.internal/ubuntu plucky/main armhf liburi-perl all 5.28-1 [88.1 kB] 264s Get:31 http://ftpmaster.internal/ubuntu plucky/main armhf libhtml-parser-perl armhf 3.83-1build1 [83.1 kB] 264s Get:32 http://ftpmaster.internal/ubuntu plucky/main armhf libhtml-tree-perl all 5.07-3 [200 kB] 264s Get:33 http://ftpmaster.internal/ubuntu plucky/main armhf libclone-perl armhf 0.47-1 [10.0 kB] 264s Get:34 http://ftpmaster.internal/ubuntu plucky/main armhf libio-html-perl all 1.004-3 [15.9 kB] 264s Get:35 http://ftpmaster.internal/ubuntu plucky/main armhf liblwp-mediatypes-perl all 6.04-2 [20.1 kB] 264s Get:36 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-message-perl all 7.00-2ubuntu1 [75.9 kB] 264s Get:37 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-cookies-perl all 6.11-1 [18.2 kB] 264s Get:38 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-negotiate-perl all 6.01-2 [12.4 kB] 264s Get:39 http://ftpmaster.internal/ubuntu plucky/main armhf perl-openssl-defaults armhf 7build3 [6628 B] 264s Get:40 http://ftpmaster.internal/ubuntu plucky/main armhf libnet-ssleay-perl armhf 1.94-2 [298 kB] 264s Get:41 http://ftpmaster.internal/ubuntu plucky/main armhf libio-socket-ssl-perl all 2.089-1 [200 kB] 264s Get:42 http://ftpmaster.internal/ubuntu plucky/main armhf libnet-http-perl all 6.23-1 [22.3 kB] 264s Get:43 http://ftpmaster.internal/ubuntu plucky/main armhf liblwp-protocol-https-perl all 6.14-1 [9040 B] 264s Get:44 http://ftpmaster.internal/ubuntu plucky/main armhf libtry-tiny-perl all 0.32-1 [21.2 kB] 264s Get:45 http://ftpmaster.internal/ubuntu plucky/main armhf libwww-robotrules-perl all 6.02-1 [12.6 kB] 264s Get:46 http://ftpmaster.internal/ubuntu plucky/main armhf libwww-perl all 6.77-1 [138 kB] 264s Get:47 http://ftpmaster.internal/ubuntu plucky/main armhf patchutils armhf 0.4.2-1build3 [73.2 kB] 264s Get:48 http://ftpmaster.internal/ubuntu plucky/main armhf wdiff armhf 1.2.2-6build1 [29.0 kB] 264s Get:49 http://ftpmaster.internal/ubuntu plucky/main armhf devscripts all 2.24.3 [1080 kB] 264s Get:50 http://ftpmaster.internal/ubuntu plucky/universe armhf putty-tools armhf 0.81-2 [566 kB] 264s Get:51 http://ftpmaster.internal/ubuntu plucky/main armhf python3-bcrypt armhf 4.2.0-1 [218 kB] 264s Get:52 http://ftpmaster.internal/ubuntu plucky/main armhf python3-hamcrest all 2.1.0-1 [28.1 kB] 264s Get:53 http://ftpmaster.internal/ubuntu plucky/main armhf python3-pyasn1 all 0.6.0-1 [57.8 kB] 264s Get:54 http://ftpmaster.internal/ubuntu plucky/main armhf python3-pyasn1-modules all 0.4.1-1 [80.2 kB] 264s Get:55 http://ftpmaster.internal/ubuntu plucky/main armhf python3-service-identity all 24.1.0-1 [11.2 kB] 264s Get:56 http://ftpmaster.internal/ubuntu plucky/main armhf python3-automat all 24.8.1-1 [35.5 kB] 264s Get:57 http://ftpmaster.internal/ubuntu plucky/main armhf python3-constantly all 23.10.4-2 [13.9 kB] 264s Get:58 http://ftpmaster.internal/ubuntu plucky/main armhf python3-hyperlink all 21.0.0-6 [68.0 kB] 264s Get:59 http://ftpmaster.internal/ubuntu plucky/main armhf python3-incremental all 24.7.2-2 [18.5 kB] 264s Get:60 http://ftpmaster.internal/ubuntu plucky/main armhf python3-zope.interface armhf 7.1.1-1build1 [138 kB] 264s Get:61 http://ftpmaster.internal/ubuntu plucky/main armhf python3-twisted all 24.10.0-1 [2067 kB] 265s Get:62 http://ftpmaster.internal/ubuntu plucky/universe armhf openssh-tests armhf 1:9.7p1-7ubuntu5 [1344 kB] 266s Fetched 8149 kB in 2s (5200 kB/s) 266s Selecting previously unselected package libtommath1:armhf. 266s (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 ... 59573 files and directories currently installed.) 266s Preparing to unpack .../00-libtommath1_1.3.0-1_armhf.deb ... 266s Unpacking libtommath1:armhf (1.3.0-1) ... 266s Selecting previously unselected package libtomcrypt1:armhf. 266s Preparing to unpack .../01-libtomcrypt1_1.18.2+dfsg-7build1_armhf.deb ... 266s Unpacking libtomcrypt1:armhf (1.18.2+dfsg-7build1) ... 266s Selecting previously unselected package dropbear-bin. 266s Preparing to unpack .../02-dropbear-bin_2024.85-3_armhf.deb ... 266s Unpacking dropbear-bin (2024.85-3) ... 266s Selecting previously unselected package dropbear. 266s Preparing to unpack .../03-dropbear_2024.85-3_all.deb ... 266s Unpacking dropbear (2024.85-3) ... 266s Selecting previously unselected package libhavege2:armhf. 266s Preparing to unpack .../04-libhavege2_1.9.14-1ubuntu2_armhf.deb ... 266s Unpacking libhavege2:armhf (1.9.14-1ubuntu2) ... 266s Selecting previously unselected package haveged. 266s Preparing to unpack .../05-haveged_1.9.14-1ubuntu2_armhf.deb ... 266s Unpacking haveged (1.9.14-1ubuntu2) ... 266s Selecting previously unselected package libfile-dirlist-perl. 266s Preparing to unpack .../06-libfile-dirlist-perl_0.05-3_all.deb ... 266s Unpacking libfile-dirlist-perl (0.05-3) ... 266s Selecting previously unselected package libfile-which-perl. 266s Preparing to unpack .../07-libfile-which-perl_1.27-2_all.deb ... 266s Unpacking libfile-which-perl (1.27-2) ... 266s Selecting previously unselected package libfile-homedir-perl. 266s Preparing to unpack .../08-libfile-homedir-perl_1.006-2_all.deb ... 266s Unpacking libfile-homedir-perl (1.006-2) ... 266s Selecting previously unselected package libfile-touch-perl. 266s Preparing to unpack .../09-libfile-touch-perl_0.12-2_all.deb ... 266s Unpacking libfile-touch-perl (0.12-2) ... 266s Selecting previously unselected package libio-pty-perl. 266s Preparing to unpack .../10-libio-pty-perl_1%3a1.20-1build3_armhf.deb ... 266s Unpacking libio-pty-perl (1:1.20-1build3) ... 266s Selecting previously unselected package libipc-run-perl. 266s Preparing to unpack .../11-libipc-run-perl_20231003.0-2_all.deb ... 266s Unpacking libipc-run-perl (20231003.0-2) ... 266s Selecting previously unselected package libclass-method-modifiers-perl. 266s Preparing to unpack .../12-libclass-method-modifiers-perl_2.15-1_all.deb ... 266s Unpacking libclass-method-modifiers-perl (2.15-1) ... 266s Selecting previously unselected package libclass-xsaccessor-perl. 266s Preparing to unpack .../13-libclass-xsaccessor-perl_1.19-4build5_armhf.deb ... 266s Unpacking libclass-xsaccessor-perl (1.19-4build5) ... 266s Selecting previously unselected package libb-hooks-op-check-perl:armhf. 266s Preparing to unpack .../14-libb-hooks-op-check-perl_0.22-3build2_armhf.deb ... 266s Unpacking libb-hooks-op-check-perl:armhf (0.22-3build2) ... 266s Selecting previously unselected package libdynaloader-functions-perl. 266s Preparing to unpack .../15-libdynaloader-functions-perl_0.004-1_all.deb ... 266s Unpacking libdynaloader-functions-perl (0.004-1) ... 266s Selecting previously unselected package libdevel-callchecker-perl:armhf. 266s Preparing to unpack .../16-libdevel-callchecker-perl_0.009-1build1_armhf.deb ... 266s Unpacking libdevel-callchecker-perl:armhf (0.009-1build1) ... 266s Selecting previously unselected package libparams-classify-perl:armhf. 266s Preparing to unpack .../17-libparams-classify-perl_0.015-2build6_armhf.deb ... 266s Unpacking libparams-classify-perl:armhf (0.015-2build6) ... 267s Selecting previously unselected package libmodule-runtime-perl. 267s Preparing to unpack .../18-libmodule-runtime-perl_0.016-2_all.deb ... 267s Unpacking libmodule-runtime-perl (0.016-2) ... 267s Selecting previously unselected package libimport-into-perl. 267s Preparing to unpack .../19-libimport-into-perl_1.002005-2_all.deb ... 267s Unpacking libimport-into-perl (1.002005-2) ... 267s Selecting previously unselected package librole-tiny-perl. 267s Preparing to unpack .../20-librole-tiny-perl_2.002004-1_all.deb ... 267s Unpacking librole-tiny-perl (2.002004-1) ... 267s Selecting previously unselected package libsub-quote-perl. 267s Preparing to unpack .../21-libsub-quote-perl_2.006008-1ubuntu1_all.deb ... 267s Unpacking libsub-quote-perl (2.006008-1ubuntu1) ... 267s Selecting previously unselected package libmoo-perl. 267s Preparing to unpack .../22-libmoo-perl_2.005005-1_all.deb ... 267s Unpacking libmoo-perl (2.005005-1) ... 267s Selecting previously unselected package libencode-locale-perl. 267s Preparing to unpack .../23-libencode-locale-perl_1.05-3_all.deb ... 267s Unpacking libencode-locale-perl (1.05-3) ... 267s Selecting previously unselected package libtimedate-perl. 267s Preparing to unpack .../24-libtimedate-perl_2.3300-2_all.deb ... 267s Unpacking libtimedate-perl (2.3300-2) ... 267s Selecting previously unselected package libhttp-date-perl. 267s Preparing to unpack .../25-libhttp-date-perl_6.06-1_all.deb ... 267s Unpacking libhttp-date-perl (6.06-1) ... 267s Selecting previously unselected package libfile-listing-perl. 267s Preparing to unpack .../26-libfile-listing-perl_6.16-1_all.deb ... 267s Unpacking libfile-listing-perl (6.16-1) ... 267s Selecting previously unselected package libhtml-tagset-perl. 267s Preparing to unpack .../27-libhtml-tagset-perl_3.24-1_all.deb ... 267s Unpacking libhtml-tagset-perl (3.24-1) ... 267s Selecting previously unselected package liburi-perl. 267s Preparing to unpack .../28-liburi-perl_5.28-1_all.deb ... 267s Unpacking liburi-perl (5.28-1) ... 267s Selecting previously unselected package libhtml-parser-perl:armhf. 267s Preparing to unpack .../29-libhtml-parser-perl_3.83-1build1_armhf.deb ... 267s Unpacking libhtml-parser-perl:armhf (3.83-1build1) ... 267s Selecting previously unselected package libhtml-tree-perl. 267s Preparing to unpack .../30-libhtml-tree-perl_5.07-3_all.deb ... 267s Unpacking libhtml-tree-perl (5.07-3) ... 267s Selecting previously unselected package libclone-perl:armhf. 267s Preparing to unpack .../31-libclone-perl_0.47-1_armhf.deb ... 267s Unpacking libclone-perl:armhf (0.47-1) ... 267s Selecting previously unselected package libio-html-perl. 267s Preparing to unpack .../32-libio-html-perl_1.004-3_all.deb ... 267s Unpacking libio-html-perl (1.004-3) ... 267s Selecting previously unselected package liblwp-mediatypes-perl. 267s Preparing to unpack .../33-liblwp-mediatypes-perl_6.04-2_all.deb ... 267s Unpacking liblwp-mediatypes-perl (6.04-2) ... 267s Selecting previously unselected package libhttp-message-perl. 267s Preparing to unpack .../34-libhttp-message-perl_7.00-2ubuntu1_all.deb ... 267s Unpacking libhttp-message-perl (7.00-2ubuntu1) ... 267s Selecting previously unselected package libhttp-cookies-perl. 267s Preparing to unpack .../35-libhttp-cookies-perl_6.11-1_all.deb ... 267s Unpacking libhttp-cookies-perl (6.11-1) ... 268s Selecting previously unselected package libhttp-negotiate-perl. 268s Preparing to unpack .../36-libhttp-negotiate-perl_6.01-2_all.deb ... 268s Unpacking libhttp-negotiate-perl (6.01-2) ... 268s Selecting previously unselected package perl-openssl-defaults:armhf. 268s Preparing to unpack .../37-perl-openssl-defaults_7build3_armhf.deb ... 268s Unpacking perl-openssl-defaults:armhf (7build3) ... 268s Selecting previously unselected package libnet-ssleay-perl:armhf. 268s Preparing to unpack .../38-libnet-ssleay-perl_1.94-2_armhf.deb ... 268s Unpacking libnet-ssleay-perl:armhf (1.94-2) ... 268s Selecting previously unselected package libio-socket-ssl-perl. 268s Preparing to unpack .../39-libio-socket-ssl-perl_2.089-1_all.deb ... 268s Unpacking libio-socket-ssl-perl (2.089-1) ... 268s Selecting previously unselected package libnet-http-perl. 268s Preparing to unpack .../40-libnet-http-perl_6.23-1_all.deb ... 268s Unpacking libnet-http-perl (6.23-1) ... 268s Selecting previously unselected package liblwp-protocol-https-perl. 268s Preparing to unpack .../41-liblwp-protocol-https-perl_6.14-1_all.deb ... 268s Unpacking liblwp-protocol-https-perl (6.14-1) ... 268s Selecting previously unselected package libtry-tiny-perl. 268s Preparing to unpack .../42-libtry-tiny-perl_0.32-1_all.deb ... 268s Unpacking libtry-tiny-perl (0.32-1) ... 268s Selecting previously unselected package libwww-robotrules-perl. 268s Preparing to unpack .../43-libwww-robotrules-perl_6.02-1_all.deb ... 268s Unpacking libwww-robotrules-perl (6.02-1) ... 268s Selecting previously unselected package libwww-perl. 268s Preparing to unpack .../44-libwww-perl_6.77-1_all.deb ... 268s Unpacking libwww-perl (6.77-1) ... 268s Selecting previously unselected package patchutils. 268s Preparing to unpack .../45-patchutils_0.4.2-1build3_armhf.deb ... 268s Unpacking patchutils (0.4.2-1build3) ... 268s Selecting previously unselected package wdiff. 268s Preparing to unpack .../46-wdiff_1.2.2-6build1_armhf.deb ... 268s Unpacking wdiff (1.2.2-6build1) ... 268s Selecting previously unselected package devscripts. 268s Preparing to unpack .../47-devscripts_2.24.3_all.deb ... 268s Unpacking devscripts (2.24.3) ... 268s Selecting previously unselected package putty-tools. 268s Preparing to unpack .../48-putty-tools_0.81-2_armhf.deb ... 268s Unpacking putty-tools (0.81-2) ... 268s Selecting previously unselected package python3-bcrypt. 268s Preparing to unpack .../49-python3-bcrypt_4.2.0-1_armhf.deb ... 268s Unpacking python3-bcrypt (4.2.0-1) ... 268s Selecting previously unselected package python3-hamcrest. 268s Preparing to unpack .../50-python3-hamcrest_2.1.0-1_all.deb ... 268s Unpacking python3-hamcrest (2.1.0-1) ... 268s Selecting previously unselected package python3-pyasn1. 268s Preparing to unpack .../51-python3-pyasn1_0.6.0-1_all.deb ... 268s Unpacking python3-pyasn1 (0.6.0-1) ... 269s Selecting previously unselected package python3-pyasn1-modules. 269s Preparing to unpack .../52-python3-pyasn1-modules_0.4.1-1_all.deb ... 269s Unpacking python3-pyasn1-modules (0.4.1-1) ... 269s Selecting previously unselected package python3-service-identity. 269s Preparing to unpack .../53-python3-service-identity_24.1.0-1_all.deb ... 269s Unpacking python3-service-identity (24.1.0-1) ... 269s Selecting previously unselected package python3-automat. 269s Preparing to unpack .../54-python3-automat_24.8.1-1_all.deb ... 269s Unpacking python3-automat (24.8.1-1) ... 269s Selecting previously unselected package python3-constantly. 269s Preparing to unpack .../55-python3-constantly_23.10.4-2_all.deb ... 269s Unpacking python3-constantly (23.10.4-2) ... 269s Selecting previously unselected package python3-hyperlink. 269s Preparing to unpack .../56-python3-hyperlink_21.0.0-6_all.deb ... 269s Unpacking python3-hyperlink (21.0.0-6) ... 269s Selecting previously unselected package python3-incremental. 269s Preparing to unpack .../57-python3-incremental_24.7.2-2_all.deb ... 269s Unpacking python3-incremental (24.7.2-2) ... 269s Selecting previously unselected package python3-zope.interface. 269s Preparing to unpack .../58-python3-zope.interface_7.1.1-1build1_armhf.deb ... 269s Unpacking python3-zope.interface (7.1.1-1build1) ... 269s Selecting previously unselected package python3-twisted. 269s Preparing to unpack .../59-python3-twisted_24.10.0-1_all.deb ... 269s Unpacking python3-twisted (24.10.0-1) ... 269s Selecting previously unselected package openssh-tests. 269s Preparing to unpack .../60-openssh-tests_1%3a9.7p1-7ubuntu5_armhf.deb ... 269s Unpacking openssh-tests (1:9.7p1-7ubuntu5) ... 269s Selecting previously unselected package autopkgtest-satdep. 269s Preparing to unpack .../61-1-autopkgtest-satdep.deb ... 269s Unpacking autopkgtest-satdep (0) ... 269s Setting up wdiff (1.2.2-6build1) ... 269s Setting up libfile-which-perl (1.27-2) ... 270s Setting up libdynaloader-functions-perl (0.004-1) ... 270s Setting up libclass-method-modifiers-perl (2.15-1) ... 270s Setting up libio-pty-perl (1:1.20-1build3) ... 270s Setting up python3-zope.interface (7.1.1-1build1) ... 270s Setting up libclone-perl:armhf (0.47-1) ... 270s Setting up libtommath1:armhf (1.3.0-1) ... 270s Setting up libhtml-tagset-perl (3.24-1) ... 270s Setting up python3-bcrypt (4.2.0-1) ... 270s Setting up python3-automat (24.8.1-1) ... 270s Setting up liblwp-mediatypes-perl (6.04-2) ... 270s Setting up libtry-tiny-perl (0.32-1) ... 270s Setting up perl-openssl-defaults:armhf (7build3) ... 270s Setting up libencode-locale-perl (1.05-3) ... 270s Setting up python3-hamcrest (2.1.0-1) ... 271s Setting up putty-tools (0.81-2) ... 271s Setting up libhavege2:armhf (1.9.14-1ubuntu2) ... 271s Setting up patchutils (0.4.2-1build3) ... 271s Setting up python3-incremental (24.7.2-2) ... 271s Setting up python3-hyperlink (21.0.0-6) ... 271s Setting up libio-html-perl (1.004-3) ... 271s Setting up libb-hooks-op-check-perl:armhf (0.22-3build2) ... 271s Setting up libipc-run-perl (20231003.0-2) ... 271s Setting up libtimedate-perl (2.3300-2) ... 271s Setting up librole-tiny-perl (2.002004-1) ... 271s Setting up python3-pyasn1 (0.6.0-1) ... 272s Setting up python3-constantly (23.10.4-2) ... 272s Setting up libsub-quote-perl (2.006008-1ubuntu1) ... 272s Setting up libclass-xsaccessor-perl (1.19-4build5) ... 272s Setting up libfile-dirlist-perl (0.05-3) ... 272s Setting up libfile-homedir-perl (1.006-2) ... 272s Setting up liburi-perl (5.28-1) ... 272s Setting up libfile-touch-perl (0.12-2) ... 272s Setting up libnet-ssleay-perl:armhf (1.94-2) ... 272s Setting up libtomcrypt1:armhf (1.18.2+dfsg-7build1) ... 272s Setting up libhttp-date-perl (6.06-1) ... 272s Setting up haveged (1.9.14-1ubuntu2) ... 272s apparmor_parser: Unable to replace "/usr/sbin/haveged". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 272s 272s Created symlink '/etc/systemd/system/sysinit.target.wants/haveged.service' → '/usr/lib/systemd/system/haveged.service'. 273s Setting up dropbear-bin (2024.85-3) ... 273s Setting up libfile-listing-perl (6.16-1) ... 273s Setting up libnet-http-perl (6.23-1) ... 273s Setting up libdevel-callchecker-perl:armhf (0.009-1build1) ... 273s Setting up dropbear (2024.85-3) ... 273s Converting existing OpenSSH RSA host key to Dropbear format. 273s Key is a ssh-rsa key 273s Wrote key to '/etc/dropbear/dropbear_rsa_host_key' 273s 3072 SHA256:EQ/k071tKYc8BGa6X8S+tqnbxpFT02jiwITAO/Uk27U /etc/dropbear/dropbear_rsa_host_key (RSA) 273s +---[RSA 3072]----+ 273s | ..o+.+ | 273s | ..+Oo+. | 273s | o=Oo.=. o | 273s | o .+==E+=..| 273s | .S oO==. | 273s | . .=* | 273s | ..oo | 273s | ooo | 273s | o++ | 273s +----[SHA256]-----+ 273s Converting existing OpenSSH ECDSA host key to Dropbear format. 273s Key is a ecdsa-sha2-nistp256 key 273s Wrote key to '/etc/dropbear/dropbear_ecdsa_host_key' 273s 256 SHA256:aTU4haB/XEc+v7cTmgM+/x5Cet55KrSM7i+hktDBpII /etc/dropbear/dropbear_ecdsa_host_key (ECDSA) 273s +---[ECDSA 256]---+ 273s | .. .. . | 273s | .. .o o | 273s | . .+ o + + | 273s |E . ..o. = o o | 273s | . ...S .. | 273s | . .o ..+ o | 273s | . . ..*.++.o| 273s | o . oo*+oo=| 273s | . ooo++=Bo| 273s +----[SHA256]-----+ 273s Converting existing OpenSSH ED25519 host key to Dropbear format. 273s Key is a ssh-ed25519 key 273s Wrote key to '/etc/dropbear/dropbear_ed25519_host_key' 273s 256 SHA256:8N5gOnUBupfVEDDwYoJQIkx5BSa+smRAXC0mr/NJXSY /etc/dropbear/dropbear_ed25519_host_key (ED25519) 273s +--[ED25519 256]--+ 273s |B=+++...+.o. | 273s |+Bo= . o o o | 273s |..* o = . o . | 273s |. .. E B o . | 273s |.+. . = S . | 273s |++ . . * + | 273s |. + . o . . | 273s | o . | 273s | | 273s +----[SHA256]-----+ 273s Created symlink '/etc/systemd/system/multi-user.target.wants/dropbear.service' → '/usr/lib/systemd/system/dropbear.service'. 274s Setting up python3-pyasn1-modules (0.4.1-1) ... 274s Setting up python3-service-identity (24.1.0-1) ... 274s Setting up libwww-robotrules-perl (6.02-1) ... 274s Setting up libhtml-parser-perl:armhf (3.83-1build1) ... 274s Setting up libio-socket-ssl-perl (2.089-1) ... 274s Setting up libhttp-message-perl (7.00-2ubuntu1) ... 274s Setting up libhttp-negotiate-perl (6.01-2) ... 274s Setting up libhttp-cookies-perl (6.11-1) ... 274s Setting up libhtml-tree-perl (5.07-3) ... 274s Setting up libparams-classify-perl:armhf (0.015-2build6) ... 274s Setting up libmodule-runtime-perl (0.016-2) ... 274s Setting up python3-twisted (24.10.0-1) ... 279s Setting up libimport-into-perl (1.002005-2) ... 279s Setting up libmoo-perl (2.005005-1) ... 279s Setting up openssh-tests (1:9.7p1-7ubuntu5) ... 279s Setting up liblwp-protocol-https-perl (6.14-1) ... 279s Setting up libwww-perl (6.77-1) ... 279s Setting up devscripts (2.24.3) ... 279s Setting up autopkgtest-satdep (0) ... 279s Processing triggers for libc-bin (2.40-1ubuntu3) ... 279s Processing triggers for man-db (2.13.0-1) ... 281s Processing triggers for install-info (7.1.1-1) ... 301s (Reading database ... 62749 files and directories currently installed.) 301s Removing autopkgtest-satdep (0) ... 306s autopkgtest [21:44:25]: test regress: [----------------------- 309s info: Adding user `openssh-tests' ... 309s info: Selecting UID/GID from range 1000 to 59999 ... 309s info: Adding new group `openssh-tests' (1001) ... 309s info: Adding new user `openssh-tests' (1001) with group `openssh-tests (1001)' ... 309s info: Creating home directory `/home/openssh-tests' ... 309s info: Copying files from `/etc/skel' ... 309s info: Adding new user `openssh-tests' to supplemental / extra groups `users' ... 309s info: Adding user `openssh-tests' to group `users' ... 309s Synchronizing state of haveged.service with SysV service script with /usr/lib/systemd/systemd-sysv-install. 309s Executing: /usr/lib/systemd/systemd-sysv-install enable haveged 310s I: annotate-output 2.24.3 310s I: prefix='%H:%M:%S.%N ' 310s 21:44:29.445146586 I: Started /usr/lib/openssh/regress/run-tests /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user 310s 21:44:29.497300447 O: make: Entering directory '/tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress' 310s 21:44:29.501114201 O: test "x" = "x" || mkdir -p /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/valgrind-out 310s 21:44:29.503082098 E: + /usr/bin/ssh -Q key 310s 21:44:29.505394519 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 310s 21:44:29.506462888 E: + grep -q ^ssh-rsa 310s 21:44:29.509754717 O: ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2.prv | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 310s 21:44:29.513458430 O: tr '\n' '\r' /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv ; \ 310s 21:44:29.515965972 E: + ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2.prv 310s 21:44:29.516582698 O: ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 310s 21:44:29.519655765 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv 310s 21:44:29.520050409 O: awk '{print $0 "\r"}' /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2.prv > /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv ; \ 310s 21:44:29.523470199 O: ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 310s 21:44:29.525947901 E: + tr \n \r 310s 21:44:29.526339424 O: fi 310s 21:44:29.529477212 E: + ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv 310s 21:44:29.532440238 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv 310s 21:44:29.540570990 E: + awk {print $0 "\r"} /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2.prv 310s 21:44:29.546536563 E: + ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv 310s 21:44:29.549696671 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv 310s 21:44:29.558150265 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 310s 21:44:29.561395174 O: cat /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv > /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t2.out ; \ 310s 21:44:29.561107852 E: + /usr/bin/ssh -Q key 310s 21:44:29.564908485 E: + grep -q ^ssh-rsa 310s 21:44:29.565028766 O: chmod 600 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t2.out ; \ 310s 21:44:29.568588638 O: ssh-keygen -yf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t2.out | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub ; \ 310s 21:44:29.571314422 E: + cat /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.prv 310s 21:44:29.571820826 O: fi 310s 21:44:29.574919374 E: + chmod 600 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t2.out 310s 21:44:29.578002081 E: + ssh-keygen -yf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t2.out 310s 21:44:29.581687314 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub 310s 21:44:29.588574294 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 310s 21:44:29.590375990 E: + /usr/bin/ssh -Q key 310s 21:44:29.592966973 O: ssh-keygen -ef /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub >/tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t3.out ; \ 310s 21:44:29.593631819 E: + grep -q ^ssh-rsa 310s 21:44:29.597123490 O: ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t3.out | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub ; \ 310s 21:44:29.599930715 E: + ssh-keygen -ef /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub 310s 21:44:29.600555760 O: fi 310s 21:44:29.607574462 E: + ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t3.out 310s 21:44:29.611087813 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub 310s 21:44:29.618380438 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 310s 21:44:29.621227023 E: + /usr/bin/ssh -Q key 310s 21:44:29.621536986 O: ssh-keygen -E md5 -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 310s 21:44:29.624671254 E: + grep -q ^ssh-rsa 310s 21:44:29.625124538 O: awk '{print $2}' | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t4.ok ; \ 310s 21:44:29.628637889 O: fi 310s 21:44:29.631666355 E: + ssh-keygen -E md5 -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub 310s 21:44:29.644535669 E: + awk {print $2} 310s 21:44:29.647439415 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t4.ok 310s 21:44:29.647392375 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 310s 21:44:29.650906286 E: + /usr/bin/ssh -Q key 310s 21:44:29.651749293 O: ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 310s 21:44:29.654997642 E: + grep -q ^ssh-rsa 310s 21:44:29.655788569 O: awk '{print $2}' | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t5.ok ; \ 310s 21:44:29.659201479 O: fi 310s 21:44:29.661255337 E: + ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub 310s 21:44:29.664501966 E: + awk {print $2} 310s 21:44:29.667680154 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t5.ok 310s 21:44:29.672042152 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 310s 21:44:29.674897298 E: + /usr/bin/ssh -Q key 310s 21:44:29.676028668 O: ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/dsa_ssh2.prv > /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out1 ; \ 310s 21:44:29.678433449 E: + grep -q ^ssh-dss 310s 21:44:29.679783661 O: ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/dsa_ssh2.pub > /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out2 ; \ 310s 21:44:29.683128890 O: chmod 600 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out1 ; \ 310s 21:44:29.685921235 E: + ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/dsa_ssh2.prv 310s 21:44:29.686890524 O: ssh-keygen -yf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out1 | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out2 ; \ 310s 21:44:29.690622477 O: fi 310s 21:44:29.695804643 E: + ssh-keygen -if /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/dsa_ssh2.pub 310s 21:44:29.704800842 E: + chmod 600 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out1 310s 21:44:29.708055951 E: + ssh-keygen -yf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out1 310s 21:44:29.711431141 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t6.out2 310s 21:44:29.719797415 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 310s 21:44:29.721469870 E: + /usr/bin/ssh -Q key 310s 21:44:29.723638609 O: ssh-keygen -q -t rsa -N '' -f /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t7.out ; \ 310s 21:44:29.725476065 E: + grep -q ^ssh-dss 310s 21:44:29.727383482 O: fi 310s 21:44:29.732316925 E: + ssh-keygen -q -t rsa -N -f /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t7.out 311s 21:44:30.807252591 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 311s 21:44:30.809637212 E: + /usr/bin/ssh -Q key 311s 21:44:30.811391948 O: ssh-keygen -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t7.out > /dev/null ; \ 311s 21:44:30.813535367 E: + grep -q ^ssh-dss 311s 21:44:30.815146141 O: ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t7.out > /dev/null ; \ 311s 21:44:30.818842614 O: fi 311s 21:44:30.820605669 E: + ssh-keygen -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t7.out 311s 21:44:30.829411867 E: + ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t7.out 311s 21:44:30.839297634 O: set -xe ; if ssh -Q key | grep -q "^ssh-dss" ; then \ 311s 21:44:30.842949467 E: + + ssh -Q key 311s 21:44:30.843399511 O: ssh-keygen -q -t dsa -N '' -f /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t8.out ; \ 311s 21:44:30.847256865 O: fi 311s 21:44:30.847419946 E: grep -q ^ssh-dss 311s 21:44:30.852109948 E: + ssh-keygen -q -t dsa -N -f /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t8.out 312s 21:44:31.006292351 O: set -xe ; if ssh -Q key | grep -q "^ssh-dss" ; then \ 312s 21:44:31.009398299 E: + ssh -Q key 312s 21:44:31.010109705 O: ssh-keygen -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t8.out > /dev/null ; \ 312s 21:44:31.012631967 E: + grep -q ^ssh-dss 312s 21:44:31.014298222 O: ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t8.out > /dev/null ; \ 312s 21:44:31.017881494 O: fi 312s 21:44:31.018378618 E: + ssh-keygen -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t8.out 312s 21:44:31.027904942 E: + ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t8.out 312s 21:44:31.037982712 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 312s 21:44:31.041950187 O: ssh-keygen -q -t ecdsa -N '' -f /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t9.out 312s 21:44:31.059452381 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 312s 21:44:31.063247615 O: ssh-keygen -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t9.out > /dev/null 312s 21:44:31.080752890 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 312s 21:44:31.084992447 O: ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t9.out > /dev/null 312s 21:44:31.103229409 O: ssh-keygen -q -t ed25519 -N '' -f /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t10.out 312s 21:44:31.114425788 O: ssh-keygen -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t10.out > /dev/null 312s 21:44:31.125781008 O: ssh-keygen -Bf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t10.out > /dev/null 312s 21:44:31.137423671 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 312s 21:44:31.141305985 E: + /usr/bin/ssh -Q key 312s 21:44:31.141636668 O: ssh-keygen -E sha256 -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 312s 21:44:31.146585232 O: awk '{print $2}' | diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t11.ok ; \ 312s 21:44:31.146870155 E: + grep -q ^ssh-dss 312s 21:44:31.150817070 O: fi 312s 21:44:31.151681317 E: + ssh-keygen -E sha256 -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/rsa_openssh.pub 312s 21:44:31.155435630 E: + awk {print $2} 312s 21:44:31.159363465 E: + diff - /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t11.ok 312s 21:44:31.162466693 O: ssh-keygen -q -t ed25519 -N '' -C 'test-comment-1234' -f /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t12.out 312s 21:44:31.172935625 O: ssh-keygen -lf /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/t12.out.pub | grep test-comment-1234 >/dev/null 312s 21:44:31.190209858 E: run test connect.sh ... 315s 21:44:34.066787383 O: ok simple connect 315s 21:44:34.068024954 E: run test proxy-connect.sh ... 315s 21:44:34.593782365 O: plain username comp=no 316s 21:44:34.998214424 O: plain username comp=yes 316s 21:44:35.394100807 O: username with style 316s 21:44:35.794675711 O: ok proxy connect 316s 21:44:35.795342957 E: run test sshfp-connect.sh ... 317s 21:44:36.344353856 O: SKIPPED: TEST_SSH_SSHFP_DOMAIN not set. 317s 21:44:36.346337393 E: run test connect-privsep.sh ... 323s 21:44:42.037318333 O: ok proxy connect with privsep 323s 21:44:42.037538694 E: run test connect-uri.sh ... 323s 21:44:42.734206344 O: uri connect: no trailing slash 324s 21:44:43.172468546 O: uri connect: trailing slash 324s 21:44:43.624384308 O: uri connect: with path name 324s 21:44:43.694531890 E: run test proto-version.sh ... 324s 21:44:43.694468049 O: ok uri connect 325s 21:44:44.220958392 O: ok sshd version with different protocol combinations 325s 21:44:44.222272164 E: run test proto-mismatch.sh ... 325s 21:44:44.802011619 O: ok protocol version mismatch 325s 21:44:44.804255199 E: run test exit-status.sh ... 326s 21:44:45.329438532 O: test remote exit status: status 0 332s 21:44:51.116925340 O: test remote exit status: status 1 337s 21:44:56.952764812 O: test remote exit status: status 4 343s 21:45:02.763920939 O: test remote exit status: status 5 349s 21:45:08.605644692 O: test remote exit status: status 44 355s 21:45:14.410389110 O: ok remote exit status 355s 21:45:14.411773963 E: run test exit-status-signal.sh ... 356s 21:45:15.939474943 O: ok exit status on signal 356s 21:45:15.939479463 E: run test envpass.sh ... 357s 21:45:16.464639012 O: test environment passing: pass env, don't accept 357s 21:45:16.879410499 O: test environment passing: setenv, don't accept 358s 21:45:17.301810735 O: test environment passing: don't pass env, accept 358s 21:45:17.726056187 O: test environment passing: pass single env, accept single env 359s 21:45:18.134331857 O: test environment passing: pass multiple env, accept multiple env 359s 21:45:18.560978211 O: test environment passing: setenv, accept 360s 21:45:18.986306513 O: test environment passing: setenv, first match wins 360s 21:45:19.384890138 O: test environment passing: server setenv wins 360s 21:45:19.785722503 O: test environment passing: server setenv wins 361s 21:45:20.195539187 O: ok environment passing 361s 21:45:20.195538987 E: run test transfer.sh ... 364s 21:45:23.751544781 O: ok transfer data 364s 21:45:23.752448909 E: run test banner.sh ... 365s 21:45:24.182556056 O: test banner: missing banner file 365s 21:45:24.555334853 O: test banner: size 0 365s 21:45:24.953144953 O: test banner: size 10 366s 21:45:25.348476711 O: test banner: size 100 366s 21:45:25.733377456 O: test banner: size 1000 367s 21:45:26.128352451 O: test banner: size 10000 367s 21:45:26.556466382 O: test banner: size 100000 367s 21:45:26.932865252 O: test banner: suppress banner (-q) 368s 21:45:27.289810909 O: ok banner 368s 21:45:27.289987110 E: run test rekey.sh ... 368s 21:45:27.768896933 O: client rekey KexAlgorithms=diffie-hellman-group1-sha1 370s 21:45:29.889778174 O: client rekey KexAlgorithms=diffie-hellman-group14-sha1 372s 21:45:31.945380758 O: client rekey KexAlgorithms=diffie-hellman-group14-sha256 375s 21:45:34.016407363 O: client rekey KexAlgorithms=diffie-hellman-group16-sha512 377s 21:45:36.064525728 O: client rekey KexAlgorithms=diffie-hellman-group18-sha512 379s 21:45:38.123516114 O: client rekey KexAlgorithms=diffie-hellman-group-exchange-sha1 381s 21:45:40.195916424 O: client rekey KexAlgorithms=diffie-hellman-group-exchange-sha256 383s 21:45:42.234819159 O: client rekey KexAlgorithms=ecdh-sha2-nistp256 385s 21:45:44.306196267 O: client rekey KexAlgorithms=ecdh-sha2-nistp384 387s 21:45:46.366026397 O: client rekey KexAlgorithms=ecdh-sha2-nistp521 389s 21:45:48.430483451 O: client rekey KexAlgorithms=curve25519-sha256 391s 21:45:50.497378851 O: client rekey KexAlgorithms=curve25519-sha256@libssh.org 393s 21:45:52.589047597 O: client rekey KexAlgorithms=sntrup761x25519-sha512@openssh.com 395s 21:45:54.651036681 O: client rekey Ciphers=3des-cbc 397s 21:45:56.752782884 O: client rekey Ciphers=aes128-cbc 399s 21:45:58.824021379 O: client rekey Ciphers=aes192-cbc 401s 21:46:00.923790892 O: client rekey Ciphers=aes256-cbc 404s 21:46:02.995471318 O: client rekey Ciphers=aes128-ctr 406s 21:46:05.075573344 O: client rekey Ciphers=aes192-ctr 408s 21:46:07.183380221 O: client rekey Ciphers=aes256-ctr 410s 21:46:09.266917645 O: client rekey Ciphers=aes128-gcm@openssh.com 412s 21:46:11.313002298 O: client rekey Ciphers=aes256-gcm@openssh.com 414s 21:46:13.369663329 O: client rekey Ciphers=chacha20-poly1305@openssh.com 416s 21:46:15.437516144 O: client rekey MACs=hmac-sha1 418s 21:46:17.500332358 O: client rekey MACs=hmac-sha1-96 420s 21:46:19.540759535 O: client rekey MACs=hmac-sha2-256 422s 21:46:21.597778984 O: client rekey MACs=hmac-sha2-512 424s 21:46:23.664885327 O: client rekey MACs=hmac-md5 426s 21:46:25.739477141 O: client rekey MACs=hmac-md5-96 428s 21:46:27.792632446 O: client rekey MACs=umac-64@openssh.com 430s 21:46:29.820825212 O: client rekey MACs=umac-128@openssh.com 432s 21:46:31.939527272 O: client rekey MACs=hmac-sha1-etm@openssh.com 435s 21:46:34.025610803 O: client rekey MACs=hmac-sha1-96-etm@openssh.com 437s 21:46:36.076221700 O: client rekey MACs=hmac-sha2-256-etm@openssh.com 439s 21:46:38.121690475 O: client rekey MACs=hmac-sha2-512-etm@openssh.com 441s 21:46:40.306310980 O: client rekey MACs=hmac-md5-etm@openssh.com 443s 21:46:42.389289259 O: client rekey MACs=hmac-md5-96-etm@openssh.com 445s 21:46:44.458550297 O: client rekey MACs=umac-64-etm@openssh.com 447s 21:46:46.532972226 O: client rekey MACs=umac-128-etm@openssh.com 449s 21:46:48.674249438 O: client rekey aes128-gcm@openssh.com diffie-hellman-group1-sha1 451s 21:46:50.827242078 O: client rekey aes128-gcm@openssh.com diffie-hellman-group14-sha1 453s 21:46:52.906473301 O: client rekey aes128-gcm@openssh.com diffie-hellman-group14-sha256 456s 21:46:54.999361130 O: client rekey aes128-gcm@openssh.com diffie-hellman-group16-sha512 458s 21:46:57.088966332 O: client rekey aes128-gcm@openssh.com diffie-hellman-group18-sha512 460s 21:46:59.206132546 O: client rekey aes128-gcm@openssh.com diffie-hellman-group-exchange-sha1 462s 21:47:01.307571702 O: client rekey aes128-gcm@openssh.com diffie-hellman-group-exchange-sha256 464s 21:47:03.383692874 O: client rekey aes128-gcm@openssh.com ecdh-sha2-nistp256 466s 21:47:05.480774598 O: client rekey aes128-gcm@openssh.com ecdh-sha2-nistp384 468s 21:47:07.621068274 O: client rekey aes128-gcm@openssh.com ecdh-sha2-nistp521 470s 21:47:09.744891805 O: client rekey aes128-gcm@openssh.com curve25519-sha256 472s 21:47:11.861750477 O: client rekey aes128-gcm@openssh.com curve25519-sha256@libssh.org 475s 21:47:14.370806840 O: client rekey aes128-gcm@openssh.com sntrup761x25519-sha512@openssh.com 477s 21:47:16.539241704 O: client rekey aes256-gcm@openssh.com diffie-hellman-group1-sha1 479s 21:47:18.645639893 O: client rekey aes256-gcm@openssh.com diffie-hellman-group14-sha1 481s 21:47:20.769694405 O: client rekey aes256-gcm@openssh.com diffie-hellman-group14-sha256 483s 21:47:22.888449192 O: client rekey aes256-gcm@openssh.com diffie-hellman-group16-sha512 486s 21:47:24.999756676 O: client rekey aes256-gcm@openssh.com diffie-hellman-group18-sha512 488s 21:47:27.112091572 O: client rekey aes256-gcm@openssh.com diffie-hellman-group-exchange-sha1 490s 21:47:29.215132588 O: client rekey aes256-gcm@openssh.com diffie-hellman-group-exchange-sha256 492s 21:47:31.315488064 O: client rekey aes256-gcm@openssh.com ecdh-sha2-nistp256 494s 21:47:33.421106030 O: client rekey aes256-gcm@openssh.com ecdh-sha2-nistp384 496s 21:47:35.536112524 O: client rekey aes256-gcm@openssh.com ecdh-sha2-nistp521 498s 21:47:37.657060514 O: client rekey aes256-gcm@openssh.com curve25519-sha256 501s 21:47:40.096812302 O: client rekey aes256-gcm@openssh.com curve25519-sha256@libssh.org 503s 21:47:42.194118847 O: client rekey aes256-gcm@openssh.com sntrup761x25519-sha512@openssh.com 505s 21:47:44.314463202 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group1-sha1 507s 21:47:46.396840699 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group14-sha1 509s 21:47:48.459648462 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group14-sha256 511s 21:47:50.586902290 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group16-sha512 513s 21:47:52.699978033 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group18-sha512 515s 21:47:54.799853901 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group-exchange-sha1 517s 21:47:56.933856879 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group-exchange-sha256 520s 21:47:59.021398801 O: client rekey chacha20-poly1305@openssh.com ecdh-sha2-nistp256 522s 21:48:01.133216146 O: client rekey chacha20-poly1305@openssh.com ecdh-sha2-nistp384 524s 21:48:03.389321037 O: client rekey chacha20-poly1305@openssh.com ecdh-sha2-nistp521 526s 21:48:05.498546924 O: client rekey chacha20-poly1305@openssh.com curve25519-sha256 528s 21:48:07.616464694 O: client rekey chacha20-poly1305@openssh.com curve25519-sha256@libssh.org 530s 21:48:09.702523458 O: client rekey chacha20-poly1305@openssh.com sntrup761x25519-sha512@openssh.com 532s 21:48:11.807601038 O: client rekeylimit 16 535s 21:48:14.628229408 O: client rekeylimit 1k 538s 21:48:17.231760260 O: client rekeylimit 128k 540s 21:48:19.364290219 O: client rekeylimit 256k 542s 21:48:21.474757101 O: client rekeylimit default 5 557s 21:48:36.932819881 O: client rekeylimit default 10 578s 21:48:57.402578528 O: client rekeylimit default 5 no data 593s 21:49:12.942278943 O: client rekeylimit default 10 no data 614s 21:49:33.361347314 O: server rekeylimit 16 617s 21:49:36.242228431 O: server rekeylimit 1k 619s 21:49:38.765555192 O: server rekeylimit 128k 621s 21:49:40.823854353 O: server rekeylimit 256k 623s 21:49:42.931969248 O: server rekeylimit default 5 no data 639s 21:49:58.467710625 O: server rekeylimit default 10 no data 659s 21:50:18.853712231 O: rekeylimit parsing 674s 21:50:33.580832738 O: ok rekey 674s 21:50:33.581140865 E: run test dhgex.sh ... 675s 21:50:33.996663285 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 3des-cbc 675s 21:50:34.281194332 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 3des-cbc 675s 21:50:34.609640987 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-cbc 675s 21:50:34.903560192 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-cbc 676s 21:50:35.199027666 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-ctr 676s 21:50:35.489668557 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-ctr 676s 21:50:35.783492994 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-gcm@openssh.com 677s 21:50:36.084060413 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-gcm@openssh.com 677s 21:50:36.410366050 O: dhgex bits 7680 diffie-hellman-group-exchange-sha1 aes192-cbc 677s 21:50:36.788808825 O: dhgex bits 7680 diffie-hellman-group-exchange-sha256 aes192-cbc 678s 21:50:37.193723795 O: dhgex bits 7680 diffie-hellman-group-exchange-sha1 aes192-ctr 678s 21:50:37.569971197 O: dhgex bits 7680 diffie-hellman-group-exchange-sha256 aes192-ctr 679s 21:50:37.971486332 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-cbc 679s 21:50:38.380888785 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-cbc 679s 21:50:38.781008203 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-ctr 680s 21:50:39.179625705 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-ctr 680s 21:50:39.596963077 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-gcm@openssh.com 681s 21:50:40.003682106 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-gcm@openssh.com 681s 21:50:40.419970088 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 chacha20-poly1305@openssh.com 681s 21:50:40.944560345 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 chacha20-poly1305@openssh.com 682s 21:50:41.488399637 O: ok dhgex 682s 21:50:41.489232974 E: run test stderr-data.sh ... 682s 21:50:41.926731954 O: test stderr data transfer: () 689s 21:50:48.910124457 O: test stderr data transfer: (-n) 696s 21:50:55.841466313 E: run test stderr-after-eof.sh ... 696s 21:50:55.838081443 O: ok stderr data transfer 699s 21:50:58.671843008 O: ok stderr data after eof 699s 21:50:58.672299337 E: run test broken-pipe.sh ... 700s 21:50:59.131855516 O: ok broken pipe test 700s 21:50:59.132696013 E: run test try-ciphers.sh ... 700s 21:50:59.565267668 O: test try ciphers: cipher 3des-cbc mac hmac-sha1 700s 21:50:59.949744769 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-96 701s 21:51:00.336998722 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-256 701s 21:51:00.742993741 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-512 702s 21:51:01.125995443 O: test try ciphers: cipher 3des-cbc mac hmac-md5 702s 21:51:01.501192899 O: test try ciphers: cipher 3des-cbc mac hmac-md5-96 702s 21:51:01.898108164 O: test try ciphers: cipher 3des-cbc mac umac-64@openssh.com 703s 21:51:02.314854511 O: test try ciphers: cipher 3des-cbc mac umac-128@openssh.com 703s 21:51:02.781712210 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-etm@openssh.com 704s 21:51:03.183009914 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-96-etm@openssh.com 704s 21:51:03.556810208 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-256-etm@openssh.com 705s 21:51:03.958712241 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-512-etm@openssh.com 705s 21:51:04.345191951 O: test try ciphers: cipher 3des-cbc mac hmac-md5-etm@openssh.com 705s 21:51:04.731316332 O: test try ciphers: cipher 3des-cbc mac hmac-md5-96-etm@openssh.com 706s 21:51:05.132308097 O: test try ciphers: cipher 3des-cbc mac umac-64-etm@openssh.com 706s 21:51:05.527014407 O: test try ciphers: cipher 3des-cbc mac umac-128-etm@openssh.com 707s 21:51:05.941590807 O: test try ciphers: cipher aes128-cbc mac hmac-sha1 707s 21:51:06.348772408 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-96 707s 21:51:06.739321506 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-256 708s 21:51:07.129365952 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-512 708s 21:51:07.542473186 O: test try ciphers: cipher aes128-cbc mac hmac-md5 708s 21:51:07.929712690 O: test try ciphers: cipher aes128-cbc mac hmac-md5-96 709s 21:51:08.319314917 O: test try ciphers: cipher aes128-cbc mac umac-64@openssh.com 709s 21:51:08.721067591 O: test try ciphers: cipher aes128-cbc mac umac-128@openssh.com 710s 21:51:09.103396786 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-etm@openssh.com 710s 21:51:09.487676215 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-96-etm@openssh.com 710s 21:51:09.862344488 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-256-etm@openssh.com 711s 21:51:10.249468172 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-512-etm@openssh.com 711s 21:51:10.631038259 O: test try ciphers: cipher aes128-cbc mac hmac-md5-etm@openssh.com 712s 21:51:11.018257462 O: test try ciphers: cipher aes128-cbc mac hmac-md5-96-etm@openssh.com 712s 21:51:11.430082121 O: test try ciphers: cipher aes128-cbc mac umac-64-etm@openssh.com 712s 21:51:11.829360284 O: test try ciphers: cipher aes128-cbc mac umac-128-etm@openssh.com 713s 21:51:12.345407868 O: test try ciphers: cipher aes192-cbc mac hmac-sha1 713s 21:51:12.842124534 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-96 714s 21:51:13.225766727 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-256 714s 21:51:13.617652245 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-512 715s 21:51:14.025435727 O: test try ciphers: cipher aes192-cbc mac hmac-md5 715s 21:51:14.413989810 O: test try ciphers: cipher aes192-cbc mac hmac-md5-96 715s 21:51:14.818273574 O: test try ciphers: cipher aes192-cbc mac umac-64@openssh.com 716s 21:51:15.269466010 O: test try ciphers: cipher aes192-cbc mac umac-128@openssh.com 716s 21:51:15.683776172 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-etm@openssh.com 717s 21:51:16.123105721 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-96-etm@openssh.com 717s 21:51:16.548456140 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-256-etm@openssh.com 717s 21:51:16.924196229 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-512-etm@openssh.com 718s 21:51:17.307407025 O: test try ciphers: cipher aes192-cbc mac hmac-md5-etm@openssh.com 718s 21:51:17.692074449 O: test try ciphers: cipher aes192-cbc mac hmac-md5-96-etm@openssh.com 719s 21:51:18.069301200 O: test try ciphers: cipher aes192-cbc mac umac-64-etm@openssh.com 719s 21:51:18.489438379 O: test try ciphers: cipher aes192-cbc mac umac-128-etm@openssh.com 719s 21:51:18.909229190 O: test try ciphers: cipher aes256-cbc mac hmac-sha1 720s 21:51:19.305975648 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-96 720s 21:51:19.709075273 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-256 721s 21:51:20.108691026 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-512 721s 21:51:20.512118451 O: test try ciphers: cipher aes256-cbc mac hmac-md5 721s 21:51:20.913762399 O: test try ciphers: cipher aes256-cbc mac hmac-md5-96 722s 21:51:21.300359038 O: test try ciphers: cipher aes256-cbc mac umac-64@openssh.com 722s 21:51:21.694612110 O: test try ciphers: cipher aes256-cbc mac umac-128@openssh.com 723s 21:51:22.088945422 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-etm@openssh.com 723s 21:51:22.477717896 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-96-etm@openssh.com 723s 21:51:22.874016163 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-256-etm@openssh.com 724s 21:51:23.275952420 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-512-etm@openssh.com 724s 21:51:23.686867775 O: test try ciphers: cipher aes256-cbc mac hmac-md5-etm@openssh.com 725s 21:51:24.080505740 O: test try ciphers: cipher aes256-cbc mac hmac-md5-96-etm@openssh.com 725s 21:51:24.471848293 O: test try ciphers: cipher aes256-cbc mac umac-64-etm@openssh.com 725s 21:51:24.865289369 O: test try ciphers: cipher aes256-cbc mac umac-128-etm@openssh.com 726s 21:51:25.276034190 O: test try ciphers: cipher aes128-ctr mac hmac-sha1 726s 21:51:25.668546520 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-96 727s 21:51:26.053510216 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-256 727s 21:51:26.446140262 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-512 727s 21:51:26.832201655 O: test try ciphers: cipher aes128-ctr mac hmac-md5 728s 21:51:27.221796276 O: test try ciphers: cipher aes128-ctr mac hmac-md5-96 728s 21:51:27.603481055 O: test try ciphers: cipher aes128-ctr mac umac-64@openssh.com 729s 21:51:27.989356558 O: test try ciphers: cipher aes128-ctr mac umac-128@openssh.com 729s 21:51:28.379779786 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-etm@openssh.com 729s 21:51:28.779482001 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-96-etm@openssh.com 730s 21:51:29.174850726 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-256-etm@openssh.com 730s 21:51:29.607379915 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-512-etm@openssh.com 731s 21:51:30.007280807 O: test try ciphers: cipher aes128-ctr mac hmac-md5-etm@openssh.com 731s 21:51:30.399294574 O: test try ciphers: cipher aes128-ctr mac hmac-md5-96-etm@openssh.com 731s 21:51:30.801494026 O: test try ciphers: cipher aes128-ctr mac umac-64-etm@openssh.com 732s 21:51:31.194894018 O: test try ciphers: cipher aes128-ctr mac umac-128-etm@openssh.com 732s 21:51:31.601359309 O: test try ciphers: cipher aes192-ctr mac hmac-sha1 733s 21:51:32.049315833 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-96 733s 21:51:32.438062561 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-256 733s 21:51:32.834577685 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-512 734s 21:51:33.229143447 O: test try ciphers: cipher aes192-ctr mac hmac-md5 734s 21:51:33.616739625 O: test try ciphers: cipher aes192-ctr mac hmac-md5-96 735s 21:51:34.008576329 O: test try ciphers: cipher aes192-ctr mac umac-64@openssh.com 735s 21:51:34.401978137 O: test try ciphers: cipher aes192-ctr mac umac-128@openssh.com 735s 21:51:34.796347325 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-etm@openssh.com 736s 21:51:35.196267502 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-96-etm@openssh.com 736s 21:51:35.605739786 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-256-etm@openssh.com 737s 21:51:36.019219350 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-512-etm@openssh.com 737s 21:51:36.430868870 O: test try ciphers: cipher aes192-ctr mac hmac-md5-etm@openssh.com 737s 21:51:36.843438330 O: test try ciphers: cipher aes192-ctr mac hmac-md5-96-etm@openssh.com 738s 21:51:37.239463894 O: test try ciphers: cipher aes192-ctr mac umac-64-etm@openssh.com 738s 21:51:37.671798461 O: test try ciphers: cipher aes192-ctr mac umac-128-etm@openssh.com 739s 21:51:38.081897463 O: test try ciphers: cipher aes256-ctr mac hmac-sha1 739s 21:51:38.482667993 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-96 739s 21:51:38.875764529 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-256 740s 21:51:39.266371452 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-512 740s 21:51:39.666000032 O: test try ciphers: cipher aes256-ctr mac hmac-md5 741s 21:51:40.058745874 O: test try ciphers: cipher aes256-ctr mac hmac-md5-96 741s 21:51:40.448461690 O: test try ciphers: cipher aes256-ctr mac umac-64@openssh.com 741s 21:51:40.840530313 O: test try ciphers: cipher aes256-ctr mac umac-128@openssh.com 742s 21:51:41.209525832 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-etm@openssh.com 742s 21:51:41.580837594 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-96-etm@openssh.com 742s 21:51:41.938471684 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-256-etm@openssh.com 743s 21:51:42.299318834 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-512-etm@openssh.com 743s 21:51:42.667717372 O: test try ciphers: cipher aes256-ctr mac hmac-md5-etm@openssh.com 744s 21:51:43.036021148 O: test try ciphers: cipher aes256-ctr mac hmac-md5-96-etm@openssh.com 744s 21:51:43.404380280 O: test try ciphers: cipher aes256-ctr mac umac-64-etm@openssh.com 744s 21:51:43.793554746 O: test try ciphers: cipher aes256-ctr mac umac-128-etm@openssh.com 745s 21:51:44.201441101 O: test try ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1 745s 21:51:44.597585779 O: test try ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1 746s 21:51:44.989104486 O: test try ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1 746s 21:51:45.371338441 E: run test yes-head.sh ... 746s 21:51:45.370344862 O: ok try ciphers 749s 21:51:48.790210691 O: ok yes pipe head 749s 21:51:48.790628939 E: run test login-timeout.sh ... 765s 21:52:04.870223449 O: ok connect after login grace timeout 765s 21:52:04.870619977 E: run test agent.sh ... 779s 21:52:18.606838487 O: ok simple agent test 779s 21:52:18.607002411 E: run test agent-getpeereid.sh ... 780s 21:52:19.076881102 O: ok disallow agent attach from other uid 780s 21:52:19.077656317 E: run test agent-timeout.sh ... 800s 21:52:39.671070592 O: ok agent timeout test 800s 21:52:39.671811446 E: run test agent-ptrace.sh ... 801s 21:52:40.062266638 E: run test agent-subprocess.sh ... 801s 21:52:40.062088634 O: skipped (gdb not found) 811s 21:52:50.524417632 O: ok agent subprocess 811s 21:52:50.528562830 E: run test keyscan.sh ... 815s 21:52:54.765297995 O: ok keyscan 815s 21:52:54.765638041 E: run test keygen-change.sh ... 822s 21:53:01.344310315 E: run test keygen-comment.sh ... 822s 21:53:01.344273635 O: ok change passphrase for key 830s 21:53:09.307489003 O: ok Comment extraction from private key 830s 21:53:09.307850129 E: run test keygen-convert.sh ... 835s 21:53:14.741594296 O: ok convert keys 835s 21:53:14.742060504 E: run test keygen-knownhosts.sh ... 836s 21:53:15.489796521 O: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts updated. 836s 21:53:15.493385147 O: Original contents retained as /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts.old 836s 21:53:15.535136761 O: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts updated. 836s 21:53:15.538116416 O: Original contents retained as /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts.old 836s 21:53:15.553238976 O: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts updated. 836s 21:53:15.556406915 O: Original contents retained as /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts.old 836s 21:53:15.584417074 O: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts updated. 836s 21:53:15.586964001 O: Original contents retained as /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hosts.old 836s 21:53:15.638589717 O: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hashed updated. 836s 21:53:15.641434810 O: Original contents retained as /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/kh.hashed.old 836s 21:53:15.648993070 O: ok ssh-keygen known_hosts 836s 21:53:15.649227154 E: run test keygen-moduli.sh ... 843s 21:53:22.444793563 O: ok keygen moduli 843s 21:53:22.445695860 E: run test keygen-sshfp.sh ... 844s 21:53:23.016024292 O: ok keygen-sshfp 844s 21:53:23.017260634 E: run test key-options.sh ... 844s 21:53:23.437786980 O: key option command="echo bar" 844s 21:53:23.800874667 O: key option no-pty,command="echo bar" 845s 21:53:24.172495429 O: key option pty default 845s 21:53:24.562197481 O: key option pty no-pty 845s 21:53:24.922199307 O: key option pty restrict 846s 21:53:25.283396311 O: key option pty restrict,pty 846s 21:53:25.663099014 O: key option environment 847s 21:53:26.655044288 O: key option from="127.0.0.1" 848s 21:53:27.905466536 O: key option from="127.0.0.0/8" 849s 21:53:28.743109588 O: key option expiry-time default 850s 21:53:29.108014043 O: key option expiry-time invalid 850s 21:53:29.537882326 O: key option expiry-time expired 851s 21:53:29.965194242 O: key option expiry-time valid 851s 21:53:30.357087703 O: ok key options 851s 21:53:30.357276107 E: run test scp.sh ... 851s 21:53:30.734723823 O: scp: scp mode: simple copy local file to local file 851s 21:53:30.759584439 O: scp: scp mode: simple copy local file to remote file 851s 21:53:30.778485265 O: scp: scp mode: simple copy remote file to local file 851s 21:53:30.800456028 O: scp: scp mode: copy local file to remote file in place 851s 21:53:30.825395965 O: scp: scp mode: copy remote file to local file in place 851s 21:53:30.853290636 O: scp: scp mode: copy local file to remote file clobber 851s 21:53:30.876811027 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 21:53 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/copy 851s 21:53:30.879812322 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 21:53 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/data 851s 21:53:30.882758456 O: scp: scp mode: copy remote file to local file clobber 851s 21:53:30.907982878 O: scp: scp mode: simple copy local file to remote dir 851s 21:53:30.934621566 O: scp: scp mode: simple copy local file to local dir 852s 21:53:30.961486099 O: scp: scp mode: simple copy remote file to local dir 852s 21:53:30.990884437 O: scp: scp mode: recursive local dir to remote dir 852s 21:53:31.045548718 O: scp: scp mode: recursive local dir to local dir 852s 21:53:31.107458772 O: scp: scp mode: recursive remote dir to local dir 852s 21:53:31.170859093 O: scp: scp mode: unmatched glob file local->remote 852s 21:53:31.197383539 O: scp: scp mode: unmatched glob file remote->local 852s 21:53:31.211589679 O: scp: scp mode: unmatched glob dir recursive local->remote 852s 21:53:31.253087079 O: scp: scp mode: unmatched glob dir recursive remote->local 852s 21:53:31.270385035 O: scp: scp mode: shell metacharacters 852s 21:53:31.318412075 O: scp: scp mode: skipped file after scp -p with failed chown+utimes 852s 21:53:31.431827512 O: scp: scp mode: disallow bad server #0 852s 21:53:31.493221036 O: scp: scp mode: disallow bad server #1 852s 21:53:31.555400894 O: scp: scp mode: disallow bad server #2 852s 21:53:31.616716177 O: scp: scp mode: disallow bad server #3 852s 21:53:31.681453843 O: scp: scp mode: disallow bad server #4 852s 21:53:31.747624174 O: scp: scp mode: disallow bad server #5 852s 21:53:31.810934133 O: scp: scp mode: disallow bad server #6 852s 21:53:31.876420493 O: scp: scp mode: disallow bad server #7 852s 21:53:31.943970689 O: scp: scp mode: detect non-directory target 852s 21:53:31.959152167 E: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/copy2: Not a directory 853s 21:53:31.964750150 O: scp: sftp mode: simple copy local file to local file 853s 21:53:31.990886109 O: scp: sftp mode: simple copy local file to remote file 853s 21:53:32.017912563 O: scp: sftp mode: simple copy remote file to local file 853s 21:53:32.043718115 O: scp: sftp mode: copy local file to remote file in place 853s 21:53:32.073801946 O: scp: sftp mode: copy remote file to local file in place 853s 21:53:32.104106580 O: scp: sftp mode: copy local file to remote file clobber 853s 21:53:32.132004171 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 21:53 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/copy 853s 21:53:32.135366752 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 21:53 /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/data 853s 21:53:32.138475009 O: scp: sftp mode: copy remote file to local file clobber 853s 21:53:32.167077493 O: scp: sftp mode: simple copy local file to remote dir 853s 21:53:32.197676653 O: scp: sftp mode: simple copy local file to local dir 853s 21:53:32.225958930 O: scp: sftp mode: simple copy remote file to local dir 853s 21:53:32.255028382 O: scp: sftp mode: recursive local dir to remote dir 853s 21:53:32.312424352 O: scp: sftp mode: recursive local dir to local dir 853s 21:53:32.369223071 O: scp: sftp mode: recursive remote dir to local dir 853s 21:53:32.434401464 O: scp: sftp mode: unmatched glob file local->remote 853s 21:53:32.461266436 O: scp: sftp mode: unmatched glob file remote->local 853s 21:53:32.484022692 O: scp: sftp mode: unmatched glob dir recursive local->remote 853s 21:53:32.529407562 O: scp: sftp mode: unmatched glob dir recursive remote->local 853s 21:53:32.555316797 O: scp: sftp mode: shell metacharacters 853s 21:53:32.579355916 O: scp: sftp mode: skipped file after scp -p with failed chown+utimes 853s 21:53:32.691389406 O: scp: sftp mode: disallow bad server #0 853s 21:53:32.774904895 O: scp: sftp mode: disallow bad server #1 853s 21:53:32.852742999 O: scp: sftp mode: disallow bad server #2 853s 21:53:32.921992346 O: scp: sftp mode: disallow bad server #3 854s 21:53:32.989200536 O: scp: sftp mode: disallow bad server #4 854s 21:53:33.055910596 O: scp: sftp mode: disallow bad server #5 854s 21:53:33.116588745 O: scp: sftp mode: disallow bad server #6 854s 21:53:33.182258466 O: scp: sftp mode: disallow bad server #7 854s 21:53:33.246824366 O: scp: sftp mode: detect non-directory target 854s 21:53:33.256795429 E: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/copy2: Not a directory 854s 21:53:33.270516400 O: ok scp 854s 21:53:33.271597379 E: run test scp3.sh ... 854s 21:53:33.704899182 O: scp3: scp mode: simple copy remote file to remote file 855s 21:53:34.110123790 O: scp3: scp mode: simple copy remote file to remote dir 855s 21:53:34.514423137 O: scp3: scp mode: recursive remote dir to remote dir 856s 21:53:34.966966006 O: scp3: scp mode: detect non-directory target 856s 21:53:35.737108628 O: scp3: sftp mode: simple copy remote file to remote file 856s 21:53:35.762857058 O: scp3: sftp mode: simple copy remote file to remote dir 856s 21:53:35.795523054 O: scp3: sftp mode: recursive remote dir to remote dir 856s 21:53:35.860640443 O: scp3: sftp mode: detect non-directory target 856s 21:53:35.876429411 E: scp: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/copy2: destination is not a directory 856s 21:53:35.879043099 E: scp: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/copy2: destination is not a directory 856s 21:53:35.894824827 O: ok scp3 856s 21:53:35.896095650 E: run test scp-uri.sh ... 857s 21:53:36.369417568 O: scp-uri: scp mode: simple copy local file to remote file 857s 21:53:36.394259581 O: scp-uri: scp mode: simple copy remote file to local file 857s 21:53:36.415449608 O: scp-uri: scp mode: simple copy local file to remote dir 857s 21:53:36.443362157 O: scp-uri: scp mode: simple copy remote file to local dir 857s 21:53:36.470061404 O: scp-uri: scp mode: recursive local dir to remote dir 857s 21:53:36.501370015 O: scp-uri: scp mode: recursive remote dir to local dir 857s 21:53:36.532025815 O: scp-uri: sftp mode: simple copy local file to remote file 857s 21:53:36.553425685 O: scp-uri: sftp mode: simple copy remote file to local file 857s 21:53:36.574388827 O: scp-uri: sftp mode: simple copy local file to remote dir 857s 21:53:36.599796691 O: scp-uri: sftp mode: simple copy remote file to local dir 857s 21:53:36.626009489 O: scp-uri: sftp mode: recursive local dir to remote dir 857s 21:53:36.657538585 O: scp-uri: sftp mode: recursive remote dir to local dir 857s 21:53:36.699310307 O: ok scp-uri 857s 21:53:36.699310307 E: run test sftp.sh ... 858s 21:53:37.168285901 O: test basic sftp put/get: buffer_size 5 num_requests 1 862s 21:53:41.856408812 O: test basic sftp put/get: buffer_size 5 num_requests 2 865s 21:53:44.120883496 O: test basic sftp put/get: buffer_size 5 num_requests 10 866s 21:53:45.711868749 O: test basic sftp put/get: buffer_size 1000 num_requests 1 866s 21:53:45.753637866 O: test basic sftp put/get: buffer_size 1000 num_requests 2 866s 21:53:45.784314503 O: test basic sftp put/get: buffer_size 1000 num_requests 10 866s 21:53:45.814250965 O: test basic sftp put/get: buffer_size 32000 num_requests 1 866s 21:53:45.835050862 O: test basic sftp put/get: buffer_size 32000 num_requests 2 866s 21:53:45.855742317 O: test basic sftp put/get: buffer_size 32000 num_requests 10 866s 21:53:45.874688221 O: test basic sftp put/get: buffer_size 64000 num_requests 1 866s 21:53:45.894429979 O: test basic sftp put/get: buffer_size 64000 num_requests 2 866s 21:53:45.911608770 O: test basic sftp put/get: buffer_size 64000 num_requests 10 866s 21:53:45.935225598 O: ok basic sftp put/get 866s 21:53:45.935280079 E: run test sftp-chroot.sh ... 867s 21:53:46.503858340 O: test sftp in chroot: get 867s 21:53:46.941986997 O: test sftp in chroot: match 868s 21:53:47.578784045 O: ok sftp in chroot 868s 21:53:47.595413546 E: run test sftp-cmds.sh ... 869s 21:53:47.966536825 O: sftp commands: lls 869s 21:53:47.979316336 O: sftp commands: lls w/path 869s 21:53:47.992075967 O: sftp commands: ls 869s 21:53:48.003837980 O: sftp commands: shell 869s 21:53:48.014524893 O: sftp commands: pwd 869s 21:53:48.020854368 O: sftp commands: lpwd 869s 21:53:48.028088898 O: sftp commands: quit 869s 21:53:48.035605554 O: sftp commands: help 869s 21:53:48.043870584 O: sftp commands: get 869s 21:53:48.060593326 O: sftp commands: get quoted 869s 21:53:48.076645857 O: sftp commands: get filename with quotes 869s 21:53:48.094579741 O: sftp commands: get filename with spaces 869s 21:53:48.110995198 O: sftp commands: get filename with glob metacharacters 869s 21:53:48.125756265 O: sftp commands: get to directory 869s 21:53:48.138373453 O: sftp commands: glob get to directory 869s 21:53:48.310447006 O: sftp commands: get to local dir 869s 21:53:48.325475838 O: sftp commands: glob get to local dir 869s 21:53:48.416950773 O: sftp commands: put 869s 21:53:48.436011078 O: sftp commands: put filename with quotes 869s 21:53:48.451442597 O: sftp commands: put filename with spaces 869s 21:53:48.470890908 O: sftp commands: put to directory 869s 21:53:48.488133660 O: sftp commands: glob put to directory 869s 21:53:48.508532989 O: sftp commands: put to local dir 869s 21:53:48.526114867 O: sftp commands: glob put to local dir 869s 21:53:48.543192656 O: sftp commands: rename 869s 21:53:48.554858547 O: sftp commands: rename directory 869s 21:53:48.564286798 O: sftp commands: ln 869s 21:53:48.574316779 O: sftp commands: ln -s 869s 21:53:48.584463043 O: sftp commands: cp 869s 21:53:48.599075227 O: sftp commands: mkdir 869s 21:53:48.606942930 O: sftp commands: chdir 869s 21:53:48.614973035 O: sftp commands: rmdir 869s 21:53:48.623051381 O: sftp commands: lmkdir 869s 21:53:48.631470213 O: sftp commands: lchdir 869s 21:53:48.644110362 O: ok sftp commands 869s 21:53:48.644574450 E: run test sftp-badcmds.sh ... 870s 21:53:49.016685301 O: sftp invalid commands: get nonexistent 870s 21:53:49.026498919 O: sftp invalid commands: glob get to nonexistent directory 870s 21:53:49.054125178 O: sftp invalid commands: put nonexistent 870s 21:53:49.066233797 O: sftp invalid commands: glob put to nonexistent directory 870s 21:53:49.078372297 O: sftp invalid commands: rename nonexistent 870s 21:53:49.091474013 O: sftp invalid commands: rename target exists (directory) 870s 21:53:49.114590351 O: sftp invalid commands: glob put files to local file 870s 21:53:49.130275395 O: ok sftp invalid commands 870s 21:53:49.131087090 E: run test sftp-batch.sh ... 870s 21:53:49.490059659 O: sftp batchfile: good commands 870s 21:53:49.504435238 O: sftp batchfile: bad commands 870s 21:53:49.521402905 O: sftp batchfile: comments and blanks 870s 21:53:49.532683629 O: sftp batchfile: junk command 870s 21:53:49.542750091 O: ok sftp batchfile 870s 21:53:49.543067697 E: run test sftp-glob.sh ... 870s 21:53:49.929508082 O: sftp glob: file glob 870s 21:53:49.946409828 O: sftp glob: dir glob 870s 21:53:49.961268697 O: sftp glob: quoted glob 871s 21:53:49.976330369 O: sftp glob: escaped glob 871s 21:53:49.992482901 O: sftp glob: escaped quote 871s 21:53:50.007112765 O: sftp glob: quoted quote 871s 21:53:50.019826195 O: sftp glob: single-quoted quote 871s 21:53:50.033317599 O: sftp glob: escaped space 871s 21:53:50.047847341 O: sftp glob: quoted space 871s 21:53:50.063080616 O: sftp glob: escaped slash 871s 21:53:50.077291113 O: sftp glob: quoted slash 871s 21:53:50.090598593 O: sftp glob: escaped slash at EOL 871s 21:53:50.105119056 O: sftp glob: quoted slash at EOL 871s 21:53:50.122110682 O: sftp glob: escaped slash+quote 871s 21:53:50.137780126 O: sftp glob: quoted slash+quote 871s 21:53:50.153938817 O: ok sftp glob 871s 21:53:50.155090358 E: run test sftp-perm.sh ... 871s 21:53:50.521930545 O: sftp permissions: read-only upload 871s 21:53:50.555379029 O: sftp permissions: read-only setstat 871s 21:53:50.592781305 O: sftp permissions: read-only rm 871s 21:53:50.628699514 O: sftp permissions: read-only mkdir 871s 21:53:50.658457691 O: sftp permissions: read-only rmdir 871s 21:53:50.692791231 O: sftp permissions: read-only posix-rename 871s 21:53:50.740470533 O: sftp permissions: read-only oldrename 871s 21:53:50.776006134 O: sftp permissions: read-only symlink 871s 21:53:50.812660677 O: sftp permissions: read-only hardlink 871s 21:53:50.851592860 O: sftp permissions: explicit open 871s 21:53:50.914679479 O: sftp permissions: explicit read 872s 21:53:50.979259126 O: sftp permissions: explicit write 872s 21:53:51.046134453 O: sftp permissions: explicit lstat 872s 21:53:51.109363155 O: sftp permissions: explicit opendir 872s 21:53:51.168466342 O: sftp permissions: explicit readdir 872s 21:53:51.228642348 O: sftp permissions: explicit setstat 872s 21:53:51.297852117 O: sftp permissions: explicit remove 872s 21:53:51.362534805 O: sftp permissions: explicit mkdir 872s 21:53:51.413790810 O: sftp permissions: explicit rmdir 872s 21:53:51.478637781 O: sftp permissions: explicit rename 872s 21:53:51.544904897 O: sftp permissions: explicit symlink 872s 21:53:51.607676790 O: sftp permissions: explicit hardlink 872s 21:53:51.674184271 O: sftp permissions: explicit statvfs 872s 21:53:51.722995112 O: ok sftp permissions 872s 21:53:51.723074953 E: run test sftp-uri.sh ... 873s 21:53:52.289620856 O: sftp-uri: non-interactive fetch to local file 873s 21:53:52.714394239 O: sftp-uri: non-interactive fetch to local dir 874s 21:53:53.143132931 O: sftp-uri: put to remote directory (trailing slash) 874s 21:53:53.568055110 O: sftp-uri: put to remote directory (no slash) 875s 21:53:54.035464615 O: ok sftp-uri 875s 21:53:54.035807141 E: run test reconfigure.sh ... 889s 21:54:08.337209634 O: ok simple connect after reconfigure 889s 21:54:08.338782942 E: run test dynamic-forward.sh ... 890s 21:54:09.126024743 O: test -D forwarding 892s 21:54:11.441132069 O: test -R forwarding 894s 21:54:13.681812488 O: PermitRemoteOpen=any 897s 21:54:16.726779635 O: PermitRemoteOpen=none 898s 21:54:17.290082345 O: PermitRemoteOpen=explicit 901s 21:54:20.391976206 O: PermitRemoteOpen=disallowed 902s 21:54:21.015421196 O: ok dynamic forwarding 902s 21:54:21.016212330 E: run test forwarding.sh ... 910s 21:54:29.745494819 O: ok local and remote forwarding 910s 21:54:29.746250712 E: run test multiplex.sh ... 912s 21:54:31.362795559 O: test connection multiplexing: setenv 912s 21:54:31.404285007 O: test connection multiplexing: envpass 912s 21:54:31.431366883 O: test connection multiplexing: transfer 912s 21:54:31.577245205 O: test connection multiplexing: forward 914s 21:54:33.672696096 O: test connection multiplexing: status 0 () 919s 21:54:38.731547857 O: test connection multiplexing: status 0 (-Oproxy) 924s 21:54:43.798593783 O: test connection multiplexing: status 1 () 929s 21:54:48.855713202 O: test connection multiplexing: status 1 (-Oproxy) 934s 21:54:53.919366243 O: test connection multiplexing: status 4 () 940s 21:54:58.979668617 O: test connection multiplexing: status 4 (-Oproxy) 945s 21:55:04.038080152 O: test connection multiplexing: status 5 () 950s 21:55:09.097011014 O: test connection multiplexing: status 5 (-Oproxy) 955s 21:55:14.153966962 O: test connection multiplexing: status 44 () 960s 21:55:19.215548352 O: test connection multiplexing: status 44 (-Oproxy) 965s 21:55:24.276017489 O: test connection multiplexing: cmd check 965s 21:55:24.294138356 O: test connection multiplexing: cmd forward local (TCP) 966s 21:55:25.747695573 O: test connection multiplexing: cmd forward remote (TCP) 968s 21:55:27.198029152 O: test connection multiplexing: cmd forward local (UNIX) 969s 21:55:28.316705056 O: test connection multiplexing: cmd forward remote (UNIX) 970s 21:55:29.434329448 O: test connection multiplexing: cmd exit 970s 21:55:29.453105245 O: test connection multiplexing: cmd stop 981s 21:55:40.935547914 O: ok connection multiplexing 981s 21:55:40.935879720 E: run test reexec.sh ... 982s 21:55:41.274272602 O: test config passing 982s 21:55:41.905813806 O: test reexec fallback 982s 21:55:41.907565115 E: ln: failed to create hard link '/tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/sshd' => '/usr/sbin/sshd': Operation not permitted 983s 21:55:42.482880450 O: ok reexec tests 983s 21:55:42.482982492 E: run test brokenkeys.sh ... 984s 21:55:43.462282800 O: ok broken keys 984s 21:55:43.462308321 E: run test sshcfgparse.sh ... 984s 21:55:43.806327650 O: reparse minimal config 984s 21:55:43.841234235 O: ssh -W opts 984s 21:55:43.936601835 O: user first match 985s 21:55:44.003924844 O: pubkeyacceptedalgorithms 985s 21:55:44.159266887 O: agentforwarding 985s 21:55:44.238615897 O: command line override 985s 21:55:44.282308909 O: ok ssh config parse 985s 21:55:44.282503833 E: run test cfgparse.sh ... 985s 21:55:44.622966739 O: reparse minimal config 985s 21:55:44.795798395 O: reparse regress config 986s 21:55:44.965903886 O: listenaddress order 986s 21:55:45.152664975 O: ok sshd config parse 986s 21:55:45.153035901 E: run test cfgmatch.sh ... 995s 21:55:54.007979133 O: ok sshd_config match 995s 21:55:54.008184417 E: run test cfgmatchlisten.sh ... 1008s 21:56:07.530821164 O: ok sshd_config matchlisten 1008s 21:56:07.531073608 E: run test percent.sh ... 1008s 21:56:07.877010007 O: percent expansions matchexec percent 1013s 21:56:12.109295104 O: percent expansions localcommand percent 1017s 21:56:16.378686398 O: percent expansions remotecommand percent 1017s 21:56:16.673551167 O: percent expansions controlpath percent 1018s 21:56:16.971552507 O: percent expansions identityagent percent 1018s 21:56:17.264922368 O: percent expansions forwardagent percent 1018s 21:56:17.565969596 O: percent expansions localforward percent 1018s 21:56:17.855577315 O: percent expansions remoteforward percent 1019s 21:56:18.146091608 O: percent expansions revokedhostkeys percent 1019s 21:56:18.458208894 O: percent expansions userknownhostsfile percent 1022s 21:56:21.862975280 O: percent expansions controlpath dollar 1022s 21:56:21.890531692 O: percent expansions identityagent dollar 1022s 21:56:21.916422397 O: percent expansions forwardagent dollar 1022s 21:56:21.942278301 O: percent expansions localforward dollar 1023s 21:56:21.968811456 O: percent expansions remoteforward dollar 1023s 21:56:21.994909403 O: percent expansions userknownhostsfile dollar 1023s 21:56:22.317936737 O: percent expansions controlpath tilde 1023s 21:56:22.364779864 O: percent expansions identityagent tilde 1023s 21:56:22.418587706 O: percent expansions forwardagent tilde 1023s 21:56:22.468775968 O: ok percent expansions 1023s 21:56:22.468946131 E: run test addrmatch.sh ... 1023s 21:56:22.826626432 O: test first entry for user 192.168.0.1 somehost 1023s 21:56:22.901570700 O: test negative match for user 192.168.30.1 somehost 1024s 21:56:22.975841597 O: test no match for user 19.0.0.1 somehost 1024s 21:56:23.079789339 O: test list middle for user 10.255.255.254 somehost 1024s 21:56:23.182033214 O: test faked IP in hostname for user 192.168.30.1 192.168.0.1 1024s 21:56:23.256325990 O: test bare IP4 address for user 1.1.1.1 somehost.example.com 1024s 21:56:23.329483189 O: test localaddress for user 19.0.0.1 somehost 1024s 21:56:23.402981752 O: test localport for user 19.0.0.1 somehost 1024s 21:56:23.476772921 O: test bare IP6 address for user ::1 somehost.example.com 1024s 21:56:23.549806677 O: test deny IPv6 for user ::2 somehost.example.com 1024s 21:56:23.628402044 O: test IP6 negated for user ::3 somehost 1024s 21:56:23.701791566 O: test IP6 no match for user ::4 somehost 1024s 21:56:23.776470229 O: test IP6 network for user 2000::1 somehost 1024s 21:56:23.850348438 O: test IP6 network for user 2001::1 somehost 1024s 21:56:23.923666319 O: test IP6 localaddress for user ::5 somehost 1025s 21:56:23.996002744 O: test IP6 localport for user ::5 somehost 1025s 21:56:24.069275223 O: test invalid Match address 10.0.1.0/8 1025s 21:56:24.093327377 O: test invalid Match localaddress 10.0.1.0/8 1025s 21:56:24.120382299 O: test invalid Match address 10.0.0.1/24 1025s 21:56:24.143661320 O: test invalid Match localaddress 10.0.0.1/24 1025s 21:56:24.168111481 O: test invalid Match address 2000:aa:bb:01::/56 1025s 21:56:24.194074906 O: test invalid Match localaddress 2000:aa:bb:01::/56 1025s 21:56:24.244850417 O: ok address match 1025s 21:56:24.246037396 E: run test localcommand.sh ... 1025s 21:56:24.594997867 O: test localcommand: proto localcommand 1025s 21:56:24.951952470 O: ok localcommand 1025s 21:56:24.952186114 E: run test forcecommand.sh ... 1027s 21:56:26.817780663 E: Connection closed. 1027s 21:56:26.820248943 E: Connection closed 1028s 21:56:27.509084160 E: Connection closed. 1028s 21:56:27.512337613 E: Connection closed 1028s 21:56:27.872482577 O: ok forced command 1028s 21:56:27.873474393 E: run test portnum.sh ... 1029s 21:56:28.251792412 O: port number parsing: invalid port 0 1029s 21:56:28.269660384 O: port number parsing: invalid port 65536 1029s 21:56:28.342871299 O: port number parsing: invalid port 131073 1029s 21:56:28.365956836 O: port number parsing: invalid port 2000blah 1029s 21:56:28.384610221 O: port number parsing: invalid port blah2000 1029s 21:56:28.403354287 O: port number parsing: valid port 1 1029s 21:56:28.790586210 O: port number parsing: valid port 22 1030s 21:56:29.138099604 O: port number parsing: valid port 2222 1030s 21:56:29.484524377 O: port number parsing: valid port 22222 1030s 21:56:29.829022919 O: port number parsing: valid port 65535 1031s 21:56:30.171072100 O: ok port number parsing 1031s 21:56:30.171569588 E: run test keytype.sh ... 1031s 21:56:30.565825939 O: keygen ed25519, 512 bits 1031s 21:56:30.589950412 O: keygen ed25519-sk, n/a bits 1031s 21:56:30.619504134 O: keygen ecdsa, 256 bits 1031s 21:56:30.642332547 O: keygen ecdsa, 384 bits 1031s 21:56:30.667375475 O: keygen ecdsa, 521 bits 1031s 21:56:30.697778691 O: keygen ecdsa-sk, n/a bits 1031s 21:56:30.726265756 O: keygen dsa, 1024 bits 1031s 21:56:30.935150763 O: keygen rsa, 2048 bits 1032s 21:56:31.758706268 O: keygen rsa, 3072 bits 1033s 21:56:32.095144392 O: userkey ed25519-512, hostkey ed25519-512 1033s 21:56:32.362836673 O: userkey ed25519-512, hostkey ed25519-512 1033s 21:56:32.595990752 O: userkey ed25519-512, hostkey ed25519-512 1033s 21:56:32.847827574 O: userkey ed25519-sk, hostkey ed25519-sk 1034s 21:56:33.100063163 O: userkey ed25519-sk, hostkey ed25519-sk 1034s 21:56:33.344801508 O: userkey ed25519-sk, hostkey ed25519-sk 1034s 21:56:33.621123607 O: userkey ecdsa-256, hostkey ecdsa-256 1034s 21:56:33.857558857 O: userkey ecdsa-256, hostkey ecdsa-256 1035s 21:56:34.089891599 O: userkey ecdsa-256, hostkey ecdsa-256 1035s 21:56:34.338529805 O: userkey ecdsa-384, hostkey ecdsa-384 1035s 21:56:34.646712701 O: userkey ecdsa-384, hostkey ecdsa-384 1035s 21:56:34.951049773 O: userkey ecdsa-384, hostkey ecdsa-384 1036s 21:56:35.306593716 O: userkey ecdsa-521, hostkey ecdsa-521 1036s 21:56:35.758705549 O: userkey ecdsa-521, hostkey ecdsa-521 1037s 21:56:36.213363102 O: userkey ecdsa-521, hostkey ecdsa-521 1037s 21:56:36.682598730 O: userkey ecdsa-sk, hostkey ecdsa-sk 1037s 21:56:36.932057544 O: userkey ecdsa-sk, hostkey ecdsa-sk 1038s 21:56:37.177668975 O: userkey ecdsa-sk, hostkey ecdsa-sk 1038s 21:56:37.449990439 O: userkey dsa-1024, hostkey dsa-1024 1038s 21:56:37.672949061 O: userkey dsa-1024, hostkey dsa-1024 1038s 21:56:37.902806796 O: userkey dsa-1024, hostkey dsa-1024 1039s 21:56:38.141075945 O: userkey rsa-2048, hostkey rsa-2048 1039s 21:56:38.405233314 O: userkey rsa-2048, hostkey rsa-2048 1039s 21:56:38.653714549 O: userkey rsa-2048, hostkey rsa-2048 1039s 21:56:38.899200654 O: userkey rsa-3072, hostkey rsa-3072 1040s 21:56:39.150253209 O: userkey rsa-3072, hostkey rsa-3072 1040s 21:56:39.420997083 O: userkey rsa-3072, hostkey rsa-3072 1040s 21:56:39.674596358 O: ok login with different key types 1040s 21:56:39.675585134 E: run test kextype.sh ... 1041s 21:56:40.104550974 O: kex diffie-hellman-group1-sha1 1042s 21:56:41.083589492 O: kex diffie-hellman-group14-sha1 1043s 21:56:42.139671608 O: kex diffie-hellman-group14-sha256 1044s 21:56:43.156126433 O: kex diffie-hellman-group16-sha512 1045s 21:56:44.387531887 O: kex diffie-hellman-group18-sha512 1047s 21:56:46.381859903 O: kex diffie-hellman-group-exchange-sha1 1049s 21:56:48.357385979 O: kex diffie-hellman-group-exchange-sha256 1051s 21:56:50.339343324 O: kex ecdh-sha2-nistp256 1052s 21:56:51.320703788 O: kex ecdh-sha2-nistp384 1053s 21:56:52.378204230 O: kex ecdh-sha2-nistp521 1054s 21:56:53.553675841 O: kex curve25519-sha256 1055s 21:56:54.540535686 O: kex curve25519-sha256@libssh.org 1056s 21:56:55.493188651 O: kex sntrup761x25519-sha512@openssh.com 1057s 21:56:56.857083259 O: ok login with different key exchange algorithms 1057s 21:56:56.858117435 E: run test cert-hostkey.sh ... 1059s 21:56:58.393944426 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/host_ca_key.pub 1059s 21:56:58.396400946 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/host_ca_key2.pub 1059s 21:56:58.398779624 O: certified host keys: sign host ed25519 cert 1059s 21:56:58.411249944 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ed25519.pub 1059s 21:56:58.432343403 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ed25519-cert.pub 1059s 21:56:58.440448293 O: certified host keys: sign host sk-ssh-ed25519@openssh.com cert 1059s 21:56:58.462073200 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_sk-ssh-ed25519@openssh.com.pub 1059s 21:56:58.483456144 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_sk-ssh-ed25519@openssh.com-cert.pub 1059s 21:56:58.490104890 O: certified host keys: sign host ecdsa-sha2-nistp256 cert 1059s 21:56:58.504341799 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp256.pub 1059s 21:56:58.526217150 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp256-cert.pub 1059s 21:56:58.532750815 O: certified host keys: sign host ecdsa-sha2-nistp384 cert 1059s 21:56:58.552477452 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp384.pub 1059s 21:56:58.580591343 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp384-cert.pub 1059s 21:56:58.588305147 O: certified host keys: sign host ecdsa-sha2-nistp521 cert 1059s 21:56:58.620712747 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp521.pub 1059s 21:56:58.659765655 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp521-cert.pub 1059s 21:56:58.667309136 O: certified host keys: sign host sk-ecdsa-sha2-nistp256@openssh.com cert 1059s 21:56:58.689149486 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_sk-ecdsa-sha2-nistp256@openssh.com.pub 1059s 21:56:58.710953436 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_sk-ecdsa-sha2-nistp256@openssh.com-cert.pub 1059s 21:56:58.718513798 O: certified host keys: sign host dsa cert 1060s 21:56:59.417954425 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_dsa.pub 1060s 21:56:59.439076643 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_dsa-cert.pub 1060s 21:56:59.446929370 O: certified host keys: sign host rsa cert 1061s 21:57:00.925482368 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_rsa.pub 1061s 21:57:00.948135292 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_rsa-cert.pub 1061s 21:57:00.955191885 O: certified host keys: sign host rsa-sha2-256 cert 1062s 21:57:01.743392280 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-256.pub 1062s 21:57:01.771054323 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-256-cert.pub 1062s 21:57:01.778790247 O: certified host keys: sign host rsa-sha2-512 cert 1063s 21:57:02.750038170 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-512.pub 1063s 21:57:02.779569443 O: Revoking from /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-512-cert.pub 1063s 21:57:02.788330783 O: certified host keys: host ed25519 cert connect 1063s 21:57:02.794030835 O: certified host keys: ed25519 basic connect expect success yes 1064s 21:57:03.131576121 O: certified host keys: ed25519 empty KRL expect success yes 1064s 21:57:03.444231048 O: certified host keys: ed25519 KRL w/ plain key revoked expect success no 1064s 21:57:03.663238634 O: certified host keys: ed25519 KRL w/ cert revoked expect success no 1064s 21:57:03.913640404 O: certified host keys: ed25519 KRL w/ CA revoked expect success no 1065s 21:57:04.133402122 O: certified host keys: ed25519 empty plaintext revocation expect success yes 1065s 21:57:04.449771105 O: certified host keys: ed25519 plain key plaintext revocation expect success no 1065s 21:57:04.670451356 O: certified host keys: ed25519 cert plaintext revocation expect success no 1065s 21:57:04.896744058 O: certified host keys: ed25519 CA plaintext revocation expect success no 1066s 21:57:05.139043574 O: certified host keys: host sk-ssh-ed25519@openssh.com cert connect 1066s 21:57:05.142774714 O: certified host keys: sk-ssh-ed25519@openssh.com basic connect expect success yes 1066s 21:57:05.470110230 O: certified host keys: sk-ssh-ed25519@openssh.com empty KRL expect success yes 1066s 21:57:05.803314519 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ plain key revoked expect success no 1067s 21:57:06.029774941 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ cert revoked expect success no 1067s 21:57:06.254652416 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ CA revoked expect success no 1067s 21:57:06.482560699 O: certified host keys: sk-ssh-ed25519@openssh.com empty plaintext revocation expect success yes 1067s 21:57:06.796819563 O: certified host keys: sk-ssh-ed25519@openssh.com plain key plaintext revocation expect success no 1068s 21:57:07.019654845 O: certified host keys: sk-ssh-ed25519@openssh.com cert plaintext revocation expect success no 1068s 21:57:07.250756258 O: certified host keys: sk-ssh-ed25519@openssh.com CA plaintext revocation expect success no 1068s 21:57:07.479025505 O: certified host keys: host ecdsa-sha2-nistp256 cert connect 1068s 21:57:07.483827302 O: certified host keys: ecdsa-sha2-nistp256 basic connect expect success yes 1068s 21:57:07.809541906 O: certified host keys: ecdsa-sha2-nistp256 empty KRL expect success yes 1069s 21:57:08.137399503 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ plain key revoked expect success no 1069s 21:57:08.358298710 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ cert revoked expect success no 1069s 21:57:08.578875673 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ CA revoked expect success no 1069s 21:57:08.800729295 O: certified host keys: ecdsa-sha2-nistp256 empty plaintext revocation expect success yes 1070s 21:57:09.120881327 O: certified host keys: ecdsa-sha2-nistp256 plain key plaintext revocation expect success no 1070s 21:57:09.342704307 O: certified host keys: ecdsa-sha2-nistp256 cert plaintext revocation expect success no 1070s 21:57:09.572703778 O: certified host keys: ecdsa-sha2-nistp256 CA plaintext revocation expect success no 1070s 21:57:09.793193497 O: certified host keys: host ecdsa-sha2-nistp384 cert connect 1070s 21:57:09.798524542 O: certified host keys: ecdsa-sha2-nistp384 basic connect expect success yes 1071s 21:57:10.160595199 O: certified host keys: ecdsa-sha2-nistp384 empty KRL expect success yes 1071s 21:57:10.524956891 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ plain key revoked expect success no 1071s 21:57:10.771497504 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ cert revoked expect success no 1072s 21:57:11.020626958 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ CA revoked expect success no 1072s 21:57:11.270267818 O: certified host keys: ecdsa-sha2-nistp384 empty plaintext revocation expect success yes 1072s 21:57:11.650095474 O: certified host keys: ecdsa-sha2-nistp384 plain key plaintext revocation expect success no 1072s 21:57:11.903870919 O: certified host keys: ecdsa-sha2-nistp384 cert plaintext revocation expect success no 1073s 21:57:12.170306286 O: certified host keys: ecdsa-sha2-nistp384 CA plaintext revocation expect success no 1073s 21:57:12.417679467 O: certified host keys: host ecdsa-sha2-nistp521 cert connect 1073s 21:57:12.423264636 O: certified host keys: ecdsa-sha2-nistp521 basic connect expect success yes 1073s 21:57:12.841020213 O: certified host keys: ecdsa-sha2-nistp521 empty KRL expect success yes 1074s 21:57:13.254025392 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ plain key revoked expect success no 1074s 21:57:13.543852927 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ cert revoked expect success no 1074s 21:57:13.835984900 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ CA revoked expect success no 1075s 21:57:14.122223257 O: certified host keys: ecdsa-sha2-nistp521 empty plaintext revocation expect success yes 1075s 21:57:14.533904370 O: certified host keys: ecdsa-sha2-nistp521 plain key plaintext revocation expect success no 1075s 21:57:14.830881337 O: certified host keys: ecdsa-sha2-nistp521 cert plaintext revocation expect success no 1076s 21:57:15.147790380 O: certified host keys: ecdsa-sha2-nistp521 CA plaintext revocation expect success no 1076s 21:57:15.438362843 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com cert connect 1076s 21:57:15.443662527 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com basic connect expect success yes 1076s 21:57:15.774742634 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com empty KRL expect success yes 1077s 21:57:16.104602401 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ plain key revoked expect success no 1077s 21:57:16.331745652 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ cert revoked expect success no 1077s 21:57:16.564426472 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ CA revoked expect success no 1077s 21:57:16.792136732 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com empty plaintext revocation expect success yes 1078s 21:57:17.126862454 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com plain key plaintext revocation expect success no 1078s 21:57:17.369257106 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com cert plaintext revocation expect success no 1078s 21:57:17.631930320 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com CA plaintext revocation expect success no 1078s 21:57:17.859679339 O: certified host keys: host dsa cert connect 1078s 21:57:17.864044848 O: certified host keys: dsa basic connect expect success yes 1079s 21:57:18.171312450 O: certified host keys: dsa empty KRL expect success yes 1079s 21:57:18.476989465 O: certified host keys: dsa KRL w/ plain key revoked expect success no 1079s 21:57:18.695337773 O: certified host keys: dsa KRL w/ cert revoked expect success no 1079s 21:57:18.915947717 O: certified host keys: dsa KRL w/ CA revoked expect success no 1080s 21:57:19.136382817 O: certified host keys: dsa empty plaintext revocation expect success yes 1080s 21:57:19.448368850 O: certified host keys: dsa plain key plaintext revocation expect success no 1080s 21:57:19.690919740 O: certified host keys: dsa cert plaintext revocation expect success no 1080s 21:57:19.950365138 O: certified host keys: dsa CA plaintext revocation expect success no 1081s 21:57:20.165930599 O: certified host keys: host rsa cert connect 1081s 21:57:20.176952894 O: certified host keys: rsa basic connect expect success yes 1081s 21:57:20.508765598 O: certified host keys: rsa empty KRL expect success yes 1081s 21:57:20.843779794 O: certified host keys: rsa KRL w/ plain key revoked expect success no 1082s 21:57:21.075428989 O: certified host keys: rsa KRL w/ cert revoked expect success no 1082s 21:57:21.308414123 O: certified host keys: rsa KRL w/ CA revoked expect success no 1082s 21:57:21.549922953 O: certified host keys: rsa empty plaintext revocation expect success yes 1082s 21:57:21.893409160 O: certified host keys: rsa plain key plaintext revocation expect success no 1083s 21:57:22.154571620 O: certified host keys: rsa cert plaintext revocation expect success no 1083s 21:57:22.431191884 O: certified host keys: rsa CA plaintext revocation expect success no 1083s 21:57:22.660892685 O: certified host keys: host rsa-sha2-256 cert connect 1083s 21:57:22.665792242 O: certified host keys: rsa-sha2-256 basic connect expect success yes 1084s 21:57:22.970188347 O: certified host keys: rsa-sha2-256 empty KRL expect success yes 1084s 21:57:23.272529016 O: certified host keys: rsa-sha2-256 KRL w/ plain key revoked expect success no 1084s 21:57:23.496771808 O: certified host keys: rsa-sha2-256 KRL w/ cert revoked expect success no 1084s 21:57:23.720885438 O: certified host keys: rsa-sha2-256 KRL w/ CA revoked expect success no 1084s 21:57:23.950014548 O: certified host keys: rsa-sha2-256 empty plaintext revocation expect success yes 1085s 21:57:24.247482538 O: certified host keys: rsa-sha2-256 plain key plaintext revocation expect success no 1085s 21:57:24.485030619 O: certified host keys: rsa-sha2-256 cert plaintext revocation expect success no 1085s 21:57:24.753963757 O: certified host keys: rsa-sha2-256 CA plaintext revocation expect success no 1086s 21:57:24.976530480 O: certified host keys: host rsa-sha2-512 cert connect 1086s 21:57:24.981368757 O: certified host keys: rsa-sha2-512 basic connect expect success yes 1086s 21:57:25.283969666 O: certified host keys: rsa-sha2-512 empty KRL expect success yes 1086s 21:57:25.589600262 O: certified host keys: rsa-sha2-512 KRL w/ plain key revoked expect success no 1086s 21:57:25.818251640 O: certified host keys: rsa-sha2-512 KRL w/ cert revoked expect success no 1087s 21:57:26.049536379 O: certified host keys: rsa-sha2-512 KRL w/ CA revoked expect success no 1087s 21:57:26.284760140 O: certified host keys: rsa-sha2-512 empty plaintext revocation expect success yes 1087s 21:57:26.597466365 O: certified host keys: rsa-sha2-512 plain key plaintext revocation expect success no 1087s 21:57:26.841298381 O: certified host keys: rsa-sha2-512 cert plaintext revocation expect success no 1088s 21:57:27.108590048 O: certified host keys: rsa-sha2-512 CA plaintext revocation expect success no 1088s 21:57:27.364237969 O: certified host keys: host ed25519 revoked cert 1088s 21:57:27.615484580 O: certified host keys: host sk-ssh-ed25519@openssh.com revoked cert 1088s 21:57:27.874438234 O: certified host keys: host ecdsa-sha2-nistp256 revoked cert 1089s 21:57:28.126694540 O: certified host keys: host ecdsa-sha2-nistp384 revoked cert 1089s 21:57:28.402196133 O: certified host keys: host ecdsa-sha2-nistp521 revoked cert 1089s 21:57:28.718358208 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com revoked cert 1090s 21:57:28.976370604 O: certified host keys: host dsa revoked cert 1090s 21:57:29.222376009 O: certified host keys: host rsa revoked cert 1090s 21:57:29.480395563 O: certified host keys: host rsa-sha2-256 revoked cert 1090s 21:57:29.736996215 O: certified host keys: host rsa-sha2-512 revoked cert 1091s 21:57:29.999939767 O: certified host keys: host ed25519 revoked cert 1091s 21:57:30.220792772 O: certified host keys: host sk-ssh-ed25519@openssh.com revoked cert 1091s 21:57:30.446646817 O: certified host keys: host ecdsa-sha2-nistp256 revoked cert 1091s 21:57:30.666985254 O: certified host keys: host ecdsa-sha2-nistp384 revoked cert 1091s 21:57:30.912835214 O: certified host keys: host ecdsa-sha2-nistp521 revoked cert 1092s 21:57:31.205652154 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com revoked cert 1092s 21:57:31.438685430 O: certified host keys: host dsa revoked cert 1092s 21:57:31.659512673 O: certified host keys: host rsa revoked cert 1092s 21:57:31.892429107 O: certified host keys: host rsa-sha2-256 revoked cert 1093s 21:57:32.118704595 O: certified host keys: host rsa-sha2-512 revoked cert 1112s 21:57:51.300182160 O: certified host keys: host ed25519 cert downgrade to raw key 1112s 21:57:51.947761229 O: certified host keys: host sk-ssh-ed25519@openssh.com cert downgrade to raw key 1113s 21:57:52.615818454 O: certified host keys: host ecdsa-sha2-nistp256 cert downgrade to raw key 1114s 21:57:53.268853321 O: certified host keys: host ecdsa-sha2-nistp384 cert downgrade to raw key 1115s 21:57:53.989296117 O: certified host keys: host ecdsa-sha2-nistp521 cert downgrade to raw key 1115s 21:57:54.895742326 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com cert downgrade to raw key 1116s 21:57:55.574811027 O: certified host keys: host dsa cert downgrade to raw key 1117s 21:57:56.435863438 O: certified host keys: host rsa cert downgrade to raw key 1118s 21:57:57.287983705 O: certified host keys: host rsa-sha2-256 cert downgrade to raw key 1119s 21:57:58.050648454 O: certified host keys: host rsa-sha2-512 cert downgrade to raw key 1120s 21:57:59.673904380 O: certified host keys: host ed25519 connect wrong cert 1120s 21:57:59.921415709 O: certified host keys: host sk-ssh-ed25519@openssh.com connect wrong cert 1121s 21:58:00.174311999 O: certified host keys: host ecdsa-sha2-nistp256 connect wrong cert 1121s 21:58:00.404939544 O: certified host keys: host ecdsa-sha2-nistp384 connect wrong cert 1121s 21:58:00.691093870 O: certified host keys: host ecdsa-sha2-nistp521 connect wrong cert 1122s 21:58:01.074796753 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com connect wrong cert 1122s 21:58:01.329612111 O: certified host keys: host dsa connect wrong cert 1122s 21:58:01.732467048 O: certified host keys: host rsa connect wrong cert 1123s 21:58:02.076072304 O: certified host keys: host rsa-sha2-256 connect wrong cert 1124s 21:58:02.997015322 O: certified host keys: host rsa-sha2-512 connect wrong cert 1124s 21:58:03.708220077 O: ok certified host keys 1124s 21:58:03.708276158 E: run test cert-userkey.sh ... 1125s 21:58:04.301606163 O: certified user keys: sign user ed25519 cert 1125s 21:58:04.330076684 O: certified user keys: sign user sk-ssh-ed25519@openssh.com cert 1125s 21:58:04.362605629 O: certified user keys: sign user ecdsa-sha2-nistp256 cert 1125s 21:58:04.389534246 O: certified user keys: sign user ecdsa-sha2-nistp384 cert 1125s 21:58:04.423860019 O: certified user keys: sign user ecdsa-sha2-nistp521 cert 1125s 21:58:04.469270923 O: certified user keys: sign user sk-ecdsa-sha2-nistp256@openssh.com cert 1125s 21:58:04.507778200 O: certified user keys: sign user dsa cert 1125s 21:58:04.687297584 O: certified user keys: sign user rsa cert 1129s 21:58:08.614650589 O: certified user keys: sign user rsa-sha2-256 cert 1131s 21:58:10.658475045 O: certified user keys: sign user rsa-sha2-512 cert 1135s 21:58:14.087042852 O: certified user keys: ed25519 missing authorized_principals 1135s 21:58:14.403150370 O: certified user keys: ed25519 empty authorized_principals 1135s 21:58:14.721428842 O: certified user keys: ed25519 wrong authorized_principals 1136s 21:58:15.035766733 O: certified user keys: ed25519 correct authorized_principals 1136s 21:58:15.385084561 O: certified user keys: ed25519 authorized_principals bad key opt 1136s 21:58:15.697865425 O: certified user keys: ed25519 authorized_principals command=false 1137s 21:58:16.042582782 O: certified user keys: ed25519 authorized_principals command=true 1137s 21:58:16.394737811 O: certified user keys: ed25519 wrong principals key option 1137s 21:58:16.726980853 O: certified user keys: ed25519 correct principals key option 1138s 21:58:17.087466530 O: certified user keys: sk-ssh-ed25519@openssh.com missing authorized_principals 1138s 21:58:17.408038870 O: certified user keys: sk-ssh-ed25519@openssh.com empty authorized_principals 1138s 21:58:17.724738750 O: certified user keys: sk-ssh-ed25519@openssh.com wrong authorized_principals 1139s 21:58:18.045767457 O: certified user keys: sk-ssh-ed25519@openssh.com correct authorized_principals 1139s 21:58:18.399987713 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals bad key opt 1139s 21:58:18.713856787 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals command=false 1140s 21:58:19.059618352 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals command=true 1140s 21:58:19.429628368 O: certified user keys: sk-ssh-ed25519@openssh.com wrong principals key option 1140s 21:58:19.759466165 O: certified user keys: sk-ssh-ed25519@openssh.com correct principals key option 1141s 21:58:20.122702356 O: certified user keys: ecdsa-sha2-nistp256 missing authorized_principals 1141s 21:58:20.430044325 O: certified user keys: ecdsa-sha2-nistp256 empty authorized_principals 1141s 21:58:20.735918512 O: certified user keys: ecdsa-sha2-nistp256 wrong authorized_principals 1142s 21:58:21.044125414 O: certified user keys: ecdsa-sha2-nistp256 correct authorized_principals 1142s 21:58:21.391008068 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals bad key opt 1142s 21:58:21.708423390 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals command=false 1143s 21:58:22.050647053 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals command=true 1143s 21:58:22.402034894 O: certified user keys: ecdsa-sha2-nistp256 wrong principals key option 1143s 21:58:22.732474894 O: certified user keys: ecdsa-sha2-nistp256 correct principals key option 1144s 21:58:23.094086931 O: certified user keys: ecdsa-sha2-nistp384 missing authorized_principals 1144s 21:58:23.428979317 O: certified user keys: ecdsa-sha2-nistp384 empty authorized_principals 1144s 21:58:23.764684835 O: certified user keys: ecdsa-sha2-nistp384 wrong authorized_principals 1145s 21:58:24.103329917 O: certified user keys: ecdsa-sha2-nistp384 correct authorized_principals 1145s 21:58:24.487675459 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals bad key opt 1145s 21:58:24.822052274 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals command=false 1146s 21:58:25.203071204 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals command=true 1146s 21:58:25.595079861 O: certified user keys: ecdsa-sha2-nistp384 wrong principals key option 1146s 21:58:25.927593965 O: certified user keys: ecdsa-sha2-nistp384 correct principals key option 1147s 21:58:26.332418656 O: certified user keys: ecdsa-sha2-nistp521 missing authorized_principals 1147s 21:58:26.753906603 O: certified user keys: ecdsa-sha2-nistp521 empty authorized_principals 1148s 21:58:27.173967406 O: certified user keys: ecdsa-sha2-nistp521 wrong authorized_principals 1148s 21:58:27.594868740 O: certified user keys: ecdsa-sha2-nistp521 correct authorized_principals 1149s 21:58:28.060951367 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals bad key opt 1149s 21:58:28.475244917 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals command=false 1149s 21:58:28.930503374 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals command=true 1150s 21:58:29.426081727 O: certified user keys: ecdsa-sha2-nistp521 wrong principals key option 1150s 21:58:29.806129549 O: certified user keys: ecdsa-sha2-nistp521 correct principals key option 1151s 21:58:30.276554754 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com missing authorized_principals 1151s 21:58:30.598758967 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com empty authorized_principals 1151s 21:58:30.921850595 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com wrong authorized_principals 1152s 21:58:31.243500998 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com correct authorized_principals 1152s 21:58:31.590202304 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals bad key opt 1152s 21:58:31.914106142 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals command=false 1153s 21:58:32.266903259 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals command=true 1153s 21:58:32.634692965 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com wrong principals key option 1153s 21:58:32.959667297 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com correct principals key option 1154s 21:58:33.330475727 O: certified user keys: dsa missing authorized_principals 1154s 21:58:33.666938231 O: certified user keys: dsa empty authorized_principals 1155s 21:58:33.996572871 O: certified user keys: dsa wrong authorized_principals 1155s 21:58:34.323925794 O: certified user keys: dsa correct authorized_principals 1155s 21:58:34.674695155 O: certified user keys: dsa authorized_principals bad key opt 1156s 21:58:35.002504845 O: certified user keys: dsa authorized_principals command=false 1156s 21:58:35.347891081 O: certified user keys: dsa authorized_principals command=true 1156s 21:58:35.701507523 O: certified user keys: dsa wrong principals key option 1157s 21:58:36.020068029 O: certified user keys: dsa correct principals key option 1157s 21:58:36.370704862 O: certified user keys: rsa missing authorized_principals 1157s 21:58:36.679227093 O: certified user keys: rsa empty authorized_principals 1158s 21:58:36.986220860 O: certified user keys: rsa wrong authorized_principals 1158s 21:58:37.294953612 O: certified user keys: rsa correct authorized_principals 1158s 21:58:37.632350841 O: certified user keys: rsa authorized_principals bad key opt 1158s 21:58:37.935656269 O: certified user keys: rsa authorized_principals command=false 1159s 21:58:38.275980301 O: certified user keys: rsa authorized_principals command=true 1159s 21:58:38.625582634 O: certified user keys: rsa wrong principals key option 1159s 21:58:38.934452225 O: certified user keys: rsa correct principals key option 1160s 21:58:39.297925647 O: certified user keys: rsa-sha2-256 missing authorized_principals 1160s 21:58:39.608400901 O: certified user keys: rsa-sha2-256 empty authorized_principals 1160s 21:58:39.916133713 O: certified user keys: rsa-sha2-256 wrong authorized_principals 1161s 21:58:40.223938444 O: certified user keys: rsa-sha2-256 correct authorized_principals 1161s 21:58:40.565506089 O: certified user keys: rsa-sha2-256 authorized_principals bad key opt 1161s 21:58:40.873813107 O: certified user keys: rsa-sha2-256 authorized_principals command=false 1162s 21:58:41.215450992 O: certified user keys: rsa-sha2-256 authorized_principals command=true 1162s 21:58:41.565083398 O: certified user keys: rsa-sha2-256 wrong principals key option 1162s 21:58:41.877388595 O: certified user keys: rsa-sha2-256 correct principals key option 1163s 21:58:42.229710159 O: certified user keys: rsa-sha2-512 missing authorized_principals 1163s 21:58:42.539570757 O: certified user keys: rsa-sha2-512 empty authorized_principals 1163s 21:58:42.851115180 O: certified user keys: rsa-sha2-512 wrong authorized_principals 1164s 21:58:43.159954641 O: certified user keys: rsa-sha2-512 correct authorized_principals 1164s 21:58:43.503244585 O: certified user keys: rsa-sha2-512 authorized_principals bad key opt 1164s 21:58:43.811857041 O: certified user keys: rsa-sha2-512 authorized_principals command=false 1165s 21:58:44.159995058 O: certified user keys: rsa-sha2-512 authorized_principals command=true 1165s 21:58:44.514237846 O: certified user keys: rsa-sha2-512 wrong principals key option 1165s 21:58:44.828203422 O: certified user keys: rsa-sha2-512 correct principals key option 1166s 21:58:45.187636967 O: certified user keys: ed25519 authorized_keys connect 1166s 21:58:45.539059430 O: certified user keys: ed25519 authorized_keys revoked key 1166s 21:58:45.855599962 O: certified user keys: ed25519 authorized_keys revoked via KRL 1167s 21:58:46.170754112 O: certified user keys: ed25519 authorized_keys empty KRL 1167s 21:58:46.522008330 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys connect 1167s 21:58:46.888399418 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys revoked key 1168s 21:58:47.224702567 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys revoked via KRL 1168s 21:58:47.563018945 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys empty KRL 1168s 21:58:47.927545762 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys connect 1169s 21:58:48.290131547 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys revoked key 1169s 21:58:48.627352347 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys revoked via KRL 1170s 21:58:48.969285218 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys empty KRL 1170s 21:58:49.339359514 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys connect 1170s 21:58:49.734048423 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys revoked key 1171s 21:58:50.103361506 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys revoked via KRL 1171s 21:58:50.450850817 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys empty KRL 1171s 21:58:50.859094289 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys connect 1172s 21:58:51.343661076 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys revoked key 1172s 21:58:51.784781844 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys revoked via KRL 1173s 21:58:52.154253204 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys empty KRL 1173s 21:58:52.630996948 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys connect 1174s 21:58:52.980988572 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys revoked key 1174s 21:58:53.295465055 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys revoked via KRL 1174s 21:58:53.618662990 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys empty KRL 1175s 21:58:53.975417954 O: certified user keys: dsa authorized_keys connect 1175s 21:58:54.319854648 O: certified user keys: dsa authorized_keys revoked key 1175s 21:58:54.646455793 O: certified user keys: dsa authorized_keys revoked via KRL 1176s 21:58:54.974006871 O: certified user keys: dsa authorized_keys empty KRL 1176s 21:58:55.329988738 O: certified user keys: rsa authorized_keys connect 1176s 21:58:55.678690215 O: certified user keys: rsa authorized_keys revoked key 1177s 21:58:55.996932831 O: certified user keys: rsa authorized_keys revoked via KRL 1177s 21:58:56.314940481 O: certified user keys: rsa authorized_keys empty KRL 1177s 21:58:56.665050096 O: certified user keys: rsa-sha2-256 authorized_keys connect 1178s 21:58:57.019892983 O: certified user keys: rsa-sha2-256 authorized_keys revoked key 1178s 21:58:57.334443978 O: certified user keys: rsa-sha2-256 authorized_keys revoked via KRL 1178s 21:58:57.666730722 O: certified user keys: rsa-sha2-256 authorized_keys empty KRL 1179s 21:58:58.022783985 O: certified user keys: rsa-sha2-512 authorized_keys connect 1179s 21:58:58.378501040 O: certified user keys: rsa-sha2-512 authorized_keys revoked key 1179s 21:58:58.700021138 O: certified user keys: rsa-sha2-512 authorized_keys revoked via KRL 1180s 21:58:59.030363610 O: certified user keys: rsa-sha2-512 authorized_keys empty KRL 1180s 21:58:59.388661742 O: certified user keys: rsa-sha2-512 authorized_keys revoked CA key 1180s 21:58:59.700048285 O: certified user keys: authorized_keys CA does not authenticate 1180s 21:58:59.704617954 O: certified user keys: ensure CA key does not authenticate user 1181s 21:59:00.010639536 O: certified user keys: ed25519 TrustedUserCAKeys connect 1181s 21:59:00.358597389 O: certified user keys: ed25519 TrustedUserCAKeys revoked key 1181s 21:59:00.671572474 O: certified user keys: ed25519 TrustedUserCAKeys revoked via KRL 1182s 21:59:00.987925370 O: certified user keys: ed25519 TrustedUserCAKeys empty KRL 1182s 21:59:01.340368369 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys connect 1182s 21:59:01.695233404 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys revoked key 1183s 21:59:02.005448725 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys revoked via KRL 1183s 21:59:02.317612553 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys empty KRL 1183s 21:59:02.673820006 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys connect 1184s 21:59:03.019688343 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys revoked key 1184s 21:59:03.348597182 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys revoked via KRL 1184s 21:59:03.681613842 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys empty KRL 1185s 21:59:04.034709165 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys connect 1185s 21:59:04.422551130 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys revoked key 1185s 21:59:04.768824588 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys revoked via KRL 1186s 21:59:05.121643944 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys empty KRL 1186s 21:59:05.524526212 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys connect 1187s 21:59:05.980689723 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys revoked key 1187s 21:59:06.395916495 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys revoked via KRL 1187s 21:59:06.802433575 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys empty KRL 1188s 21:59:07.279718919 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys connect 1188s 21:59:07.639763657 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys revoked key 1188s 21:59:07.951338586 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys revoked via KRL 1189s 21:59:08.267219898 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys empty KRL 1189s 21:59:08.617111561 O: certified user keys: dsa TrustedUserCAKeys connect 1190s 21:59:08.970023029 O: certified user keys: dsa TrustedUserCAKeys revoked key 1190s 21:59:09.289671596 O: certified user keys: dsa TrustedUserCAKeys revoked via KRL 1190s 21:59:09.612383848 O: certified user keys: dsa TrustedUserCAKeys empty KRL 1190s 21:59:09.964213217 O: certified user keys: rsa TrustedUserCAKeys connect 1191s 21:59:10.310848587 O: certified user keys: rsa TrustedUserCAKeys revoked key 1191s 21:59:10.627818270 O: certified user keys: rsa TrustedUserCAKeys revoked via KRL 1191s 21:59:10.947937841 O: certified user keys: rsa TrustedUserCAKeys empty KRL 1192s 21:59:11.305146847 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys connect 1192s 21:59:11.664733329 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys revoked key 1193s 21:59:11.986826287 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys revoked via KRL 1193s 21:59:12.311196677 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys empty KRL 1193s 21:59:12.669627739 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys connect 1194s 21:59:13.022406596 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked key 1194s 21:59:13.336670792 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked via KRL 1194s 21:59:13.653661749 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys empty KRL 1195s 21:59:14.007628862 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked CA key 1195s 21:59:14.325646552 O: certified user keys: TrustedUserCAKeys CA does not authenticate 1195s 21:59:14.330352143 O: certified user keys: ensure CA key does not authenticate user 1195s 21:59:14.631940947 O: certified user keys: correct principal auth authorized_keys expect success rsa 1196s 21:59:15.006975573 O: certified user keys: correct principal auth authorized_keys expect success ed25519 1196s 21:59:15.378561264 O: certified user keys: correct principal auth TrustedUserCAKeys expect success rsa 1196s 21:59:15.752291108 O: certified user keys: correct principal auth TrustedUserCAKeys expect success ed25519 1197s 21:59:16.124829693 O: certified user keys: host-certificate auth authorized_keys expect failure rsa 1197s 21:59:16.453464779 O: certified user keys: host-certificate auth authorized_keys expect failure ed25519 1197s 21:59:16.775704008 O: certified user keys: host-certificate auth TrustedUserCAKeys expect failure rsa 1198s 21:59:17.099337218 O: certified user keys: host-certificate auth TrustedUserCAKeys expect failure ed25519 1198s 21:59:17.424533410 O: certified user keys: wrong principals auth authorized_keys expect failure rsa 1198s 21:59:17.768476802 O: certified user keys: wrong principals auth authorized_keys expect failure ed25519 1199s 21:59:18.112275712 O: certified user keys: wrong principals auth TrustedUserCAKeys expect failure rsa 1199s 21:59:18.445834547 O: certified user keys: wrong principals auth TrustedUserCAKeys expect failure ed25519 1199s 21:59:18.784008930 O: certified user keys: cert not yet valid auth authorized_keys expect failure rsa 1200s 21:59:19.119379791 O: certified user keys: cert not yet valid auth authorized_keys expect failure ed25519 1200s 21:59:19.461126746 O: certified user keys: cert not yet valid auth TrustedUserCAKeys expect failure rsa 1200s 21:59:19.796108120 O: certified user keys: cert not yet valid auth TrustedUserCAKeys expect failure ed25519 1201s 21:59:20.131359457 O: certified user keys: cert expired auth authorized_keys expect failure rsa 1201s 21:59:20.469096670 O: certified user keys: cert expired auth authorized_keys expect failure ed25519 1201s 21:59:20.805063216 O: certified user keys: cert expired auth TrustedUserCAKeys expect failure rsa 1202s 21:59:21.135537919 O: certified user keys: cert expired auth TrustedUserCAKeys expect failure ed25519 1202s 21:59:21.466979196 O: certified user keys: cert valid interval auth authorized_keys expect success rsa 1203s 21:59:21.855410404 O: certified user keys: cert valid interval auth authorized_keys expect success ed25519 1203s 21:59:22.220908068 O: certified user keys: cert valid interval auth TrustedUserCAKeys expect success rsa 1203s 21:59:22.590367111 O: certified user keys: cert valid interval auth TrustedUserCAKeys expect success ed25519 1204s 21:59:22.976380360 O: certified user keys: wrong source-address auth authorized_keys expect failure rsa 1204s 21:59:23.314552853 O: certified user keys: wrong source-address auth authorized_keys expect failure ed25519 1204s 21:59:23.647594189 O: certified user keys: wrong source-address auth TrustedUserCAKeys expect failure rsa 1205s 21:59:23.978232529 O: certified user keys: wrong source-address auth TrustedUserCAKeys expect failure ed25519 1205s 21:59:24.308590783 O: certified user keys: force-command auth authorized_keys expect failure rsa 1205s 21:59:24.679920328 O: certified user keys: force-command auth authorized_keys expect failure ed25519 1206s 21:59:25.048243868 O: certified user keys: force-command auth TrustedUserCAKeys expect failure rsa 1206s 21:59:25.420329262 O: certified user keys: force-command auth TrustedUserCAKeys expect failure ed25519 1206s 21:59:25.784238535 O: certified user keys: empty principals auth authorized_keys expect success rsa 1207s 21:59:26.151844541 O: certified user keys: empty principals auth authorized_keys expect success ed25519 1207s 21:59:26.513644059 O: certified user keys: empty principals auth TrustedUserCAKeys expect failure rsa 1207s 21:59:26.842975773 O: certified user keys: empty principals auth TrustedUserCAKeys expect failure ed25519 1208s 21:59:27.173458703 O: certified user keys: AuthorizedPrincipalsFile principals auth TrustedUserCAKeys expect success rsa 1208s 21:59:27.547112396 O: certified user keys: AuthorizedPrincipalsFile principals auth TrustedUserCAKeys expect success ed25519 1208s 21:59:27.914993802 O: certified user keys: AuthorizedPrincipalsFile no principals auth TrustedUserCAKeys expect failure rsa 1209s 21:59:28.249097663 O: certified user keys: AuthorizedPrincipalsFile no principals auth TrustedUserCAKeys expect failure ed25519 1209s 21:59:28.595825152 O: certified user keys: principals key option principals auth authorized_keys expect success rsa 1210s 21:59:28.965733227 O: certified user keys: principals key option principals auth authorized_keys expect success ed25519 1210s 21:59:29.336384950 O: certified user keys: principals key option no principals auth authorized_keys expect failure rsa 1210s 21:59:29.679056416 O: certified user keys: principals key option no principals auth authorized_keys expect failure ed25519 1211s 21:59:30.016491284 O: certified user keys: force-command match true auth authorized_keys expect success rsa 1211s 21:59:30.384223641 O: certified user keys: force-command match true auth authorized_keys expect success ed25519 1211s 21:59:30.746791841 O: certified user keys: force-command match true auth authorized_keys expect failure rsa 1212s 21:59:31.117338359 O: certified user keys: force-command match true auth authorized_keys expect failure ed25519 1212s 21:59:31.482702439 O: certified user keys: force-command mismatch 1 auth authorized_keys expect failure rsa 1212s 21:59:31.817892109 O: certified user keys: force-command mismatch 1 auth authorized_keys expect failure ed25519 1213s 21:59:32.151216591 O: certified user keys: force-command mismatch 2 auth authorized_keys expect failure rsa 1213s 21:59:32.486526340 O: certified user keys: force-command mismatch 2 auth authorized_keys expect failure ed25519 1213s 21:59:32.829771728 O: certified user keys: user ed25519 connect wrong cert 1214s 21:59:33.166373376 O: certified user keys: user sk-ssh-ed25519@openssh.com connect wrong cert 1214s 21:59:33.479098028 O: certified user keys: user ecdsa-sha2-nistp256 connect wrong cert 1214s 21:59:33.800740612 O: certified user keys: user ecdsa-sha2-nistp384 connect wrong cert 1215s 21:59:34.144331882 O: certified user keys: user ecdsa-sha2-nistp521 connect wrong cert 1215s 21:59:34.459478288 O: certified user keys: user sk-ecdsa-sha2-nistp256@openssh.com connect wrong cert 1215s 21:59:34.768414881 O: certified user keys: user dsa connect wrong cert 1216s 21:59:35.088477079 O: certified user keys: user rsa connect wrong cert 1216s 21:59:35.421597190 O: certified user keys: user rsa-sha2-256 connect wrong cert 1216s 21:59:35.755762636 O: certified user keys: user rsa-sha2-512 connect wrong cert 1217s 21:59:36.074757936 O: ok certified user keys 1217s 21:59:36.076301159 E: run test host-expand.sh ... 1219s 21:59:36.765151352 O: ok expand %h and %n 1219s 21:59:36.765457957 E: run test keys-command.sh ... 1219s 21:59:37.150282552 O: AuthorizedKeysCommand with arguments 1219s 21:59:37.527740077 O: AuthorizedKeysCommand without arguments 1219s 21:59:37.911463935 O: ok authorized keys from command 1219s 21:59:37.926597320 E: run test forward-control.sh ... 1221s 21:59:40.219021055 O: check_lfwd done (expecting Y): default configuration 1223s 21:59:42.013571901 O: check_rfwd done (expecting Y): default configuration 1224s 21:59:43.770392606 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes 1226s 21:59:45.544332905 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes 1227s 21:59:46.931364903 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, !PermitOpen 1229s 21:59:48.704808598 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, !PermitOpen 1231s 21:59:50.480947074 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, PermitOpen 1233s 21:59:52.262997578 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, PermitOpen 1234s 21:59:53.645731373 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, !permitopen 1236s 21:59:55.441497523 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, !permitopen 1238s 21:59:57.194698986 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, permitopen 1240s 21:59:58.972960079 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, permitopen 1241s 22:00:00.356522388 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, no-port-forwarding 1241s 22:00:00.715641389 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, no-port-forwarding 1243s 22:00:02.098852039 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, restrict 1243s 22:00:02.460147186 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, restrict 1245s 22:00:04.228978603 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, restrict,port-forwarding 1247s 22:00:06.003731087 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, restrict,port-forwarding 1248s 22:00:07.770782318 O: check_lfwd done (expecting Y): AllowTcpForwarding=local 1249s 22:00:08.129552097 O: check_rfwd done (expecting N): AllowTcpForwarding=local 1250s 22:00:09.499566250 O: check_lfwd done (expecting N): AllowTcpForwarding=local, !PermitOpen 1250s 22:00:09.852435138 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !PermitOpen 1252s 22:00:11.591309236 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, PermitOpen 1253s 22:00:11.975023812 O: check_rfwd done (expecting N): AllowTcpForwarding=local, PermitOpen 1254s 22:00:13.361012846 O: check_lfwd done (expecting N): AllowTcpForwarding=local, !permitopen 1254s 22:00:13.718386752 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !permitopen 1256s 22:00:15.475574077 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, permitopen 1256s 22:00:15.833693550 O: check_rfwd done (expecting N): AllowTcpForwarding=local, permitopen 1258s 22:00:17.224099138 O: check_lfwd done (expecting N): AllowTcpForwarding=local, no-port-forwarding 1258s 22:00:17.593130925 O: check_rfwd done (expecting N): AllowTcpForwarding=local, no-port-forwarding 1260s 22:00:18.972062051 O: check_lfwd done (expecting N): AllowTcpForwarding=local, restrict 1260s 22:00:19.339438130 O: check_rfwd done (expecting N): AllowTcpForwarding=local, restrict 1262s 22:00:21.112596869 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, restrict,port-forwarding 1262s 22:00:21.468446576 O: check_rfwd done (expecting N): AllowTcpForwarding=local, restrict,port-forwarding 1262s 22:00:21.844948344 O: check_lfwd done (expecting N): AllowTcpForwarding=remote 1264s 22:00:23.612099288 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote 1266s 22:00:24.985637926 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !PermitOpen 1267s 22:00:26.751956465 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, !PermitOpen 1269s 22:00:28.125411876 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, PermitOpen 1270s 22:00:29.913042373 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, PermitOpen 1272s 22:00:31.288705311 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !permitopen 1274s 22:00:33.067025839 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, !permitopen 1275s 22:00:34.460469049 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, permitopen 1277s 22:00:36.250362513 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, permitopen 1278s 22:00:37.639921521 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, no-port-forwarding 1279s 22:00:38.009987201 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, no-port-forwarding 1280s 22:00:39.394397200 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, restrict 1280s 22:00:39.750981240 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, restrict 1282s 22:00:41.133479678 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, restrict,port-forwarding 1283s 22:00:42.927343331 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, restrict,port-forwarding 1285s 22:00:44.326522384 O: check_lfwd done (expecting N): AllowTcpForwarding=no 1285s 22:00:44.681969517 O: check_rfwd done (expecting N): AllowTcpForwarding=no 1287s 22:00:46.065742016 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !PermitOpen 1287s 22:00:46.422012637 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !PermitOpen 1288s 22:00:47.801663942 O: check_lfwd done (expecting N): AllowTcpForwarding=no, PermitOpen 1289s 22:00:48.160149792 O: check_rfwd done (expecting N): AllowTcpForwarding=no, PermitOpen 1290s 22:00:49.541594790 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !permitopen 1290s 22:00:49.906997896 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !permitopen 1292s 22:00:51.291901250 O: check_lfwd done (expecting N): AllowTcpForwarding=no, permitopen 1292s 22:00:51.657440354 O: check_rfwd done (expecting N): AllowTcpForwarding=no, permitopen 1294s 22:00:53.086741053 O: check_lfwd done (expecting N): AllowTcpForwarding=no, no-port-forwarding 1294s 22:00:53.463065549 O: check_rfwd done (expecting N): AllowTcpForwarding=no, no-port-forwarding 1295s 22:00:54.873429442 O: check_lfwd done (expecting N): AllowTcpForwarding=no, restrict 1296s 22:00:55.248138631 O: check_rfwd done (expecting N): AllowTcpForwarding=no, restrict 1297s 22:00:56.644410146 O: check_lfwd done (expecting N): AllowTcpForwarding=no, restrict,port-forwarding 1298s 22:00:57.013823136 O: check_rfwd done (expecting N): AllowTcpForwarding=no, restrict,port-forwarding 1299s 22:00:58.771456027 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, !PermitListen 1300s 22:00:59.131897084 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, !PermitListen 1301s 22:01:00.883289825 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, PermitListen 1303s 22:01:02.684436863 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, PermitListen 1305s 22:01:04.454313556 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, !PermitListen 1305s 22:01:04.816336064 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !PermitListen 1307s 22:01:06.563485490 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, PermitListen 1307s 22:01:06.934144038 O: check_rfwd done (expecting N): AllowTcpForwarding=local, PermitListen 1309s 22:01:08.313545222 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !PermitListen 1309s 22:01:08.666024425 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, !PermitListen 1311s 22:01:10.050309787 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, PermitListen 1312s 22:01:11.827115187 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, PermitListen 1314s 22:01:13.225126440 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !PermitListen 1314s 22:01:13.585033540 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !PermitListen 1315s 22:01:14.960389338 O: check_lfwd done (expecting N): AllowTcpForwarding=no, PermitListen 1316s 22:01:15.327691380 O: check_rfwd done (expecting N): AllowTcpForwarding=no, PermitListen 1316s 22:01:15.361102777 E: run test integrity.sh ... 1316s 22:01:15.361088577 O: ok sshd control of local and remote forwarding 1316s 22:01:15.843230297 O: test integrity: hmac-sha1 @2900 1317s 22:01:16.210114452 O: test integrity: hmac-sha1 @2901 1317s 22:01:16.580872261 O: test integrity: hmac-sha1 @2902 1317s 22:01:16.939577338 O: test integrity: hmac-sha1 @2903 1318s 22:01:17.314098559 O: test integrity: hmac-sha1 @2904 1318s 22:01:17.683872073 O: test integrity: hmac-sha1 @2905 1319s 22:01:18.056694269 O: test integrity: hmac-sha1 @2906 1319s 22:01:18.433197556 O: test integrity: hmac-sha1 @2907 1319s 22:01:18.812645685 O: test integrity: hmac-sha1 @2908 1320s 22:01:19.196697439 O: test integrity: hmac-sha1 @2909 1320s 22:01:19.553298240 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1320s 22:01:19.586099948 O: test integrity: hmac-sha1-96 @2900 1320s 22:01:19.959860794 O: test integrity: hmac-sha1-96 @2901 1321s 22:01:20.319583318 O: test integrity: hmac-sha1-96 @2902 1321s 22:01:20.716587693 O: test integrity: hmac-sha1-96 @2903 1322s 22:01:21.099394505 O: test integrity: hmac-sha1-96 @2904 1322s 22:01:21.462544236 O: test integrity: hmac-sha1-96 @2905 1322s 22:01:21.821248424 O: test integrity: hmac-sha1-96 @2906 1323s 22:01:22.179407163 O: test integrity: hmac-sha1-96 @2907 1323s 22:01:22.535479551 O: test integrity: hmac-sha1-96 @2908 1323s 22:01:22.897649986 O: test integrity: hmac-sha1-96 @2909 1324s 22:01:23.254055058 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1324s 22:01:23.285645908 O: test integrity: hmac-sha2-256 @2900 1324s 22:01:23.657704282 O: test integrity: hmac-sha2-256 @2901 1325s 22:01:24.021860863 O: test integrity: hmac-sha2-256 @2902 1325s 22:01:24.385614637 O: test integrity: hmac-sha2-256 @2903 1325s 22:01:24.754824408 O: test integrity: hmac-sha2-256 @2904 1326s 22:01:25.120864614 O: test integrity: hmac-sha2-256 @2905 1326s 22:01:25.490361227 O: test integrity: hmac-sha2-256 @2906 1326s 22:01:25.864616589 O: test integrity: hmac-sha2-256 @2907 1327s 22:01:26.222006309 O: test integrity: hmac-sha2-256 @2908 1327s 22:01:26.601285979 O: test integrity: hmac-sha2-256 @2909 1327s 22:01:26.945996959 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1328s 22:01:26.975206854 O: test integrity: hmac-sha2-512 @2900 1328s 22:01:27.306334359 O: test integrity: hmac-sha2-512 @2901 1328s 22:01:27.637940310 O: test integrity: hmac-sha2-512 @2902 1329s 22:01:27.971085963 O: test integrity: hmac-sha2-512 @2903 1329s 22:01:28.304061012 O: test integrity: hmac-sha2-512 @2904 1329s 22:01:28.632503237 O: test integrity: hmac-sha2-512 @2905 1329s 22:01:28.961394428 O: test integrity: hmac-sha2-512 @2906 1330s 22:01:29.292184565 O: test integrity: hmac-sha2-512 @2907 1330s 22:01:29.625531257 O: test integrity: hmac-sha2-512 @2908 1330s 22:01:29.961392386 O: test integrity: hmac-sha2-512 @2909 1331s 22:01:30.271449106 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1331s 22:01:30.304128570 O: test integrity: hmac-md5 @2900 1331s 22:01:30.671532384 O: test integrity: hmac-md5 @2901 1332s 22:01:31.035406548 O: test integrity: hmac-md5 @2902 1332s 22:01:31.407433026 O: test integrity: hmac-md5 @2903 1332s 22:01:31.778931056 O: test integrity: hmac-md5 @2904 1333s 22:01:32.148534899 O: test integrity: hmac-md5 @2905 1333s 22:01:32.543321778 O: test integrity: hmac-md5 @2906 1333s 22:01:32.940549731 O: test integrity: hmac-md5 @2907 1334s 22:01:33.389999783 O: test integrity: hmac-md5 @2908 1334s 22:01:33.786052638 O: test integrity: hmac-md5 @2909 1335s 22:01:34.151035451 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1335s 22:01:34.187275365 O: test integrity: hmac-md5-96 @2900 1335s 22:01:34.565457764 O: test integrity: hmac-md5-96 @2901 1335s 22:01:34.941839898 O: test integrity: hmac-md5-96 @2902 1336s 22:01:35.309536867 O: test integrity: hmac-md5-96 @2903 1336s 22:01:35.681603938 O: test integrity: hmac-md5-96 @2904 1337s 22:01:36.051924384 O: test integrity: hmac-md5-96 @2905 1337s 22:01:36.417030794 O: test integrity: hmac-md5-96 @2906 1337s 22:01:36.784767722 O: test integrity: hmac-md5-96 @2907 1338s 22:01:37.187579865 O: test integrity: hmac-md5-96 @2908 1338s 22:01:37.548868819 O: test integrity: hmac-md5-96 @2909 1338s 22:01:37.890109410 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1338s 22:01:37.919864871 O: test integrity: umac-64@openssh.com @2900 1339s 22:01:38.288620930 O: test integrity: umac-64@openssh.com @2901 1339s 22:01:38.656645098 O: test integrity: umac-64@openssh.com @2902 1340s 22:01:39.023907855 O: test integrity: umac-64@openssh.com @2903 1340s 22:01:39.394058811 O: test integrity: umac-64@openssh.com @2904 1340s 22:01:39.771557791 O: test integrity: umac-64@openssh.com @2905 1341s 22:01:40.145713043 O: test integrity: umac-64@openssh.com @2906 1341s 22:01:40.509739590 O: test integrity: umac-64@openssh.com @2907 1341s 22:01:40.882269938 O: test integrity: umac-64@openssh.com @2908 1342s 22:01:41.252477692 O: test integrity: umac-64@openssh.com @2909 1342s 22:01:41.597192444 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1342s 22:01:41.625981571 O: test integrity: umac-128@openssh.com @2900 1343s 22:01:41.990389603 O: test integrity: umac-128@openssh.com @2901 1343s 22:01:42.357894916 O: test integrity: umac-128@openssh.com @2902 1343s 22:01:42.723919048 O: test integrity: umac-128@openssh.com @2903 1344s 22:01:43.086710614 O: test integrity: umac-128@openssh.com @2904 1344s 22:01:43.447615312 O: test integrity: umac-128@openssh.com @2905 1344s 22:01:43.813240316 O: test integrity: umac-128@openssh.com @2906 1345s 22:01:44.178067869 O: test integrity: umac-128@openssh.com @2907 1345s 22:01:44.543579630 O: test integrity: umac-128@openssh.com @2908 1345s 22:01:44.903982479 O: test integrity: umac-128@openssh.com @2909 1346s 22:01:45.245797224 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1346s 22:01:45.276078612 O: test integrity: hmac-sha1-etm@openssh.com @2900 1346s 22:01:45.644826177 O: test integrity: hmac-sha1-etm@openssh.com @2901 1347s 22:01:46.024302733 O: test integrity: hmac-sha1-etm@openssh.com @2902 1347s 22:01:46.393574543 O: test integrity: hmac-sha1-etm@openssh.com @2903 1347s 22:01:46.758973819 O: test integrity: hmac-sha1-etm@openssh.com @2904 1348s 22:01:47.129230883 O: test integrity: hmac-sha1-etm@openssh.com @2905 1348s 22:01:47.496543504 O: test integrity: hmac-sha1-etm@openssh.com @2906 1348s 22:01:47.861807416 O: test integrity: hmac-sha1-etm@openssh.com @2907 1349s 22:01:48.226343117 O: test integrity: hmac-sha1-etm@openssh.com @2908 1349s 22:01:48.614071624 O: test integrity: hmac-sha1-etm@openssh.com @2909 1350s 22:01:48.970849655 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1350s 22:01:49.002964108 O: test integrity: hmac-sha1-96-etm@openssh.com @2900 1350s 22:01:49.366680714 O: test integrity: hmac-sha1-96-etm@openssh.com @2901 1350s 22:01:49.742057685 O: test integrity: hmac-sha1-96-etm@openssh.com @2902 1351s 22:01:50.117520697 O: test integrity: hmac-sha1-96-etm@openssh.com @2903 1351s 22:01:50.500256170 O: test integrity: hmac-sha1-96-etm@openssh.com @2904 1351s 22:01:50.869452452 O: test integrity: hmac-sha1-96-etm@openssh.com @2905 1352s 22:01:51.236661705 O: test integrity: hmac-sha1-96-etm@openssh.com @2906 1352s 22:01:51.624878533 O: test integrity: hmac-sha1-96-etm@openssh.com @2907 1353s 22:01:51.984124993 O: test integrity: hmac-sha1-96-etm@openssh.com @2908 1354s 22:01:52.351547486 O: test integrity: hmac-sha1-96-etm@openssh.com @2909 1354s 22:01:52.695854134 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1354s 22:01:52.726946452 O: test integrity: hmac-sha2-256-etm@openssh.com @2900 1354s 22:01:53.095740724 O: test integrity: hmac-sha2-256-etm@openssh.com @2901 1354s 22:01:53.458413869 O: test integrity: hmac-sha2-256-etm@openssh.com @2902 1354s 22:01:53.819378150 O: test integrity: hmac-sha2-256-etm@openssh.com @2903 1355s 22:01:54.181257482 O: test integrity: hmac-sha2-256-etm@openssh.com @2904 1355s 22:01:54.542096839 O: test integrity: hmac-sha2-256-etm@openssh.com @2905 1355s 22:01:54.903488164 O: test integrity: hmac-sha2-256-etm@openssh.com @2906 1356s 22:01:55.260880752 O: test integrity: hmac-sha2-256-etm@openssh.com @2907 1356s 22:01:55.623329290 O: test integrity: hmac-sha2-256-etm@openssh.com @2908 1357s 22:01:55.986958564 O: test integrity: hmac-sha2-256-etm@openssh.com @2909 1357s 22:01:56.326598060 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1357s 22:01:56.357874740 O: test integrity: hmac-sha2-512-etm@openssh.com @2900 1357s 22:01:56.674492991 O: test integrity: hmac-sha2-512-etm@openssh.com @2901 1358s 22:01:56.994707734 O: test integrity: hmac-sha2-512-etm@openssh.com @2902 1358s 22:01:57.308949551 O: test integrity: hmac-sha2-512-etm@openssh.com @2903 1358s 22:01:57.627025461 O: test integrity: hmac-sha2-512-etm@openssh.com @2904 1358s 22:01:57.949487434 O: test integrity: hmac-sha2-512-etm@openssh.com @2905 1359s 22:01:58.281990666 O: test integrity: hmac-sha2-512-etm@openssh.com @2906 1359s 22:01:58.605390530 O: test integrity: hmac-sha2-512-etm@openssh.com @2907 1359s 22:01:58.920909963 O: test integrity: hmac-sha2-512-etm@openssh.com @2908 1360s 22:01:59.243982101 O: test integrity: hmac-sha2-512-etm@openssh.com @2909 1360s 22:01:59.548419937 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1360s 22:01:59.577962272 O: test integrity: hmac-md5-etm@openssh.com @2900 1360s 22:01:59.940539525 O: test integrity: hmac-md5-etm@openssh.com @2901 1361s 22:02:00.305440369 O: test integrity: hmac-md5-etm@openssh.com @2902 1361s 22:02:00.672956529 O: test integrity: hmac-md5-etm@openssh.com @2903 1362s 22:02:01.039742478 O: test integrity: hmac-md5-etm@openssh.com @2904 1362s 22:02:01.412544831 O: test integrity: hmac-md5-etm@openssh.com @2905 1362s 22:02:01.783852483 O: test integrity: hmac-md5-etm@openssh.com @2906 1363s 22:02:02.150493868 O: test integrity: hmac-md5-etm@openssh.com @2907 1363s 22:02:02.514861981 O: test integrity: hmac-md5-etm@openssh.com @2908 1363s 22:02:02.876798979 O: test integrity: hmac-md5-etm@openssh.com @2909 1364s 22:02:03.234872282 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1364s 22:02:03.265849436 O: test integrity: hmac-md5-96-etm@openssh.com @2900 1364s 22:02:03.628202239 O: test integrity: hmac-md5-96-etm@openssh.com @2901 1365s 22:02:03.988974499 O: test integrity: hmac-md5-96-etm@openssh.com @2902 1365s 22:02:04.363373709 O: test integrity: hmac-md5-96-etm@openssh.com @2903 1365s 22:02:04.729436081 O: test integrity: hmac-md5-96-etm@openssh.com @2904 1366s 22:02:05.105942920 O: test integrity: hmac-md5-96-etm@openssh.com @2905 1366s 22:02:05.476736717 O: test integrity: hmac-md5-96-etm@openssh.com @2906 1366s 22:02:05.844256348 O: test integrity: hmac-md5-96-etm@openssh.com @2907 1367s 22:02:06.207364237 O: test integrity: hmac-md5-96-etm@openssh.com @2908 1367s 22:02:06.570926931 O: test integrity: hmac-md5-96-etm@openssh.com @2909 1367s 22:02:06.917307104 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1367s 22:02:06.948231938 O: test integrity: umac-64-etm@openssh.com @2900 1368s 22:02:07.315374360 O: test integrity: umac-64-etm@openssh.com @2901 1368s 22:02:07.675491124 O: test integrity: umac-64-etm@openssh.com @2902 1369s 22:02:08.046494041 O: test integrity: umac-64-etm@openssh.com @2903 1369s 22:02:08.401574373 O: test integrity: umac-64-etm@openssh.com @2904 1369s 22:02:08.762541347 O: test integrity: umac-64-etm@openssh.com @2905 1370s 22:02:09.125738312 O: test integrity: umac-64-etm@openssh.com @2906 1370s 22:02:09.482533946 O: test integrity: umac-64-etm@openssh.com @2907 1370s 22:02:09.844788296 O: test integrity: umac-64-etm@openssh.com @2908 1371s 22:02:10.251889513 O: test integrity: umac-64-etm@openssh.com @2909 1371s 22:02:10.599241533 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1371s 22:02:10.629828201 O: test integrity: umac-128-etm@openssh.com @2900 1372s 22:02:10.986588633 O: test integrity: umac-128-etm@openssh.com @2901 1372s 22:02:11.340736187 O: test integrity: umac-128-etm@openssh.com @2902 1372s 22:02:11.716814647 O: test integrity: umac-128-etm@openssh.com @2903 1373s 22:02:12.090586035 O: test integrity: umac-128-etm@openssh.com @2904 1373s 22:02:12.451389360 O: test integrity: umac-128-etm@openssh.com @2905 1373s 22:02:12.813568024 O: test integrity: umac-128-etm@openssh.com @2906 1374s 22:02:13.194393028 O: test integrity: umac-128-etm@openssh.com @2907 1374s 22:02:13.559762576 O: test integrity: umac-128-etm@openssh.com @2908 1374s 22:02:13.918371348 O: test integrity: umac-128-etm@openssh.com @2909 1375s 22:02:14.262932723 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1375s 22:02:14.293574511 O: test integrity: aes128-gcm@openssh.com @2900 1375s 22:02:14.603925208 O: test integrity: aes128-gcm@openssh.com @2901 1375s 22:02:14.918046637 O: test integrity: aes128-gcm@openssh.com @2902 1376s 22:02:15.235928718 O: test integrity: aes128-gcm@openssh.com @2903 1376s 22:02:15.584595108 O: test integrity: aes128-gcm@openssh.com @2904 1376s 22:02:15.893467623 O: test integrity: aes128-gcm@openssh.com @2905 1377s 22:02:16.213890657 O: test integrity: aes128-gcm@openssh.com @2906 1377s 22:02:16.525662771 O: test integrity: aes128-gcm@openssh.com @2907 1377s 22:02:16.834618845 O: test integrity: aes128-gcm@openssh.com @2908 1378s 22:02:17.145507505 O: test integrity: aes128-gcm@openssh.com @2909 1378s 22:02:17.453647287 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1378s 22:02:17.484645239 O: test integrity: aes256-gcm@openssh.com @2900 1378s 22:02:17.805550599 O: test integrity: aes256-gcm@openssh.com @2901 1379s 22:02:18.120614956 O: test integrity: aes256-gcm@openssh.com @2902 1379s 22:02:18.426060899 O: test integrity: aes256-gcm@openssh.com @2903 1379s 22:02:18.731150276 O: test integrity: aes256-gcm@openssh.com @2904 1380s 22:02:19.042349978 O: test integrity: aes256-gcm@openssh.com @2905 1380s 22:02:19.354578694 O: test integrity: aes256-gcm@openssh.com @2906 1380s 22:02:19.680689763 O: test integrity: aes256-gcm@openssh.com @2907 1381s 22:02:19.991009691 O: test integrity: aes256-gcm@openssh.com @2908 1381s 22:02:20.298376378 O: test integrity: aes256-gcm@openssh.com @2909 1381s 22:02:20.590313769 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1381s 22:02:20.620002503 O: test integrity: chacha20-poly1305@openssh.com @2900 1381s 22:02:20.926496217 O: test integrity: chacha20-poly1305@openssh.com @2901 1382s 22:02:21.235452084 O: test integrity: chacha20-poly1305@openssh.com @2902 1382s 22:02:21.561541430 O: test integrity: chacha20-poly1305@openssh.com @2903 1382s 22:02:21.873791462 O: test integrity: chacha20-poly1305@openssh.com @2904 1383s 22:02:22.187842399 O: test integrity: chacha20-poly1305@openssh.com @2905 1383s 22:02:22.496502741 O: test integrity: chacha20-poly1305@openssh.com @2906 1383s 22:02:22.809084017 O: test integrity: chacha20-poly1305@openssh.com @2907 1384s 22:02:23.128528387 O: test integrity: chacha20-poly1305@openssh.com @2908 1384s 22:02:23.470594793 O: test integrity: chacha20-poly1305@openssh.com @2909 1384s 22:02:23.762245936 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1384s 22:02:23.766805759 O: ok integrity 1384s 22:02:23.767235365 E: run test krl.sh ... 1385s 22:02:24.145070828 O: key revocation lists: generating test keys 1387s 22:02:25.976391526 O: key revocation lists: generating KRLs 1387s 22:02:26.171470041 O: key revocation lists: checking revocations for revoked keys 1388s 22:02:27.076981963 O: key revocation lists: checking revocations for unrevoked keys 1389s 22:02:27.972607703 O: key revocation lists: checking revocations for revoked certs 1390s 22:02:29.389744690 O: key revocation lists: checking revocations for unrevoked certs 1391s 22:02:30.766958673 O: key revocation lists: testing KRL update 1393s 22:02:32.279962534 O: key revocation lists: checking revocations for revoked keys 1394s 22:02:33.171020949 O: key revocation lists: checking revocations for unrevoked keys 1395s 22:02:34.037829664 O: key revocation lists: checking revocations for revoked certs 1396s 22:02:35.442864283 O: key revocation lists: checking revocations for unrevoked certs 1397s 22:02:36.832590442 O: ok key revocation lists 1397s 22:02:36.833281291 E: run test multipubkey.sh ... 1401s 22:02:40.222785194 O: ok multiple pubkey 1401s 22:02:40.223011078 E: run test limit-keytype.sh ... 1404s 22:02:43.444862288 O: allow rsa,ed25519 1405s 22:02:44.415882124 O: allow ed25519 1406s 22:02:45.312137562 O: allow cert only 1407s 22:02:46.274571991 O: match w/ no match 1408s 22:02:47.210467809 O: match w/ matching 1409s 22:02:48.223303686 O: ok restrict pubkey type 1409s 22:02:48.223948615 E: run test hostkey-agent.sh ... 1411s 22:02:50.366620132 O: key type ssh-ed25519 1411s 22:02:50.604682819 O: key type sk-ssh-ed25519@openssh.com 1411s 22:02:50.840655557 O: key type ecdsa-sha2-nistp256 1412s 22:02:51.070553651 O: key type ecdsa-sha2-nistp384 1412s 22:02:51.343731782 O: key type ecdsa-sha2-nistp521 1412s 22:02:51.657975999 O: key type sk-ecdsa-sha2-nistp256@openssh.com 1412s 22:02:51.891931029 O: key type ssh-dss 1413s 22:02:52.117142977 O: key type ssh-rsa 1413s 22:02:52.362860567 O: cert type ssh-ed25519-cert-v01@openssh.com 1413s 22:02:52.667682173 O: cert type sk-ssh-ed25519-cert-v01@openssh.com 1414s 22:02:52.999033706 O: cert type ecdsa-sha2-nistp256-cert-v01@openssh.com 1414s 22:02:53.295876480 O: cert type ecdsa-sha2-nistp384-cert-v01@openssh.com 1414s 22:02:53.622810750 O: cert type ecdsa-sha2-nistp521-cert-v01@openssh.com 1415s 22:02:54.013577901 O: cert type sk-ecdsa-sha2-nistp256-cert-v01@openssh.com 1415s 22:02:54.318803790 O: cert type ssh-dss-cert-v01@openssh.com 1415s 22:02:54.637736908 O: cert type ssh-rsa-cert-v01@openssh.com 1415s 22:02:54.947685822 O: cert type rsa-sha2-256-cert-v01@openssh.com 1416s 22:02:55.254699534 O: cert type rsa-sha2-512-cert-v01@openssh.com 1416s 22:02:55.631892814 O: ok hostkey agent 1416s 22:02:55.632056296 E: run test hostkey-rotate.sh ... 1418s 22:02:57.240095257 O: learn hostkey with StrictHostKeyChecking=no 1418s 22:02:57.551975034 O: learn additional hostkeys 1419s 22:02:57.994628372 O: learn additional hostkeys, type=ssh-ed25519 1419s 22:02:58.333970606 O: learn additional hostkeys, type=sk-ssh-ed25519@openssh.com 1419s 22:02:58.681349790 O: learn additional hostkeys, type=ecdsa-sha2-nistp256 1420s 22:02:59.020537021 O: learn additional hostkeys, type=ecdsa-sha2-nistp384 1420s 22:02:59.376916448 O: learn additional hostkeys, type=ecdsa-sha2-nistp521 1420s 22:02:59.786591488 O: learn additional hostkeys, type=sk-ecdsa-sha2-nistp256@openssh.com 1421s 22:03:00.135701694 O: learn additional hostkeys, type=ssh-dss 1421s 22:03:00.492407004 O: learn additional hostkeys, type=ssh-rsa 1421s 22:03:00.850565013 O: learn changed non-primary hostkey type=ssh-rsa 1424s 22:03:03.009660997 O: learn new primary hostkey 1424s 22:03:03.377365933 O: rotate primary hostkey 1424s 22:03:03.755336530 O: check rotate primary hostkey 1425s 22:03:04.117210106 O: ok hostkey rotate 1425s 22:03:04.117422829 E: run test principals-command.sh ... 1425s 22:03:04.790316919 O: authorized principals command: empty authorized_principals 1426s 22:03:05.124609993 O: authorized principals command: wrong authorized_principals 1426s 22:03:05.488611915 O: authorized principals command: correct authorized_principals 1426s 22:03:05.865672377 O: authorized principals command: authorized_principals bad key opt 1427s 22:03:06.205069040 O: authorized principals command: authorized_principals command=false 1427s 22:03:06.576776906 O: authorized principals command: authorized_principals command=true 1427s 22:03:06.954817140 O: authorized principals command: wrong principals key option 1428s 22:03:07.305194952 O: authorized principals command: correct principals key option 1428s 22:03:07.683533548 O: ok authorized principals command 1428s 22:03:07.697535060 E: run test cert-file.sh ... 1429s 22:03:08.123535350 O: identity cert with no plain public file 1429s 22:03:08.502132868 O: CertificateFile with no plain public file 1429s 22:03:08.904515552 O: plain keys 1430s 22:03:09.237644884 O: untrusted cert 1430s 22:03:09.575322919 O: good cert, bad key 1430s 22:03:09.956874356 O: single trusted 1431s 22:03:10.328818539 O: multiple trusted 1432s 22:03:11.856049290 O: ok ssh with certificates 1432s 22:03:11.856694538 E: run test cfginclude.sh ... 1433s 22:03:12.198106421 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.211127679 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.225067790 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.238645456 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.253033134 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.268040819 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.282019251 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.296752253 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.309905154 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.343547295 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.358316497 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.373186501 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.396105695 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.432548995 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.446608188 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.462727089 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.476495598 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.490193066 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.504951508 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.518794258 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.533043613 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.565936704 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.580432063 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.594212052 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1433s 22:03:12.614351488 O: ok config include 1433s 22:03:12.614598971 E: run test servcfginclude.sh ... 1434s 22:03:13.421617595 O: ok server config include 1434s 22:03:13.422185403 E: run test allow-deny-users.sh ... 1437s 22:03:16.541220698 O: ok AllowUsers/DenyUsers 1437s 22:03:16.541386261 E: run test authinfo.sh ... 1437s 22:03:16.890270559 O: ExposeAuthInfo=no 1438s 22:03:17.246619518 O: ExposeAuthInfo=yes 1438s 22:03:17.587581746 O: ok authinfo 1438s 22:03:17.588089153 E: run test sshsig.sh ... 1439s 22:03:17.971204718 O: sshsig: make certificates 1439s 22:03:18.052847675 O: sshsig: check signature for ssh-ed25519 1439s 22:03:18.651045183 O: sshsig: check signature for sk-ssh-ed25519@openssh.com 1440s 22:03:19.273581462 O: sshsig: check signature for ecdsa-sha2-nistp256 1440s 22:03:19.807504007 O: sshsig: check signature for ecdsa-sha2-nistp384 1441s 22:03:20.800660753 O: sshsig: check signature for ecdsa-sha2-nistp521 1443s 22:03:22.349887216 O: sshsig: check signature for sk-ecdsa-sha2-nistp256@openssh.com 1444s 22:03:23.007078760 O: sshsig: check signature for ssh-dss 1444s 22:03:23.521903995 O: sshsig: check signature for ssh-rsa 1445s 22:03:24.115368025 O: sshsig: check signature for ssh-ed25519-cert.pub 1446s 22:03:25.322981641 O: sshsig: check signature for sk-ssh-ed25519@openssh.com-cert.pub 1447s 22:03:26.611534237 O: sshsig: check signature for ecdsa-sha2-nistp256-cert.pub 1448s 22:03:27.757099154 O: sshsig: check signature for ecdsa-sha2-nistp384-cert.pub 1450s 22:03:29.389069462 O: sshsig: check signature for ecdsa-sha2-nistp521-cert.pub 1452s 22:03:31.858088250 O: sshsig: check signature for sk-ecdsa-sha2-nistp256@openssh.com-cert.pub 1454s 22:03:33.127672673 O: sshsig: check signature for ssh-dss-cert.pub 1455s 22:03:34.222141583 O: sshsig: check signature for ssh-rsa-cert.pub 1456s 22:03:35.344019902 O: sshsig: match principals 1456s 22:03:35.388450707 O: sshsig: nomatch principals 1456s 22:03:35.414808346 O: ok sshsig 1456s 22:03:35.415998202 E: run test knownhosts.sh ... 1458s 22:03:37.857890801 O: ok known hosts 1458s 22:03:37.858149164 E: run test knownhosts-command.sh ... 1459s 22:03:38.176926541 O: simple connection 1459s 22:03:38.492731118 O: no keys 1459s 22:03:38.715048862 O: bad exit status 1459s 22:03:38.845611198 O: keytype ssh-ed25519 1460s 22:03:39.135555102 O: keytype sk-ssh-ed25519@openssh.com 1460s 22:03:39.439860801 O: keytype ecdsa-sha2-nistp256 1460s 22:03:39.725259802 O: keytype ecdsa-sha2-nistp384 1461s 22:03:40.035366259 O: keytype ecdsa-sha2-nistp521 1461s 22:03:40.386525514 O: keytype sk-ecdsa-sha2-nistp256@openssh.com 1461s 22:03:40.685786903 O: keytype ssh-rsa 1462s 22:03:40.995073028 O: ok known hosts command 1462s 22:03:40.995361352 E: run test agent-restrict.sh ... 1462s 22:03:41.327852431 O: generate keys 1462s 22:03:41.449091759 O: prepare client config 1462s 22:03:41.477487305 O: prepare known_hosts 1462s 22:03:41.489292545 O: prepare server configs 1462s 22:03:41.530432984 O: authentication w/o agent 1464s 22:03:43.922264643 O: start agent 1468s 22:03:47.931013499 O: authentication with agent (no restrict) 1471s 22:03:50.407318960 O: unrestricted keylist 1472s 22:03:51.730032689 O: authentication with agent (basic restrict) 1474s 22:03:52.976281534 O: authentication with agent incorrect key (basic restrict) 1474s 22:03:53.859955263 O: keylist (basic restrict) 1476s 22:03:55.226973813 O: username 1477s 22:03:56.580013246 O: username wildcard 1478s 22:03:57.891899355 O: username incorrect 1479s 22:03:58.038576780 O: agent restriction honours certificate principal 1479s 22:03:58.115899585 O: multihop without agent 1480s 22:03:59.574293548 O: multihop agent unrestricted 1482s 22:04:01.057655480 O: multihop restricted 1483s 22:04:02.600505926 O: multihop username 1485s 22:04:04.059640114 O: multihop wildcard username 1486s 22:04:05.496704795 O: multihop wrong username 1487s 22:04:06.510541477 O: multihop cycle no agent 1489s 22:04:08.651975565 O: multihop cycle agent unrestricted 1491s 22:04:10.819737790 O: multihop cycle restricted deny 1492s 22:04:11.822863868 O: multihop cycle restricted allow 1495s 22:04:14.009756884 O: ok agent restrictions 1495s 22:04:14.009942687 E: run test hostbased.sh ... 1495s 22:04:14.350534352 O: SKIPPED: TEST_SSH_HOSTBASED_AUTH not set. 1495s 22:04:14.350697075 E: run test channel-timeout.sh ... 1495s 22:04:14.690307807 O: no timeout 1501s 22:04:20.027869093 O: command timeout 1501s 22:04:20.893940974 O: command long timeout 1502s 22:04:21.223862167 O: command wildcard timeout 1502s 22:04:21.906773064 O: command irrelevant timeout 1508s 22:04:27.250336806 O: multiplexed command timeout 1518s 22:04:37.932597313 O: irrelevant multiplexed command timeout 1534s 22:04:53.304112521 O: global command timeout 1555s 22:05:14.947124820 O: sftp no timeout 1561s 22:05:20.306961983 O: sftp timeout 1561s 22:05:20.891407956 E: Connection closed 1561s 22:05:20.894419035 O: sftp irrelevant timeout 1567s 22:05:26.248646659 O: ok channel timeout 1567s 22:05:26.248945503 E: run test connection-timeout.sh ... 1567s 22:05:26.588394747 O: no timeout 1572s 22:05:31.924292070 O: timeout 1581s 22:05:40.237385112 O: session inhibits timeout 1589s 22:05:48.589618328 O: timeout after session 1597s 22:05:56.603569930 O: timeout with listeners 1605s 22:06:04.950317570 O: ok unused connection timeout 1605s 22:06:04.951024619 E: run test match-subsystem.sh ... 1609s 22:06:08.616189532 O: ok sshd_config match subsystem 1609s 22:06:08.616731700 E: run test agent-pkcs11-restrict.sh ... 1609s 22:06:08.955633772 O: SKIPPED: No PKCS#11 library found 1609s 22:06:08.956007297 E: run test agent-pkcs11-cert.sh ... 1610s 22:06:09.303526121 O: SKIPPED: No PKCS#11 library found 1610s 22:06:09.306088754 O: set -e ; if test -z "" ; then \ 1610s 22:06:09.308573547 O: V="" ; \ 1610s 22:06:09.310616734 O: test "x" = "x" || \ 1610s 22:06:09.312993045 O: V=/tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/valgrind-unit.sh ; \ 1610s 22:06:09.316098045 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/sshbuf/test_sshbuf ; \ 1610s 22:06:09.318399195 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/sshkey/test_sshkey \ 1610s 22:06:09.320540543 O: -d /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/sshkey/testdata ; \ 1610s 22:06:09.322819613 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/sshsig/test_sshsig \ 1610s 22:06:09.324871720 O: -d /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/sshsig/testdata ; \ 1610s 22:06:09.327016148 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/authopt/test_authopt \ 1610s 22:06:09.329664543 O: -d /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/authopt/testdata ; \ 1610s 22:06:09.331897292 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/bitmap/test_bitmap ; \ 1610s 22:06:09.334054560 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/conversion/test_conversion ; \ 1610s 22:06:09.336518192 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/kex/test_kex ; \ 1610s 22:06:09.338738541 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/hostkeys/test_hostkeys \ 1610s 22:06:09.340846129 O: -d /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/hostkeys/testdata ; \ 1610s 22:06:09.343296121 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/match/test_match ; \ 1610s 22:06:09.345583471 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/misc/test_misc ; \ 1610s 22:06:09.348334707 O: if test "x" = "xyes" ; then \ 1610s 22:06:09.350842460 O: $V /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/unittests/utf8/test_utf8 ; \ 1610s 22:06:09.352850406 O: fi \ 1610s 22:06:09.355022314 O: fi 1633s 22:06:31.980330282 O: test_sshbuf: ...................................................................................................... 103 tests ok 1740s 22:08:19.157677583 O: test_sshkey: ........................................................................................................ 104 tests ok 1740s 22:08:19.178372286 O: test_sshsig: ........ 8 tests ok 1740s 22:08:19.586507522 O: test_authopt: .................................................................................................................................................. 146 tests ok 1755s 22:08:34.414466306 O: test_bitmap: .. 2 tests ok 1755s 22:08:34.421350193 O: test_conversion: . 1 tests ok 1774s 22:08:53.381664905 O: test_kex: ............................................................................................................................................................................................................................................................................................................................................................................................................. 398 tests ok 1774s 22:08:53.700814584 O: test_hostkeys: .................. 18 tests ok 1774s 22:08:53.709391532 O: test_match: ...... 6 tests ok 1774s 22:08:53.717436714 O: test_misc: ........................................... 43 tests ok 1774s 22:08:53.721951451 E: run test putty-transfer.sh ... 1778s 22:08:57.240849882 O: plink version 0.81 minor 81 1778s 22:08:57.258564226 O: putty transfer data: compression 0 1780s 22:08:59.234852812 O: putty transfer data: compression 1 1782s 22:09:01.246061111 O: ok putty transfer data 1782s 22:09:01.246456636 E: run test putty-ciphers.sh ... 1783s 22:09:02.196890445 O: plink version 0.81 minor 81 1783s 22:09:02.567806531 O: putty ciphers: cipher default mac default 1783s 22:09:02.823315879 O: putty ciphers: cipher default mac hmac-sha1 1784s 22:09:03.076095872 O: putty ciphers: cipher default mac hmac-sha1-96 1784s 22:09:03.325796787 O: putty ciphers: cipher default mac hmac-sha2-256 1784s 22:09:03.580704446 O: putty ciphers: cipher default mac hmac-sha2-512 1784s 22:09:03.835589906 O: putty ciphers: cipher default mac hmac-md5 1785s 22:09:04.090864610 O: putty ciphers: cipher default mac hmac-sha1-etm@openssh.com 1785s 22:09:04.379135611 O: putty ciphers: cipher default mac hmac-sha1-96-etm@openssh.com 1785s 22:09:04.634246353 O: putty ciphers: cipher default mac hmac-sha2-256-etm@openssh.com 1785s 22:09:04.891608923 O: putty ciphers: cipher default mac hmac-sha2-512-etm@openssh.com 1786s 22:09:05.159914952 O: putty ciphers: cipher default mac hmac-md5-etm@openssh.com 1786s 22:09:05.414599528 O: putty ciphers: cipher 3des-cbc mac default 1786s 22:09:05.671735175 O: putty ciphers: cipher 3des-cbc mac hmac-sha1 1786s 22:09:05.922729384 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-96 1787s 22:09:06.175356174 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-256 1787s 22:09:06.512459270 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-512 1787s 22:09:06.768435421 O: putty ciphers: cipher 3des-cbc mac hmac-md5 1789s 22:09:07.021186212 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-etm@openssh.com 1789s 22:09:07.280215202 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-96-etm@openssh.com 1789s 22:09:07.543885611 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-256-etm@openssh.com 1789s 22:09:07.795183343 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-512-etm@openssh.com 1789s 22:09:08.069687728 O: putty ciphers: cipher 3des-cbc mac hmac-md5-etm@openssh.com 1789s 22:09:08.324821668 O: putty ciphers: cipher aes128-cbc mac default 1789s 22:09:08.578711872 O: putty ciphers: cipher aes128-cbc mac hmac-sha1 1789s 22:09:08.835376951 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-96 1790s 22:09:09.089846483 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-256 1790s 22:09:09.350932377 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-512 1790s 22:09:09.606978128 O: putty ciphers: cipher aes128-cbc mac hmac-md5 1790s 22:09:09.861017214 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-etm@openssh.com 1791s 22:09:10.117434770 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-96-etm@openssh.com 1791s 22:09:10.372243424 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-256-etm@openssh.com 1791s 22:09:10.641524662 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-512-etm@openssh.com 1791s 22:09:10.903585288 O: putty ciphers: cipher aes128-cbc mac hmac-md5-etm@openssh.com 1792s 22:09:11.159690519 O: putty ciphers: cipher aes192-cbc mac default 1792s 22:09:11.418387663 O: putty ciphers: cipher aes192-cbc mac hmac-sha1 1792s 22:09:11.679747920 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-96 1792s 22:09:11.932640790 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-256 1793s 22:09:12.191990861 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-512 1793s 22:09:12.476323367 O: putty ciphers: cipher aes192-cbc mac hmac-md5 1793s 22:09:12.735803880 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-etm@openssh.com 1794s 22:09:12.994220979 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-96-etm@openssh.com 1794s 22:09:13.260285494 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-256-etm@openssh.com 1794s 22:09:13.518098705 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-512-etm@openssh.com 1794s 22:09:13.775663673 O: putty ciphers: cipher aes192-cbc mac hmac-md5-etm@openssh.com 1795s 22:09:14.037461575 O: putty ciphers: cipher aes256-cbc mac default 1795s 22:09:14.300457971 O: putty ciphers: cipher aes256-cbc mac hmac-sha1 1795s 22:09:14.559908882 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-96 1795s 22:09:14.864977008 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-256 1796s 22:09:15.127021032 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-512 1796s 22:09:15.388259125 O: putty ciphers: cipher aes256-cbc mac hmac-md5 1796s 22:09:15.641527078 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-etm@openssh.com 1796s 22:09:15.898451277 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-96-etm@openssh.com 1797s 22:09:16.158010789 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-256-etm@openssh.com 1797s 22:09:16.419289922 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-512-etm@openssh.com 1797s 22:09:16.694297388 O: putty ciphers: cipher aes256-cbc mac hmac-md5-etm@openssh.com 1797s 22:09:16.947646541 O: putty ciphers: cipher aes128-ctr mac default 1798s 22:09:17.205135266 O: putty ciphers: cipher aes128-ctr mac hmac-sha1 1798s 22:09:17.476963612 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-96 1798s 22:09:17.735346588 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-256 1799s 22:09:17.991568777 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-512 1799s 22:09:18.247204878 O: putty ciphers: cipher aes128-ctr mac hmac-md5 1799s 22:09:18.506110260 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-etm@openssh.com 1799s 22:09:18.771535725 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-96-etm@openssh.com 1800s 22:09:19.052772108 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-256-etm@openssh.com 1800s 22:09:19.308842694 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-512-etm@openssh.com 1800s 22:09:19.560990791 O: putty ciphers: cipher aes128-ctr mac hmac-md5-etm@openssh.com 1800s 22:09:19.870752053 O: putty ciphers: cipher aes192-ctr mac default 1801s 22:09:20.146798770 O: putty ciphers: cipher aes192-ctr mac hmac-sha1 1801s 22:09:20.402939796 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-96 1801s 22:09:20.659741111 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-256 1801s 22:09:20.919353421 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-512 1802s 22:09:21.180329188 O: putty ciphers: cipher aes192-ctr mac hmac-md5 1802s 22:09:21.437919472 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-etm@openssh.com 1802s 22:09:21.708702082 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-96-etm@openssh.com 1803s 22:09:21.973273654 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-256-etm@openssh.com 1803s 22:09:22.228953474 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-512-etm@openssh.com 1803s 22:09:22.486281074 O: putty ciphers: cipher aes192-ctr mac hmac-md5-etm@openssh.com 1803s 22:09:22.737035591 O: putty ciphers: cipher aes256-ctr mac default 1804s 22:09:22.990174979 O: putty ciphers: cipher aes256-ctr mac hmac-sha1 1804s 22:09:23.247009732 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-96 1804s 22:09:23.495774584 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-256 1804s 22:09:23.746827945 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-512 1805s 22:09:24.000619300 O: putty ciphers: cipher aes256-ctr mac hmac-md5 1805s 22:09:24.260484651 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-etm@openssh.com 1805s 22:09:24.523321479 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-96-etm@openssh.com 1805s 22:09:24.778922297 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-256-etm@openssh.com 1806s 22:09:25.032962455 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-512-etm@openssh.com 1806s 22:09:25.285362791 O: putty ciphers: cipher aes256-ctr mac hmac-md5-etm@openssh.com 1806s 22:09:25.535887384 O: putty ciphers: cipher aes128-gcm@openssh.com mac default 1806s 22:09:25.808352933 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1 1807s 22:09:26.061241716 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-96 1807s 22:09:26.319571007 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-256 1807s 22:09:26.571996463 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-512 1807s 22:09:26.837531484 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-md5 1808s 22:09:27.089773938 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-etm@openssh.com 1808s 22:09:27.341372744 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-96-etm@openssh.com 1808s 22:09:27.589848470 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-256-etm@openssh.com 1808s 22:09:27.853871352 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-512-etm@openssh.com 1809s 22:09:28.120843270 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-md5-etm@openssh.com 1809s 22:09:28.375749957 O: putty ciphers: cipher aes256-gcm@openssh.com mac default 1809s 22:09:28.626446870 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1 1809s 22:09:28.876892261 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-96 1810s 22:09:29.122359148 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-256 1810s 22:09:29.394429810 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-512 1810s 22:09:29.680768972 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-md5 1810s 22:09:29.932285655 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-etm@openssh.com 1811s 22:09:30.189339008 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-96-etm@openssh.com 1811s 22:09:30.440935572 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-256-etm@openssh.com 1811s 22:09:30.695825977 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-512-etm@openssh.com 1811s 22:09:30.948965840 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-md5-etm@openssh.com 1812s 22:09:31.196776796 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac default 1812s 22:09:31.480325522 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1 1812s 22:09:31.731276077 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-96 1813s 22:09:31.980522651 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-256 1813s 22:09:32.236052063 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-512 1813s 22:09:32.509205017 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-md5 1813s 22:09:32.758207587 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-etm@openssh.com 1814s 22:09:33.012535064 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-96-etm@openssh.com 1814s 22:09:33.258704239 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-256-etm@openssh.com 1814s 22:09:33.507634767 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-512-etm@openssh.com 1814s 22:09:33.757912353 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-md5-etm@openssh.com 1815s 22:09:34.010435767 O: ok putty ciphers 1815s 22:09:34.010729531 E: run test putty-kex.sh ... 1816s 22:09:35.612659621 O: plink version 0.81 minor 81 1816s 22:09:35.756348947 O: putty KEX: kex diffie-hellman-group1-sha1 1817s 22:09:35.968223889 O: putty KEX: kex diffie-hellman-group14-sha1 1817s 22:09:36.277551615 O: putty KEX: kex diffie-hellman-group14-sha256 1817s 22:09:36.587609351 O: putty KEX: kex diffie-hellman-group16-sha512 1818s 22:09:37.564852987 O: putty KEX: kex diffie-hellman-group18-sha512 1824s 22:09:42.996903030 O: putty KEX: kex diffie-hellman-group-exchange-sha1 1824s 22:09:43.388928270 O: putty KEX: kex diffie-hellman-group-exchange-sha256 1825s 22:09:44.384744766 O: putty KEX: kex ecdh-sha2-nistp256 1825s 22:09:44.600000747 O: putty KEX: kex ecdh-sha2-nistp384 1825s 22:09:44.842937275 O: putty KEX: kex ecdh-sha2-nistp521 1826s 22:09:45.160624261 O: putty KEX: kex curve25519-sha256 1826s 22:09:45.377560702 O: putty KEX: kex curve25519-sha256@libssh.org 1826s 22:09:45.580944334 O: putty KEX: kex sntrup761x25519-sha512@openssh.com 1826s 22:09:45.827327025 O: ok putty KEX 1826s 22:09:45.827864031 E: run test conch-ciphers.sh ... 1827s 22:09:46.385932552 O: conch ciphers: cipher aes256-ctr 1828s 22:09:47.653973216 O: conch ciphers: cipher aes256-cbc 1829s 22:09:48.660192954 O: conch ciphers: cipher aes192-ctr 1830s 22:09:49.572844797 O: conch ciphers: cipher aes192-cbc 1831s 22:09:50.517681282 O: conch ciphers: cipher aes128-ctr 1832s 22:09:51.402876497 O: conch ciphers: cipher aes128-cbc 1833s 22:09:52.333378599 O: conch ciphers: cipher cast128-cbc 1834s 22:09:53.224441445 O: conch ciphers: cipher blowfish 1835s 22:09:54.162863043 O: conch ciphers: cipher 3des-cbc 1836s 22:09:55.171298076 E: run test dropbear-ciphers.sh ... 1836s 22:09:55.171080393 O: ok conch ciphers 1838s 22:09:57.714755890 E: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/.dropbear/ossh.id_dss: No such file or directory 1838s 22:09:57.822365597 E: run test dropbear-kex.sh ... 1838s 22:09:57.822211196 O: ok dropbear ciphers 1839s 22:09:58.127054253 E: /tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress/.dropbear/ossh.id_dss: No such file or directory 1839s 22:09:58.211899955 O: dropbear kex: kex curve25519-sha256 1839s 22:09:58.459287492 O: dropbear kex: kex curve25519-sha256@libssh.org 1839s 22:09:58.694712480 O: dropbear kex: kex diffie-hellman-group14-sha256 1840s 22:09:58.979822809 O: dropbear kex: kex diffie-hellman-group14-sha1 1840s 22:09:59.263885205 O: ok dropbear kex 1840s 22:09:59.266447637 O: make: Leaving directory '/tmp/autopkgtest.0dhFo8/autopkgtest_tmp/user/regress' 1840s 22:09:59.269732118 I: Finished with exitcode 0 1840s Synchronizing state of haveged.service with SysV service script with /usr/lib/systemd/systemd-sysv-install. 1840s Executing: /usr/lib/systemd/systemd-sysv-install disable haveged 1840s Removed '/etc/systemd/system/sysinit.target.wants/haveged.service'. 1841s info: Looking for files to backup/remove ... 1841s info: Removing files ... 1841s info: Removing crontab ... 1841s info: Removing user `openssh-tests' ... 1841s autopkgtest [22:10:00]: test regress: -----------------------] 1845s autopkgtest [22:10:04]: test regress: - - - - - - - - - - results - - - - - - - - - - 1845s regress PASS 1849s autopkgtest [22:10:08]: test ssh-gssapi: preparing testbed 1905s autopkgtest [22:11:04]: testbed dpkg architecture: armhf 1906s autopkgtest [22:11:05]: testbed apt version: 2.9.8 1906s autopkgtest [22:11:05]: @@@@@@@@@@@@@@@@@@@@ test bed setup 1914s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 1914s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [93.0 kB] 1914s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 1914s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1029 kB] 1914s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 1914s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [145 kB] 1914s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [737 kB] 1914s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [4428 B] 1915s Fetched 2105 kB in 1s (2007 kB/s) 1915s Reading package lists... 1929s tee: /proc/self/fd/2: Permission denied 1952s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 1952s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 1952s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 1952s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 1954s Reading package lists... 1954s Reading package lists... 1954s Building dependency tree... 1954s Reading state information... 1955s Calculating upgrade... 1956s The following NEW packages will be installed: 1956s libassuan9 1956s The following packages will be upgraded: 1956s libgpgme11t64 libseccomp2 python3-cffi-backend python3-markupsafe 1956s 4 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 1956s Need to get 297 kB of archives. 1956s After this operation, 224 kB of additional disk space will be used. 1956s Get:1 http://ftpmaster.internal/ubuntu plucky/main armhf libseccomp2 armhf 2.5.5-1ubuntu5 [49.3 kB] 1957s Get:2 http://ftpmaster.internal/ubuntu plucky/main armhf python3-cffi-backend armhf 1.17.1-2build1 [75.9 kB] 1957s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libassuan9 armhf 3.0.1-2 [34.3 kB] 1957s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf libgpgme11t64 armhf 1.24.0-2ubuntu1 [125 kB] 1957s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf python3-markupsafe armhf 2.1.5-1build3 [12.5 kB] 1957s Fetched 297 kB in 0s (599 kB/s) 1957s (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 ... 59566 files and directories currently installed.) 1957s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu5_armhf.deb ... 1957s Unpacking libseccomp2:armhf (2.5.5-1ubuntu5) over (2.5.5-1ubuntu4) ... 1957s Setting up libseccomp2:armhf (2.5.5-1ubuntu5) ... 1958s (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 ... 59566 files and directories currently installed.) 1958s Preparing to unpack .../python3-cffi-backend_1.17.1-2build1_armhf.deb ... 1958s Unpacking python3-cffi-backend:armhf (1.17.1-2build1) over (1.17.1-2) ... 1958s Selecting previously unselected package libassuan9:armhf. 1958s Preparing to unpack .../libassuan9_3.0.1-2_armhf.deb ... 1958s Unpacking libassuan9:armhf (3.0.1-2) ... 1958s Preparing to unpack .../libgpgme11t64_1.24.0-2ubuntu1_armhf.deb ... 1958s Unpacking libgpgme11t64:armhf (1.24.0-2ubuntu1) over (1.23.2-5ubuntu4) ... 1958s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_armhf.deb ... 1958s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 1958s Setting up python3-markupsafe (2.1.5-1build3) ... 1958s Setting up libassuan9:armhf (3.0.1-2) ... 1958s Setting up libgpgme11t64:armhf (1.24.0-2ubuntu1) ... 1958s Setting up python3-cffi-backend:armhf (1.17.1-2build1) ... 1958s Processing triggers for libc-bin (2.40-1ubuntu3) ... 1958s Reading package lists... 1959s Building dependency tree... 1959s Reading state information... 1960s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 1962s autopkgtest [22:12:01]: rebooting testbed after setup commands that affected boot 2061s Reading package lists... 2061s Building dependency tree... 2061s Reading state information... 2062s Starting pkgProblemResolver with broken count: 0 2062s Starting 2 pkgProblemResolver with broken count: 0 2062s Done 2063s The following additional packages will be installed: 2063s krb5-admin-server krb5-config krb5-kdc krb5-user libevent-2.1-7t64 2063s libgssrpc4t64 libkadm5clnt-mit12 libkadm5srv-mit12 libkdb5-10t64 2063s libverto-libevent1t64 libverto1t64 2063s Suggested packages: 2063s krb5-kdc-ldap krb5-kpropd krb5-k5tls krb5-doc 2063s The following NEW packages will be installed: 2063s autopkgtest-satdep krb5-admin-server krb5-config krb5-kdc krb5-user 2063s libevent-2.1-7t64 libgssrpc4t64 libkadm5clnt-mit12 libkadm5srv-mit12 2063s libkdb5-10t64 libverto-libevent1t64 libverto1t64 2063s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded. 2063s Need to get 711 kB/711 kB of archives. 2063s After this operation, 2005 kB of additional disk space will be used. 2063s Get:1 /tmp/autopkgtest.0dhFo8/2-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [724 B] 2063s Get:2 http://ftpmaster.internal/ubuntu plucky/main armhf krb5-config all 2.7 [22.0 kB] 2064s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libgssrpc4t64 armhf 1.21.3-3 [51.5 kB] 2064s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf libkadm5clnt-mit12 armhf 1.21.3-3 [35.1 kB] 2064s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf libkdb5-10t64 armhf 1.21.3-3 [35.1 kB] 2064s Get:6 http://ftpmaster.internal/ubuntu plucky/main armhf libkadm5srv-mit12 armhf 1.21.3-3 [45.6 kB] 2064s Get:7 http://ftpmaster.internal/ubuntu plucky/universe armhf krb5-user armhf 1.21.3-3 [111 kB] 2064s Get:8 http://ftpmaster.internal/ubuntu plucky/main armhf libevent-2.1-7t64 armhf 2.1.12-stable-10 [127 kB] 2064s Get:9 http://ftpmaster.internal/ubuntu plucky/main armhf libverto1t64 armhf 0.3.1-1.2ubuntu3 [9364 B] 2064s Get:10 http://ftpmaster.internal/ubuntu plucky/main armhf libverto-libevent1t64 armhf 0.3.1-1.2ubuntu3 [6324 B] 2064s Get:11 http://ftpmaster.internal/ubuntu plucky/universe armhf krb5-kdc armhf 1.21.3-3 [177 kB] 2064s Get:12 http://ftpmaster.internal/ubuntu plucky/universe armhf krb5-admin-server armhf 1.21.3-3 [91.0 kB] 2064s Preconfiguring packages ... 2065s Fetched 711 kB in 1s (1141 kB/s) 2065s Selecting previously unselected package krb5-config. 2065s (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 ... 59573 files and directories currently installed.) 2065s Preparing to unpack .../00-krb5-config_2.7_all.deb ... 2065s Unpacking krb5-config (2.7) ... 2065s Selecting previously unselected package libgssrpc4t64:armhf. 2065s Preparing to unpack .../01-libgssrpc4t64_1.21.3-3_armhf.deb ... 2065s Unpacking libgssrpc4t64:armhf (1.21.3-3) ... 2065s Selecting previously unselected package libkadm5clnt-mit12:armhf. 2065s Preparing to unpack .../02-libkadm5clnt-mit12_1.21.3-3_armhf.deb ... 2065s Unpacking libkadm5clnt-mit12:armhf (1.21.3-3) ... 2065s Selecting previously unselected package libkdb5-10t64:armhf. 2065s Preparing to unpack .../03-libkdb5-10t64_1.21.3-3_armhf.deb ... 2065s Unpacking libkdb5-10t64:armhf (1.21.3-3) ... 2065s Selecting previously unselected package libkadm5srv-mit12:armhf. 2065s Preparing to unpack .../04-libkadm5srv-mit12_1.21.3-3_armhf.deb ... 2065s Unpacking libkadm5srv-mit12:armhf (1.21.3-3) ... 2065s Selecting previously unselected package krb5-user. 2065s Preparing to unpack .../05-krb5-user_1.21.3-3_armhf.deb ... 2065s Unpacking krb5-user (1.21.3-3) ... 2065s Selecting previously unselected package libevent-2.1-7t64:armhf. 2065s Preparing to unpack .../06-libevent-2.1-7t64_2.1.12-stable-10_armhf.deb ... 2065s Unpacking libevent-2.1-7t64:armhf (2.1.12-stable-10) ... 2065s Selecting previously unselected package libverto1t64:armhf. 2065s Preparing to unpack .../07-libverto1t64_0.3.1-1.2ubuntu3_armhf.deb ... 2065s Unpacking libverto1t64:armhf (0.3.1-1.2ubuntu3) ... 2065s Selecting previously unselected package libverto-libevent1t64:armhf. 2065s Preparing to unpack .../08-libverto-libevent1t64_0.3.1-1.2ubuntu3_armhf.deb ... 2065s Unpacking libverto-libevent1t64:armhf (0.3.1-1.2ubuntu3) ... 2065s Selecting previously unselected package krb5-kdc. 2065s Preparing to unpack .../09-krb5-kdc_1.21.3-3_armhf.deb ... 2065s Unpacking krb5-kdc (1.21.3-3) ... 2065s Selecting previously unselected package krb5-admin-server. 2065s Preparing to unpack .../10-krb5-admin-server_1.21.3-3_armhf.deb ... 2065s Unpacking krb5-admin-server (1.21.3-3) ... 2065s Selecting previously unselected package autopkgtest-satdep. 2065s Preparing to unpack .../11-2-autopkgtest-satdep.deb ... 2065s Unpacking autopkgtest-satdep (0) ... 2065s Setting up libevent-2.1-7t64:armhf (2.1.12-stable-10) ... 2065s Setting up libgssrpc4t64:armhf (1.21.3-3) ... 2065s Setting up krb5-config (2.7) ... 2065s Setting up libkadm5clnt-mit12:armhf (1.21.3-3) ... 2065s Setting up libkdb5-10t64:armhf (1.21.3-3) ... 2065s Setting up libkadm5srv-mit12:armhf (1.21.3-3) ... 2065s Setting up krb5-user (1.21.3-3) ... 2065s update-alternatives: using /usr/bin/kinit.mit to provide /usr/bin/kinit (kinit) in auto mode 2065s update-alternatives: using /usr/bin/klist.mit to provide /usr/bin/klist (klist) in auto mode 2065s update-alternatives: using /usr/bin/kswitch.mit to provide /usr/bin/kswitch (kswitch) in auto mode 2066s update-alternatives: using /usr/bin/ksu.mit to provide /usr/bin/ksu (ksu) in auto mode 2066s update-alternatives: using /usr/bin/kpasswd.mit to provide /usr/bin/kpasswd (kpasswd) in auto mode 2066s update-alternatives: using /usr/bin/kdestroy.mit to provide /usr/bin/kdestroy (kdestroy) in auto mode 2066s update-alternatives: using /usr/bin/kadmin.mit to provide /usr/bin/kadmin (kadmin) in auto mode 2066s update-alternatives: using /usr/bin/ktutil.mit to provide /usr/bin/ktutil (ktutil) in auto mode 2066s Setting up libverto1t64:armhf (0.3.1-1.2ubuntu3) ... 2066s Setting up libverto-libevent1t64:armhf (0.3.1-1.2ubuntu3) ... 2066s Setting up krb5-kdc (1.21.3-3) ... 2066s Created symlink '/etc/systemd/system/multi-user.target.wants/krb5-kdc.service' → '/usr/lib/systemd/system/krb5-kdc.service'. 2066s Could not execute systemctl: at /usr/bin/deb-systemd-invoke line 148. 2066s Setting up krb5-admin-server (1.21.3-3) ... 2067s Created symlink '/etc/systemd/system/multi-user.target.wants/krb5-admin-server.service' → '/usr/lib/systemd/system/krb5-admin-server.service'. 2067s Setting up autopkgtest-satdep (0) ... 2067s Processing triggers for libc-bin (2.40-1ubuntu3) ... 2067s Processing triggers for man-db (2.13.0-1) ... 2081s (Reading database ... 59687 files and directories currently installed.) 2081s Removing autopkgtest-satdep (0) ... 2092s autopkgtest [22:14:11]: test ssh-gssapi: [----------------------- 2095s ## Setting up test environment 2095s ## Creating Kerberos realm EXAMPLE.FAKE 2095s Initializing database '/var/lib/krb5kdc/principal' for realm 'EXAMPLE.FAKE', 2095s master key name 'K/M@EXAMPLE.FAKE' 2095s ## Creating principals 2095s Authenticating as principal root/admin@EXAMPLE.FAKE with password. 2095s Principal "testuser1136@EXAMPLE.FAKE" created. 2095s Authenticating as principal root/admin@EXAMPLE.FAKE with password. 2095s Principal "host/sshd-gssapi.example.fake@EXAMPLE.FAKE" created. 2095s ## Extracting service principal host/sshd-gssapi.example.fake 2095s Authenticating as principal root/admin@EXAMPLE.FAKE with password. 2095s Entry for principal host/sshd-gssapi.example.fake with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/etc/krb5.keytab. 2095s Entry for principal host/sshd-gssapi.example.fake with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/etc/krb5.keytab. 2095s ## Adjusting /etc/krb5.conf 2095s ## TESTS 2095s 2095s ## TEST test_gssapi_login 2095s ## Configuring sshd for gssapi-with-mic authentication 2095s ## Restarting ssh 2095s ## Obtaining TGT 2095s Password for testuser1136@EXAMPLE.FAKE: 2095s Ticket cache: FILE:/tmp/krb5cc_0 2095s Default principal: testuser1136@EXAMPLE.FAKE 2095s 2095s Valid starting Expires Service principal 2095s 11/15/24 22:14:14 11/16/24 08:14:14 krbtgt/EXAMPLE.FAKE@EXAMPLE.FAKE 2095s renew until 11/16/24 22:14:14 2095s 2095s ## ssh'ing into localhost using gssapi-with-mic auth 2095s Warning: Permanently added 'sshd-gssapi.example.fake' (ED25519) to the list of known hosts. 2095s Fri Nov 15 22:14:14 UTC 2024 2095s 2095s ## checking that we got a service ticket for ssh (host/) 2095s 11/15/24 22:14:14 11/16/24 08:14:14 host/sshd-gssapi.example.fake@ 2095s Ticket server: host/sshd-gssapi.example.fake@EXAMPLE.FAKE 2095s 2095s ## Checking ssh logs to confirm gssapi-with-mic auth was used 2095s Nov 15 22:14:14 sshd-gssapi.example.fake sshd[1198]: Accepted gssapi-with-mic for testuser1136 from 127.0.0.1 port 38138 ssh2: testuser1136@EXAMPLE.FAKE 2095s ## PASS test_gssapi_login 2095s 2095s ## TEST test_gssapi_keyex_login 2095s ## Configuring sshd for gssapi-keyex authentication 2095s ## Restarting ssh 2095s ## Obtaining TGT 2095s Password for testuser1136@EXAMPLE.FAKE: 2095s Ticket cache: FILE:/tmp/krb5cc_0 2095s Default principal: testuser1136@EXAMPLE.FAKE 2095s 2095s Valid starting Expires Service principal 2095s 11/15/24 22:14:14 11/16/24 08:14:14 krbtgt/EXAMPLE.FAKE@EXAMPLE.FAKE 2095s renew until 11/16/24 22:14:14 2095s 2095s ## ssh'ing into localhost using gssapi-keyex auth 2096s Fri Nov 15 22:14:15 UTC 2024 2096s 2096s ## checking that we got a service ticket for ssh (host/) 2096s 11/15/24 22:14:14 11/16/24 08:14:14 host/sshd-gssapi.example.fake@ 2096s Ticket server: host/sshd-gssapi.example.fake@EXAMPLE.FAKE 2096s 2096s ## Checking ssh logs to confirm gssapi-keyex auth was used 2096s Nov 15 22:14:15 sshd-gssapi.example.fake sshd[1245]: Accepted gssapi-keyex for testuser1136 from 127.0.0.1 port 38142 ssh2: testuser1136@EXAMPLE.FAKE 2096s ## PASS test_gssapi_keyex_login 2096s 2096s ## ALL TESTS PASSED 2096s ## Cleaning up 2096s autopkgtest [22:14:15]: test ssh-gssapi: -----------------------] 2100s autopkgtest [22:14:19]: test ssh-gssapi: - - - - - - - - - - results - - - - - - - - - - 2100s ssh-gssapi PASS 2103s autopkgtest [22:14:22]: test systemd-socket-activation: preparing testbed 2157s autopkgtest [22:15:16]: testbed dpkg architecture: armhf 2158s autopkgtest [22:15:17]: testbed apt version: 2.9.8 2158s autopkgtest [22:15:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup 2166s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 2166s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 2166s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 2166s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [93.0 kB] 2166s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1029 kB] 2166s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [145 kB] 2166s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [737 kB] 2167s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [4428 B] 2167s Fetched 2105 kB in 1s (2039 kB/s) 2167s Reading package lists... 2181s tee: /proc/self/fd/2: Permission denied 2203s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 2203s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 2203s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 2203s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 2205s Reading package lists... 2205s Reading package lists... 2206s Building dependency tree... 2206s Reading state information... 2207s Calculating upgrade... 2208s The following NEW packages will be installed: 2208s libassuan9 2208s The following packages will be upgraded: 2208s libgpgme11t64 libseccomp2 python3-cffi-backend python3-markupsafe 2208s 4 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 2208s Need to get 297 kB of archives. 2208s After this operation, 224 kB of additional disk space will be used. 2208s Get:1 http://ftpmaster.internal/ubuntu plucky/main armhf libseccomp2 armhf 2.5.5-1ubuntu5 [49.3 kB] 2208s Get:2 http://ftpmaster.internal/ubuntu plucky/main armhf python3-cffi-backend armhf 1.17.1-2build1 [75.9 kB] 2208s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libassuan9 armhf 3.0.1-2 [34.3 kB] 2208s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf libgpgme11t64 armhf 1.24.0-2ubuntu1 [125 kB] 2208s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf python3-markupsafe armhf 2.1.5-1build3 [12.5 kB] 2209s Fetched 297 kB in 0s (623 kB/s) 2209s (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 ... 59566 files and directories currently installed.) 2209s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu5_armhf.deb ... 2209s Unpacking libseccomp2:armhf (2.5.5-1ubuntu5) over (2.5.5-1ubuntu4) ... 2209s Setting up libseccomp2:armhf (2.5.5-1ubuntu5) ... 2209s (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 ... 59566 files and directories currently installed.) 2209s Preparing to unpack .../python3-cffi-backend_1.17.1-2build1_armhf.deb ... 2209s Unpacking python3-cffi-backend:armhf (1.17.1-2build1) over (1.17.1-2) ... 2209s Selecting previously unselected package libassuan9:armhf. 2209s Preparing to unpack .../libassuan9_3.0.1-2_armhf.deb ... 2209s Unpacking libassuan9:armhf (3.0.1-2) ... 2209s Preparing to unpack .../libgpgme11t64_1.24.0-2ubuntu1_armhf.deb ... 2209s Unpacking libgpgme11t64:armhf (1.24.0-2ubuntu1) over (1.23.2-5ubuntu4) ... 2209s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_armhf.deb ... 2209s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 2209s Setting up python3-markupsafe (2.1.5-1build3) ... 2209s Setting up libassuan9:armhf (3.0.1-2) ... 2209s Setting up libgpgme11t64:armhf (1.24.0-2ubuntu1) ... 2209s Setting up python3-cffi-backend:armhf (1.17.1-2build1) ... 2209s Processing triggers for libc-bin (2.40-1ubuntu3) ... 2210s Reading package lists... 2210s Building dependency tree... 2210s Reading state information... 2212s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2214s autopkgtest [22:16:13]: rebooting testbed after setup commands that affected boot 2314s Reading package lists... 2314s Building dependency tree... 2314s Reading state information... 2315s Starting pkgProblemResolver with broken count: 0 2315s Starting 2 pkgProblemResolver with broken count: 0 2315s Done 2316s The following NEW packages will be installed: 2316s autopkgtest-satdep 2316s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 2316s Need to get 0 B/720 B of archives. 2316s After this operation, 0 B of additional disk space will be used. 2316s Get:1 /tmp/autopkgtest.0dhFo8/3-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 2317s Selecting previously unselected package autopkgtest-satdep. 2317s (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 ... 59573 files and directories currently installed.) 2317s Preparing to unpack .../3-autopkgtest-satdep.deb ... 2317s Unpacking autopkgtest-satdep (0) ... 2317s Setting up autopkgtest-satdep (0) ... 2329s (Reading database ... 59573 files and directories currently installed.) 2329s Removing autopkgtest-satdep (0) ... 2340s autopkgtest [22:18:19]: test systemd-socket-activation: [----------------------- 2343s Stopping ssh.service... 2343s Checking that ssh.socket is active and listening... 2343s Checking that ssh.service is inactive/dead... 2343s Checking that a connection attempt activates ssh.service... 2343s Warning: Permanently added 'localhost' (ED25519) to the list of known hosts. 2343s Checking that sshd can be re-executed... 2343s Checking sshd can run in debug mode... 2344s debug1: SELinux support disabled 2344s debug1: PAM: reinitializing credentials 2344s debug1: permanently_set_uid: 0/0 2344s debug3: Copy environment: XDG_SESSION_ID=23639 2344s debug3: Copy environment: XDG_RUNTIME_DIR=/run/user/0 2344s debug3: Copy environment: DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/0/bus 2344s debug3: Copy environment: XDG_SESSION_TYPE=tty 2344s debug3: Copy environment: XDG_SESSION_CLASS=user 2344s debug3: Copy environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin 2344s debug3: Copy environment: http_proxy=http://squid.internal:3128 2344s debug3: Copy environment: https_proxy=http://squid.internal:3128 2344s debug3: Copy environment: no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com 2344s debug3: Copy environment: LANG=C.UTF-8 2344s Environment: 2344s LANG=C.UTF-8 2344s USER=root 2344s LOGNAME=root 2344s HOME=/root 2344s PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin 2344s SHELL=/bin/bash 2344s XDG_SESSION_ID=23639 2344s XDG_RUNTIME_DIR=/run/user/0 2344s DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/0/bus 2344s XDG_SESSION_TYPE=tty 2344s XDG_SESSION_CLASS=user 2344s http_proxy=http://squid.internal:3128 2344s https_proxy=http://squid.internal:3128 2344s no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.c 2344s SSH_CLIENT=127.0.0.1 41530 22 2344s SSH_CONNECTION=127.0.0.1 41530 127.0.0.1 22 2344s Done. 2344s autopkgtest [22:18:23]: test systemd-socket-activation: -----------------------] 2348s autopkgtest [22:18:27]: test systemd-socket-activation: - - - - - - - - - - results - - - - - - - - - - 2348s systemd-socket-activation PASS 2351s autopkgtest [22:18:30]: test sshd-socket-generator: preparing testbed 2361s Reading package lists... 2361s Building dependency tree... 2361s Reading state information... 2362s Starting pkgProblemResolver with broken count: 0 2362s Starting 2 pkgProblemResolver with broken count: 0 2362s Done 2363s The following NEW packages will be installed: 2363s autopkgtest-satdep 2363s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 2363s Need to get 0 B/720 B of archives. 2363s After this operation, 0 B of additional disk space will be used. 2363s Get:1 /tmp/autopkgtest.0dhFo8/4-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 2364s Selecting previously unselected package autopkgtest-satdep. 2364s (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 ... 59573 files and directories currently installed.) 2364s Preparing to unpack .../4-autopkgtest-satdep.deb ... 2364s Unpacking autopkgtest-satdep (0) ... 2364s Setting up autopkgtest-satdep (0) ... 2376s (Reading database ... 59573 files and directories currently installed.) 2376s Removing autopkgtest-satdep (0) ... 2382s autopkgtest [22:19:01]: test sshd-socket-generator: [----------------------- 2384s test_default...PASS 2384s test_custom_port...PASS 2384s test_default_and_custom_port...PASS 2384s test_mutiple_custom_ports...PASS 2384s test_custom_listenaddress...PASS 2384s test_custom_listenaddress_and_port...PASS 2384s test_custom_ipv6_listenaddress...PASS 2384s test_custom_family_ipv4...PASS 2384s test_custom_family_ipv6...PASS 2384s test_custom_port_and_family_ipv4...PASS 2384s test_custom_port_and_family_ipv6...PASS 2384s test_match_on_port...PASS 2384s autopkgtest [22:19:03]: test sshd-socket-generator: -----------------------] 2388s autopkgtest [22:19:07]: test sshd-socket-generator: - - - - - - - - - - results - - - - - - - - - - 2388s sshd-socket-generator PASS 2392s autopkgtest [22:19:11]: @@@@@@@@@@@@@@@@@@@@ summary 2392s regress PASS 2392s ssh-gssapi PASS 2392s systemd-socket-activation PASS 2392s sshd-socket-generator PASS