"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestSyncWithTrackRenamesStrategyLeaf)$'" - Starting (try 2/5) 2025/03/17 05:08:26 DEBUG : Creating backend with remote "TestGoFile:rclone-test-nukoxan8xazo" 2025/03/17 05:08:26 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/17 05:08:26 DEBUG : Creating backend with remote "/tmp/rclone2387571457" === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "gofile root 'rclone-test-nukoxan8xazo'", Local "Local file system at /tmp/rclone2387571457", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/03/17 05:08:26 DEBUG : Added delayed dir = "sub", newDst= 2025/03/17 05:08:26 INFO : gofile root 'rclone-test-nukoxan8xazo': Making map for --track-renames 2025/03/17 05:08:26 INFO : gofile root 'rclone-test-nukoxan8xazo': Finished making map for --track-renames 2025/03/17 05:08:26 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for checks to finish 2025/03/17 05:08:26 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/17 05:08:26 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/03/17 05:08:26 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for renames to finish 2025/03/17 05:08:26 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for transfers to finish 2025/03/17 05:08:27 DEBUG : Upload server store-eu-par-2 (eu) responded in 123.794677ms 2025/03/17 05:08:27 DEBUG : Upload server store-eu-par-1 (eu) responded in 125.071156ms 2025/03/17 05:08:27 DEBUG : potato: Using upload server store-eu-par-2 (eu) 2025/03/17 05:08:27 DEBUG : sub/yam: Using upload server store-eu-par-2 (eu) 2025/03/17 05:08:27 DEBUG : sub/yam: md5 = 48dc443644c4b89556dc06834b46451d OK 2025/03/17 05:08:27 INFO : sub/yam: Copied (new) 2025/03/17 05:08:27 DEBUG : potato: md5 = 7f6fa9ddec9bfebda9510af0323fd696 OK 2025/03/17 05:08:27 INFO : potato: Copied (new) 2025/03/17 05:08:27 DEBUG : Waiting for deletions to finish 2025/03/17 05:08:27 INFO : sub: Set directory modification time (using DirSetModTime) run.go:180: Remote "gofile root 'rclone-test-nukoxan8xazo'", Local "Local file system at /tmp/rclone2387571457", Modify Window "1s" 2025/03/17 05:08:28 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/17 05:08:28 DEBUG : potato: Unchanged skipping 2025/03/17 05:08:28 INFO : sub: Set directory modification time (using SetModTime) 2025/03/17 05:08:28 DEBUG : Added delayed dir = "sub", newDst=sub 2025/03/17 05:08:28 INFO : gofile root 'rclone-test-nukoxan8xazo': Making map for --track-renames 2025/03/17 05:08:28 INFO : gofile root 'rclone-test-nukoxan8xazo': Finished making map for --track-renames 2025/03/17 05:08:28 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for checks to finish 2025/03/17 05:08:28 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for renames to finish 2025/03/17 05:08:28 INFO : sub/yam: Moved (server-side) to: yam 2025/03/17 05:08:28 INFO : yam: Renamed from "sub/yam" 2025/03/17 05:08:28 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for transfers to finish 2025/03/17 05:08:28 DEBUG : Waiting for deletions to finish 2025/03/17 05:08:28 INFO : There was nothing to transfer run.go:180: Remote "gofile root 'rclone-test-nukoxan8xazo'", Local "Local file system at /tmp/rclone2387571457", Modify Window "1s" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (3.61s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "gofile root 'rclone-test-nukoxan8xazo'", Local "Local file system at /tmp/rclone2387571457", Modify Window "1s" 2025/03/17 05:08:30 DEBUG : Added delayed dir = "nested", newDst= 2025/03/17 05:08:30 DEBUG : Added delayed dir = "sub dir", newDst= 2025/03/17 05:08:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/17 05:08:30 DEBUG : Added delayed dir = "nested/sub dir", newDst= 2025/03/17 05:08:30 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/03/17 05:08:30 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for checks to finish 2025/03/17 05:08:30 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Waiting for transfers to finish 2025/03/17 05:08:30 DEBUG : sub dir/hello world: Using upload server store-eu-par-1 (eu) 2025/03/17 05:08:30 DEBUG : nested/sub dir/file: Using upload server store-eu-par-2 (eu) 2025/03/17 05:08:31 DEBUG : nested/sub dir/file: md5 = 83d3784ea62518eafc60e98d84f877ad OK 2025/03/17 05:08:31 INFO : nested/sub dir/file: Copied (new) 2025/03/17 05:08:31 INFO : nested/sub dir/file: Deleted 2025/03/17 05:08:31 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/03/17 05:08:31 INFO : sub dir/hello world: Copied (new) 2025/03/17 05:08:31 INFO : sub dir/hello world: Deleted 2025/03/17 05:08:31 INFO : nested/sub dir: Set directory modification time (using DirSetModTime) 2025/03/17 05:08:31 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/17 05:08:31 INFO : nested: Set directory modification time (using DirSetModTime) 2025/03/17 05:08:31 INFO : sub dir: Removing directory 2025/03/17 05:08:31 INFO : nested/sub dir: Removing directory 2025/03/17 05:08:31 INFO : nested: Removing directory 2025/03/17 05:08:31 DEBUG : Local file system at /tmp/rclone2387571457: deleted 3 directories run.go:180: Remote "gofile root 'rclone-test-nukoxan8xazo'", Local "Local file system at /tmp/rclone2387571457", Modify Window "1s" --- PASS: TestMoveWithDeleteEmptySrcDirs (2.97s) PASS 2025/03/17 05:08:32 DEBUG : gofile root 'rclone-test-nukoxan8xazo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestSyncWithTrackRenamesStrategyLeaf)$'" - Finished OK in 7.148092459s (try 2/5)