Other bits about the banner, from the logs. I don't see anything obviously truncated:
16:53:44.527442099 O: debug1: Local version string SSH-2.0-OpenSSH_9.6p1 Ubuntu-3ubuntu13.11+ccache2 16:53:44.528835039 O: debug1: Remote protocol version 2.0, remote software version OpenSSH_9.6p1 Ubuntu-3ubuntu13.11+ccache2 16:53:44.530280132 O: debug1: compat_banner: match: OpenSSH_9.6p1 Ubuntu-3ubuntu13.11+ccache2 pat OpenSSH* compat 0x04000000 The server logs look happy, I was not able to spot an obvious problem. Some snippets: 16:53:44.791772945 O: ==> /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/failed-sshd.log <== 16:53:44.793780839 O: Executing: /usr/sbin/sshd -i -f /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/sshd_proxy ... 16:53:45.084249374 O: Accepted key ED25519 SHA256:GaNBm0jKEm5khuEZBageIYnrgkpeGFi9+THdb+NfsAg found at /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/authorized_keys_openssh-tests:1 ... 16:53:45.104184938 O: Postponed publickey for openssh-tests from UNKNOWN port 65535 ssh2 [preauth] ... 16:53:45.108405093 O: debug1: userauth-request for user openssh-tests service ssh-connection method publickey-hostbound-...@openssh.com [preauth] ... 16:53:45.177265163 O: Accepted publickey for openssh-tests from UNKNOWN port 65535 ssh2: ED25519 SHA256:GaNBm0jKEm5khuEZBageIYnrgkpeGFi9+THdb+NfsAg ... 16:53:45.214089006 O: debug1: PAM: establishing credentials 16:53:45.216001412 O: debug3: PAM: opening session ... 16:53:45.266099637 O: debug1: active: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding 16:53:45.269041783 O: debug3: sending debug message: /tmp/autopkgtest.mlareh/autopkgtes16:53:45.272714333 I: Finished with exitcode 2 Synchronizing state of haveged.service with SysV service script with /usr/lib/systemd/systemd-sysv-install. Executing: /usr/lib/systemd/systemd-sysv-install disable haveged Removed "/etc/systemd/system/sysinit.target.wants/haveged.service". info: Looking for files to backup/remove ... info: Removing files ... info: Removing crontab ... info: Removing user `openssh-tests' ... autopkgtest [13:53:46]: test regress: -----------------------] regress FAIL non-zero exit status 2 There seems to be a truncation of some sort in the last debug3 message: "sending debug message". But looks like the user was authenticated, and PAM was granting them a session. I got a hold of the actual sshd logs, and the truncation is not there. But I also don't see anything obvious being wrong: debug1: active: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding^M debug3: sending debug message: /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/authorized_keys_openssh-tests:1: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding^M debug3: send packet: type 4^M debug3: sending debug message: /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/authorized_keys_openssh-tests:1: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding^M debug3: send packet: type 4^M debug1: Entering interactive session for SSH2.^M debug1: server_init_dispatch^M Connection closed by UNKNOWN port 65535^M debug1: do_cleanup^M debug3: PAM: sshpam_thread_cleanup entering^M debug1: temporarily_use_uid: 1002/1002 (e=1002/1002)^M debug1: restore_uid: (unprivileged)^M Transferred: sent 4512, received 2776 bytes^M Closing connection to UNKNOWN port 65535^M debug3: mm_audit_event entering^M debug3: mm_request_send: entering, type 112^M debug3: mm_request_send: entering, type 50^M debug3: mm_request_receive: entering^M debug3: monitor_read: checking request 112^M debug3: mm_answer_audit_event entering^M debug3: mm_request_receive: entering^M debug3: monitor_read: checking request 50^M debug3: mm_answer_term: tearing down sessions^M debug1: PAM: cleanup^M debug1: PAM: closing session^M debug1: PAM: deleting credentials^M FAIL: unexpected error mac hmac-sha2-512 at 2900: Executing: /usr/bin/ssh -m hmac-sha2-512 -c aes128-ctr -F /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/ssh_proxy -o proxycommand=sudo env SSH_SK_HELPER= sh /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/sshd-log-wrapper.sh -i -f /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/sshd_proxy | /tmp/autopkgtest.mlareh/autopkgtest_tmp/user/regress/modpipe -wm xor:2900:1 -oServerAliveInterval=1 -oServerAliveCountMax=30 999.999.999.999 printf "%4096s" " ".Connection to UNKNOWN port 65535 timed out. -- You received this bug notification because you are a member of Ubuntu Touch seeded packages, which is subscribed to openssh in Ubuntu. https://bugs.launchpad.net/bugs/2091943 Title: OpenSSH autopkgtests do not like tilde character in its version string (e.g. ~ppa1) Status in openssh package in Ubuntu: New Bug description: Starting with Noble, the openssh autopkgtest "regress" (specifically "integrity.sh") fails when the version string contains a tilde character, such as "~ppa1". In such case, it would fail with a log like this: """ 943s 15:17:52.628196592 O: aes128-...@openssh.com: expected 10 mac errors, got 9 943s 15:17:52.643425013 O: test integrity: aes256-...@openssh.com @2900 973s 15:18:22.861245950 O: unexpected error mac aes256-...@openssh.com at 2900: Executing: /usr/bin/ssh -c aes256-...@openssh.com -F /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/ssh_proxy -o proxycommand=sudo env SSH_SK_HELPER= sh /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/sshd-log-wrapper.sh -i -f /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/sshd_proxy | /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/modpipe -wm xor:2900:1 -oServerAliveInterval=1 -oServerAliveCountMax=30 999.999.999.999 printf "%4096s" " ".Connection to UNKNOWN port 65535 timed out. 973s 15:18:22.873852332 O: test integrity: aes256-...@openssh.com @2901 974s 15:18:23.054367085 O: test integrity: aes256-...@openssh.com @2902 974s 15:18:23.233795263 O: test integrity: aes256-...@openssh.com @2903 974s 15:18:23.414326814 O: test integrity: aes256-...@openssh.com @2904 974s 15:18:23.593728032 O: test integrity: aes256-...@openssh.com @2905 974s 15:18:23.773737617 O: test integrity: aes256-...@openssh.com @2906 974s 15:18:23.953240316 O: test integrity: aes256-...@openssh.com @2907 975s 15:18:24.132768013 O: test integrity: aes256-...@openssh.com @2908 975s 15:18:24.314160170 O: test integrity: aes256-...@openssh.com @2909 975s 15:18:24.481575251 O: test integrity: 10 errors: mac 9 padding 0 length 0 timeout 0 975s 15:18:24.511336625 O: aes256-...@openssh.com: expected 10 mac errors, got 9 975s 15:18:24.527543807 O: test integrity: chacha20-poly1...@openssh.com @2900 1005s 15:18:54.780404775 O: unexpected error mac chacha20-poly1...@openssh.com at 2900: Executing: /usr/bin/ssh -c chacha20-poly1...@openssh.com -F /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/ssh_proxy -o proxycommand=sudo env SSH_SK_HELPER= sh /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/sshd-log-wrapper.sh -i -f /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/sshd_proxy | /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/modpipe -wm xor:2900:1 -oServerAliveInterval=1 -oServerAliveCountMax=30 999.999.999.999 printf "%4096s" " ".Connection to UNKNOWN port 65535 timed out. 1005s 15:18:54.793199833 O: test integrity: chacha20-poly1...@openssh.com @2901 1006s 15:18:54.974724705 O: test integrity: chacha20-poly1...@openssh.com @2902 1006s 15:18:55.156217135 O: test integrity: chacha20-poly1...@openssh.com @2903 1006s 15:18:55.338105249 O: test integrity: chacha20-poly1...@openssh.com @2904 1006s 15:18:55.518876831 O: test integrity: chacha20-poly1...@openssh.com @2905 1006s 15:18:55.702486443 O: test integrity: chacha20-poly1...@openssh.com @2906 1006s 15:18:55.886914864 O: test integrity: chacha20-poly1...@openssh.com @2907 1007s 15:18:56.072806620 O: test integrity: chacha20-poly1...@openssh.com @2908 1007s 15:18:56.255436459 O: test integrity: chacha20-poly1...@openssh.com @2909 1007s 15:18:56.426811377 O: test integrity: 10 errors: mac 9 padding 0 length 0 timeout 0 1007s 15:18:56.461882513 O: chacha20-poly1...@openssh.com: expected 10 mac errors, got 9 1007s 15:18:56.462364399 E: make: *** [Makefile:252: t-exec] Error 1 1007s 15:18:56.463874215 O: failed integrity 1007s 15:18:56.466716165 O: make: Leaving directory '/tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress' 1007s 15:18:56.468626306 O: ==> /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/failed-regress.log <== 1007s 15:18:56.467685576 E: tail: error writing 'standard output': Resource temporarily unavailable 1007s 15:18:56.470363804 E: tail: error writing 'standard output': Resource temporarily unavailable 1007s 15:18:56.470451085 O: Executing: /usr/bin/ssh -Q key-plain log /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/log/20241216T151643.962770.ssh.48972.log 1007s 15:18:56.471894741 O: Executing: /usr/bin/ssh -Q key-plain log /tmp/autopkgtest.IEqRfF/autopkgtest_tmp/user/regress/log/20241216T151643.972077.ssh.48979.log 1007s 15:18:56.471892661 E: tail: error writing 'standard output': Resource temporarily unavailable """ To manage notifications about this bug go to: https://bugs.launchpad.net/ubuntu/+source/openssh/+bug/2091943/+subscriptions -- Mailing list: https://launchpad.net/~touch-packages Post to : touch-packages@lists.launchpad.net Unsubscribe : https://launchpad.net/~touch-packages More help : https://help.launchpad.net/ListHelp
