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 <[email protected]> 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, [email protected], > 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: [[email protected], > [email protected], > [email protected], [email protected], > [email protected], ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, > ecdsa-sha2-nistp521, [email protected], 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, [email protected], rsa-sha2-512, > rsa-sha2-256, ssh-rsa, [email protected], > [email protected], > [email protected], [email protected], > [email protected]] > 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, > [email protected]]) - 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
