sshd debugs with HPN enabled (client cannot connect)

openssh-hpn-enabled-noconnect.txt (text/plain), 7.29 KB, created by Reuben Farrelly on 2022-01-05 05:34:06 UTC

nas ~/.ssh # /usr/sbin/sshd -p 2200 -d
debug1: Config token is passwordauthentication
debug1: Config token is usepam
debug1: Config token is printmotd
debug1: Config token is printlastlog
debug1: Config token is subsystem
debug1: Config token is acceptenv
debug1: Config token is allowusers
debug1: Config token is permitrootlogin
debug1: Config token is acceptenv
debug1: HPN Buffer Size: 131072
debug1: sshd version OpenSSH_8.8, OpenSSL 3.0.1 14 Dec 2021
debug1: private host key #0: ssh-rsa SHA256:[REDACTED]
debug1: private host key #1: ecdsa-sha2-nistp256 SHA256:[REDACTED]
debug1: private host key #2: ssh-ed25519 SHA256:[REDACTED]
debug1: rexec_argv[0]='/usr/sbin/sshd'
debug1: rexec_argv[1]='-p'
debug1: rexec_argv[2]='2200'
debug1: rexec_argv[3]='-d'
debug1: Set /proc/self/oom_score_adj from 0 to -1000
debug1: Bind to port 2200 on 0.0.0.0.
debug1: Server TCP RWIN socket size: 131072
debug1: HPN Buffer Size: 131072
Server listening on 0.0.0.0 port 2200.
debug1: Bind to port 2200 on ::.
debug1: Server TCP RWIN socket size: 131072
debug1: HPN Buffer Size: 131072
Server listening on :: port 2200.

