"./gitannex.test -test.v -test.timeout 1h0m0s -remote TestSFTPRsyncNet: -verbose -test.run '^TestGitAnnexFstestBackendCases$/^(TransferStoreAbsolute|TransferStorePathWithInteriorWhitespace|TransferStoreRelative)$'" - Starting (try 2/5) 2025/10/11 01:06:32 DEBUG : Creating backend with remote "TestSFTPRsyncNet:rclone-test-yaxopuc8gewe" 2025/10/11 01:06:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/11 01:06:33 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: New connection [2a01:4f9:c011:405e::1]:37982->[2001:470:1:eb::9]:22 to "SSH-2.0-OpenSSH_9.9-hpn14v15 FreeBSD-openssh-portable-9.9.p1_1,1" 2025/10/11 01:06:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell type "unix" from config 2025/10/11 01:06:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Relative path resolved to "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:06:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Using root directory "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:06:34 DEBUG : Creating backend with remote "/tmp/rclone228164231" === RUN TestGitAnnexFstestBackendCases === RUN TestGitAnnexFstestBackendCases/TransferStoreAbsolute run.go:180: Remote "sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe", Local "Local file system at /tmp/rclone228164231", Modify Window "1s" 2025/10/11 01:06:34 DEBUG : Creating backend with remote "TestSFTPRsyncNet:rclone-test-yaxopuc8gewe" 2025/10/11 01:06:35 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: New connection [2a01:4f9:c011:405e::1]:37992->[2001:470:1:eb::9]:22 to "SSH-2.0-OpenSSH_9.9-hpn14v15 FreeBSD-openssh-portable-9.9.p1_1,1" 2025/10/11 01:06:35 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell type "unix" from config 2025/10/11 01:06:36 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Relative path resolved to "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:06:36 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Using root directory "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:06:36 DEBUG : Creating backend with remote "/tmp/rclone228164231" 2025/10/11 01:06:36 DEBUG : file.txt: Need to transfer - File not found at Destination gitannex_test.go:307: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:307 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:990 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Received unexpected error: attempt to read line timed out: context deadline exceeded Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute 2025/10/11 01:07:07 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell path "/data2/home/59018/rclone-test-yaxopuc8gewe/KeyAbsolute.b4a1b9a0.partial" 2025/10/11 01:07:07 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Running remote command: md5 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyAbsolute.b4a1b9a0.partial 2025/10/11 01:07:14 ERROR : KeyAbsolute.b4a1b9a0.partial: Failed to calculate dst hash: failed to calculate md5 hash: failed to run "md5 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyAbsolute.b4a1b9a0.partial": md5: /data2/home/59018/rclone-test-yaxopuc8gewe/KeyAbsolute.b4a1b9a0.partial: No such file or directory: Process exited with status 1 2025/10/11 01:07:14 ERROR : KeyAbsolute.b4a1b9a0.partial: corrupted on transfer: md5 hashes differ src(Local file system at /tmp/rclone228164231) "eb61eead90e3b899c6bcbe27ac581660" vs dst(sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe) "" 2025/10/11 01:07:14 INFO : KeyAbsolute.b4a1b9a0.partial: Removing failed copy 2025/10/11 01:07:14 INFO : KeyAbsolute.b4a1b9a0.partial: Failed to remove failed copy: remove /data2/home/59018/rclone-test-yaxopuc8gewe/KeyAbsolute.b4a1b9a0.partial: file does not exist 2025/10/11 01:07:21 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Closing 1 unused connections === RUN TestGitAnnexFstestBackendCases/TransferStoreRelative run.go:180: Remote "sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe", Local "Local file system at /tmp/rclone228164231", Modify Window "1s" 2025/10/11 01:07:23 DEBUG : Creating backend with remote "TestSFTPRsyncNet:rclone-test-yaxopuc8gewe" 2025/10/11 01:07:24 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: New connection [2a01:4f9:c011:405e::1]:42306->[2001:470:1:eb::9]:22 to "SSH-2.0-OpenSSH_9.9-hpn14v15 FreeBSD-openssh-portable-9.9.p1_1,1" 2025/10/11 01:07:24 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell type "unix" from config 2025/10/11 01:07:24 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Relative path resolved to "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:07:25 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Using root directory "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:07:25 DEBUG : Creating backend with remote "../../rclone228164231" 2025/10/11 01:07:25 DEBUG : fs cache: renaming cache item "../../rclone228164231" to be canonical "/tmp/rclone228164231" 2025/10/11 01:07:25 DEBUG : file.txt: Need to transfer - File not found at Destination 2025/10/11 01:07:26 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell path "/data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative.8f91c0cd.partial" 2025/10/11 01:07:26 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Running remote command: md5 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative.8f91c0cd.partial 2025/10/11 01:07:26 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Remote command result: eb61eead90e3b899c6bcbe27ac581660 /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative.8f91c0cd.partial 2025/10/11 01:07:26 DEBUG : KeyRelative.8f91c0cd.partial: Parsed hash: eb61eead90e3b899c6bcbe27ac581660 2025/10/11 01:07:26 DEBUG : file.txt: md5 = eb61eead90e3b899c6bcbe27ac581660 OK 2025/10/11 01:07:26 DEBUG : KeyRelative.8f91c0cd.partial: renamed to: KeyRelative 2025/10/11 01:07:26 INFO : file.txt: Copied (new) to: KeyRelative 2025/10/11 01:07:27 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell path "/data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative" 2025/10/11 01:07:27 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Running remote command: md5 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:27 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Remote command result: eb61eead90e3b899c6bcbe27ac581660 /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:27 DEBUG : KeyRelative: Parsed hash: eb61eead90e3b899c6bcbe27ac581660 2025/10/11 01:07:27 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell path "/data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative" 2025/10/11 01:07:27 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Running remote command: sha1 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:27 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Remote command result: c65f99f8c5376adadddc46d5cbcf5762f9e55eb7 /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:27 DEBUG : KeyRelative: Parsed hash: c65f99f8c5376adadddc46d5cbcf5762f9e55eb7 2025/10/11 01:07:29 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Closing 1 unused connections === RUN TestGitAnnexFstestBackendCases/TransferStorePathWithInteriorWhitespace run.go:180: Remote "sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe", Local "Local file system at /tmp/rclone228164231", Modify Window "1s" 2025/10/11 01:07:30 DEBUG : Creating backend with remote "TestSFTPRsyncNet:rclone-test-yaxopuc8gewe" 2025/10/11 01:07:31 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: New connection [2a01:4f9:c011:405e::1]:54392->[2001:470:1:eb::9]:22 to "SSH-2.0-OpenSSH_9.9-hpn14v15 FreeBSD-openssh-portable-9.9.p1_1,1" 2025/10/11 01:07:32 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell type "unix" from config 2025/10/11 01:07:32 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Relative path resolved to "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:07:32 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Using root directory "/data2/home/59018/rclone-test-yaxopuc8gewe" 2025/10/11 01:07:32 DEBUG : Creating backend with remote "../../rclone228164231" 2025/10/11 01:07:32 DEBUG : fs cache: renaming cache item "../../rclone228164231" to be canonical "/tmp/rclone228164231" 2025/10/11 01:07:32 DEBUG : filename with spaces.txt: Need to transfer - File not found at Destination 2025/10/11 01:07:33 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell path "/data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative.c9713c70.partial" 2025/10/11 01:07:33 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Running remote command: md5 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative.c9713c70.partial 2025/10/11 01:07:33 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Remote command result: eb61eead90e3b899c6bcbe27ac581660 /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative.c9713c70.partial 2025/10/11 01:07:33 DEBUG : KeyRelative.c9713c70.partial: Parsed hash: eb61eead90e3b899c6bcbe27ac581660 2025/10/11 01:07:33 DEBUG : filename with spaces.txt: md5 = eb61eead90e3b899c6bcbe27ac581660 OK 2025/10/11 01:07:33 DEBUG : KeyRelative.c9713c70.partial: renamed to: KeyRelative 2025/10/11 01:07:33 INFO : filename with spaces.txt: Copied (new) to: KeyRelative 2025/10/11 01:07:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell path "/data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative" 2025/10/11 01:07:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Running remote command: md5 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Remote command result: eb61eead90e3b899c6bcbe27ac581660 /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:34 DEBUG : KeyRelative: Parsed hash: eb61eead90e3b899c6bcbe27ac581660 2025/10/11 01:07:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Shell path "/data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative" 2025/10/11 01:07:34 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Running remote command: sha1 -r /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:35 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Remote command result: c65f99f8c5376adadddc46d5cbcf5762f9e55eb7 /data2/home/59018/rclone-test-yaxopuc8gewe/KeyRelative 2025/10/11 01:07:35 DEBUG : KeyRelative: Parsed hash: c65f99f8c5376adadddc46d5cbcf5762f9e55eb7 2025/10/11 01:07:36 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Closing 1 unused connections --- FAIL: TestGitAnnexFstestBackendCases (63.45s) --- FAIL: TestGitAnnexFstestBackendCases/TransferStoreAbsolute (48.67s) --- PASS: TestGitAnnexFstestBackendCases/TransferStoreRelative (7.53s) --- PASS: TestGitAnnexFstestBackendCases/TransferStorePathWithInteriorWhitespace (7.25s) FAIL 2025/10/11 01:07:38 DEBUG : sftp://59018@usw-s009.rsync.net:22/rclone-test-yaxopuc8gewe: Purge dir "" "./gitannex.test -test.v -test.timeout 1h0m0s -remote TestSFTPRsyncNet: -verbose -test.run '^TestGitAnnexFstestBackendCases$/^(TransferStoreAbsolute|TransferStorePathWithInteriorWhitespace|TransferStoreRelative)$'" - Finished ERROR in 1m6.881990114s (try 2/5): exit status 1: Failed [TestGitAnnexFstestBackendCases/TransferStoreAbsolute]