Error Code 3 "Permission Denied" when using WinSCP 5.13 with BizTalk 2016
Hello
I continue to get the Error Code 3 message in the Windows Log when I attempt to use SFTP to send a file using BizTalk 2016.
However if I go to the BizTalk Server folder and run WinSCP itself on the same server I can connect and upload a file to the target server without issue. Any ideas as to what I am missing.
Log snippet below:
. 2019-08-22 18:04:28.713 Using stored password.
. 2019-08-22 18:04:28.713 Sent password
. 2019-08-22 18:04:28.760 Access granted
. 2019-08-22 18:04:28.760 Opening session as main channel
. 2019-08-22 18:04:28.900 Opened main channel
. 2019-08-22 18:04:29.010 Started a shell/command
. 2019-08-22 18:04:29.010 --------------------------------------------------------------------------
. 2019-08-22 18:04:29.010 Using SFTP protocol.
. 2019-08-22 18:04:29.010 Doing startup conversation with host.
> 2019-08-22 18:04:29.010 Type: SSH_FXP_INIT, Size: 5, Number: -1
< 2019-08-22 18:04:29.041 Type: SSH_FXP_VERSION, Size: 5, Number: -1
. 2019-08-22 18:04:29.041 SFTP version 3 negotiated.
. 2019-08-22 18:04:29.041 We believe the server has signed timestamps bug
. 2019-08-22 18:04:29.041 We will use UTF-8 strings until server sends an invalid UTF-8 string as with SFTP version 3 and older UTF-8 strings are not mandatory
. 2019-08-22 18:04:29.041 Limiting packet size to OpenSSH sftp-server limit of 262148 bytes
. 2019-08-22 18:04:29.041 Getting current directory name.
. 2019-08-22 18:04:29.041 Getting real path for '.'
> 2019-08-22 18:04:29.041 Type: SSH_FXP_REALPATH, Size: 10, Number: 16
< 2019-08-22 18:04:29.072 Type: SSH_FXP_NAME, Size: 55, Number: 16
. 2019-08-22 18:04:29.072 Real path is '/home/hennegan/in'
. 2019-08-22 18:04:29.072 Startup conversation with host finished.
< 2019-08-22 18:04:29.072 Script: Active session: [1] hennegan@216.207.192.42
> 2019-08-22 18:04:29.103 Script: pwd
< 2019-08-22 18:04:29.103 Script: /home/hennegan/in
> 2019-08-22 18:04:29.182 Script: put -delete -nopermissions -nopreservetime -transfer="binary" -resumesupport="off" -- "C:\Users\DPCSBTSIHOST\AppData\Local\Temp\60e72764-2fdb-4365-a36a-87ab37d18151\ASN_201908221104277.csv" "/ASN_201908221104277.csv"
. 2019-08-22 18:04:29.182 Copying 1 files/directories to remote directory "/" - total size: 94
. 2019-08-22 18:04:29.182 PrTime: No; PrRO: No; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 0100; Resume: N (102400); CalcS: No; Mask: ASN_201908221104277.csv
. 2019-08-22 18:04:29.182 TM: B; ClAr: No; RemEOF: No; RemBOM: No; CPS: 0; NewerOnly: No; InclM: ; ResumeL: 0
. 2019-08-22 18:04:29.182 AscM: *.*html; *.htm; *.txt; *.php; *.php3; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; *.js; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
. 2019-08-22 18:04:29.182 Getting real path for '/'
> 2019-08-22 18:04:29.182 Type: SSH_FXP_REALPATH, Size: 10, Number: 272
< 2019-08-22 18:04:29.228 Type: SSH_FXP_NAME, Size: 23, Number: 272
. 2019-08-22 18:04:29.228 Real path is '/'
. 2019-08-22 18:04:29.228 File: 'C:\Users\DPCSBTSIHOST\AppData\Local\Temp\60e72764-2fdb-4365-a36a-87ab37d18151\ASN_201908221104277.csv' [2019-08-22T23:04:29.166Z] [94]
. 2019-08-22 18:04:29.228 Copying "C:\Users\DPCSBTSIHOST\AppData\Local\Temp\60e72764-2fdb-4365-a36a-87ab37d18151\ASN_201908221104277.csv" to remote directory started.
. 2019-08-22 18:04:29.228 Binary transfer mode selected.
. 2019-08-22 18:04:29.228 Opening remote file.
> 2019-08-22 18:04:29.228 Type: SSH_FXP_OPEN, Size: 49, Number: 515
< 2019-08-22 18:04:29.260 Type: SSH_FXP_STATUS, Size: 34, Number: 515
< 2019-08-22 18:04:29.260 Status code: 3, Message: 515, Server: Permission denied, Language:
> 2019-08-22 18:04:29.260 Type: SSH_FXP_LSTAT, Size: 33, Number: 775
< 2019-08-22 18:04:29.291 Type: SSH_FXP_STATUS, Size: 29, Number: 775
< 2019-08-22 18:04:29.291 Status code: 2, Message: 775, Server: No such file, Language:
* 2019-08-22 18:04:29.291 (ETerminal) Permission denied.
* 2019-08-22 18:04:29.291 Error code: 3
* 2019-08-22 18:04:29.291 Error message from server: Permission denied
. 2019-08-22 18:04:29.291 Asking user:
. 2019-08-22 18:04:29.291 Cannot create remote file '/ASN_201908221104277.csv'. ("Permission denied.
. 2019-08-22 18:04:29.291 Error code: 3
. 2019-08-22 18:04:29.291 Error message from server: Permission denied")
< 2019-08-22 18:04:29.291 Script: Cannot create remote file '/ASN_201908221104277.csv'.
< 2019-08-22 18:04:29.291 Script: Permission denied.
< 2019-08-22 18:04:29.291 Error code: 3
< 2019-08-22 18:04:29.291 Error message from server: Permission denied
* 2019-08-22 18:04:29.291 (ESkipFile) Cannot create remote file '/ASN_201908221104277.csv'.
* 2019-08-22 18:04:29.291 Permission denied.
* 2019-08-22 18:04:29.291 Error code: 3
* 2019-08-22 18:04:29.291 Error message from server: Permission denied
. 2019-08-22 18:04:29.291 Copying finished: Transferred: 0, Elapsed: 0:00:00, CPS: 0/s
. 2019-08-22 18:04:29.291 Script: Failed
I continue to get the Error Code 3 message in the Windows Log when I attempt to use SFTP to send a file using BizTalk 2016.
However if I go to the BizTalk Server folder and run WinSCP itself on the same server I can connect and upload a file to the target server without issue. Any ideas as to what I am missing.
Log snippet below:
. 2019-08-22 18:04:28.713 Using stored password.
. 2019-08-22 18:04:28.713 Sent password
. 2019-08-22 18:04:28.760 Access granted
. 2019-08-22 18:04:28.760 Opening session as main channel
. 2019-08-22 18:04:28.900 Opened main channel
. 2019-08-22 18:04:29.010 Started a shell/command
. 2019-08-22 18:04:29.010 --------------------------------------------------------------------------
. 2019-08-22 18:04:29.010 Using SFTP protocol.
. 2019-08-22 18:04:29.010 Doing startup conversation with host.
> 2019-08-22 18:04:29.010 Type: SSH_FXP_INIT, Size: 5, Number: -1
< 2019-08-22 18:04:29.041 Type: SSH_FXP_VERSION, Size: 5, Number: -1
. 2019-08-22 18:04:29.041 SFTP version 3 negotiated.
. 2019-08-22 18:04:29.041 We believe the server has signed timestamps bug
. 2019-08-22 18:04:29.041 We will use UTF-8 strings until server sends an invalid UTF-8 string as with SFTP version 3 and older UTF-8 strings are not mandatory
. 2019-08-22 18:04:29.041 Limiting packet size to OpenSSH sftp-server limit of 262148 bytes
. 2019-08-22 18:04:29.041 Getting current directory name.
. 2019-08-22 18:04:29.041 Getting real path for '.'
> 2019-08-22 18:04:29.041 Type: SSH_FXP_REALPATH, Size: 10, Number: 16
< 2019-08-22 18:04:29.072 Type: SSH_FXP_NAME, Size: 55, Number: 16
. 2019-08-22 18:04:29.072 Real path is '/home/hennegan/in'
. 2019-08-22 18:04:29.072 Startup conversation with host finished.
< 2019-08-22 18:04:29.072 Script: Active session: [1] hennegan@216.207.192.42
> 2019-08-22 18:04:29.103 Script: pwd
< 2019-08-22 18:04:29.103 Script: /home/hennegan/in
> 2019-08-22 18:04:29.182 Script: put -delete -nopermissions -nopreservetime -transfer="binary" -resumesupport="off" -- "C:\Users\DPCSBTSIHOST\AppData\Local\Temp\60e72764-2fdb-4365-a36a-87ab37d18151\ASN_201908221104277.csv" "/ASN_201908221104277.csv"
. 2019-08-22 18:04:29.182 Copying 1 files/directories to remote directory "/" - total size: 94
. 2019-08-22 18:04:29.182 PrTime: No; PrRO: No; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 0100; Resume: N (102400); CalcS: No; Mask: ASN_201908221104277.csv
. 2019-08-22 18:04:29.182 TM: B; ClAr: No; RemEOF: No; RemBOM: No; CPS: 0; NewerOnly: No; InclM: ; ResumeL: 0
. 2019-08-22 18:04:29.182 AscM: *.*html; *.htm; *.txt; *.php; *.php3; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; *.js; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
. 2019-08-22 18:04:29.182 Getting real path for '/'
> 2019-08-22 18:04:29.182 Type: SSH_FXP_REALPATH, Size: 10, Number: 272
< 2019-08-22 18:04:29.228 Type: SSH_FXP_NAME, Size: 23, Number: 272
. 2019-08-22 18:04:29.228 Real path is '/'
. 2019-08-22 18:04:29.228 File: 'C:\Users\DPCSBTSIHOST\AppData\Local\Temp\60e72764-2fdb-4365-a36a-87ab37d18151\ASN_201908221104277.csv' [2019-08-22T23:04:29.166Z] [94]
. 2019-08-22 18:04:29.228 Copying "C:\Users\DPCSBTSIHOST\AppData\Local\Temp\60e72764-2fdb-4365-a36a-87ab37d18151\ASN_201908221104277.csv" to remote directory started.
. 2019-08-22 18:04:29.228 Binary transfer mode selected.
. 2019-08-22 18:04:29.228 Opening remote file.
> 2019-08-22 18:04:29.228 Type: SSH_FXP_OPEN, Size: 49, Number: 515
< 2019-08-22 18:04:29.260 Type: SSH_FXP_STATUS, Size: 34, Number: 515
< 2019-08-22 18:04:29.260 Status code: 3, Message: 515, Server: Permission denied, Language:
> 2019-08-22 18:04:29.260 Type: SSH_FXP_LSTAT, Size: 33, Number: 775
< 2019-08-22 18:04:29.291 Type: SSH_FXP_STATUS, Size: 29, Number: 775
< 2019-08-22 18:04:29.291 Status code: 2, Message: 775, Server: No such file, Language:
* 2019-08-22 18:04:29.291 (ETerminal) Permission denied.
* 2019-08-22 18:04:29.291 Error code: 3
* 2019-08-22 18:04:29.291 Error message from server: Permission denied
. 2019-08-22 18:04:29.291 Asking user:
. 2019-08-22 18:04:29.291 Cannot create remote file '/ASN_201908221104277.csv'. ("Permission denied.
. 2019-08-22 18:04:29.291 Error code: 3
. 2019-08-22 18:04:29.291 Error message from server: Permission denied")
< 2019-08-22 18:04:29.291 Script: Cannot create remote file '/ASN_201908221104277.csv'.
< 2019-08-22 18:04:29.291 Script: Permission denied.
< 2019-08-22 18:04:29.291 Error code: 3
< 2019-08-22 18:04:29.291 Error message from server: Permission denied
* 2019-08-22 18:04:29.291 (ESkipFile) Cannot create remote file '/ASN_201908221104277.csv'.
* 2019-08-22 18:04:29.291 Permission denied.
* 2019-08-22 18:04:29.291 Error code: 3
* 2019-08-22 18:04:29.291 Error message from server: Permission denied
. 2019-08-22 18:04:29.291 Copying finished: Transferred: 0, Elapsed: 0:00:00, CPS: 0/s
. 2019-08-22 18:04:29.291 Script: Failed
