GabriRuflex opened a new issue, #847: URL: https://github.com/apache/mina-sshd/issues/847
### Version 2.15.0 ### Bug description I receive a `Connection reset` error while I'm trying to upload a file via SFTP on a Huawei device using `RHEL 8.10`. This error appears on machines running `RHEL 8.10`, which includes `OpenSSH_8.0p1, OpenSSL 1.1.1k FIPS 25 Mar 2021`. With `RHEL 9.6`, that includes `OpenSSH_8.7p1, OpenSSL 3.2.2 4 Jun 2024`, the authentication is successfully executed and the file is uploaded. ### Actual behavior On `RHEL 8.10` it doesn't work. It seems the `sshd client` can't correctly handle the `SSH_MSG_USERAUTH_BANNER` message, thus the authentication phase fails. This is the error log: ``` [org.apache.sshd.common.util.security.SecurityUtils] register(EdDSA) not registered - enabled=true, supported=false [org.apache.sshd.common.io.DefaultIoServiceFactoryFactory] No detected/configured IoServiceFactoryFactory; using Nio2ServiceFactoryFactory [org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver] reloadHostConfigEntries([email protected]:22/null) check permissions of /home/test/.ssh/config [org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver] resolveEffectiveResolver([email protected]:22) loaded 1 entries from /home/test/.ssh/config [org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver] resolveEffectiveHost([email protected]:22/null) => 10.0.0.1: [email protected]:22 [org.apache.sshd.client.SshClient] connect([email protected]:22) effective: 10.0.0.1: [email protected]:22 [org.apache.sshd.common.io.nio2.Nio2Connector] Connecting to /10.0.0.1:22 [org.apache.sshd.common.io.nio2.Nio2Connector] setOption(SO_REUSEADDR)[true] from property=Property[socket-reuseaddr](Boolean] [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) connect(/10.0.0.1:22): waiting for connection (timeout=60000ms) [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) Creating IoSession on /10.100.0.1:38794 from /10.0.0.1:22 via null [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) Client session created: Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) ClientUserAuthService(ClientSessionImpl[null@/10.0.0.1:22]) client methods: [publickey, keyboard-interactive, password] [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) sessionCreated(ClientSessionImpl[null@/10.0.0.1:22]) tracking [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) initializeProxyConnector(ClientSessionImpl[null@/10.0.0.1:22]) no proxy to initialize [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) sendIdentification(ClientSessionImpl[null@/10.0.0.1:22]): SSH-2.0-APACHE-SSHD-2.15.0 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 28 bytes [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) sendKexInit(ClientSessionImpl[null@/10.0.0.1:22]) Send SSH_MSG_KEXINIT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) encode(ClientSessionImpl[null@/10.0.0.1:22]) packet #0 sending command=20[SSH_MSG_KEXINIT] len=1393 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 1408 bytes [org.apache.sshd.client.SshClient] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider override in session listener [org.apache.sshd.client.SshClient] (sshd-SshClient[178aeecb]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider enhanced [org.apache.sshd.client.future.DefaultConnectFuture] Connected to /10.0.0.1:22 after 34357588 nanos [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-3) doReadIdentification(ClientSessionImpl[user@/10.0.0.1:22]) line='SSH-2.0--' [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-3) readIdentification(ClientSessionImpl[user@/10.0.0.1:22]) Server version string: SSH-2.0-- [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #0 SSH_MSG_KEXINIT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) handleKexInit(ClientSessionImpl[user@/10.0.0.1:22]) SSH_MSG_KEXINIT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) negotiate(ClientSessionImpl[user@/10.0.0.1:22]) strict KEX=false client=true server=false [org.apache.sshd.client.session.ClientSessionImpl] addPasswordIdentity(ClientSessionImpl[user@/10.0.0.1:22]) SHA256:NhNdqVhmUqoL3v7mKAAcTE62kB4nikQjOiPNKBHq3Bk [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: kex algorithms = curve25519-sha256 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: server host key algorithms = ecdsa-sha2-nistp521 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: encryption algorithms (client to server) = aes128-ctr [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: encryption algorithms (server to client) = aes128-ctr [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: mac algorithms (client to server) = hmac-sha2-256 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: mac algorithms (server to client) = hmac-sha2-256 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: compression algorithms (client to server) = none [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) setNegotiationResult(ClientSessionImpl[user@/10.0.0.1:22]) Kex: compression algorithms (server to client) = none [org.apache.sshd.client.kex.DHGClient] (sshd-SshClient[178aeecb]-nio2-thread-4) init(DHGClient[curve25519-sha256])[ClientSessionImpl[user@/10.0.0.1:22]] Send SSH_MSG_KEXDH_INIT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #1 sending command=30[30] len=37 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-4) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 56 bytes [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #1 31 [org.apache.sshd.client.kex.DHGClient] (sshd-SshClient[178aeecb]-nio2-thread-5) next(DHGClient[curve25519-sha256])[ClientSessionImpl[user@/10.0.0.1:22]] process command=SSH_MSG_KEXDH_REPLY [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) setServerKey(ClientSessionImpl[user@/10.0.0.1:22]) keyType=ecdsa-sha2-nistp521, digest=SHA256:Stv8rltQHQdzaAAhaowY5sB24iPxTmFUZl1l1ePnzKM [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) handleKexMessage(ClientSessionImpl[user@/10.0.0.1:22])[curve25519-sha256] KEX processing complete after cmd=31 [org.apache.sshd.client.keyverifier.AcceptAllServerKeyVerifier] (sshd-SshClient[178aeecb]-nio2-thread-5) Server at /10.0.0.1:22 presented unverified EC key: SHA256:Stv8rltQHQdzaAAhaowY5sB24iPxTmFUZl1l1ePnzKM [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) checkKeys(ClientSessionImpl[user@/10.0.0.1:22]) key=ecdsa-sha2-nistp521-SHA256:Stv8rltQHQdzaAAhaowY5sB24iPxTmFUZl1l1ePnzKM, verified=true [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) sendNewKeys(ClientSessionImpl[user@/10.0.0.1:22]) Send SSH_MSG_NEWKEYS [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) prepareNewKeys(ClientSessionImpl[user@/10.0.0.1:22]) session ID=8c:3f:ba:9e:59:f4:c3:49:a2:f7:3f:32:2a:78:3b:4c:23:32:7f:db:32:c1:cc:4b:2e:ee:5a:79:b9:27:5b:5d [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #2 sending command=21[SSH_MSG_NEWKEYS] len=1 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-5) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 16 bytes [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) setOutputEncoding(ClientSessionImpl[user@/10.0.0.1:22]): cipher BaseCTRCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16]; mac BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false; compression none[Deflater/-1]; blocks limit 134217728 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) handleNewKeys(ClientSessionImpl[user@/10.0.0.1:22]) No pending packets to flush at end of KEX [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #2 SSH_MSG_NEWKEYS [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) handleNewKeys(ClientSessionImpl[user@/10.0.0.1:22]) SSH_MSG_NEWKEYS command=SSH_MSG_NEWKEYS [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) setInputEncoding(ClientSessionImpl[user@/10.0.0.1:22]): cipher BaseCTRCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16]; mac BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false; compression none[Inflater/-1]; blocks limit 4294967296 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) sendInitialServiceRequest(ClientSessionImpl[user@/10.0.0.1:22]) Send SSH_MSG_SERVICE_REQUEST for ssh-userauth [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #3 sending command=5[SSH_MSG_SERVICE_REQUEST] len=17 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-5) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 80 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-5) auth(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST for 'none' [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #4 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=44 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-5) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 112 bytes [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-1) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #3 SSH_MSG_SERVICE_ACCEPT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-1) handleServiceAccept(ClientSessionImpl[user@/10.0.0.1:22]) SSH_MSG_SERVICE_ACCEPT service=ssh-userauth [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-1) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #4 SSH_MSG_USERAUTH_FAILURE [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-1) processUserAuth(ClientSessionImpl[user@/10.0.0.1:22]) Received SSH_MSG_USERAUTH_FAILURE - partial=false, methods=publickey,password [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-1) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) starting authentication mechanisms: client=[publickey, keyboard-interactive, password], client index=0, server=[publickey, password] [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-1) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) attempting method=publickey [org.apache.sshd.client.auth.pubkey.UserAuthPublicKey] (sshd-SshClient[178aeecb]-nio2-thread-1) sendAuthDataRequest(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST request publickey type=rsa-sha2-512 - fingerprint=SHA256:WMPCZt1CDm+g0cG2exQ2+MOXuqJIA1YlmwUaG1bTUqQ [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-1) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #5 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=605 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 672 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-1) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) successfully processed initial buffer by method=publickey [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #5 SSH_MSG_USERAUTH_FAILURE [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-2) processUserAuth(ClientSessionImpl[user@/10.0.0.1:22]) Received SSH_MSG_USERAUTH_FAILURE - partial=false, methods=publickey,password [org.apache.sshd.client.auth.pubkey.UserAuthPublicKey] (sshd-SshClient[178aeecb]-nio2-thread-2) sendAuthDataRequest(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST request publickey type=rsa-sha2-256 - fingerprint=SHA256:WMPCZt1CDm+g0cG2exQ2+MOXuqJIA1YlmwUaG1bTUqQ [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #6 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=605 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-2) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 672 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-2) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) successfully processed initial buffer by method=publickey [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-3) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #6 SSH_MSG_USERAUTH_FAILURE [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-3) processUserAuth(ClientSessionImpl[user@/10.0.0.1:22]) Received SSH_MSG_USERAUTH_FAILURE - partial=false, methods=publickey,password [org.apache.sshd.client.auth.pubkey.UserAuthPublicKey] (sshd-SshClient[178aeecb]-nio2-thread-3) sendAuthDataRequest(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST request publickey type=ssh-rsa - fingerprint=SHA256:WMPCZt1CDm+g0cG2exQ2+MOXuqJIA1YlmwUaG1bTUqQ [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-3) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #7 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=600 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-3) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 656 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-3) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) successfully processed initial buffer by method=publickey [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #7 SSH_MSG_USERAUTH_FAILURE [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-4) processUserAuth(ClientSessionImpl[user@/10.0.0.1:22]) Received SSH_MSG_USERAUTH_FAILURE - partial=false, methods=publickey,password [org.apache.sshd.common.config.keys.loader.openssh.OpenSSHKeyPairResourceParser] (sshd-SshClient[178aeecb]-nio2-thread-4) extractKeyPairs(/home/test/.ssh/id_rsa_git) decode 1 keys using context=OpenSSHParserContext[cipher=none, kdfOptions=none: options=] [org.apache.sshd.client.auth.pubkey.UserAuthPublicKey] (sshd-SshClient[178aeecb]-nio2-thread-4) sendAuthDataRequest(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST request publickey type=rsa-sha2-512 - fingerprint=SHA256:LJDP6LLpfLiJJenyvRLFjN8CXC7dlTM07rKfVX7dfn8 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-4) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #8 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=605 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-4) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 672 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-4) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) successfully processed initial buffer by method=publickey [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #8 SSH_MSG_USERAUTH_FAILURE [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-5) processUserAuth(ClientSessionImpl[user@/10.0.0.1:22]) Received SSH_MSG_USERAUTH_FAILURE - partial=false, methods=publickey,password [org.apache.sshd.client.auth.pubkey.UserAuthPublicKey] (sshd-SshClient[178aeecb]-nio2-thread-5) sendAuthDataRequest(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST request publickey type=rsa-sha2-256 - fingerprint=SHA256:LJDP6LLpfLiJJenyvRLFjN8CXC7dlTM07rKfVX7dfn8 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-5) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #9 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=605 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-5) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 672 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-5) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) successfully processed initial buffer by method=publickey [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-1) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #9 SSH_MSG_USERAUTH_FAILURE [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-1) processUserAuth(ClientSessionImpl[user@/10.0.0.1:22]) Received SSH_MSG_USERAUTH_FAILURE - partial=false, methods=publickey,password [org.apache.sshd.client.auth.pubkey.UserAuthPublicKey] (sshd-SshClient[178aeecb]-nio2-thread-1) sendAuthDataRequest(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST request publickey type=ssh-rsa - fingerprint=SHA256:LJDP6LLpfLiJJenyvRLFjN8CXC7dlTM07rKfVX7dfn8 [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-1) encode(ClientSessionImpl[user@/10.0.0.1:22]) packet #10 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=600 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) writing 656 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-1) tryNext(ClientSessionImpl[user@/10.0.0.1:22]) successfully processed initial buffer by method=publickey [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #10 SSH_MSG_USERAUTH_BANNER [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[178aeecb]-nio2-thread-2) process(ClientSessionImpl[user@/10.0.0.1:22]) Welcome banner(lang=): [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) doHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #11 SSH_MSG_DISCONNECT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=SshException, signalled=true, first=false: The connection is closed by SSH Server [org.apache.sshd.client.session.ClientSessionImpl] close(ClientSessionImpl[user@/10.0.0.1:22]) Closing immediately [org.apache.sshd.client.session.ClientSessionImpl] signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=SshException, signalled=false, first=false: Session is being closed [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) handleDisconnect(ClientSessionImpl[user@/10.0.0.1:22]) SSH_MSG_DISCONNECT reason=SSH2_DISCONNECT_PROTOCOL_ERROR, [lang= ] msg=The connection is closed by SSH Server [org.apache.sshd.common.session.helpers.SessionTimeoutListener] sessionClosed(ClientSessionImpl[user@/10.0.0.1:22]) un-tracked [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] state already Immediate [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-2) handleReadCycleFailure(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) IOException after 233906 nanos at read cycle=11: Connection reset [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-2) exceptionCaught(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) caught IOException[Connection reset] - calling handler [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=IOException, signalled=false, first=false: Connection reset [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) exceptionCaught(ClientSessionImpl[user@/10.0.0.1:22]) ignore IOException due to state=Immediate, message='Connection reset' [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-2) close(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) Closing immediately [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-2) doCloseImmediately(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) closing socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[connected local=/10.100.0.1:38794 remote=/10.0.0.1:22] [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-2) doCloseImmediately(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22]) socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[closed] closed [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[178aeecb]-nio2-thread-2) unmapSession(id=101): Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[178aeecb]-nio2-thread-2) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] state already Immediate [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[178aeecb]-nio2-thread-2) close(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22])[Immediately] closed [org.apache.sshd.client.session.ClientUserAuthService] close(org.apache.sshd.client.session.ClientUserAuthService@1e4ac143) Closing immediately [org.apache.sshd.client.session.ClientUserAuthService] close(org.apache.sshd.client.session.ClientUserAuthService@1e4ac143)[Immediately] closed [org.apache.sshd.client.session.ClientConnectionService] close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]]) Closing immediately [org.apache.sshd.client.session.ClientConnectionService] stopHeartBeat(ClientSessionImpl[user@/10.0.0.1:22]) no heartbeat to stop [org.apache.sshd.client.session.ClientConnectionService] close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]])[Immediately] closed [org.apache.sshd.common.io.nio2.Nio2Session] close(Nio2Session[local=/10.100.0.1:38794, remote=/10.0.0.1:22])[Immediately] state already Closed [org.apache.sshd.common.util.closeable.SequentialCloseable] doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@4de533a6) signal close complete immediately=true [org.apache.sshd.client.session.ClientSessionImpl] close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] closed [org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver] (MWFM Worker 2) resolveEffectiveHost([email protected]:22/null) => 10.0.0.1: [email protected]:22 [org.apache.sshd.client.SshClient] (MWFM Worker 2) connect([email protected]:22) effective: 10.0.0.1: [email protected]:22 [org.apache.sshd.common.io.nio2.Nio2Connector] (MWFM Worker 2) Connecting to /10.0.0.1:22 [org.apache.sshd.common.io.nio2.Nio2Connector] (MWFM Worker 2) setOption(SO_REUSEADDR)[true] from property=Property[socket-reuseaddr](Boolean] [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) connect(/10.0.0.1:22): waiting for connection (timeout=60000ms) [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) Creating IoSession on /10.100.0.1:52522 from /10.0.0.1:22 via null [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) Client session created: Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) ClientUserAuthService(ClientSessionImpl[null@/10.0.0.1:22]) client methods: [publickey, keyboard-interactive, password] [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) sessionCreated(ClientSessionImpl[null@/10.0.0.1:22]) tracking [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) initializeProxyConnector(ClientSessionImpl[null@/10.0.0.1:22]) no proxy to initialize [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) sendIdentification(ClientSessionImpl[null@/10.0.0.1:22]): SSH-2.0-APACHE-SSHD-2.15.0 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22]) writing 28 bytes [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) sendKexInit(ClientSessionImpl[null@/10.0.0.1:22]) Send SSH_MSG_KEXINIT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) encode(ClientSessionImpl[null@/10.0.0.1:22]) packet #0 sending command=20[SSH_MSG_KEXINIT] len=1393 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22]) writing 1408 bytes [org.apache.sshd.client.SshClient] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider override in session listener [org.apache.sshd.client.SshClient] (sshd-SshClient[3ca6a47]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider enhanced [org.apache.sshd.client.future.DefaultConnectFuture] (MWFM Worker 2) Connected to /10.0.0.1:22 after 12137620 nanos [org.apache.sshd.client.session.ClientSessionImpl] (MWFM Worker 2) addPasswordIdentity(ClientSessionImpl[user@/10.0.0.1:22]) SHA256:NhNdqVhmUqoL3v7mKAAcTE62kB4nikQjOiPNKBHq3Bk [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-thread-3) handleReadCycleFailure(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22]) IOException after 12088785 nanos at read cycle=1: Connection reset [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-thread-3) exceptionCaught(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22]) caught IOException[Connection reset] - calling handler [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-thread-3) signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=IOException, signalled=true, first=false: Connection reset [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-thread-3) exceptionCaught(ClientSessionImpl[user@/10.0.0.1:22])[state=Opened] IOException: Connection reset: java.io.IOException: Connection reset [org.apache.sshd.client.session.ClientSessionImpl] (MWFM Worker 2) close(ClientSessionImpl[user@/10.0.0.1:22]) Closing immediately [org.apache.sshd.client.session.ClientSessionImpl] (MWFM Worker 2) signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=SshException, signalled=false, first=false: Session is being closed [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (MWFM Worker 2) sessionClosed(ClientSessionImpl[user@/10.0.0.1:22]) un-tracked [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[3ca6a47]-nio2-thread-3) sessionException(ClientSessionImpl[user@/10.0.0.1:22]) IOException: Connection reset [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-thread-3) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] state already Immediate [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-thread-3) close(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22]) Closing immediately [org.apache.sshd.client.session.ClientUserAuthService] (MWFM Worker 2) close(org.apache.sshd.client.session.ClientUserAuthService@26e71b15) Closing immediately [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-thread-3) doCloseImmediately(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22]) closing socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[connected local=/10.100.0.1:52522 remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientUserAuthService] (MWFM Worker 2) close(org.apache.sshd.client.session.ClientUserAuthService@26e71b15)[Immediately] closed [org.apache.sshd.client.session.ClientConnectionService] (MWFM Worker 2) close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]]) Closing immediately [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-thread-3) doCloseImmediately(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22]) socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[closed] closed [org.apache.sshd.client.session.ClientConnectionService] (MWFM Worker 2) stopHeartBeat(ClientSessionImpl[user@/10.0.0.1:22]) no heartbeat to stop [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[3ca6a47]-nio2-thread-3) unmapSession(id=102): Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[3ca6a47]-nio2-thread-3) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] state already Immediate [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[3ca6a47]-nio2-thread-3) close(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22])[Immediately] closed [org.apache.sshd.client.session.ClientConnectionService] (MWFM Worker 2) close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]])[Immediately] closed [org.apache.sshd.common.io.nio2.Nio2Session] (MWFM Worker 2) close(Nio2Session[local=/10.100.0.1:52522, remote=/10.0.0.1:22])[Immediately] state already Closed [org.apache.sshd.common.util.closeable.SequentialCloseable] (MWFM Worker 2) doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@2a7193c2) signal close complete immediately=true [org.apache.sshd.client.session.ClientSessionImpl] (MWFM Worker 2) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] closed [org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver] (MWFM Worker 1) resolveEffectiveHost([email protected]:22/null) => 10.0.0.1: [email protected]:22 [org.apache.sshd.client.SshClient] (MWFM Worker 1) connect([email protected]:22) effective: 10.0.0.1: [email protected]:22 [org.apache.sshd.common.io.nio2.Nio2Connector] (MWFM Worker 1) Connecting to /10.0.0.1:22 [org.apache.sshd.common.io.nio2.Nio2Connector] (MWFM Worker 1) setOption(SO_REUSEADDR)[true] from property=Property[socket-reuseaddr](Boolean] [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) connect(/10.0.0.1:22): waiting for connection (timeout=60000ms) [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) Creating IoSession on /10.100.0.1:45052 from /10.0.0.1:22 via null [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) Client session created: Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) ClientUserAuthService(ClientSessionImpl[null@/10.0.0.1:22]) client methods: [publickey, keyboard-interactive, password] [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) sessionCreated(ClientSessionImpl[null@/10.0.0.1:22]) tracking [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) initializeProxyConnector(ClientSessionImpl[null@/10.0.0.1:22]) no proxy to initialize [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) sendIdentification(ClientSessionImpl[null@/10.0.0.1:22]): SSH-2.0-APACHE-SSHD-2.15.0 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22]) writing 28 bytes [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) sendKexInit(ClientSessionImpl[null@/10.0.0.1:22]) Send SSH_MSG_KEXINIT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) encode(ClientSessionImpl[null@/10.0.0.1:22]) packet #0 sending command=20[SSH_MSG_KEXINIT] len=1393 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22]) writing 1408 bytes [org.apache.sshd.client.SshClient] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider override in session listener [org.apache.sshd.client.SshClient] (sshd-SshClient[5833ddff]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider enhanced [org.apache.sshd.client.future.DefaultConnectFuture] (MWFM Worker 1) Connected to /10.0.0.1:22 after 12742499 nanos [org.apache.sshd.client.session.ClientSessionImpl] (MWFM Worker 1) addPasswordIdentity(ClientSessionImpl[user@/10.0.0.1:22]) SHA256:NhNdqVhmUqoL3v7mKAAcTE62kB4nikQjOiPNKBHq3Bk [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-thread-3) handleReadCycleFailure(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22]) IOException after 14069579 nanos at read cycle=1: Connection reset [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-thread-3) exceptionCaught(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22]) caught IOException[Connection reset] - calling handler [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-thread-3) signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=IOException, signalled=true, first=false: Connection reset [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-thread-3) exceptionCaught(ClientSessionImpl[user@/10.0.0.1:22])[state=Opened] IOException: Connection reset: java.io.IOException: Connection reset [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[5833ddff]-nio2-thread-3) sessionException(ClientSessionImpl[user@/10.0.0.1:22]) IOException: Connection reset [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[5833ddff]-nio2-thread-3) sessionClosed(ClientSessionImpl[user@/10.0.0.1:22]) un-tracked [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-thread-3) close(ClientSessionImpl[user@/10.0.0.1:22]) Closing immediately [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-thread-3) signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=SshException, signalled=false, first=false: Session is being closed [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[5833ddff]-nio2-thread-3) close(org.apache.sshd.client.session.ClientUserAuthService@3aa65cf2) Closing immediately [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[5833ddff]-nio2-thread-3) close(org.apache.sshd.client.session.ClientUserAuthService@3aa65cf2)[Immediately] closed [org.apache.sshd.client.session.ClientConnectionService] (sshd-SshClient[5833ddff]-nio2-thread-3) close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]]) Closing immediately [org.apache.sshd.client.session.ClientConnectionService] (sshd-SshClient[5833ddff]-nio2-thread-3) stopHeartBeat(ClientSessionImpl[user@/10.0.0.1:22]) no heartbeat to stop [org.apache.sshd.client.session.ClientConnectionService] (sshd-SshClient[5833ddff]-nio2-thread-3) close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]])[Immediately] closed [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-thread-3) close(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22]) Closing immediately [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-thread-3) doCloseImmediately(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22]) closing socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[connected local=/10.100.0.1:45052 remote=/10.0.0.1:22] [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-thread-3) doCloseImmediately(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22]) socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[closed] closed [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[5833ddff]-nio2-thread-3) unmapSession(id=103): Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-thread-3) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] state already Immediate [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-thread-3) close(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22])[Immediately] closed [org.apache.sshd.common.util.closeable.SequentialCloseable] (sshd-SshClient[5833ddff]-nio2-thread-3) doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@3461a5d6) signal close complete immediately=true [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[5833ddff]-nio2-thread-3) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] closed [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[5833ddff]-nio2-thread-3) close(Nio2Session[local=/10.100.0.1:45052, remote=/10.0.0.1:22])[Immediately] state already Closed [org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver] resolveEffectiveHost([email protected]:22/null) => 10.0.0.1: [email protected]:22 [org.apache.sshd.client.SshClient] connect([email protected]:22) effective: 10.0.0.1: [email protected]:22 [org.apache.sshd.common.io.nio2.Nio2Connector] Connecting to /10.0.0.1:22 [org.apache.sshd.common.io.nio2.Nio2Connector] setOption(SO_REUSEADDR)[true] from property=Property[socket-reuseaddr](Boolean] [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) connect(/10.0.0.1:22): waiting for connection (timeout=60000ms) [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) Creating IoSession on /10.100.0.1:45064 from /10.0.0.1:22 via null [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) Client session created: Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) ClientUserAuthService(ClientSessionImpl[null@/10.0.0.1:22]) client methods: [publickey, keyboard-interactive, password] [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) sessionCreated(ClientSessionImpl[null@/10.0.0.1:22]) tracking [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) initializeProxyConnector(ClientSessionImpl[null@/10.0.0.1:22]) no proxy to initialize [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) sendIdentification(ClientSessionImpl[null@/10.0.0.1:22]): SSH-2.0-APACHE-SSHD-2.15.0 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22]) writing 28 bytes [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) sendKexInit(ClientSessionImpl[null@/10.0.0.1:22]) Send SSH_MSG_KEXINIT [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) encode(ClientSessionImpl[null@/10.0.0.1:22]) packet #0 sending command=20[SSH_MSG_KEXINIT] len=1393 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) writeBuffer(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22]) writing 1408 bytes [org.apache.sshd.client.SshClient] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider override in session listener [org.apache.sshd.client.SshClient] (sshd-SshClient[36cadf8]-nio2-resume-thread-1) setupDefaultSessionIdentities(ClientSessionImpl[user@/10.0.0.1:22]) key identity provider enhanced [org.apache.sshd.client.future.DefaultConnectFuture] Connected to /10.0.0.1:22 after 12534511 nanos [org.apache.sshd.client.session.ClientSessionImpl] addPasswordIdentity(ClientSessionImpl[user@/10.0.0.1:22]) SHA256:NhNdqVhmUqoL3v7mKAAcTE62kB4nikQjOiPNKBHq3Bk [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-thread-3) handleReadCycleFailure(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22]) IOException after 14448337 nanos at read cycle=1: Connection reset [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-thread-3) exceptionCaught(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22]) caught IOException[Connection reset] - calling handler [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-thread-3) signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=IOException, signalled=true, first=false: Connection reset [org.apache.sshd.client.session.ClientSessionImpl] close(ClientSessionImpl[user@/10.0.0.1:22]) Closing immediately [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-thread-3) exceptionCaught(ClientSessionImpl[user@/10.0.0.1:22])[state=Opened] IOException: Connection reset: java.io.IOException: Connection reset [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[36cadf8]-nio2-thread-3) sessionException(ClientSessionImpl[user@/10.0.0.1:22]) IOException: Connection reset [org.apache.sshd.common.session.helpers.SessionTimeoutListener] (sshd-SshClient[36cadf8]-nio2-thread-3) sessionClosed(ClientSessionImpl[user@/10.0.0.1:22]) un-tracked [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-thread-3) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] state already Immediate [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-thread-3) close(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22]) Closing immediately [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-thread-3) doCloseImmediately(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22]) closing socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[connected local=/10.100.0.1:45064 remote=/10.0.0.1:22] [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-thread-3) doCloseImmediately(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22]) socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[closed] closed [org.apache.sshd.common.io.nio2.Nio2Connector] (sshd-SshClient[36cadf8]-nio2-thread-3) unmapSession(id=104): Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22] [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-thread-3) close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] state already Immediate [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[36cadf8]-nio2-thread-3) close(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22])[Immediately] closed [org.apache.sshd.client.session.ClientSessionImpl] signalAuthFailure(ClientSessionImpl[user@/10.0.0.1:22]) type=SshException, signalled=false, first=false: Session is being closed [org.apache.sshd.client.session.ClientUserAuthService] close(org.apache.sshd.client.session.ClientUserAuthService@2ac3071) Closing immediately [org.apache.sshd.client.session.ClientUserAuthService] close(org.apache.sshd.client.session.ClientUserAuthService@2ac3071)[Immediately] closed [org.apache.sshd.client.session.ClientConnectionService] close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]]) Closing immediately [org.apache.sshd.client.session.ClientConnectionService] stopHeartBeat(ClientSessionImpl[user@/10.0.0.1:22]) no heartbeat to stop [org.apache.sshd.client.session.ClientConnectionService] close(ClientConnectionService[ClientSessionImpl[user@/10.0.0.1:22]])[Immediately] closed [org.apache.sshd.common.io.nio2.Nio2Session] close(Nio2Session[local=/10.100.0.1:45064, remote=/10.0.0.1:22])[Immediately] state already Closed [org.apache.sshd.common.util.closeable.SequentialCloseable] doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@64495eb1) signal close complete immediately=true [org.apache.sshd.client.session.ClientSessionImpl] close(ClientSessionImpl[user@/10.0.0.1:22])[Immediately] closed [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[36cadf8]-nio2-thread-3) exceptionCaught(ClientSessionImpl[user@/10.0.0.1:22])[state=Opened] IOException: Connection reset: java.io.IOException: Connection reset at java.base/sun.nio.ch.UnixAsynchronousSocketChannelImpl.finishRead(UnixAsynchronousSocketChannelImpl.java:425) at java.base/sun.nio.ch.UnixAsynchronousSocketChannelImpl.finish(UnixAsynchronousSocketChannelImpl.java:195) at java.base/sun.nio.ch.UnixAsynchronousSocketChannelImpl.onEvent(UnixAsynchronousSocketChannelImpl.java:217) at java.base/sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:306) at java.base/java.lang.Thread.run(Thread.java:840) ``` The verbose output of the SSH command returns: ``` ... debug1: Next authentication method: password [email protected]'s password: Info: Password will expire in: 90 days.debug1: Authentication succeeded (password). Authenticated to 10.0.0.1 ([10.0.0.1]:22). debug1: channel 0: new [client-session] debug1: Entering interactive session. debug1: pledge: network debug1: Sending environment. debug1: Sending env LANG = en_US.UTF-8 ``` ### Expected behavior Using `RHEL 9.6` this works as expected. The `SSH_MSG_USERAUTH_BANNER` is properly handled and the authentication phase is completed. ``` ... [org.apache.sshd.client.auth.pubkey.UserAuthPublicKey] (sshd-SshClient[1cdfac07]-nio2-thread-8) userresolveAttemptedPublicKeyIdentity(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] no more keys to send [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[1cdfac07]-nio2-thread-8) usertryNext(ClientSessionImpl[user@/10.0.0.1:22]) no initial request sent by method=publickey [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[1cdfac07]-nio2-thread-8) usertryNext(ClientSessionImpl[user@/10.0.0.1:22]) attempting method=password [org.apache.sshd.client.auth.password.UserAuthPassword] (sshd-SshClient[1cdfac07]-nio2-thread-8) usersendPassword(ClientSessionImpl[user@/10.0.0.1:22])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST for password - modified=false [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[1cdfac07]-nio2-thread-8) userencode(ClientSessionImpl[user@/10.0.0.1:22]) packet #8 sending command=50[SSH_MSG_USERAUTH_REQUEST] len=63 [org.apache.sshd.common.io.nio2.Nio2Session] (sshd-SshClient[1cdfac07]-nio2-thread-8) userwriteBuffer(Nio2Session[local=/10.100.0.1:60698, remote=/10.78.55.130:22]) writing 128 bytes [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[1cdfac07]-nio2-thread-8) usertryNext(ClientSessionImpl[user@/10.0.0.1:22]) successfully processed initial buffer by method=password [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[1cdfac07]-nio2-thread-9) userdoHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #8 SSH_MSG_USERAUTH_BANNER [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[1cdfac07]-nio2-thread-9) userprocess(ClientSessionImpl[user@/10.0.0.1:22]) Welcome banner(lang=): Info: Password will expire in: 90 days. [org.apache.sshd.client.session.ClientSessionImpl] (sshd-SshClient[1cdfac07]-nio2-thread-9) userdoHandleMessage(ClientSessionImpl[user@/10.0.0.1:22]) process #9 SSH_MSG_USERAUTH_SUCCESS [org.apache.sshd.client.session.ClientUserAuthService] (sshd-SshClient[1cdfac07]-nio2-thread-9) userprocessUserAuth(ClientSessionImpl[user@/10.0.0.1:22]) SSH_MSG_USERAUTH_SUCCESS Succeeded with password ... ``` The verbose output of the SSH command returns: ``` ... debug1: Next authentication method: password [email protected]'s password: Info: Password will expire in: 90 days.Authenticated to 10.0.0.1 ([10.0.0.1]:22) using "password". debug1: pkcs11_del_provider: called, provider_id = (null) debug1: channel 0: new [client-session] debug1: Entering interactive session. debug1: pledge: filesystem full ``` ### Relevant log output ```Shell ``` ### Other information _No response_ -- This is an automated message from the Apache Git Service. To respond to the message, please log on to GitHub and use the URL above to go to the specific comment. To unsubscribe, e-mail: [email protected] For queries about this service, please contact Infrastructure at: [email protected] --------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
