"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyAfterDelete|TestCopyOverSelf|TestCopyRedownload|TestFixCase|TestMoveOverSelf|TestNothingToTransferWithoutEmptyDirs|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncBasedOnCheckSum|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncOverlapWithFilter)$'" - Starting (try 2/5) 2025/04/23 06:19:46 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cewawuf7hisa" 2025/04/23 06:19:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/23 06:19:47 DEBUG : Starting OpenDrive session with ID: 5aebbe4179ef03c8f9be97e8d3414d41c15439d365b9d65fed29b00a6405792d 2025/04/23 06:19:47 DEBUG : Creating backend with remote "/tmp/rclone3771712575" === RUN TestSyncEmptyDirectories run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:19:47 DEBUG : sub dir2: Making directory with metadata 2025/04/23 06:19:47 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/23 06:19:47 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/23 06:19:48 INFO : sub dir: Making directory 2025/04/23 06:19:48 INFO : sub dir2: Making directory 2025/04/23 06:19:48 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/23 06:19:48 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:19:48 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:19:49 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:19:50 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/04/23 06:19:50 INFO : sub dir/hello world: Copied (new) 2025/04/23 06:19:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:19:51 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (5.13s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:19:52 INFO : sub dir2: Making directory 2025/04/23 06:19:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/23 06:19:52 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:19:52 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:19:54 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:19:54 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/04/23 06:19:54 INFO : sub dir/hello world: Copied (new) 2025/04/23 06:19:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (3.49s) === RUN TestServerSideCopy run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:19:57 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:19:58 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-nuvepew1hipo" 2025/04/23 06:19:59 DEBUG : Starting OpenDrive session with ID: ae8a2190bbaa86c9459265f0c73808fd285dda1c4d0289ebe03f538f511dee05 sync_test.go:590: Server side copy (if possible) OpenDrive root 'rclone-test-cewawuf7hisa' -> OpenDrive root 'rclone-test-nuvepew1hipo' 2025/04/23 06:19:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/23 06:19:59 DEBUG : OpenDrive root 'rclone-test-nuvepew1hipo': Waiting for checks to finish 2025/04/23 06:19:59 DEBUG : OpenDrive root 'rclone-test-nuvepew1hipo': Waiting for transfers to finish 2025/04/23 06:20:00 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2025/04/23 06:20:00 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:01 DEBUG : OpenDrive root 'rclone-test-nuvepew1hipo': Purge remote --- PASS: TestServerSideCopy (6.59s) === RUN TestCopyOverSelf run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:03 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:20:05 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/23 06:20:05 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:20:05 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:20:06 DEBUG : sub dir/hello world: Uploading chunk 0, size=17, remain=0 2025/04/23 06:20:07 DEBUG : sub dir/hello world: md5 = 00321a507bdb420dbbd4f53c733b1505 OK 2025/04/23 06:20:07 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" --- PASS: TestCopyOverSelf (6.19s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:10 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:20:11 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-biqugem3noce" 2025/04/23 06:20:11 DEBUG : Starting OpenDrive session with ID: b7a174b60e9d050ee0be3e11fd96b43696173755c1eeb7f3bf9d14c5b2dee02a sync_test.go:626: Server side copy (if possible) OpenDrive root 'rclone-test-cewawuf7hisa' -> OpenDrive root 'rclone-test-biqugem3noce' 2025/04/23 06:20:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/23 06:20:12 DEBUG : OpenDrive root 'rclone-test-biqugem3noce': Waiting for checks to finish 2025/04/23 06:20:12 DEBUG : OpenDrive root 'rclone-test-biqugem3noce': Waiting for transfers to finish 2025/04/23 06:20:13 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2025/04/23 06:20:13 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:14 DEBUG : sub dir/hello world: Uploading chunk 0, size=17, remain=0 2025/04/23 06:20:15 DEBUG : OpenDrive root 'rclone-test-biqugem3noce': Waiting for checks to finish 2025/04/23 06:20:15 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/23 06:20:15 DEBUG : OpenDrive root 'rclone-test-biqugem3noce': Waiting for transfers to finish 2025/04/23 06:20:16 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2025/04/23 06:20:16 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 6s just to make sure 2025/04/23 06:20:24 DEBUG : OpenDrive root 'rclone-test-biqugem3noce': Purge remote --- PASS: TestServerSideCopyOverSelf (17.29s) === RUN TestMoveOverSelf run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:27 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:20:29 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/23 06:20:29 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:20:29 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:20:29 DEBUG : sub dir/hello world: Uploading chunk 0, size=17, remain=0 2025/04/23 06:20:30 DEBUG : sub dir/hello world: md5 = 00321a507bdb420dbbd4f53c733b1505 OK 2025/04/23 06:20:30 INFO : sub dir/hello world: Copied (replaced existing) 2025/04/23 06:20:30 INFO : sub dir/hello world: Deleted run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" --- PASS: TestMoveOverSelf (5.54s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:32 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:20:34 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qigajic8jaco" 2025/04/23 06:20:34 DEBUG : Starting OpenDrive session with ID: c8addb1aa77db03b57f7b4c61c80d5c1f0e8bbaa109979e7cfd152da287f0c3d sync_test.go:671: Server side copy (if possible) OpenDrive root 'rclone-test-cewawuf7hisa' -> OpenDrive root 'rclone-test-qigajic8jaco' 2025/04/23 06:20:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/23 06:20:35 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Waiting for checks to finish 2025/04/23 06:20:35 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Waiting for transfers to finish 2025/04/23 06:20:36 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2025/04/23 06:20:36 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:37 DEBUG : sub dir/hello world: Uploading chunk 0, size=17, remain=0 2025/04/23 06:20:38 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Using server-side directory move 2025/04/23 06:20:38 INFO : OpenDrive root 'rclone-test-qigajic8jaco': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/23 06:20:38 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/23 06:20:38 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Waiting for checks to finish 2025/04/23 06:20:38 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Waiting for transfers to finish 2025/04/23 06:20:39 INFO : sub dir/hello world: Deleted 2025/04/23 06:20:39 INFO : sub dir/hello world: Moved (server-side) 2025/04/23 06:20:40 DEBUG : sub dir/hello world: Uploading chunk 0, size=24, remain=0 2025/04/23 06:20:42 DEBUG : testing file moves 2025/04/23 06:20:42 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/04/23 06:20:42 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Waiting for checks to finish 2025/04/23 06:20:42 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Waiting for transfers to finish 2025/04/23 06:20:42 INFO : sub dir/hello world: Deleted 2025/04/23 06:20:42 INFO : sub dir/hello world: Moved (server-side) run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:43 DEBUG : OpenDrive root 'rclone-test-qigajic8jaco': Purge remote --- PASS: TestServerSideMoveOverSelf (13.59s) === RUN TestCopyAfterDelete run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:46 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:20:47 ERROR : : error listing: directory not found 2025/04/23 06:20:47 INFO : Local file system at /tmp/rclone3771712575: Making directory 2025/04/23 06:20:48 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:20:48 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" --- PASS: TestCopyAfterDelete (4.33s) === RUN TestCopyRedownload run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:20:50 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/04/23 06:20:52 DEBUG : Added delayed dir = "sub dir", newDst= 2025/04/23 06:20:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/23 06:20:52 DEBUG : Local file system at /tmp/rclone3771712575: Waiting for checks to finish 2025/04/23 06:20:52 DEBUG : Local file system at /tmp/rclone3771712575: Waiting for transfers to finish 2025/04/23 06:20:53 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/04/23 06:20:53 DEBUG : sub dir/hello world.87ffde68.partial: renamed to: sub dir/hello world 2025/04/23 06:20:53 INFO : sub dir/hello world: Copied (new) 2025/04/23 06:20:53 INFO : sub dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" run.go:125: removing dir "sub dir" failed - try 1/3: folder not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 6s just to make sure --- PASS: TestCopyRedownload (13.46s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:21:03 DEBUG : check sum: Need to transfer - File not found at Destination 2025/04/23 06:21:03 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:21:03 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:21:04 DEBUG : check sum: Uploading chunk 0, size=1, remain=0 2025/04/23 06:21:05 DEBUG : check sum: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/04/23 06:21:05 INFO : check sum: Copied (new) 2025/04/23 06:21:05 DEBUG : Waiting for deletions to finish run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:21:05 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:21:05 DEBUG : check sum: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/04/23 06:21:05 DEBUG : check sum: Size and md5 of src and dst objects identical 2025/04/23 06:21:05 DEBUG : check sum: Unchanged skipping 2025/04/23 06:21:05 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:21:05 DEBUG : Waiting for deletions to finish 2025/04/23 06:21:05 INFO : There was nothing to transfer run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 6s just to make sure --- PASS: TestSyncBasedOnCheckSum (11.10s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:21:14 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cewawuf7hisa/rclone-sync-test" 2025/04/23 06:21:14 DEBUG : Config file has changed externally - reloading 2025/04/23 06:21:14 DEBUG : Starting OpenDrive session with ID: 4a55d019ae5904e1769a944ded3dc845d46e4173553f69e1b75207b4117535d8 2025/04/23 06:21:15 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cewawuf7hisa/rclone-sync-test-include/layer2" 2025/04/23 06:21:16 DEBUG : Starting OpenDrive session with ID: 640c8c8dcef7c155dc59a4ea6b4b350d720623641eec270ae37e3c8c5dc01656 2025/04/23 06:21:17 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cewawuf7hisa/rclone-sync-test-ignore-file" 2025/04/23 06:21:18 DEBUG : Starting OpenDrive session with ID: 4d7b08544622080e92e6de146e68d787cad19e5c474e222ff7762b6c37e41be6 2025/04/23 06:21:20 DEBUG : rclone-sync-test-ignore-file/.ignore: Uploading chunk 0, size=1, remain=0 2025/04/23 06:21:21 DEBUG : rclone-sync-test: Excluded 2025/04/23 06:21:22 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/23 06:21:22 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/04/23 06:21:22 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa/rclone-sync-test': Waiting for checks to finish 2025/04/23 06:21:22 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa/rclone-sync-test': Waiting for transfers to finish 2025/04/23 06:21:22 DEBUG : Waiting for deletions to finish 2025/04/23 06:21:22 INFO : There was nothing to transfer 2025/04/23 06:21:23 DEBUG : rclone-sync-test: Excluded 2025/04/23 06:21:23 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/23 06:21:23 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/04/23 06:21:23 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:21:23 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:21:23 DEBUG : Waiting for deletions to finish 2025/04/23 06:21:23 INFO : rclone-sync-test-include: Removing directory 2025/04/23 06:21:24 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': deleted 1 directories 2025/04/23 06:21:24 INFO : There was nothing to transfer run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:21:24 ERROR : OpenDrive root 'rclone-test-cewawuf7hisa': Failed to discover whether directory is included: failed to get folder list: Folder is already deleted (Error 403) sync_test.go:2003: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2003 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2029 Error: Received unexpected error: can't sync or move files on overlapping remotes (try excluding the destination with a filter rule) Test: TestSyncOverlapWithFilter run.go:125: removing dir "rclone-sync-test-include" failed - try 1/3: Folder is already deleted (Error 403) run.go:125: removing dir "rclone-sync-test-include" failed - try 2/3: Folder is already deleted (Error 403) run.go:125: removing dir "rclone-sync-test-include" failed - try 3/3: Folder is already deleted (Error 403) run.go:128: removing dir "rclone-sync-test-include" failed: Folder is already deleted (Error 403) --- FAIL: TestSyncOverlapWithFilter (17.31s) === RUN TestFixCase run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:21:32 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0 2025/04/23 06:21:34 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0 2025/04/23 06:21:36 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 0, size=8, remain=0 2025/04/23 06:21:38 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 0, size=8, remain=0 2025/04/23 06:21:40 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/23 06:21:40 DEBUG : existing: Unchanged skipping 2025/04/23 06:21:40 DEBUG : existingbutdifferent: Sizes differ (src 5 vs dst 8) 2025/04/23 06:21:40 DEBUG : subdira-rclone-move-zerepoj0: same parent dir (ODFfODQ2NzI4N19Qc2JmVQ) - using folder/rename instead of move_copy 2025/04/23 06:21:41 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-guqegup0 2025/04/23 06:21:41 DEBUG : EXISTING: moving to existing-rclone-move-todunob4 2025/04/23 06:21:41 DEBUG : subdira: same parent dir (ODFfODQ2NzI4N19Qc2JmVQ) - using folder/rename instead of move_copy 2025/04/23 06:21:41 DEBUG : EXISTING: same parent dir (ODFfODQ2NzI4N19Qc2JmVQ) - using file/rename instead of move_copy for existing-rclone-move-todunob4 2025/04/23 06:21:41 INFO : SUBDIRA: Fixed case by renaming to: subdira 2025/04/23 06:21:41 INFO : EXISTING: Moved (server-side) to: existing-rclone-move-todunob4 2025/04/23 06:21:41 DEBUG : EXISTING: moving to existing 2025/04/23 06:21:41 DEBUG : EXISTINGBUTDIFFERENT: same parent dir (ODFfODQ2NzI4N19Qc2JmVQ) - using file/rename instead of move_copy for existingbutdifferent-rclone-move-guqegup0 2025/04/23 06:21:42 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-guqegup0 2025/04/23 06:21:42 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent 2025/04/23 06:21:42 DEBUG : existing-rclone-move-todunob4: same parent dir (ODFfODQ2NzI4N19Qc2JmVQ) - using file/rename instead of move_copy for existing 2025/04/23 06:21:42 DEBUG : subdira/subdirb-rclone-move-rarequr3: same parent dir (ODFfODQ2NzMxOF80dmpwUQ) - using folder/rename instead of move_copy 2025/04/23 06:21:42 INFO : existing-rclone-move-todunob4: Moved (server-side) to: existing 2025/04/23 06:21:42 INFO : EXISTING: Moved (server-side) to: existing 2025/04/23 06:21:42 INFO : EXISTING: Fixed case by renaming to: existing 2025/04/23 06:21:42 INFO : OpenDrive root 'rclone-test-cewawuf7hisa': Can't DirMove - falling back to file moves: can't copy directory - destination already exists 2025/04/23 06:21:42 DEBUG : existingbutdifferent-rclone-move-guqegup0: same parent dir (ODFfODQ2NzI4N19Qc2JmVQ) - using file/rename instead of move_copy for existingbutdifferent 2025/04/23 06:21:42 ERROR : subdira/subdirb-rclone-move-rarequr3: error listing: directory not found 2025/04/23 06:21:42 ERROR : SUBDIRA/subdirb: Error while attempting to rename to subdira/subdirb: RenameDir tree walk: directory not found 2025/04/23 06:21:42 INFO : existingbutdifferent-rclone-move-guqegup0: Moved (server-side) to: existingbutdifferent 2025/04/23 06:21:42 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent 2025/04/23 06:21:42 INFO : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent 2025/04/23 06:21:43 DEBUG : existingbutdifferent: Uploading chunk 0, size=5, remain=0 2025/04/23 06:21:43 DEBUG : subdira/subdirb/subdirc-rclone-move-betupim7: same parent dir (ODFfODQ2NzMyMF94a014VA) - using folder/rename instead of move_copy 2025/04/23 06:21:43 INFO : OpenDrive root 'rclone-test-cewawuf7hisa': Can't DirMove - falling back to file moves: can't copy directory - destination already exists 2025/04/23 06:21:44 DEBUG : existingbutdifferent: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/04/23 06:21:44 INFO : existingbutdifferent: Copied (replaced existing) 2025/04/23 06:21:44 INFO : subdira/subdirb/subdirc/HELLO: Deleted 2025/04/23 06:21:44 INFO : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Deleted 2025/04/23 06:21:44 ERROR : subdira/subdirb/subdirc-rclone-move-betupim7/HELLO: Couldn't move: failed to get fileinfo: File is deleted (Error 404) 2025/04/23 06:21:44 ERROR : subdira/subdirb/subdirc-rclone-move-betupim7/subdird/filewithoutcasedifferences: Couldn't move: failed to get fileinfo: Get "https://dev.opendrive.com/api/v1/file/info.json/ODFfOTU4OTMxMDFfY3R2N3c?session_id=5aebbe4179ef03c8f9be97e8d3414d41c15439d365b9d65fed29b00a6405792d": failed to get fileinfo: File is deleted (Error 404) 2025/04/23 06:21:44 ERROR : SUBDIRA/subdirb/SUBDIRC: Error while attempting to rename to subdira/subdirb/subdirc: RenameDir renames: failed to get fileinfo: File is deleted (Error 404) 2025/04/23 06:21:45 DEBUG : subdira/subdirb/subdirc/hello: Need to transfer - File not found at Destination 2025/04/23 06:21:45 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Need to transfer - File not found at Destination 2025/04/23 06:21:45 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for checks to finish 2025/04/23 06:21:45 DEBUG : OpenDrive root 'rclone-test-cewawuf7hisa': Waiting for transfers to finish 2025/04/23 06:21:45 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 0, size=5, remain=0 2025/04/23 06:21:45 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 0, size=5, remain=0 2025/04/23 06:21:46 DEBUG : subdira/subdirb/subdirc/hello: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/04/23 06:21:46 INFO : subdira/subdirb/subdirc/hello: Copied (new) 2025/04/23 06:21:47 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/04/23 06:21:47 INFO : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (new) 2025/04/23 06:21:47 ERROR : OpenDrive root 'rclone-test-cewawuf7hisa': not deleting files as there were IO errors 2025/04/23 06:21:47 ERROR : OpenDrive root 'rclone-test-cewawuf7hisa': not deleting directories as there were IO errors sync_test.go:2655: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2655 Error: Received unexpected error: RenameDir renames: failed to get fileinfo: File is deleted (Error 404) Test: TestFixCase run.go:125: removing dir "subdira/subdirb-rclone-move-rarequr3/subdirc-rclone-move-betupim7/subdird" failed - try 1/3: folder not empty --- FAIL: TestFixCase (19.64s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "OpenDrive root 'rclone-test-cewawuf7hisa'", Local "Local file system at /tmp/rclone3771712575", Modify Window "1s" 2025/04/23 06:21:51 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/23 06:21:51 INFO : sub dir: Making directory 2025/04/23 06:21:51 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC sync_test.go:2868: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2868 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bilib/output.go:18 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2866 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2950 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestNothingToTransferWithoutEmptyDirs --- FAIL: TestNothingToTransferWithoutEmptyDirs (6.51s) FAIL "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyAfterDelete|TestCopyOverSelf|TestCopyRedownload|TestFixCase|TestMoveOverSelf|TestNothingToTransferWithoutEmptyDirs|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncBasedOnCheckSum|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncOverlapWithFilter)$'" - Finished ERROR in 2m11.532983539s (try 2/5): exit status 1: Failed [TestSyncOverlapWithFilter TestFixCase TestNothingToTransferWithoutEmptyDirs]