debug1: Server will not fork when running in debugging mode.
debug1: rexec start in 5 out 5 newsock 5 pipe -1 sock 8
debug1: Config token is passwordauthentication
debug1: Config token is usepam
debug1: Config token is printmotd
debug1: Config token is printlastlog
debug1: Config token is subsystem
debug1: Config token is acceptenv
debug1: Config token is allowusers
debug1: Config token is permitrootlogin
debug1: Config token is acceptenv
debug1: HPN Buffer Size: 131072
debug1: sshd version OpenSSH_8.8, OpenSSL 3.0.1 14 Dec 2021
debug1: private host key #0: ssh-rsa SHA256:[REDACTED]
debug1: private host key #1: ecdsa-sha2-nistp256 SHA256:[REDACTED]
debug1: private host key #2: ssh-ed25519 SHA256:[REDACTED]
debug1: inetd sockets after dupping: 3, 3
Connection from 2403:5808:50:11:6949:3b5c:dce6:607d port 58867 on 2403:5808:50:10::24 port 2200 rdomain ""
debug1: HPN Disabled: 0, HPN Buffer Size: 131072
debug1: Local version string SSH-2.0-OpenSSH_8.8p1-hpn15v2
debug1: Remote protocol version 2.0, remote software version SecureCRT_9.2.0 (x64 build 2659)
debug1: compat_banner: no match: SecureCRT_9.2.0 (x64 build 2659)
debug1: permanently_set_uid: 22/22 [preauth]
debug1: list_hostkey_types: rsa-sha2-512,rsa-sha2-256,ecdsa-sha2-nistp256,ssh-ed25519 [preauth]
debug1: SSH2_MSG_KEXINIT sent [preauth]
debug1: SSH2_MSG_KEXINIT received [preauth]
debug1: AUTH STATE IS 0 [preauth]
debug1: kex: algorithm: [e-mail] [preauth]
debug1: kex: host key algorithm: rsa-sha2-512 [preauth]
debug1: REQUESTED ENC.NAME is 'aes256-ctr' [preauth]
debug1: REQUESTED MAC.NAME is 'hmac-sha2-512' [preauth]
debug1: kex: client->server cipher: aes256-ctr MAC: hmac-sha2-512 compression: none [preauth]
debug1: REQUESTED ENC.NAME is 'aes256-ctr' [preauth]
debug1: REQUESTED MAC.NAME is 'hmac-sha2-512' [preauth]
debug1: kex: server->client cipher: aes256-ctr MAC: hmac-sha2-512 compression: none [preauth]
debug1: expecting SSH2_MSG_KEX_ECDH_INIT [preauth]
debug1: SSH2_MSG_KEX_ECDH_INIT received [preauth]
debug1: rekey out after 4294967296 blocks [preauth]
debug1: SSH2_MSG_NEWKEYS sent [preauth]
debug1: Sending SSH2_MSG_EXT_INFO [preauth]
debug1: expecting SSH2_MSG_NEWKEYS [preauth]
debug1: SSH2_MSG_NEWKEYS received [preauth]
debug1: rekey in after 4294967296 blocks [preauth]
debug1: KEX done [preauth]
debug1: userauth-request for user root service ssh-connection method none [preauth]
debug1: attempt 0 failures 0 [preauth]
debug1: Config token is passwordauthentication
debug1: Config token is usepam
debug1: Config token is printmotd
debug1: Config token is printlastlog
debug1: Config token is subsystem
debug1: Config token is acceptenv
debug1: Config token is allowusers
debug1: Config token is permitrootlogin
debug1: Config token is acceptenv
debug1: PAM: initializing for "root"
debug1: PAM: setting PAM_RHOST to "2403:5808:50:11:6949:3b5c:dce6:607d"
debug1: PAM: setting PAM_TTY to "ssh"
debug1: userauth-request for user root service ssh-connection method publickey [preauth]
debug1: attempt 1 failures 0 [preauth]
debug1: userauth_pubkey: test pkalg ssh-ed25519 pkblob ED25519 SHA256:[REDACTED] [preauth]
debug1: temporarily_use_uid: 0/0 (e=0/0)
debug1: trying public key file /root/.ssh/authorized_keys
debug1: fd 4 clearing O_NONBLOCK
debug1: /root/.ssh/authorized_keys:3: matching key found: ED25519 SHA256:[REDACTED]
debug1: /root/.ssh/authorized_keys:3: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding
Accepted key ED25519 SHA256:[REDACTED] found at /root/.ssh/authorized_keys:3
debug1: restore_uid: 0/0
Postponed publickey for root from 2403:5808:50:11:6949:3b5c:dce6:607d port 58867 ssh2 [preauth]
debug1: userauth-request for user root service ssh-connection method publickey [preauth]
debug1: attempt 2 failures 0 [preauth]
debug1: temporarily_use_uid: 0/0 (e=0/0)
debug1: trying public key file /root/.ssh/authorized_keys
debug1: fd 4 clearing O_NONBLOCK
debug1: /root/.ssh/authorized_keys:3: matching key found: ED25519 SHA256:u/tsFcH4Bxar9/JuKshWHvOv3VLTfSq/1a8NnfkYyPU
debug1: /root/.ssh/authorized_keys:3: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding
Accepted key ED25519 SHA256:[REDACTED] found at /root/.ssh/authorized_keys:3
debug1: restore_uid: 0/0
debug1: auth_activate_options: setting new authentication options
debug1: do_pam_account: called
Accepted publickey for root from 2403:5808:50:11:6949:3b5c:dce6:607d port 58867 ssh2: ED25519 SHA256:[REDACTED]
debug1: monitor_child_preauth: user root authenticated by privileged process
debug1: auth_activate_options: setting new authentication options [preauth]
debug1: monitor_read_log: child log fd closed
debug1: PAM: establishing credentials
debug1: rekey in after 4294967296 blocks
debug1: rekey out after 4294967296 blocks
debug1: ssh_packet_set_postauth: called
debug1: Single to Multithreaded CTR cipher swap - server request
debug1: active: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding
debug1: Entering interactive session for SSH2.
debug1: server_init_dispatch
debug1: SSH2_MSG_KEXINIT sent
debug1: server_input_channel_open: ctype session rchan 0 win 2097152 max 32768
debug1: input_session_request
debug1: channel 0: new [server-session]
debug1: session_new: session 0
debug1: session_open: channel 0
debug1: session_open: session 0: link with channel 0
debug1: server_input_channel_open: confirm session
debug1: enqueue packet: 91
debug1: Got 82/8 for keepalive
debug1: SSH2_MSG_KEXINIT received
debug1: AUTH STATE IS 1
debug1: kex: algorithm: [e-mail]
debug1: kex: host key algorithm: rsa-sha2-512
debug1: REQUESTED ENC.NAME is 'aes256-ctr'
debug1: REQUESTED MAC.NAME is 'hmac-sha2-512'
debug1: kex: client->server cipher: aes256-ctr MAC: hmac-sha2-512 compression: none
debug1: REQUESTED ENC.NAME is 'aes256-ctr'
debug1: REQUESTED MAC.NAME is 'hmac-sha2-512'
debug1: kex: server->client cipher: aes256-ctr MAC: hmac-sha2-512 compression: none
debug1: expecting SSH2_MSG_KEX_ECDH_INIT
debug1: SSH2_MSG_KEX_ECDH_INIT received
sshd_hostkey_sign: privkey sign failed
debug1: do_cleanup
debug1: PAM: cleanup
debug1: PAM: closing session
debug1: PAM: deleting credentials
nas ~/.ssh # 
nas ~/.ssh #