0s autopkgtest [19:37:59]: starting date and time: 2024-11-15 19:37:59+0000 0s autopkgtest [19:37:59]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [19:37:59]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.rt7czxkj/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:audit --apt-upgrade openssh --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=audit/1:4.0.2-2ubuntu1 -- lxd -r lxd-armhf-10.145.243.227 lxd-armhf-10.145.243.227:autopkgtest/ubuntu/plucky/armhf 53s autopkgtest [19:38:52]: testbed dpkg architecture: armhf 55s autopkgtest [19:38:54]: testbed apt version: 2.9.8 55s autopkgtest [19:38:54]: @@@@@@@@@@@@@@@@@@@@ test bed setup 62s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 62s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 62s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 62s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [91.9 kB] 63s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1054 kB] 63s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [144 kB] 63s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [756 kB] 63s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [4428 B] 63s Fetched 2146 kB in 1s (2147 kB/s) 63s Reading package lists... 80s tee: /proc/self/fd/2: Permission denied 103s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 103s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 103s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 103s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 104s Reading package lists... 104s Reading package lists... 105s Building dependency tree... 105s Reading state information... 105s Calculating upgrade... 106s The following NEW packages will be installed: 106s libassuan9 106s The following packages will be upgraded: 106s libaudit-common libaudit1 libgpgme11t64 libseccomp2 python3-cffi-backend 106s python3-markupsafe 106s 6 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 106s Need to get 351 kB of archives. 106s After this operation, 224 kB of additional disk space will be used. 106s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libaudit-common all 1:4.0.2-2ubuntu1 [6578 B] 106s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libaudit1 armhf 1:4.0.2-2ubuntu1 [47.5 kB] 106s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libseccomp2 armhf 2.5.5-1ubuntu5 [49.3 kB] 106s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf python3-cffi-backend armhf 1.17.1-2build1 [75.9 kB] 106s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf libassuan9 armhf 3.0.1-2 [34.3 kB] 106s Get:6 http://ftpmaster.internal/ubuntu plucky/main armhf libgpgme11t64 armhf 1.24.0-2ubuntu1 [125 kB] 106s Get:7 http://ftpmaster.internal/ubuntu plucky/main armhf python3-markupsafe armhf 2.1.5-1build3 [12.5 kB] 107s Fetched 351 kB in 0s (739 kB/s) 107s (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.) 107s Preparing to unpack .../libaudit-common_1%3a4.0.2-2ubuntu1_all.deb ... 107s Unpacking libaudit-common (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 107s Setting up libaudit-common (1:4.0.2-2ubuntu1) ... 107s (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.) 107s Preparing to unpack .../libaudit1_1%3a4.0.2-2ubuntu1_armhf.deb ... 107s Unpacking libaudit1:armhf (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 107s Setting up libaudit1:armhf (1:4.0.2-2ubuntu1) ... 107s (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.) 107s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu5_armhf.deb ... 107s Unpacking libseccomp2:armhf (2.5.5-1ubuntu5) over (2.5.5-1ubuntu4) ... 107s Setting up libseccomp2:armhf (2.5.5-1ubuntu5) ... 107s (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.) 107s Preparing to unpack .../python3-cffi-backend_1.17.1-2build1_armhf.deb ... 107s Unpacking python3-cffi-backend:armhf (1.17.1-2build1) over (1.17.1-2) ... 107s Selecting previously unselected package libassuan9:armhf. 107s Preparing to unpack .../libassuan9_3.0.1-2_armhf.deb ... 107s Unpacking libassuan9:armhf (3.0.1-2) ... 107s Preparing to unpack .../libgpgme11t64_1.24.0-2ubuntu1_armhf.deb ... 107s Unpacking libgpgme11t64:armhf (1.24.0-2ubuntu1) over (1.23.2-5ubuntu4) ... 107s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_armhf.deb ... 107s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 107s Setting up python3-markupsafe (2.1.5-1build3) ... 108s Setting up libassuan9:armhf (3.0.1-2) ... 108s Setting up libgpgme11t64:armhf (1.24.0-2ubuntu1) ... 108s Setting up python3-cffi-backend:armhf (1.17.1-2build1) ... 108s Processing triggers for man-db (2.13.0-1) ... 108s Processing triggers for libc-bin (2.40-1ubuntu3) ... 108s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 111s autopkgtest [19:39:50]: rebooting testbed after setup commands that affected boot 180s autopkgtest [19:40:59]: 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 209s autopkgtest [19:41:28]: @@@@@@@@@@@@@@@@@@@@ apt-source openssh 240s Get:1 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (dsc) [3327 B] 240s Get:2 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (tar) [1849 kB] 240s Get:3 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (asc) [833 B] 240s Get:4 http://ftpmaster.internal/ubuntu plucky/main openssh 1:9.7p1-7ubuntu5 (diff) [208 kB] 240s gpgv: Signature made Wed Oct 30 12:49:43 2024 UTC 240s gpgv: using RSA key CED62F17BB727A48FC50762E2A15898770574541 240s gpgv: Can't check signature: No public key 240s dpkg-source: warning: cannot verify inline signature for ./openssh_9.7p1-7ubuntu5.dsc: no acceptable signature found 240s autopkgtest [19:41:59]: testing package openssh version 1:9.7p1-7ubuntu5 243s autopkgtest [19:42:02]: build not needed 246s autopkgtest [19:42:05]: test regress: preparing testbed 257s Reading package lists... 257s Building dependency tree... 257s Reading state information... 258s Starting pkgProblemResolver with broken count: 0 258s Starting 2 pkgProblemResolver with broken count: 0 258s Done 259s The following additional packages will be installed: 259s devscripts dropbear dropbear-bin haveged libb-hooks-op-check-perl 259s libclass-method-modifiers-perl libclass-xsaccessor-perl libclone-perl 259s libdevel-callchecker-perl libdynaloader-functions-perl libencode-locale-perl 259s libfile-dirlist-perl libfile-homedir-perl libfile-listing-perl 259s libfile-touch-perl libfile-which-perl libhavege2 libhtml-parser-perl 259s libhtml-tagset-perl libhtml-tree-perl libhttp-cookies-perl libhttp-date-perl 259s libhttp-message-perl libhttp-negotiate-perl libimport-into-perl 259s libio-html-perl libio-pty-perl libio-socket-ssl-perl libipc-run-perl 259s liblwp-mediatypes-perl liblwp-protocol-https-perl libmodule-runtime-perl 259s libmoo-perl libnet-http-perl libnet-ssleay-perl libparams-classify-perl 259s librole-tiny-perl libsub-quote-perl libtimedate-perl libtomcrypt1 259s libtommath1 libtry-tiny-perl liburi-perl libwww-perl libwww-robotrules-perl 259s openssh-tests patchutils perl-openssl-defaults putty-tools python3-automat 259s python3-bcrypt python3-constantly python3-hamcrest python3-hyperlink 259s python3-incremental python3-pyasn1 python3-pyasn1-modules 259s python3-service-identity python3-twisted python3-zope.interface wdiff 259s Suggested packages: 259s adequate at autopkgtest bls-standalone bsd-mailx | mailx build-essential 259s check-all-the-things cvs-buildpackage debhelper diffoscope disorderfs 259s docker.io dose-extra duck elpa-devscripts faketime gnuplot how-can-i-help 259s libauthen-sasl-perl libdbd-pg-perl libfile-desktopentry-perl 259s libterm-size-perl libyaml-syck-perl mmdebstrap mutt piuparts 259s postgresql-client pristine-lfs python3-debianbts python3-pycurl quilt ratt 259s reprotest svn-buildpackage w3m debian-keyring equivs libgitlab-api-v4-perl 259s libsoap-lite-perl pristine-tar dropbear-initramfs runit libdata-dump-perl 259s libio-compress-brotli-perl libcrypt-ssleay-perl libscalar-number-perl 259s libxstring-perl libsub-name-perl libbusiness-isbn-perl libregexp-ipv6-perl 259s libauthen-ntlm-perl putty-doc python3-pampy python3-tk python3-wxgtk4.0 259s wdiff-doc 259s Recommended packages: 259s dctrl-tools dput | dupload libdistro-info-perl libgit-wrapper-perl 259s libjson-perl liblist-compare-perl libstring-shellquote-perl licensecheck 259s lintian python3-debian python3-magic python3-unidiff python3-xdg unzip 259s libhtml-format-perl libnamespace-clean-perl libdata-dump-perl 259s libhtml-form-perl libhttp-daemon-perl libmailtools-perl python3-click 259s The following NEW packages will be installed: 259s autopkgtest-satdep devscripts dropbear dropbear-bin haveged 259s libb-hooks-op-check-perl libclass-method-modifiers-perl 259s libclass-xsaccessor-perl libclone-perl libdevel-callchecker-perl 259s libdynaloader-functions-perl libencode-locale-perl libfile-dirlist-perl 259s libfile-homedir-perl libfile-listing-perl libfile-touch-perl 259s libfile-which-perl libhavege2 libhtml-parser-perl libhtml-tagset-perl 259s libhtml-tree-perl libhttp-cookies-perl libhttp-date-perl 259s libhttp-message-perl libhttp-negotiate-perl libimport-into-perl 259s libio-html-perl libio-pty-perl libio-socket-ssl-perl libipc-run-perl 259s liblwp-mediatypes-perl liblwp-protocol-https-perl libmodule-runtime-perl 259s libmoo-perl libnet-http-perl libnet-ssleay-perl libparams-classify-perl 259s librole-tiny-perl libsub-quote-perl libtimedate-perl libtomcrypt1 259s libtommath1 libtry-tiny-perl liburi-perl libwww-perl libwww-robotrules-perl 259s openssh-tests patchutils perl-openssl-defaults putty-tools python3-automat 259s python3-bcrypt python3-constantly python3-hamcrest python3-hyperlink 259s python3-incremental python3-pyasn1 python3-pyasn1-modules 259s python3-service-identity python3-twisted python3-zope.interface wdiff 259s 0 upgraded, 62 newly installed, 0 to remove and 0 not upgraded. 259s Need to get 8149 kB/8150 kB of archives. 259s After this operation, 33.3 MB of additional disk space will be used. 259s Get:1 /tmp/autopkgtest.bx8bVp/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [768 B] 259s Get:2 http://ftpmaster.internal/ubuntu plucky/universe armhf libtommath1 armhf 1.3.0-1 [45.8 kB] 259s Get:3 http://ftpmaster.internal/ubuntu plucky/universe armhf libtomcrypt1 armhf 1.18.2+dfsg-7build1 [377 kB] 259s Get:4 http://ftpmaster.internal/ubuntu plucky/universe armhf dropbear-bin armhf 2024.85-3 [117 kB] 259s Get:5 http://ftpmaster.internal/ubuntu plucky/universe armhf dropbear all 2024.85-3 [8668 B] 259s Get:6 http://ftpmaster.internal/ubuntu plucky/universe armhf libhavege2 armhf 1.9.14-1ubuntu2 [23.6 kB] 259s Get:7 http://ftpmaster.internal/ubuntu plucky/universe armhf haveged armhf 1.9.14-1ubuntu2 [33.1 kB] 259s Get:8 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-dirlist-perl all 0.05-3 [7286 B] 259s Get:9 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-which-perl all 1.27-2 [12.5 kB] 259s Get:10 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-homedir-perl all 1.006-2 [37.0 kB] 259s Get:11 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-touch-perl all 0.12-2 [7498 B] 259s Get:12 http://ftpmaster.internal/ubuntu plucky/main armhf libio-pty-perl armhf 1:1.20-1build3 [31.0 kB] 259s Get:13 http://ftpmaster.internal/ubuntu plucky/main armhf libipc-run-perl all 20231003.0-2 [91.5 kB] 259s Get:14 http://ftpmaster.internal/ubuntu plucky/main armhf libclass-method-modifiers-perl all 2.15-1 [16.1 kB] 259s Get:15 http://ftpmaster.internal/ubuntu plucky/main armhf libclass-xsaccessor-perl armhf 1.19-4build5 [32.3 kB] 259s Get:16 http://ftpmaster.internal/ubuntu plucky/main armhf libb-hooks-op-check-perl armhf 0.22-3build2 [9174 B] 259s Get:17 http://ftpmaster.internal/ubuntu plucky/main armhf libdynaloader-functions-perl all 0.004-1 [11.4 kB] 259s Get:18 http://ftpmaster.internal/ubuntu plucky/main armhf libdevel-callchecker-perl armhf 0.009-1build1 [14.0 kB] 259s Get:19 http://ftpmaster.internal/ubuntu plucky/main armhf libparams-classify-perl armhf 0.015-2build6 [18.8 kB] 259s Get:20 http://ftpmaster.internal/ubuntu plucky/main armhf libmodule-runtime-perl all 0.016-2 [16.4 kB] 259s Get:21 http://ftpmaster.internal/ubuntu plucky/main armhf libimport-into-perl all 1.002005-2 [10.7 kB] 259s Get:22 http://ftpmaster.internal/ubuntu plucky/main armhf librole-tiny-perl all 2.002004-1 [16.3 kB] 259s Get:23 http://ftpmaster.internal/ubuntu plucky/main armhf libsub-quote-perl all 2.006008-1ubuntu1 [20.7 kB] 259s Get:24 http://ftpmaster.internal/ubuntu plucky/main armhf libmoo-perl all 2.005005-1 [47.4 kB] 259s Get:25 http://ftpmaster.internal/ubuntu plucky/main armhf libencode-locale-perl all 1.05-3 [11.6 kB] 260s Get:26 http://ftpmaster.internal/ubuntu plucky/main armhf libtimedate-perl all 2.3300-2 [34.0 kB] 260s Get:27 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-date-perl all 6.06-1 [10.2 kB] 260s Get:28 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-listing-perl all 6.16-1 [11.3 kB] 260s Get:29 http://ftpmaster.internal/ubuntu plucky/main armhf libhtml-tagset-perl all 3.24-1 [14.1 kB] 260s Get:30 http://ftpmaster.internal/ubuntu plucky/main armhf liburi-perl all 5.28-1 [88.1 kB] 260s Get:31 http://ftpmaster.internal/ubuntu plucky/main armhf libhtml-parser-perl armhf 3.83-1build1 [83.1 kB] 260s Get:32 http://ftpmaster.internal/ubuntu plucky/main armhf libhtml-tree-perl all 5.07-3 [200 kB] 260s Get:33 http://ftpmaster.internal/ubuntu plucky/main armhf libclone-perl armhf 0.47-1 [10.0 kB] 260s Get:34 http://ftpmaster.internal/ubuntu plucky/main armhf libio-html-perl all 1.004-3 [15.9 kB] 260s Get:35 http://ftpmaster.internal/ubuntu plucky/main armhf liblwp-mediatypes-perl all 6.04-2 [20.1 kB] 260s Get:36 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-message-perl all 7.00-2ubuntu1 [75.9 kB] 260s Get:37 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-cookies-perl all 6.11-1 [18.2 kB] 260s Get:38 http://ftpmaster.internal/ubuntu plucky/main armhf libhttp-negotiate-perl all 6.01-2 [12.4 kB] 260s Get:39 http://ftpmaster.internal/ubuntu plucky/main armhf perl-openssl-defaults armhf 7build3 [6628 B] 260s Get:40 http://ftpmaster.internal/ubuntu plucky/main armhf libnet-ssleay-perl armhf 1.94-2 [298 kB] 260s Get:41 http://ftpmaster.internal/ubuntu plucky/main armhf libio-socket-ssl-perl all 2.089-1 [200 kB] 260s Get:42 http://ftpmaster.internal/ubuntu plucky/main armhf libnet-http-perl all 6.23-1 [22.3 kB] 260s Get:43 http://ftpmaster.internal/ubuntu plucky/main armhf liblwp-protocol-https-perl all 6.14-1 [9040 B] 260s Get:44 http://ftpmaster.internal/ubuntu plucky/main armhf libtry-tiny-perl all 0.32-1 [21.2 kB] 260s Get:45 http://ftpmaster.internal/ubuntu plucky/main armhf libwww-robotrules-perl all 6.02-1 [12.6 kB] 260s Get:46 http://ftpmaster.internal/ubuntu plucky/main armhf libwww-perl all 6.77-1 [138 kB] 260s Get:47 http://ftpmaster.internal/ubuntu plucky/main armhf patchutils armhf 0.4.2-1build3 [73.2 kB] 260s Get:48 http://ftpmaster.internal/ubuntu plucky/main armhf wdiff armhf 1.2.2-6build1 [29.0 kB] 260s Get:49 http://ftpmaster.internal/ubuntu plucky/main armhf devscripts all 2.24.3 [1080 kB] 260s Get:50 http://ftpmaster.internal/ubuntu plucky/universe armhf putty-tools armhf 0.81-2 [566 kB] 260s Get:51 http://ftpmaster.internal/ubuntu plucky/main armhf python3-bcrypt armhf 4.2.0-1 [218 kB] 260s Get:52 http://ftpmaster.internal/ubuntu plucky/main armhf python3-hamcrest all 2.1.0-1 [28.1 kB] 260s Get:53 http://ftpmaster.internal/ubuntu plucky/main armhf python3-pyasn1 all 0.6.0-1 [57.8 kB] 260s Get:54 http://ftpmaster.internal/ubuntu plucky/main armhf python3-pyasn1-modules all 0.4.1-1 [80.2 kB] 260s Get:55 http://ftpmaster.internal/ubuntu plucky/main armhf python3-service-identity all 24.1.0-1 [11.2 kB] 260s Get:56 http://ftpmaster.internal/ubuntu plucky/main armhf python3-automat all 24.8.1-1 [35.5 kB] 260s Get:57 http://ftpmaster.internal/ubuntu plucky/main armhf python3-constantly all 23.10.4-2 [13.9 kB] 260s Get:58 http://ftpmaster.internal/ubuntu plucky/main armhf python3-hyperlink all 21.0.0-6 [68.0 kB] 260s Get:59 http://ftpmaster.internal/ubuntu plucky/main armhf python3-incremental all 24.7.2-2 [18.5 kB] 260s Get:60 http://ftpmaster.internal/ubuntu plucky/main armhf python3-zope.interface armhf 7.1.1-1build1 [138 kB] 260s Get:61 http://ftpmaster.internal/ubuntu plucky/main armhf python3-twisted all 24.10.0-1 [2067 kB] 260s Get:62 http://ftpmaster.internal/ubuntu plucky/universe armhf openssh-tests armhf 1:9.7p1-7ubuntu5 [1344 kB] 261s Fetched 8149 kB in 1s (6089 kB/s) 261s Selecting previously unselected package libtommath1:armhf. 261s (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.) 261s Preparing to unpack .../00-libtommath1_1.3.0-1_armhf.deb ... 261s Unpacking libtommath1:armhf (1.3.0-1) ... 261s Selecting previously unselected package libtomcrypt1:armhf. 261s Preparing to unpack .../01-libtomcrypt1_1.18.2+dfsg-7build1_armhf.deb ... 261s Unpacking libtomcrypt1:armhf (1.18.2+dfsg-7build1) ... 261s Selecting previously unselected package dropbear-bin. 261s Preparing to unpack .../02-dropbear-bin_2024.85-3_armhf.deb ... 261s Unpacking dropbear-bin (2024.85-3) ... 261s Selecting previously unselected package dropbear. 261s Preparing to unpack .../03-dropbear_2024.85-3_all.deb ... 261s Unpacking dropbear (2024.85-3) ... 261s Selecting previously unselected package libhavege2:armhf. 261s Preparing to unpack .../04-libhavege2_1.9.14-1ubuntu2_armhf.deb ... 261s Unpacking libhavege2:armhf (1.9.14-1ubuntu2) ... 261s Selecting previously unselected package haveged. 261s Preparing to unpack .../05-haveged_1.9.14-1ubuntu2_armhf.deb ... 261s Unpacking haveged (1.9.14-1ubuntu2) ... 261s Selecting previously unselected package libfile-dirlist-perl. 261s Preparing to unpack .../06-libfile-dirlist-perl_0.05-3_all.deb ... 261s Unpacking libfile-dirlist-perl (0.05-3) ... 261s Selecting previously unselected package libfile-which-perl. 261s Preparing to unpack .../07-libfile-which-perl_1.27-2_all.deb ... 261s Unpacking libfile-which-perl (1.27-2) ... 261s Selecting previously unselected package libfile-homedir-perl. 261s Preparing to unpack .../08-libfile-homedir-perl_1.006-2_all.deb ... 261s Unpacking libfile-homedir-perl (1.006-2) ... 261s Selecting previously unselected package libfile-touch-perl. 261s Preparing to unpack .../09-libfile-touch-perl_0.12-2_all.deb ... 261s Unpacking libfile-touch-perl (0.12-2) ... 261s Selecting previously unselected package libio-pty-perl. 261s Preparing to unpack .../10-libio-pty-perl_1%3a1.20-1build3_armhf.deb ... 261s Unpacking libio-pty-perl (1:1.20-1build3) ... 261s Selecting previously unselected package libipc-run-perl. 261s Preparing to unpack .../11-libipc-run-perl_20231003.0-2_all.deb ... 261s Unpacking libipc-run-perl (20231003.0-2) ... 261s Selecting previously unselected package libclass-method-modifiers-perl. 261s Preparing to unpack .../12-libclass-method-modifiers-perl_2.15-1_all.deb ... 261s Unpacking libclass-method-modifiers-perl (2.15-1) ... 261s Selecting previously unselected package libclass-xsaccessor-perl. 261s Preparing to unpack .../13-libclass-xsaccessor-perl_1.19-4build5_armhf.deb ... 261s Unpacking libclass-xsaccessor-perl (1.19-4build5) ... 261s Selecting previously unselected package libb-hooks-op-check-perl:armhf. 261s Preparing to unpack .../14-libb-hooks-op-check-perl_0.22-3build2_armhf.deb ... 261s Unpacking libb-hooks-op-check-perl:armhf (0.22-3build2) ... 261s Selecting previously unselected package libdynaloader-functions-perl. 261s Preparing to unpack .../15-libdynaloader-functions-perl_0.004-1_all.deb ... 261s Unpacking libdynaloader-functions-perl (0.004-1) ... 261s Selecting previously unselected package libdevel-callchecker-perl:armhf. 261s Preparing to unpack .../16-libdevel-callchecker-perl_0.009-1build1_armhf.deb ... 261s Unpacking libdevel-callchecker-perl:armhf (0.009-1build1) ... 261s Selecting previously unselected package libparams-classify-perl:armhf. 261s Preparing to unpack .../17-libparams-classify-perl_0.015-2build6_armhf.deb ... 261s Unpacking libparams-classify-perl:armhf (0.015-2build6) ... 261s Selecting previously unselected package libmodule-runtime-perl. 261s Preparing to unpack .../18-libmodule-runtime-perl_0.016-2_all.deb ... 261s Unpacking libmodule-runtime-perl (0.016-2) ... 261s Selecting previously unselected package libimport-into-perl. 261s Preparing to unpack .../19-libimport-into-perl_1.002005-2_all.deb ... 261s Unpacking libimport-into-perl (1.002005-2) ... 261s Selecting previously unselected package librole-tiny-perl. 261s Preparing to unpack .../20-librole-tiny-perl_2.002004-1_all.deb ... 261s Unpacking librole-tiny-perl (2.002004-1) ... 261s Selecting previously unselected package libsub-quote-perl. 261s Preparing to unpack .../21-libsub-quote-perl_2.006008-1ubuntu1_all.deb ... 261s Unpacking libsub-quote-perl (2.006008-1ubuntu1) ... 261s Selecting previously unselected package libmoo-perl. 261s Preparing to unpack .../22-libmoo-perl_2.005005-1_all.deb ... 261s Unpacking libmoo-perl (2.005005-1) ... 261s Selecting previously unselected package libencode-locale-perl. 261s Preparing to unpack .../23-libencode-locale-perl_1.05-3_all.deb ... 261s Unpacking libencode-locale-perl (1.05-3) ... 261s Selecting previously unselected package libtimedate-perl. 261s Preparing to unpack .../24-libtimedate-perl_2.3300-2_all.deb ... 261s Unpacking libtimedate-perl (2.3300-2) ... 261s Selecting previously unselected package libhttp-date-perl. 261s Preparing to unpack .../25-libhttp-date-perl_6.06-1_all.deb ... 261s Unpacking libhttp-date-perl (6.06-1) ... 261s Selecting previously unselected package libfile-listing-perl. 262s Preparing to unpack .../26-libfile-listing-perl_6.16-1_all.deb ... 262s Unpacking libfile-listing-perl (6.16-1) ... 262s Selecting previously unselected package libhtml-tagset-perl. 262s Preparing to unpack .../27-libhtml-tagset-perl_3.24-1_all.deb ... 262s Unpacking libhtml-tagset-perl (3.24-1) ... 262s Selecting previously unselected package liburi-perl. 262s Preparing to unpack .../28-liburi-perl_5.28-1_all.deb ... 262s Unpacking liburi-perl (5.28-1) ... 262s Selecting previously unselected package libhtml-parser-perl:armhf. 262s Preparing to unpack .../29-libhtml-parser-perl_3.83-1build1_armhf.deb ... 262s Unpacking libhtml-parser-perl:armhf (3.83-1build1) ... 262s Selecting previously unselected package libhtml-tree-perl. 262s Preparing to unpack .../30-libhtml-tree-perl_5.07-3_all.deb ... 262s Unpacking libhtml-tree-perl (5.07-3) ... 262s Selecting previously unselected package libclone-perl:armhf. 262s Preparing to unpack .../31-libclone-perl_0.47-1_armhf.deb ... 262s Unpacking libclone-perl:armhf (0.47-1) ... 262s Selecting previously unselected package libio-html-perl. 262s Preparing to unpack .../32-libio-html-perl_1.004-3_all.deb ... 262s Unpacking libio-html-perl (1.004-3) ... 262s Selecting previously unselected package liblwp-mediatypes-perl. 262s Preparing to unpack .../33-liblwp-mediatypes-perl_6.04-2_all.deb ... 262s Unpacking liblwp-mediatypes-perl (6.04-2) ... 262s Selecting previously unselected package libhttp-message-perl. 262s Preparing to unpack .../34-libhttp-message-perl_7.00-2ubuntu1_all.deb ... 262s Unpacking libhttp-message-perl (7.00-2ubuntu1) ... 262s Selecting previously unselected package libhttp-cookies-perl. 262s Preparing to unpack .../35-libhttp-cookies-perl_6.11-1_all.deb ... 262s Unpacking libhttp-cookies-perl (6.11-1) ... 262s Selecting previously unselected package libhttp-negotiate-perl. 262s Preparing to unpack .../36-libhttp-negotiate-perl_6.01-2_all.deb ... 262s Unpacking libhttp-negotiate-perl (6.01-2) ... 262s Selecting previously unselected package perl-openssl-defaults:armhf. 262s Preparing to unpack .../37-perl-openssl-defaults_7build3_armhf.deb ... 262s Unpacking perl-openssl-defaults:armhf (7build3) ... 262s Selecting previously unselected package libnet-ssleay-perl:armhf. 262s Preparing to unpack .../38-libnet-ssleay-perl_1.94-2_armhf.deb ... 262s Unpacking libnet-ssleay-perl:armhf (1.94-2) ... 262s Selecting previously unselected package libio-socket-ssl-perl. 262s Preparing to unpack .../39-libio-socket-ssl-perl_2.089-1_all.deb ... 262s Unpacking libio-socket-ssl-perl (2.089-1) ... 262s Selecting previously unselected package libnet-http-perl. 262s Preparing to unpack .../40-libnet-http-perl_6.23-1_all.deb ... 262s Unpacking libnet-http-perl (6.23-1) ... 262s Selecting previously unselected package liblwp-protocol-https-perl. 262s Preparing to unpack .../41-liblwp-protocol-https-perl_6.14-1_all.deb ... 262s Unpacking liblwp-protocol-https-perl (6.14-1) ... 262s Selecting previously unselected package libtry-tiny-perl. 262s Preparing to unpack .../42-libtry-tiny-perl_0.32-1_all.deb ... 262s Unpacking libtry-tiny-perl (0.32-1) ... 262s Selecting previously unselected package libwww-robotrules-perl. 262s Preparing to unpack .../43-libwww-robotrules-perl_6.02-1_all.deb ... 262s Unpacking libwww-robotrules-perl (6.02-1) ... 262s Selecting previously unselected package libwww-perl. 262s Preparing to unpack .../44-libwww-perl_6.77-1_all.deb ... 262s Unpacking libwww-perl (6.77-1) ... 262s Selecting previously unselected package patchutils. 262s Preparing to unpack .../45-patchutils_0.4.2-1build3_armhf.deb ... 262s Unpacking patchutils (0.4.2-1build3) ... 262s Selecting previously unselected package wdiff. 262s Preparing to unpack .../46-wdiff_1.2.2-6build1_armhf.deb ... 262s Unpacking wdiff (1.2.2-6build1) ... 262s Selecting previously unselected package devscripts. 262s Preparing to unpack .../47-devscripts_2.24.3_all.deb ... 262s Unpacking devscripts (2.24.3) ... 262s Selecting previously unselected package putty-tools. 262s Preparing to unpack .../48-putty-tools_0.81-2_armhf.deb ... 262s Unpacking putty-tools (0.81-2) ... 262s Selecting previously unselected package python3-bcrypt. 262s Preparing to unpack .../49-python3-bcrypt_4.2.0-1_armhf.deb ... 262s Unpacking python3-bcrypt (4.2.0-1) ... 262s Selecting previously unselected package python3-hamcrest. 262s Preparing to unpack .../50-python3-hamcrest_2.1.0-1_all.deb ... 262s Unpacking python3-hamcrest (2.1.0-1) ... 262s Selecting previously unselected package python3-pyasn1. 262s Preparing to unpack .../51-python3-pyasn1_0.6.0-1_all.deb ... 262s Unpacking python3-pyasn1 (0.6.0-1) ... 262s Selecting previously unselected package python3-pyasn1-modules. 262s Preparing to unpack .../52-python3-pyasn1-modules_0.4.1-1_all.deb ... 262s Unpacking python3-pyasn1-modules (0.4.1-1) ... 263s Selecting previously unselected package python3-service-identity. 263s Preparing to unpack .../53-python3-service-identity_24.1.0-1_all.deb ... 263s Unpacking python3-service-identity (24.1.0-1) ... 263s Selecting previously unselected package python3-automat. 263s Preparing to unpack .../54-python3-automat_24.8.1-1_all.deb ... 263s Unpacking python3-automat (24.8.1-1) ... 263s Selecting previously unselected package python3-constantly. 263s Preparing to unpack .../55-python3-constantly_23.10.4-2_all.deb ... 263s Unpacking python3-constantly (23.10.4-2) ... 263s Selecting previously unselected package python3-hyperlink. 263s Preparing to unpack .../56-python3-hyperlink_21.0.0-6_all.deb ... 263s Unpacking python3-hyperlink (21.0.0-6) ... 263s Selecting previously unselected package python3-incremental. 263s Preparing to unpack .../57-python3-incremental_24.7.2-2_all.deb ... 263s Unpacking python3-incremental (24.7.2-2) ... 263s Selecting previously unselected package python3-zope.interface. 263s Preparing to unpack .../58-python3-zope.interface_7.1.1-1build1_armhf.deb ... 263s Unpacking python3-zope.interface (7.1.1-1build1) ... 263s Selecting previously unselected package python3-twisted. 263s Preparing to unpack .../59-python3-twisted_24.10.0-1_all.deb ... 263s Unpacking python3-twisted (24.10.0-1) ... 263s Selecting previously unselected package openssh-tests. 263s Preparing to unpack .../60-openssh-tests_1%3a9.7p1-7ubuntu5_armhf.deb ... 263s Unpacking openssh-tests (1:9.7p1-7ubuntu5) ... 263s Selecting previously unselected package autopkgtest-satdep. 263s Preparing to unpack .../61-1-autopkgtest-satdep.deb ... 263s Unpacking autopkgtest-satdep (0) ... 263s Setting up wdiff (1.2.2-6build1) ... 263s Setting up libfile-which-perl (1.27-2) ... 263s Setting up libdynaloader-functions-perl (0.004-1) ... 263s Setting up libclass-method-modifiers-perl (2.15-1) ... 263s Setting up libio-pty-perl (1:1.20-1build3) ... 263s Setting up python3-zope.interface (7.1.1-1build1) ... 263s Setting up libclone-perl:armhf (0.47-1) ... 263s Setting up libtommath1:armhf (1.3.0-1) ... 263s Setting up libhtml-tagset-perl (3.24-1) ... 263s Setting up python3-bcrypt (4.2.0-1) ... 263s Setting up python3-automat (24.8.1-1) ... 264s Setting up liblwp-mediatypes-perl (6.04-2) ... 264s Setting up libtry-tiny-perl (0.32-1) ... 264s Setting up perl-openssl-defaults:armhf (7build3) ... 264s Setting up libencode-locale-perl (1.05-3) ... 264s Setting up python3-hamcrest (2.1.0-1) ... 264s Setting up putty-tools (0.81-2) ... 264s Setting up libhavege2:armhf (1.9.14-1ubuntu2) ... 264s Setting up patchutils (0.4.2-1build3) ... 264s Setting up python3-incremental (24.7.2-2) ... 264s Setting up python3-hyperlink (21.0.0-6) ... 264s Setting up libio-html-perl (1.004-3) ... 264s Setting up libb-hooks-op-check-perl:armhf (0.22-3build2) ... 264s Setting up libipc-run-perl (20231003.0-2) ... 264s Setting up libtimedate-perl (2.3300-2) ... 264s Setting up librole-tiny-perl (2.002004-1) ... 264s Setting up python3-pyasn1 (0.6.0-1) ... 264s Setting up python3-constantly (23.10.4-2) ... 264s Setting up libsub-quote-perl (2.006008-1ubuntu1) ... 264s Setting up libclass-xsaccessor-perl (1.19-4build5) ... 264s Setting up libfile-dirlist-perl (0.05-3) ... 264s Setting up libfile-homedir-perl (1.006-2) ... 264s Setting up liburi-perl (5.28-1) ... 264s Setting up libfile-touch-perl (0.12-2) ... 264s Setting up libnet-ssleay-perl:armhf (1.94-2) ... 264s Setting up libtomcrypt1:armhf (1.18.2+dfsg-7build1) ... 264s Setting up libhttp-date-perl (6.06-1) ... 264s Setting up haveged (1.9.14-1ubuntu2) ... 264s apparmor_parser: Unable to replace "/usr/sbin/haveged". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 264s 265s Created symlink '/etc/systemd/system/sysinit.target.wants/haveged.service' → '/usr/lib/systemd/system/haveged.service'. 265s Setting up dropbear-bin (2024.85-3) ... 265s Setting up libfile-listing-perl (6.16-1) ... 265s Setting up libnet-http-perl (6.23-1) ... 265s Setting up libdevel-callchecker-perl:armhf (0.009-1build1) ... 265s Setting up dropbear (2024.85-3) ... 265s Converting existing OpenSSH RSA host key to Dropbear format. 265s Key is a ssh-rsa key 265s Wrote key to '/etc/dropbear/dropbear_rsa_host_key' 265s 3072 SHA256:qVUVcysNsceZ3KEELYmQtjeF89P3K/z9yc29VYLo3nI /etc/dropbear/dropbear_rsa_host_key (RSA) 265s +---[RSA 3072]----+ 265s | .o o.X+.. | 265s | o + =.X.=.| 265s | . . = =.O .| 265s | . = + = . | 265s | S o o o o| 265s | o . .o| 265s | . . . o| 265s | ...Eo.o*| 265s | .o. o=O| 265s +----[SHA256]-----+ 265s Converting existing OpenSSH ECDSA host key to Dropbear format. 265s Key is a ecdsa-sha2-nistp256 key 265s Wrote key to '/etc/dropbear/dropbear_ecdsa_host_key' 265s 256 SHA256:cqkoOc9yOOJ/3yn45V68fP4uD6mvya87sYjPADz0Yfg /etc/dropbear/dropbear_ecdsa_host_key (ECDSA) 265s +---[ECDSA 256]---+ 265s | | 265s | . | 265s | o o | 265s | o + .. | 265s | +.ES | 265s | . .o+ .. . | 265s | +.. o....ooo | 265s |. +=.o o*.=o+o. | 265s |.o.=+ oo+B XX+=+ | 265s +----[SHA256]-----+ 265s Converting existing OpenSSH ED25519 host key to Dropbear format. 265s Key is a ssh-ed25519 key 265s Wrote key to '/etc/dropbear/dropbear_ed25519_host_key' 265s 256 SHA256:Li1f3Oi4NW3cIFBYvRrgpjxFTRLtfC2DktANG+bxZbs /etc/dropbear/dropbear_ed25519_host_key (ED25519) 265s +--[ED25519 256]--+ 265s | .BX+.o | 265s | .o=B+o.. | 265s | ++=...o | 265s | *.= =.. | 265s | . +S..+Eo | 265s | +o ..* o | 265s | o.o * = . | 265s | + = o | 265s | +.. | 265s +----[SHA256]-----+ 265s Created symlink '/etc/systemd/system/multi-user.target.wants/dropbear.service' → '/usr/lib/systemd/system/dropbear.service'. 266s Setting up python3-pyasn1-modules (0.4.1-1) ... 266s Setting up python3-service-identity (24.1.0-1) ... 266s Setting up libwww-robotrules-perl (6.02-1) ... 266s Setting up libhtml-parser-perl:armhf (3.83-1build1) ... 266s Setting up libio-socket-ssl-perl (2.089-1) ... 266s Setting up libhttp-message-perl (7.00-2ubuntu1) ... 266s Setting up libhttp-negotiate-perl (6.01-2) ... 266s Setting up libhttp-cookies-perl (6.11-1) ... 266s Setting up libhtml-tree-perl (5.07-3) ... 266s Setting up libparams-classify-perl:armhf (0.015-2build6) ... 266s Setting up libmodule-runtime-perl (0.016-2) ... 266s Setting up python3-twisted (24.10.0-1) ... 269s Setting up libimport-into-perl (1.002005-2) ... 269s Setting up libmoo-perl (2.005005-1) ... 269s Setting up openssh-tests (1:9.7p1-7ubuntu5) ... 269s Setting up liblwp-protocol-https-perl (6.14-1) ... 269s Setting up libwww-perl (6.77-1) ... 269s Setting up devscripts (2.24.3) ... 269s Setting up autopkgtest-satdep (0) ... 269s Processing triggers for libc-bin (2.40-1ubuntu3) ... 269s Processing triggers for man-db (2.13.0-1) ... 271s Processing triggers for install-info (7.1.1-1) ... 288s (Reading database ... 62749 files and directories currently installed.) 289s Removing autopkgtest-satdep (0) ... 294s autopkgtest [19:42:53]: test regress: [----------------------- 296s info: Adding user `openssh-tests' ... 296s info: Selecting UID/GID from range 1000 to 59999 ... 296s info: Adding new group `openssh-tests' (1001) ... 296s info: Adding new user `openssh-tests' (1001) with group `openssh-tests (1001)' ... 296s info: Creating home directory `/home/openssh-tests' ... 296s info: Copying files from `/etc/skel' ... 296s info: Adding new user `openssh-tests' to supplemental / extra groups `users' ... 296s info: Adding user `openssh-tests' to group `users' ... 297s Synchronizing state of haveged.service with SysV service script with /usr/lib/systemd/systemd-sysv-install. 297s Executing: /usr/lib/systemd/systemd-sysv-install enable haveged 297s I: annotate-output 2.24.3 297s I: prefix='%H:%M:%S.%N ' 297s 19:42:56.716609998 I: Started /usr/lib/openssh/regress/run-tests /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user 297s 19:42:56.842258964 O: make: Entering directory '/tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress' 297s 19:42:56.843626985 O: test "x" = "x" || mkdir -p /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/valgrind-out 297s 19:42:56.844556598 E: + /usr/bin/ssh -Q key 297s 19:42:56.845510173 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 297s 19:42:56.846586429 E: + grep -q ^ssh-rsa 297s 19:42:56.848270174 O: ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2.prv | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 297s 19:42:56.852051111 O: tr '\n' '\r' /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv ; \ 297s 19:42:56.857275229 O: ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 297s 19:42:56.862391866 O: awk '{print $0 "\r"}' /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2.prv > /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv ; \ 297s 19:42:56.864356016 O: ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv ; \ 297s 19:42:56.865589994 O: fi 297s 19:42:56.869696976 E: + ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2.prv 297s 19:42:56.871025356 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv 297s 19:42:56.875903229 E: + tr \n \r 297s 19:42:56.877548334 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv 297s 19:42:56.903341681 E: + ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2_cr.prv 297s 19:42:56.909902139 E: + awk {print $0 "\r"} /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2.prv 297s 19:42:56.912367896 E: + ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_ssh2_crnl.prv 297s 19:42:56.913574714 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv 297s 19:42:56.918588070 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 297s 19:42:56.919493523 E: + /usr/bin/ssh -Q key 297s 19:42:56.919932730 O: cat /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv > /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t2.out ; \ 297s 19:42:56.920659101 E: + grep -q ^ssh-rsa 297s 19:42:56.921197509 O: chmod 600 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t2.out ; \ 297s 19:42:56.922389047 O: ssh-keygen -yf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t2.out | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub ; \ 297s 19:42:56.923579385 O: fi 297s 19:42:56.924433397 E: + cat /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.prv 297s 19:42:56.925605855 E: + chmod 600 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t2.out 297s 19:42:56.927110518 E: + ssh-keygen -yf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t2.out 297s 19:42:56.928312856 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub 297s 19:42:56.932396557 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 297s 19:42:56.933389492 E: + /usr/bin/ssh -Q key 297s 19:42:56.933628135 O: ssh-keygen -ef /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub >/tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t3.out ; \ 297s 19:42:56.934646031 E: + grep -q ^ssh-rsa 297s 19:42:56.934899675 O: ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t3.out | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub ; \ 297s 19:42:56.936428538 O: fi 297s 19:42:56.938293406 E: + ssh-keygen -ef /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub 297s 19:42:56.942966996 E: + ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t3.out 297s 19:42:56.944253335 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub 297s 19:42:56.947487384 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 297s 19:42:56.948481518 E: + /usr/bin/ssh -Q key 297s 19:42:56.948687242 O: ssh-keygen -E md5 -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 297s 19:42:56.949744617 E: + grep -q ^ssh-rsa 297s 19:42:56.950003541 O: awk '{print $2}' | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t4.ok ; \ 297s 19:42:56.951266680 O: fi 297s 19:42:56.953648036 E: + ssh-keygen -E md5 -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub 297s 19:42:56.954973176 E: + awk {print $2} 297s 19:42:56.956392237 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t4.ok 297s 19:42:56.958959796 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-rsa" ; then \ 297s 19:42:56.959831969 E: + /usr/bin/ssh -Q key 297s 19:42:56.960294136 O: ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 297s 19:42:56.961107908 E: + grep -q ^ssh-rsa 297s 19:42:56.961597315 O: awk '{print $2}' | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t5.ok ; \ 297s 19:42:56.962794773 O: fi 297s 19:42:56.965287291 E: + ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub 297s 19:42:56.966643231 E: + awk {print $2} 297s 19:42:56.968010852 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t5.ok 298s 19:42:56.970703852 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 298s 19:42:56.971760748 E: + /usr/bin/ssh -Q key 298s 19:42:56.972241075 O: ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/dsa_ssh2.prv > /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out1 ; \ 298s 19:42:56.973139929 E: + grep -q ^ssh-dss 298s 19:42:56.973454053 O: ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/dsa_ssh2.pub > /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out2 ; \ 298s 19:42:56.974685392 O: chmod 600 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out1 ; \ 298s 19:42:56.976657301 O: ssh-keygen -yf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out1 | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out2 ; \ 298s 19:42:56.976825824 E: + ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/dsa_ssh2.prv 298s 19:42:56.977997241 O: fi 298s 19:42:56.982126663 E: + ssh-keygen -if /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/dsa_ssh2.pub 298s 19:42:56.986502889 E: + chmod 600 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out1 298s 19:42:56.987907030 E: + ssh-keygen -yf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out1 298s 19:42:56.989130529 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t6.out2 298s 19:42:56.993354952 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 298s 19:42:56.994461889 E: + /usr/bin/ssh -Q key 298s 19:42:56.994605531 O: ssh-keygen -q -t rsa -N '' -f /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t7.out ; \ 298s 19:42:56.995715507 E: + grep -q ^ssh-dss 298s 19:42:56.995975671 O: fi 298s 19:42:56.999127079 E: + ssh-keygen -q -t rsa -N -f /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t7.out 299s 19:42:58.747551949 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 299s 19:42:58.748326441 E: + /usr/bin/ssh -Q key 299s 19:42:58.748938810 O: ssh-keygen -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t7.out > /dev/null ; \ 299s 19:42:58.749591980 E: + grep -q ^ssh-dss 299s 19:42:58.750260270 O: ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t7.out > /dev/null ; \ 299s 19:42:58.752053737 O: fi 299s 19:42:58.755111183 E: + ssh-keygen -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t7.out 299s 19:42:58.759782733 E: + ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t7.out 299s 19:42:58.764613085 O: set -xe ; if ssh -Q key | grep -q "^ssh-dss" ; then \ 299s 19:42:58.765594980 E: + ssh -Q key 299s 19:42:58.765874384 O: ssh-keygen -q -t dsa -N '' -f /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t8.out ; \ 299s 19:42:58.766950680 E: + grep -q ^ssh-dss 299s 19:42:58.767046482 O: fi 299s 19:42:58.770691416 E: + ssh-keygen -q -t dsa -N -f /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t8.out 300s 19:42:58.997738102 O: set -xe ; if ssh -Q key | grep -q "^ssh-dss" ; then \ 300s 19:42:58.998904319 E: + ssh -Q key 300s 19:42:58.999258765 O: ssh-keygen -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t8.out > /dev/null ; \ 300s 19:42:59.000344621 E: + grep -q ^ssh-dss 300s 19:42:59.000564544 O: ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t8.out > /dev/null ; \ 300s 19:42:59.002108487 O: fi 300s 19:42:59.003574149 E: + ssh-keygen -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t8.out 300s 19:42:59.007925455 E: + ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t8.out 300s 19:42:59.012640845 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 300s 19:42:59.013707861 O: ssh-keygen -q -t ecdsa -N '' -f /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t9.out 300s 19:42:59.023670011 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 300s 19:42:59.024841788 O: ssh-keygen -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t9.out > /dev/null 300s 19:42:59.034661336 O: ! /usr/bin/ssh -Q key-plain | grep ecdsa >/dev/null || \ 300s 19:42:59.035894914 O: ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t9.out > /dev/null 300s 19:42:59.045495338 O: ssh-keygen -q -t ed25519 -N '' -f /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t10.out 300s 19:42:59.051572589 O: ssh-keygen -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t10.out > /dev/null 300s 19:42:59.056951190 O: ssh-keygen -Bf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t10.out > /dev/null 300s 19:42:59.062223749 O: set -xe ; if /usr/bin/ssh -Q key | grep -q "^ssh-dss" ; then \ 300s 19:42:59.063217644 E: + /usr/bin/ssh -Q key 300s 19:42:59.063402327 O: ssh-keygen -E sha256 -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub |\ 300s 19:42:59.064441702 E: + grep -q ^ssh-dss 300s 19:42:59.064701546 O: awk '{print $2}' | diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t11.ok ; \ 300s 19:42:59.066054846 O: fi 300s 19:42:59.067979875 E: + ssh-keygen -E sha256 -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/rsa_openssh.pub 300s 19:42:59.069126972 E: + awk {print $2} 300s 19:42:59.070387831 E: + diff - /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t11.ok 300s 19:42:59.073283915 O: ssh-keygen -q -t ed25519 -N '' -C 'test-comment-1234' -f /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t12.out 300s 19:42:59.079074882 O: ssh-keygen -lf /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/t12.out.pub | grep test-comment-1234 >/dev/null 300s 19:42:59.086464072 E: run test connect.sh ... 302s 19:43:01.148376941 O: ok simple connect 302s 19:43:01.148531424 E: run test proxy-connect.sh ... 302s 19:43:01.396352297 O: plain username comp=no 302s 19:43:01.703403497 O: plain username comp=yes 303s 19:43:02.002485858 O: username with style 303s 19:43:02.320269138 O: ok proxy connect 303s 19:43:02.320355979 E: run test sshfp-connect.sh ... 303s 19:43:02.564741320 O: SKIPPED: TEST_SSH_SSHFP_DOMAIN not set. 303s 19:43:02.564944403 E: run test connect-privsep.sh ... 308s 19:43:06.989549858 O: ok proxy connect with privsep 308s 19:43:06.989741261 E: run test connect-uri.sh ... 309s 19:43:07.386646235 O: uri connect: no trailing slash 309s 19:43:07.752372543 O: uri connect: trailing slash 309s 19:43:08.124022579 O: uri connect: with path name 309s 19:43:08.157298916 O: ok uri connect 309s 19:43:08.157509879 E: run test proto-version.sh ... 309s 19:43:08.465228918 O: ok sshd version with different protocol combinations 309s 19:43:08.466223773 E: run test proto-mismatch.sh ... 309s 19:43:08.812769192 O: ok protocol version mismatch 309s 19:43:08.812939755 E: run test exit-status.sh ... 310s 19:43:09.073524849 O: test remote exit status: status 0 315s 19:43:14.681087073 O: test remote exit status: status 1 321s 19:43:20.285680567 O: test remote exit status: status 4 326s 19:43:25.900749531 O: test remote exit status: status 5 332s 19:43:31.523704169 O: test remote exit status: status 44 338s 19:43:37.125255608 O: ok remote exit status 338s 19:43:37.125425771 E: run test exit-status-signal.sh ... 339s 19:43:38.382370164 O: ok exit status on signal 339s 19:43:38.382369604 E: run test envpass.sh ... 339s 19:43:38.627760113 O: test environment passing: pass env, don't accept 339s 19:43:38.943730386 O: test environment passing: setenv, don't accept 340s 19:43:39.249474066 O: test environment passing: don't pass env, accept 340s 19:43:39.560343502 O: test environment passing: pass single env, accept single env 340s 19:43:39.867465402 O: test environment passing: pass multiple env, accept multiple env 341s 19:43:40.165416006 O: test environment passing: setenv, accept 341s 19:43:40.469563501 O: test environment passing: setenv, first match wins 341s 19:43:40.775308220 O: test environment passing: server setenv wins 342s 19:43:41.076248627 O: test environment passing: server setenv wins 342s 19:43:41.381915543 O: ok environment passing 342s 19:43:41.382095145 E: run test transfer.sh ... 345s 19:43:44.111709095 O: ok transfer data 345s 19:43:44.111768176 E: run test banner.sh ... 345s 19:43:44.367496750 O: test banner: missing banner file 345s 19:43:44.681807909 O: test banner: size 0 346s 19:43:44.991395958 O: test banner: size 10 346s 19:43:45.308387914 O: test banner: size 100 346s 19:43:45.629184367 O: test banner: size 1000 346s 19:43:45.943588686 O: test banner: size 10000 347s 19:43:46.263268281 O: test banner: size 100000 347s 19:43:46.581121369 O: test banner: suppress banner (-q) 347s 19:43:46.878996722 O: ok banner 347s 19:43:46.879322967 E: run test rekey.sh ... 348s 19:43:47.155944886 O: client rekey KexAlgorithms=diffie-hellman-group1-sha1 350s 19:43:49.088083247 O: client rekey KexAlgorithms=diffie-hellman-group14-sha1 352s 19:43:51.020670596 O: client rekey KexAlgorithms=diffie-hellman-group14-sha256 353s 19:43:52.954218220 O: client rekey KexAlgorithms=diffie-hellman-group16-sha512 355s 19:43:54.886341045 O: client rekey KexAlgorithms=diffie-hellman-group18-sha512 357s 19:43:56.816037056 O: client rekey KexAlgorithms=diffie-hellman-group-exchange-sha1 359s 19:43:58.752859874 O: client rekey KexAlgorithms=diffie-hellman-group-exchange-sha256 361s 19:44:00.690265441 O: client rekey KexAlgorithms=ecdh-sha2-nistp256 363s 19:44:02.618961263 O: client rekey KexAlgorithms=ecdh-sha2-nistp384 365s 19:44:04.549662737 O: client rekey KexAlgorithms=ecdh-sha2-nistp521 367s 19:44:06.480924681 O: client rekey KexAlgorithms=curve25519-sha256 369s 19:44:08.418870064 O: client rekey KexAlgorithms=curve25519-sha256@libssh.org 371s 19:44:10.347939020 O: client rekey KexAlgorithms=sntrup761x25519-sha512@openssh.com 373s 19:44:12.285852088 O: client rekey Ciphers=3des-cbc 375s 19:44:14.223910580 O: client rekey Ciphers=aes128-cbc 377s 19:44:16.136385120 O: client rekey Ciphers=aes192-cbc 379s 19:44:18.051463802 O: client rekey Ciphers=aes256-cbc 381s 19:44:19.980932596 O: client rekey Ciphers=aes128-ctr 382s 19:44:21.911050742 O: client rekey Ciphers=aes192-ctr 384s 19:44:23.835581549 O: client rekey Ciphers=aes256-ctr 386s 19:44:25.761476119 O: client rekey Ciphers=aes128-gcm@openssh.com 388s 19:44:27.690137912 O: client rekey Ciphers=aes256-gcm@openssh.com 390s 19:44:29.622493342 O: client rekey Ciphers=chacha20-poly1305@openssh.com 392s 19:44:31.558343365 O: client rekey MACs=hmac-sha1 394s 19:44:33.477060483 O: client rekey MACs=hmac-sha1-96 396s 19:44:35.408101562 O: client rekey MACs=hmac-sha2-256 398s 19:44:37.332721012 O: client rekey MACs=hmac-sha2-512 400s 19:44:39.260344809 O: client rekey MACs=hmac-md5 402s 19:44:41.216859007 O: client rekey MACs=hmac-md5-96 404s 19:44:43.168892604 O: client rekey MACs=umac-64@openssh.com 406s 19:44:45.112357339 O: client rekey MACs=umac-128@openssh.com 408s 19:44:47.052429969 O: client rekey MACs=hmac-sha1-etm@openssh.com 410s 19:44:49.014645102 O: client rekey MACs=hmac-sha1-96-etm@openssh.com 411s 19:44:50.948475608 O: client rekey MACs=hmac-sha2-256-etm@openssh.com 413s 19:44:52.865668817 O: client rekey MACs=hmac-sha2-512-etm@openssh.com 415s 19:44:54.782685608 O: client rekey MACs=hmac-md5-etm@openssh.com 417s 19:44:56.707879140 O: client rekey MACs=hmac-md5-96-etm@openssh.com 419s 19:44:58.621875295 O: client rekey MACs=umac-64-etm@openssh.com 421s 19:45:00.535945915 O: client rekey MACs=umac-128-etm@openssh.com 423s 19:45:02.491356515 O: client rekey aes128-gcm@openssh.com diffie-hellman-group1-sha1 425s 19:45:04.433821832 O: client rekey aes128-gcm@openssh.com diffie-hellman-group14-sha1 427s 19:45:06.373047566 O: client rekey aes128-gcm@openssh.com diffie-hellman-group14-sha256 429s 19:45:08.336035266 O: client rekey aes128-gcm@openssh.com diffie-hellman-group16-sha512 431s 19:45:10.254687393 O: client rekey aes128-gcm@openssh.com diffie-hellman-group18-sha512 433s 19:45:12.210780041 O: client rekey aes128-gcm@openssh.com diffie-hellman-group-exchange-sha1 435s 19:45:14.127829793 O: client rekey aes128-gcm@openssh.com diffie-hellman-group-exchange-sha256 437s 19:45:16.059040853 O: client rekey aes128-gcm@openssh.com ecdh-sha2-nistp256 439s 19:45:17.979627185 O: client rekey aes128-gcm@openssh.com ecdh-sha2-nistp384 440s 19:45:19.890834447 O: client rekey aes128-gcm@openssh.com ecdh-sha2-nistp521 442s 19:45:21.821610374 O: client rekey aes128-gcm@openssh.com curve25519-sha256 444s 19:45:23.739457821 O: client rekey aes128-gcm@openssh.com curve25519-sha256@libssh.org 446s 19:45:25.674780423 O: client rekey aes128-gcm@openssh.com sntrup761x25519-sha512@openssh.com 448s 19:45:27.598500403 O: client rekey aes256-gcm@openssh.com diffie-hellman-group1-sha1 450s 19:45:29.513553484 O: client rekey aes256-gcm@openssh.com diffie-hellman-group14-sha1 452s 19:45:31.425312784 O: client rekey aes256-gcm@openssh.com diffie-hellman-group14-sha256 454s 19:45:33.336086334 O: client rekey aes256-gcm@openssh.com diffie-hellman-group16-sha512 456s 19:45:35.275397397 O: client rekey aes256-gcm@openssh.com diffie-hellman-group18-sha512 458s 19:45:37.248078240 O: client rekey aes256-gcm@openssh.com diffie-hellman-group-exchange-sha1 460s 19:45:39.266367717 O: client rekey aes256-gcm@openssh.com diffie-hellman-group-exchange-sha256 462s 19:45:41.269475362 O: client rekey aes256-gcm@openssh.com ecdh-sha2-nistp256 464s 19:45:43.269698990 O: client rekey aes256-gcm@openssh.com ecdh-sha2-nistp384 466s 19:45:45.228858418 O: client rekey aes256-gcm@openssh.com ecdh-sha2-nistp521 468s 19:45:47.163709165 O: client rekey aes256-gcm@openssh.com curve25519-sha256 470s 19:45:49.087235977 O: client rekey aes256-gcm@openssh.com curve25519-sha256@libssh.org 472s 19:45:51.003416990 O: client rekey aes256-gcm@openssh.com sntrup761x25519-sha512@openssh.com 473s 19:45:52.927749184 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group1-sha1 475s 19:45:54.839140181 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group14-sha1 477s 19:45:56.749696111 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group14-sha256 479s 19:45:58.661257921 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group16-sha512 481s 19:46:00.579266009 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group18-sha512 483s 19:46:02.497757849 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group-exchange-sha1 485s 19:46:04.414316808 O: client rekey chacha20-poly1305@openssh.com diffie-hellman-group-exchange-sha256 487s 19:46:06.335834743 O: client rekey chacha20-poly1305@openssh.com ecdh-sha2-nistp256 489s 19:46:08.293394294 O: client rekey chacha20-poly1305@openssh.com ecdh-sha2-nistp384 491s 19:46:10.233271380 O: client rekey chacha20-poly1305@openssh.com ecdh-sha2-nistp521 493s 19:46:12.205980836 O: client rekey chacha20-poly1305@openssh.com curve25519-sha256 495s 19:46:14.164866562 O: client rekey chacha20-poly1305@openssh.com curve25519-sha256@libssh.org 497s 19:46:16.135098314 O: client rekey chacha20-poly1305@openssh.com sntrup761x25519-sha512@openssh.com 499s 19:46:18.044097108 O: client rekeylimit 16 501s 19:46:20.649411777 O: client rekeylimit 1k 504s 19:46:23.031012152 O: client rekeylimit 128k 505s 19:46:24.937865588 O: client rekeylimit 256k 507s 19:46:26.859730301 O: client rekeylimit default 5 523s 19:46:42.173004544 O: client rekeylimit default 10 543s 19:47:02.497994930 O: client rekeylimit default 5 no data 558s 19:47:17.850679549 O: client rekeylimit default 10 no data 579s 19:47:38.239098505 O: server rekeylimit 16 581s 19:47:40.919448936 O: server rekeylimit 1k 584s 19:47:43.309664339 O: server rekeylimit 128k 586s 19:47:45.252726275 O: server rekeylimit 256k 588s 19:47:47.172031792 O: server rekeylimit default 5 no data 603s 19:48:02.607789114 O: server rekeylimit default 10 no data 624s 19:48:23.069136564 O: rekeylimit parsing 636s 19:48:35.668114660 E: run test dhgex.sh ... 636s 19:48:35.668099460 O: ok rekey 637s 19:48:35.978378055 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 3des-cbc 637s 19:48:36.238042198 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 3des-cbc 637s 19:48:36.505500288 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-cbc 637s 19:48:36.764702185 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-cbc 638s 19:48:37.006466004 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-ctr 638s 19:48:37.243689320 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-ctr 638s 19:48:37.489631156 O: dhgex bits 3072 diffie-hellman-group-exchange-sha1 aes128-gcm@openssh.com 638s 19:48:37.723221502 O: dhgex bits 3072 diffie-hellman-group-exchange-sha256 aes128-gcm@openssh.com 638s 19:48:37.961464073 O: dhgex bits 7680 diffie-hellman-group-exchange-sha1 aes192-cbc 639s 19:48:38.288177769 O: dhgex bits 7680 diffie-hellman-group-exchange-sha256 aes192-cbc 639s 19:48:38.615011827 O: dhgex bits 7680 diffie-hellman-group-exchange-sha1 aes192-ctr 639s 19:48:38.946305226 O: dhgex bits 7680 diffie-hellman-group-exchange-sha256 aes192-ctr 640s 19:48:39.295519628 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-cbc 640s 19:48:39.635501785 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-cbc 640s 19:48:39.972927066 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-ctr 641s 19:48:40.310763953 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-ctr 641s 19:48:40.650272422 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 aes256-gcm@openssh.com 642s 19:48:40.994273432 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 aes256-gcm@openssh.com 642s 19:48:41.346686436 O: dhgex bits 8192 diffie-hellman-group-exchange-sha1 chacha20-poly1305@openssh.com 642s 19:48:41.803449822 O: dhgex bits 8192 diffie-hellman-group-exchange-sha256 chacha20-poly1305@openssh.com 643s 19:48:42.272404454 O: ok dhgex 643s 19:48:42.272571576 E: run test stderr-data.sh ... 643s 19:48:42.542256652 O: test stderr data transfer: () 650s 19:48:49.242827309 O: test stderr data transfer: (-n) 656s 19:48:55.902556527 O: ok stderr data transfer 656s 19:48:55.903849465 E: run test stderr-after-eof.sh ... 659s 19:48:58.552660417 O: ok stderr data after eof 659s 19:48:58.552936381 E: run test broken-pipe.sh ... 659s 19:48:58.831925251 O: ok broken pipe test 659s 19:48:58.831989531 E: run test try-ciphers.sh ... 660s 19:48:59.131336918 O: test try ciphers: cipher 3des-cbc mac hmac-sha1 660s 19:48:59.466401708 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-96 660s 19:48:59.815330248 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-256 661s 19:49:00.150342237 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-512 661s 19:49:00.494228547 O: test try ciphers: cipher 3des-cbc mac hmac-md5 661s 19:49:00.847399983 O: test try ciphers: cipher 3des-cbc mac hmac-md5-96 662s 19:49:01.172817121 O: test try ciphers: cipher 3des-cbc mac umac-64@openssh.com 662s 19:49:01.491892413 O: test try ciphers: cipher 3des-cbc mac umac-128@openssh.com 662s 19:49:01.826291793 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-etm@openssh.com 663s 19:49:02.146997307 O: test try ciphers: cipher 3des-cbc mac hmac-sha1-96-etm@openssh.com 663s 19:49:02.470797622 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-256-etm@openssh.com 663s 19:49:02.787879686 O: test try ciphers: cipher 3des-cbc mac hmac-sha2-512-etm@openssh.com 664s 19:49:03.109719975 O: test try ciphers: cipher 3des-cbc mac hmac-md5-etm@openssh.com 664s 19:49:03.440708987 O: test try ciphers: cipher 3des-cbc mac hmac-md5-96-etm@openssh.com 664s 19:49:03.760120761 O: test try ciphers: cipher 3des-cbc mac umac-64-etm@openssh.com 665s 19:49:04.086239467 O: test try ciphers: cipher 3des-cbc mac umac-128-etm@openssh.com 665s 19:49:04.434817677 O: test try ciphers: cipher aes128-cbc mac hmac-sha1 665s 19:49:04.778515780 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-96 666s 19:49:05.123574902 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-256 666s 19:49:05.469363633 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-512 666s 19:49:05.795393056 O: test try ciphers: cipher aes128-cbc mac hmac-md5 667s 19:49:06.124837924 O: test try ciphers: cipher aes128-cbc mac hmac-md5-96 667s 19:49:06.450894627 O: test try ciphers: cipher aes128-cbc mac umac-64@openssh.com 667s 19:49:06.791607488 O: test try ciphers: cipher aes128-cbc mac umac-128@openssh.com 668s 19:49:07.129916156 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-etm@openssh.com 668s 19:49:07.447148858 O: test try ciphers: cipher aes128-cbc mac hmac-sha1-96-etm@openssh.com 668s 19:49:07.762641216 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-256-etm@openssh.com 669s 19:49:08.088463634 O: test try ciphers: cipher aes128-cbc mac hmac-sha2-512-etm@openssh.com 669s 19:49:08.408723256 O: test try ciphers: cipher aes128-cbc mac hmac-md5-etm@openssh.com 669s 19:49:08.734301871 O: test try ciphers: cipher aes128-cbc mac hmac-md5-96-etm@openssh.com 670s 19:49:09.053760722 O: test try ciphers: cipher aes128-cbc mac umac-64-etm@openssh.com 670s 19:49:09.376237853 O: test try ciphers: cipher aes128-cbc mac umac-128-etm@openssh.com 670s 19:49:09.707600865 O: test try ciphers: cipher aes192-cbc mac hmac-sha1 671s 19:49:10.037654218 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-96 671s 19:49:10.364369086 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-256 671s 19:49:10.694776164 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-512 672s 19:49:11.016379363 O: test try ciphers: cipher aes192-cbc mac hmac-md5 672s 19:49:11.344289806 O: test try ciphers: cipher aes192-cbc mac hmac-md5-96 672s 19:49:11.677821045 O: test try ciphers: cipher aes192-cbc mac umac-64@openssh.com 673s 19:49:12.006139934 O: test try ciphers: cipher aes192-cbc mac umac-128@openssh.com 673s 19:49:12.326995761 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-etm@openssh.com 673s 19:49:12.661674375 O: test try ciphers: cipher aes192-cbc mac hmac-sha1-96-etm@openssh.com 674s 19:49:12.982134716 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-256-etm@openssh.com 674s 19:49:13.327993801 O: test try ciphers: cipher aes192-cbc mac hmac-sha2-512-etm@openssh.com 674s 19:49:13.657251460 O: test try ciphers: cipher aes192-cbc mac hmac-md5-etm@openssh.com 675s 19:49:13.983444278 O: test try ciphers: cipher aes192-cbc mac hmac-md5-96-etm@openssh.com 675s 19:49:14.309084888 O: test try ciphers: cipher aes192-cbc mac umac-64-etm@openssh.com 675s 19:49:14.632419227 O: test try ciphers: cipher aes192-cbc mac umac-128-etm@openssh.com 675s 19:49:14.959623738 O: test try ciphers: cipher aes256-cbc mac hmac-sha1 676s 19:49:15.310851853 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-96 676s 19:49:15.639519703 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-256 677s 19:49:16.010758010 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-512 677s 19:49:16.427004524 O: test try ciphers: cipher aes256-cbc mac hmac-md5 677s 19:49:16.769925006 O: test try ciphers: cipher aes256-cbc mac hmac-md5-96 678s 19:49:17.093740310 O: test try ciphers: cipher aes256-cbc mac umac-64@openssh.com 678s 19:49:17.415847509 O: test try ciphers: cipher aes256-cbc mac umac-128@openssh.com 678s 19:49:17.737902148 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-etm@openssh.com 679s 19:49:18.061268644 O: test try ciphers: cipher aes256-cbc mac hmac-sha1-96-etm@openssh.com 680s 19:49:18.393327577 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-256-etm@openssh.com 680s 19:49:18.721105933 O: test try ciphers: cipher aes256-cbc mac hmac-sha2-512-etm@openssh.com 680s 19:49:19.044911474 O: test try ciphers: cipher aes256-cbc mac hmac-md5-etm@openssh.com 680s 19:49:19.367029872 O: test try ciphers: cipher aes256-cbc mac hmac-md5-96-etm@openssh.com 680s 19:49:19.702563052 O: test try ciphers: cipher aes256-cbc mac umac-64-etm@openssh.com 681s 19:49:20.104908975 O: test try ciphers: cipher aes256-cbc mac umac-128-etm@openssh.com 681s 19:49:20.488852328 O: test try ciphers: cipher aes128-ctr mac hmac-sha1 681s 19:49:20.856467541 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-96 682s 19:49:21.191572753 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-256 682s 19:49:21.549967640 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-512 682s 19:49:21.877985836 O: test try ciphers: cipher aes128-ctr mac hmac-md5 683s 19:49:22.231703259 O: test try ciphers: cipher aes128-ctr mac hmac-md5-96 683s 19:49:22.563961951 O: test try ciphers: cipher aes128-ctr mac umac-64@openssh.com 683s 19:49:22.882955225 O: test try ciphers: cipher aes128-ctr mac umac-128@openssh.com 684s 19:49:23.251058641 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-etm@openssh.com 684s 19:49:23.593552231 O: test try ciphers: cipher aes128-ctr mac hmac-sha1-96-etm@openssh.com 684s 19:49:23.935486974 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-256-etm@openssh.com 685s 19:49:24.267369740 O: test try ciphers: cipher aes128-ctr mac hmac-sha2-512-etm@openssh.com 685s 19:49:24.591687923 O: test try ciphers: cipher aes128-ctr mac hmac-md5-etm@openssh.com 685s 19:49:24.921525781 O: test try ciphers: cipher aes128-ctr mac hmac-md5-96-etm@openssh.com 686s 19:49:25.244753149 O: test try ciphers: cipher aes128-ctr mac umac-64-etm@openssh.com 686s 19:49:25.571384003 O: test try ciphers: cipher aes128-ctr mac umac-128-etm@openssh.com 686s 19:49:25.910144621 O: test try ciphers: cipher aes192-ctr mac hmac-sha1 687s 19:49:26.233003783 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-96 687s 19:49:26.595874646 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-256 687s 19:49:26.937707425 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-512 688s 19:49:27.266780310 O: test try ciphers: cipher aes192-ctr mac hmac-md5 688s 19:49:27.594121252 O: test try ciphers: cipher aes192-ctr mac hmac-md5-96 688s 19:49:27.930835840 O: test try ciphers: cipher aes192-ctr mac umac-64@openssh.com 689s 19:49:28.259753043 O: test try ciphers: cipher aes192-ctr mac umac-128@openssh.com 689s 19:49:28.618990375 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-etm@openssh.com 690s 19:49:28.984830436 O: test try ciphers: cipher aes192-ctr mac hmac-sha1-96-etm@openssh.com 690s 19:49:29.322405594 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-256-etm@openssh.com 690s 19:49:29.650903390 O: test try ciphers: cipher aes192-ctr mac hmac-sha2-512-etm@openssh.com 691s 19:49:29.979570228 O: test try ciphers: cipher aes192-ctr mac hmac-md5-etm@openssh.com 691s 19:49:30.310415854 O: test try ciphers: cipher aes192-ctr mac hmac-md5-96-etm@openssh.com 691s 19:49:30.642286895 O: test try ciphers: cipher aes192-ctr mac umac-64-etm@openssh.com 692s 19:49:30.983519342 O: test try ciphers: cipher aes192-ctr mac umac-128-etm@openssh.com 692s 19:49:31.324637626 O: test try ciphers: cipher aes256-ctr mac hmac-sha1 692s 19:49:31.665355385 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-96 693s 19:49:31.994990155 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-256 693s 19:49:32.324026675 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-512 693s 19:49:32.648182250 O: test try ciphers: cipher aes256-ctr mac hmac-md5 693s 19:49:32.965948099 O: test try ciphers: cipher aes256-ctr mac hmac-md5-96 694s 19:49:33.287896563 O: test try ciphers: cipher aes256-ctr mac umac-64@openssh.com 694s 19:49:33.623011365 O: test try ciphers: cipher aes256-ctr mac umac-128@openssh.com 694s 19:49:33.961645814 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-etm@openssh.com 695s 19:49:34.291645866 O: test try ciphers: cipher aes256-ctr mac hmac-sha1-96-etm@openssh.com 695s 19:49:34.616368686 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-256-etm@openssh.com 695s 19:49:34.942389245 O: test try ciphers: cipher aes256-ctr mac hmac-sha2-512-etm@openssh.com 696s 19:49:35.266201812 O: test try ciphers: cipher aes256-ctr mac hmac-md5-etm@openssh.com 696s 19:49:35.605436308 O: test try ciphers: cipher aes256-ctr mac hmac-md5-96-etm@openssh.com 696s 19:49:35.934566147 O: test try ciphers: cipher aes256-ctr mac umac-64-etm@openssh.com 697s 19:49:36.262730293 O: test try ciphers: cipher aes256-ctr mac umac-128-etm@openssh.com 697s 19:49:36.595886946 O: test try ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1 697s 19:49:36.939893105 O: test try ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1 698s 19:49:37.284229508 O: test try ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1 698s 19:49:37.618892140 O: ok try ciphers 698s 19:49:37.618903540 E: run test yes-head.sh ... 701s 19:49:40.922504228 O: ok yes pipe head 701s 19:49:40.922693991 E: run test login-timeout.sh ... 717s 19:49:56.844557657 O: ok connect after login grace timeout 717s 19:49:56.844566377 E: run test agent.sh ... 730s 19:50:09.928485120 O: ok simple agent test 730s 19:50:09.928545001 E: run test agent-getpeereid.sh ... 731s 19:50:10.238481635 O: ok disallow agent attach from other uid 731s 19:50:10.238534995 E: run test agent-timeout.sh ... 751s 19:50:30.626771427 O: ok agent timeout test 751s 19:50:30.628467929 E: run test agent-ptrace.sh ... 751s 19:50:30.883719059 O: skipped (gdb not found) 751s 19:50:30.883800700 E: run test agent-subprocess.sh ... 762s 19:50:41.168705545 O: ok agent subprocess 762s 19:50:41.168809707 E: run test keyscan.sh ... 765s 19:50:44.638911440 O: ok keyscan 765s 19:50:44.639035041 E: run test keygen-change.sh ... 771s 19:50:50.116257793 O: ok change passphrase for key 771s 19:50:50.116408316 E: run test keygen-comment.sh ... 779s 19:50:58.923553843 O: ok Comment extraction from private key 779s 19:50:58.923715925 E: run test keygen-convert.sh ... 784s 19:51:03.666690275 O: ok convert keys 784s 19:51:03.666819316 E: run test keygen-knownhosts.sh ... 785s 19:51:04.163482354 O: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts updated. 785s 19:51:04.164931853 O: Original contents retained as /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts.old 785s 19:51:04.190951199 O: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts updated. 785s 19:51:04.192466419 O: Original contents retained as /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts.old 785s 19:51:04.201217895 O: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts updated. 785s 19:51:04.202837037 O: Original contents retained as /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts.old 785s 19:51:04.221907090 O: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts updated. 785s 19:51:04.223614113 O: Original contents retained as /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hosts.old 785s 19:51:04.253513910 O: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hashed updated. 785s 19:51:04.254971329 O: Original contents retained as /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/kh.hashed.old 785s 19:51:04.260259919 O: ok ssh-keygen known_hosts 785s 19:51:04.260569924 E: run test keygen-moduli.sh ... 792s 19:51:11.006104996 O: ok keygen moduli 792s 19:51:11.006466880 E: run test keygen-sshfp.sh ... 792s 19:51:11.317083961 O: ok keygen-sshfp 792s 19:51:11.317303964 E: run test key-options.sh ... 792s 19:51:11.571671259 O: key option command="echo bar" 792s 19:51:11.885555704 O: key option no-pty,command="echo bar" 793s 19:51:12.194701245 O: key option pty default 793s 19:51:12.506079736 O: key option pty no-pty 793s 19:51:12.821756963 O: key option pty restrict 794s 19:51:13.144561365 O: key option pty restrict,pty 794s 19:51:13.451867321 O: key option environment 795s 19:51:14.225934467 O: key option from="127.0.0.1" 796s 19:51:15.291013351 O: key option from="127.0.0.0/8" 797s 19:51:16.059669383 O: key option expiry-time default 797s 19:51:16.364520464 O: key option expiry-time invalid 797s 19:51:16.754625796 O: key option expiry-time expired 798s 19:51:17.153706006 O: key option expiry-time valid 798s 19:51:17.492776861 O: ok key options 798s 19:51:17.492821421 E: run test scp.sh ... 798s 19:51:17.743921630 O: scp: scp mode: simple copy local file to local file 798s 19:51:17.758293900 O: scp: scp mode: simple copy local file to remote file 798s 19:51:17.769147044 O: scp: scp mode: simple copy remote file to local file 798s 19:51:17.778978894 O: scp: scp mode: copy local file to remote file in place 798s 19:51:17.792978240 O: scp: scp mode: copy remote file to local file in place 798s 19:51:17.806999626 O: scp: scp mode: copy local file to remote file clobber 798s 19:51:17.819451111 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 19:51 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/copy 798s 19:51:17.820801249 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 19:51 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/data 798s 19:51:17.822321269 O: scp: scp mode: copy remote file to local file clobber 798s 19:51:17.836023451 O: scp: scp mode: simple copy local file to remote dir 798s 19:51:17.850567483 O: scp: scp mode: simple copy local file to local dir 798s 19:51:17.864895033 O: scp: scp mode: simple copy remote file to local dir 798s 19:51:17.879665389 O: scp: scp mode: recursive local dir to remote dir 798s 19:51:17.905994458 O: scp: scp mode: recursive local dir to local dir 798s 19:51:17.933060657 O: scp: scp mode: recursive remote dir to local dir 798s 19:51:17.961888239 O: scp: scp mode: unmatched glob file local->remote 798s 19:51:17.973295630 O: scp: scp mode: unmatched glob file remote->local 799s 19:51:17.979858717 O: scp: scp mode: unmatched glob dir recursive local->remote 799s 19:51:18.002081972 O: scp: scp mode: unmatched glob dir recursive remote->local 799s 19:51:18.010986970 O: scp: scp mode: shell metacharacters 799s 19:51:18.022255639 O: scp: scp mode: skipped file after scp -p with failed chown+utimes 799s 19:51:18.075897670 O: scp: scp mode: disallow bad server #0 799s 19:51:18.106264072 O: scp: scp mode: disallow bad server #1 799s 19:51:18.135036774 O: scp: scp mode: disallow bad server #2 799s 19:51:18.163098786 O: scp: scp mode: disallow bad server #3 799s 19:51:18.193789472 O: scp: scp mode: disallow bad server #4 799s 19:51:18.226560507 O: scp: scp mode: disallow bad server #5 799s 19:51:18.255938696 O: scp: scp mode: disallow bad server #6 799s 19:51:18.283048255 O: scp: scp mode: disallow bad server #7 799s 19:51:18.319485018 O: scp: scp mode: detect non-directory target 799s 19:51:18.325332376 E: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/copy2: Not a directory 799s 19:51:18.329814635 O: scp: sftp mode: simple copy local file to local file 799s 19:51:18.341870755 O: scp: sftp mode: simple copy local file to remote file 799s 19:51:18.360741085 O: scp: sftp mode: simple copy remote file to local file 799s 19:51:18.373448173 O: scp: sftp mode: copy local file to remote file in place 799s 19:51:18.392789230 O: scp: sftp mode: copy remote file to local file in place 799s 19:51:18.407987871 O: scp: sftp mode: copy local file to remote file clobber 799s 19:51:18.421236847 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 19:51 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/copy 799s 19:51:18.422683346 O: -rw-rw-r-- 1 openssh-tests openssh-tests 235236 Nov 15 19:51 /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/data 799s 19:51:18.424389729 O: scp: sftp mode: copy remote file to local file clobber 799s 19:51:18.442150684 O: scp: sftp mode: simple copy local file to remote dir 799s 19:51:18.458795065 O: scp: sftp mode: simple copy local file to local dir 799s 19:51:18.474034386 O: scp: sftp mode: simple copy remote file to local dir 799s 19:51:18.489288429 O: scp: sftp mode: recursive local dir to remote dir 799s 19:51:18.519409188 O: scp: sftp mode: recursive local dir to local dir 799s 19:51:18.550059954 O: scp: sftp mode: recursive remote dir to local dir 799s 19:51:18.588873388 O: scp: sftp mode: unmatched glob file local->remote 799s 19:51:18.602968375 O: scp: sftp mode: unmatched glob file remote->local 799s 19:51:18.614828212 O: scp: sftp mode: unmatched glob dir recursive local->remote 799s 19:51:18.642916505 O: scp: sftp mode: unmatched glob dir recursive remote->local 799s 19:51:18.658711514 O: scp: sftp mode: shell metacharacters 799s 19:51:18.672815901 O: scp: sftp mode: skipped file after scp -p with failed chown+utimes 799s 19:51:18.732628854 O: scp: sftp mode: disallow bad server #0 799s 19:51:18.772840627 O: scp: sftp mode: disallow bad server #1 799s 19:51:18.811406618 O: scp: sftp mode: disallow bad server #2 799s 19:51:18.848840874 O: scp: sftp mode: disallow bad server #3 799s 19:51:18.886446132 O: scp: sftp mode: disallow bad server #4 799s 19:51:18.924618758 O: scp: sftp mode: disallow bad server #5 800s 19:51:18.991937850 O: scp: sftp mode: disallow bad server #6 800s 19:51:19.080739027 O: scp: sftp mode: disallow bad server #7 800s 19:51:19.118072202 O: scp: sftp mode: detect non-directory target 800s 19:51:19.124036281 E: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/copy2: Not a directory 800s 19:51:19.132709116 O: ok scp 800s 19:51:19.133128681 E: run test scp3.sh ... 800s 19:51:19.393387130 O: scp3: scp mode: simple copy remote file to remote file 800s 19:51:19.730448156 O: scp3: scp mode: simple copy remote file to remote dir 801s 19:51:20.060747093 O: scp3: scp mode: recursive remote dir to remote dir 801s 19:51:20.402436020 O: scp3: scp mode: detect non-directory target 802s 19:51:21.030740064 O: scp3: sftp mode: simple copy remote file to remote file 802s 19:51:21.044762130 O: scp3: sftp mode: simple copy remote file to remote dir 802s 19:51:21.062002478 O: scp3: sftp mode: recursive remote dir to remote dir 802s 19:51:21.095079557 O: scp3: sftp mode: detect non-directory target 802s 19:51:21.103117383 E: scp: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/copy2: destination is not a directory 802s 19:51:21.104466641 E: scp: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/copy2: destination is not a directory 802s 19:51:21.112389226 O: ok scp3 802s 19:51:21.112528948 E: run test scp-uri.sh ... 802s 19:51:21.385995010 O: scp-uri: scp mode: simple copy local file to remote file 802s 19:51:21.398186372 O: scp-uri: scp mode: simple copy remote file to local file 802s 19:51:21.407771619 O: scp-uri: scp mode: simple copy local file to remote dir 802s 19:51:21.421790805 O: scp-uri: scp mode: simple copy remote file to local dir 802s 19:51:21.436319797 O: scp-uri: scp mode: recursive local dir to remote dir 802s 19:51:21.453523585 O: scp-uri: scp mode: recursive remote dir to local dir 802s 19:51:21.469184392 O: scp-uri: sftp mode: simple copy local file to remote file 802s 19:51:21.480775866 O: scp-uri: sftp mode: simple copy remote file to local file 802s 19:51:21.492403540 O: scp-uri: sftp mode: simple copy local file to remote dir 802s 19:51:21.505603435 O: scp-uri: sftp mode: simple copy remote file to local dir 802s 19:51:21.523498352 O: scp-uri: sftp mode: recursive local dir to remote dir 802s 19:51:21.542772967 O: scp-uri: sftp mode: recursive remote dir to local dir 802s 19:51:21.566026515 E: run test sftp.sh ... 802s 19:51:21.566931687 O: ok scp-uri 802s 19:51:21.873040342 O: test basic sftp put/get: buffer_size 5 num_requests 1 805s 19:51:24.277646348 O: test basic sftp put/get: buffer_size 5 num_requests 2 806s 19:51:25.892622090 O: test basic sftp put/get: buffer_size 5 num_requests 10 808s 19:51:27.474854913 O: test basic sftp put/get: buffer_size 1000 num_requests 1 808s 19:51:27.499356917 O: test basic sftp put/get: buffer_size 1000 num_requests 2 808s 19:51:27.519354982 O: test basic sftp put/get: buffer_size 1000 num_requests 10 808s 19:51:27.539490968 O: test basic sftp put/get: buffer_size 32000 num_requests 1 808s 19:51:27.554096041 O: test basic sftp put/get: buffer_size 32000 num_requests 2 808s 19:51:27.566150041 O: test basic sftp put/get: buffer_size 32000 num_requests 10 808s 19:51:27.577930077 O: test basic sftp put/get: buffer_size 64000 num_requests 1 808s 19:51:27.591635498 O: test basic sftp put/get: buffer_size 64000 num_requests 2 808s 19:51:27.603987182 O: test basic sftp put/get: buffer_size 64000 num_requests 10 808s 19:51:27.622471466 O: ok basic sftp put/get 808s 19:51:27.622855191 E: run test sftp-chroot.sh ... 809s 19:51:28.045268662 O: test sftp in chroot: get 809s 19:51:28.467839774 O: test sftp in chroot: match 810s 19:51:29.042957624 O: ok sftp in chroot 810s 19:51:29.054221653 E: run test sftp-cmds.sh ... 810s 19:51:29.312340788 O: sftp commands: lls 810s 19:51:29.321132384 O: sftp commands: lls w/path 810s 19:51:29.329594216 O: sftp commands: ls 810s 19:51:29.338810138 O: sftp commands: shell 810s 19:51:29.345358905 O: sftp commands: pwd 810s 19:51:29.350208009 O: sftp commands: lpwd 810s 19:51:29.354710389 O: sftp commands: quit 810s 19:51:29.359318170 O: sftp commands: help 810s 19:51:29.365074966 O: sftp commands: get 810s 19:51:29.376671399 O: sftp commands: get quoted 810s 19:51:29.387801386 O: sftp commands: get filename with quotes 810s 19:51:29.401727211 O: sftp commands: get filename with spaces 810s 19:51:29.416181202 O: sftp commands: get filename with glob metacharacters 810s 19:51:29.427452791 O: sftp commands: get to directory 810s 19:51:29.438355575 O: sftp commands: glob get to directory 810s 19:51:29.566815555 O: sftp commands: get to local dir 810s 19:51:29.576861408 O: sftp commands: glob get to local dir 810s 19:51:29.637403809 O: sftp commands: put 810s 19:51:29.647511463 O: sftp commands: put filename with quotes 810s 19:51:29.658096243 O: sftp commands: put filename with spaces 810s 19:51:29.672322671 O: sftp commands: put to directory 810s 19:51:29.682104920 O: sftp commands: glob put to directory 810s 19:51:29.693107866 O: sftp commands: put to local dir 810s 19:51:29.703081038 O: sftp commands: glob put to local dir 810s 19:51:29.712619444 O: sftp commands: rename 810s 19:51:29.718881127 O: sftp commands: rename directory 810s 19:51:29.723773912 O: sftp commands: ln 810s 19:51:29.729866552 O: sftp commands: ln -s 810s 19:51:29.736180876 O: sftp commands: cp 810s 19:51:29.744480065 O: sftp commands: mkdir 810s 19:51:29.749302889 O: sftp commands: chdir 810s 19:51:29.753911510 O: sftp commands: rmdir 810s 19:51:29.758508411 O: sftp commands: lmkdir 810s 19:51:29.763028551 O: sftp commands: lchdir 810s 19:51:29.771241900 O: ok sftp commands 810s 19:51:29.771642625 E: run test sftp-badcmds.sh ... 811s 19:51:30.031676745 O: sftp invalid commands: get nonexistent 811s 19:51:30.037412421 O: sftp invalid commands: glob get to nonexistent directory 811s 19:51:30.055973907 O: sftp invalid commands: put nonexistent 811s 19:51:30.061558141 O: sftp invalid commands: glob put to nonexistent directory 811s 19:51:30.068400111 O: sftp invalid commands: rename nonexistent 811s 19:51:30.077581152 O: sftp invalid commands: rename target exists (directory) 811s 19:51:30.090548364 O: sftp invalid commands: glob put files to local file 811s 19:51:30.100178571 O: ok sftp invalid commands 811s 19:51:30.100730419 E: run test sftp-batch.sh ... 811s 19:51:30.403150499 O: sftp batchfile: good commands 811s 19:51:30.413074551 O: sftp batchfile: bad commands 811s 19:51:30.424938628 O: sftp batchfile: comments and blanks 811s 19:51:30.435600529 O: sftp batchfile: junk command 811s 19:51:30.441139682 O: ok sftp batchfile 811s 19:51:30.441828691 E: run test sftp-glob.sh ... 811s 19:51:30.754615309 O: sftp glob: file glob 811s 19:51:30.765280570 O: sftp glob: dir glob 811s 19:51:30.774630814 O: sftp glob: quoted glob 811s 19:51:30.785075592 O: sftp glob: escaped glob 811s 19:51:30.796023817 O: sftp glob: escaped quote 811s 19:51:30.804546249 O: sftp glob: quoted quote 811s 19:51:30.813542608 O: sftp glob: single-quoted quote 811s 19:51:30.822088081 O: sftp glob: escaped space 811s 19:51:30.830354711 O: sftp glob: quoted space 811s 19:51:30.839033665 O: sftp glob: escaped slash 811s 19:51:30.847979864 O: sftp glob: quoted slash 811s 19:51:30.856497137 O: sftp glob: escaped slash at EOL 811s 19:51:30.865274293 O: sftp glob: quoted slash at EOL 811s 19:51:30.874310732 O: sftp glob: escaped slash+quote 811s 19:51:30.882545601 O: sftp glob: quoted slash+quote 811s 19:51:30.892525933 O: ok sftp glob 811s 19:51:30.892782497 E: run test sftp-perm.sh ... 812s 19:51:31.144018740 O: sftp permissions: read-only upload 812s 19:51:31.167479610 O: sftp permissions: read-only setstat 812s 19:51:31.191633890 O: sftp permissions: read-only rm 812s 19:51:31.213772182 O: sftp permissions: read-only mkdir 812s 19:51:31.233567484 O: sftp permissions: read-only rmdir 812s 19:51:31.260095675 O: sftp permissions: read-only posix-rename 812s 19:51:31.308199511 O: sftp permissions: read-only oldrename 812s 19:51:31.344012145 O: sftp permissions: read-only symlink 812s 19:51:31.385501494 O: sftp permissions: read-only hardlink 812s 19:51:31.426023230 O: sftp permissions: explicit open 812s 19:51:31.498753392 O: sftp permissions: explicit read 812s 19:51:31.573720463 O: sftp permissions: explicit write 812s 19:51:31.656195434 O: sftp permissions: explicit lstat 812s 19:51:31.712453498 O: sftp permissions: explicit opendir 812s 19:51:31.760545414 O: sftp permissions: explicit readdir 812s 19:51:31.823830491 O: sftp permissions: explicit setstat 812s 19:51:31.904753322 O: sftp permissions: explicit remove 812s 19:51:31.973212507 O: sftp permissions: explicit mkdir 813s 19:51:32.036789108 O: sftp permissions: explicit rmdir 813s 19:51:32.125990688 O: sftp permissions: explicit rename 813s 19:51:32.211784622 O: sftp permissions: explicit symlink 813s 19:51:32.298093844 O: sftp permissions: explicit hardlink 813s 19:51:32.384026660 O: sftp permissions: explicit statvfs 813s 19:51:32.453273416 O: ok sftp permissions 813s 19:51:32.453934905 E: run test sftp-uri.sh ... 814s 19:51:33.134423144 O: sftp-uri: non-interactive fetch to local file 814s 19:51:33.558709194 O: sftp-uri: non-interactive fetch to local dir 815s 19:51:33.989942576 O: sftp-uri: put to remote directory (trailing slash) 815s 19:51:34.403440763 O: sftp-uri: put to remote directory (no slash) 815s 19:51:34.843495220 E: run test reconfigure.sh ... 815s 19:51:34.843495140 O: ok sftp-uri 829s 19:51:48.918435335 E: run test dynamic-forward.sh ... 829s 19:51:48.919485109 O: ok simple connect after reconfigure 830s 19:51:49.405265477 O: test -D forwarding 832s 19:51:51.099182259 O: test -R forwarding 833s 19:51:52.907991471 O: PermitRemoteOpen=any 835s 19:51:54.710095348 O: PermitRemoteOpen=none 836s 19:51:55.235650315 O: PermitRemoteOpen=explicit 838s 19:51:57.060984090 O: PermitRemoteOpen=disallowed 838s 19:51:57.637411165 O: ok dynamic forwarding 838s 19:51:57.640289803 E: run test forwarding.sh ... 846s 19:52:05.545438298 O: ok local and remote forwarding 846s 19:52:05.545553099 E: run test multiplex.sh ... 848s 19:52:06.990011827 O: test connection multiplexing: setenv 848s 19:52:07.010586258 O: test connection multiplexing: envpass 848s 19:52:07.030668282 O: test connection multiplexing: transfer 848s 19:52:07.140252924 O: test connection multiplexing: forward 850s 19:52:09.203405826 O: test connection multiplexing: status 0 () 855s 19:52:14.249691700 O: test connection multiplexing: status 0 (-Oproxy) 860s 19:52:19.302377090 O: test connection multiplexing: status 1 () 865s 19:52:24.353013207 O: test connection multiplexing: status 1 (-Oproxy) 870s 19:52:29.392880737 O: test connection multiplexing: status 4 () 875s 19:52:34.438632658 O: test connection multiplexing: status 4 (-Oproxy) 880s 19:52:39.479831235 O: test connection multiplexing: status 5 () 885s 19:52:44.534229299 O: test connection multiplexing: status 5 (-Oproxy) 890s 19:52:49.583274849 O: test connection multiplexing: status 44 () 895s 19:52:54.666276839 O: test connection multiplexing: status 44 (-Oproxy) 900s 19:52:59.721395901 O: test connection multiplexing: cmd check 900s 19:52:59.742393055 O: test connection multiplexing: cmd forward local (TCP) 902s 19:53:01.170105185 O: test connection multiplexing: cmd forward remote (TCP) 903s 19:53:02.616502196 O: test connection multiplexing: cmd forward local (UNIX) 904s 19:53:03.713714163 O: test connection multiplexing: cmd forward remote (UNIX) 905s 19:53:04.813811966 O: test connection multiplexing: cmd exit 905s 19:53:04.826777096 O: test connection multiplexing: cmd stop 916s 19:53:15.900412685 O: ok connection multiplexing 916s 19:53:15.900457685 E: run test reexec.sh ... 917s 19:53:16.174509378 O: test config passing 917s 19:53:16.742875867 O: test reexec fallback 917s 19:53:16.744022882 E: ln: failed to create hard link '/tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/sshd' => '/usr/sbin/sshd': Operation not permitted 918s 19:53:17.292684594 O: ok reexec tests 918s 19:53:17.294702781 E: run test brokenkeys.sh ... 919s 19:53:18.473235261 E: run test sshcfgparse.sh ... 919s 19:53:18.471726522 O: ok broken keys 919s 19:53:18.910057474 O: reparse minimal config 919s 19:53:18.944959409 O: ssh -W opts 920s 19:53:19.040055929 O: user first match 920s 19:53:19.103560076 O: pubkeyacceptedalgorithms 920s 19:53:19.294241081 O: agentforwarding 920s 19:53:19.385056784 O: command line override 920s 19:53:19.426661846 E: run test cfgparse.sh ... 920s 19:53:19.426686727 O: ok ssh config parse 922s 19:53:19.724352086 O: reparse minimal config 922s 19:53:19.882712709 O: reparse regress config 922s 19:53:20.041727221 O: listenaddress order 922s 19:53:20.209856012 E: run test cfgmatch.sh ... 922s 19:53:20.209494247 O: ok sshd config parse 929s 19:53:28.908117650 O: ok sshd_config match 929s 19:53:28.908363413 E: run test cfgmatchlisten.sh ... 943s 19:53:42.417641146 O: ok sshd_config matchlisten 943s 19:53:42.418570438 E: run test percent.sh ... 943s 19:53:42.717841047 O: percent expansions matchexec percent 947s 19:53:46.632973669 O: percent expansions localcommand percent 951s 19:53:50.721291877 O: percent expansions remotecommand percent 951s 19:53:50.951760029 O: percent expansions controlpath percent 952s 19:53:51.158911238 O: percent expansions identityagent percent 952s 19:53:51.374629598 O: percent expansions forwardagent percent 952s 19:53:51.584546643 O: percent expansions localforward percent 952s 19:53:51.811216025 O: percent expansions remoteforward percent 953s 19:53:52.072183973 O: percent expansions revokedhostkeys percent 953s 19:53:52.291121614 O: percent expansions userknownhostsfile percent 956s 19:53:55.234921657 O: percent expansions controlpath dollar 956s 19:53:55.253668380 O: percent expansions identityagent dollar 956s 19:53:55.271435611 O: percent expansions forwardagent dollar 956s 19:53:55.289762088 O: percent expansions localforward dollar 956s 19:53:55.307531359 O: percent expansions remoteforward dollar 956s 19:53:55.325135307 O: percent expansions userknownhostsfile dollar 956s 19:53:55.613729972 O: percent expansions controlpath tilde 956s 19:53:55.647412809 O: percent expansions identityagent tilde 956s 19:53:55.680816802 O: percent expansions forwardagent tilde 956s 19:53:55.714989246 O: ok percent expansions 956s 19:53:55.715319490 E: run test addrmatch.sh ... 957s 19:53:55.979674320 O: test first entry for user 192.168.0.1 somehost 957s 19:53:56.048870938 O: test negative match for user 192.168.30.1 somehost 957s 19:53:56.117594309 O: test no match for user 19.0.0.1 somehost 957s 19:53:56.185909355 O: test list middle for user 10.255.255.254 somehost 957s 19:53:56.254760049 O: test faked IP in hostname for user 192.168.30.1 192.168.0.1 957s 19:53:56.323474780 O: test bare IP4 address for user 1.1.1.1 somehost.example.com 957s 19:53:56.393305446 O: test localaddress for user 19.0.0.1 somehost 957s 19:53:56.464456889 O: test localport for user 19.0.0.1 somehost 957s 19:53:56.534335476 O: test bare IP6 address for user ::1 somehost.example.com 957s 19:53:56.604993232 O: test deny IPv6 for user ::2 somehost.example.com 957s 19:53:56.673543762 O: test IP6 negated for user ::3 somehost 957s 19:53:56.742256573 O: test IP6 no match for user ::4 somehost 957s 19:53:56.811892596 O: test IP6 network for user 2000::1 somehost 957s 19:53:56.880657488 O: test IP6 network for user 2001::1 somehost 957s 19:53:56.950519235 O: test IP6 localaddress for user ::5 somehost 958s 19:53:57.020212459 O: test IP6 localport for user ::5 somehost 958s 19:53:57.091974990 O: test invalid Match address 10.0.1.0/8 958s 19:53:57.111092958 O: test invalid Match localaddress 10.0.1.0/8 958s 19:53:57.130366768 O: test invalid Match address 10.0.0.1/24 958s 19:53:57.150233985 O: test invalid Match localaddress 10.0.0.1/24 958s 19:53:57.167732692 O: test invalid Match address 2000:aa:bb:01::/56 958s 19:53:57.185213839 O: test invalid Match localaddress 2000:aa:bb:01::/56 958s 19:53:57.213365164 E: run test localcommand.sh ... 958s 19:53:57.213368924 O: ok address match 958s 19:53:57.581192896 O: test localcommand: proto localcommand 958s 19:53:57.937447717 O: ok localcommand 958s 19:53:57.940352835 E: run test forcecommand.sh ... 960s 19:53:59.826324295 E: Connection closed. 960s 19:53:59.828904248 E: Connection closed 961s 19:54:00.537494717 E: Connection closed. 961s 19:54:00.539375181 E: Connection closed 961s 19:54:00.919004184 E: run test portnum.sh ... 961s 19:54:00.919602632 O: ok forced command 962s 19:54:01.307914907 O: port number parsing: invalid port 0 962s 19:54:01.324571843 O: port number parsing: invalid port 65536 962s 19:54:01.346666249 O: port number parsing: invalid port 131073 962s 19:54:01.365860578 O: port number parsing: invalid port 2000blah 962s 19:54:01.385558993 O: port number parsing: invalid port blah2000 962s 19:54:01.406925030 O: port number parsing: valid port 1 962s 19:54:01.775214005 O: port number parsing: valid port 22 963s 19:54:02.120296280 O: port number parsing: valid port 2222 963s 19:54:02.447613723 O: port number parsing: valid port 22222 963s 19:54:02.764731874 O: port number parsing: valid port 65535 964s 19:54:03.071259528 O: ok port number parsing 964s 19:54:03.071462650 E: run test keytype.sh ... 964s 19:54:03.407112601 O: keygen ed25519, 512 bits 964s 19:54:03.423264771 O: keygen ed25519-sk, n/a bits 964s 19:54:03.444746089 O: keygen ecdsa, 256 bits 964s 19:54:03.459567041 O: keygen ecdsa, 384 bits 964s 19:54:03.478572768 O: keygen ecdsa, 521 bits 964s 19:54:03.502950204 O: keygen ecdsa-sk, n/a bits 964s 19:54:03.523778714 O: keygen dsa, 1024 bits 964s 19:54:03.678679082 O: keygen rsa, 2048 bits 965s 19:54:04.013546782 O: keygen rsa, 3072 bits 965s 19:54:04.686005298 O: userkey ed25519-512, hostkey ed25519-512 965s 19:54:04.911748784 O: userkey ed25519-512, hostkey ed25519-512 966s 19:54:05.172097198 O: userkey ed25519-512, hostkey ed25519-512 966s 19:54:05.460813100 O: userkey ed25519-sk, hostkey ed25519-sk 966s 19:54:05.722227048 O: userkey ed25519-sk, hostkey ed25519-sk 966s 19:54:05.925179118 O: userkey ed25519-sk, hostkey ed25519-sk 967s 19:54:06.133563018 O: userkey ecdsa-256, hostkey ecdsa-256 967s 19:54:06.327481491 O: userkey ecdsa-256, hostkey ecdsa-256 967s 19:54:06.518983773 O: userkey ecdsa-256, hostkey ecdsa-256 967s 19:54:06.725012443 O: userkey ecdsa-384, hostkey ecdsa-384 968s 19:54:07.024899288 O: userkey ecdsa-384, hostkey ecdsa-384 968s 19:54:07.326360394 O: userkey ecdsa-384, hostkey ecdsa-384 968s 19:54:07.653685395 O: userkey ecdsa-521, hostkey ecdsa-521 969s 19:54:08.109750904 O: userkey ecdsa-521, hostkey ecdsa-521 969s 19:54:08.568002841 O: userkey ecdsa-521, hostkey ecdsa-521 970s 19:54:09.067870117 O: userkey ecdsa-sk, hostkey ecdsa-sk 970s 19:54:09.350577579 O: userkey ecdsa-sk, hostkey ecdsa-sk 970s 19:54:09.620252712 O: userkey ecdsa-sk, hostkey ecdsa-sk 970s 19:54:09.880784087 O: userkey dsa-1024, hostkey dsa-1024 971s 19:54:10.093228959 O: userkey dsa-1024, hostkey dsa-1024 971s 19:54:10.303233559 O: userkey dsa-1024, hostkey dsa-1024 971s 19:54:10.528377915 O: userkey rsa-2048, hostkey rsa-2048 971s 19:54:10.744873799 O: userkey rsa-2048, hostkey rsa-2048 972s 19:54:10.979745922 O: userkey rsa-2048, hostkey rsa-2048 972s 19:54:11.245625845 O: userkey rsa-3072, hostkey rsa-3072 972s 19:54:11.486151520 O: userkey rsa-3072, hostkey rsa-3072 972s 19:54:11.709052247 O: userkey rsa-3072, hostkey rsa-3072 972s 19:54:11.924020031 O: ok login with different key types 972s 19:54:11.924419396 E: run test kextype.sh ... 973s 19:54:12.223431868 O: kex diffie-hellman-group1-sha1 974s 19:54:13.109468501 O: kex diffie-hellman-group14-sha1 975s 19:54:14.040482196 O: kex diffie-hellman-group14-sha256 975s 19:54:14.937950575 O: kex diffie-hellman-group16-sha512 977s 19:54:16.010438378 O: kex diffie-hellman-group18-sha512 978s 19:54:17.799481934 O: kex diffie-hellman-group-exchange-sha1 980s 19:54:19.597627042 O: kex diffie-hellman-group-exchange-sha256 982s 19:54:21.457503825 O: kex ecdh-sha2-nistp256 983s 19:54:22.284071797 O: kex ecdh-sha2-nistp384 984s 19:54:23.398093206 O: kex ecdh-sha2-nistp521 985s 19:54:24.438462701 O: kex curve25519-sha256 986s 19:54:25.273190095 O: kex curve25519-sha256@libssh.org 987s 19:54:26.105975544 O: kex sntrup761x25519-sha512@openssh.com 988s 19:54:27.346620624 O: ok login with different key exchange algorithms 988s 19:54:27.346792386 E: run test cert-hostkey.sh ... 989s 19:54:28.168928534 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/host_ca_key.pub 989s 19:54:28.170412993 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/host_ca_key2.pub 989s 19:54:28.171883932 O: certified host keys: sign host ed25519 cert 989s 19:54:28.181266693 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ed25519.pub 989s 19:54:28.197986669 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ed25519-cert.pub 989s 19:54:28.201986601 O: certified host keys: sign host sk-ssh-ed25519@openssh.com cert 989s 19:54:28.216642991 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_sk-ssh-ed25519@openssh.com.pub 989s 19:54:28.232931641 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_sk-ssh-ed25519@openssh.com-cert.pub 989s 19:54:28.237061695 O: certified host keys: sign host ecdsa-sha2-nistp256 cert 989s 19:54:28.247234786 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp256.pub 989s 19:54:28.264077364 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp256-cert.pub 989s 19:54:28.268599102 O: certified host keys: sign host ecdsa-sha2-nistp384 cert 989s 19:54:28.285989927 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp384.pub 989s 19:54:28.309709434 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp384-cert.pub 989s 19:54:28.314127691 O: certified host keys: sign host ecdsa-sha2-nistp521 cert 989s 19:54:28.341889050 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp521.pub 989s 19:54:28.376373015 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_ecdsa-sha2-nistp521-cert.pub 989s 19:54:28.380675071 O: certified host keys: sign host sk-ecdsa-sha2-nistp256@openssh.com cert 989s 19:54:28.398300339 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_sk-ecdsa-sha2-nistp256@openssh.com.pub 989s 19:54:28.416033608 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_sk-ecdsa-sha2-nistp256@openssh.com-cert.pub 989s 19:54:28.420268743 O: certified host keys: sign host dsa cert 989s 19:54:28.571432137 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_dsa.pub 989s 19:54:28.588997564 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_dsa-cert.pub 989s 19:54:28.593909107 O: certified host keys: sign host rsa cert 990s 19:54:29.674689197 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_rsa.pub 990s 19:54:29.691118529 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_rsa-cert.pub 990s 19:54:29.695473025 O: certified host keys: sign host rsa-sha2-256 cert 992s 19:54:31.146191334 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-256.pub 992s 19:54:31.169100630 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-256-cert.pub 992s 19:54:31.174115815 O: certified host keys: sign host rsa-sha2-512 cert 993s 19:54:32.701607352 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-512.pub 993s 19:54:32.728899065 O: Revoking from /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/cert_host_key_rsa-sha2-512-cert.pub 993s 19:54:32.733815728 O: certified host keys: host ed25519 cert connect 993s 19:54:32.741309865 O: certified host keys: ed25519 basic connect expect success yes 994s 19:54:33.051985679 O: certified host keys: ed25519 empty KRL expect success yes 994s 19:54:33.379786194 O: certified host keys: ed25519 KRL w/ plain key revoked expect success no 994s 19:54:33.603838289 O: certified host keys: ed25519 KRL w/ cert revoked expect success no 994s 19:54:33.829066558 O: certified host keys: ed25519 KRL w/ CA revoked expect success no 995s 19:54:34.058220439 O: certified host keys: ed25519 empty plaintext revocation expect success yes 995s 19:54:34.378694619 O: certified host keys: ed25519 plain key plaintext revocation expect success no 995s 19:54:34.595514219 O: certified host keys: ed25519 cert plaintext revocation expect success no 995s 19:54:34.815074576 O: certified host keys: ed25519 CA plaintext revocation expect success no 996s 19:54:35.023846632 O: certified host keys: host sk-ssh-ed25519@openssh.com cert connect 996s 19:54:35.028369771 O: certified host keys: sk-ssh-ed25519@openssh.com basic connect expect success yes 996s 19:54:35.380583880 O: certified host keys: sk-ssh-ed25519@openssh.com empty KRL expect success yes 996s 19:54:35.682172416 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ plain key revoked expect success no 996s 19:54:35.888187717 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ cert revoked expect success no 997s 19:54:36.099969532 O: certified host keys: sk-ssh-ed25519@openssh.com KRL w/ CA revoked expect success no 997s 19:54:36.315020709 O: certified host keys: sk-ssh-ed25519@openssh.com empty plaintext revocation expect success yes 997s 19:54:36.598495250 O: certified host keys: sk-ssh-ed25519@openssh.com plain key plaintext revocation expect success no 997s 19:54:36.807311347 O: certified host keys: sk-ssh-ed25519@openssh.com cert plaintext revocation expect success no 998s 19:54:37.021676836 O: certified host keys: sk-ssh-ed25519@openssh.com CA plaintext revocation expect success no 998s 19:54:37.228646669 O: certified host keys: host ecdsa-sha2-nistp256 cert connect 998s 19:54:37.231645747 O: certified host keys: ecdsa-sha2-nistp256 basic connect expect success yes 998s 19:54:37.515449412 O: certified host keys: ecdsa-sha2-nistp256 empty KRL expect success yes 998s 19:54:37.810383941 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ plain key revoked expect success no 999s 19:54:38.012715634 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ cert revoked expect success no 999s 19:54:38.225435660 O: certified host keys: ecdsa-sha2-nistp256 KRL w/ CA revoked expect success no 999s 19:54:38.432202050 O: certified host keys: ecdsa-sha2-nistp256 empty plaintext revocation expect success yes 999s 19:54:38.714511615 O: certified host keys: ecdsa-sha2-nistp256 plain key plaintext revocation expect success no 999s 19:54:38.918744812 O: certified host keys: ecdsa-sha2-nistp256 cert plaintext revocation expect success no 1000s 19:54:39.133013819 O: certified host keys: ecdsa-sha2-nistp256 CA plaintext revocation expect success no 1000s 19:54:39.334494100 O: certified host keys: host ecdsa-sha2-nistp384 cert connect 1000s 19:54:39.337564660 O: certified host keys: ecdsa-sha2-nistp384 basic connect expect success yes 1000s 19:54:39.668181568 O: certified host keys: ecdsa-sha2-nistp384 empty KRL expect success yes 1001s 19:54:39.998824877 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ plain key revoked expect success no 1001s 19:54:40.228272719 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ cert revoked expect success no 1001s 19:54:40.465297859 O: certified host keys: ecdsa-sha2-nistp384 KRL w/ CA revoked expect success no 1001s 19:54:40.695727554 O: certified host keys: ecdsa-sha2-nistp384 empty plaintext revocation expect success yes 1002s 19:54:41.004009694 O: certified host keys: ecdsa-sha2-nistp384 plain key plaintext revocation expect success no 1002s 19:54:41.235065196 O: certified host keys: ecdsa-sha2-nistp384 cert plaintext revocation expect success no 1002s 19:54:41.487627976 O: certified host keys: ecdsa-sha2-nistp384 CA plaintext revocation expect success no 1002s 19:54:41.719091164 O: certified host keys: host ecdsa-sha2-nistp521 cert connect 1002s 19:54:41.722094803 O: certified host keys: ecdsa-sha2-nistp521 basic connect expect success yes 1003s 19:54:42.107822942 O: certified host keys: ecdsa-sha2-nistp521 empty KRL expect success yes 1003s 19:54:42.511701594 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ plain key revoked expect success no 1003s 19:54:42.783884147 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ cert revoked expect success no 1004s 19:54:43.055683935 O: certified host keys: ecdsa-sha2-nistp521 KRL w/ CA revoked expect success no 1004s 19:54:43.327920369 O: certified host keys: ecdsa-sha2-nistp521 empty plaintext revocation expect success yes 1004s 19:54:43.710020700 O: certified host keys: ecdsa-sha2-nistp521 plain key plaintext revocation expect success no 1005s 19:54:43.995843708 O: certified host keys: ecdsa-sha2-nistp521 cert plaintext revocation expect success no 1005s 19:54:44.298347652 O: certified host keys: ecdsa-sha2-nistp521 CA plaintext revocation expect success no 1005s 19:54:44.575491388 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com cert connect 1005s 19:54:44.578674109 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com basic connect expect success yes 1005s 19:54:44.864081192 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com empty KRL expect success yes 1006s 19:54:45.149261992 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ plain key revoked expect success no 1006s 19:54:45.359288422 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ cert revoked expect success no 1006s 19:54:45.569143369 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com KRL w/ CA revoked expect success no 1006s 19:54:45.780061491 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com empty plaintext revocation expect success yes 1007s 19:54:46.101107873 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com plain key plaintext revocation expect success no 1007s 19:54:46.322648531 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com cert plaintext revocation expect success no 1007s 19:54:46.567119725 O: certified host keys: sk-ecdsa-sha2-nistp256@openssh.com CA plaintext revocation expect success no 1007s 19:54:46.774381919 O: certified host keys: host dsa cert connect 1007s 19:54:46.777602040 O: certified host keys: dsa basic connect expect success yes 1008s 19:54:47.061957589 O: certified host keys: dsa empty KRL expect success yes 1008s 19:54:47.345018040 O: certified host keys: dsa KRL w/ plain key revoked expect success no 1008s 19:54:47.546597840 O: certified host keys: dsa KRL w/ cert revoked expect success no 1008s 19:54:47.750439710 O: certified host keys: dsa KRL w/ CA revoked expect success no 1008s 19:54:47.952043751 O: certified host keys: dsa empty plaintext revocation expect success yes 1009s 19:54:48.230087577 O: certified host keys: dsa plain key plaintext revocation expect success no 1009s 19:54:48.449988213 O: certified host keys: dsa cert plaintext revocation expect success no 1009s 19:54:48.689900028 O: certified host keys: dsa CA plaintext revocation expect success no 1009s 19:54:48.891923794 O: certified host keys: host rsa cert connect 1009s 19:54:48.895102035 O: certified host keys: rsa basic connect expect success yes 1010s 19:54:49.201718869 O: certified host keys: rsa empty KRL expect success yes 1010s 19:54:49.502435308 O: certified host keys: rsa KRL w/ plain key revoked expect success no 1010s 19:54:49.716671191 O: certified host keys: rsa KRL w/ cert revoked expect success no 1010s 19:54:49.932207490 O: certified host keys: rsa KRL w/ CA revoked expect success no 1011s 19:54:50.154464357 O: certified host keys: rsa empty plaintext revocation expect success yes 1011s 19:54:50.470925238 O: certified host keys: rsa plain key plaintext revocation expect success no 1011s 19:54:50.711903705 O: certified host keys: rsa cert plaintext revocation expect success no 1012s 19:54:50.978234260 O: certified host keys: rsa CA plaintext revocation expect success no 1012s 19:54:51.211110463 O: certified host keys: host rsa-sha2-256 cert connect 1012s 19:54:51.214255823 O: certified host keys: rsa-sha2-256 basic connect expect success yes 1012s 19:54:51.502445859 O: certified host keys: rsa-sha2-256 empty KRL expect success yes 1012s 19:54:51.799300447 O: certified host keys: rsa-sha2-256 KRL w/ plain key revoked expect success no 1013s 19:54:52.014377260 O: certified host keys: rsa-sha2-256 KRL w/ cert revoked expect success no 1013s 19:54:52.235644633 O: certified host keys: rsa-sha2-256 KRL w/ CA revoked expect success no 1013s 19:54:52.467983428 O: certified host keys: rsa-sha2-256 empty plaintext revocation expect success yes 1013s 19:54:52.742016562 O: certified host keys: rsa-sha2-256 plain key plaintext revocation expect success no 1013s 19:54:52.961748274 O: certified host keys: rsa-sha2-256 cert plaintext revocation expect success no 1014s 19:54:53.210821766 O: certified host keys: rsa-sha2-256 CA plaintext revocation expect success no 1014s 19:54:53.417836034 O: certified host keys: host rsa-sha2-512 cert connect 1014s 19:54:53.421413560 O: certified host keys: rsa-sha2-512 basic connect expect success yes 1014s 19:54:53.705173859 O: certified host keys: rsa-sha2-512 empty KRL expect success yes 1014s 19:54:53.973386076 O: certified host keys: rsa-sha2-512 KRL w/ plain key revoked expect success no 1015s 19:54:54.178990007 O: certified host keys: rsa-sha2-512 KRL w/ cert revoked expect success no 1015s 19:54:54.384124611 O: certified host keys: rsa-sha2-512 KRL w/ CA revoked expect success no 1015s 19:54:54.596048903 O: certified host keys: rsa-sha2-512 empty plaintext revocation expect success yes 1015s 19:54:54.868436574 O: certified host keys: rsa-sha2-512 plain key plaintext revocation expect success no 1016s 19:54:55.094781091 O: certified host keys: rsa-sha2-512 cert plaintext revocation expect success no 1016s 19:54:55.354077233 O: certified host keys: rsa-sha2-512 CA plaintext revocation expect success no 1016s 19:54:55.581790488 O: certified host keys: host ed25519 revoked cert 1016s 19:54:55.816595315 O: certified host keys: host sk-ssh-ed25519@openssh.com revoked cert 1017s 19:54:56.057315697 O: certified host keys: host ecdsa-sha2-nistp256 revoked cert 1017s 19:54:56.304180159 O: certified host keys: host ecdsa-sha2-nistp384 revoked cert 1017s 19:54:56.582871670 O: certified host keys: host ecdsa-sha2-nistp521 revoked cert 1017s 19:54:56.892926106 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com revoked cert 1018s 19:54:57.160344112 O: certified host keys: host dsa revoked cert 1018s 19:54:57.402127948 O: certified host keys: host rsa revoked cert 1018s 19:54:57.661847495 O: certified host keys: host rsa-sha2-256 revoked cert 1018s 19:54:57.913714420 O: certified host keys: host rsa-sha2-512 revoked cert 1019s 19:54:58.178232749 O: certified host keys: host ed25519 revoked cert 1019s 19:54:58.400128608 O: certified host keys: host sk-ssh-ed25519@openssh.com revoked cert 1019s 19:54:58.616654118 O: certified host keys: host ecdsa-sha2-nistp256 revoked cert 1019s 19:54:58.821773201 O: certified host keys: host ecdsa-sha2-nistp384 revoked cert 1020s 19:54:59.056523705 O: certified host keys: host ecdsa-sha2-nistp521 revoked cert 1020s 19:54:59.334297084 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com revoked cert 1020s 19:54:59.546643020 O: certified host keys: host dsa revoked cert 1020s 19:54:59.758665831 O: certified host keys: host rsa revoked cert 1021s 19:54:59.984533621 O: certified host keys: host rsa-sha2-256 revoked cert 1021s 19:55:00.198580259 O: certified host keys: host rsa-sha2-512 revoked cert 1039s 19:55:18.456885294 O: certified host keys: host ed25519 cert downgrade to raw key 1040s 19:55:19.081647527 O: certified host keys: host sk-ssh-ed25519@openssh.com cert downgrade to raw key 1040s 19:55:19.712975484 O: certified host keys: host ecdsa-sha2-nistp256 cert downgrade to raw key 1041s 19:55:20.323548534 O: certified host keys: host ecdsa-sha2-nistp384 cert downgrade to raw key 1042s 19:55:21.024007379 O: certified host keys: host ecdsa-sha2-nistp521 cert downgrade to raw key 1042s 19:55:21.876697940 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com cert downgrade to raw key 1043s 19:55:22.553113115 O: certified host keys: host dsa cert downgrade to raw key 1044s 19:55:23.381194398 O: certified host keys: host rsa cert downgrade to raw key 1046s 19:55:24.992789509 O: certified host keys: host rsa-sha2-256 cert downgrade to raw key 1046s 19:55:25.793884163 O: certified host keys: host rsa-sha2-512 cert downgrade to raw key 1049s 19:55:28.310345574 O: certified host keys: host ed25519 connect wrong cert 1049s 19:55:28.547364899 O: certified host keys: host sk-ssh-ed25519@openssh.com connect wrong cert 1049s 19:55:28.810388437 O: certified host keys: host ecdsa-sha2-nistp256 connect wrong cert 1050s 19:55:29.032267608 O: certified host keys: host ecdsa-sha2-nistp384 connect wrong cert 1050s 19:55:29.312514047 O: certified host keys: host ecdsa-sha2-nistp521 connect wrong cert 1050s 19:55:29.688911562 O: certified host keys: host sk-ecdsa-sha2-nistp256@openssh.com connect wrong cert 1050s 19:55:29.950765125 O: certified host keys: host dsa connect wrong cert 1051s 19:55:30.297824703 O: certified host keys: host rsa connect wrong cert 1052s 19:55:31.259358332 O: certified host keys: host rsa-sha2-256 connect wrong cert 1053s 19:55:32.086033348 O: certified host keys: host rsa-sha2-512 connect wrong cert 1055s 19:55:34.386196642 E: run test cert-userkey.sh ... 1055s 19:55:34.387221695 O: ok certified host keys 1057s 19:55:36.194391854 O: certified user keys: sign user ed25519 cert 1057s 19:55:36.224109756 O: certified user keys: sign user sk-ssh-ed25519@openssh.com cert 1057s 19:55:36.258266754 O: certified user keys: sign user ecdsa-sha2-nistp256 cert 1057s 19:55:36.287398688 O: certified user keys: sign user ecdsa-sha2-nistp384 cert 1057s 19:55:36.320511713 O: certified user keys: sign user ecdsa-sha2-nistp521 cert 1057s 19:55:36.362979218 O: certified user keys: sign user sk-ecdsa-sha2-nistp256@openssh.com cert 1057s 19:55:36.393769813 O: certified user keys: sign user dsa cert 1057s 19:55:36.822332354 O: certified user keys: sign user rsa cert 1059s 19:55:38.645215790 O: certified user keys: sign user rsa-sha2-256 cert 1060s 19:55:39.821294202 O: certified user keys: sign user rsa-sha2-512 cert 1061s 19:55:40.101999724 O: certified user keys: ed25519 missing authorized_principals 1061s 19:55:40.412351386 O: certified user keys: ed25519 empty authorized_principals 1061s 19:55:40.718605915 O: certified user keys: ed25519 wrong authorized_principals 1062s 19:55:41.024907925 O: certified user keys: ed25519 correct authorized_principals 1062s 19:55:41.355684049 O: certified user keys: ed25519 authorized_principals bad key opt 1062s 19:55:41.660642162 O: certified user keys: ed25519 authorized_principals command=false 1063s 19:55:41.999131544 O: certified user keys: ed25519 authorized_principals command=true 1063s 19:55:42.331769771 O: certified user keys: ed25519 wrong principals key option 1063s 19:55:42.624234843 O: certified user keys: ed25519 correct principals key option 1063s 19:55:42.950527029 O: certified user keys: sk-ssh-ed25519@openssh.com missing authorized_principals 1064s 19:55:43.255335379 O: certified user keys: sk-ssh-ed25519@openssh.com empty authorized_principals 1064s 19:55:43.558253105 O: certified user keys: sk-ssh-ed25519@openssh.com wrong authorized_principals 1064s 19:55:43.860856826 O: certified user keys: sk-ssh-ed25519@openssh.com correct authorized_principals 1065s 19:55:44.178175616 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals bad key opt 1065s 19:55:44.479396680 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals command=false 1065s 19:55:44.794688964 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_principals command=true 1066s 19:55:45.118327234 O: certified user keys: sk-ssh-ed25519@openssh.com wrong principals key option 1066s 19:55:45.426281944 O: certified user keys: sk-ssh-ed25519@openssh.com correct principals key option 1066s 19:55:45.753411659 O: certified user keys: ecdsa-sha2-nistp256 missing authorized_principals 1067s 19:55:46.049215933 O: certified user keys: ecdsa-sha2-nistp256 empty authorized_principals 1067s 19:55:46.343417465 O: certified user keys: ecdsa-sha2-nistp256 wrong authorized_principals 1067s 19:55:46.638676812 O: certified user keys: ecdsa-sha2-nistp256 correct authorized_principals 1067s 19:55:46.963054131 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals bad key opt 1068s 19:55:47.273808796 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals command=false 1068s 19:55:47.622949193 O: certified user keys: ecdsa-sha2-nistp256 authorized_principals command=true 1068s 19:55:47.956950435 O: certified user keys: ecdsa-sha2-nistp256 wrong principals key option 1069s 19:55:48.273273931 O: certified user keys: ecdsa-sha2-nistp256 correct principals key option 1069s 19:55:48.620726026 O: certified user keys: ecdsa-sha2-nistp384 missing authorized_principals 1069s 19:55:48.949820045 O: certified user keys: ecdsa-sha2-nistp384 empty authorized_principals 1070s 19:55:49.268776574 O: certified user keys: ecdsa-sha2-nistp384 wrong authorized_principals 1070s 19:55:49.593752420 O: certified user keys: ecdsa-sha2-nistp384 correct authorized_principals 1070s 19:55:49.972698278 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals bad key opt 1071s 19:55:50.300583722 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals command=false 1071s 19:55:50.671720319 O: certified user keys: ecdsa-sha2-nistp384 authorized_principals command=true 1072s 19:55:51.031595252 O: certified user keys: ecdsa-sha2-nistp384 wrong principals key option 1072s 19:55:51.359858780 O: certified user keys: ecdsa-sha2-nistp384 correct principals key option 1072s 19:55:51.739349604 O: certified user keys: ecdsa-sha2-nistp521 missing authorized_principals 1073s 19:55:52.113555200 O: certified user keys: ecdsa-sha2-nistp521 empty authorized_principals 1073s 19:55:52.485724650 O: certified user keys: ecdsa-sha2-nistp521 wrong authorized_principals 1073s 19:55:52.860777096 O: certified user keys: ecdsa-sha2-nistp521 correct authorized_principals 1074s 19:55:53.305208592 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals bad key opt 1074s 19:55:53.682813231 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals command=false 1075s 19:55:54.128402741 O: certified user keys: ecdsa-sha2-nistp521 authorized_principals command=true 1075s 19:55:54.577199852 O: certified user keys: ecdsa-sha2-nistp521 wrong principals key option 1075s 19:55:54.919587679 O: certified user keys: ecdsa-sha2-nistp521 correct principals key option 1076s 19:55:55.341785089 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com missing authorized_principals 1076s 19:55:55.659457159 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com empty authorized_principals 1076s 19:55:55.965509720 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com wrong authorized_principals 1077s 19:55:56.271438360 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com correct authorized_principals 1077s 19:55:56.597450537 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals bad key opt 1077s 19:55:56.905038197 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals command=false 1078s 19:55:57.230620768 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_principals command=true 1078s 19:55:57.559470581 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com wrong principals key option 1078s 19:55:57.868041214 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com correct principals key option 1079s 19:55:58.201381524 O: certified user keys: dsa missing authorized_principals 1079s 19:55:58.496600625 O: certified user keys: dsa empty authorized_principals 1079s 19:55:58.788603405 O: certified user keys: dsa wrong authorized_principals 1080s 19:55:59.082550610 O: certified user keys: dsa correct authorized_principals 1080s 19:55:59.403016075 O: certified user keys: dsa authorized_principals bad key opt 1080s 19:55:59.698965065 O: certified user keys: dsa authorized_principals command=false 1081s 19:56:00.008464029 O: certified user keys: dsa authorized_principals command=true 1081s 19:56:00.321384877 O: certified user keys: dsa wrong principals key option 1081s 19:56:00.614727074 O: certified user keys: dsa correct principals key option 1081s 19:56:00.930685360 O: certified user keys: rsa missing authorized_principals 1082s 19:56:01.222327015 O: certified user keys: rsa empty authorized_principals 1082s 19:56:01.511410516 O: certified user keys: rsa wrong authorized_principals 1082s 19:56:01.798036787 O: certified user keys: rsa correct authorized_principals 1083s 19:56:02.111652123 O: certified user keys: rsa authorized_principals bad key opt 1083s 19:56:02.398205632 O: certified user keys: rsa authorized_principals command=false 1083s 19:56:02.710886355 O: certified user keys: rsa authorized_principals command=true 1084s 19:56:03.033237003 O: certified user keys: rsa wrong principals key option 1084s 19:56:03.327014764 O: certified user keys: rsa correct principals key option 1084s 19:56:03.651984045 O: certified user keys: rsa-sha2-256 missing authorized_principals 1084s 19:56:03.953140621 O: certified user keys: rsa-sha2-256 empty authorized_principals 1085s 19:56:04.254970045 O: certified user keys: rsa-sha2-256 wrong authorized_principals 1085s 19:56:04.556398704 O: certified user keys: rsa-sha2-256 correct authorized_principals 1085s 19:56:04.893774503 O: certified user keys: rsa-sha2-256 authorized_principals bad key opt 1086s 19:56:05.207464878 O: certified user keys: rsa-sha2-256 authorized_principals command=false 1086s 19:56:05.575528550 O: certified user keys: rsa-sha2-256 authorized_principals command=true 1086s 19:56:05.924667099 O: certified user keys: rsa-sha2-256 wrong principals key option 1087s 19:56:06.223630246 O: certified user keys: rsa-sha2-256 correct principals key option 1087s 19:56:06.561390929 O: certified user keys: rsa-sha2-512 missing authorized_principals 1087s 19:56:06.873870568 O: certified user keys: rsa-sha2-512 empty authorized_principals 1088s 19:56:07.170774888 O: certified user keys: rsa-sha2-512 wrong authorized_principals 1088s 19:56:07.474113771 O: certified user keys: rsa-sha2-512 correct authorized_principals 1088s 19:56:07.797647751 O: certified user keys: rsa-sha2-512 authorized_principals bad key opt 1089s 19:56:08.096728019 O: certified user keys: rsa-sha2-512 authorized_principals command=false 1089s 19:56:08.429690880 O: certified user keys: rsa-sha2-512 authorized_principals command=true 1089s 19:56:08.760264551 O: certified user keys: rsa-sha2-512 wrong principals key option 1090s 19:56:09.071186569 O: certified user keys: rsa-sha2-512 correct principals key option 1090s 19:56:09.428415061 O: certified user keys: ed25519 authorized_keys connect 1090s 19:56:09.760970156 O: certified user keys: ed25519 authorized_keys revoked key 1091s 19:56:10.091789229 O: certified user keys: ed25519 authorized_keys revoked via KRL 1091s 19:56:10.404121145 O: certified user keys: ed25519 authorized_keys empty KRL 1091s 19:56:10.734471612 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys connect 1092s 19:56:11.054526467 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys revoked key 1092s 19:56:11.351218143 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys revoked via KRL 1092s 19:56:11.660663182 O: certified user keys: sk-ssh-ed25519@openssh.com authorized_keys empty KRL 1093s 19:56:11.997081246 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys connect 1093s 19:56:12.330427070 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys revoked key 1093s 19:56:12.639028538 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys revoked via KRL 1093s 19:56:12.955935712 O: certified user keys: ecdsa-sha2-nistp256 authorized_keys empty KRL 1094s 19:56:13.279777495 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys connect 1094s 19:56:13.636272455 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys revoked key 1095s 19:56:13.976535447 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys revoked via KRL 1095s 19:56:14.301262121 O: certified user keys: ecdsa-sha2-nistp384 authorized_keys empty KRL 1095s 19:56:14.652900498 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys connect 1096s 19:56:15.100388342 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys revoked key 1096s 19:56:15.536767122 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys revoked via KRL 1096s 19:56:15.953265209 O: certified user keys: ecdsa-sha2-nistp521 authorized_keys empty KRL 1097s 19:56:16.380419472 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys connect 1097s 19:56:16.698845584 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys revoked key 1098s 19:56:17.008401022 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys revoked via KRL 1098s 19:56:17.320839697 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com authorized_keys empty KRL 1098s 19:56:17.653622153 O: certified user keys: dsa authorized_keys connect 1098s 19:56:17.970689647 O: certified user keys: dsa authorized_keys revoked key 1099s 19:56:18.280679250 O: certified user keys: dsa authorized_keys revoked via KRL 1099s 19:56:18.592640279 O: certified user keys: dsa authorized_keys empty KRL 1099s 19:56:18.935782546 O: certified user keys: rsa authorized_keys connect 1100s 19:56:19.260879303 O: certified user keys: rsa authorized_keys revoked key 1100s 19:56:19.555895114 O: certified user keys: rsa authorized_keys revoked via KRL 1100s 19:56:19.864849864 O: certified user keys: rsa authorized_keys empty KRL 1101s 19:56:20.189698177 O: certified user keys: rsa-sha2-256 authorized_keys connect 1101s 19:56:20.512183779 O: certified user keys: rsa-sha2-256 authorized_keys revoked key 1101s 19:56:20.824113687 O: certified user keys: rsa-sha2-256 authorized_keys revoked via KRL 1102s 19:56:21.128792262 O: certified user keys: rsa-sha2-256 authorized_keys empty KRL 1102s 19:56:21.454220301 O: certified user keys: rsa-sha2-512 authorized_keys connect 1102s 19:56:21.775738171 O: certified user keys: rsa-sha2-512 authorized_keys revoked key 1103s 19:56:22.079092408 O: certified user keys: rsa-sha2-512 authorized_keys revoked via KRL 1103s 19:56:22.379115163 O: certified user keys: rsa-sha2-512 authorized_keys empty KRL 1104s 19:56:22.701751487 O: certified user keys: rsa-sha2-512 authorized_keys revoked CA key 1104s 19:56:23.007217591 O: certified user keys: authorized_keys CA does not authenticate 1104s 19:56:23.010621874 O: certified user keys: ensure CA key does not authenticate user 1104s 19:56:23.305225119 O: certified user keys: ed25519 TrustedUserCAKeys connect 1104s 19:56:23.621102716 O: certified user keys: ed25519 TrustedUserCAKeys revoked key 1104s 19:56:23.923075576 O: certified user keys: ed25519 TrustedUserCAKeys revoked via KRL 1105s 19:56:24.225812364 O: certified user keys: ed25519 TrustedUserCAKeys empty KRL 1105s 19:56:24.552843103 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys connect 1105s 19:56:24.877895897 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys revoked key 1106s 19:56:25.175590341 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys revoked via KRL 1106s 19:56:25.485568702 O: certified user keys: sk-ssh-ed25519@openssh.com TrustedUserCAKeys empty KRL 1106s 19:56:25.825572566 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys connect 1107s 19:56:26.166599004 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys revoked key 1107s 19:56:26.475490270 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys revoked via KRL 1107s 19:56:26.784529899 O: certified user keys: ecdsa-sha2-nistp256 TrustedUserCAKeys empty KRL 1108s 19:56:27.109737814 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys connect 1108s 19:56:27.471997362 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys revoked key 1108s 19:56:27.806851440 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys revoked via KRL 1109s 19:56:28.121673102 O: certified user keys: ecdsa-sha2-nistp384 TrustedUserCAKeys empty KRL 1109s 19:56:28.477491927 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys connect 1109s 19:56:28.900148086 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys revoked key 1110s 19:56:29.296939115 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys revoked via KRL 1110s 19:56:29.699417055 O: certified user keys: ecdsa-sha2-nistp521 TrustedUserCAKeys empty KRL 1111s 19:56:30.158360037 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys connect 1111s 19:56:30.485903461 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys revoked key 1111s 19:56:30.808585342 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys revoked via KRL 1112s 19:56:31.132001193 O: certified user keys: sk-ecdsa-sha2-nistp256@openssh.com TrustedUserCAKeys empty KRL 1112s 19:56:31.464305077 O: certified user keys: dsa TrustedUserCAKeys connect 1112s 19:56:31.780806679 O: certified user keys: dsa TrustedUserCAKeys revoked key 1113s 19:56:32.085940415 O: certified user keys: dsa TrustedUserCAKeys revoked via KRL 1113s 19:56:32.396482821 O: certified user keys: dsa TrustedUserCAKeys empty KRL 1113s 19:56:32.725764906 O: certified user keys: rsa TrustedUserCAKeys connect 1114s 19:56:33.070085223 O: certified user keys: rsa TrustedUserCAKeys revoked key 1114s 19:56:33.392398178 O: certified user keys: rsa TrustedUserCAKeys revoked via KRL 1114s 19:56:33.707728045 O: certified user keys: rsa TrustedUserCAKeys empty KRL 1115s 19:56:34.046590811 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys connect 1115s 19:56:34.372193289 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys revoked key 1115s 19:56:34.670039811 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys revoked via KRL 1115s 19:56:34.971816544 O: certified user keys: rsa-sha2-256 TrustedUserCAKeys empty KRL 1116s 19:56:35.305434924 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys connect 1116s 19:56:35.629880706 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked key 1116s 19:56:35.923724937 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked via KRL 1117s 19:56:36.221966344 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys empty KRL 1117s 19:56:36.561217475 O: certified user keys: rsa-sha2-512 TrustedUserCAKeys revoked CA key 1117s 19:56:36.860706258 O: certified user keys: TrustedUserCAKeys CA does not authenticate 1117s 19:56:36.863590855 O: certified user keys: ensure CA key does not authenticate user 1118s 19:56:37.154089523 O: certified user keys: correct principal auth authorized_keys expect success rsa 1118s 19:56:37.490034571 O: certified user keys: correct principal auth authorized_keys expect success ed25519 1118s 19:56:37.818823208 O: certified user keys: correct principal auth TrustedUserCAKeys expect success rsa 1119s 19:56:38.162584956 O: certified user keys: correct principal auth TrustedUserCAKeys expect success ed25519 1119s 19:56:38.517437445 O: certified user keys: host-certificate auth authorized_keys expect failure rsa 1119s 19:56:38.817907440 O: certified user keys: host-certificate auth authorized_keys expect failure ed25519 1120s 19:56:39.117908189 O: certified user keys: host-certificate auth TrustedUserCAKeys expect failure rsa 1120s 19:56:39.424908507 O: certified user keys: host-certificate auth TrustedUserCAKeys expect failure ed25519 1120s 19:56:39.733210801 O: certified user keys: wrong principals auth authorized_keys expect failure rsa 1121s 19:56:40.064507869 O: certified user keys: wrong principals auth authorized_keys expect failure ed25519 1121s 19:56:40.366751286 O: certified user keys: wrong principals auth TrustedUserCAKeys expect failure rsa 1121s 19:56:40.676020113 O: certified user keys: wrong principals auth TrustedUserCAKeys expect failure ed25519 1122s 19:56:40.985089257 O: certified user keys: cert not yet valid auth authorized_keys expect failure rsa 1122s 19:56:41.299746032 O: certified user keys: cert not yet valid auth authorized_keys expect failure ed25519 1122s 19:56:41.604047595 O: certified user keys: cert not yet valid auth TrustedUserCAKeys expect failure rsa 1122s 19:56:41.916899706 O: certified user keys: cert not yet valid auth TrustedUserCAKeys expect failure ed25519 1123s 19:56:42.226059531 O: certified user keys: cert expired auth authorized_keys expect failure rsa 1123s 19:56:42.528337028 O: certified user keys: cert expired auth authorized_keys expect failure ed25519 1123s 19:56:42.829987917 O: certified user keys: cert expired auth TrustedUserCAKeys expect failure rsa 1124s 19:56:43.138695575 O: certified user keys: cert expired auth TrustedUserCAKeys expect failure ed25519 1124s 19:56:43.458336613 O: certified user keys: cert valid interval auth authorized_keys expect success rsa 1124s 19:56:43.799274923 O: certified user keys: cert valid interval auth authorized_keys expect success ed25519 1125s 19:56:44.157757016 O: certified user keys: cert valid interval auth TrustedUserCAKeys expect success rsa 1125s 19:56:44.513585595 O: certified user keys: cert valid interval auth TrustedUserCAKeys expect success ed25519 1125s 19:56:44.848946593 O: certified user keys: wrong source-address auth authorized_keys expect failure rsa 1126s 19:56:45.153938524 O: certified user keys: wrong source-address auth authorized_keys expect failure ed25519 1126s 19:56:45.456500703 O: certified user keys: wrong source-address auth TrustedUserCAKeys expect failure rsa 1126s 19:56:45.765500684 O: certified user keys: wrong source-address auth TrustedUserCAKeys expect failure ed25519 1127s 19:56:46.076690894 O: certified user keys: force-command auth authorized_keys expect failure rsa 1127s 19:56:46.429147989 O: certified user keys: force-command auth authorized_keys expect failure ed25519 1127s 19:56:46.783274586 O: certified user keys: force-command auth TrustedUserCAKeys expect failure rsa 1128s 19:56:47.123962651 O: certified user keys: force-command auth TrustedUserCAKeys expect failure ed25519 1128s 19:56:47.499553041 O: certified user keys: empty principals auth authorized_keys expect success rsa 1128s 19:56:47.833490300 O: certified user keys: empty principals auth authorized_keys expect success ed25519 1129s 19:56:48.174359447 O: certified user keys: empty principals auth TrustedUserCAKeys expect failure rsa 1129s 19:56:48.495834427 O: certified user keys: empty principals auth TrustedUserCAKeys expect failure ed25519 1129s 19:56:48.811277369 O: certified user keys: AuthorizedPrincipalsFile principals auth TrustedUserCAKeys expect success rsa 1130s 19:56:49.148307987 O: certified user keys: AuthorizedPrincipalsFile principals auth TrustedUserCAKeys expect success ed25519 1130s 19:56:49.494575442 O: certified user keys: AuthorizedPrincipalsFile no principals auth TrustedUserCAKeys expect failure rsa 1130s 19:56:49.813252186 O: certified user keys: AuthorizedPrincipalsFile no principals auth TrustedUserCAKeys expect failure ed25519 1131s 19:56:50.121241433 O: certified user keys: principals key option principals auth authorized_keys expect success rsa 1131s 19:56:50.454189278 O: certified user keys: principals key option principals auth authorized_keys expect success ed25519 1131s 19:56:50.804793268 O: certified user keys: principals key option no principals auth authorized_keys expect failure rsa 1132s 19:56:51.131213230 O: certified user keys: principals key option no principals auth authorized_keys expect failure ed25519 1132s 19:56:51.438635269 O: certified user keys: force-command match true auth authorized_keys expect success rsa 1132s 19:56:51.773679061 O: certified user keys: force-command match true auth authorized_keys expect success ed25519 1133s 19:56:52.107102712 O: certified user keys: force-command match true auth authorized_keys expect failure rsa 1133s 19:56:52.439876834 O: certified user keys: force-command match true auth authorized_keys expect failure ed25519 1133s 19:56:52.768654185 O: certified user keys: force-command mismatch 1 auth authorized_keys expect failure rsa 1134s 19:56:53.073670033 O: certified user keys: force-command mismatch 1 auth authorized_keys expect failure ed25519 1134s 19:56:53.376183730 O: certified user keys: force-command mismatch 2 auth authorized_keys expect failure rsa 1134s 19:56:53.686748648 O: certified user keys: force-command mismatch 2 auth authorized_keys expect failure ed25519 1135s 19:56:54.001180456 O: certified user keys: user ed25519 connect wrong cert 1135s 19:56:54.303251626 O: certified user keys: user sk-ssh-ed25519@openssh.com connect wrong cert 1135s 19:56:54.585510584 O: certified user keys: user ecdsa-sha2-nistp256 connect wrong cert 1135s 19:56:54.891244081 O: certified user keys: user ecdsa-sha2-nistp384 connect wrong cert 1136s 19:56:55.235313186 O: certified user keys: user ecdsa-sha2-nistp521 connect wrong cert 1136s 19:56:55.524891917 O: certified user keys: user sk-ecdsa-sha2-nistp256@openssh.com connect wrong cert 1136s 19:56:55.820048838 O: certified user keys: user dsa connect wrong cert 1137s 19:56:56.137351402 O: certified user keys: user rsa connect wrong cert 1137s 19:56:56.447708837 O: certified user keys: user rsa-sha2-256 connect wrong cert 1137s 19:56:56.757850190 O: certified user keys: user rsa-sha2-512 connect wrong cert 1138s 19:56:57.053754401 O: ok certified user keys 1138s 19:56:57.054897735 E: run test host-expand.sh ... 1138s 19:56:57.622763811 O: ok expand %h and %n 1138s 19:56:57.622804972 E: run test keys-command.sh ... 1138s 19:56:57.914103684 O: AuthorizedKeysCommand with arguments 1139s 19:56:58.231394167 O: AuthorizedKeysCommand without arguments 1139s 19:56:58.564375369 O: ok authorized keys from command 1139s 19:56:58.577092331 E: run test forward-control.sh ... 1141s 19:57:00.714578284 O: check_lfwd done (expecting Y): default configuration 1143s 19:57:02.428441436 O: check_rfwd done (expecting Y): default configuration 1145s 19:57:04.115474643 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes 1146s 19:57:05.816962871 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes 1148s 19:57:07.181982572 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, !PermitOpen 1149s 19:57:08.936925395 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, !PermitOpen 1151s 19:57:10.647391209 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, PermitOpen 1153s 19:57:12.368528756 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, PermitOpen 1154s 19:57:13.724540813 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, !permitopen 1156s 19:57:15.443255883 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, !permitopen 1158s 19:57:17.135906179 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, permitopen 1159s 19:57:18.857692203 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, permitopen 1161s 19:57:20.201009089 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, no-port-forwarding 1161s 19:57:20.589691433 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, no-port-forwarding 1163s 19:57:21.985509785 O: check_lfwd done (expecting N): AllowTcpForwarding=yes, restrict 1163s 19:57:22.334891468 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, restrict 1165s 19:57:24.051793260 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, restrict,port-forwarding 1166s 19:57:25.760526786 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, restrict,port-forwarding 1168s 19:57:27.454830885 O: check_lfwd done (expecting Y): AllowTcpForwarding=local 1168s 19:57:27.782416609 O: check_rfwd done (expecting N): AllowTcpForwarding=local 1170s 19:57:29.130874989 O: check_lfwd done (expecting N): AllowTcpForwarding=local, !PermitOpen 1170s 19:57:29.449847603 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !PermitOpen 1172s 19:57:31.152452281 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, PermitOpen 1172s 19:57:31.540027767 O: check_rfwd done (expecting N): AllowTcpForwarding=local, PermitOpen 1173s 19:57:32.938061252 O: check_lfwd done (expecting N): AllowTcpForwarding=local, !permitopen 1174s 19:57:33.269930308 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !permitopen 1175s 19:57:34.971954853 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, permitopen 1176s 19:57:35.328004496 O: check_rfwd done (expecting N): AllowTcpForwarding=local, permitopen 1177s 19:57:36.704759865 O: check_lfwd done (expecting N): AllowTcpForwarding=local, no-port-forwarding 1178s 19:57:37.043338766 O: check_rfwd done (expecting N): AllowTcpForwarding=local, no-port-forwarding 1178s 19:57:37.398965323 O: check_lfwd done (expecting N): AllowTcpForwarding=local, restrict 1178s 19:57:37.757230074 O: check_rfwd done (expecting N): AllowTcpForwarding=local, restrict 1180s 19:57:39.494567860 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, restrict,port-forwarding 1180s 19:57:39.819034700 O: check_rfwd done (expecting N): AllowTcpForwarding=local, restrict,port-forwarding 1182s 19:57:41.159758606 O: check_lfwd done (expecting N): AllowTcpForwarding=remote 1183s 19:57:42.886755334 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote 1185s 19:57:44.229205538 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !PermitOpen 1186s 19:57:45.957410717 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, !PermitOpen 1188s 19:57:47.294014882 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, PermitOpen 1190s 19:57:49.005464763 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, PermitOpen 1191s 19:57:50.346359379 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !permitopen 1193s 19:57:52.046868836 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, !permitopen 1194s 19:57:53.385379418 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, permitopen 1196s 19:57:55.134741330 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, permitopen 1196s 19:57:55.503317605 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, no-port-forwarding 1196s 19:57:55.855306310 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, no-port-forwarding 1198s 19:57:57.258021261 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, restrict 1198s 19:57:57.605415667 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, restrict 1200s 19:57:58.979279050 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, restrict,port-forwarding 1201s 19:58:00.816308064 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, restrict,port-forwarding 1203s 19:58:02.246003831 O: check_lfwd done (expecting N): AllowTcpForwarding=no 1203s 19:58:02.692220448 O: check_rfwd done (expecting N): AllowTcpForwarding=no 1204s 19:58:03.138719069 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !PermitOpen 1204s 19:58:03.584556280 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !PermitOpen 1206s 19:58:05.084389813 O: check_lfwd done (expecting N): AllowTcpForwarding=no, PermitOpen 1206s 19:58:05.469053128 O: check_rfwd done (expecting N): AllowTcpForwarding=no, PermitOpen 1207s 19:58:06.900503071 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !permitopen 1208s 19:58:07.328007889 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !permitopen 1209s 19:58:08.804096835 O: check_lfwd done (expecting N): AllowTcpForwarding=no, permitopen 1210s 19:58:09.163259147 O: check_rfwd done (expecting N): AllowTcpForwarding=no, permitopen 1210s 19:58:09.533303716 O: check_lfwd done (expecting N): AllowTcpForwarding=no, no-port-forwarding 1210s 19:58:09.879659064 O: check_rfwd done (expecting N): AllowTcpForwarding=no, no-port-forwarding 1211s 19:58:10.240426636 O: check_lfwd done (expecting N): AllowTcpForwarding=no, restrict 1211s 19:58:10.584121470 O: check_rfwd done (expecting N): AllowTcpForwarding=no, restrict 1212s 19:58:11.961321319 O: check_lfwd done (expecting N): AllowTcpForwarding=no, restrict,port-forwarding 1213s 19:58:12.309616652 O: check_rfwd done (expecting N): AllowTcpForwarding=no, restrict,port-forwarding 1215s 19:58:14.032623679 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, !PermitListen 1215s 19:58:14.393542731 O: check_rfwd done (expecting N): AllowTcpForwarding=yes, !PermitListen 1217s 19:58:16.127247850 O: check_lfwd done (expecting Y): AllowTcpForwarding=yes, PermitListen 1219s 19:58:17.908228765 O: check_rfwd done (expecting Y): AllowTcpForwarding=yes, PermitListen 1220s 19:58:19.648122597 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, !PermitListen 1221s 19:58:19.992643160 O: check_rfwd done (expecting N): AllowTcpForwarding=local, !PermitListen 1222s 19:58:21.713135743 O: check_lfwd done (expecting Y): AllowTcpForwarding=local, PermitListen 1223s 19:58:22.095353902 O: check_rfwd done (expecting N): AllowTcpForwarding=local, PermitListen 1223s 19:58:22.470884576 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, !PermitListen 1224s 19:58:22.841291865 O: check_rfwd done (expecting N): AllowTcpForwarding=remote, !PermitListen 1224s 19:58:23.236354946 O: check_lfwd done (expecting N): AllowTcpForwarding=remote, PermitListen 1226s 19:58:25.033115770 O: check_rfwd done (expecting Y): AllowTcpForwarding=remote, PermitListen 1227s 19:58:26.427337536 O: check_lfwd done (expecting N): AllowTcpForwarding=no, !PermitListen 1227s 19:58:26.783321161 O: check_rfwd done (expecting N): AllowTcpForwarding=no, !PermitListen 1228s 19:58:27.156843368 O: check_lfwd done (expecting N): AllowTcpForwarding=no, PermitListen 1228s 19:58:27.489984264 O: check_rfwd done (expecting N): AllowTcpForwarding=no, PermitListen 1228s 19:58:27.517678975 O: ok sshd control of local and remote forwarding 1228s 19:58:27.518415664 E: run test integrity.sh ... 1228s 19:58:27.802345697 O: test integrity: hmac-sha1 @2900 1229s 19:58:28.117458005 O: test integrity: hmac-sha1 @2901 1229s 19:58:28.431685901 O: test integrity: hmac-sha1 @2902 1229s 19:58:28.782343578 O: test integrity: hmac-sha1 @2903 1230s 19:58:29.123008729 O: test integrity: hmac-sha1 @2904 1230s 19:58:29.444377676 O: test integrity: hmac-sha1 @2905 1230s 19:58:29.758456410 O: test integrity: hmac-sha1 @2906 1231s 19:58:30.095654876 O: test integrity: hmac-sha1 @2907 1231s 19:58:30.423496584 O: test integrity: hmac-sha1 @2908 1231s 19:58:30.770724778 O: test integrity: hmac-sha1 @2909 1232s 19:58:31.083444334 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1232s 19:58:31.106793390 O: test integrity: hmac-sha1-96 @2900 1232s 19:58:31.445847359 O: test integrity: hmac-sha1-96 @2901 1232s 19:58:31.767894233 O: test integrity: hmac-sha1-96 @2902 1233s 19:58:32.097145279 O: test integrity: hmac-sha1-96 @2903 1233s 19:58:32.428310508 O: test integrity: hmac-sha1-96 @2904 1233s 19:58:32.760382229 O: test integrity: hmac-sha1-96 @2905 1234s 19:58:33.096316399 O: test integrity: hmac-sha1-96 @2906 1234s 19:58:33.424887475 O: test integrity: hmac-sha1-96 @2907 1234s 19:58:33.757700005 O: test integrity: hmac-sha1-96 @2908 1235s 19:58:34.079613357 O: test integrity: hmac-sha1-96 @2909 1235s 19:58:34.383617723 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1235s 19:58:34.402317839 O: test integrity: hmac-sha2-256 @2900 1235s 19:58:34.729145333 O: test integrity: hmac-sha2-256 @2901 1236s 19:58:35.060687887 O: test integrity: hmac-sha2-256 @2902 1236s 19:58:35.381918870 O: test integrity: hmac-sha2-256 @2903 1236s 19:58:35.707660110 O: test integrity: hmac-sha2-256 @2904 1237s 19:58:36.051571860 O: test integrity: hmac-sha2-256 @2905 1237s 19:58:36.398099362 O: test integrity: hmac-sha2-256 @2906 1237s 19:58:36.758954646 O: test integrity: hmac-sha2-256 @2907 1238s 19:58:37.154276125 O: test integrity: hmac-sha2-256 @2908 1238s 19:58:37.542660557 O: test integrity: hmac-sha2-256 @2909 1239s 19:58:37.920988381 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1239s 19:58:37.945123407 O: test integrity: hmac-sha2-512 @2900 1239s 19:58:38.264878890 O: test integrity: hmac-sha2-512 @2901 1239s 19:58:38.596094839 O: test integrity: hmac-sha2-512 @2902 1239s 19:58:38.910076569 O: test integrity: hmac-sha2-512 @2903 1240s 19:58:39.247475515 O: test integrity: hmac-sha2-512 @2904 1240s 19:58:39.576955041 O: test integrity: hmac-sha2-512 @2905 1240s 19:58:39.926823865 O: test integrity: hmac-sha2-512 @2906 1241s 19:58:40.277580340 O: test integrity: hmac-sha2-512 @2907 1241s 19:58:40.647577058 O: test integrity: hmac-sha2-512 @2908 1242s 19:58:41.026490409 O: test integrity: hmac-sha2-512 @2909 1242s 19:58:41.377286444 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1242s 19:58:41.430495437 O: test integrity: hmac-md5 @2900 1242s 19:58:41.875859708 O: test integrity: hmac-md5 @2901 1243s 19:58:42.306666154 O: test integrity: hmac-md5 @2902 1243s 19:58:42.671566927 O: test integrity: hmac-md5 @2903 1244s 19:58:43.028404678 O: test integrity: hmac-md5 @2904 1244s 19:58:43.401225791 O: test integrity: hmac-md5 @2905 1244s 19:58:43.741319610 O: test integrity: hmac-md5 @2906 1245s 19:58:44.062151186 O: test integrity: hmac-md5 @2907 1245s 19:58:44.387809782 O: test integrity: hmac-md5 @2908 1245s 19:58:44.717388588 O: test integrity: hmac-md5 @2909 1246s 19:58:45.024321588 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1246s 19:58:45.042868582 O: test integrity: hmac-md5-96 @2900 1246s 19:58:45.362848706 O: test integrity: hmac-md5-96 @2901 1246s 19:58:45.683721562 O: test integrity: hmac-md5-96 @2902 1247s 19:58:46.007702937 O: test integrity: hmac-md5-96 @2903 1247s 19:58:46.327359657 O: test integrity: hmac-md5-96 @2904 1247s 19:58:46.649905693 O: test integrity: hmac-md5-96 @2905 1248s 19:58:46.991147366 O: test integrity: hmac-md5-96 @2906 1248s 19:58:47.340758344 O: test integrity: hmac-md5-96 @2907 1248s 19:58:47.713574816 O: test integrity: hmac-md5-96 @2908 1249s 19:58:48.087457541 O: test integrity: hmac-md5-96 @2909 1249s 19:58:48.437714487 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1249s 19:58:48.460868220 O: test integrity: umac-64@openssh.com @2900 1249s 19:58:48.845872565 O: test integrity: umac-64@openssh.com @2901 1250s 19:58:49.226710897 O: test integrity: umac-64@openssh.com @2902 1250s 19:58:49.583657007 O: test integrity: umac-64@openssh.com @2903 1250s 19:58:49.948608619 O: test integrity: umac-64@openssh.com @2904 1251s 19:58:50.310999718 O: test integrity: umac-64@openssh.com @2905 1251s 19:58:50.729513366 O: test integrity: umac-64@openssh.com @2906 1252s 19:58:51.132852982 O: test integrity: umac-64@openssh.com @2907 1252s 19:58:51.526340913 O: test integrity: umac-64@openssh.com @2908 1252s 19:58:51.914364336 O: test integrity: umac-64@openssh.com @2909 1253s 19:58:52.277556084 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1253s 19:58:52.312393524 O: test integrity: umac-128@openssh.com @2900 1253s 19:58:52.662967633 O: test integrity: umac-128@openssh.com @2901 1254s 19:58:53.004513348 O: test integrity: umac-128@openssh.com @2902 1254s 19:58:53.347872566 O: test integrity: umac-128@openssh.com @2903 1254s 19:58:53.667766007 O: test integrity: umac-128@openssh.com @2904 1255s 19:58:53.982812586 O: test integrity: umac-128@openssh.com @2905 1255s 19:58:54.310522086 O: test integrity: umac-128@openssh.com @2906 1255s 19:58:54.628240859 O: test integrity: umac-128@openssh.com @2907 1255s 19:58:54.943677404 O: test integrity: umac-128@openssh.com @2908 1256s 19:58:55.258772024 O: test integrity: umac-128@openssh.com @2909 1256s 19:58:55.560422274 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1256s 19:58:55.578539703 O: test integrity: hmac-sha1-etm@openssh.com @2900 1256s 19:58:55.905776156 O: test integrity: hmac-sha1-etm@openssh.com @2901 1257s 19:58:56.239324129 O: test integrity: hmac-sha1-etm@openssh.com @2902 1257s 19:58:56.583633277 O: test integrity: hmac-sha1-etm@openssh.com @2903 1258s 19:58:56.988205147 O: test integrity: hmac-sha1-etm@openssh.com @2904 1258s 19:58:57.371960034 O: test integrity: hmac-sha1-etm@openssh.com @2905 1258s 19:58:57.741601422 O: test integrity: hmac-sha1-etm@openssh.com @2906 1259s 19:58:58.083239136 O: test integrity: hmac-sha1-etm@openssh.com @2907 1259s 19:58:58.429238866 O: test integrity: hmac-sha1-etm@openssh.com @2908 1259s 19:58:58.776249088 O: test integrity: hmac-sha1-etm@openssh.com @2909 1260s 19:58:59.101880720 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1260s 19:58:59.126856275 O: test integrity: hmac-sha1-96-etm@openssh.com @2900 1260s 19:58:59.456805682 O: test integrity: hmac-sha1-96-etm@openssh.com @2901 1260s 19:58:59.791686670 O: test integrity: hmac-sha1-96-etm@openssh.com @2902 1261s 19:59:00.134998806 O: test integrity: hmac-sha1-96-etm@openssh.com @2903 1261s 19:59:00.470352520 O: test integrity: hmac-sha1-96-etm@openssh.com @2904 1261s 19:59:00.819961214 O: test integrity: hmac-sha1-96-etm@openssh.com @2905 1262s 19:59:01.160332432 O: test integrity: hmac-sha1-96-etm@openssh.com @2906 1262s 19:59:01.477680319 O: test integrity: hmac-sha1-96-etm@openssh.com @2907 1262s 19:59:01.797580678 O: test integrity: hmac-sha1-96-etm@openssh.com @2908 1263s 19:59:02.119949068 O: test integrity: hmac-sha1-96-etm@openssh.com @2909 1263s 19:59:02.428278760 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1263s 19:59:02.446777834 O: test integrity: hmac-sha2-256-etm@openssh.com @2900 1263s 19:59:02.769370547 O: test integrity: hmac-sha2-256-etm@openssh.com @2901 1264s 19:59:03.123489417 O: test integrity: hmac-sha2-256-etm@openssh.com @2902 1264s 19:59:03.474476928 O: test integrity: hmac-sha2-256-etm@openssh.com @2903 1264s 19:59:03.817944944 O: test integrity: hmac-sha2-256-etm@openssh.com @2904 1265s 19:59:04.140372894 O: test integrity: hmac-sha2-256-etm@openssh.com @2905 1265s 19:59:04.461814712 O: test integrity: hmac-sha2-256-etm@openssh.com @2906 1265s 19:59:04.786678533 O: test integrity: hmac-sha2-256-etm@openssh.com @2907 1266s 19:59:05.110909066 O: test integrity: hmac-sha2-256-etm@openssh.com @2908 1266s 19:59:05.443135579 O: test integrity: hmac-sha2-256-etm@openssh.com @2909 1266s 19:59:05.779452104 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1266s 19:59:05.801614184 O: test integrity: hmac-sha2-512-etm@openssh.com @2900 1267s 19:59:06.094809645 O: test integrity: hmac-sha2-512-etm@openssh.com @2901 1267s 19:59:06.407079906 O: test integrity: hmac-sha2-512-etm@openssh.com @2902 1267s 19:59:06.716508132 O: test integrity: hmac-sha2-512-etm@openssh.com @2903 1268s 19:59:07.027723940 O: test integrity: hmac-sha2-512-etm@openssh.com @2904 1268s 19:59:07.346228880 O: test integrity: hmac-sha2-512-etm@openssh.com @2905 1268s 19:59:07.650061394 O: test integrity: hmac-sha2-512-etm@openssh.com @2906 1268s 19:59:07.948719524 O: test integrity: hmac-sha2-512-etm@openssh.com @2907 1269s 19:59:08.244422735 O: test integrity: hmac-sha2-512-etm@openssh.com @2908 1269s 19:59:08.531505758 O: test integrity: hmac-sha2-512-etm@openssh.com @2909 1269s 19:59:08.803996677 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1269s 19:59:08.822675913 O: test integrity: hmac-md5-etm@openssh.com @2900 1270s 19:59:09.138678981 O: test integrity: hmac-md5-etm@openssh.com @2901 1270s 19:59:09.467450970 O: test integrity: hmac-md5-etm@openssh.com @2902 1270s 19:59:09.787026242 O: test integrity: hmac-md5-etm@openssh.com @2903 1271s 19:59:10.104977255 O: test integrity: hmac-md5-etm@openssh.com @2904 1271s 19:59:10.424016960 O: test integrity: hmac-md5-etm@openssh.com @2905 1271s 19:59:10.743761635 O: test integrity: hmac-md5-etm@openssh.com @2906 1272s 19:59:11.064455362 O: test integrity: hmac-md5-etm@openssh.com @2907 1272s 19:59:11.381681164 O: test integrity: hmac-md5-etm@openssh.com @2908 1272s 19:59:11.696659978 O: test integrity: hmac-md5-etm@openssh.com @2909 1273s 19:59:11.999890925 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1273s 19:59:12.017964153 O: test integrity: hmac-md5-96-etm@openssh.com @2900 1273s 19:59:12.333909259 O: test integrity: hmac-md5-96-etm@openssh.com @2901 1273s 19:59:12.650047287 O: test integrity: hmac-md5-96-etm@openssh.com @2902 1273s 19:59:12.963849887 O: test integrity: hmac-md5-96-etm@openssh.com @2903 1274s 19:59:13.284889497 O: test integrity: hmac-md5-96-etm@openssh.com @2904 1274s 19:59:13.601094406 O: test integrity: hmac-md5-96-etm@openssh.com @2905 1274s 19:59:13.915883137 O: test integrity: hmac-md5-96-etm@openssh.com @2906 1275s 19:59:14.263049437 O: test integrity: hmac-md5-96-etm@openssh.com @2907 1275s 19:59:14.585589986 O: test integrity: hmac-md5-96-etm@openssh.com @2908 1275s 19:59:14.903451716 O: test integrity: hmac-md5-96-etm@openssh.com @2909 1276s 19:59:15.207586272 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1276s 19:59:15.226884756 O: test integrity: umac-64-etm@openssh.com @2900 1276s 19:59:15.543825314 O: test integrity: umac-64-etm@openssh.com @2901 1276s 19:59:15.860353586 O: test integrity: umac-64-etm@openssh.com @2902 1277s 19:59:16.187856517 O: test integrity: umac-64-etm@openssh.com @2903 1277s 19:59:16.513661987 O: test integrity: umac-64-etm@openssh.com @2904 1277s 19:59:16.831066351 O: test integrity: umac-64-etm@openssh.com @2905 1278s 19:59:17.150377738 O: test integrity: umac-64-etm@openssh.com @2906 1278s 19:59:17.483187736 O: test integrity: umac-64-etm@openssh.com @2907 1278s 19:59:17.808081394 O: test integrity: umac-64-etm@openssh.com @2908 1279s 19:59:18.130057014 O: test integrity: umac-64-etm@openssh.com @2909 1279s 19:59:18.435932472 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1279s 19:59:18.454689029 O: test integrity: umac-128-etm@openssh.com @2900 1279s 19:59:18.784110783 O: test integrity: umac-128-etm@openssh.com @2901 1280s 19:59:19.107718104 O: test integrity: umac-128-etm@openssh.com @2902 1280s 19:59:19.426130960 O: test integrity: umac-128-etm@openssh.com @2903 1280s 19:59:19.742603231 O: test integrity: umac-128-etm@openssh.com @2904 1281s 19:59:20.071951104 O: test integrity: umac-128-etm@openssh.com @2905 1281s 19:59:20.404634060 O: test integrity: umac-128-etm@openssh.com @2906 1281s 19:59:20.735870837 O: test integrity: umac-128-etm@openssh.com @2907 1282s 19:59:21.079150365 O: test integrity: umac-128-etm@openssh.com @2908 1282s 19:59:21.440098837 O: test integrity: umac-128-etm@openssh.com @2909 1282s 19:59:21.758446051 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1282s 19:59:21.783977373 O: test integrity: aes128-gcm@openssh.com @2900 1283s 19:59:22.069668335 O: test integrity: aes128-gcm@openssh.com @2901 1283s 19:59:22.349778707 O: test integrity: aes128-gcm@openssh.com @2902 1283s 19:59:22.629075429 O: test integrity: aes128-gcm@openssh.com @2903 1283s 19:59:22.924356872 O: test integrity: aes128-gcm@openssh.com @2904 1284s 19:59:23.208182170 O: test integrity: aes128-gcm@openssh.com @2905 1284s 19:59:23.491949148 O: test integrity: aes128-gcm@openssh.com @2906 1284s 19:59:23.774870075 O: test integrity: aes128-gcm@openssh.com @2907 1285s 19:59:24.056071780 O: test integrity: aes128-gcm@openssh.com @2908 1285s 19:59:24.337242685 O: test integrity: aes128-gcm@openssh.com @2909 1285s 19:59:24.605093822 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1285s 19:59:24.624025900 O: test integrity: aes256-gcm@openssh.com @2900 1285s 19:59:24.906199258 O: test integrity: aes256-gcm@openssh.com @2901 1286s 19:59:25.191609736 O: test integrity: aes256-gcm@openssh.com @2902 1286s 19:59:25.473111525 O: test integrity: aes256-gcm@openssh.com @2903 1286s 19:59:25.753863304 O: test integrity: aes256-gcm@openssh.com @2904 1287s 19:59:26.036409986 O: test integrity: aes256-gcm@openssh.com @2905 1287s 19:59:26.317755932 O: test integrity: aes256-gcm@openssh.com @2906 1287s 19:59:26.598144547 O: test integrity: aes256-gcm@openssh.com @2907 1287s 19:59:26.880712708 O: test integrity: aes256-gcm@openssh.com @2908 1288s 19:59:27.162941986 O: test integrity: aes256-gcm@openssh.com @2909 1288s 19:59:27.450319288 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1288s 19:59:27.470196339 O: test integrity: chacha20-poly1305@openssh.com @2900 1288s 19:59:27.754441842 O: test integrity: chacha20-poly1305@openssh.com @2901 1289s 19:59:28.037053404 O: test integrity: chacha20-poly1305@openssh.com @2902 1289s 19:59:28.324325785 O: test integrity: chacha20-poly1305@openssh.com @2903 1289s 19:59:28.622117858 O: test integrity: chacha20-poly1305@openssh.com @2904 1289s 19:59:28.906978168 O: test integrity: chacha20-poly1305@openssh.com @2905 1290s 19:59:29.187907709 O: test integrity: chacha20-poly1305@openssh.com @2906 1290s 19:59:29.468274562 O: test integrity: chacha20-poly1305@openssh.com @2907 1290s 19:59:29.751284569 O: test integrity: chacha20-poly1305@openssh.com @2908 1291s 19:59:30.032052628 O: test integrity: chacha20-poly1305@openssh.com @2909 1291s 19:59:30.305983720 O: test integrity: 10 errors: mac 10 padding 0 length 0 timeout 0 1291s 19:59:30.308829876 O: ok integrity 1291s 19:59:30.308939317 E: run test krl.sh ... 1291s 19:59:30.575394835 O: key revocation lists: generating test keys 1296s 19:59:35.426806565 O: key revocation lists: generating KRLs 1296s 19:59:35.592115927 O: key revocation lists: checking revocations for revoked keys 1297s 19:59:36.286349833 O: key revocation lists: checking revocations for unrevoked keys 1297s 19:59:36.945697540 O: key revocation lists: checking revocations for revoked certs 1299s 19:59:38.137056227 O: key revocation lists: checking revocations for unrevoked certs 1300s 19:59:39.379393235 O: key revocation lists: testing KRL update 1301s 19:59:40.713205634 O: key revocation lists: checking revocations for revoked keys 1302s 19:59:41.397979258 O: key revocation lists: checking revocations for unrevoked keys 1303s 19:59:42.049991830 O: key revocation lists: checking revocations for revoked certs 1304s 19:59:43.205978267 O: key revocation lists: checking revocations for unrevoked certs 1305s 19:59:44.348521814 O: ok key revocation lists 1305s 19:59:44.348577614 E: run test multipubkey.sh ... 1308s 19:59:47.293246769 O: ok multiple pubkey 1308s 19:59:47.293242929 E: run test limit-keytype.sh ... 1313s 19:59:52.235476779 O: allow rsa,ed25519 1314s 19:59:53.145428031 O: allow ed25519 1314s 19:59:53.970250011 O: allow cert only 1315s 19:59:54.853550687 O: match w/ no match 1316s 19:59:55.767118382 O: match w/ matching 1317s 19:59:56.796882579 E: run test hostkey-agent.sh ... 1317s 19:59:56.796977420 O: ok restrict pubkey type 1319s 19:59:58.949310340 O: key type ssh-ed25519 1320s 19:59:59.142350928 O: key type sk-ssh-ed25519@openssh.com 1320s 19:59:59.346345454 O: key type ecdsa-sha2-nistp256 1320s 19:59:59.535071509 O: key type ecdsa-sha2-nistp384 1320s 19:59:59.759567933 O: key type ecdsa-sha2-nistp521 1321s 20:00:00.047765958 O: key type sk-ecdsa-sha2-nistp256@openssh.com 1321s 20:00:00.247251228 O: key type ssh-dss 1321s 20:00:00.438618715 O: key type ssh-rsa 1321s 20:00:00.666540102 O: cert type ssh-ed25519-cert-v01@openssh.com 1321s 20:00:00.947998403 O: cert type sk-ssh-ed25519-cert-v01@openssh.com 1322s 20:00:01.233299151 O: cert type ecdsa-sha2-nistp256-cert-v01@openssh.com 1322s 20:00:01.511245688 O: cert type ecdsa-sha2-nistp384-cert-v01@openssh.com 1322s 20:00:01.809333197 O: cert type ecdsa-sha2-nistp521-cert-v01@openssh.com 1323s 20:00:02.160235051 O: cert type sk-ecdsa-sha2-nistp256-cert-v01@openssh.com 1323s 20:00:02.445313517 O: cert type ssh-dss-cert-v01@openssh.com 1323s 20:00:02.742925540 O: cert type ssh-rsa-cert-v01@openssh.com 1324s 20:00:03.071726436 O: cert type rsa-sha2-256-cert-v01@openssh.com 1324s 20:00:03.436456983 O: cert type rsa-sha2-512-cert-v01@openssh.com 1324s 20:00:03.761032345 E: run test hostkey-rotate.sh ... 1324s 20:00:03.761028585 O: ok hostkey agent 1326s 20:00:05.296050450 O: learn hostkey with StrictHostKeyChecking=no 1326s 20:00:05.588542168 O: learn additional hostkeys 1327s 20:00:05.990535584 O: learn additional hostkeys, type=ssh-ed25519 1327s 20:00:06.318196344 O: learn additional hostkeys, type=sk-ssh-ed25519@openssh.com 1327s 20:00:06.639116140 O: learn additional hostkeys, type=ecdsa-sha2-nistp256 1327s 20:00:06.947838622 O: learn additional hostkeys, type=ecdsa-sha2-nistp384 1328s 20:00:07.286923526 O: learn additional hostkeys, type=ecdsa-sha2-nistp521 1328s 20:00:07.634369494 O: learn additional hostkeys, type=sk-ecdsa-sha2-nistp256@openssh.com 1328s 20:00:07.949643459 O: learn additional hostkeys, type=ssh-dss 1329s 20:00:08.243253951 O: learn additional hostkeys, type=ssh-rsa 1329s 20:00:08.551258703 O: learn changed non-primary hostkey type=ssh-rsa 1331s 20:00:10.611320084 O: learn new primary hostkey 1332s 20:00:11.000417335 O: rotate primary hostkey 1332s 20:00:11.368724126 O: check rotate primary hostkey 1332s 20:00:11.700635538 O: ok hostkey rotate 1332s 20:00:11.701388828 E: run test principals-command.sh ... 1333s 20:00:12.616141687 O: authorized principals command: empty authorized_principals 1334s 20:00:12.976194693 O: authorized principals command: wrong authorized_principals 1334s 20:00:13.294913059 O: authorized principals command: correct authorized_principals 1334s 20:00:13.653515007 O: authorized principals command: authorized_principals bad key opt 1334s 20:00:13.974673084 O: authorized principals command: authorized_principals command=false 1335s 20:00:14.322725498 O: authorized principals command: authorized_principals command=true 1335s 20:00:14.680569196 O: authorized principals command: wrong principals key option 1336s 20:00:15.002282120 O: authorized principals command: correct principals key option 1336s 20:00:15.367296387 O: ok authorized principals command 1336s 20:00:15.378640570 E: run test cert-file.sh ... 1336s 20:00:15.763733050 O: identity cert with no plain public file 1337s 20:00:16.113075521 O: CertificateFile with no plain public file 1337s 20:00:16.462101667 O: plain keys 1337s 20:00:16.772055043 O: untrusted cert 1338s 20:00:17.082614705 O: good cert, bad key 1338s 20:00:17.422001491 O: single trusted 1338s 20:00:17.752070039 O: multiple trusted 1340s 20:00:19.132531146 O: ok ssh with certificates 1340s 20:00:19.132648827 E: run test cfginclude.sh ... 1340s 20:00:19.382569288 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.392385931 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.402438217 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.412434743 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.423320360 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.432655157 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.442431760 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.452394405 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.462339290 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.484425688 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.494344452 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.505211749 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.519937174 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.530433146 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.540368751 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.549316063 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.559347909 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.569252153 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.579373681 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.589362326 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.599362852 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.622421222 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.632836912 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.643411045 E: Pseudo-terminal will not be allocated because stdin is not a terminal. 1340s 20:00:19.657973548 O: ok config include 1340s 20:00:19.658307152 E: run test servcfginclude.sh ... 1341s 20:00:20.333612398 E: run test allow-deny-users.sh ... 1341s 20:00:20.333621558 O: ok server config include 1344s 20:00:23.141305274 O: ok AllowUsers/DenyUsers 1344s 20:00:23.141455435 E: run test authinfo.sh ... 1344s 20:00:23.385673464 O: ExposeAuthInfo=no 1344s 20:00:23.685393349 O: ExposeAuthInfo=yes 1345s 20:00:24.016456788 O: ok authinfo 1345s 20:00:24.016625990 E: run test sshsig.sh ... 1345s 20:00:24.394688939 O: sshsig: make certificates 1345s 20:00:24.467275371 O: sshsig: check signature for ssh-ed25519 1345s 20:00:24.957583410 O: sshsig: check signature for sk-ssh-ed25519@openssh.com 1346s 20:00:25.519419108 O: sshsig: check signature for ecdsa-sha2-nistp256 1347s 20:00:26.049783010 O: sshsig: check signature for ecdsa-sha2-nistp384 1348s 20:00:27.107656457 O: sshsig: check signature for ecdsa-sha2-nistp521 1349s 20:00:28.697899230 O: sshsig: check signature for sk-ecdsa-sha2-nistp256@openssh.com 1350s 20:00:29.336788334 O: sshsig: check signature for ssh-dss 1350s 20:00:29.785584930 O: sshsig: check signature for ssh-rsa 1351s 20:00:30.299123219 O: sshsig: check signature for ssh-ed25519-cert.pub 1352s 20:00:31.432231688 O: sshsig: check signature for sk-ssh-ed25519@openssh.com-cert.pub 1353s 20:00:32.496455331 O: sshsig: check signature for ecdsa-sha2-nistp256-cert.pub 1354s 20:00:33.401235571 O: sshsig: check signature for ecdsa-sha2-nistp384-cert.pub 1355s 20:00:34.851810744 O: sshsig: check signature for ecdsa-sha2-nistp521-cert.pub 1358s 20:00:37.281626207 O: sshsig: check signature for sk-ecdsa-sha2-nistp256@openssh.com-cert.pub 1359s 20:00:38.536250196 O: sshsig: check signature for ssh-dss-cert.pub 1360s 20:00:39.531449968 O: sshsig: check signature for ssh-rsa-cert.pub 1361s 20:00:40.492148146 O: sshsig: match principals 1361s 20:00:40.525574805 O: sshsig: nomatch principals 1361s 20:00:40.545147011 O: ok sshsig 1361s 20:00:40.545225612 E: run test knownhosts.sh ... 1363s 20:00:42.611783427 O: ok known hosts 1363s 20:00:42.612057231 E: run test knownhosts-command.sh ... 1363s 20:00:42.860875673 O: simple connection 1364s 20:00:43.147901395 O: no keys 1364s 20:00:43.340053206 O: bad exit status 1364s 20:00:43.449239657 O: keytype ssh-ed25519 1364s 20:00:43.709349081 O: keytype sk-ssh-ed25519@openssh.com 1365s 20:00:43.971355009 O: keytype ecdsa-sha2-nistp256 1365s 20:00:44.233451417 O: keytype ecdsa-sha2-nistp384 1365s 20:00:44.517379500 O: keytype ecdsa-sha2-nistp521 1365s 20:00:44.849432787 O: keytype sk-ecdsa-sha2-nistp256@openssh.com 1366s 20:00:45.108653919 O: keytype ssh-rsa 1366s 20:00:45.378784949 O: ok known hosts command 1366s 20:00:45.378928191 E: run test agent-restrict.sh ... 1366s 20:00:45.624760995 O: generate keys 1366s 20:00:45.722783785 O: prepare client config 1366s 20:00:45.740421086 O: prepare known_hosts 1366s 20:00:45.748439147 O: prepare server configs 1366s 20:00:45.773029456 O: authentication w/o agent 1368s 20:00:47.865512589 O: start agent 1372s 20:00:51.877448197 O: authentication with agent (no restrict) 1375s 20:00:54.450789832 O: unrestricted keylist 1376s 20:00:55.816606281 O: authentication with agent (basic restrict) 1378s 20:00:57.186471539 O: authentication with agent incorrect key (basic restrict) 1379s 20:00:58.018448171 O: keylist (basic restrict) 1380s 20:00:59.276603867 O: username 1381s 20:01:00.467288515 O: username wildcard 1382s 20:01:01.583739912 O: username incorrect 1382s 20:01:01.685221904 O: agent restriction honours certificate principal 1382s 20:01:01.732523777 O: multihop without agent 1383s 20:01:02.946181032 O: multihop agent unrestricted 1385s 20:01:04.301780065 O: multihop restricted 1386s 20:01:05.577268052 O: multihop username 1388s 20:01:07.000922136 O: multihop wildcard username 1389s 20:01:08.361356946 O: multihop wrong username 1390s 20:01:09.318613302 O: multihop cycle no agent 1392s 20:01:11.149761688 O: multihop cycle agent unrestricted 1393s 20:01:12.964212983 O: multihop cycle restricted deny 1394s 20:01:13.745007326 O: multihop cycle restricted allow 1397s 20:01:15.595379067 O: ok agent restrictions 1397s 20:01:15.595483389 E: run test hostbased.sh ... 1397s 20:01:15.839316083 O: SKIPPED: TEST_SSH_HOSTBASED_AUTH not set. 1397s 20:01:15.839563846 E: run test channel-timeout.sh ... 1397s 20:01:16.088145360 O: no timeout 1402s 20:01:21.391064302 O: command timeout 1402s 20:01:21.892655544 O: command long timeout 1403s 20:01:22.264521041 O: command wildcard timeout 1403s 20:01:22.898079855 O: command irrelevant timeout 1409s 20:01:28.272956075 O: multiplexed command timeout 1419s 20:01:38.928954848 O: irrelevant multiplexed command timeout 1435s 20:01:54.294370003 O: global command timeout 1456s 20:02:15.941139850 O: sftp no timeout 1462s 20:02:21.298325799 O: sftp timeout 1462s 20:02:21.891886331 E: Connection closed 1462s 20:02:21.894093719 O: sftp irrelevant timeout 1468s 20:02:27.230229747 E: run test connection-timeout.sh ... 1468s 20:02:27.230194466 O: ok channel timeout 1468s 20:02:27.532375039 O: no timeout 1473s 20:02:32.854307273 O: timeout 1482s 20:02:41.171898111 O: session inhibits timeout 1490s 20:02:49.519321883 O: timeout after session 1498s 20:02:57.528775005 O: timeout with listeners 1506s 20:03:05.864813083 O: ok unused connection timeout 1506s 20:03:05.865954417 E: run test match-subsystem.sh ... 1510s 20:03:09.314471277 O: ok sshd_config match subsystem 1510s 20:03:09.314667359 E: run test agent-pkcs11-restrict.sh ... 1510s 20:03:09.565496485 O: SKIPPED: No PKCS#11 library found 1510s 20:03:09.566101413 E: run test agent-pkcs11-cert.sh ... 1510s 20:03:09.819440170 O: SKIPPED: No PKCS#11 library found 1510s 20:03:09.820756466 O: set -e ; if test -z "" ; then \ 1510s 20:03:09.822130403 O: V="" ; \ 1510s 20:03:09.823552341 O: test "x" = "x" || \ 1510s 20:03:09.824969319 O: V=/tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/valgrind-unit.sh ; \ 1510s 20:03:09.826302255 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/sshbuf/test_sshbuf ; \ 1510s 20:03:09.827662952 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/sshkey/test_sshkey \ 1510s 20:03:09.829074970 O: -d /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/sshkey/testdata ; \ 1510s 20:03:09.830631749 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/sshsig/test_sshsig \ 1510s 20:03:09.831970646 O: -d /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/sshsig/testdata ; \ 1510s 20:03:09.833359663 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/authopt/test_authopt \ 1510s 20:03:09.834738320 O: -d /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/authopt/testdata ; \ 1510s 20:03:09.836266539 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/bitmap/test_bitmap ; \ 1510s 20:03:09.837704757 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/conversion/test_conversion ; \ 1510s 20:03:09.839086094 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/kex/test_kex ; \ 1510s 20:03:09.840522712 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/hostkeys/test_hostkeys \ 1510s 20:03:09.842052091 O: -d /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/hostkeys/testdata ; \ 1510s 20:03:09.843612631 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/match/test_match ; \ 1510s 20:03:09.845315332 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/misc/test_misc ; \ 1510s 20:03:09.847000953 O: if test "x" = "xyes" ; then \ 1510s 20:03:09.849260581 O: $V /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/unittests/utf8/test_utf8 ; \ 1510s 20:03:09.850793880 O: fi \ 1510s 20:03:09.852536182 O: fi 1533s 20:03:32.552245294 O: test_sshbuf: ...................................................................................................... 103 tests ok 1640s 20:05:19.478446967 O: test_sshkey: ........................................................................................................ 104 tests ok 1640s 20:05:19.497510924 O: test_sshsig: ........ 8 tests ok 1640s 20:05:19.902828231 O: test_authopt: .................................................................................................................................................. 146 tests ok 1655s 20:05:34.812581434 O: test_bitmap: .. 2 tests ok 1655s 20:05:34.817385974 O: test_conversion: . 1 tests ok 1675s 20:05:54.399845349 O: test_kex: ............................................................................................................................................................................................................................................................................................................................................................................................................. 398 tests ok 1675s 20:05:54.725839268 O: test_hostkeys: .................. 18 tests ok 1675s 20:05:54.733844087 O: test_match: ...... 6 tests ok 1675s 20:05:54.739722920 O: test_misc: ........................................... 43 tests ok 1675s 20:05:54.743526647 E: run test putty-transfer.sh ... 1679s 20:05:58.178310161 O: plink version 0.81 minor 81 1679s 20:05:58.193610830 O: putty transfer data: compression 0 1681s 20:06:00.040067064 O: putty transfer data: compression 1 1683s 20:06:02.204486196 E: run test putty-ciphers.sh ... 1683s 20:06:02.205653610 O: ok putty transfer data 1685s 20:06:04.964746425 O: plink version 0.81 minor 81 1686s 20:06:05.255046061 O: putty ciphers: cipher default mac default 1686s 20:06:05.488596114 O: putty ciphers: cipher default mac hmac-sha1 1686s 20:06:05.720835550 O: putty ciphers: cipher default mac hmac-sha1-96 1686s 20:06:05.953133667 O: putty ciphers: cipher default mac hmac-sha2-256 1687s 20:06:06.187472370 O: putty ciphers: cipher default mac hmac-sha2-512 1687s 20:06:06.417834343 O: putty ciphers: cipher default mac hmac-md5 1687s 20:06:06.665635892 O: putty ciphers: cipher default mac hmac-sha1-etm@openssh.com 1687s 20:06:06.922478553 O: putty ciphers: cipher default mac hmac-sha1-96-etm@openssh.com 1688s 20:06:07.159416088 O: putty ciphers: cipher default mac hmac-sha2-256-etm@openssh.com 1688s 20:06:07.388957330 O: putty ciphers: cipher default mac hmac-sha2-512-etm@openssh.com 1688s 20:06:07.619558986 O: putty ciphers: cipher default mac hmac-md5-etm@openssh.com 1688s 20:06:07.853317642 O: putty ciphers: cipher 3des-cbc mac default 1689s 20:06:08.084887510 O: putty ciphers: cipher 3des-cbc mac hmac-sha1 1689s 20:06:08.326279699 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-96 1689s 20:06:08.561103247 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-256 1689s 20:06:08.789921321 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-512 1690s 20:06:09.027495703 O: putty ciphers: cipher 3des-cbc mac hmac-md5 1690s 20:06:09.273831074 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-etm@openssh.com 1690s 20:06:09.522997800 O: putty ciphers: cipher 3des-cbc mac hmac-sha1-96-etm@openssh.com 1690s 20:06:09.770496705 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-256-etm@openssh.com 1691s 20:06:10.005926581 O: putty ciphers: cipher 3des-cbc mac hmac-sha2-512-etm@openssh.com 1691s 20:06:10.246624281 O: putty ciphers: cipher 3des-cbc mac hmac-md5-etm@openssh.com 1691s 20:06:10.477788584 O: putty ciphers: cipher aes128-cbc mac default 1691s 20:06:10.709119249 O: putty ciphers: cipher aes128-cbc mac hmac-sha1 1691s 20:06:10.941314044 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-96 1692s 20:06:11.173686562 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-256 1692s 20:06:11.404023814 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-512 1692s 20:06:11.635951646 O: putty ciphers: cipher aes128-cbc mac hmac-md5 1692s 20:06:11.866931067 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-etm@openssh.com 1693s 20:06:12.094096080 O: putty ciphers: cipher aes128-cbc mac hmac-sha1-96-etm@openssh.com 1693s 20:06:12.322652910 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-256-etm@openssh.com 1693s 20:06:12.569055361 O: putty ciphers: cipher aes128-cbc mac hmac-sha2-512-etm@openssh.com 1693s 20:06:12.800726430 O: putty ciphers: cipher aes128-cbc mac hmac-md5-etm@openssh.com 1694s 20:06:13.029342821 O: putty ciphers: cipher aes192-cbc mac default 1694s 20:06:13.267566291 O: putty ciphers: cipher aes192-cbc mac hmac-sha1 1694s 20:06:13.509393926 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-96 1694s 20:06:13.756534306 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-256 1695s 20:06:13.990683445 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-512 1695s 20:06:14.233552333 O: putty ciphers: cipher aes192-cbc mac hmac-md5 1695s 20:06:14.477464993 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-etm@openssh.com 1695s 20:06:14.724852536 O: putty ciphers: cipher aes192-cbc mac hmac-sha1-96-etm@openssh.com 1695s 20:06:14.953344606 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-256-etm@openssh.com 1696s 20:06:15.189029484 O: putty ciphers: cipher aes192-cbc mac hmac-sha2-512-etm@openssh.com 1696s 20:06:15.422050049 O: putty ciphers: cipher aes192-cbc mac hmac-md5-etm@openssh.com 1696s 20:06:15.671139373 O: putty ciphers: cipher aes256-cbc mac default 1696s 20:06:15.915302957 O: putty ciphers: cipher aes256-cbc mac hmac-sha1 1697s 20:06:16.143691104 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-96 1697s 20:06:16.373909475 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-256 1697s 20:06:16.605434862 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-512 1697s 20:06:16.849895729 O: putty ciphers: cipher aes256-cbc mac hmac-md5 1698s 20:06:17.085251883 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-etm@openssh.com 1698s 20:06:17.323015027 O: putty ciphers: cipher aes256-cbc mac hmac-sha1-96-etm@openssh.com 1698s 20:06:17.558368261 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-256-etm@openssh.com 1698s 20:06:17.787601339 O: putty ciphers: cipher aes256-cbc mac hmac-sha2-512-etm@openssh.com 1699s 20:06:18.027899554 O: putty ciphers: cipher aes256-cbc mac hmac-md5-etm@openssh.com 1699s 20:06:18.264276961 O: putty ciphers: cipher aes128-ctr mac default 1699s 20:06:18.503925088 O: putty ciphers: cipher aes128-ctr mac hmac-sha1 1699s 20:06:18.759336890 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-96 1700s 20:06:18.998715694 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-256 1700s 20:06:19.227689009 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-512 1700s 20:06:19.494858236 O: putty ciphers: cipher aes128-ctr mac hmac-md5 1700s 20:06:19.739227542 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-etm@openssh.com 1701s 20:06:19.983713689 O: putty ciphers: cipher aes128-ctr mac hmac-sha1-96-etm@openssh.com 1701s 20:06:20.232554769 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-256-etm@openssh.com 1701s 20:06:20.484265406 O: putty ciphers: cipher aes128-ctr mac hmac-sha2-512-etm@openssh.com 1701s 20:06:20.727130412 O: putty ciphers: cipher aes128-ctr mac hmac-md5-etm@openssh.com 1701s 20:06:20.965252881 O: putty ciphers: cipher aes192-ctr mac default 1702s 20:06:21.212647703 O: putty ciphers: cipher aes192-ctr mac hmac-sha1 1702s 20:06:21.468336749 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-96 1702s 20:06:21.701608277 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-256 1702s 20:06:21.936454224 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-512 1703s 20:06:22.180557686 O: putty ciphers: cipher aes192-ctr mac hmac-md5 1703s 20:06:22.418561152 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-etm@openssh.com 1703s 20:06:22.662143048 O: putty ciphers: cipher aes192-ctr mac hmac-sha1-96-etm@openssh.com 1703s 20:06:22.896350627 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-256-etm@openssh.com 1704s 20:06:23.127310406 O: putty ciphers: cipher aes192-ctr mac hmac-sha2-512-etm@openssh.com 1704s 20:06:23.382267723 O: putty ciphers: cipher aes192-ctr mac hmac-md5-etm@openssh.com 1704s 20:06:23.622695859 O: putty ciphers: cipher aes256-ctr mac default 1704s 20:06:23.868834026 O: putty ciphers: cipher aes256-ctr mac hmac-sha1 1705s 20:06:24.105892440 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-96 1705s 20:06:24.376575191 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-256 1705s 20:06:24.632332677 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-512 1705s 20:06:24.880022983 O: putty ciphers: cipher aes256-ctr mac hmac-md5 1706s 20:06:25.109384423 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-etm@openssh.com 1706s 20:06:25.354636379 O: putty ciphers: cipher aes256-ctr mac hmac-sha1-96-etm@openssh.com 1706s 20:06:25.597937270 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-256-etm@openssh.com 1706s 20:06:25.839765744 O: putty ciphers: cipher aes256-ctr mac hmac-sha2-512-etm@openssh.com 1707s 20:06:26.123384815 O: putty ciphers: cipher aes256-ctr mac hmac-md5-etm@openssh.com 1707s 20:06:26.361575683 O: putty ciphers: cipher aes128-gcm@openssh.com mac default 1707s 20:06:26.608896344 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1 1707s 20:06:26.851382306 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-96 1708s 20:06:27.086901381 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-256 1708s 20:06:27.335485178 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-512 1708s 20:06:27.617762832 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-md5 1708s 20:06:27.906767969 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-etm@openssh.com 1709s 20:06:28.177986646 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha1-96-etm@openssh.com 1709s 20:06:28.445936043 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-256-etm@openssh.com 1709s 20:06:28.705361094 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-sha2-512-etm@openssh.com 1710s 20:06:28.978362033 O: putty ciphers: cipher aes128-gcm@openssh.com mac hmac-md5-etm@openssh.com 1710s 20:06:29.231028120 O: putty ciphers: cipher aes256-gcm@openssh.com mac default 1710s 20:06:29.505355996 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1 1710s 20:06:29.790237242 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-96 1711s 20:06:30.071919008 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-256 1711s 20:06:30.367333385 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-512 1711s 20:06:30.658026262 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-md5 1711s 20:06:30.958722664 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-etm@openssh.com 1712s 20:06:31.238921372 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha1-96-etm@openssh.com 1712s 20:06:31.530135496 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-256-etm@openssh.com 1712s 20:06:31.835056950 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-sha2-512-etm@openssh.com 1713s 20:06:32.164290185 O: putty ciphers: cipher aes256-gcm@openssh.com mac hmac-md5-etm@openssh.com 1713s 20:06:32.437545887 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac default 1713s 20:06:32.706948941 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1 1713s 20:06:32.952536700 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-96 1714s 20:06:33.203142442 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-256 1714s 20:06:33.504980777 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-512 1714s 20:06:33.767383385 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-md5 1715s 20:06:34.026117067 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-etm@openssh.com 1715s 20:06:34.274500661 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha1-96-etm@openssh.com 1715s 20:06:34.524920760 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-256-etm@openssh.com 1715s 20:06:34.759073257 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-sha2-512-etm@openssh.com 1716s 20:06:34.997879133 O: putty ciphers: cipher chacha20-poly1305@openssh.com mac hmac-md5-etm@openssh.com 1716s 20:06:35.237658740 O: ok putty ciphers 1716s 20:06:35.237770381 E: run test putty-kex.sh ... 1717s 20:06:36.056351552 O: plink version 0.81 minor 81 1717s 20:06:36.198437990 O: putty KEX: kex diffie-hellman-group1-sha1 1717s 20:06:36.391536419 O: putty KEX: kex diffie-hellman-group14-sha1 1717s 20:06:36.697134441 O: putty KEX: kex diffie-hellman-group14-sha256 1718s 20:06:37.002512460 O: putty KEX: kex diffie-hellman-group16-sha512 1718s 20:06:37.945721925 O: putty KEX: kex diffie-hellman-group18-sha512 1724s 20:06:43.267968772 O: putty KEX: kex diffie-hellman-group-exchange-sha1 1724s 20:06:43.610399387 O: putty KEX: kex diffie-hellman-group-exchange-sha256 1725s 20:06:44.608818143 O: putty KEX: kex ecdh-sha2-nistp256 1725s 20:06:44.822777852 O: putty KEX: kex ecdh-sha2-nistp384 1726s 20:06:45.069193999 O: putty KEX: kex ecdh-sha2-nistp521 1726s 20:06:45.351846873 O: putty KEX: kex curve25519-sha256 1726s 20:06:45.535701369 O: putty KEX: kex curve25519-sha256@libssh.org 1726s 20:06:45.719648383 O: putty KEX: kex sntrup761x25519-sha512@openssh.com 1726s 20:06:45.965405064 E: run test conch-ciphers.sh ... 1726s 20:06:45.965469503 O: ok putty KEX 1727s 20:06:46.399419331 O: conch ciphers: cipher aes256-ctr 1728s 20:06:47.308254837 O: conch ciphers: cipher aes256-cbc 1729s 20:06:48.040417907 O: conch ciphers: cipher aes192-ctr 1729s 20:06:48.786569867 O: conch ciphers: cipher aes192-cbc 1730s 20:06:49.511113098 O: conch ciphers: cipher aes128-ctr 1731s 20:06:50.251649711 O: conch ciphers: cipher aes128-cbc 1732s 20:06:51.016461786 O: conch ciphers: cipher cast128-cbc 1732s 20:06:51.805655014 O: conch ciphers: cipher blowfish 1733s 20:06:52.670970528 O: conch ciphers: cipher 3des-cbc 1734s 20:06:53.447134929 E: run test dropbear-ciphers.sh ... 1734s 20:06:53.447067689 O: ok conch ciphers 1735s 20:06:54.083356371 E: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/.dropbear/ossh.id_dss: No such file or directory 1735s 20:06:54.191539094 E: run test dropbear-kex.sh ... 1735s 20:06:54.192410406 O: ok dropbear ciphers 1735s 20:06:54.457711023 E: /tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress/.dropbear/ossh.id_dss: No such file or directory 1735s 20:06:54.540486470 O: dropbear kex: kex curve25519-sha256 1735s 20:06:54.776216611 O: dropbear kex: kex curve25519-sha256@libssh.org 1736s 20:06:55.016638548 O: dropbear kex: kex diffie-hellman-group14-sha256 1736s 20:06:55.306880337 O: dropbear kex: kex diffie-hellman-group14-sha1 1736s 20:06:55.608445819 O: ok dropbear kex 1736s 20:06:55.611421070 O: make: Leaving directory '/tmp/autopkgtest.bx8bVp/autopkgtest_tmp/user/regress' 1736s 20:06:55.616681380 I: Finished with exitcode 0 1736s Synchronizing state of haveged.service with SysV service script with /usr/lib/systemd/systemd-sysv-install. 1736s Executing: /usr/lib/systemd/systemd-sysv-install disable haveged 1737s Removed '/etc/systemd/system/sysinit.target.wants/haveged.service'. 1737s info: Looking for files to backup/remove ... 1737s info: Removing files ... 1737s info: Removing crontab ... 1737s info: Removing user `openssh-tests' ... 1738s autopkgtest [20:06:57]: test regress: -----------------------] 1741s autopkgtest [20:07:00]: test regress: - - - - - - - - - - results - - - - - - - - - - 1741s regress PASS 1745s autopkgtest [20:07:04]: test ssh-gssapi: preparing testbed 1799s autopkgtest [20:07:58]: testbed dpkg architecture: armhf 1801s autopkgtest [20:08:00]: testbed apt version: 2.9.8 1801s autopkgtest [20:08:00]: @@@@@@@@@@@@@@@@@@@@ test bed setup 1809s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 1809s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [92.2 kB] 1809s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1043 kB] 1810s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 1810s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 1810s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [143 kB] 1810s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [747 kB] 1810s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [4428 B] 1810s Fetched 2126 kB in 1s (1691 kB/s) 1810s Reading package lists... 1826s tee: /proc/self/fd/2: Permission denied 1848s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 1848s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 1848s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 1848s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 1850s Reading package lists... 1850s Reading package lists... 1850s Building dependency tree... 1850s Reading state information... 1851s Calculating upgrade... 1851s The following NEW packages will be installed: 1851s libassuan9 1851s The following packages will be upgraded: 1851s libaudit-common libaudit1 libgpgme11t64 libseccomp2 python3-cffi-backend 1851s python3-markupsafe 1852s 6 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 1852s Need to get 351 kB of archives. 1852s After this operation, 224 kB of additional disk space will be used. 1852s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libaudit-common all 1:4.0.2-2ubuntu1 [6578 B] 1852s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libaudit1 armhf 1:4.0.2-2ubuntu1 [47.5 kB] 1852s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libseccomp2 armhf 2.5.5-1ubuntu5 [49.3 kB] 1852s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf python3-cffi-backend armhf 1.17.1-2build1 [75.9 kB] 1852s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf libassuan9 armhf 3.0.1-2 [34.3 kB] 1852s Get:6 http://ftpmaster.internal/ubuntu plucky/main armhf libgpgme11t64 armhf 1.24.0-2ubuntu1 [125 kB] 1852s Get:7 http://ftpmaster.internal/ubuntu plucky/main armhf python3-markupsafe armhf 2.1.5-1build3 [12.5 kB] 1852s Fetched 351 kB in 0s (736 kB/s) 1852s (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.) 1853s Preparing to unpack .../libaudit-common_1%3a4.0.2-2ubuntu1_all.deb ... 1853s Unpacking libaudit-common (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 1853s Setting up libaudit-common (1:4.0.2-2ubuntu1) ... 1853s (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.) 1853s Preparing to unpack .../libaudit1_1%3a4.0.2-2ubuntu1_armhf.deb ... 1853s Unpacking libaudit1:armhf (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 1853s Setting up libaudit1:armhf (1:4.0.2-2ubuntu1) ... 1853s (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.) 1853s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu5_armhf.deb ... 1853s Unpacking libseccomp2:armhf (2.5.5-1ubuntu5) over (2.5.5-1ubuntu4) ... 1853s Setting up libseccomp2:armhf (2.5.5-1ubuntu5) ... 1853s (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.) 1853s Preparing to unpack .../python3-cffi-backend_1.17.1-2build1_armhf.deb ... 1853s Unpacking python3-cffi-backend:armhf (1.17.1-2build1) over (1.17.1-2) ... 1853s Selecting previously unselected package libassuan9:armhf. 1853s Preparing to unpack .../libassuan9_3.0.1-2_armhf.deb ... 1853s Unpacking libassuan9:armhf (3.0.1-2) ... 1853s Preparing to unpack .../libgpgme11t64_1.24.0-2ubuntu1_armhf.deb ... 1853s Unpacking libgpgme11t64:armhf (1.24.0-2ubuntu1) over (1.23.2-5ubuntu4) ... 1853s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_armhf.deb ... 1853s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 1853s Setting up python3-markupsafe (2.1.5-1build3) ... 1853s Setting up libassuan9:armhf (3.0.1-2) ... 1853s Setting up libgpgme11t64:armhf (1.24.0-2ubuntu1) ... 1853s Setting up python3-cffi-backend:armhf (1.17.1-2build1) ... 1853s Processing triggers for man-db (2.13.0-1) ... 1854s Processing triggers for libc-bin (2.40-1ubuntu3) ... 1854s Reading package lists... 1854s Building dependency tree... 1854s Reading state information... 1855s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 1857s autopkgtest [20:08:56]: rebooting testbed after setup commands that affected boot 1960s Reading package lists... 1961s Building dependency tree... 1961s Reading state information... 1961s Starting pkgProblemResolver with broken count: 0 1961s Starting 2 pkgProblemResolver with broken count: 0 1961s Done 1962s The following additional packages will be installed: 1962s krb5-admin-server krb5-config krb5-kdc krb5-user libevent-2.1-7t64 1962s libgssrpc4t64 libkadm5clnt-mit12 libkadm5srv-mit12 libkdb5-10t64 1962s libverto-libevent1t64 libverto1t64 1962s Suggested packages: 1962s krb5-kdc-ldap krb5-kpropd krb5-k5tls krb5-doc 1962s The following NEW packages will be installed: 1962s autopkgtest-satdep krb5-admin-server krb5-config krb5-kdc krb5-user 1962s libevent-2.1-7t64 libgssrpc4t64 libkadm5clnt-mit12 libkadm5srv-mit12 1962s libkdb5-10t64 libverto-libevent1t64 libverto1t64 1962s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded. 1962s Need to get 711 kB/711 kB of archives. 1962s After this operation, 2005 kB of additional disk space will be used. 1962s Get:1 /tmp/autopkgtest.bx8bVp/2-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [724 B] 1963s Get:2 http://ftpmaster.internal/ubuntu plucky/main armhf krb5-config all 2.7 [22.0 kB] 1963s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libgssrpc4t64 armhf 1.21.3-3 [51.5 kB] 1963s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf libkadm5clnt-mit12 armhf 1.21.3-3 [35.1 kB] 1963s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf libkdb5-10t64 armhf 1.21.3-3 [35.1 kB] 1963s Get:6 http://ftpmaster.internal/ubuntu plucky/main armhf libkadm5srv-mit12 armhf 1.21.3-3 [45.6 kB] 1963s Get:7 http://ftpmaster.internal/ubuntu plucky/universe armhf krb5-user armhf 1.21.3-3 [111 kB] 1963s Get:8 http://ftpmaster.internal/ubuntu plucky/main armhf libevent-2.1-7t64 armhf 2.1.12-stable-10 [127 kB] 1963s Get:9 http://ftpmaster.internal/ubuntu plucky/main armhf libverto1t64 armhf 0.3.1-1.2ubuntu3 [9364 B] 1963s Get:10 http://ftpmaster.internal/ubuntu plucky/main armhf libverto-libevent1t64 armhf 0.3.1-1.2ubuntu3 [6324 B] 1963s Get:11 http://ftpmaster.internal/ubuntu plucky/universe armhf krb5-kdc armhf 1.21.3-3 [177 kB] 1963s Get:12 http://ftpmaster.internal/ubuntu plucky/universe armhf krb5-admin-server armhf 1.21.3-3 [91.0 kB] 1963s Preconfiguring packages ... 1964s Fetched 711 kB in 1s (1276 kB/s) 1964s Selecting previously unselected package krb5-config. 1964s (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.) 1964s Preparing to unpack .../00-krb5-config_2.7_all.deb ... 1964s Unpacking krb5-config (2.7) ... 1964s Selecting previously unselected package libgssrpc4t64:armhf. 1964s Preparing to unpack .../01-libgssrpc4t64_1.21.3-3_armhf.deb ... 1964s Unpacking libgssrpc4t64:armhf (1.21.3-3) ... 1964s Selecting previously unselected package libkadm5clnt-mit12:armhf. 1964s Preparing to unpack .../02-libkadm5clnt-mit12_1.21.3-3_armhf.deb ... 1964s Unpacking libkadm5clnt-mit12:armhf (1.21.3-3) ... 1964s Selecting previously unselected package libkdb5-10t64:armhf. 1964s Preparing to unpack .../03-libkdb5-10t64_1.21.3-3_armhf.deb ... 1964s Unpacking libkdb5-10t64:armhf (1.21.3-3) ... 1964s Selecting previously unselected package libkadm5srv-mit12:armhf. 1964s Preparing to unpack .../04-libkadm5srv-mit12_1.21.3-3_armhf.deb ... 1964s Unpacking libkadm5srv-mit12:armhf (1.21.3-3) ... 1964s Selecting previously unselected package krb5-user. 1964s Preparing to unpack .../05-krb5-user_1.21.3-3_armhf.deb ... 1964s Unpacking krb5-user (1.21.3-3) ... 1964s Selecting previously unselected package libevent-2.1-7t64:armhf. 1964s Preparing to unpack .../06-libevent-2.1-7t64_2.1.12-stable-10_armhf.deb ... 1964s Unpacking libevent-2.1-7t64:armhf (2.1.12-stable-10) ... 1964s Selecting previously unselected package libverto1t64:armhf. 1964s Preparing to unpack .../07-libverto1t64_0.3.1-1.2ubuntu3_armhf.deb ... 1964s Unpacking libverto1t64:armhf (0.3.1-1.2ubuntu3) ... 1964s Selecting previously unselected package libverto-libevent1t64:armhf. 1964s Preparing to unpack .../08-libverto-libevent1t64_0.3.1-1.2ubuntu3_armhf.deb ... 1964s Unpacking libverto-libevent1t64:armhf (0.3.1-1.2ubuntu3) ... 1964s Selecting previously unselected package krb5-kdc. 1964s Preparing to unpack .../09-krb5-kdc_1.21.3-3_armhf.deb ... 1964s Unpacking krb5-kdc (1.21.3-3) ... 1964s Selecting previously unselected package krb5-admin-server. 1964s Preparing to unpack .../10-krb5-admin-server_1.21.3-3_armhf.deb ... 1964s Unpacking krb5-admin-server (1.21.3-3) ... 1964s Selecting previously unselected package autopkgtest-satdep. 1964s Preparing to unpack .../11-2-autopkgtest-satdep.deb ... 1964s Unpacking autopkgtest-satdep (0) ... 1964s Setting up libevent-2.1-7t64:armhf (2.1.12-stable-10) ... 1964s Setting up libgssrpc4t64:armhf (1.21.3-3) ... 1964s Setting up krb5-config (2.7) ... 1964s Setting up libkadm5clnt-mit12:armhf (1.21.3-3) ... 1964s Setting up libkdb5-10t64:armhf (1.21.3-3) ... 1964s Setting up libkadm5srv-mit12:armhf (1.21.3-3) ... 1964s Setting up krb5-user (1.21.3-3) ... 1964s update-alternatives: using /usr/bin/kinit.mit to provide /usr/bin/kinit (kinit) in auto mode 1964s update-alternatives: using /usr/bin/klist.mit to provide /usr/bin/klist (klist) in auto mode 1964s update-alternatives: using /usr/bin/kswitch.mit to provide /usr/bin/kswitch (kswitch) in auto mode 1964s update-alternatives: using /usr/bin/ksu.mit to provide /usr/bin/ksu (ksu) in auto mode 1964s update-alternatives: using /usr/bin/kpasswd.mit to provide /usr/bin/kpasswd (kpasswd) in auto mode 1964s update-alternatives: using /usr/bin/kdestroy.mit to provide /usr/bin/kdestroy (kdestroy) in auto mode 1964s update-alternatives: using /usr/bin/kadmin.mit to provide /usr/bin/kadmin (kadmin) in auto mode 1964s update-alternatives: using /usr/bin/ktutil.mit to provide /usr/bin/ktutil (ktutil) in auto mode 1964s Setting up libverto1t64:armhf (0.3.1-1.2ubuntu3) ... 1964s Setting up libverto-libevent1t64:armhf (0.3.1-1.2ubuntu3) ... 1964s Setting up krb5-kdc (1.21.3-3) ... 1965s Created symlink '/etc/systemd/system/multi-user.target.wants/krb5-kdc.service' → '/usr/lib/systemd/system/krb5-kdc.service'. 1965s Could not execute systemctl: at /usr/bin/deb-systemd-invoke line 148. 1965s Setting up krb5-admin-server (1.21.3-3) ... 1966s Created symlink '/etc/systemd/system/multi-user.target.wants/krb5-admin-server.service' → '/usr/lib/systemd/system/krb5-admin-server.service'. 1966s Setting up autopkgtest-satdep (0) ... 1966s Processing triggers for libc-bin (2.40-1ubuntu3) ... 1966s Processing triggers for man-db (2.13.0-1) ... 1979s (Reading database ... 59687 files and directories currently installed.) 1979s Removing autopkgtest-satdep (0) ... 1992s autopkgtest [20:11:11]: test ssh-gssapi: [----------------------- 1995s ## Setting up test environment 1995s ## Creating Kerberos realm EXAMPLE.FAKE 1995s Initializing database '/var/lib/krb5kdc/principal' for realm 'EXAMPLE.FAKE', 1995s master key name 'K/M@EXAMPLE.FAKE' 1995s ## Creating principals 1995s Authenticating as principal root/admin@EXAMPLE.FAKE with password. 1995s Principal "testuser1141@EXAMPLE.FAKE" created. 1995s Authenticating as principal root/admin@EXAMPLE.FAKE with password. 1995s Principal "host/sshd-gssapi.example.fake@EXAMPLE.FAKE" created. 1995s ## Extracting service principal host/sshd-gssapi.example.fake 1995s Authenticating as principal root/admin@EXAMPLE.FAKE with password. 1995s 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. 1995s 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. 1995s ## Adjusting /etc/krb5.conf 1995s ## TESTS 1995s 1995s ## TEST test_gssapi_login 1995s ## Configuring sshd for gssapi-with-mic authentication 1995s ## Restarting ssh 1995s ## Obtaining TGT 1995s Password for testuser1141@EXAMPLE.FAKE: 1995s Ticket cache: FILE:/tmp/krb5cc_0 1995s Default principal: testuser1141@EXAMPLE.FAKE 1995s 1995s Valid starting Expires Service principal 1995s 11/15/24 20:11:14 11/16/24 06:11:14 krbtgt/EXAMPLE.FAKE@EXAMPLE.FAKE 1995s renew until 11/16/24 20:11:14 1995s 1995s ## ssh'ing into localhost using gssapi-with-mic auth 1995s Warning: Permanently added 'sshd-gssapi.example.fake' (ED25519) to the list of known hosts. 1996s Fri Nov 15 20:11:15 UTC 2024 1996s 1996s ## checking that we got a service ticket for ssh (host/) 1996s 11/15/24 20:11:14 11/16/24 06:11:14 host/sshd-gssapi.example.fake@ 1996s Ticket server: host/sshd-gssapi.example.fake@EXAMPLE.FAKE 1996s 1996s ## Checking ssh logs to confirm gssapi-with-mic auth was used 1996s Nov 15 20:11:14 sshd-gssapi.example.fake sshd[1203]: Accepted gssapi-with-mic for testuser1141 from 127.0.0.1 port 36316 ssh2: testuser1141@EXAMPLE.FAKE 1996s ## PASS test_gssapi_login 1996s 1996s ## TEST test_gssapi_keyex_login 1996s ## Configuring sshd for gssapi-keyex authentication 1996s ## Restarting ssh 1996s ## Obtaining TGT 1996s Password for testuser1141@EXAMPLE.FAKE: 1996s Ticket cache: FILE:/tmp/krb5cc_0 1996s Default principal: testuser1141@EXAMPLE.FAKE 1996s 1996s Valid starting Expires Service principal 1996s 11/15/24 20:11:15 11/16/24 06:11:15 krbtgt/EXAMPLE.FAKE@EXAMPLE.FAKE 1996s renew until 11/16/24 20:11:15 1996s 1996s ## ssh'ing into localhost using gssapi-keyex auth 1996s Fri Nov 15 20:11:15 UTC 2024 1996s 1996s ## checking that we got a service ticket for ssh (host/) 1996s 11/15/24 20:11:15 11/16/24 06:11:15 host/sshd-gssapi.example.fake@ 1996s Ticket server: host/sshd-gssapi.example.fake@EXAMPLE.FAKE 1996s 1996s ## Checking ssh logs to confirm gssapi-keyex auth was used 1996s Nov 15 20:11:15 sshd-gssapi.example.fake sshd[1250]: Accepted gssapi-keyex for testuser1141 from 127.0.0.1 port 36324 ssh2: testuser1141@EXAMPLE.FAKE 1996s ## PASS test_gssapi_keyex_login 1996s 1996s ## ALL TESTS PASSED 1996s ## Cleaning up 1996s autopkgtest [20:11:15]: test ssh-gssapi: -----------------------] 2000s autopkgtest [20:11:19]: test ssh-gssapi: - - - - - - - - - - results - - - - - - - - - - 2000s ssh-gssapi PASS 2004s autopkgtest [20:11:23]: test systemd-socket-activation: preparing testbed 2061s autopkgtest [20:12:20]: testbed dpkg architecture: armhf 2062s autopkgtest [20:12:21]: testbed apt version: 2.9.8 2062s autopkgtest [20:12:21]: @@@@@@@@@@@@@@@@@@@@ test bed setup 2070s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 2071s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 2071s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 2071s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [92.2 kB] 2071s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1043 kB] 2071s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [143 kB] 2071s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [747 kB] 2071s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [4428 B] 2071s Fetched 2126 kB in 1s (2239 kB/s) 2071s Reading package lists... 2087s tee: /proc/self/fd/2: Permission denied 2109s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 2109s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 2109s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 2109s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 2110s Reading package lists... 2110s Reading package lists... 2110s Building dependency tree... 2110s Reading state information... 2111s Calculating upgrade... 2112s The following NEW packages will be installed: 2112s libassuan9 2112s The following packages will be upgraded: 2112s libaudit-common libaudit1 libgpgme11t64 libseccomp2 python3-cffi-backend 2112s python3-markupsafe 2112s 6 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 2112s Need to get 351 kB of archives. 2112s After this operation, 224 kB of additional disk space will be used. 2112s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libaudit-common all 1:4.0.2-2ubuntu1 [6578 B] 2112s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libaudit1 armhf 1:4.0.2-2ubuntu1 [47.5 kB] 2112s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf libseccomp2 armhf 2.5.5-1ubuntu5 [49.3 kB] 2112s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf python3-cffi-backend armhf 1.17.1-2build1 [75.9 kB] 2112s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf libassuan9 armhf 3.0.1-2 [34.3 kB] 2112s Get:6 http://ftpmaster.internal/ubuntu plucky/main armhf libgpgme11t64 armhf 1.24.0-2ubuntu1 [125 kB] 2112s Get:7 http://ftpmaster.internal/ubuntu plucky/main armhf python3-markupsafe armhf 2.1.5-1build3 [12.5 kB] 2113s Fetched 351 kB in 0s (703 kB/s) 2113s (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.) 2113s Preparing to unpack .../libaudit-common_1%3a4.0.2-2ubuntu1_all.deb ... 2113s Unpacking libaudit-common (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 2113s Setting up libaudit-common (1:4.0.2-2ubuntu1) ... 2113s (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.) 2113s Preparing to unpack .../libaudit1_1%3a4.0.2-2ubuntu1_armhf.deb ... 2113s Unpacking libaudit1:armhf (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 2113s Setting up libaudit1:armhf (1:4.0.2-2ubuntu1) ... 2113s (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.) 2113s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu5_armhf.deb ... 2113s Unpacking libseccomp2:armhf (2.5.5-1ubuntu5) over (2.5.5-1ubuntu4) ... 2113s Setting up libseccomp2:armhf (2.5.5-1ubuntu5) ... 2113s (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.) 2113s Preparing to unpack .../python3-cffi-backend_1.17.1-2build1_armhf.deb ... 2113s Unpacking python3-cffi-backend:armhf (1.17.1-2build1) over (1.17.1-2) ... 2113s Selecting previously unselected package libassuan9:armhf. 2113s Preparing to unpack .../libassuan9_3.0.1-2_armhf.deb ... 2113s Unpacking libassuan9:armhf (3.0.1-2) ... 2113s Preparing to unpack .../libgpgme11t64_1.24.0-2ubuntu1_armhf.deb ... 2113s Unpacking libgpgme11t64:armhf (1.24.0-2ubuntu1) over (1.23.2-5ubuntu4) ... 2113s Preparing to unpack .../python3-markupsafe_2.1.5-1build3_armhf.deb ... 2113s Unpacking python3-markupsafe (2.1.5-1build3) over (2.1.5-1build2) ... 2113s Setting up python3-markupsafe (2.1.5-1build3) ... 2113s Setting up libassuan9:armhf (3.0.1-2) ... 2113s Setting up libgpgme11t64:armhf (1.24.0-2ubuntu1) ... 2113s Setting up python3-cffi-backend:armhf (1.17.1-2build1) ... 2113s Processing triggers for man-db (2.13.0-1) ... 2114s Processing triggers for libc-bin (2.40-1ubuntu3) ... 2114s Reading package lists... 2114s Building dependency tree... 2114s Reading state information... 2115s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2117s autopkgtest [20:13:16]: rebooting testbed after setup commands that affected boot 2219s Reading package lists... 2220s Building dependency tree... 2220s Reading state information... 2220s Starting pkgProblemResolver with broken count: 0 2220s Starting 2 pkgProblemResolver with broken count: 0 2220s Done 2221s The following NEW packages will be installed: 2221s autopkgtest-satdep 2221s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 2221s Need to get 0 B/724 B of archives. 2221s After this operation, 0 B of additional disk space will be used. 2221s Get:1 /tmp/autopkgtest.bx8bVp/3-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [724 B] 2222s Selecting previously unselected package autopkgtest-satdep. 2222s (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.) 2222s Preparing to unpack .../3-autopkgtest-satdep.deb ... 2222s Unpacking autopkgtest-satdep (0) ... 2222s Setting up autopkgtest-satdep (0) ... 2233s (Reading database ... 59573 files and directories currently installed.) 2233s Removing autopkgtest-satdep (0) ... 2246s autopkgtest [20:15:25]: test systemd-socket-activation: [----------------------- 2249s Stopping ssh.service... 2249s Checking that ssh.socket is active and listening... 2249s Checking that ssh.service is inactive/dead... 2249s Checking that a connection attempt activates ssh.service... 2249s Warning: Permanently added 'localhost' (ED25519) to the list of known hosts. 2249s Checking that sshd can be re-executed... 2249s Checking sshd can run in debug mode... 2250s debug1: SELinux support disabled 2250s debug1: PAM: reinitializing credentials 2250s debug1: permanently_set_uid: 0/0 2250s debug3: Copy environment: XDG_SESSION_ID=22406 2250s debug3: Copy environment: XDG_RUNTIME_DIR=/run/user/0 2250s debug3: Copy environment: DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/0/bus 2250s debug3: Copy environment: XDG_SESSION_TYPE=tty 2250s debug3: Copy environment: XDG_SESSION_CLASS=user 2250s debug3: Copy environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin 2250s debug3: Copy environment: http_proxy=http://squid.internal:3128 2250s debug3: Copy environment: https_proxy=http://squid.internal:3128 2250s 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 2250s debug3: Copy environment: LANG=C.UTF-8 2250s Environment: 2250s LANG=C.UTF-8 2250s USER=root 2250s LOGNAME=root 2250s HOME=/root 2250s PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin 2250s SHELL=/bin/bash 2250s XDG_SESSION_ID=22406 2250s XDG_RUNTIME_DIR=/run/user/0 2250s DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/0/bus 2250s XDG_SESSION_TYPE=tty 2250s XDG_SESSION_CLASS=user 2250s http_proxy=http://squid.internal:3128 2250s https_proxy=http://squid.internal:3128 2250s 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 2250s SSH_CLIENT=127.0.0.1 40564 22 2250s SSH_CONNECTION=127.0.0.1 40564 127.0.0.1 22 2250s Done. 2250s autopkgtest [20:15:29]: test systemd-socket-activation: -----------------------] 2254s systemd-socket-activation PASS 2254s autopkgtest [20:15:33]: test systemd-socket-activation: - - - - - - - - - - results - - - - - - - - - - 2258s autopkgtest [20:15:37]: test sshd-socket-generator: preparing testbed 2268s Reading package lists... 2268s Building dependency tree... 2268s Reading state information... 2269s Starting pkgProblemResolver with broken count: 0 2269s Starting 2 pkgProblemResolver with broken count: 0 2269s Done 2270s The following NEW packages will be installed: 2270s autopkgtest-satdep 2270s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 2270s Need to get 0 B/720 B of archives. 2270s After this operation, 0 B of additional disk space will be used. 2270s Get:1 /tmp/autopkgtest.bx8bVp/4-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 2270s Selecting previously unselected package autopkgtest-satdep. 2270s (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.) 2270s Preparing to unpack .../4-autopkgtest-satdep.deb ... 2270s Unpacking autopkgtest-satdep (0) ... 2270s Setting up autopkgtest-satdep (0) ... 2282s (Reading database ... 59573 files and directories currently installed.) 2282s Removing autopkgtest-satdep (0) ... 2288s autopkgtest [20:16:07]: test sshd-socket-generator: [----------------------- 2290s test_default...PASS 2290s test_custom_port...PASS 2290s test_default_and_custom_port...PASS 2290s test_mutiple_custom_ports...PASS 2290s test_custom_listenaddress...PASS 2290s test_custom_listenaddress_and_port...PASS 2290s test_custom_ipv6_listenaddress...PASS 2290s test_custom_family_ipv4...PASS 2290s test_custom_family_ipv6...PASS 2290s test_custom_port_and_family_ipv4...PASS 2290s test_custom_port_and_family_ipv6...PASS 2290s test_match_on_port...PASS 2291s autopkgtest [20:16:10]: test sshd-socket-generator: -----------------------] 2295s autopkgtest [20:16:14]: test sshd-socket-generator: - - - - - - - - - - results - - - - - - - - - - 2295s sshd-socket-generator PASS 2298s autopkgtest [20:16:17]: @@@@@@@@@@@@@@@@@@@@ summary 2298s regress PASS 2298s ssh-gssapi PASS 2298s systemd-socket-activation PASS 2298s sshd-socket-generator PASS