Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Refuses to connect #11561

Closed
cyberduck opened this issue Jan 25, 2021 · 7 comments
Closed

Refuses to connect #11561

cyberduck opened this issue Jan 25, 2021 · 7 comments
Labels
bug sftp SFTP Protocol Implementation thirdparty Issue caused by third party

Comments

@cyberduck
Copy link
Collaborator

11e81b0 created the issue

CyberDuck refuses to connect to SFTP host, says "Too Many authentication failures", although there wasn't even one.
Can connect from the same workstation to the same host using command line SFTP. The only guess I have - host has changed it's keys, so there can be conflict with previously recorded RSA key hash, although I have cleaned up known_hosts on OS, and I can't find where CyberDuck stores it's own known keys (if it does)

error	21:50:29.471707+0100	Cyberduck	Dying because - Too many authentication failures.
Subsystem ch.sudo.cyberduck  Category reader net.schmizz.sshj.transport.TransportImpl

net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
	at net.schmizz.sshj.transport.TransportImpl.gotDisconnect(TransportImpl.java:565)
	at net.schmizz.sshj.transport.TransportImpl.handle(TransportImpl.java:521)
	at net.schmizz.sshj.transport.Decoder.decode(Decoder.java:113)
	at net.schmizz.sshj.transport.Decoder.received(Decoder.java:203)
	at net.schmizz.sshj.transport.Reader.run(Reader.java:60)
<<kex done>> woke to: net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.

Attachments
@cyberduck
Copy link
Collaborator Author

@dkocher commented

Please check the server log why authentication is rejected.

@cyberduck
Copy link
Collaborator Author

11e81b0 commented

Guys,

could you pleas READ ticket description first ??? It drives me nuts, when I get responses like that, clearly indicating support person haven't even spend 30secs reading tickets description.
I wrote: says "Too Many authentication failures", although there wasn't even one. I repeat: server DOES NOT report ANY authentication failure. Credentials are 100% correct.
On server side I see:
SSH INFO SSH session closed by server for host x.x.x.x
SSH INFO SSH authentication ended unexpectedly for host x.x.x.x

@cyberduck
Copy link
Collaborator Author

11e81b0 commented

On 7.8.2 nothing changed, i.e. I get same error.

@cyberduck
Copy link
Collaborator Author

@dkocher commented

Please provide full log output which should show the authentication attempts.

@cyberduck
Copy link
Collaborator Author

11e81b0 commented

