Discuss (FTP), (FTP on .NET CF) and (FTPS, SFTP and SCP).
no avatar
User

BMackenzieJHA

Posts

11

Joined

Wed Nov 05, 2014 2:41 am

Error on SFTP Upload but file still uploads

by BMackenzieJHA » Wed Feb 18, 2015 12:32 am

I was testing SFTP transfers and saw this error message get logged:
ERROR [SFTPSubsystem] 13 Feb 2015 16:44:08.887 : VerifyRequestOK: Operation unsupported

Tried to look this up but didn't find anything useful. Oddly, the file was still successfully uploaded, even with this error.

I set the logging level higher and this is what it showed me.

DEBUG [ClientKeyExchanger] 13 Feb 2015 16:53:54.468 : Processed SSH_MSG_KEXDH_INIT reply successfully
DEBUG [ClientKeyExchanger] 13 Feb 2015 16:53:54.468 : Sending SSH_MSG_NEWKEYS
DEBUG [ClientKeyExchanger] 13 Feb 2015 16:53:54.468 : Sent SSH_MSG_NEWKEYS
DEBUG [ClientKeyExchanger] 13 Feb 2015 16:53:54.468 : Established ciphers
DEBUG [ClientKeyExchanger] 13 Feb 2015 16:53:54.468 : Established MACs
DEBUG [ClientKeyExchanger] 13 Feb 2015 16:53:54.468 : Reading SSH_MSG_NEWKEYS reply
DEBUG [AbstractKeyExchanger] 13 Feb 2015 16:53:54.483 : Processing SSH_MSG_NEWKEYS reply
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Processed 0 queued messages
DEBUG [AbstractKeyExchanger] 13 Feb 2015 16:53:54.483 : Processed SSH_MSG_NEWKEYS reply
INFO [AbstractKeyExchanger] 13 Feb 2015 16:53:54.483 : Negotiated new keys successfully
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Key exchange complete
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Sent SSH_MSG_SERVICE_REQUEST 'ssh-userauth'
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Waiting for packet
DEBUG [PlainSocket] 13 Feb 2015 16:53:54.483 : FTPConnection.2 RepeatCallback received 52 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Packet arrived
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Starting user authentication for 'sitsftptest'
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Password authentication
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Sent SSH_MSG_USERAUTH_REQUEST
DEBUG [SSH2Connection] 13 Feb 2015 16:53:54.483 : Waiting for packet
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.179 : FTPConnection.2 RepeatCallback received 36 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.179 : Packet arrived
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.179 : ProcessAuthenticationResponse: SSH_MSG_USERAUTH_SUCCESS
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.179 : User authentication successful
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.179 : Sent SSH_MSG_CHANNEL_OPEN
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.179 : FTPConnection.2 RepeatCallback received 52 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.179 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_OPEN_CONFIRMATION
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.179 : FTPConnection.2 ProcessPacket: status= 2, pt=SSH_MSG_CHANNEL_OPEN_CONFIRMATION
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.179 : FTPConnection.2 OpenSFTP pt=SSH_MSG_CHANNEL_OPEN_CONFIRMATION
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.179 : FTPConnection.2 Remote window size set to 16384
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.179 : FTPConnection.2 Remote max packet size=35840
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.179 : FTPConnection.2 Setting packet size=35840
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.179 : FTPConnection.2 Sending SSH_MSG_CHANNEL_REQUEST
INFO [SSHFTPClient] 13 Feb 2015 16:53:59.179 : Waiting for SSH channel to be opened
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.179 : FTPConnection.2 RepeatCallback received 36 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.179 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_SUCCESS
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.179 : FTPConnection.2 ProcessPacket: status= 1, pt=SSH_MSG_CHANNEL_SUCCESS
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.179 : FTPConnection.2 OpenSFTP pt=SSH_MSG_CHANNEL_SUCCESS
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.195 : SSH channel opened
INFO [SFTPSubsystem] 13 Feb 2015 16:53:59.195 : Initialize(): client version: 3
ALL [SFTPMessage] 13 Feb 2015 16:53:59.195 : Send : Name=SSH_FXP_INIT,Type=1,RequestID=0
version=3
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.195 : Transmit 9 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.195 : Remote window size decreased to 16375
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.195 : FTPConnection.2 RepeatCallback received 52 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.195 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
DEBUG [SSHChannel] 13 Feb 2015 16:53:59.195 : FTPConnection.2 Channel 0: sent SSH_MSG_CHANNEL_WINDOW_ADJUST
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.195 : FTPConnection.2 Local window size increased to 1048575
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.195 : FTPConnection.2 NextMessageLength=5
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.195 : FTPConnection.2 Received message (type=2,len=5)
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.195 : FTPConnection.2 AddMessage(0) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.195 : Reply : Name=SSH_FXP_VERSION,Type=2,RequestID=0
version=3
extension count=0
INFO [SFTPSubsystem] 13 Feb 2015 16:53:59.195 : Server SFTP version: 3
DEBUG [SFTPSubsystem] 13 Feb 2015 16:53:59.195 : SFTP subsystem started
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.195 : Connect() succeeded
ALL [SFTPMessage] 13 Feb 2015 16:53:59.195 : Send : Name=SSH_FXP_REALPATH,Type=16,RequestID=1
originalPath=.
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.195 : Transmit 14 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.195 : Remote window size decreased to 16361
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.210 : FTPConnection.2 RepeatCallback received 124 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.210 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.210 : FTPConnection.2 NextMessageLength=81
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.210 : FTPConnection.2 Received message (type=104,len=81)
DEBUG [SFTPMessage] 13 Feb 2015 16:53:59.210 : FTPConnection.2 SSH_FXP_NAME: requestID=1, 1 files
ALL [SFTPMessage] 13 Feb 2015 16:53:59.210 : FTPConnection.2 count=0,short=/Home/InstitutionD/sitsftptest
ALL [SFTPMessage] 13 Feb 2015 16:53:59.210 : FTPConnection.2 count=0,long=/Home/InstitutionD/sitsftptest
ALL [SFTPFileAttributes] 13 Feb 2015 16:53:59.210 : FTPConnection.2 flags=0
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.210 : FTPConnection.2 AddMessage(1) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.210 : Reply : Name=SSH_FXP_NAME,Type=104,RequestID=1
sitsftptest [AP=/Home/InstitutionD/sitsftptest, O=False, Valid flags=0, US=, G=, D=False, F=False, LI=False, R=False, W=False, AT=0, AD=1/1/1970 12:00:00 AM, MT=0, MD=1/1/1970 12:00:00 AM, P=0, S=0, U=, LN=/Home/InstitutionD/sitsftptest]
INFO [FTPConnection] 13 Feb 2015 16:53:59.210 : Auto FEAT disabled
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.210 : Set transfer type = ASCII
DEBUG [FTPConnection] 13 Feb 2015 16:53:59.210 : Home directory is '/Home/InstitutionD/sitsftptest'
DEBUG [ExFTPConnection] 13 Feb 2015 16:53:59.210 : Attempt 1: RegularSFTP20150213.txt Overwrite
DEBUG [FTPConnection] 13 Feb 2015 16:53:59.210 : UploadFile(D:\iPass DLLs\iPayNet\FileTransferFunctionalityTests\UploadFiles\RegularSFTP.txt,RegularSFTP20150213.txt,Overwrite)
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.210 : Put(D:\iPass DLLs\iPayNet\FileTransferFunctionalityTests\UploadFiles\RegularSFTP.txt,RegularSFTP20150213.txt)
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.226 : ResolveRemotePath('RegularSFTP20150213.txt'); [cwd='/Home/InstitutionD/sitsftptest']
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.226 : Resolved to '/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt'
DEBUG [SFTPSubsystem] 13 Feb 2015 16:53:59.226 : GetAttributes(/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt)
ALL [SFTPMessage] 13 Feb 2015 16:53:59.226 : Send : Name=SSH_FXP_STAT,Type=17,RequestID=2
path=/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.226 : Transmit 67 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.226 : Remote window size decreased to 16294
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.288 : FTPConnection.2 RepeatCallback received 76 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.288 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.288 : FTPConnection.2 NextMessageLength=31
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.288 : FTPConnection.2 Received message (type=101,len=31)
DEBUG [SFTPMessage] 13 Feb 2015 16:53:59.319 : FTPConnection.2 ErrorCode|Status=2
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.319 : FTPConnection.2 AddMessage(2) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.319 : Reply : Name=SSH_FXP_STATUS,Type=101,RequestID=2
errorCode=2
errorMessage=No such file
language=en
DEBUG [SFTPSubsystem] 13 Feb 2015 16:53:59.319 : GetAttributes: No such file : /Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.319 : Catching and ignoring exception: No such file : /Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt (code=2)
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.319 : ResolveRemotePath('RegularSFTP20150213.txt'); [cwd='/Home/InstitutionD/sitsftptest']
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.319 : Resolved to '/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt'
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.319 : Remote path=/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.319 : ResolveRemotePath('/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt'); [cwd='/Home/InstitutionD/sitsftptest']
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.319 : Resolved to '/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt'
DEBUG [SFTPSubsystem] 13 Feb 2015 16:53:59.319 : GetAttributes(/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt)
ALL [SFTPMessage] 13 Feb 2015 16:53:59.319 : Send : Name=SSH_FXP_STAT,Type=17,RequestID=3
path=/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.319 : Transmit 67 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.319 : Remote window size decreased to 16227
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.366 : FTPConnection.2 RepeatCallback received 76 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.366 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.366 : FTPConnection.2 NextMessageLength=31
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.366 : FTPConnection.2 Received message (type=101,len=31)
DEBUG [SFTPMessage] 13 Feb 2015 16:53:59.366 : FTPConnection.2 ErrorCode|Status=2
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.366 : FTPConnection.2 AddMessage(3) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.366 : Reply : Name=SSH_FXP_STATUS,Type=101,RequestID=3
errorCode=2
errorMessage=No such file
language=en
DEBUG [SFTPSubsystem] 13 Feb 2015 16:53:59.366 : GetAttributes: No such file : /Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.366 : Catching and ignoring exception: No such file : /Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt (code=2)
ALL [SFTPMessage] 13 Feb 2015 16:53:59.366 : Send : Name=SSH_FXP_OPEN,Type=3,RequestID=4
absolutePath=/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
flags=26
attributes=Valid flags=4, US=, G=, D=False, F=False, LI=False, R=True, W=True, AT=0, AD=1/1/1970 12:00:00 AM, MT=0, MD=1/1/1970 12:00:00 AM, P=493, S=0, U=prwxr-xr-x
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.382 : Transmit 79 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.382 : Remote window size decreased to 16148
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.444 : FTPConnection.2 RepeatCallback received 60 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.444 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.444 : FTPConnection.2 NextMessageLength=13
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.444 : FTPConnection.2 Received message (type=102,len=13)
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.444 : FTPConnection.2 AddMessage(4) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.444 : Reply : Name=SSH_FXP_HANDLE,Type=102,RequestID=4
handle=00000000
DEBUG [SFTPFileStreamWriter] 13 Feb 2015 16:53:59.444 : Parallel mode = True
ALL [SFTPMessage] 13 Feb 2015 16:53:59.444 : Send : Name=SSH_FXP_WRITE,Type=6,RequestID=5
handle=00000000,offset=0,datalen=9
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.444 : Transmit 38 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.444 : Remote window size decreased to 16110
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.444 : FTPConnection.2 RepeatCallback received 68 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.444 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.444 : FTPConnection.2 NextMessageLength=26
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.444 : FTPConnection.2 Received message (type=101,len=26)
DEBUG [SFTPMessage] 13 Feb 2015 16:53:59.444 : FTPConnection.2 ErrorCode|Status=0
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.444 : FTPConnection.2 AddMessage(5) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.444 : Reply : Name=SSH_FXP_STATUS,Type=101,RequestID=5
errorCode=0
errorMessage=Success
language=en
ALL [SFTPMessage] 13 Feb 2015 16:53:59.444 : Send : Name=SSH_FXP_CLOSE,Type=4,RequestID=6
handle=00000000
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.444 : Transmit 17 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.444 : Remote window size decreased to 16093
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.491 : FTPConnection.2 RepeatCallback received 68 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.491 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.491 : FTPConnection.2 NextMessageLength=26
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.491 : FTPConnection.2 Received message (type=101,len=26)
DEBUG [SFTPMessage] 13 Feb 2015 16:53:59.491 : FTPConnection.2 ErrorCode|Status=0
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.491 : FTPConnection.2 AddMessage(6) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.491 : Reply : Name=SSH_FXP_STATUS,Type=101,RequestID=6
errorCode=0
errorMessage=Success
language=en
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.491 : ResolveRemotePath('RegularSFTP20150213.txt'); [cwd='/Home/InstitutionD/sitsftptest']
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.491 : Resolved to '/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt'
DEBUG [SFTPSubsystem] 13 Feb 2015 16:53:59.491 : GetAttributes(/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt)
ALL [SFTPMessage] 13 Feb 2015 16:53:59.491 : Send : Name=SSH_FXP_STAT,Type=17,RequestID=7
path=/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.491 : Transmit 67 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.491 : Remote window size decreased to 16026
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.507 : FTPConnection.2 RepeatCallback received 84 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.507 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.507 : FTPConnection.2 NextMessageLength=37
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.507 : FTPConnection.2 Received message (type=105,len=37)
ALL [SFTPFileAttributes] 13 Feb 2015 16:53:59.507 : FTPConnection.2 flags=15
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.507 : FTPConnection.2 AddMessage(7) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.507 : Reply : Name=SSH_FXP_ATTRS,Type=105,RequestID=7
attributes=Valid flags=15, US=0, G=0, D=False, F=True, LI=False, R=True, W=True, AT=1423864439, AD=2/13/2015 9:53:59 PM, MT=1423864439, MD=2/13/2015 9:53:59 PM, P=33279, S=9, U=-rwxrwxrwx
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.507 : ChMod(755,/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt)
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.507 : ResolveRemotePath('/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt'); [cwd='/Home/InstitutionD/sitsftptest']
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.507 : Resolved to '/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt'
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.507 : Chmod(actual=/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt)
DEBUG [SFTPSubsystem] 13 Feb 2015 16:53:59.507 : ChangePermissions(/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt,493)
ALL [SFTPMessage] 13 Feb 2015 16:53:59.507 : Send : Name=SSH_FXP_SETSTAT,Type=9,RequestID=8
path=/Home/InstitutionD/sitsftptest/RegularSFTP20150213.txt
attributes=Valid flags=4, US=, G=, D=False, F=False, LI=False, R=True, W=True, AT=0, AD=1/1/1970 12:00:00 AM, MT=0, MD=1/1/1970 12:00:00 AM, P=493, S=0, U=prwxr-xr-x
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.522 : Transmit 75 bytes
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.522 : Remote window size decreased to 15951
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.522 : FTPConnection.2 RepeatCallback received 84 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.522 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_DATA
ALL [SFTPMessageProcessor] 13 Feb 2015 16:53:59.522 : FTPConnection.2 NextMessageLength=40
DEBUG [SFTPMessageFactory] 13 Feb 2015 16:53:59.522 : FTPConnection.2 Received message (type=101,len=40)
DEBUG [SFTPMessage] 13 Feb 2015 16:53:59.522 : FTPConnection.2 ErrorCode|Status=8
DEBUG [SFTPMessageStore] 13 Feb 2015 16:53:59.522 : FTPConnection.2 AddMessage(8) - added to store
ALL [SFTPMessage] 13 Feb 2015 16:53:59.522 : Reply : Name=SSH_FXP_STATUS,Type=101,RequestID=8
errorCode=8
errorMessage=Operation unsupported
language=en
ERROR [SFTPSubsystem] 13 Feb 2015 16:53:59.522 : VerifyRequestOK: Operation unsupported
WARN [SSHFTPClient] 13 Feb 2015 16:53:59.522 : Could not chmod remote file (Operation unsupported (code=8)) - skipping
DEBUG [FTPConnection] 13 Feb 2015 16:53:59.522 : Closing connection [instance=1,abrupt=False]
DEBUG [SSHFTPClient] 13 Feb 2015 16:53:59.522 : Quit() called
DEBUG [SSHChannel] 13 Feb 2015 16:53:59.522 : Closing channel 0
DEBUG [SSHChannel] 13 Feb 2015 16:53:59.522 : Channel 0: sent SSH_MSG_CHANNEL_CLOSE
DEBUG [SSHChannel] 13 Feb 2015 16:53:59.522 : Waiting for connection to close ...
DEBUG [PlainSocket] 13 Feb 2015 16:53:59.522 : FTPConnection.2 RepeatCallback received 36 bytes
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.522 : FTPConnection.2 ProcessPacket pt=SSH_MSG_CHANNEL_CLOSE
DEBUG [SSH2Channel] 13 Feb 2015 16:53:59.522 : FTPConnection.2 Received close
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.522 : FTPConnection.2 Sending SSH_MSG_DISCONNECT
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.522 : FTPConnection.2 SSH_MSG_DISCONNECT sent - closing
DEBUG [SFTPChannelReceiver] 13 Feb 2015 16:53:59.522 : FTPConnection.2 Channel closed
DEBUG [ChannelDataWindow] 13 Feb 2015 16:53:59.522 : FTPConnection.2 Stopped channel data window
DEBUG [SSHConnectionReceiver] 13 Feb 2015 16:53:59.538 : FTPConnection.2 Connection closed: (code=0)
DEBUG [SSH2Connection] 13 Feb 2015 16:53:59.538 : FTPConnection.2 Close() called
DEBUG [SSHChannel] 13 Feb 2015 16:53:59.585 : Channel 0 and its connection closed
no avatar
User

support2

Posts

3987

Joined

Tue May 18, 2004 8:30 am

Re: Error on SFTP Upload but file still uploads

by support2 » Wed Feb 18, 2015 12:52 am

This should be a debug message, and in the latest version it may be. After uploading, the library tries to chmod the file to set some appropriate permissions. In this case, the server doesn't support the chmod.
no avatar
User

BMackenzieJHA

Posts

11

Joined

Wed Nov 05, 2014 2:41 am

Re: Error on SFTP Upload but file still uploads

by BMackenzieJHA » Wed Feb 18, 2015 2:43 am

That's good to know. Thank you for the speedy reply!

Who is online

Users browsing this forum: No registered users and 29 guests

Powered by phpBB ® | phpBB3 Style by KomiDesign
cron