You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@camel.apache.org by "Patrick Wiederkehr (JIRA)" <ji...@apache.org> on 2013/06/13 14:51:20 UTC
[jira] [Created] (CAMEL-6454) sftp interprets password wrong
Patrick Wiederkehr created CAMEL-6454:
-----------------------------------------
Summary: sftp interprets password wrong
Key: CAMEL-6454
URL: https://issues.apache.org/jira/browse/CAMEL-6454
Project: Camel
Issue Type: Bug
Components: camel-ftp
Affects Versions: 2.11.0
Environment: Windows
Reporter: Patrick Wiederkehr
Tried to get a route running with a + in the password option.
+ gets interpreted as [space] always get authentication errors.
013-06-13 14:46:15,675 [128.98/WIRK/out] TRACE SftpOperations - Session isn't connected, trying to recreate and connect.
2013-06-13 14:46:15,675 [128.98/WIRK/out] DEBUG SftpOperations - Using StrickHostKeyChecking: no
2013-06-13 14:46:15,675 [128.98/WIRK/out] TRACE SftpOperations - Connecting use connectTimeout: 10000 ...
2013-06-13 14:46:15,675 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Connecting to XXX port 22
2013-06-13 14:46:15,705 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Connection established
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Remote version string: SSH-2.0-OpenSSH_4.2
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Local version string: SSH-2.0-JSCH-0.1.49
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> CheckCiphers: aes256-ctr,aes192-ctr,aes128-ctr,aes256-cbc,aes192-cbc,aes128-cbc,3des-ctr,arcfour,arcfour128,arcfour256
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> aes256-ctr is not available.
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> aes192-ctr is not available.
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> aes256-cbc is not available.
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> aes192-cbc is not available.
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> arcfour256 is not available.
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> CheckKexes: diffie-hellman-group14-sha1
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> diffie-hellman-group14-sha1 is not available.
2013-06-13 14:46:15,735 [128.98/WIRK/out] INFO SftpOperations - JSCH -> SSH_MSG_KEXINIT sent
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> SSH_MSG_KEXINIT received
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: diffie-hellman-group-exchange-sha1,diffie-hellman-group14-sha1,diffie-hellman-group1-sha1
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: ssh-rsa,ssh-dss
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,arcfour128,arcfour256,arcfour,aes192-cbc,aes256-cbc,rijndael-cbc@lysator.liu.se,aes128-ctr,aes192-ctr,aes256-ctr
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,arcfour128,arcfour256,arcfour,aes192-cbc,aes256-cbc,rijndael-cbc@lysator.liu.se,aes128-ctr,aes192-ctr,aes256-ctr
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: hmac-md5,hmac-sha1,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96,hmac-md5-96
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: hmac-md5,hmac-sha1,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96,hmac-md5-96
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: none,zlib@openssh.com
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server: none,zlib@openssh.com
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server:
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server:
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: diffie-hellman-group1-sha1,diffie-hellman-group-exchange-sha1
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: ssh-rsa,ssh-dss
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: aes128-ctr,aes128-cbc,3des-ctr,3des-cbc,blowfish-cbc
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: aes128-ctr,aes128-cbc,3des-ctr,3des-cbc,blowfish-cbc
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: hmac-md5,hmac-sha1,hmac-sha2-256,hmac-sha1-96,hmac-md5-96
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: hmac-md5,hmac-sha1,hmac-sha2-256,hmac-sha1-96,hmac-md5-96
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: none
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client: none
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client:
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client:
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: server->client aes128-ctr hmac-md5 none
2013-06-13 14:46:15,765 [128.98/WIRK/out] INFO SftpOperations - JSCH -> kex: client->server aes128-ctr hmac-md5 none
2013-06-13 14:46:15,775 [128.98/WIRK/out] INFO SftpOperations - JSCH -> SSH_MSG_KEXDH_INIT sent
2013-06-13 14:46:15,775 [128.98/WIRK/out] INFO SftpOperations - JSCH -> expecting SSH_MSG_KEXDH_REPLY
2013-06-13 14:46:15,805 [128.98/WIRK/out] INFO SftpOperations - JSCH -> ssh_rsa_verify: signature true
2013-06-13 14:46:15,805 [128.98/WIRK/out] WARN SftpOperations - JSCH -> Permanently added 'XXX' (RSA) to the list of known hosts.
2013-06-13 14:46:15,805 [128.98/WIRK/out] INFO SftpOperations - JSCH -> SSH_MSG_NEWKEYS sent
2013-06-13 14:46:15,805 [128.98/WIRK/out] INFO SftpOperations - JSCH -> SSH_MSG_NEWKEYS received
2013-06-13 14:46:15,805 [128.98/WIRK/out] INFO SftpOperations - JSCH -> SSH_MSG_SERVICE_REQUEST sent
2013-06-13 14:46:15,825 [128.98/WIRK/out] INFO SftpOperations - JSCH -> SSH_MSG_SERVICE_ACCEPT received
2013-06-13 14:46:15,865 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Authentications that can continue: publickey,keyboard-interactive,password
2013-06-13 14:46:15,865 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Next authentication method: publickey
2013-06-13 14:46:15,865 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Authentications that can continue: keyboard-interactive,password
2013-06-13 14:46:15,865 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Next authentication method: keyboard-interactive
2013-06-13 14:46:16,085 [/src/reschedule] DEBUG FileConsumer - Took 0.000 seconds to poll: src\reschedule
2013-06-13 14:46:16,595 [/src/reschedule] DEBUG FileConsumer - Took 0.000 seconds to poll: src\reschedule
2013-06-13 14:46:16,886 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Authentications that can continue: password
2013-06-13 14:46:16,886 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Next authentication method: password
2013-06-13 14:46:16,886 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Login trials exceeds 6
2013-06-13 14:46:16,886 [128.98/WIRK/out] INFO SftpOperations - JSCH -> Disconnecting from XXX port 22
2013-06-13 14:46:16,886 [128.98/WIRK/out] TRACE SftpOperations - Cannot connect due: Cannot connect to sftp://blckche@XXX:22
2013-06-13 14:46:16,886 [128.98/WIRK/out] WARN ilePollingConsumerPollStrategy - Trying to recover by disconnecting from remote server forcing a re-connect at next poll: sftp://blckche@XXX:22
2013-06-13 14:46:16,896 [128.98/WIRK/out] DEBUG DeadLetterChannel - Failed delivery for (MessageId: ID-loyalty4-win7-53562-1371127559742-0-1 on ExchangeId: ID-loyalty4-win7-53562-1371127559742-0-2). On delivery attempt: 0 caught: org.apache.camel.component.file.GenericFileOperationFailedException: Cannot connect to sftp://blckche@XXX:22
2013-06-13 14:46:16,896 [128.98/WIRK/out] DEBUG SendProcessor - >>>> Endpoint[direct://error] Exchange[Message: Consumer Consumer[sftp://blckche@XXX/WIRK/out?binary=true&consumer.bridgeErrorHandler=true&delay=3600000&include=.*%5C.DAT&noop=true&password=******&readLock=rename&separator=UNIX&stepwise=false&throwExceptionOnConnectFailed=true] failed polling endpoint: Endpoint[sftp://blckche@XXX/WIRK/out?binary=true&consumer.bridgeErrorHandler=true&delay=3600000&include=.*%5C.DAT&noop=true&password=******&readLock=rename&separator=UNIX&stepwise=false&throwExceptionOnConnectFailed=true]. Will try again at next poll]
2013-06-13 14:46:16,896 [128.98/WIRK/out] ERROR route2 - Unrecoverable Error occured
2013-06-13 14:46:16,896 [128.98/WIRK/out] DEBUG SendProcessor - >>>> Endpoint[log://ch.loyalty.retailo.gcactivator?level=ERROR&multiline=true&showAll=true] Exchange[Message: Consumer Consumer[sftp://blckche@XXX/WIRK/out?binary=true&consumer.bridgeErrorHandler=true&delay=3600000&include=.*%5C.DAT&noop=true&password=******&readLock=rename&separator=UNIX&stepwise=false&throwExceptionOnConnectFailed=true] failed polling endpoint: Endpoint[sftp://blckche@XXX/WIRK/out?binary=true&consumer.bridgeErrorHandler=true&delay=3600000&include=.*%5C.DAT&noop=true&password=******&readLock=rename&separator=UNIX&stepwise=false&throwExceptionOnConnectFailed=true]. Will try again at next poll]
2013-06-13 14:46:16,906 [128.98/WIRK/out] ERROR gcactivator - Exchange[
, Id:ID-loyalty4-win7-53562-1371127559742-0-2
, ExchangePattern:InOnly
, Properties:{CamelToEndpoint=log://ch.loyalty.retailo.gcactivator?level=ERROR&multiline=true&showAll=true, CamelCreatedTimestamp=Thu Jun 13 14:46:16 CEST 2013, CamelFailureRouteId=route1, CamelExceptionCaught=org.apache.camel.component.file.GenericFileOperationFailedException: Cannot connect to sftp://blckche@XXX:22}
, Headers:{}
, BodyType:String
, Body:Consumer Consumer[sftp://blckche@XXX/WIRK/out?binary=true&consumer.bridgeErrorHandler=true&delay=3600000&include=.*%5C.DAT&noop=true&password=******&readLock=rename&separator=UNIX&stepwise=false&throwExceptionOnConnectFailed=true] failed polling endpoint: Endpoint[sftp://blckche@XXX/WIRK/out?binary=true&consumer.bridgeErrorHandler=true&delay=3600000&include=.*%5C.DAT&noop=true&password=******&readLock=rename&separator=UNIX&stepwise=false&throwExceptionOnConnectFailed=true]. Will try again at next poll
, CaughtExceptionType:org.apache.camel.component.file.GenericFileOperationFailedException, CaughtExceptionMessage:Cannot connect to sftp://blckche@XXX:22, StackTrace:org.apache.camel.component.file.GenericFileOperationFailedException: Cannot connect to sftp://blckche@XXX:22
at org.apache.camel.component.file.remote.SftpOperations.connect(SftpOperations.java:126)
at org.apache.camel.component.file.remote.RemoteFileConsumer.connectIfNecessary(RemoteFileConsumer.java:147)
at org.apache.camel.component.file.remote.RemoteFileConsumer.recoverableConnectIfNecessary(RemoteFileConsumer.java:138)
at org.apache.camel.component.file.remote.RemoteFileConsumer.prePollCheck(RemoteFileConsumer.java:54)
at org.apache.camel.component.file.GenericFileConsumer.poll(GenericFileConsumer.java:104)
at org.apache.camel.impl.ScheduledPollConsumer.doRun(ScheduledPollConsumer.java:141)
at org.apache.camel.impl.ScheduledPollConsumer.run(ScheduledPollConsumer.java:91)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:662)
Caused by: com.jcraft.jsch.JSchException: Auth fail
at com.jcraft.jsch.Session.connect(Session.java:491)
at org.apache.camel.component.file.remote.SftpOperations.connect(SftpOperations.java:98)
... 15 more
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira