"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveLocal|TestServerSideMoveWithFilter|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 2/5) 2025/08/31 02:27:27 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bobuvum5woca" 2025/08/31 02:27:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/31 02:27:28 DEBUG : Creating backend with remote "/tmp/rclone4193032495" === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/31 02:27:28 INFO : pcloud root 'rclone-test-bobuvum5woca': Making map for --track-renames 2025/08/31 02:27:28 INFO : pcloud root 'rclone-test-bobuvum5woca': Finished making map for --track-renames 2025/08/31 02:27:28 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:28 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for renames to finish 2025/08/31 02:27:28 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/31 02:27:28 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/31 02:27:28 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:29 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/31 02:27:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/31 02:27:29 DEBUG : yam.48501227.partial: renamed to: yam 2025/08/31 02:27:29 INFO : yam: Copied (new) 2025/08/31 02:27:29 DEBUG : potato.53508f02.partial: renamed to: potato 2025/08/31 02:27:29 INFO : potato: Copied (new) 2025/08/31 02:27:29 DEBUG : Waiting for deletions to finish 2025/08/31 02:27:29 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/31 02:27:29 INFO : pcloud root 'rclone-test-bobuvum5woca': Making map for --track-renames 2025/08/31 02:27:29 INFO : pcloud root 'rclone-test-bobuvum5woca': Finished making map for --track-renames 2025/08/31 02:27:29 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:29 DEBUG : potato: Unchanged skipping 2025/08/31 02:27:29 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for renames to finish 2025/08/31 02:27:29 INFO : yam: Moved (server-side) to: yaml 2025/08/31 02:27:29 INFO : yaml: Renamed from "yam" 2025/08/31 02:27:29 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:29 DEBUG : Waiting for deletions to finish 2025/08/31 02:27:29 INFO : There was nothing to transfer --- PASS: TestSyncWithTrackRenamesStrategyModtime (1.92s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/31 02:27:30 INFO : pcloud root 'rclone-test-bobuvum5woca': Making map for --track-renames 2025/08/31 02:27:30 INFO : pcloud root 'rclone-test-bobuvum5woca': Finished making map for --track-renames 2025/08/31 02:27:30 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:30 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/31 02:27:30 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/31 02:27:30 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for renames to finish 2025/08/31 02:27:30 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:30 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/31 02:27:30 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/31 02:27:30 DEBUG : potato.53508f02.partial: renamed to: potato 2025/08/31 02:27:30 INFO : potato: Copied (new) 2025/08/31 02:27:30 DEBUG : sub/yam.48501227.partial: renamed to: sub/yam 2025/08/31 02:27:30 INFO : sub/yam: Copied (new) 2025/08/31 02:27:30 DEBUG : Waiting for deletions to finish 2025/08/31 02:27:31 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/31 02:27:31 DEBUG : potato: Unchanged skipping 2025/08/31 02:27:31 INFO : pcloud root 'rclone-test-bobuvum5woca': Making map for --track-renames 2025/08/31 02:27:31 INFO : pcloud root 'rclone-test-bobuvum5woca': Finished making map for --track-renames 2025/08/31 02:27:31 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:31 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for renames to finish 2025/08/31 02:27:31 INFO : sub/yam: Moved (server-side) to: yam 2025/08/31 02:27:31 INFO : yam: Renamed from "sub/yam" 2025/08/31 02:27:31 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:31 DEBUG : Waiting for deletions to finish 2025/08/31 02:27:31 INFO : There was nothing to transfer --- PASS: TestSyncWithTrackRenamesStrategyLeaf (1.75s) === RUN TestServerSideMoveLocal run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" 2025/08/31 02:27:32 DEBUG : Creating backend with remote "/tmp/rclone4193032495/dir1" 2025/08/31 02:27:32 DEBUG : Creating backend with remote "/tmp/rclone4193032495/dir2" 2025/08/31 02:27:32 DEBUG : Local file system at /tmp/rclone4193032495/dir2: Using server-side directory move 2025/08/31 02:27:32 INFO : Local file system at /tmp/rclone4193032495/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/31 02:27:32 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/31 02:27:32 DEBUG : Local file system at /tmp/rclone4193032495/dir2: Waiting for checks to finish 2025/08/31 02:27:32 DEBUG : Local file system at /tmp/rclone4193032495/dir2: Waiting for transfers to finish 2025/08/31 02:27:32 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.19s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" 2025/08/31 02:27:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/31 02:27:32 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/31 02:27:32 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:32 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:32 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/31 02:27:32 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/31 02:27:32 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/08/31 02:27:32 INFO : sub dir/hello world: Copied (new) 2025/08/31 02:27:32 INFO : sub dir/hello world: Deleted 2025/08/31 02:27:33 DEBUG : nested/sub dir/file.468f3f0c.partial: renamed to: nested/sub dir/file 2025/08/31 02:27:33 INFO : nested/sub dir/file: Copied (new) 2025/08/31 02:27:33 INFO : nested/sub dir/file: Deleted 2025/08/31 02:27:33 INFO : sub dir: Removing directory 2025/08/31 02:27:33 INFO : nested/sub dir: Removing directory 2025/08/31 02:27:33 INFO : nested: Removing directory 2025/08/31 02:27:33 DEBUG : Local file system at /tmp/rclone4193032495: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (1.66s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" 2025/08/31 02:27:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/31 02:27:34 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/31 02:27:34 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:34 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:34 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/31 02:27:34 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/31 02:27:34 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/08/31 02:27:34 INFO : sub dir/hello world: Copied (new) 2025/08/31 02:27:34 INFO : sub dir/hello world: Deleted 2025/08/31 02:27:34 DEBUG : nested/sub dir/file.468f3f0c.partial: renamed to: nested/sub dir/file 2025/08/31 02:27:34 INFO : nested/sub dir/file: Copied (new) 2025/08/31 02:27:34 INFO : nested/sub dir/file: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (1.66s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" 2025/08/31 02:27:35 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/08/31 02:27:35 DEBUG : existing: Need to transfer - File not found at Destination 2025/08/31 02:27:35 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:35 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:35 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2025/08/31 02:27:35 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2025/08/31 02:27:35 DEBUG : existing-b.468f3f0c.partial: renamed to: existing-b 2025/08/31 02:27:35 INFO : existing-b: Copied (new) 2025/08/31 02:27:35 INFO : existing-b: Deleted 2025/08/31 02:27:35 DEBUG : existing.468f3f0c.partial: renamed to: existing 2025/08/31 02:27:35 INFO : existing: Copied (new) 2025/08/31 02:27:35 INFO : existing: Deleted 2025/08/31 02:27:36 DEBUG : existing: Destination exists, skipping 2025/08/31 02:27:36 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/08/31 02:27:36 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for checks to finish 2025/08/31 02:27:36 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Waiting for transfers to finish 2025/08/31 02:27:36 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (1.21s) === RUN TestServerSideMove run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" 2025/08/31 02:27:36 DEBUG : Creating backend with remote "TestPcloud:rclone-test-rarumoc9faku" sync_test.go:1735: Server side move (if possible) pcloud root 'rclone-test-bobuvum5woca' -> pcloud root 'rclone-test-rarumoc9faku' 2025/08/31 02:27:38 DEBUG : pcloud root 'rclone-test-rarumoc9faku': Using server-side directory move 2025/08/31 02:27:38 INFO : pcloud root 'rclone-test-rarumoc9faku': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/31 02:27:38 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/31 02:27:38 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/31 02:27:38 DEBUG : empty space: Unchanged skipping 2025/08/31 02:27:38 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/31 02:27:38 DEBUG : pcloud root 'rclone-test-rarumoc9faku': Waiting for checks to finish 2025/08/31 02:27:38 INFO : empty space: Deleted 2025/08/31 02:27:38 DEBUG : pcloud root 'rclone-test-rarumoc9faku': Waiting for transfers to finish 2025/08/31 02:27:38 INFO : potato2: Moved (server-side) 2025/08/31 02:27:38 INFO : potato3: Deleted 2025/08/31 02:27:39 INFO : potato3: Moved (server-side) 2025/08/31 02:27:39 DEBUG : Creating backend with remote "TestPcloud:rclone-test-rugahib9vico" 2025/08/31 02:27:39 DEBUG : pcloud root 'rclone-test-rugahib9vico': Using server-side directory move 2025/08/31 02:27:40 INFO : pcloud root 'rclone-test-rugahib9vico': Server side directory move succeeded 2025/08/31 02:27:41 DEBUG : pcloud root 'rclone-test-rugahib9vico': Purge remote 2025/08/31 02:27:41 DEBUG : pcloud root 'rclone-test-rarumoc9faku': Purge remote 2025/08/31 02:27:41 NOTICE: purge failed: directory not found --- PASS: TestServerSideMove (5.10s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "pcloud root 'rclone-test-bobuvum5woca'", Local "Local file system at /tmp/rclone4193032495", Modify Window "1s" 2025/08/31 02:27:41 DEBUG : Creating backend with remote "TestPcloud:rclone-test-hixacub8ruki" sync_test.go:1735: Server side move (if possible) pcloud root 'rclone-test-bobuvum5woca' -> pcloud root 'rclone-test-hixacub8ruki' 2025/08/31 02:27:43 DEBUG : empty space: Excluded (Size Filter) 2025/08/31 02:27:43 DEBUG : empty space: Excluded 2025/08/31 02:27:43 DEBUG : empty space: Excluded (Size Filter) 2025/08/31 02:27:43 DEBUG : empty space: Excluded 2025/08/31 02:27:43 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/31 02:27:43 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/31 02:27:43 DEBUG : pcloud root 'rclone-test-hixacub8ruki': Waiting for checks to finish 2025/08/31 02:27:43 DEBUG : pcloud root 'rclone-test-hixacub8ruki': Waiting for transfers to finish 2025/08/31 02:27:43 INFO : potato2: Moved (server-side) 2025/08/31 02:27:44 INFO : potato3: Deleted 2025/08/31 02:27:44 INFO : potato3: Moved (server-side) 2025/08/31 02:27:44 DEBUG : Creating backend with remote "TestPcloud:rclone-test-paviwuc3gesu" 2025/08/31 02:27:45 DEBUG : empty space: Excluded (Size Filter) 2025/08/31 02:27:45 DEBUG : empty space: Excluded 2025/08/31 02:27:45 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/31 02:27:45 DEBUG : potato3: Need to transfer - File not found at Destination 2025/08/31 02:27:45 DEBUG : pcloud root 'rclone-test-paviwuc3gesu': Waiting for checks to finish 2025/08/31 02:27:45 DEBUG : pcloud root 'rclone-test-paviwuc3gesu': Waiting for transfers to finish 2025/08/31 02:27:45 INFO : potato2: Moved (server-side) 2025/08/31 02:27:45 INFO : potato3: Moved (server-side) 2025/08/31 02:27:46 DEBUG : pcloud root 'rclone-test-paviwuc3gesu': Purge remote 2025/08/31 02:27:46 DEBUG : pcloud root 'rclone-test-hixacub8ruki': Purge remote --- PASS: TestServerSideMoveWithFilter (4.84s) PASS 2025/08/31 02:27:46 DEBUG : pcloud root 'rclone-test-bobuvum5woca': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveLocal|TestServerSideMoveWithFilter|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished OK in 19.06980417s (try 2/5)