3 Replies Latest reply on Jul 25, 2013 3:20 PM by Peter Krutý

    FTP Voyager - Scheduler getting Bad Message Error

    robertk

      We are FTPing to one of our clients and using FTP Voyager using SSH2 port 10022. They don't allow us to see anything in the directory they just allow us to push files. I can manually push the file using the FTP Voyager interface manually however when I use the scheduler it errors out with the following message.  There must be a setting that I am not changing to get this error but I am not seeing it.  Any help would be appreciated.

       

      [12] Tue 16Jul13 08:07:02 - (Task: Tape Backup To WF) - Execution triggered by admin user.

      [03] Tue 16Jul13 08:07:02 - Resolving host "ftp.someplace.com"...

      [03] Tue 16Jul13 08:07:02 - Connecting to "10.10.10.10" on port 10022.

      [03] Tue 16Jul13 08:07:02 - Connected to 10.10.10.10:10022 from 172.31.30.1:3532.

      [03] Tue 16Jul13 08:07:02 - Negotiating SSH2 session with server...

      [03] Tue 16Jul13 08:07:02 - Client Identification: SSH-2.0-FTP Voyager_16.0.2.0

      [03] Tue 16Jul13 08:07:02 - Server Identification: SSH-2.0-Connect:Enterprise_UNIX_2.4.04 Build 00

      [03] Tue 16Jul13 08:07:02 - Initializing key exchange process...

      [03] Tue 16Jul13 08:07:02 - Selected key exchange algorithm: diffie-hellman-group1-sha1

      [03] Tue 16Jul13 08:07:02 - Host Key Fingerprint: DD:81:35:FA:15:75:E9:85:B3:3A:A7:BE:1F:A3:F5:C0

      [03] Tue 16Jul13 08:07:02 - Server --> Client: Encryption: aes128-cbc, MAC: hmac-sha1, Compression: zlib

      [03] Tue 16Jul13 08:07:02 - Client --> Server: Encryption: aes128-cbc, MAC: hmac-sha1, Compression: zlib

      [03] Tue 16Jul13 08:07:02 - Selected public key protocol: ssh-dss

      [03] Tue 16Jul13 08:07:02 - Key exchange process successfully completed.

      [07] Tue 16Jul13 08:07:02 - SSH_MSG_SERVICE_REQUEST: service: ssh-userauth

      [08] Tue 16Jul13 08:07:02 - SSH_MSG_SERVICE_ACCEPT: service accepted

      [03] Tue 16Jul13 08:07:02 - Querying server for supported authentication methods

      [07] Tue 16Jul13 08:07:02 - SSH_MSG_USERAUTH_REQUEST: user: 316041; service: ssh-connection; type: none

      [08] Tue 16Jul13 08:07:02 - SSH_MSG_USERAUTH_FAILURE: partial: 0; available authentications: publickey, password, keyboard-interactive

      [03] Tue 16Jul13 08:07:02 - Supported authentication methods: publickey, password, keyboard-interactive

      [07] Tue 16Jul13 08:07:02 - SSH_MSG_USERAUTH_REQUEST: user: 316041; service: ssh-connection; type: password

      [08] Tue 16Jul13 08:07:02 - SSH_MSG_USERAUTH_SUCCESS: authentication successful

      [03] Tue 16Jul13 08:07:02 - Login successful.

      [07] Tue 16Jul13 08:07:02 - SSH_MSG_CHANNEL_OPEN: type: session; local channel: 0

      [08] Tue 16Jul13 08:07:03 - SSH_MSG_CHANNEL_OPEN_CONFIRMATION: local channel: 0; remote channel: 0

      [07] Tue 16Jul13 08:07:03 - SSH_MSG_CHANNEL_REQUEST: remote channel: 0; request type: subsystem; subsytem: sftp

      [08] Tue 16Jul13 08:07:03 - SSH_MSG_CHANNEL_SUCCESS: channel request succeeded; local channel: 0

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_INIT: client version: 6

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_VERSION: server version: 3

      [03] Tue 16Jul13 08:07:03 - Negotiated SFTP version 3

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_REALPATH: translating path: .

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_NAME: translated path: /217025

      [13] Tue 16Jul13 08:07:03 - (Action: "D:\MonthlyBackups\*.zip" to "/") - Uploading from "D:\MonthlyBackups\*.zip" to "/"

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_STAT: path: /SQL07162013.zip

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_STATUS: status: SSH_FX_BAD_MESSAGE; description: Bad message

      [03] Tue 16Jul13 08:07:03 - Sending: D:\MonthlyBackups\SQL07162013.zip -> /SQL07162013.zip

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_OPEN: path: /SQL07162013.zip; flags: 26

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_STATUS: status: SSH_FX_BAD_MESSAGE; description: Bad message

      [04] Tue 16Jul13 08:07:03 - Upload of "D:\MonthlyBackups\SQL07162013.zip" failed.

      [04] Tue 16Jul13 08:07:03 - Retrying failed transfer (attempt 2 out of 3)...

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_STAT: path: /SQL07162013.zip

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_STATUS: status: SSH_FX_BAD_MESSAGE; description: Bad message

      [03] Tue 16Jul13 08:07:03 - Sending: D:\MonthlyBackups\SQL07162013.zip -> /SQL07162013.zip

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_OPEN: path: /SQL07162013.zip; flags: 26

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_STATUS: status: SSH_FX_BAD_MESSAGE; description: Bad message

      [04] Tue 16Jul13 08:07:03 - Upload of "D:\MonthlyBackups\SQL07162013.zip" failed.

      [04] Tue 16Jul13 08:07:03 - Retrying failed transfer (attempt 3 out of 3)...

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_STAT: path: /SQL07162013.zip

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_STATUS: status: SSH_FX_BAD_MESSAGE; description: Bad message

      [03] Tue 16Jul13 08:07:03 - Sending: D:\MonthlyBackups\SQL07162013.zip -> /SQL07162013.zip

      [07] Tue 16Jul13 08:07:03 - SSH_FXP_OPEN: path: /SQL07162013.zip; flags: 26

      [08] Tue 16Jul13 08:07:03 - SSH_FXP_STATUS: status: SSH_FX_BAD_MESSAGE; description: Bad message

      [04] Tue 16Jul13 08:07:03 - Upload of "D:\MonthlyBackups\SQL07162013.zip" failed.

      [13] Tue 16Jul13 08:07:03 - (Action: "D:\MonthlyBackups\*.zip" to "/") - Action successfully completed.

      [13] Tue 16Jul13 08:07:03 - (Action: "C:\Scripts\email.vbs") - Running external program: C:\Scripts\email.vbs

      [13] Tue 16Jul13 08:07:03 - (Action: "C:\Scripts\email.vbs") - Waiting until external program exits...