"./sync.test -test.v -test.timeout 2h0m0s -remote TestDrime: -verbose -test.run '^(TestCopyDeleteBefore|TestCopyNoEmptyDirectories|TestCopyOverSelf|TestMoveNoEmptyDirectories|TestMoveOverSelf|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestSyncAfterAddingAFile|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncDeleteDuring|TestSyncEmptyDirectories|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 3/5) 2026/02/07 06:29:09 DEBUG : Creating backend with remote "TestDrime:rclone-test-caxayij2nubo" 2026/02/07 06:29:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/02/07 06:29:10 DEBUG : Creating backend with remote "/tmp/rclone3081813046" === RUN TestCopyNoEmptyDirectories run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:29:10 INFO : sub dir2: Making directory 2026/02/07 06:29:10 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2026/02/07 06:29:10 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/02/07 06:29:11 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:29:11 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:29:11 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:29:18 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:29:18 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (9.56s) === RUN TestMoveNoEmptyDirectories run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:29:20 INFO : sub dir2: Making directory 2026/02/07 06:29:20 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:29:20 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:29:20 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:29:24 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:29:24 INFO : sub dir/hello world: Copied (new) 2026/02/07 06:29:24 INFO : sub dir/hello world: Deleted run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestMoveNoEmptyDirectories (7.88s) === RUN TestSyncEmptyDirectories run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:29:28 DEBUG : sub dir2: Making directory with metadata 2026/02/07 06:29:28 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/02/07 06:29:28 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/02/07 06:29:28 INFO : sub dir2: Making directory 2026/02/07 06:29:29 INFO : sub dir: Making directory 2026/02/07 06:29:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:29:29 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:29:29 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:29:36 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:29:36 INFO : sub dir/hello world: Copied (new) 2026/02/07 06:29:36 DEBUG : Waiting for deletions to finish 2026/02/07 06:29:37 DEBUG : drime root 'rclone-test-caxayij2nubo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (11.30s) === RUN TestServerSideCopy run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:29:50 DEBUG : Creating backend with remote "TestDrime:rclone-test-veyejat3zuba" sync_test.go:620: Server side copy (if possible) drime root 'rclone-test-caxayij2nubo' -> drime root 'rclone-test-veyejat3zuba' 2026/02/07 06:29:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:29:52 DEBUG : drime root 'rclone-test-veyejat3zuba': Waiting for checks to finish 2026/02/07 06:29:52 DEBUG : drime root 'rclone-test-veyejat3zuba': Waiting for transfers to finish 2026/02/07 06:29:55 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:29:55 INFO : sub dir/hello world: Copied (server-side copy) 2026/02/07 06:29:55 DEBUG : drime root 'rclone-test-veyejat3zuba': Purge remote run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestServerSideCopy (19.63s) === RUN TestCopyOverSelf run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:30:04 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:30:04 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone3081813046) 2026/02/07 06:30:04 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:30:04 DEBUG : sub dir/hello world: Sizes differ 2026/02/07 06:30:04 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:30:12 DEBUG : sub dir/hello world: Removing old object on successful upload 2026/02/07 06:30:13 DEBUG : sub dir/hello world: size = 17 OK 2026/02/07 06:30:13 INFO : sub dir/hello world: Copied (replaced existing) --- PASS: TestCopyOverSelf (16.55s) === RUN TestServerSideCopyOverSelf run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:30:21 DEBUG : Creating backend with remote "TestDrime:rclone-test-himiwol4voka" sync_test.go:656: Server side copy (if possible) drime root 'rclone-test-caxayij2nubo' -> drime root 'rclone-test-himiwol4voka' 2026/02/07 06:30:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:30:23 DEBUG : drime root 'rclone-test-himiwol4voka': Waiting for checks to finish 2026/02/07 06:30:23 DEBUG : drime root 'rclone-test-himiwol4voka': Waiting for transfers to finish 2026/02/07 06:30:26 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:30:26 INFO : sub dir/hello world: Copied (server-side copy) 2026/02/07 06:30:30 DEBUG : sub dir/hello world: Removing old object on successful upload 2026/02/07 06:30:31 DEBUG : drime root 'rclone-test-himiwol4voka': Waiting for checks to finish 2026/02/07 06:30:31 DEBUG : sub dir/hello world: size = 17 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:30:31 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-himiwol4voka') 2026/02/07 06:30:31 DEBUG : sub dir/hello world: Sizes differ 2026/02/07 06:30:31 DEBUG : drime root 'rclone-test-himiwol4voka': Waiting for transfers to finish 2026/02/07 06:30:32 DEBUG : sub dir/hello world: Server side copy: removing existing object after successful copy 2026/02/07 06:30:32 DEBUG : sub dir/hello world: size = 17 OK 2026/02/07 06:30:32 INFO : sub dir/hello world: Copied (server-side copy) 2026/02/07 06:30:33 DEBUG : drime root 'rclone-test-himiwol4voka': Purge remote run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestServerSideCopyOverSelf (21.13s) === RUN TestMoveOverSelf run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:30:46 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone3081813046) 2026/02/07 06:30:46 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:30:46 DEBUG : sub dir/hello world: Sizes differ 2026/02/07 06:30:46 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:30:46 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:30:56 DEBUG : sub dir/hello world: Removing old object on successful upload 2026/02/07 06:30:56 DEBUG : sub dir/hello world: size = 17 OK 2026/02/07 06:30:56 INFO : sub dir/hello world: Copied (replaced existing) 2026/02/07 06:30:56 INFO : sub dir/hello world: Deleted --- PASS: TestMoveOverSelf (23.26s) === RUN TestServerSideMoveOverSelf run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:31:10 DEBUG : Creating backend with remote "TestDrime:rclone-test-qasukop3keje" sync_test.go:701: Server side copy (if possible) drime root 'rclone-test-caxayij2nubo' -> drime root 'rclone-test-qasukop3keje' 2026/02/07 06:31:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:31:12 DEBUG : drime root 'rclone-test-qasukop3keje': Waiting for checks to finish 2026/02/07 06:31:12 DEBUG : drime root 'rclone-test-qasukop3keje': Waiting for transfers to finish 2026/02/07 06:31:15 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:31:15 INFO : sub dir/hello world: Copied (server-side copy) 2026/02/07 06:31:19 DEBUG : sub dir/hello world: Removing old object on successful upload 2026/02/07 06:31:20 DEBUG : drime root 'rclone-test-qasukop3keje': Using server-side directory move 2026/02/07 06:31:20 INFO : drime root 'rclone-test-qasukop3keje': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2026/02/07 06:31:21 DEBUG : sub dir/hello world: size = 17 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:31:21 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-qasukop3keje') 2026/02/07 06:31:21 DEBUG : sub dir/hello world: Sizes differ 2026/02/07 06:31:21 DEBUG : drime root 'rclone-test-qasukop3keje': Waiting for checks to finish 2026/02/07 06:31:21 DEBUG : drime root 'rclone-test-qasukop3keje': Waiting for transfers to finish 2026/02/07 06:31:21 INFO : sub dir/hello world: Deleted 2026/02/07 06:31:22 INFO : sub dir/hello world: Moved (server-side) 2026/02/07 06:31:27 DEBUG : testing file moves 2026/02/07 06:31:27 DEBUG : sub dir/hello world: size = 24 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:31:27 DEBUG : sub dir/hello world: size = 17 (drime root 'rclone-test-qasukop3keje') 2026/02/07 06:31:27 DEBUG : sub dir/hello world: Sizes differ 2026/02/07 06:31:27 DEBUG : drime root 'rclone-test-qasukop3keje': Waiting for checks to finish 2026/02/07 06:31:27 DEBUG : drime root 'rclone-test-qasukop3keje': Waiting for transfers to finish 2026/02/07 06:31:27 INFO : sub dir/hello world: Deleted 2026/02/07 06:31:28 ERROR : sub dir/hello world: Couldn't move: object not found sync_test.go:726: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:726 Error: Received unexpected error: object not found Test: TestServerSideMoveOverSelf 2026/02/07 06:31:28 DEBUG : drime root 'rclone-test-qasukop3keje': Purge remote --- FAIL: TestServerSideMoveOverSelf (30.99s) === RUN TestSyncAfterAddingAFile run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:31:33 DEBUG : empty space: size = 1 OK 2026/02/07 06:31:33 DEBUG : empty space: Sizes identical 2026/02/07 06:31:33 DEBUG : potato: Need to transfer - File not found at Destination 2026/02/07 06:31:33 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:31:33 DEBUG : empty space: Unchanged skipping 2026/02/07 06:31:33 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:31:41 DEBUG : potato: size = 60 OK 2026/02/07 06:31:41 INFO : potato: Copied (new) 2026/02/07 06:31:41 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (12.14s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:31:51 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:31:51 DEBUG : potato: size = 21 (Local file system at /tmp/rclone3081813046) 2026/02/07 06:31:51 DEBUG : potato: size = 60 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:31:51 DEBUG : potato: Sizes differ 2026/02/07 06:31:51 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:31:55 DEBUG : potato: Removing old object on successful upload 2026/02/07 06:31:55 DEBUG : potato: size = 21 OK 2026/02/07 06:31:55 INFO : potato: Copied (replaced existing) 2026/02/07 06:31:55 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncAfterChangingFilesSizeOnly (21.73s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:32:12 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/07 06:32:12 DEBUG : empty space: size = 1 OK 2026/02/07 06:32:12 DEBUG : empty space: Sizes identical 2026/02/07 06:32:12 DEBUG : empty space: Unchanged skipping 2026/02/07 06:32:12 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:32:12 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:32:12 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2026/02/07 06:32:12 DEBUG : Waiting for deletions to finish 2026/02/07 06:32:12 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (9.60s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:32:20 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/07 06:32:20 DEBUG : empty space: size = 1 OK 2026/02/07 06:32:20 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:32:20 DEBUG : empty space: Sizes identical 2026/02/07 06:32:20 DEBUG : empty space: Unchanged skipping 2026/02/07 06:32:20 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:32:25 DEBUG : potato2: size = 60 OK 2026/02/07 06:32:25 INFO : potato2: Copied (new) 2026/02/07 06:32:25 DEBUG : Waiting for deletions to finish 2026/02/07 06:32:26 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (13.36s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:32:37 INFO : d: Making directory 2026/02/07 06:32:37 INFO : d/e: Making directory 2026/02/07 06:32:40 DEBUG : a/potato2: Need to transfer - File not found at Destination 2026/02/07 06:32:40 DEBUG : c/non empty space: size = 5 OK 2026/02/07 06:32:40 DEBUG : c/non empty space: Sizes identical 2026/02/07 06:32:40 DEBUG : c/non empty space: Unchanged skipping 2026/02/07 06:32:41 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:32:41 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:32:52 DEBUG : a/potato2: size = 60 OK 2026/02/07 06:32:52 INFO : a/potato2: Copied (new) 2026/02/07 06:32:52 DEBUG : Waiting for deletions to finish 2026/02/07 06:32:53 INFO : b/potato: Deleted 2026/02/07 06:32:53 INFO : d/e: Removing directory 2026/02/07 06:32:53 INFO : d: Removing directory 2026/02/07 06:32:54 INFO : b: Removing directory 2026/02/07 06:32:55 DEBUG : drime root 'rclone-test-caxayij2nubo': deleted 3 directories --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (30.40s) === RUN TestSyncDeleteDuring run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:33:04 DEBUG : Waiting for deletions to finish 2026/02/07 06:33:04 DEBUG : empty space: size = 1 OK 2026/02/07 06:33:04 DEBUG : empty space: Sizes identical 2026/02/07 06:33:04 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/07 06:33:04 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:33:04 DEBUG : empty space: Unchanged skipping 2026/02/07 06:33:04 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:33:05 INFO : potato: Deleted 2026/02/07 06:33:09 DEBUG : potato2: size = 60 OK 2026/02/07 06:33:09 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteDuring (13.04s) === RUN TestCopyDeleteBefore run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:33:25 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/07 06:33:25 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:33:25 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:33:27 DEBUG : potato2: size = 19 OK 2026/02/07 06:33:27 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (17.84s) === RUN TestSyncWithTrackRenames run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" sync_test.go:1569: Can track renames: false 2026/02/07 06:33:29 ERROR : drime root 'rclone-test-caxayij2nubo': Ignoring --track-renames as the source and destination do not have a common hash 2026/02/07 06:33:29 DEBUG : potato: Need to transfer - File not found at Destination 2026/02/07 06:33:29 DEBUG : yam: Need to transfer - File not found at Destination 2026/02/07 06:33:29 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:33:29 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:33:32 DEBUG : potato: size = 14 OK 2026/02/07 06:33:32 INFO : potato: Copied (new) 2026/02/07 06:33:36 DEBUG : yam: size = 11 OK 2026/02/07 06:33:36 INFO : yam: Copied (new) 2026/02/07 06:33:36 DEBUG : Waiting for deletions to finish 2026/02/07 06:33:37 ERROR : drime root 'rclone-test-caxayij2nubo': Ignoring --track-renames as the source and destination do not have a common hash 2026/02/07 06:33:37 DEBUG : potato: size = 14 OK 2026/02/07 06:33:37 DEBUG : potato: Sizes identical 2026/02/07 06:33:37 DEBUG : yaml: Need to transfer - File not found at Destination 2026/02/07 06:33:37 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:33:37 DEBUG : potato: Unchanged skipping 2026/02/07 06:33:37 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:33:41 DEBUG : yaml: size = 11 OK 2026/02/07 06:33:41 INFO : yaml: Copied (new) 2026/02/07 06:33:41 DEBUG : Waiting for deletions to finish 2026/02/07 06:33:41 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (13.61s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" sync_test.go:1641: Can track renames: false 2026/02/07 06:33:42 ERROR : drime root 'rclone-test-caxayij2nubo': Ignoring --track-renames as either the source or destination do not support modtime 2026/02/07 06:33:43 DEBUG : potato: Need to transfer - File not found at Destination 2026/02/07 06:33:43 DEBUG : yam: Need to transfer - File not found at Destination 2026/02/07 06:33:43 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:33:43 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:33:48 DEBUG : yam: size = 11 OK 2026/02/07 06:33:48 INFO : yam: Copied (new) 2026/02/07 06:33:49 DEBUG : potato: size = 14 OK 2026/02/07 06:33:49 INFO : potato: Copied (new) 2026/02/07 06:33:49 DEBUG : Waiting for deletions to finish 2026/02/07 06:33:49 ERROR : drime root 'rclone-test-caxayij2nubo': Ignoring --track-renames as either the source or destination do not support modtime 2026/02/07 06:33:49 DEBUG : potato: size = 14 OK 2026/02/07 06:33:49 DEBUG : potato: Sizes identical 2026/02/07 06:33:49 DEBUG : yaml: Need to transfer - File not found at Destination 2026/02/07 06:33:49 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:33:49 DEBUG : potato: Unchanged skipping 2026/02/07 06:33:49 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:33:52 DEBUG : yaml: size = 11 OK 2026/02/07 06:33:52 INFO : yaml: Copied (new) 2026/02/07 06:33:52 DEBUG : Waiting for deletions to finish 2026/02/07 06:33:52 INFO : yam: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncWithTrackRenamesStrategyModtime (18.58s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" sync_test.go:1680: Can track renames: false 2026/02/07 06:34:01 INFO : drime root 'rclone-test-caxayij2nubo': Making map for --track-renames 2026/02/07 06:34:01 INFO : drime root 'rclone-test-caxayij2nubo': Finished making map for --track-renames 2026/02/07 06:34:01 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:34:01 DEBUG : potato: Need to transfer - No matching file found at Destination 2026/02/07 06:34:01 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2026/02/07 06:34:01 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for renames to finish 2026/02/07 06:34:01 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:34:04 DEBUG : potato: size = 14 OK 2026/02/07 06:34:04 INFO : potato: Copied (new) 2026/02/07 06:34:17 DEBUG : sub/yam: size = 11 OK 2026/02/07 06:34:17 INFO : sub/yam: Copied (new) 2026/02/07 06:34:17 DEBUG : Waiting for deletions to finish 2026/02/07 06:34:18 DEBUG : potato: size = 14 OK 2026/02/07 06:34:18 DEBUG : potato: Sizes identical 2026/02/07 06:34:18 DEBUG : potato: Unchanged skipping 2026/02/07 06:34:18 INFO : drime root 'rclone-test-caxayij2nubo': Making map for --track-renames 2026/02/07 06:34:18 INFO : drime root 'rclone-test-caxayij2nubo': Finished making map for --track-renames 2026/02/07 06:34:18 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:34:18 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for renames to finish 2026/02/07 06:34:19 ERROR : sub/yam: Couldn't move: object not found 2026/02/07 06:34:19 DEBUG : yam: Failed to rename to "sub/yam": object not found 2026/02/07 06:34:19 DEBUG : yam: Need to transfer - No matching file found at Destination 2026/02/07 06:34:19 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:34:23 DEBUG : yam: size = 11 OK 2026/02/07 06:34:23 INFO : yam: Copied (new) 2026/02/07 06:34:23 ERROR : drime root 'rclone-test-caxayij2nubo': not deleting files as there were IO errors 2026/02/07 06:34:23 ERROR : drime root 'rclone-test-caxayij2nubo': not deleting directories as there were IO errors sync_test.go:1698: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1698 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (25.35s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:34:26 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:34:26 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/02/07 06:34:26 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:34:26 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:34:35 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:34:35 INFO : sub dir/hello world: Copied (new) 2026/02/07 06:34:35 INFO : sub dir/hello world: Deleted 2026/02/07 06:34:35 DEBUG : nested/sub dir/file: size = 6 OK 2026/02/07 06:34:35 INFO : nested/sub dir/file: Copied (new) 2026/02/07 06:34:35 INFO : nested/sub dir/file: Deleted 2026/02/07 06:34:35 ERROR : Local file system at /tmp/rclone3081813046: not deleting directories as there were IO errors sync_test.go:1819: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1819 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty --- FAIL: TestMoveWithDeleteEmptySrcDirs (13.68s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:34:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/07 06:34:40 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/02/07 06:34:40 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:34:40 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:34:46 DEBUG : sub dir/hello world: size = 11 OK 2026/02/07 06:34:46 INFO : sub dir/hello world: Copied (new) 2026/02/07 06:34:46 INFO : sub dir/hello world: Deleted 2026/02/07 06:34:47 DEBUG : nested/sub dir/file: size = 6 OK 2026/02/07 06:34:47 INFO : nested/sub dir/file: Copied (new) 2026/02/07 06:34:47 INFO : nested/sub dir/file: Deleted run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestMoveWithoutDeleteEmptySrcDirs (12.42s) === RUN TestMoveWithIgnoreExisting run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:34:52 DEBUG : existing-b: Need to transfer - File not found at Destination 2026/02/07 06:34:52 DEBUG : existing: Need to transfer - File not found at Destination 2026/02/07 06:34:52 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:34:52 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:34:56 DEBUG : existing: size = 6 OK 2026/02/07 06:34:56 INFO : existing: Copied (new) 2026/02/07 06:34:56 INFO : existing: Deleted 2026/02/07 06:35:00 DEBUG : existing-b: size = 6 OK 2026/02/07 06:35:00 INFO : existing-b: Copied (new) 2026/02/07 06:35:00 INFO : existing-b: Deleted 2026/02/07 06:35:00 DEBUG : existing: Destination exists, skipping 2026/02/07 06:35:00 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2026/02/07 06:35:00 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for checks to finish 2026/02/07 06:35:00 DEBUG : drime root 'rclone-test-caxayij2nubo': Waiting for transfers to finish 2026/02/07 06:35:00 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (9.18s) === RUN TestServerSideMove run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:35:01 DEBUG : Creating backend with remote "TestDrime:rclone-test-jikaweg7pobe" sync_test.go:1736: Server side move (if possible) drime root 'rclone-test-caxayij2nubo' -> drime root 'rclone-test-jikaweg7pobe' 2026/02/07 06:35:16 DEBUG : drime root 'rclone-test-jikaweg7pobe': Using server-side directory move 2026/02/07 06:35:16 INFO : drime root 'rclone-test-jikaweg7pobe': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2026/02/07 06:35:17 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/07 06:35:17 DEBUG : empty space: size = 1 OK 2026/02/07 06:35:17 DEBUG : empty space: Sizes identical 2026/02/07 06:35:17 DEBUG : empty space: Unchanged skipping 2026/02/07 06:35:17 DEBUG : potato3: size = 68 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:35:17 DEBUG : potato3: size = 60 (drime root 'rclone-test-jikaweg7pobe') 2026/02/07 06:35:17 DEBUG : potato3: Sizes differ 2026/02/07 06:35:17 DEBUG : drime root 'rclone-test-jikaweg7pobe': Waiting for checks to finish 2026/02/07 06:35:17 INFO : potato3: Deleted 2026/02/07 06:35:17 ERROR : potato2: Couldn't move: object not found 2026/02/07 06:35:17 INFO : empty space: Deleted 2026/02/07 06:35:17 DEBUG : drime root 'rclone-test-jikaweg7pobe': Waiting for transfers to finish 2026/02/07 06:35:17 INFO : potato3: Moved (server-side) sync_test.go:1747: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1747 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1912 Error: Received unexpected error: object not found Test: TestServerSideMove 2026/02/07 06:35:17 DEBUG : drime root 'rclone-test-jikaweg7pobe': Purge remote --- FAIL: TestServerSideMove (17.06s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:185: Remote "drime root 'rclone-test-caxayij2nubo'", Local "Local file system at /tmp/rclone3081813046", Modify Window "876000h0m0s" 2026/02/07 06:35:18 DEBUG : Creating backend with remote "TestDrime:rclone-test-gojunup0fajo" 2026/02/07 06:35:35 INFO : tomatoDir: Making directory sync_test.go:1736: Server side move (if possible) drime root 'rclone-test-caxayij2nubo' -> drime root 'rclone-test-gojunup0fajo' 2026/02/07 06:35:53 DEBUG : drime root 'rclone-test-gojunup0fajo': Using server-side directory move 2026/02/07 06:35:53 INFO : drime root 'rclone-test-gojunup0fajo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2026/02/07 06:35:54 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/07 06:35:54 DEBUG : empty space: size = 1 OK 2026/02/07 06:35:54 DEBUG : empty space: Sizes identical 2026/02/07 06:35:54 DEBUG : empty space: Unchanged skipping 2026/02/07 06:35:54 DEBUG : potato3: size = 68 (drime root 'rclone-test-caxayij2nubo') 2026/02/07 06:35:54 DEBUG : potato3: size = 60 (drime root 'rclone-test-gojunup0fajo') 2026/02/07 06:35:54 DEBUG : potato3: Sizes differ 2026/02/07 06:35:54 DEBUG : drime root 'rclone-test-gojunup0fajo': Waiting for checks to finish 2026/02/07 06:35:54 INFO : potato3: Deleted 2026/02/07 06:35:54 INFO : empty space: Deleted 2026/02/07 06:35:54 DEBUG : drime root 'rclone-test-gojunup0fajo': Waiting for transfers to finish 2026/02/07 06:35:54 INFO : potato2: Moved (server-side) 2026/02/07 06:35:54 INFO : potato3: Moved (server-side) 2026/02/07 06:35:54 INFO : tomatoDir: Removing directory 2026/02/07 06:35:55 DEBUG : drime root 'rclone-test-caxayij2nubo': deleted 1 directories 2026/02/07 06:35:56 DEBUG : Creating backend with remote "TestDrime:rclone-test-liqayep8poxo" 2026/02/07 06:35:57 INFO : tomatoDir: Making directory 2026/02/07 06:35:57 DEBUG : drime root 'rclone-test-liqayep8poxo': Using server-side directory move 2026/02/07 06:35:58 INFO : drime root 'rclone-test-liqayep8poxo': Server side directory move succeeded 2026/02/07 06:35:59 ERROR : error listing: directory not found fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/02/07 06:36:08 ERROR : error listing: directory not found 2026/02/07 06:36:08 ERROR : error listing: directory not found 2026/02/07 06:36:08 DEBUG : drime root 'rclone-test-liqayep8poxo': Purge remote 2026/02/07 06:36:08 DEBUG : drime root 'rclone-test-gojunup0fajo': Purge remote 2026/02/07 06:36:09 NOTICE: purge failed: directory not found --- PASS: TestServerSideMoveDeleteEmptySourceDirs (50.69s) FAIL 2026/02/07 06:36:09 DEBUG : drime root 'rclone-test-caxayij2nubo': Purge remote "./sync.test -test.v -test.timeout 2h0m0s -remote TestDrime: -verbose -test.run '^(TestCopyDeleteBefore|TestCopyNoEmptyDirectories|TestCopyOverSelf|TestMoveNoEmptyDirectories|TestMoveOverSelf|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestSyncAfterAddingAFile|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncDeleteDuring|TestSyncEmptyDirectories|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 7m0.786441195s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove]