[LBBS-69] net_ssh: SFTP uploads fail with WinSCP

← All Issues || New Issue →

Sort Normal || Priority

Details

WinSCP is doing something that we're not accounting for properly, in that uploads will fail due to a "No such file" error.

Current workaround for WinSCP is not use SFTP and use encrypted FTP instead:

[2024-09-10 14:08:54.831]   DEBUG[3906625]: net_ssh.c:593 subsystem_request: Starting SFTP session on node 5
[2024-09-10 14:08:54.831]   DEBUG[3906625]: net_ssh.c:1379 do_sftp: Starting SFTP session on node 5
[2024-09-10 14:08:54.898]   -- Setting current directory to '/home/bbs/files/home/1'
[2024-09-10 14:08:54.986]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message 16 (REALPATH), client path: .
[2024-09-10 14:08:54.987]   DEBUG[3906625]: net_ssh.c:1410 do_sftp: MAKE PATH(/home/bbs/files/home/1) '.'
[2024-09-10 14:08:54.987]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1' -> user path '/home/interlinked'
[2024-09-10 14:08:54.987]   DEBUG[3906625]: transfer.c:620 __bbs_transfer_set_disk_path_relative: Relative path request: current '/home/interlinked', differential '.'
[2024-09-10 14:08:54.987]   DEBUG[3906625]: transfer.c:499 append_userpath_to_diskpath: Translated username interlinked to user ID 1
[2024-09-10 14:08:54.987]   DEBUG[3906625]: transfer.c:521 append_userpath_to_diskpath: Doesn't end in a slash, adding one
[2024-09-10 14:08:54.987]   DEBUG[3906625]: transfer.c:578 append_userpath_to_diskpath: Removing trailing '/.' from path
[2024-09-10 14:08:54.987]   DEBUG[3906625]: transfer.c:633 __bbs_transfer_set_disk_path_relative: Relative path request: current '/home/interlinked', differential '.' -> '/home/bbs/files/home/1'
[2024-09-10 14:08:54.987]   DEBUG[3906625]: transfer.c:435 __transfer_set_path: disk_path_relative(.) => '/home/bbs/files/home/1'
[2024-09-10 14:08:54.987]   DEBUG[3906625]: net_ssh.c:1410 do_sftp: realpath(/home/bbs/files/home/1) -> /home/bbs/files/home/1
[2024-09-10 14:08:54.988]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1' -> user path '/home/interlinked'
[2024-09-10 14:08:55.090]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message 11 ( OPENDIR), client path: /home/interlinked
[2024-09-10 14:08:55.091]   DEBUG[3906625]: net_ssh.c:1414 do_sftp: MAKE PATH(/home/bbs/files/home/1) '/home/interlinked'
[2024-09-10 14:08:55.091]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1' -> user path '/home/interlinked'
[2024-09-10 14:08:55.091]   DEBUG[3906625]: transfer.c:620 __bbs_transfer_set_disk_path_relative: Relative path request: current '/home/interlinked', differential '/home/interlinked'
[2024-09-10 14:08:55.091]   DEBUG[3906625]: transfer.c:560 append_userpath_to_diskpath: Translated username interlinked to user ID 1
[2024-09-10 14:08:55.091]   DEBUG[3906625]: transfer.c:435 __transfer_set_path: disk_path_absolute(/home/interlinked) => '/home/bbs/files/home/1'
[2024-09-10 14:08:55.091]   DEBUG[3906625]: net_ssh.c:1414 do_sftp: realpath(/home/bbs/files/home/1) -> /home/bbs/files/home/1
[2024-09-10 14:08:55.091]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1' -> user path '/home/interlinked'
[2024-09-10 14:08:55.091]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1' -> user path '/home/interlinked'
[2024-09-10 14:08:55.092]   DEBUG[3906625]: net_ssh.c:1430 do_sftp: Opened user directory '/home/interlinked' (home dir: 0)
[2024-09-10 14:08:55.112]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message 12 ( READDIR), client path: (null)
[2024-09-10 14:08:55.112]   DEBUG[3906625]: net_ssh.c:1088 handle_readdir: Have /home/interlinked/FileZilla_3_setup.exe
[2024-09-10 14:08:55.113]   DEBUG[3906625]: net_ssh.c:1088 handle_readdir: Have /home/interlinked/.config
[2024-09-10 14:08:55.132]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message 12 ( READDIR), client path: (null)
[2024-09-10 14:08:56.316]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message  4 (   CLOSE), client path: (null)
[2024-09-10 14:08:59.299]   DEBUG[3906623]: node.c:1465 node_read_cursor_pos: Incomplete response to cursor position query...
[2024-09-10 14:09:01.762]   -- Node 3 timed out due to inactivity
[2024-09-10 14:09:01.923]   DEBUG[3906277]: mod_smtp_delivery_external.c:1240 run_queue: Processing mail queue (1 message)
[2024-09-10 14:09:01.923]   DEBUG[3906277]: mod_smtp_delivery_external.c:1282 queue_handler: 0/1 message processed: 0 delivered, 0 failed, 0 delayed
[2024-09-10 14:09:03.824]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message  7 (   LSTAT), client path: /home/interlinked/FileZilla_3_setup.exe
[2024-09-10 14:09:03.824]   DEBUG[3906625]: net_ssh.c:1469 do_sftp: MAKE PATH(/home/bbs/files/home/1) '/home/interlinked/FileZilla_3_setup.exe'
[2024-09-10 14:09:03.824]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1' -> user path '/home/interlinked'
[2024-09-10 14:09:03.824]   DEBUG[3906625]: transfer.c:620 __bbs_transfer_set_disk_path_relative: Relative path request: current '/home/interlinked', differential '/home/interlinked/FileZilla_3_setup.exe'
[2024-09-10 14:09:03.824]   DEBUG[3906625]: transfer.c:560 append_userpath_to_diskpath: Translated username interlinked to user ID 1
[2024-09-10 14:09:03.824]   DEBUG[3906625]: transfer.c:435 __transfer_set_path: disk_path_absolute(/home/interlinked/FileZilla_3_setup.exe) => '/home/bbs/files/home/1/FileZilla_3_setup.exe'
[2024-09-10 14:09:03.824]   DEBUG[3906625]: net_ssh.c:1469 do_sftp: realpath(/home/bbs/files/home/1/FileZilla_3_setup.exe) -> /home/bbs/files/home/1/FileZilla_3_setup.exe
[2024-09-10 14:09:03.824]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1/FileZilla_3_setup.exe' -> user path '/home/interlinked/FileZilla_3_setup.exe'
[2024-09-10 14:09:03.844]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message  7 (   LSTAT), client path: /home/interlinked/FileZilla_3_setup.exe.filepart
[2024-09-10 14:09:03.845]   DEBUG[3906625]: net_ssh.c:1469 do_sftp: MAKE PATH(/home/bbs/files/home/1/FileZilla_3_setup.exe) '/home/interlinked/FileZilla_3_setup.exe.filepart'
[2024-09-10 14:09:03.845]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1/FileZilla_3_setup.exe' -> user path '/home/interlinked/FileZilla_3_setup.exe'
[2024-09-10 14:09:03.845]   DEBUG[3906625]: transfer.c:620 __bbs_transfer_set_disk_path_relative: Relative path request: current '/home/interlinked/FileZilla_3_setup.exe', differential '/home/interlinked/FileZilla_3_setup.exe.filepart'
[2024-09-10 14:09:03.845]   DEBUG[3906625]: transfer.c:560 append_userpath_to_diskpath: Translated username interlinked to user ID 1
[2024-09-10 14:09:03.846]   DEBUG[3906625]: transfer.c:427 __transfer_set_path: Path /home/bbs/files/home/1/FileZilla_3_setup.exe.filepart does not exist
[2024-09-10 14:09:03.846]   DEBUG[3906625]: net_ssh.c:917 handle_errno: errno: No such file or directory