2021-01-27 14:41:43.774274+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.binding.Proxy] Already on main thread. Invoke ch.cyberduck.ui.cocoa.controller.BrowserController$15@7c6442c2 directly.
2021-01-27 14:41:43.774591+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.AbstractCache] Clear cache Cache{size=0}
2021-01-27 14:41:43.774644+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.ui.cocoa.controller.BrowserController] Set working directory to null
2021-01-27 14:41:43.774694+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.ui.cocoa.controller.BrowserController] Set path filter to RegexFilter{pattern=\..*}
2021-01-27 14:41:43.774776+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.ui.cocoa.controller.BrowserController] Reload data with selected files []
2021-01-27 14:41:43.774852+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.ui.cocoa.datasource.BrowserOutlineViewDataSource] Reload table view <CDOutlineView: 0x7f7ff74f0e00> for changes files []
2021-01-27 14:41:43.775106+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.ui.cocoa.datasource.BrowserOutlineViewDataSource] Reload table view <CDOutlineView: 0x7f7ff74f0e00> for changes files []
2021-01-27 14:41:43.778674+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.local.TildeExpander] Expanded ~/.ssh/known_hosts to /Users/anonikov/.ssh/known_hosts
2021-01-27 14:41:43.778951+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.preferences.UserDefaultsPreferences] Set property  for key local.bookmark.~/.ssh/known_hosts
2021-01-27 14:41:43.778998+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.preferences.UserDefaultsPreferences] Delete property local.bookmark.~/.ssh/known_hosts
2021-01-27 14:41:43.795609+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main net.schmizz.sshj.common.ECDSAVariationsAdapter] Key algo: ecdsa-sha2-nistp256, Key curve: nistp256, Key Len: 65, 0x04: 4
x: [103, -38, 50, -36, -32, -43, 3, 38, -107, -17, -13, -24, -116, -122, 105, 95, 100, 55, 93, -56, -116, 123, -80, 7, -24, 53, -64, -14, 17, 9, -127, -105]
y: [-115, -117, 14, 92, 43, -12, -72, 121, -54, 24, 56, 40, 72, -52, 6, 70, -79, -117, 127, 113, -25, -2, 61, 91, 72, -35, -99, 92, 63, -88, 15, 62]
2021-01-27 14:41:43.814738+0100 0x36dac5   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Finalizer org.rococoa] Draining autorelease pool
2021-01-27 14:41:43.918179+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main net.schmizz.sshj.common.KeyType] Key algo: ssh-ed25519, Key curve: 25519, Key Len: 32
p: [-17, -56, -36, 27, -2, -5, -9, 51, 28, -69, -96, 17, -89, -11, 4, 80, -44, -93, -29, -30, 20, 97, 103, 94, 44, 100, 31, -65, 25, 65, 4, 41]
2021-01-27 14:41:43.934111+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main net.schmizz.sshj.common.KeyType] Key algo: ssh-ed25519, Key curve: 25519, Key Len: 32
p: [-17, -56, -36, 27, -2, -5, -9, 51, 28, -69, -96, 17, -89, -11, 4, 80, -44, -93, -29, -30, 20, 97, 103, 94, 44, 100, 31, -65, 25, 65, 4, 41]
2021-01-27 14:41:43.935663+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main net.schmizz.sshj.common.KeyType] Key algo: ssh-ed25519, Key curve: 25519, Key Len: 32
p: [66, 79, -42, 13, 80, -39, -114, -117, -121, 77, -75, 104, 15, -52, 35, -92, -120, -70, -101, -91, 26, 42, 53, 44, -18, 93, 50, -93, 53, 8, 56, 98]
2021-01-27 14:41:43.935813+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main net.schmizz.sshj.common.KeyType] Key algo: ssh-ed25519, Key curve: 25519, Key Len: 32
p: [66, -29, -72, 44, 92, -125, 32, -95, -116, 70, 68, -105, 61, 76, -47, -107, -109, 73, -51, 125, 99, -29, -58, -55, -87, -65, -115, -109, 31, -3, -74, 15]
2021-01-27 14:41:43.944310+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.SessionPoolFactory] Create new stateless connection pool for Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='null', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:43.944756+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.SessionFactory] Create session for Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='null', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:43.950067+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.threading.DefaultBackgroundExecutor] Run action WorkerBackgroundAction{worker=MountWorker{cache=ch.cyberduck.core.ReverseLookupCache@2459319c}} in background
2021-01-27 14:41:43.952018+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main ch.cyberduck.core.threading.DefaultBackgroundExecutor] Scheduled background runnable WorkerBackgroundAction{worker=MountWorker{cache=ch.cyberduck.core.ReverseLookupCache@2459319c}} for execution
2021-01-27 14:41:43.952354+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.BackgroundCallable] Running background action WorkerBackgroundAction{worker=MountWorker{cache=ch.cyberduck.core.ReverseLookupCache@2459319c}}
2021-01-27 14:41:43.952474+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.BackgroundCallable] Prepare background action WorkerBackgroundAction{worker=MountWorker{cache=ch.cyberduck.core.ReverseLookupCache@2459319c}}
2021-01-27 14:41:43.952532+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.AbstractBackgroundAction] Prepare background task WorkerBackgroundAction{worker=MountWorker{cache=ch.cyberduck.core.ReverseLookupCache@2459319c}}
2021-01-27 14:41:43.952654+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.AbstractController] Start action WorkerBackgroundAction{worker=MountWorker{cache=ch.cyberduck.core.ReverseLookupCache@2459319c}}
2021-01-27 14:41:43.952886+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.BackgroundCallable] Call background action WorkerBackgroundAction{worker=MountWorker{cache=ch.cyberduck.core.ReverseLookupCache@2459319c}}
2021-01-27 14:41:43.952985+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.Session] Add listener ch.cyberduck.ui.cocoa.controller.BrowserController@af78c87
2021-01-27 14:41:43.953109+0100 0x36da99   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:main org.rococoa.callback] No method _sidebarTrackingAdapter for selector:_sidebarTrackingAdapter
2021-01-27 14:41:43.954063+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.KeychainLoginService] Validate login credentials for Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='null', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:43.954170+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.DefaultHostPasswordStore] Fetching private key passphrase from keychain for Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='null', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:43.955862+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.proxy.SystemConfigurationProxy] No proxy configuration found for target ftp://192.168.201.68:22
2021-01-27 14:41:43.956797+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.NamedThreadFactory] Create thread for runnable ch.cyberduck.core.Resolver$1@34acdd15
2021-01-27 14:41:43.957041+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.Resolver] Waiting for resolving of 192.168.201.68
2021-01-27 14:41:43.957198+0100 0x36e278   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:resolver-1 ch.cyberduck.core.Resolver] Resolved 192.168.201.68 to 192.168.201.68
2021-01-27 14:41:43.957313+0100 0x36e278   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:resolver-1 ch.cyberduck.core.threading.NamedThreadFactory] Finished execution of runnable ch.cyberduck.core.Resolver$1@34acdd15
2021-01-27 14:41:43.957554+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.Session] Connection will open to Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='null', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:43.965854+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.random.JCERandom] Creating new SecureRandom.
2021-01-27 14:41:43.966973+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.random.JCERandom] Random creation took 1 ms
2021-01-27 14:41:43.996899+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.DefaultConfig] Available cipher factories: [aes128-cbc, aes128-ctr, aes192-cbc, aes192-ctr, aes256-cbc, aes256-ctr, aes128-gcm@openssh.com, aes256-gcm@openssh.com, blowfish-cbc, blowfish-ctr, cast128-cbc, cast128-ctr, idea-cbc, idea-ctr, serpent128-cbc, serpent128-ctr, serpent192-cbc, serpent192-ctr, serpent256-cbc, serpent256-ctr, 3des-cbc, 3des-ctr, twofish128-cbc, twofish128-ctr, twofish192-cbc, twofish192-ctr, twofish256-cbc, twofish256-ctr, twofish-cbc, arcfour, arcfour128, arcfour256]
2021-01-27 14:41:44.011976+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.proxy.SystemConfigurationProxy] No proxy configuration found for target ftp://192.168.201.68:22
2021-01-27 14:41:44.020748+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.socket.DefaultSocketConfigurator] Set timeout to 30000ms for socket Socket[unconnected]
2021-01-27 14:41:44.039966+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.TransportImpl] Client identity string: SSH-2.0-Cyberduck/7.8.2.34203 (Mac OS X/11.1) (x86_64)
2021-01-27 14:41:44.043683+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.TransportImpl] Server identity string: SSH-2.0-Mocana SSH
2021-01-27 14:41:44.043901+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] Setting <<kex done>> to `null`
2021-01-27 14:41:44.043980+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.KeyExchanger] Sending SSH_MSG_KEXINIT
2021-01-27 14:41:44.045428+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] Setting <<kexinit sent>> to `SOME`
2021-01-27 14:41:44.045492+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] Awaiting <<kex done>>
2021-01-27 14:41:44.046646+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Received SSH_MSG_KEXINIT
2021-01-27 14:41:44.046992+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Negotiated algorithms: [ kex=diffie-hellman-group1-sha1; sig=ssh-rsa; c2sCipher=aes128-cbc; s2cCipher=aes128-cbc; c2sMAC=hmac-sha1; s2cMAC=hmac-sha1; c2sComp=none; s2cComp=none; rsaSHA2Support=false ]
2021-01-27 14:41:44.047063+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Trying to verify algorithms with ch.cyberduck.core.sftp.SFTPSession$2@7be73097
2021-01-27 14:41:44.047124+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader ch.cyberduck.core.sftp.SFTPSession] Negotiated algorithms [ kex=diffie-hellman-group1-sha1; sig=ssh-rsa; c2sCipher=aes128-cbc; s2cCipher=aes128-cbc; c2sMAC=hmac-sha1; s2cMAC=hmac-sha1; c2sComp=none; s2cComp=none; rsaSHA2Support=false ]
2021-01-27 14:41:44.059713+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader com.hierynomus.sshj.transport.kex.DHG] Sending SSH_MSG_KEXDH_INIT
2021-01-27 14:41:44.060452+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] Received SSH_MSG_DISCONNECT (reason=CONNECTION_LOST, msg=Too many authentication failures.)
2021-01-27 14:41:44.060755+0100 0x36e27c   Error       0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] Dying because - Too many authentication failures.
2021-01-27 14:41:44.061466+0100 0x36e27c   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.061516+0100 0x36e27c   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.TransportImpl.gotDisconnect(TransportImpl.java:565)
2021-01-27 14:41:44.061546+0100 0x36e27c   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.TransportImpl.handle(TransportImpl.java:521)
2021-01-27 14:41:44.061581+0100 0x36e27c   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.Decoder.decode(Decoder.java:113)
2021-01-27 14:41:44.061620+0100 0x36e27c   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.Decoder.received(Decoder.java:203)
2021-01-27 14:41:44.061641+0100 0x36e27c   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.Reader.run(Reader.java:60)
2021-01-27 14:41:44.061709+0100 0x36e27c   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader ch.cyberduck.core.sftp.SFTPSession] Disconnected CONNECTION_LOST
2021-01-27 14:41:44.061975+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Got notified of net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.062072+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl$NullService] Notified of net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.062130+0100 0x36e0e2   Error       0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] <<kex done>> woke to: net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.062198+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] Setting active service to null-service
2021-01-27 14:41:44.062909+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.concurrent.Promise] Setting <<transport close>> to `SOME`
2021-01-27 14:41:44.062976+0100 0x36e27c   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.Reader] Stopping
2021-01-27 14:41:44.070590+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.DefaultFailureDiagnostics] Determine cause for failure BackgroundException{class=class ch.cyberduck.core.exception.ConnectionRefusedException, file=null, message='Connection failed', detail='Too many authentication failures.', cause='net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.'}
2021-01-27 14:41:44.071117+0100 0x36e0e2   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.AbstractRetryCallable] Retry for failure BackgroundException{class=class ch.cyberduck.core.exception.ConnectionRefusedException, file=null, message='Connection failed', detail='Too many authentication failures.', cause='net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.'} with delay of 0s
2021-01-27 14:41:44.071244+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.Session] Add listener ch.cyberduck.ui.cocoa.controller.BrowserController@af78c87
2021-01-27 14:41:44.071414+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.KeychainLoginService] Validate login credentials for Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='12a8aa10-e937-47e6-8602-ba7439f5b2f6', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:44.071485+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.DefaultHostPasswordStore] Fetching private key passphrase from keychain for Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='12a8aa10-e937-47e6-8602-ba7439f5b2f6', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:44.071808+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.proxy.SystemConfigurationProxy] No proxy configuration found for target ftp://192.168.201.68:22
2021-01-27 14:41:44.071904+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.NamedThreadFactory] Create thread for runnable ch.cyberduck.core.Resolver$1@6dc57030
2021-01-27 14:41:44.072107+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.Resolver] Waiting for resolving of 192.168.201.68
2021-01-27 14:41:44.072237+0100 0x36e27d   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:resolver-2 ch.cyberduck.core.Resolver] Resolved 192.168.201.68 to 192.168.201.68
2021-01-27 14:41:44.072291+0100 0x36e27d   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:resolver-2 ch.cyberduck.core.threading.NamedThreadFactory] Finished execution of runnable ch.cyberduck.core.Resolver$1@6dc57030
2021-01-27 14:41:44.072463+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.Session] Connection will open to Host{protocol=Profile{parent=sftp, vendor=iterate GmbH, description=null, image=null}, port=22, hostname='192.168.201.68', credentials=Credentials{user='rwa', oauth='Tokens{accessToken='null', refreshToken='null'}', token='', identity=null}, uuid='12a8aa10-e937-47e6-8602-ba7439f5b2f6', nickname='null', defaultpath='null', workdir=null, labels=null}
2021-01-27 14:41:44.072537+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.random.JCERandom] Creating new SecureRandom.
2021-01-27 14:41:44.072659+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.random.JCERandom] Random creation took 0 ms
2021-01-27 14:41:44.077219+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.DefaultConfig] Available cipher factories: [aes128-cbc, aes128-ctr, aes192-cbc, aes192-ctr, aes256-cbc, aes256-ctr, aes128-gcm@openssh.com, aes256-gcm@openssh.com, blowfish-cbc, blowfish-ctr, cast128-cbc, cast128-ctr, idea-cbc, idea-ctr, serpent128-cbc, serpent128-ctr, serpent192-cbc, serpent192-ctr, serpent256-cbc, serpent256-ctr, 3des-cbc, 3des-ctr, twofish128-cbc, twofish128-ctr, twofish192-cbc, twofish192-ctr, twofish256-cbc, twofish256-ctr, twofish-cbc, arcfour, arcfour128, arcfour256]
2021-01-27 14:41:44.079517+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.proxy.SystemConfigurationProxy] No proxy configuration found for target ftp://192.168.201.68:22
2021-01-27 14:41:44.079589+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.socket.DefaultSocketConfigurator] Set timeout to 30000ms for socket Socket[unconnected]
2021-01-27 14:41:44.081702+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.TransportImpl] Client identity string: SSH-2.0-Cyberduck/7.8.2.34203 (Mac OS X/11.1) (x86_64)
2021-01-27 14:41:44.086216+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.TransportImpl] Server identity string: SSH-2.0-Mocana SSH
2021-01-27 14:41:44.086417+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] Setting <<kex done>> to `null`
2021-01-27 14:41:44.086471+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.sshj.transport.KeyExchanger] Sending SSH_MSG_KEXINIT
2021-01-27 14:41:44.086736+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] Setting <<kexinit sent>> to `SOME`
2021-01-27 14:41:44.086783+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] Awaiting <<kex done>>
2021-01-27 14:41:44.088432+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Received SSH_MSG_KEXINIT
2021-01-27 14:41:44.088534+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Negotiated algorithms: [ kex=diffie-hellman-group1-sha1; sig=ssh-rsa; c2sCipher=aes128-cbc; s2cCipher=aes128-cbc; c2sMAC=hmac-sha1; s2cMAC=hmac-sha1; c2sComp=none; s2cComp=none; rsaSHA2Support=false ]
2021-01-27 14:41:44.088610+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Trying to verify algorithms with ch.cyberduck.core.sftp.SFTPSession$2@5ceadf58
2021-01-27 14:41:44.088663+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader ch.cyberduck.core.sftp.SFTPSession] Negotiated algorithms [ kex=diffie-hellman-group1-sha1; sig=ssh-rsa; c2sCipher=aes128-cbc; s2cCipher=aes128-cbc; c2sMAC=hmac-sha1; s2cMAC=hmac-sha1; c2sComp=none; s2cComp=none; rsaSHA2Support=false ]
2021-01-27 14:41:44.093338+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader com.hierynomus.sshj.transport.kex.DHG] Sending SSH_MSG_KEXDH_INIT
2021-01-27 14:41:44.093581+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] Received SSH_MSG_DISCONNECT (reason=CONNECTION_LOST, msg=Too many authentication failures.)
2021-01-27 14:41:44.093645+0100 0x36e27e   Error       0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] Dying because - Too many authentication failures.
2021-01-27 14:41:44.093741+0100 0x36e27e   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.093765+0100 0x36e27e   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.TransportImpl.gotDisconnect(TransportImpl.java:565)
2021-01-27 14:41:44.093783+0100 0x36e27e   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.TransportImpl.handle(TransportImpl.java:521)
2021-01-27 14:41:44.093800+0100 0x36e27e   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.Decoder.decode(Decoder.java:113)
2021-01-27 14:41:44.093816+0100 0x36e27e   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.Decoder.received(Decoder.java:203)
2021-01-27 14:41:44.093832+0100 0x36e27e   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] 	at net.schmizz.sshj.transport.Reader.run(Reader.java:60)
2021-01-27 14:41:44.093863+0100 0x36e27e   Default     0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader ch.cyberduck.core.sftp.SFTPSession] Disconnected CONNECTION_LOST
2021-01-27 14:41:44.093904+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.KeyExchanger] Got notified of net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.093952+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl$NullService] Notified of net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.093980+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.TransportImpl] Setting active service to null-service
2021-01-27 14:41:44.094029+0100 0x36e0e2   Error       0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 net.schmizz.concurrent.Promise] <<kex done>> woke to: net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.
2021-01-27 14:41:44.094147+0100 0x36e0e2   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:Thread-89 ch.cyberduck.core.threading.DefaultFailureDiagnostics] Determine cause for failure BackgroundException{class=class ch.cyberduck.core.exception.ConnectionRefusedException, file=null, message='Connection failed', detail='Too many authentication failures.', cause='net.schmizz.sshj.transport.TransportException: [CONNECTION_LOST] Too many authentication failures.'}
2021-01-27 14:41:44.094200+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.concurrent.Promise] Setting <<transport close>> to `SOME`
2021-01-27 14:41:44.094239+0100 0x36e27e   Info        0x0                  96160  0    Cyberduck: (libcore.dylib) [ch.sudo.cyberduck:reader net.schmizz.sshj.transport.Reader] Stopping

@cyberduck
Copy link
Collaborator Author

11e81b0 commented

Added cap file with SFTP connection attempts from Cyberduck (failed) and command line sftp tool (successful)

  1. Frames 1-40 - failed connection attempt with Cyberduck
  2. 41-end - successful connection with sftp

@cyberduck
Copy link
Collaborator Author

@dkocher commented

It looks like the server return an error after SSH_MSG_KEXDH_INIT possibly because of a problem with the negotiated key exchange algorithms. Do you have access to the server log of the Mocana SSH server?

@iterate-ch iterate-ch locked as resolved and limited conversation to collaborators Nov 27, 2021
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
bug sftp SFTP Protocol Implementation thirdparty Issue caused by third party
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@cyberduck