"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestError|TestFixCase|TestSyncAfterChangingModtimeOnly|TestSyncSuffixKeepExtension)$'" - Starting (try 2/5) 2025/07/10 02:50:27 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-piwayud7yaci" 2025/07/10 02:50:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/10 02:50:28 DEBUG : Starting OpenDrive session with ID: d5a5c6ae63cf10a1de5f609e4979a8470962f41a09e8d0a61c7f6a60429d57f9 2025/07/10 02:50:28 DEBUG : Creating backend with remote "/tmp/rclone1609663336" === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "OpenDrive root 'rclone-test-piwayud7yaci'", Local "Local file system at /tmp/rclone1609663336", Modify Window "1s" 2025/07/10 02:50:29 DEBUG : empty space: Uploading chunk 0, size=1, remain=0 2025/07/10 02:50:30 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for checks to finish 2025/07/10 02:50:30 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/07/10 02:50:30 DEBUG : empty space: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/07/10 02:50:30 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2025/07/10 02:50:30 DEBUG : empty space: Unchanged skipping 2025/07/10 02:50:30 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for transfers to finish 2025/07/10 02:50:30 DEBUG : Waiting for deletions to finish 2025/07/10 02:50:30 INFO : There was nothing to transfer 2025/07/10 02:50:31 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/07/10 02:50:31 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for checks to finish 2025/07/10 02:50:31 DEBUG : empty space: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/07/10 02:50:31 INFO : empty space: Updated modification time in destination 2025/07/10 02:50:31 DEBUG : empty space: Unchanged skipping 2025/07/10 02:50:31 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for transfers to finish 2025/07/10 02:50:31 DEBUG : Waiting for deletions to finish 2025/07/10 02:50:31 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (3.62s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "OpenDrive root 'rclone-test-piwayud7yaci'", Local "Local file system at /tmp/rclone1609663336", Modify Window "1s" 2025/07/10 02:50:33 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2025/07/10 02:50:34 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2025/07/10 02:50:36 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2025/07/10 02:50:38 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-piwayud7yaci/dst" 2025/07/10 02:50:38 DEBUG : Starting OpenDrive session with ID: b7f201baae8e5eb65ad2eea929d9b5ac80737e2e6e342d05d709e0a970929635 2025/07/10 02:50:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/10 02:50:39 DEBUG : one: same parent dir (ODFfOTE1NjEwNV9yemY1Ug) - using file/rename instead of move_copy for one-2019-01-01 2025/07/10 02:50:39 INFO : one: Moved (server-side) to: one-2019-01-01 2025/07/10 02:50:40 DEBUG : one: Uploading chunk 0, size=4, remain=0 2025/07/10 02:50:41 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/07/10 02:50:41 INFO : one: Copied (new) 2025/07/10 02:50:41 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/10 02:50:41 DEBUG : two: Unchanged skipping 2025/07/10 02:50:41 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/07/10 02:50:42 DEBUG : three.txt: same parent dir (ODFfOTE1NjEwNV9yemY1Ug) - using file/rename instead of move_copy for three-2019-01-01.txt 2025/07/10 02:50:42 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/07/10 02:50:42 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0 2025/07/10 02:50:43 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/07/10 02:50:43 INFO : three.txt: Copied (new) 2025/07/10 02:50:44 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/10 02:50:45 INFO : one-2019-01-01: Deleted 2025/07/10 02:50:45 DEBUG : one: same parent dir (ODFfOTE1NjEwNV9yemY1Ug) - using file/rename instead of move_copy for one-2019-01-01 2025/07/10 02:50:45 INFO : one: Moved (server-side) to: one-2019-01-01 2025/07/10 02:50:46 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/07/10 02:50:47 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/07/10 02:50:47 INFO : one: Copied (new) 2025/07/10 02:50:47 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/10 02:50:47 DEBUG : two: Unchanged skipping 2025/07/10 02:50:47 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/07/10 02:50:47 INFO : three-2019-01-01.txt: Deleted 2025/07/10 02:50:47 DEBUG : three.txt: same parent dir (ODFfOTE1NjEwNV9yemY1Ug) - using file/rename instead of move_copy for three-2019-01-01.txt 2025/07/10 02:50:48 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/07/10 02:50:48 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0 2025/07/10 02:50:49 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/07/10 02:50:49 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (19.79s) === RUN TestFixCase run.go:180: Remote "OpenDrive root 'rclone-test-piwayud7yaci'", Local "Local file system at /tmp/rclone1609663336", Modify Window "1s" 2025/07/10 02:50:52 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0 2025/07/10 02:50:54 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0 2025/07/10 02:50:57 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 0, size=8, remain=0 2025/07/10 02:50:59 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 0, size=8, remain=0 2025/07/10 02:51:01 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/10 02:51:01 DEBUG : existing: Unchanged skipping 2025/07/10 02:51:01 DEBUG : existingbutdifferent: Sizes differ (src 5 vs dst 8) 2025/07/10 02:51:01 DEBUG : subdira-rclone-move-woxonij8: same parent dir (ODFfOTE1NjEwNF9weVRBYw) - using folder/rename instead of move_copy 2025/07/10 02:51:01 DEBUG : EXISTING: moving to existing-rclone-move-nayuwad6 2025/07/10 02:51:01 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-jijuvim7 2025/07/10 02:51:02 DEBUG : subdira: same parent dir (ODFfOTE1NjEwNF9weVRBYw) - using folder/rename instead of move_copy 2025/07/10 02:51:02 DEBUG : EXISTINGBUTDIFFERENT: same parent dir (ODFfOTE1NjEwNF9weVRBYw) - using file/rename instead of move_copy for existingbutdifferent-rclone-move-jijuvim7 2025/07/10 02:51:02 INFO : SUBDIRA: Fixed case by renaming to: subdira 2025/07/10 02:51:02 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-jijuvim7 2025/07/10 02:51:02 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent 2025/07/10 02:51:02 DEBUG : EXISTING: same parent dir (ODFfOTE1NjEwNF9weVRBYw) - using file/rename instead of move_copy for existing-rclone-move-nayuwad6 2025/07/10 02:51:02 INFO : EXISTING: Moved (server-side) to: existing-rclone-move-nayuwad6 2025/07/10 02:51:02 DEBUG : EXISTING: moving to existing 2025/07/10 02:51:02 DEBUG : subdira/subdirb-rclone-move-kitimaf9: same parent dir (ODFfOTE1NjEwNl90bTZOcQ) - using folder/rename instead of move_copy 2025/07/10 02:51:02 DEBUG : existingbutdifferent-rclone-move-jijuvim7: same parent dir (ODFfOTE1NjEwNF9weVRBYw) - using file/rename instead of move_copy for existingbutdifferent 2025/07/10 02:51:03 DEBUG : existing-rclone-move-nayuwad6: same parent dir (ODFfOTE1NjEwNF9weVRBYw) - using file/rename instead of move_copy for existing 2025/07/10 02:51:03 INFO : existingbutdifferent-rclone-move-jijuvim7: Moved (server-side) to: existingbutdifferent 2025/07/10 02:51:03 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent 2025/07/10 02:51:03 INFO : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent 2025/07/10 02:51:03 INFO : existing-rclone-move-nayuwad6: Moved (server-side) to: existing 2025/07/10 02:51:03 INFO : EXISTING: Moved (server-side) to: existing 2025/07/10 02:51:03 INFO : EXISTING: Fixed case by renaming to: existing 2025/07/10 02:51:03 DEBUG : existingbutdifferent: Uploading chunk 0, size=5, remain=0 2025/07/10 02:51:03 DEBUG : subdira/subdirb: same parent dir (ODFfOTE1NjEwNl90bTZOcQ) - using folder/rename instead of move_copy 2025/07/10 02:51:03 INFO : SUBDIRA/subdirb: Fixed case by renaming to: subdira/subdirb 2025/07/10 02:51:04 DEBUG : subdira/subdirb/subdirc-rclone-move-fucarip0: same parent dir (ODFfOTE1NjEwN19PVG1QdQ) - using folder/rename instead of move_copy 2025/07/10 02:51:04 DEBUG : existingbutdifferent: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/07/10 02:51:04 INFO : existingbutdifferent: Copied (replaced existing) 2025/07/10 02:51:04 INFO : OpenDrive root 'rclone-test-piwayud7yaci': Can't DirMove - falling back to file moves: can't copy directory - destination already exists 2025/07/10 02:51:05 INFO : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Deleted 2025/07/10 02:51:05 INFO : subdira/subdirb/subdirc/HELLO: Deleted 2025/07/10 02:51:05 ERROR : subdira/subdirb/subdirc-rclone-move-fucarip0/subdird/filewithoutcasedifferences: Couldn't move: failed to get fileinfo: File is deleted (Error 404) 2025/07/10 02:51:05 ERROR : subdira/subdirb/subdirc-rclone-move-fucarip0/HELLO: Couldn't move: failed to get fileinfo: Get "https://dev.opendrive.com/api/v1/file/info.json/ODFfMTAyMDAwMjYzX1lQRGNP?session_id=d5a5c6ae63cf10a1de5f609e4979a8470962f41a09e8d0a61c7f6a60429d57f9": failed to get fileinfo: File is deleted (Error 404) 2025/07/10 02:51:05 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/07/10 02:51:06 DEBUG : subdira/subdirb/subdirc/hello: Need to transfer - File not found at Destination 2025/07/10 02:51:06 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Need to transfer - File not found at Destination 2025/07/10 02:51:06 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for checks to finish 2025/07/10 02:51:06 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for transfers to finish 2025/07/10 02:51:06 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 0, size=5, remain=0 2025/07/10 02:51:07 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 0, size=5, remain=0 2025/07/10 02:51:07 DEBUG : subdira/subdirb/subdirc/hello: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/07/10 02:51:07 INFO : subdira/subdirb/subdirc/hello: Copied (new) 2025/07/10 02:51:08 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/07/10 02:51:08 INFO : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (new) 2025/07/10 02:51:08 ERROR : OpenDrive root 'rclone-test-piwayud7yaci': not deleting files as there were IO errors 2025/07/10 02:51:08 ERROR : OpenDrive root 'rclone-test-piwayud7yaci': not deleting directories as there were IO errors sync_test.go:2685: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2685 Error: Received unexpected error: RenameDir renames: failed to get fileinfo: File is deleted (Error 404) Test: TestFixCase --- FAIL: TestFixCase (19.59s) === RUN TestError run.go:180: Remote "OpenDrive root 'rclone-test-piwayud7yaci'", Local "Local file system at /tmp/rclone1609663336", Modify Window "1s" 2025/07/10 02:51:11 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:11 DEBUG : toe: transformed to: 2025/07/10 02:51:11 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:11 DEBUG : toe: transformed to: 2025/07/10 02:51:11 INFO : OpenDrive root 'rclone-test-piwayud7yaci': Making directory 2025/07/10 02:51:11 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:11 DEBUG : toe: transformed to: 2025/07/10 02:51:11 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:11 DEBUG : toe: transformed to: 2025/07/10 02:51:11 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:11 DEBUG : toe/toe: transformed to: 2025/07/10 02:51:11 ERROR : toe/toe: number of path segments must match: toe/toe (1), (0) 2025/07/10 02:51:11 INFO : toe/toe: Making directory 2025/07/10 02:51:12 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:12 DEBUG : toe/toe: transformed to: 2025/07/10 02:51:12 ERROR : toe/toe: number of path segments must match: toe/toe (1), (0) 2025/07/10 02:51:12 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:12 DEBUG : toe: transformed to: 2025/07/10 02:51:12 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/07/10 02:51:12 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for checks to finish 2025/07/10 02:51:12 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Waiting for transfers to finish 2025/07/10 02:51:12 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/07/10 02:51:12 DEBUG : toe/toe/toe: transformed to: 2025/07/10 02:51:12 ERROR : toe/toe/toe: number of path segments must match: toe/toe/toe (2), (0) 2025/07/10 02:51:13 DEBUG : toe/toe/toe: Uploading chunk 0, size=11, remain=0 2025/07/10 02:51:14 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/07/10 02:51:14 INFO : toe/toe/toe: Copied (new) 2025/07/10 02:51:14 ERROR : OpenDrive root 'rclone-test-piwayud7yaci': not deleting files as there were IO errors 2025/07/10 02:51:14 ERROR : OpenDrive root 'rclone-test-piwayud7yaci': not deleting directories as there were IO errors --- PASS: TestError (4.82s) FAIL 2025/07/10 02:51:16 DEBUG : OpenDrive root 'rclone-test-piwayud7yaci': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestError|TestFixCase|TestSyncAfterChangingModtimeOnly|TestSyncSuffixKeepExtension)$'" - Finished ERROR in 49.169783938s (try 2/5): exit status 1: Failed [TestFixCase]