"./sync.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestBase64|TestCopyAfterDelete|TestManualTransformFile|TestServerSideMoveOverSelf|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestTransformFile)$'" - Starting (try 2/5) 2025/09/04 04:21:59 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-culijeg2baki" 2025/09/04 04:21:59 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/04 04:22:00 DEBUG : Creating backend with remote "/tmp/rclone2049511485" === RUN TestServerSideMoveOverSelf run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" 2025/09/04 04:22:03 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-vomazoz4wuge" sync_test.go:701: Server side copy (if possible) files root 'rclone-test-culijeg2baki' -> files root 'rclone-test-vomazoz4wuge' 2025/09/04 04:22:04 DEBUG : Added delayed dir = "sub dir", newDst= 2025/09/04 04:22:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/04 04:22:05 DEBUG : files root 'rclone-test-vomazoz4wuge': Waiting for checks to finish 2025/09/04 04:22:05 DEBUG : files root 'rclone-test-vomazoz4wuge': Waiting for transfers to finish 2025/09/04 04:22:07 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/09/04 04:22:07 INFO : sub dir/hello world: Copied (server-side copy) 2025/09/04 04:22:08 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:10 DEBUG : files root 'rclone-test-vomazoz4wuge': Using server-side directory move 2025/09/04 04:22:11 INFO : files root 'rclone-test-vomazoz4wuge': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/04 04:22:11 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:11 DEBUG : Added delayed dir = "sub dir", newDst=sub dir 2025/09/04 04:22:11 DEBUG : files root 'rclone-test-vomazoz4wuge': Waiting for checks to finish 2025/09/04 04:22:11 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/04 04:22:11 DEBUG : files root 'rclone-test-vomazoz4wuge': Waiting for transfers to finish 2025/09/04 04:22:12 INFO : sub dir/hello world: Deleted 2025/09/04 04:22:12 INFO : sub dir/hello world: Moved (server-side) 2025/09/04 04:22:12 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:14 DEBUG : testing file moves 2025/09/04 04:22:14 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:14 DEBUG : Added delayed dir = "sub dir", newDst=sub dir 2025/09/04 04:22:15 DEBUG : files root 'rclone-test-vomazoz4wuge': Waiting for checks to finish 2025/09/04 04:22:15 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/09/04 04:22:15 DEBUG : files root 'rclone-test-vomazoz4wuge': Waiting for transfers to finish 2025/09/04 04:22:15 INFO : sub dir/hello world: Deleted 2025/09/04 04:22:15 INFO : sub dir/hello world: Moved (server-side) 2025/09/04 04:22:15 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:16 DEBUG : files root 'rclone-test-vomazoz4wuge': Purge remote --- PASS: TestServerSideMoveOverSelf (16.52s) === RUN TestCopyAfterDelete run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" 2025/09/04 04:22:18 ERROR : error listing: directory not found 2025/09/04 04:22:18 INFO : Local file system at /tmp/rclone2049511485: Making directory 2025/09/04 04:22:18 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for checks to finish 2025/09/04 04:22:18 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for transfers to finish --- PASS: TestCopyAfterDelete (2.42s) === RUN TestSyncWithTrackRenames run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/04 04:22:20 INFO : files root 'rclone-test-culijeg2baki': Making map for --track-renames 2025/09/04 04:22:20 INFO : files root 'rclone-test-culijeg2baki': Finished making map for --track-renames 2025/09/04 04:22:20 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for checks to finish 2025/09/04 04:22:20 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for renames to finish 2025/09/04 04:22:20 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/04 04:22:20 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/04 04:22:20 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for transfers to finish 2025/09/04 04:22:20 DEBUG : potato: Dst hash empty - aborting Src hash check 2025/09/04 04:22:20 INFO : potato: Copied (new) 2025/09/04 04:22:20 DEBUG : yam: Dst hash empty - aborting Src hash check 2025/09/04 04:22:20 INFO : yam: Copied (new) 2025/09/04 04:22:20 DEBUG : Waiting for deletions to finish 2025/09/04 04:22:21 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/04 04:22:21 INFO : files root 'rclone-test-culijeg2baki': Making map for --track-renames 2025/09/04 04:22:21 INFO : files root 'rclone-test-culijeg2baki': Finished making map for --track-renames 2025/09/04 04:22:21 DEBUG : potato: Unchanged skipping 2025/09/04 04:22:21 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for checks to finish 2025/09/04 04:22:21 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for renames to finish 2025/09/04 04:22:21 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/04 04:22:21 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for transfers to finish 2025/09/04 04:22:22 DEBUG : yaml: Dst hash empty - aborting Src hash check 2025/09/04 04:22:22 INFO : yaml: Copied (new) 2025/09/04 04:22:22 DEBUG : Waiting for deletions to finish 2025/09/04 04:22:22 INFO : yam: Deleted sync_test.go:1594: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1594 Error: Not equal: expected: true actual : false Test: TestSyncWithTrackRenames Messages: canTrackRenames=true, renames=0 --- FAIL: TestSyncWithTrackRenames (3.06s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" 2025/09/04 04:22:25 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-culijeg2baki/dst" 2025/09/04 04:22:26 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-culijeg2baki/backup" 2025/09/04 04:22:27 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/04 04:22:27 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for checks to finish 2025/09/04 04:22:27 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/04 04:22:27 DEBUG : two: Unchanged skipping 2025/09/04 04:22:28 INFO : one: Moved (server-side) to: one-2019-01-01 2025/09/04 04:22:28 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for transfers to finish 2025/09/04 04:22:30 DEBUG : one: Dst hash empty - aborting Src hash check 2025/09/04 04:22:30 INFO : one: Copied (new) 2025/09/04 04:22:30 DEBUG : Waiting for deletions to finish 2025/09/04 04:22:31 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/09/04 04:22:31 INFO : three.txt: Moved into backup dir 2025/09/04 04:22:33 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/09/04 04:22:33 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for checks to finish 2025/09/04 04:22:33 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/04 04:22:33 DEBUG : two: Unchanged skipping 2025/09/04 04:22:34 INFO : one-2019-01-01: Deleted 2025/09/04 04:22:34 INFO : one: Moved (server-side) to: one-2019-01-01 2025/09/04 04:22:34 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for transfers to finish 2025/09/04 04:22:36 DEBUG : one: Dst hash empty - aborting Src hash check 2025/09/04 04:22:36 INFO : one: Copied (new) 2025/09/04 04:22:36 DEBUG : Waiting for deletions to finish 2025/09/04 04:22:36 INFO : three-2019-01-01.txt: Deleted 2025/09/04 04:22:36 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/09/04 04:22:36 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (16.87s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" 2025/09/04 04:22:42 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-culijeg2baki/dst" 2025/09/04 04:22:43 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/04 04:22:43 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for checks to finish 2025/09/04 04:22:43 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/04 04:22:43 DEBUG : two: Unchanged skipping 2025/09/04 04:22:45 INFO : one: Moved (server-side) to: one.bak 2025/09/04 04:22:45 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for transfers to finish 2025/09/04 04:22:46 DEBUG : one: Dst hash empty - aborting Src hash check 2025/09/04 04:22:46 INFO : one: Copied (new) 2025/09/04 04:22:46 DEBUG : Waiting for deletions to finish 2025/09/04 04:22:47 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/09/04 04:22:47 INFO : three.txt: Moved into backup dir 2025/09/04 04:22:50 DEBUG : one.bak: Excluded (Path Filter) 2025/09/04 04:22:50 DEBUG : one.bak: Excluded 2025/09/04 04:22:50 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/09/04 04:22:50 DEBUG : three.txt.bak: Excluded 2025/09/04 04:22:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/09/04 04:22:50 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/04 04:22:50 DEBUG : two: Unchanged skipping 2025/09/04 04:22:50 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for checks to finish 2025/09/04 04:22:50 INFO : one.bak: Deleted 2025/09/04 04:22:51 INFO : one: Moved (server-side) to: one.bak 2025/09/04 04:22:51 DEBUG : files root 'rclone-test-culijeg2baki/dst': Waiting for transfers to finish 2025/09/04 04:22:52 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/09/04 04:22:52 INFO : one: Copied (new) 2025/09/04 04:22:52 DEBUG : Waiting for deletions to finish 2025/09/04 04:22:53 INFO : three.txt.bak: Deleted 2025/09/04 04:22:53 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/09/04 04:22:53 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (16.82s) === RUN TestTransformFile run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" 2025/09/04 04:22:56 DEBUG : empty_dir: Making directory with metadata 2025/09/04 04:22:56 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/09/04 04:22:56 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:22:56 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:22:56 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:22:56 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:22:56 INFO : tictacempty_dir: Making directory 2025/09/04 04:22:57 INFO : tictacempty_dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC 2025/09/04 04:22:57 DEBUG : Added delayed dir = "tictacempty_dir", newDst= 2025/09/04 04:22:57 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:22:57 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:22:57 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:22:57 INFO : tictactoe: Making directory 2025/09/04 04:22:57 INFO : tictactoe: Made directory with modification time 2025-09-04 04:22:56.677371828 +0000 UTC 2025/09/04 04:22:57 DEBUG : Added delayed dir = "tictactoe", newDst= 2025/09/04 04:22:57 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:22:57 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:22:57 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/04 04:22:57 INFO : tictactoe/tictactoe: Making directory 2025/09/04 04:22:57 INFO : tictactoe/tictactoe: Made directory with modification time 2025-09-04 04:22:56.677371828 +0000 UTC 2025/09/04 04:22:57 DEBUG : Added delayed dir = "tictactoe/tictactoe", newDst= 2025/09/04 04:22:57 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/04 04:22:57 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/09/04 04:22:57 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:22:57 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/04 04:22:57 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:22:57 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:22:57 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for checks to finish 2025/09/04 04:22:57 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for transfers to finish 2025/09/04 04:22:58 DEBUG : tictactoe/tictactoe/tictactoe.txt: Dst hash empty - aborting Src hash check 2025/09/04 04:22:58 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:22:58 INFO : toe/toe/toe.txt: Deleted 2025/09/04 04:22:58 INFO : tictactoe/tictactoe: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:59 INFO : tictactoe: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:59 INFO : tictacempty_dir: Set directory modification time (using DirSetModTime) 2025/09/04 04:22:59 INFO : toe/toe: Removing directory 2025/09/04 04:22:59 INFO : toe: Removing directory 2025/09/04 04:22:59 INFO : empty_dir: Removing directory 2025/09/04 04:22:59 DEBUG : Local file system at /tmp/rclone2049511485: deleted 3 directories 2025/09/04 04:22:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/04 04:22:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/09/04 04:22:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/09/04 04:22:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/09/04 04:23:00 INFO : tictactoe/tictactoe/tictactoe.txt: Moved (server-side) to: toe/toe/toe.txt 2025/09/04 04:23:02 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-culijeg2baki/tictactoe not empty`) 2025/09/04 04:23:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/09/04 04:23:02 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-culijeg2baki/tictactoe not empty`) 2025/09/04 04:23:02 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/09/04 04:23:02 DEBUG : pacer: low level retry 3/10 (error Folder Not Empty - `Folder rclone-test-culijeg2baki/tictactoe not empty`) 2025/09/04 04:23:02 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/09/04 04:23:02 DEBUG : pacer: low level retry 4/10 (error Folder Not Empty - `Folder rclone-test-culijeg2baki/tictactoe not empty`) 2025/09/04 04:23:02 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/09/04 04:23:02 DEBUG : pacer: Reducing sleep to 120ms 2025/09/04 04:23:02 DEBUG : pacer: Reducing sleep to 90ms 2025/09/04 04:23:02 DEBUG : pacer: Reducing sleep to 67.5ms --- PASS: TestTransformFile (6.30s) === RUN TestManualTransformFile run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" 2025/09/04 04:23:02 DEBUG : Reset feature "Copy" 2025/09/04 04:23:02 DEBUG : Reset feature "Move" 2025/09/04 04:23:02 DEBUG : Reset feature "Copy" 2025/09/04 04:23:02 DEBUG : Reset feature "Move" 2025/09/04 04:23:02 DEBUG : empty_dir: Making directory with metadata 2025/09/04 04:23:02 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/09/04 04:23:02 DEBUG : pacer: Reducing sleep to 50.625ms 2025/09/04 04:23:02 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:23:02 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:23:02 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:23:03 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:23:03 INFO : tictacempty_dir: Making directory 2025/09/04 04:23:03 DEBUG : pacer: Reducing sleep to 37.96875ms 2025/09/04 04:23:03 DEBUG : pacer: Reducing sleep to 28.476562ms 2025/09/04 04:23:03 INFO : tictacempty_dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC 2025/09/04 04:23:03 DEBUG : Added delayed dir = "tictacempty_dir", newDst= 2025/09/04 04:23:03 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/04 04:23:03 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:23:03 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:23:03 INFO : tictactoe: Making directory 2025/09/04 04:23:03 DEBUG : pacer: Reducing sleep to 21.357421ms 2025/09/04 04:23:03 DEBUG : pacer: Reducing sleep to 16.018065ms 2025/09/04 04:23:03 INFO : tictactoe: Made directory with modification time 2025-09-04 04:23:02.973389515 +0000 UTC 2025/09/04 04:23:03 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:23:03 DEBUG : toe: transformed to: tictactoe 2025/09/04 04:23:03 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/04 04:23:03 INFO : tictactoe/tictactoe: Making directory 2025/09/04 04:23:03 DEBUG : pacer: Reducing sleep to 12.013548ms 2025/09/04 04:23:04 DEBUG : pacer: Reducing sleep to 10ms 2025/09/04 04:23:04 INFO : tictactoe/tictactoe: Made directory with modification time 2025-09-04 04:23:02.973389515 +0000 UTC 2025/09/04 04:23:04 DEBUG : Added delayed dir = "tictactoe/tictactoe", newDst= 2025/09/04 04:23:04 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/04 04:23:04 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/09/04 04:23:04 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:23:04 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/04 04:23:04 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for checks to finish 2025/09/04 04:23:04 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:23:04 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for transfers to finish 2025/09/04 04:23:04 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:23:04 DEBUG : tictactoe/tictactoe/tictactoe.txt: Dst hash empty - aborting Src hash check 2025/09/04 04:23:04 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/09/04 04:23:04 INFO : toe/toe/toe.txt: Deleted 2025/09/04 04:23:04 INFO : tictactoe/tictactoe: Set directory modification time (using DirSetModTime) 2025/09/04 04:23:05 ERROR : tictacempty_dir: Failed to update directory timestamp or metadata: Not Found - `Not Found. This may be related to your permissions.` 2025/09/04 04:23:05 ERROR : Local file system at /tmp/rclone2049511485: not deleting directories as there were IO errors sync_transform_test.go:457: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:457 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestManualTransformFile 2025/09/04 04:23:06 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-culijeg2baki/tictactoe not empty`) 2025/09/04 04:23:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/09/04 04:23:06 DEBUG : pacer: Reducing sleep to 15ms 2025/09/04 04:23:06 DEBUG : pacer: Reducing sleep to 11.25ms --- FAIL: TestManualTransformFile (3.41s) === RUN TestBase64 run.go:180: Remote "files root 'rclone-test-culijeg2baki'", Local "Local file system at /tmp/rclone2049511485", Modify Window "1s" 2025/09/04 04:23:06 DEBUG : pacer: Reducing sleep to 10ms 2025/09/04 04:23:06 DEBUG : toe: transformed to: dG9l 2025/09/04 04:23:06 DEBUG : toe: transformed to: dG9l 2025/09/04 04:23:06 INFO : dG9l: Making directory 2025/09/04 04:23:06 INFO : dG9l: Made directory with modification time 2025-09-04 04:23:06.386399104 +0000 UTC 2025/09/04 04:23:06 DEBUG : Added delayed dir = "dG9l", newDst= 2025/09/04 04:23:06 DEBUG : toe: transformed to: dG9l 2025/09/04 04:23:06 DEBUG : toe: transformed to: dG9l 2025/09/04 04:23:06 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/09/04 04:23:06 INFO : dG9l/dG9l: Making directory 2025/09/04 04:23:07 INFO : dG9l/dG9l: Made directory with modification time 2025-09-04 04:23:06.386399104 +0000 UTC 2025/09/04 04:23:07 DEBUG : Added delayed dir = "dG9l/dG9l", newDst= 2025/09/04 04:23:07 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/09/04 04:23:07 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2025/09/04 04:23:07 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/09/04 04:23:07 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/04 04:23:07 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/09/04 04:23:07 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for checks to finish 2025/09/04 04:23:07 DEBUG : files root 'rclone-test-culijeg2baki': Waiting for transfers to finish 2025/09/04 04:23:08 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Dst hash empty - aborting Src hash check 2025/09/04 04:23:08 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2025/09/04 04:23:08 ERROR : files root 'rclone-test-culijeg2baki': not deleting files as there were IO errors 2025/09/04 04:23:08 INFO : dG9l/dG9l: Set directory modification time (using DirSetModTime) 2025/09/04 04:23:08 INFO : dG9l: Set directory modification time (using DirSetModTime) 2025/09/04 04:23:08 ERROR : files root 'rclone-test-culijeg2baki': not deleting directories as there were IO errors sync_transform_test.go:481: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:481 Error: Received unexpected error: not deleting files as there were IO errors Test: TestBase64 --- FAIL: TestBase64 (2.97s) FAIL 2025/09/04 04:23:09 DEBUG : files root 'rclone-test-culijeg2baki': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestBase64|TestCopyAfterDelete|TestManualTransformFile|TestServerSideMoveOverSelf|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestTransformFile)$'" - Finished ERROR in 1m9.702238943s (try 2/5): exit status 1: Failed [TestSyncWithTrackRenames TestManualTransformFile TestBase64]