You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@karaf.apache.org by Paul Spencer <pa...@mindspring.com> on 2022/11/14 15:53:03 UTC
Karaf 4.4.2 bin/client -> Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
Karaf version 4.4.2
Java Virtual Machine Java HotSpot(TM) 64-Bit Server VM version 25.172-b11
Version 1.8.0_172
Vendor Oracle Corporation
bin/karaf works, but bin/client fails with the following error:
DefaultOpenFuture[ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]: Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
I have verified the ssh port is not in use prior to starting karaf using bin/start
sparrow:apache-karaf-4.4.2 paul$ netstat -an | grep 8101
sparrow:apache-karaf-4.4.2 paul$
What am I missing?
***
* Below is bin/client with debug logging enabled.
***
sparrow:apache-karaf-4.4.2 paul$ bin/client -v -l 3
165 [main] DEBUG org.apache.sshd.common.util.security.SecurityUtils - register([BC, true, false]) not registered - enabled=null, supported={}
165 [main] DEBUG org.apache.sshd.common.util.security.SecurityUtils - register([EdDSA, true, false]) not registered - enabled=null, supported={}
Logging in as karaf
260 [main] INFO org.apache.sshd.common.io.DefaultIoServiceFactoryFactory - No detected/configured IoServiceFactoryFactory using Nio2ServiceFactoryFactory
266 [main] DEBUG org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - reloadHostConfigEntries([karaf, localhost, 8101, null, /Users/paul/.ssh/config]@null:{}/{}) check permissions of {}
272 [main] INFO org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - resolveEffectiveResolver(karaf@localhost:8101) loaded 7 entries from /Users/paul/.ssh/config
273 [main] DEBUG org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - resolveEffectiveHost([karaf, localhost, 8101, null, null]@null:{}/{}) => {}
273 [main] DEBUG org.apache.sshd.client.SshClient - connect([karaf, localhost, 8101]@null:{}) no overrides
277 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - Connecting to localhost/127.0.0.1:8101
282 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - setOption([SO_REUSEADDR, true, Property[socket-reuseaddr](Boolean]])[null] from property={}
286 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - Creating IoSession on [/127.0.0.1:64796, localhost/127.0.0.1:8101, null] from null via {}
298 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - Client session created: Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]
299 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientUserAuthService - ClientUserAuthService(ClientSessionImpl[null@localhost/127.0.0.1:8101]) client methods: [publickey, keyboard-interactive, password]
303 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.session.helpers.SessionTimeoutListener - sessionCreated(ClientSessionImpl[null@localhost/127.0.0.1:8101]) tracking
304 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - initializeProxyConnector(ClientSessionImpl[null@localhost/127.0.0.1:8101]) no proxy to initialize
305 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendIdentification(ClientSessionImpl[null@localhost/127.0.0.1:8101]): SSH-2.0-APACHE-SSHD-2.9.1
305 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 27 bytes
307 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendKexInit(ClientSessionImpl[null@localhost/127.0.0.1:8101]) Send SSH_MSG_KEXINIT
313 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[null@localhost/127.0.0.1:8101], 0, 20, SSH_MSG_KEXINIT, 1171]) packet #null sending command={}[{}] len={}
313 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 1184 bytes
314 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.SshClient - setupDefaultSessionIdentities(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) key identity provider override in session listener
315 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - doReadIdentification(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) line='SSH-2.0-APACHE-SSHD-2.9.1'
316 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - readIdentification(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Server version string: SSH-2.0-APACHE-SSHD-2.9.1
316 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleKexInit(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_KEXINIT
321 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - addPasswordIdentity(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SHA256:MFiExFNQu83IUEdulJM4nQvyxg1KalAz2uFviHDn6o0
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], kex algorithms, ecdh-sha2-nistp521]) Kex: null = {}
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], server host key algorithms, rsa-sha2-512]) Kex: null = {}
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], encryption algorithms (client to server), aes128-ctr]) Kex: null = {}
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], encryption algorithms (server to client), aes128-ctr]) Kex: null = {}
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], mac algorithms (client to server), hmac-sha2-256]) Kex: null = {}
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], mac algorithms (server to client), hmac-sha2-256]) Kex: null = {}
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], compression algorithms (client to server), none]) Kex: null = {}
323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], compression algorithms (server to client), none]) Kex: null = {}
368 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.kex.DHGClient - init(DHGClient[ecdh-sha2-nistp521])[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]] Send SSH_MSG_KEXDH_INIT
368 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 1, 30, 30, 138]) packet #null sending command={}[{}] len={}
369 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 152 bytes
378 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.kex.DHGClient - next([DHGClient[ecdh-sha2-nistp521], ClientSessionImpl[karaf@localhost/127.0.0.1:8101], SSH_MSG_KEXDH_REPLY])[null] process command={}
388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setServerKey([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-rsa, SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw]) keyType=null, digest={}
388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleKexMessage([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ecdh-sha2-nistp521, 31])[null] KEX processing complete after cmd={}
388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] WARN org.apache.sshd.client.keyverifier.AcceptAllServerKeyVerifier - Server at localhost/127.0.0.1:8101 presented unverified RSA key: SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw
389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - checkKeys([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-rsa, SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw, true]) key=null-{}, verified={}
389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_NEWKEYS
389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - prepareNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) session ID=50:78:c0:35:ea:d9:67:92:d4:05:b7:7c:ef:00:36:57:24:f2:52:27:95:42:64:2c:a4:7a:98:2f:e1:e6:92:19:94:24:7b:77:4d:26:7f:a9:b3:99:6d:fd:51:83:fa:4c:5f:9f:43:19:94:a2:3b:4a:4b:2b:3b:52:26:d9:7a:38
411 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 2, 21, SSH_MSG_NEWKEYS, 1]) packet #null sending command={}[{}] len={}
411 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 16 bytes
425 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setOutputEncoding([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], BaseCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16], BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false, none[Deflater/-1], 134217728]): cipher null; mac {}; compression {}; blocks limit {}
426 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) No pending packets to flush at end of KEX
426 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_NEWKEYS command=SSH_MSG_NEWKEYS
427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setInputEncoding([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], BaseCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16], BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false, none[Inflater/-1], 4294967296]): cipher null; mac {}; compression {}; blocks limit {}
427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendInitialServiceRequest(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_SERVICE_REQUEST for ssh-userauth
427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 3, 5, SSH_MSG_SERVICE_REQUEST, 17]) packet #null sending command={}[{}] len={}
427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - auth(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST for 'none'
428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 4, 50, SSH_MSG_USERAUTH_REQUEST, 36]) packet #null sending command={}[{}] len={}
428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 96 bytes
429 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): [ssh-rsa, rsa-sha2-256, rsa-sha2-512, sk-ecdsa-sha2-nistp256@openssh.com, ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521]
430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): PubkeyAcceptedAlgorithms before: [ecdsa-sha2-nistp256-cert-v01@openssh.com, ecdsa-sha2-nistp384-cert-v01@openssh.com, ecdsa-sha2-nistp521-cert-v01@openssh.com, rsa-sha2-512-cert-v01@openssh.com, rsa-sha2-256-cert-v01@openssh.com, ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, sk-ecdsa-sha2-nistp256@openssh.com, rsa-sha2-512, rsa-sha2-256, ssh-rsa]
430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): PubkeyAcceptedAlgorithms after: [ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, sk-ecdsa-sha2-nistp256@openssh.com, rsa-sha2-512, rsa-sha2-256, ssh-rsa, ecdsa-sha2-nistp256-cert-v01@openssh.com, ecdsa-sha2-nistp384-cert-v01@openssh.com, ecdsa-sha2-nistp521-cert-v01@openssh.com, rsa-sha2-512-cert-v01@openssh.com, rsa-sha2-256-cert-v01@openssh.com]
430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleServiceAccept(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_SERVICE_ACCEPT service=ssh-userauth
430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], false, keyboard-interactive,password,publickey]) Received SSH_MSG_USERAUTH_FAILURE - partial=null, methods={}
430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], [publickey, keyboard-interactive, password], [keyboard-interactive, password, publickey]]) starting authentication mechanisms: client=null, server={}
430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) attempting method=publickey
444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, publickey, rsa-sha2-512, SHA256:fcF5snOtV4tmHqf3leQCyiKl5lpMeQp6wRZKA1T0ckg])[null] send SSH_MSG_USERAUTH_REQUEST request {} type={} - fingerprint={}
444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 5, 50, SSH_MSG_USERAUTH_REQUEST, 339]) packet #null sending command={}[{}] len={}
444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 400 bytes
445 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) successfully processed initial buffer by method=publickey
447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], false, keyboard-interactive,password,publickey]) Received SSH_MSG_USERAUTH_FAILURE - partial=null, methods={}
447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, rsa-sha2-512])[null] server rejected publickey authentication with known signature algorithm {}
447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_dsa) no key loaded
447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_ecdsa) no key loaded
447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_ed25519) no key loaded
448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - resolveAttemptedPublicKeyIdentity(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection] no more keys to send
448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) no initial request sent by method=publickey
448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - destroy(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection]
448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) attempting method=keyboard-interactive
449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - verifyTrialsCount([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, SSH_MSG_USERAUTH_REQUEST, 0, 3])[null] cmd={} - {} out of {}
449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, keyboard-interactive, , ])[null] send SSH_MSG_USERAUTH_REQUEST for {}: lang={}, methods={}
449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 6, 50, SSH_MSG_USERAUTH_REQUEST, 60]) packet #null sending command={}[{}] len={}
449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 128 bytes
449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) successfully processed initial buffer by method=keyboard-interactive
450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 60, keyboard-interactive]) delegate processing of null to {}
450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - processAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, Password authentication, , en-US, 1])[null] SSH_MSG_USERAUTH_INFO_REQUEST name={}, instruction={}, language={}, num-prompts={}
450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - verifyTrialsCount([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, SSH_MSG_USERAUTH_INFO_REQUEST, 1, 3])[null] cmd={} - {} out of {}
450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - getUserResponses(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) use password candidate for interaction=Password authentication
450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 7, 61, SSH_MSG_USERAUTH_INFO_RESPONSE, 14]) packet #null sending command={}[{}] len={}
451 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
452 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_USERAUTH_SUCCESS Succeeded with keyboard-interactive
452 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - destroy(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection]
453 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) no heartbeat to stop
453 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientConnectionService - startHeartbeat([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], PT1M, keepalive@sshd.apache.org]) - started at interval=null with request={}
578 [main] DEBUG org.apache.sshd.client.channel.ChannelShell - init() service=[ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]], ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0] session=null id={}
578 [main] DEBUG org.apache.sshd.common.channel.Window - init([Window[client/local](ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]), 2097152, 2097152, 32768]) size=null, max={}, packet={}
578 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - registerChannel([ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]], 0, true, ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]])[id=null, registered={}] {}
579 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - createShellChannel([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0, null]) created id=null - PTY={}
580 [main] DEBUG org.apache.sshd.client.channel.ChannelShell - open(ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_CHANNEL_OPEN - type=session
580 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 8, 90, SSH_MSG_CHANNEL_OPEN, 24]) packet #null sending command={}[{}] len={}
581 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientConnectionService - channelOpenConfirmation([ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0, 2097152, 32768]) SSH_MSG_CHANNEL_OPEN_CONFIRMATION sender=null, window-size={}, packet-size={}
582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - setRecipient(ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) recipient=0
582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.channel.Window - init([Window[client/remote](ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]), 2097152, 2097152, 32768]) size=null, max={}, packet={}
583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - doOpenPty(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send agent forwarding request
583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 9, 98, SSH_MSG_CHANNEL_REQUEST, 36]) packet #null sending command={}[{}] len={}
583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 96 bytes
584 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - doOpenPty(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_CHANNEL_REQUEST pty-req: PtyChannelConfiguration[type=xterm-256color, lines=47, columns=259, height=480, width=640, modes={IGNCR=0, ECHOE=1, VSTATUS=20, ECHOK=0, IXON=1, OPOST=1, ONOCR=0, VERASE=127, IXANY=1, VINTR=3, VSTART=17, INLCR=0, VEOL=-1, PARMRK=0, OCRNL=0, ICRNL=1, INPCK=0, VREPRINT=18, IGNPAR=0, ONLCR=1, ISTRIP=0, ISIG=1, ONLRET=0, VKILL=21, VEOL2=-1, VSUSP=26, VLNEXT=22, VDISCARD=15, ECHONL=0, ICANON=1, TOSTOP=0, IEXTEN=1, VSTOP=19, VEOF=4, VWERASE=23, NOFLSH=0, VDSUSP=25, IXOFF=0, ECHO=1, VQUIT=28}]
586 [main] DEBUG org.apache.sshd.client.SshClient - close(SshClient[10bdf5e5]) Closing immediately
587 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - close(org.apache.sshd.common.io.nio2.Nio2Connector@5af97850) Closing immediately
589 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.channel.AbstractChannel$GracefulChannelCloseable - close(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[immediately=true] processing
589 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientConnectionService - unregisterChannel(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) result=ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]
589 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) Closing immediately
590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - doCloseImmediately(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) closing socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[connected local=/127.0.0.1:64796 remote=localhost/127.0.0.1:8101]
590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@69716b88) signal close complete immediately=true
590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - doCloseImmediately(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[closed] closed
590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@57f7fe58) signal close complete immediately=true
590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - unmapSession(id=101): Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]
590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@65ec6247) signal close complete immediately=true
590 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - close(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Closing immediately
590 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - signalAuthFailure([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], SshException, false, false, Session is being closed]) type=null, signalled={}, first={}: {}
591 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - handleReadCycleCompletion(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) IoSession has been closed, stop reading
593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - close(ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]) Closing immediately
593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) stopping
593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) stopped
593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - close(ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]])[Immediately] closed
593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101])[Immediately] state already Closed
593 [main] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@14ec4505) signal close complete immediately=true
593 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - close(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[Immediately] closed
593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101])[Immediately] closed
593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - close(org.apache.sshd.common.io.nio2.Nio2Connector@5af97850)[Immediately] closed
593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - close(org.apache.sshd.common.io.nio2.Nio2ServiceFactory@53ca01a2) Closing immediately
594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown group
594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Group successfully shut down
594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown executor
595 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown complete
595 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - close(org.apache.sshd.common.io.nio2.Nio2ServiceFactory@53ca01a2)[Immediately] closed
595 [main] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@358c99f5) signal close complete immediately=true
595 [main] DEBUG org.apache.sshd.client.SshClient - close(SshClient[10bdf5e5])[Immediately] closed
org.apache.sshd.common.SshException: DefaultOpenFuture[ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]: Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
at org.apache.sshd.common.future.AbstractSshFuture.lambda$verifyResult$1(AbstractSshFuture.java:132)
at org.apache.sshd.common.future.AbstractSshFuture.formatExceptionMessage(AbstractSshFuture.java:190)
at org.apache.sshd.common.future.AbstractSshFuture.verifyResult(AbstractSshFuture.java:131)
at org.apache.sshd.client.future.DefaultOpenFuture.verify(DefaultOpenFuture.java:39)
at org.apache.sshd.client.future.DefaultOpenFuture.verify(DefaultOpenFuture.java:32)
at org.apache.sshd.common.future.VerifiableFuture.verify(VerifiableFuture.java:43)
at org.apache.karaf.client.Main.main(Main.java:281)
Caused by: java.lang.IllegalArgumentException: Invalid UINT32 value: -1
at org.apache.sshd.common.util.ValidateUtils.createFormattedException(ValidateUtils.java:213)
at org.apache.sshd.common.util.ValidateUtils.throwIllegalArgumentException(ValidateUtils.java:179)
at org.apache.sshd.common.util.ValidateUtils.checkTrue(ValidateUtils.java:162)
at org.apache.sshd.common.util.buffer.BufferUtils.validateUint32Value(BufferUtils.java:703)
at org.apache.sshd.common.util.buffer.Buffer.putUInt(Buffer.java:726)
at org.apache.sshd.client.channel.PtyCapableChannelSession.lambda$doOpenPty$0(PtyCapableChannelSession.java:265)
at java.util.HashMap.forEach(HashMap.java:1289)
at org.apache.sshd.client.channel.PtyCapableChannelSession.doOpenPty(PtyCapableChannelSession.java:263)
at org.apache.sshd.client.channel.ChannelShell.doOpen(ChannelShell.java:45)
at org.apache.sshd.client.channel.AbstractClientChannel.handleOpenSuccess(AbstractClientChannel.java:366)
at org.apache.sshd.common.session.helpers.AbstractConnectionService.channelOpenConfirmation(AbstractConnectionService.java:545)
at org.apache.sshd.common.session.helpers.AbstractConnectionService.process(AbstractConnectionService.java:456)
at org.apache.sshd.common.session.helpers.CurrentService.process(CurrentService.java:109)
at org.apache.sshd.common.session.helpers.AbstractSession.doHandleMessage(AbstractSession.java:594)
at org.apache.sshd.common.session.helpers.AbstractSession.lambda$handleMessage$0(AbstractSession.java:525)
at org.apache.sshd.common.util.threads.ThreadUtils.runAsInternal(ThreadUtils.java:66)
at org.apache.sshd.common.session.helpers.AbstractSession.handleMessage(AbstractSession.java:524)
at org.apache.sshd.common.session.helpers.AbstractSession.decode(AbstractSession.java:1644)
at org.apache.sshd.common.session.helpers.AbstractSession.messageReceived(AbstractSession.java:485)
at org.apache.sshd.common.session.helpers.AbstractSessionIoHandler.messageReceived(AbstractSessionIoHandler.java:64)
at org.apache.sshd.common.io.nio2.Nio2Session.handleReadCycleCompletion(Nio2Session.java:371)
at org.apache.sshd.common.io.nio2.Nio2Session$1.onCompleted(Nio2Session.java:344)
at org.apache.sshd.common.io.nio2.Nio2Session$1.onCompleted(Nio2Session.java:339)
at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.lambda$completed$0(Nio2CompletionHandler.java:38)
at java.security.AccessController.doPrivileged(Native Method)
at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.completed(Nio2CompletionHandler.java:37)
at sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:126)
at sun.nio.ch.Invoker$2.run(Invoker.java:218)
at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
sparrow:apache-karaf-4.4.2 paul$
Paul Spencer
Re: Karaf 4.4.2 bin/client -> Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
Posted by Jean-Baptiste Onofré <jb...@nanthrax.net>.
Hi,
This is a known bug. It will be fixed in the next release.
Regards
JB
On Mon, Nov 14, 2022 at 4:53 PM Paul Spencer <pa...@mindspring.com> wrote:
>
> Karaf version 4.4.2
> Java Virtual Machine Java HotSpot(TM) 64-Bit Server VM version 25.172-b11
> Version 1.8.0_172
> Vendor Oracle Corporation
>
> bin/karaf works, but bin/client fails with the following error:
> DefaultOpenFuture[ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]: Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
>
> I have verified the ssh port is not in use prior to starting karaf using bin/start
> sparrow:apache-karaf-4.4.2 paul$ netstat -an | grep 8101
> sparrow:apache-karaf-4.4.2 paul$
>
> What am I missing?
>
> ***
> * Below is bin/client with debug logging enabled.
> ***
> sparrow:apache-karaf-4.4.2 paul$ bin/client -v -l 3
> 165 [main] DEBUG org.apache.sshd.common.util.security.SecurityUtils - register([BC, true, false]) not registered - enabled=null, supported={}
> 165 [main] DEBUG org.apache.sshd.common.util.security.SecurityUtils - register([EdDSA, true, false]) not registered - enabled=null, supported={}
> Logging in as karaf
> 260 [main] INFO org.apache.sshd.common.io.DefaultIoServiceFactoryFactory - No detected/configured IoServiceFactoryFactory using Nio2ServiceFactoryFactory
> 266 [main] DEBUG org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - reloadHostConfigEntries([karaf, localhost, 8101, null, /Users/paul/.ssh/config]@null:{}/{}) check permissions of {}
> 272 [main] INFO org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - resolveEffectiveResolver(karaf@localhost:8101) loaded 7 entries from /Users/paul/.ssh/config
> 273 [main] DEBUG org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - resolveEffectiveHost([karaf, localhost, 8101, null, null]@null:{}/{}) => {}
> 273 [main] DEBUG org.apache.sshd.client.SshClient - connect([karaf, localhost, 8101]@null:{}) no overrides
> 277 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - Connecting to localhost/127.0.0.1:8101
> 282 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - setOption([SO_REUSEADDR, true, Property[socket-reuseaddr](Boolean]])[null] from property={}
> 286 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - Creating IoSession on [/127.0.0.1:64796, localhost/127.0.0.1:8101, null] from null via {}
> 298 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - Client session created: Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]
> 299 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientUserAuthService - ClientUserAuthService(ClientSessionImpl[null@localhost/127.0.0.1:8101]) client methods: [publickey, keyboard-interactive, password]
> 303 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.session.helpers.SessionTimeoutListener - sessionCreated(ClientSessionImpl[null@localhost/127.0.0.1:8101]) tracking
> 304 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - initializeProxyConnector(ClientSessionImpl[null@localhost/127.0.0.1:8101]) no proxy to initialize
> 305 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendIdentification(ClientSessionImpl[null@localhost/127.0.0.1:8101]): SSH-2.0-APACHE-SSHD-2.9.1
> 305 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 27 bytes
> 307 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendKexInit(ClientSessionImpl[null@localhost/127.0.0.1:8101]) Send SSH_MSG_KEXINIT
> 313 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[null@localhost/127.0.0.1:8101], 0, 20, SSH_MSG_KEXINIT, 1171]) packet #null sending command={}[{}] len={}
> 313 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 1184 bytes
> 314 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.SshClient - setupDefaultSessionIdentities(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) key identity provider override in session listener
> 315 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - doReadIdentification(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) line='SSH-2.0-APACHE-SSHD-2.9.1'
> 316 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - readIdentification(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Server version string: SSH-2.0-APACHE-SSHD-2.9.1
> 316 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleKexInit(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_KEXINIT
> 321 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - addPasswordIdentity(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SHA256:MFiExFNQu83IUEdulJM4nQvyxg1KalAz2uFviHDn6o0
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], kex algorithms, ecdh-sha2-nistp521]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], server host key algorithms, rsa-sha2-512]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], encryption algorithms (client to server), aes128-ctr]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], encryption algorithms (server to client), aes128-ctr]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], mac algorithms (client to server), hmac-sha2-256]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], mac algorithms (server to client), hmac-sha2-256]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], compression algorithms (client to server), none]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], compression algorithms (server to client), none]) Kex: null = {}
> 368 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.kex.DHGClient - init(DHGClient[ecdh-sha2-nistp521])[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]] Send SSH_MSG_KEXDH_INIT
> 368 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 1, 30, 30, 138]) packet #null sending command={}[{}] len={}
> 369 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 152 bytes
> 378 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.kex.DHGClient - next([DHGClient[ecdh-sha2-nistp521], ClientSessionImpl[karaf@localhost/127.0.0.1:8101], SSH_MSG_KEXDH_REPLY])[null] process command={}
> 388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setServerKey([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-rsa, SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw]) keyType=null, digest={}
> 388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleKexMessage([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ecdh-sha2-nistp521, 31])[null] KEX processing complete after cmd={}
> 388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] WARN org.apache.sshd.client.keyverifier.AcceptAllServerKeyVerifier - Server at localhost/127.0.0.1:8101 presented unverified RSA key: SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw
> 389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - checkKeys([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-rsa, SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw, true]) key=null-{}, verified={}
> 389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_NEWKEYS
> 389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - prepareNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) session ID=50:78:c0:35:ea:d9:67:92:d4:05:b7:7c:ef:00:36:57:24:f2:52:27:95:42:64:2c:a4:7a:98:2f:e1:e6:92:19:94:24:7b:77:4d:26:7f:a9:b3:99:6d:fd:51:83:fa:4c:5f:9f:43:19:94:a2:3b:4a:4b:2b:3b:52:26:d9:7a:38
> 411 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 2, 21, SSH_MSG_NEWKEYS, 1]) packet #null sending command={}[{}] len={}
> 411 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 16 bytes
> 425 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setOutputEncoding([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], BaseCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16], BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false, none[Deflater/-1], 134217728]): cipher null; mac {}; compression {}; blocks limit {}
> 426 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) No pending packets to flush at end of KEX
> 426 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_NEWKEYS command=SSH_MSG_NEWKEYS
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setInputEncoding([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], BaseCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16], BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false, none[Inflater/-1], 4294967296]): cipher null; mac {}; compression {}; blocks limit {}
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendInitialServiceRequest(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_SERVICE_REQUEST for ssh-userauth
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 3, 5, SSH_MSG_SERVICE_REQUEST, 17]) packet #null sending command={}[{}] len={}
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
> 428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - auth(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST for 'none'
> 428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 4, 50, SSH_MSG_USERAUTH_REQUEST, 36]) packet #null sending command={}[{}] len={}
> 428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 96 bytes
> 429 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): [ssh-rsa, rsa-sha2-256, rsa-sha2-512, sk-ecdsa-sha2-nistp256@openssh.com, ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521]
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): PubkeyAcceptedAlgorithms before: [ecdsa-sha2-nistp256-cert-v01@openssh.com, ecdsa-sha2-nistp384-cert-v01@openssh.com, ecdsa-sha2-nistp521-cert-v01@openssh.com, rsa-sha2-512-cert-v01@openssh.com, rsa-sha2-256-cert-v01@openssh.com, ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, sk-ecdsa-sha2-nistp256@openssh.com, rsa-sha2-512, rsa-sha2-256, ssh-rsa]
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): PubkeyAcceptedAlgorithms after: [ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, sk-ecdsa-sha2-nistp256@openssh.com, rsa-sha2-512, rsa-sha2-256, ssh-rsa, ecdsa-sha2-nistp256-cert-v01@openssh.com, ecdsa-sha2-nistp384-cert-v01@openssh.com, ecdsa-sha2-nistp521-cert-v01@openssh.com, rsa-sha2-512-cert-v01@openssh.com, rsa-sha2-256-cert-v01@openssh.com]
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleServiceAccept(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_SERVICE_ACCEPT service=ssh-userauth
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], false, keyboard-interactive,password,publickey]) Received SSH_MSG_USERAUTH_FAILURE - partial=null, methods={}
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], [publickey, keyboard-interactive, password], [keyboard-interactive, password, publickey]]) starting authentication mechanisms: client=null, server={}
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) attempting method=publickey
> 444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, publickey, rsa-sha2-512, SHA256:fcF5snOtV4tmHqf3leQCyiKl5lpMeQp6wRZKA1T0ckg])[null] send SSH_MSG_USERAUTH_REQUEST request {} type={} - fingerprint={}
> 444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 5, 50, SSH_MSG_USERAUTH_REQUEST, 339]) packet #null sending command={}[{}] len={}
> 444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 400 bytes
> 445 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) successfully processed initial buffer by method=publickey
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], false, keyboard-interactive,password,publickey]) Received SSH_MSG_USERAUTH_FAILURE - partial=null, methods={}
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, rsa-sha2-512])[null] server rejected publickey authentication with known signature algorithm {}
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_dsa) no key loaded
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_ecdsa) no key loaded
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_ed25519) no key loaded
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - resolveAttemptedPublicKeyIdentity(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection] no more keys to send
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) no initial request sent by method=publickey
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - destroy(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection]
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) attempting method=keyboard-interactive
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - verifyTrialsCount([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, SSH_MSG_USERAUTH_REQUEST, 0, 3])[null] cmd={} - {} out of {}
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, keyboard-interactive, , ])[null] send SSH_MSG_USERAUTH_REQUEST for {}: lang={}, methods={}
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 6, 50, SSH_MSG_USERAUTH_REQUEST, 60]) packet #null sending command={}[{}] len={}
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 128 bytes
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) successfully processed initial buffer by method=keyboard-interactive
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 60, keyboard-interactive]) delegate processing of null to {}
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - processAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, Password authentication, , en-US, 1])[null] SSH_MSG_USERAUTH_INFO_REQUEST name={}, instruction={}, language={}, num-prompts={}
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - verifyTrialsCount([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, SSH_MSG_USERAUTH_INFO_REQUEST, 1, 3])[null] cmd={} - {} out of {}
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - getUserResponses(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) use password candidate for interaction=Password authentication
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 7, 61, SSH_MSG_USERAUTH_INFO_RESPONSE, 14]) packet #null sending command={}[{}] len={}
> 451 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
> 452 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_USERAUTH_SUCCESS Succeeded with keyboard-interactive
> 452 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - destroy(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection]
> 453 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) no heartbeat to stop
> 453 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientConnectionService - startHeartbeat([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], PT1M, keepalive@sshd.apache.org]) - started at interval=null with request={}
> 578 [main] DEBUG org.apache.sshd.client.channel.ChannelShell - init() service=[ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]], ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0] session=null id={}
> 578 [main] DEBUG org.apache.sshd.common.channel.Window - init([Window[client/local](ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]), 2097152, 2097152, 32768]) size=null, max={}, packet={}
> 578 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - registerChannel([ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]], 0, true, ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]])[id=null, registered={}] {}
> 579 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - createShellChannel([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0, null]) created id=null - PTY={}
> 580 [main] DEBUG org.apache.sshd.client.channel.ChannelShell - open(ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_CHANNEL_OPEN - type=session
> 580 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 8, 90, SSH_MSG_CHANNEL_OPEN, 24]) packet #null sending command={}[{}] len={}
> 581 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
> 582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientConnectionService - channelOpenConfirmation([ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0, 2097152, 32768]) SSH_MSG_CHANNEL_OPEN_CONFIRMATION sender=null, window-size={}, packet-size={}
> 582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - setRecipient(ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) recipient=0
> 582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.channel.Window - init([Window[client/remote](ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]), 2097152, 2097152, 32768]) size=null, max={}, packet={}
> 583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - doOpenPty(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send agent forwarding request
> 583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 9, 98, SSH_MSG_CHANNEL_REQUEST, 36]) packet #null sending command={}[{}] len={}
> 583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 96 bytes
> 584 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - doOpenPty(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_CHANNEL_REQUEST pty-req: PtyChannelConfiguration[type=xterm-256color, lines=47, columns=259, height=480, width=640, modes={IGNCR=0, ECHOE=1, VSTATUS=20, ECHOK=0, IXON=1, OPOST=1, ONOCR=0, VERASE=127, IXANY=1, VINTR=3, VSTART=17, INLCR=0, VEOL=-1, PARMRK=0, OCRNL=0, ICRNL=1, INPCK=0, VREPRINT=18, IGNPAR=0, ONLCR=1, ISTRIP=0, ISIG=1, ONLRET=0, VKILL=21, VEOL2=-1, VSUSP=26, VLNEXT=22, VDISCARD=15, ECHONL=0, ICANON=1, TOSTOP=0, IEXTEN=1, VSTOP=19, VEOF=4, VWERASE=23, NOFLSH=0, VDSUSP=25, IXOFF=0, ECHO=1, VQUIT=28}]
> 586 [main] DEBUG org.apache.sshd.client.SshClient - close(SshClient[10bdf5e5]) Closing immediately
> 587 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - close(org.apache.sshd.common.io.nio2.Nio2Connector@5af97850) Closing immediately
> 589 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.channel.AbstractChannel$GracefulChannelCloseable - close(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[immediately=true] processing
> 589 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientConnectionService - unregisterChannel(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) result=ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]
> 589 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) Closing immediately
> 590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - doCloseImmediately(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) closing socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[connected local=/127.0.0.1:64796 remote=localhost/127.0.0.1:8101]
> 590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@69716b88) signal close complete immediately=true
> 590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - doCloseImmediately(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[closed] closed
> 590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@57f7fe58) signal close complete immediately=true
> 590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - unmapSession(id=101): Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]
> 590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@65ec6247) signal close complete immediately=true
> 590 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - close(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Closing immediately
> 590 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - signalAuthFailure([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], SshException, false, false, Session is being closed]) type=null, signalled={}, first={}: {}
> 591 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - handleReadCycleCompletion(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) IoSession has been closed, stop reading
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - close(ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]) Closing immediately
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) stopping
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) stopped
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - close(ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]])[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101])[Immediately] state already Closed
> 593 [main] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@14ec4505) signal close complete immediately=true
> 593 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - close(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101])[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - close(org.apache.sshd.common.io.nio2.Nio2Connector@5af97850)[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - close(org.apache.sshd.common.io.nio2.Nio2ServiceFactory@53ca01a2) Closing immediately
> 594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown group
> 594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Group successfully shut down
> 594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown executor
> 595 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown complete
> 595 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - close(org.apache.sshd.common.io.nio2.Nio2ServiceFactory@53ca01a2)[Immediately] closed
> 595 [main] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@358c99f5) signal close complete immediately=true
> 595 [main] DEBUG org.apache.sshd.client.SshClient - close(SshClient[10bdf5e5])[Immediately] closed
> org.apache.sshd.common.SshException: DefaultOpenFuture[ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]: Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
> at org.apache.sshd.common.future.AbstractSshFuture.lambda$verifyResult$1(AbstractSshFuture.java:132)
> at org.apache.sshd.common.future.AbstractSshFuture.formatExceptionMessage(AbstractSshFuture.java:190)
> at org.apache.sshd.common.future.AbstractSshFuture.verifyResult(AbstractSshFuture.java:131)
> at org.apache.sshd.client.future.DefaultOpenFuture.verify(DefaultOpenFuture.java:39)
> at org.apache.sshd.client.future.DefaultOpenFuture.verify(DefaultOpenFuture.java:32)
> at org.apache.sshd.common.future.VerifiableFuture.verify(VerifiableFuture.java:43)
> at org.apache.karaf.client.Main.main(Main.java:281)
> Caused by: java.lang.IllegalArgumentException: Invalid UINT32 value: -1
> at org.apache.sshd.common.util.ValidateUtils.createFormattedException(ValidateUtils.java:213)
> at org.apache.sshd.common.util.ValidateUtils.throwIllegalArgumentException(ValidateUtils.java:179)
> at org.apache.sshd.common.util.ValidateUtils.checkTrue(ValidateUtils.java:162)
> at org.apache.sshd.common.util.buffer.BufferUtils.validateUint32Value(BufferUtils.java:703)
> at org.apache.sshd.common.util.buffer.Buffer.putUInt(Buffer.java:726)
> at org.apache.sshd.client.channel.PtyCapableChannelSession.lambda$doOpenPty$0(PtyCapableChannelSession.java:265)
> at java.util.HashMap.forEach(HashMap.java:1289)
> at org.apache.sshd.client.channel.PtyCapableChannelSession.doOpenPty(PtyCapableChannelSession.java:263)
> at org.apache.sshd.client.channel.ChannelShell.doOpen(ChannelShell.java:45)
> at org.apache.sshd.client.channel.AbstractClientChannel.handleOpenSuccess(AbstractClientChannel.java:366)
> at org.apache.sshd.common.session.helpers.AbstractConnectionService.channelOpenConfirmation(AbstractConnectionService.java:545)
> at org.apache.sshd.common.session.helpers.AbstractConnectionService.process(AbstractConnectionService.java:456)
> at org.apache.sshd.common.session.helpers.CurrentService.process(CurrentService.java:109)
> at org.apache.sshd.common.session.helpers.AbstractSession.doHandleMessage(AbstractSession.java:594)
> at org.apache.sshd.common.session.helpers.AbstractSession.lambda$handleMessage$0(AbstractSession.java:525)
> at org.apache.sshd.common.util.threads.ThreadUtils.runAsInternal(ThreadUtils.java:66)
> at org.apache.sshd.common.session.helpers.AbstractSession.handleMessage(AbstractSession.java:524)
> at org.apache.sshd.common.session.helpers.AbstractSession.decode(AbstractSession.java:1644)
> at org.apache.sshd.common.session.helpers.AbstractSession.messageReceived(AbstractSession.java:485)
> at org.apache.sshd.common.session.helpers.AbstractSessionIoHandler.messageReceived(AbstractSessionIoHandler.java:64)
> at org.apache.sshd.common.io.nio2.Nio2Session.handleReadCycleCompletion(Nio2Session.java:371)
> at org.apache.sshd.common.io.nio2.Nio2Session$1.onCompleted(Nio2Session.java:344)
> at org.apache.sshd.common.io.nio2.Nio2Session$1.onCompleted(Nio2Session.java:339)
> at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.lambda$completed$0(Nio2CompletionHandler.java:38)
> at java.security.AccessController.doPrivileged(Native Method)
> at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.completed(Nio2CompletionHandler.java:37)
> at sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:126)
> at sun.nio.ch.Invoker$2.run(Invoker.java:218)
> at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
> at java.lang.Thread.run(Thread.java:748)
> sparrow:apache-karaf-4.4.2 paul$
>
>
> Paul Spencer
Re: Karaf 4.4.2 bin/client -> Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
Posted by Paul Spencer <pa...@apache.org>.
Just found https://issues.apache.org/jira/browse/KARAF-7607, so this is a known bug.
Paul Spencer
On 2022/11/14 15:53:03 Paul Spencer wrote:
> Karaf version 4.4.2
> Java Virtual Machine Java HotSpot(TM) 64-Bit Server VM version 25.172-b11
> Version 1.8.0_172
> Vendor Oracle Corporation
>
> bin/karaf works, but bin/client fails with the following error:
> DefaultOpenFuture[ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]: Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
>
> I have verified the ssh port is not in use prior to starting karaf using bin/start
> sparrow:apache-karaf-4.4.2 paul$ netstat -an | grep 8101
> sparrow:apache-karaf-4.4.2 paul$
>
> What am I missing?
>
> ***
> * Below is bin/client with debug logging enabled.
> ***
> sparrow:apache-karaf-4.4.2 paul$ bin/client -v -l 3
> 165 [main] DEBUG org.apache.sshd.common.util.security.SecurityUtils - register([BC, true, false]) not registered - enabled=null, supported={}
> 165 [main] DEBUG org.apache.sshd.common.util.security.SecurityUtils - register([EdDSA, true, false]) not registered - enabled=null, supported={}
> Logging in as karaf
> 260 [main] INFO org.apache.sshd.common.io.DefaultIoServiceFactoryFactory - No detected/configured IoServiceFactoryFactory using Nio2ServiceFactoryFactory
> 266 [main] DEBUG org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - reloadHostConfigEntries([karaf, localhost, 8101, null, /Users/paul/.ssh/config]@null:{}/{}) check permissions of {}
> 272 [main] INFO org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - resolveEffectiveResolver(karaf@localhost:8101) loaded 7 entries from /Users/paul/.ssh/config
> 273 [main] DEBUG org.apache.sshd.client.config.hosts.DefaultConfigFileHostEntryResolver - resolveEffectiveHost([karaf, localhost, 8101, null, null]@null:{}/{}) => {}
> 273 [main] DEBUG org.apache.sshd.client.SshClient - connect([karaf, localhost, 8101]@null:{}) no overrides
> 277 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - Connecting to localhost/127.0.0.1:8101
> 282 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - setOption([SO_REUSEADDR, true, Property[socket-reuseaddr](Boolean]])[null] from property={}
> 286 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - Creating IoSession on [/127.0.0.1:64796, localhost/127.0.0.1:8101, null] from null via {}
> 298 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - Client session created: Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]
> 299 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientUserAuthService - ClientUserAuthService(ClientSessionImpl[null@localhost/127.0.0.1:8101]) client methods: [publickey, keyboard-interactive, password]
> 303 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.session.helpers.SessionTimeoutListener - sessionCreated(ClientSessionImpl[null@localhost/127.0.0.1:8101]) tracking
> 304 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - initializeProxyConnector(ClientSessionImpl[null@localhost/127.0.0.1:8101]) no proxy to initialize
> 305 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendIdentification(ClientSessionImpl[null@localhost/127.0.0.1:8101]): SSH-2.0-APACHE-SSHD-2.9.1
> 305 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 27 bytes
> 307 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendKexInit(ClientSessionImpl[null@localhost/127.0.0.1:8101]) Send SSH_MSG_KEXINIT
> 313 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[null@localhost/127.0.0.1:8101], 0, 20, SSH_MSG_KEXINIT, 1171]) packet #null sending command={}[{}] len={}
> 313 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 1184 bytes
> 314 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.SshClient - setupDefaultSessionIdentities(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) key identity provider override in session listener
> 315 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - doReadIdentification(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) line='SSH-2.0-APACHE-SSHD-2.9.1'
> 316 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - readIdentification(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Server version string: SSH-2.0-APACHE-SSHD-2.9.1
> 316 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleKexInit(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_KEXINIT
> 321 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - addPasswordIdentity(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SHA256:MFiExFNQu83IUEdulJM4nQvyxg1KalAz2uFviHDn6o0
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], kex algorithms, ecdh-sha2-nistp521]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], server host key algorithms, rsa-sha2-512]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], encryption algorithms (client to server), aes128-ctr]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], encryption algorithms (server to client), aes128-ctr]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], mac algorithms (client to server), hmac-sha2-256]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], mac algorithms (server to client), hmac-sha2-256]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], compression algorithms (client to server), none]) Kex: null = {}
> 323 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setNegotiationResult([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], compression algorithms (server to client), none]) Kex: null = {}
> 368 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.kex.DHGClient - init(DHGClient[ecdh-sha2-nistp521])[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]] Send SSH_MSG_KEXDH_INIT
> 368 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 1, 30, 30, 138]) packet #null sending command={}[{}] len={}
> 369 [sshd-SshClient[10bdf5e5]-nio2-thread-1] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 152 bytes
> 378 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.kex.DHGClient - next([DHGClient[ecdh-sha2-nistp521], ClientSessionImpl[karaf@localhost/127.0.0.1:8101], SSH_MSG_KEXDH_REPLY])[null] process command={}
> 388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setServerKey([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-rsa, SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw]) keyType=null, digest={}
> 388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleKexMessage([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ecdh-sha2-nistp521, 31])[null] KEX processing complete after cmd={}
> 388 [sshd-SshClient[10bdf5e5]-nio2-thread-2] WARN org.apache.sshd.client.keyverifier.AcceptAllServerKeyVerifier - Server at localhost/127.0.0.1:8101 presented unverified RSA key: SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw
> 389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - checkKeys([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-rsa, SHA256:0XXt/w0gjLKT+0fMxcNYjDRbXpNpcGmXncs8rrN/hgw, true]) key=null-{}, verified={}
> 389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_NEWKEYS
> 389 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - prepareNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) session ID=50:78:c0:35:ea:d9:67:92:d4:05:b7:7c:ef:00:36:57:24:f2:52:27:95:42:64:2c:a4:7a:98:2f:e1:e6:92:19:94:24:7b:77:4d:26:7f:a9:b3:99:6d:fd:51:83:fa:4c:5f:9f:43:19:94:a2:3b:4a:4b:2b:3b:52:26:d9:7a:38
> 411 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 2, 21, SSH_MSG_NEWKEYS, 1]) packet #null sending command={}[{}] len={}
> 411 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 16 bytes
> 425 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setOutputEncoding([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], BaseCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16], BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false, none[Deflater/-1], 134217728]): cipher null; mac {}; compression {}; blocks limit {}
> 426 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) No pending packets to flush at end of KEX
> 426 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleNewKeys(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_NEWKEYS command=SSH_MSG_NEWKEYS
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - setInputEncoding([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], BaseCipher[AES, ivSize=16, kdfSize=16,AES/CTR/NoPadding, blkSize=16], BaseMac[HmacSHA256] - block=32/32 bytes, encrypt-then-mac=false, none[Inflater/-1], 4294967296]): cipher null; mac {}; compression {}; blocks limit {}
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - sendInitialServiceRequest(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_SERVICE_REQUEST for ssh-userauth
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 3, 5, SSH_MSG_SERVICE_REQUEST, 17]) packet #null sending command={}[{}] len={}
> 427 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
> 428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - auth(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection] send SSH_MSG_USERAUTH_REQUEST for 'none'
> 428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 4, 50, SSH_MSG_USERAUTH_REQUEST, 36]) packet #null sending command={}[{}] len={}
> 428 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 96 bytes
> 429 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): [ssh-rsa, rsa-sha2-256, rsa-sha2-512, sk-ecdsa-sha2-nistp256@openssh.com, ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521]
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): PubkeyAcceptedAlgorithms before: [ecdsa-sha2-nistp256-cert-v01@openssh.com, ecdsa-sha2-nistp384-cert-v01@openssh.com, ecdsa-sha2-nistp521-cert-v01@openssh.com, rsa-sha2-512-cert-v01@openssh.com, rsa-sha2-256-cert-v01@openssh.com, ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, sk-ecdsa-sha2-nistp256@openssh.com, rsa-sha2-512, rsa-sha2-256, ssh-rsa]
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.kex.extension.DefaultClientKexExtensionHandler - handleServerSignatureAlgorithms(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]): PubkeyAcceptedAlgorithms after: [ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, sk-ecdsa-sha2-nistp256@openssh.com, rsa-sha2-512, rsa-sha2-256, ssh-rsa, ecdsa-sha2-nistp256-cert-v01@openssh.com, ecdsa-sha2-nistp384-cert-v01@openssh.com, ecdsa-sha2-nistp521-cert-v01@openssh.com, rsa-sha2-512-cert-v01@openssh.com, rsa-sha2-256-cert-v01@openssh.com]
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - handleServiceAccept(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_SERVICE_ACCEPT service=ssh-userauth
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], false, keyboard-interactive,password,publickey]) Received SSH_MSG_USERAUTH_FAILURE - partial=null, methods={}
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], [publickey, keyboard-interactive, password], [keyboard-interactive, password, publickey]]) starting authentication mechanisms: client=null, server={}
> 430 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) attempting method=publickey
> 444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, publickey, rsa-sha2-512, SHA256:fcF5snOtV4tmHqf3leQCyiKl5lpMeQp6wRZKA1T0ckg])[null] send SSH_MSG_USERAUTH_REQUEST request {} type={} - fingerprint={}
> 444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 5, 50, SSH_MSG_USERAUTH_REQUEST, 339]) packet #null sending command={}[{}] len={}
> 444 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 400 bytes
> 445 [sshd-SshClient[10bdf5e5]-nio2-thread-2] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) successfully processed initial buffer by method=publickey
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], false, keyboard-interactive,password,publickey]) Received SSH_MSG_USERAUTH_FAILURE - partial=null, methods={}
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, rsa-sha2-512])[null] server rejected publickey authentication with known signature algorithm {}
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_dsa) no key loaded
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_ecdsa) no key loaded
> 447 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.config.keys.DefaultClientIdentitiesWatcher - loadKeys(/Users/paul/.ssh/id_ed25519) no key loaded
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - resolveAttemptedPublicKeyIdentity(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection] no more keys to send
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) no initial request sent by method=publickey
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.pubkey.UserAuthPublicKey - destroy(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection]
> 448 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) attempting method=keyboard-interactive
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - verifyTrialsCount([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, SSH_MSG_USERAUTH_REQUEST, 0, 3])[null] cmd={} - {} out of {}
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - sendAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, keyboard-interactive, , ])[null] send SSH_MSG_USERAUTH_REQUEST for {}: lang={}, methods={}
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 6, 50, SSH_MSG_USERAUTH_REQUEST, 60]) packet #null sending command={}[{}] len={}
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 128 bytes
> 449 [sshd-SshClient[10bdf5e5]-nio2-thread-3] DEBUG org.apache.sshd.client.session.ClientUserAuthService - tryNext(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) successfully processed initial buffer by method=keyboard-interactive
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 60, keyboard-interactive]) delegate processing of null to {}
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - processAuthDataRequest([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, Password authentication, , en-US, 1])[null] SSH_MSG_USERAUTH_INFO_REQUEST name={}, instruction={}, language={}, num-prompts={}
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - verifyTrialsCount([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], ssh-connection, SSH_MSG_USERAUTH_INFO_REQUEST, 1, 3])[null] cmd={} - {} out of {}
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - getUserResponses(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) use password candidate for interaction=Password authentication
> 450 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 7, 61, SSH_MSG_USERAUTH_INFO_RESPONSE, 14]) packet #null sending command={}[{}] len={}
> 451 [sshd-SshClient[10bdf5e5]-nio2-thread-4] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
> 452 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientUserAuthService - processUserAuth(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) SSH_MSG_USERAUTH_SUCCESS Succeeded with keyboard-interactive
> 452 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.auth.keyboard.UserAuthKeyboardInteractive - destroy(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[ssh-connection]
> 453 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) no heartbeat to stop
> 453 [sshd-SshClient[10bdf5e5]-nio2-thread-5] DEBUG org.apache.sshd.client.session.ClientConnectionService - startHeartbeat([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], PT1M, keepalive@sshd.apache.org]) - started at interval=null with request={}
> 578 [main] DEBUG org.apache.sshd.client.channel.ChannelShell - init() service=[ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]], ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0] session=null id={}
> 578 [main] DEBUG org.apache.sshd.common.channel.Window - init([Window[client/local](ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]), 2097152, 2097152, 32768]) size=null, max={}, packet={}
> 578 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - registerChannel([ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]], 0, true, ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]])[id=null, registered={}] {}
> 579 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - createShellChannel([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0, null]) created id=null - PTY={}
> 580 [main] DEBUG org.apache.sshd.client.channel.ChannelShell - open(ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_CHANNEL_OPEN - type=session
> 580 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 8, 90, SSH_MSG_CHANNEL_OPEN, 24]) packet #null sending command={}[{}] len={}
> 581 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 80 bytes
> 582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientConnectionService - channelOpenConfirmation([ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 0, 2097152, 32768]) SSH_MSG_CHANNEL_OPEN_CONFIRMATION sender=null, window-size={}, packet-size={}
> 582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - setRecipient(ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) recipient=0
> 582 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.channel.Window - init([Window[client/remote](ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]), 2097152, 2097152, 32768]) size=null, max={}, packet={}
> 583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - doOpenPty(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send agent forwarding request
> 583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientSessionImpl - encode([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], 9, 98, SSH_MSG_CHANNEL_REQUEST, 36]) packet #null sending command={}[{}] len={}
> 583 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - writeBuffer(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) writing 96 bytes
> 584 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.channel.ChannelShell - doOpenPty(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Send SSH_MSG_CHANNEL_REQUEST pty-req: PtyChannelConfiguration[type=xterm-256color, lines=47, columns=259, height=480, width=640, modes={IGNCR=0, ECHOE=1, VSTATUS=20, ECHOK=0, IXON=1, OPOST=1, ONOCR=0, VERASE=127, IXANY=1, VINTR=3, VSTART=17, INLCR=0, VEOL=-1, PARMRK=0, OCRNL=0, ICRNL=1, INPCK=0, VREPRINT=18, IGNPAR=0, ONLCR=1, ISTRIP=0, ISIG=1, ONLRET=0, VKILL=21, VEOL2=-1, VSUSP=26, VLNEXT=22, VDISCARD=15, ECHONL=0, ICANON=1, TOSTOP=0, IEXTEN=1, VSTOP=19, VEOF=4, VWERASE=23, NOFLSH=0, VDSUSP=25, IXOFF=0, ECHO=1, VQUIT=28}]
> 586 [main] DEBUG org.apache.sshd.client.SshClient - close(SshClient[10bdf5e5]) Closing immediately
> 587 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - close(org.apache.sshd.common.io.nio2.Nio2Connector@5af97850) Closing immediately
> 589 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.channel.AbstractChannel$GracefulChannelCloseable - close(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[immediately=true] processing
> 589 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.client.session.ClientConnectionService - unregisterChannel(ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) result=ChannelShell[id=0, recipient=0]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]
> 589 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) Closing immediately
> 590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - doCloseImmediately(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) closing socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[connected local=/127.0.0.1:64796 remote=localhost/127.0.0.1:8101]
> 590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@69716b88) signal close complete immediately=true
> 590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - doCloseImmediately(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) socket=sun.nio.ch.UnixAsynchronousSocketChannelImpl[closed] closed
> 590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@57f7fe58) signal close complete immediately=true
> 590 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - unmapSession(id=101): Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]
> 590 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@65ec6247) signal close complete immediately=true
> 590 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - close(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) Closing immediately
> 590 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - signalAuthFailure([ClientSessionImpl[karaf@localhost/127.0.0.1:8101], SshException, false, false, Session is being closed]) type=null, signalled={}, first={}: {}
> 591 [sshd-SshClient[10bdf5e5]-nio2-thread-7] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - handleReadCycleCompletion(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101]) IoSession has been closed, stop reading
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - close(ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]) Closing immediately
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) stopping
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - stopHeartBeat(ClientSessionImpl[karaf@localhost/127.0.0.1:8101]) stopped
> 593 [main] DEBUG org.apache.sshd.client.session.ClientConnectionService - close(ClientConnectionService[ClientSessionImpl[karaf@localhost/127.0.0.1:8101]])[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101])[Immediately] state already Closed
> 593 [main] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@14ec4505) signal close complete immediately=true
> 593 [main] DEBUG org.apache.sshd.client.session.ClientSessionImpl - close(ClientSessionImpl[karaf@localhost/127.0.0.1:8101])[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Session - close(Nio2Session[local=/127.0.0.1:64796, remote=localhost/127.0.0.1:8101])[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2Connector - close(org.apache.sshd.common.io.nio2.Nio2Connector@5af97850)[Immediately] closed
> 593 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - close(org.apache.sshd.common.io.nio2.Nio2ServiceFactory@53ca01a2) Closing immediately
> 594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown group
> 594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Group successfully shut down
> 594 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown executor
> 595 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - Shutdown complete
> 595 [main] DEBUG org.apache.sshd.common.io.nio2.Nio2ServiceFactory - close(org.apache.sshd.common.io.nio2.Nio2ServiceFactory@53ca01a2)[Immediately] closed
> 595 [main] DEBUG org.apache.sshd.common.util.closeable.SequentialCloseable - doClose(org.apache.sshd.common.util.closeable.SequentialCloseable$1@358c99f5) signal close complete immediately=true
> 595 [main] DEBUG org.apache.sshd.client.SshClient - close(SshClient[10bdf5e5])[Immediately] closed
> org.apache.sshd.common.SshException: DefaultOpenFuture[ChannelShell[id=0, recipient=-1]-ClientSessionImpl[karaf@localhost/127.0.0.1:8101]]: Failed (IllegalArgumentException) to execute: Invalid UINT32 value: -1
> at org.apache.sshd.common.future.AbstractSshFuture.lambda$verifyResult$1(AbstractSshFuture.java:132)
> at org.apache.sshd.common.future.AbstractSshFuture.formatExceptionMessage(AbstractSshFuture.java:190)
> at org.apache.sshd.common.future.AbstractSshFuture.verifyResult(AbstractSshFuture.java:131)
> at org.apache.sshd.client.future.DefaultOpenFuture.verify(DefaultOpenFuture.java:39)
> at org.apache.sshd.client.future.DefaultOpenFuture.verify(DefaultOpenFuture.java:32)
> at org.apache.sshd.common.future.VerifiableFuture.verify(VerifiableFuture.java:43)
> at org.apache.karaf.client.Main.main(Main.java:281)
> Caused by: java.lang.IllegalArgumentException: Invalid UINT32 value: -1
> at org.apache.sshd.common.util.ValidateUtils.createFormattedException(ValidateUtils.java:213)
> at org.apache.sshd.common.util.ValidateUtils.throwIllegalArgumentException(ValidateUtils.java:179)
> at org.apache.sshd.common.util.ValidateUtils.checkTrue(ValidateUtils.java:162)
> at org.apache.sshd.common.util.buffer.BufferUtils.validateUint32Value(BufferUtils.java:703)
> at org.apache.sshd.common.util.buffer.Buffer.putUInt(Buffer.java:726)
> at org.apache.sshd.client.channel.PtyCapableChannelSession.lambda$doOpenPty$0(PtyCapableChannelSession.java:265)
> at java.util.HashMap.forEach(HashMap.java:1289)
> at org.apache.sshd.client.channel.PtyCapableChannelSession.doOpenPty(PtyCapableChannelSession.java:263)
> at org.apache.sshd.client.channel.ChannelShell.doOpen(ChannelShell.java:45)
> at org.apache.sshd.client.channel.AbstractClientChannel.handleOpenSuccess(AbstractClientChannel.java:366)
> at org.apache.sshd.common.session.helpers.AbstractConnectionService.channelOpenConfirmation(AbstractConnectionService.java:545)
> at org.apache.sshd.common.session.helpers.AbstractConnectionService.process(AbstractConnectionService.java:456)
> at org.apache.sshd.common.session.helpers.CurrentService.process(CurrentService.java:109)
> at org.apache.sshd.common.session.helpers.AbstractSession.doHandleMessage(AbstractSession.java:594)
> at org.apache.sshd.common.session.helpers.AbstractSession.lambda$handleMessage$0(AbstractSession.java:525)
> at org.apache.sshd.common.util.threads.ThreadUtils.runAsInternal(ThreadUtils.java:66)
> at org.apache.sshd.common.session.helpers.AbstractSession.handleMessage(AbstractSession.java:524)
> at org.apache.sshd.common.session.helpers.AbstractSession.decode(AbstractSession.java:1644)
> at org.apache.sshd.common.session.helpers.AbstractSession.messageReceived(AbstractSession.java:485)
> at org.apache.sshd.common.session.helpers.AbstractSessionIoHandler.messageReceived(AbstractSessionIoHandler.java:64)
> at org.apache.sshd.common.io.nio2.Nio2Session.handleReadCycleCompletion(Nio2Session.java:371)
> at org.apache.sshd.common.io.nio2.Nio2Session$1.onCompleted(Nio2Session.java:344)
> at org.apache.sshd.common.io.nio2.Nio2Session$1.onCompleted(Nio2Session.java:339)
> at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.lambda$completed$0(Nio2CompletionHandler.java:38)
> at java.security.AccessController.doPrivileged(Native Method)
> at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.completed(Nio2CompletionHandler.java:37)
> at sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:126)
> at sun.nio.ch.Invoker$2.run(Invoker.java:218)
> at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
> at java.lang.Thread.run(Thread.java:748)
> sparrow:apache-karaf-4.4.2 paul$
>
>
> Paul Spencer