[2024-09-10 14:09:05.938]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message  3 (    OPEN), client path: /home/interlinked/FileZilla_3_setup.exe.filepart
[2024-09-10 14:09:05.938]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1/FileZilla_3_setup.exe' -> user path '/home/interlinked/FileZilla_3_setup.exe'
[2024-09-10 14:09:05.938]   DEBUG[3906625]: transfer.c:620 __bbs_transfer_set_disk_path_relative: Relative path request: current '/home/interlinked/FileZilla_3_setup.exe', differential '/home/interlinked/FileZilla_3_setup.exe.filepart'
[2024-09-10 14:09:05.938]   DEBUG[3906625]: transfer.c:560 append_userpath_to_diskpath: Translated username interlinked to user ID 1
[2024-09-10 14:09:05.939]   DEBUG[3906625]: transfer.c:435 __transfer_set_path: disk_path_absolute(/home/interlinked/FileZilla_3_setup.exe.filepart) => '/home/bbs/files/home/1/FileZilla_3_setup.exe.filepart'
[2024-09-10 14:09:05.939]   DEBUG[3906625]: net_ssh.c:1438 do_sftp: Path '/home/bbs/files/home/1/FileZilla_3_setup.exe.filepart' not found: No such file or directory
[2024-09-10 14:09:05.939]   DEBUG[3906625]: net_ssh.c:917 handle_errno: errno: No such file or directory
[2024-09-10 14:09:05.958]   DEBUG[3906625]: net_ssh.c:1407 do_sftp: Got SFTP client message  7 (   LSTAT), client path: /home/interlinked/FileZilla_3_setup.exe.filepart
[2024-09-10 14:09:05.958]   DEBUG[3906625]: net_ssh.c:1469 do_sftp: MAKE PATH(/home/bbs/files/home/1/FileZilla_3_setup.exe.filepart) '/home/interlinked/FileZilla_3_setup.exe.filepart'
[2024-09-10 14:09:05.958]   DEBUG[3906625]: transfer.c:361 bbs_transfer_get_user_path: Translated disk path '/home/bbs/files/home/1/FileZilla_3_setup.exe.filepart' -> user path '/home/interlinked/FileZilla_3_setup.exe.filepart'
[2024-09-10 14:09:05.958]   DEBUG[3906625]: transfer.c:620 __bbs_transfer_set_disk_path_relative: Relative path request: current '/home/interlinked/FileZilla_3_setup.exe.filepart', differential '/home/interlinked/FileZilla_3_setup.exe.filepart'
[2024-09-10 14:09:05.958]   DEBUG[3906625]: transfer.c:560 append_userpath_to_diskpath: Translated username interlinked to user ID 1
[2024-09-10 14:09:05.959]   DEBUG[3906625]: transfer.c:427 __transfer_set_path: Path /home/bbs/files/home/1/FileZilla_3_setup.exe.filepart does not exist
[2024-09-10 14:09:05.959]   DEBUG[3906625]: net_ssh.c:917 handle_errno: errno: No such file or directory
[2024-09-10 14:09:09.209]   -- Node 4 timed out due to inactivity

Comments

You must be logged in to leave a comment.