"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestBase64|TestFixCase|TestManualTransformFile|TestMove|TestMoveWithDeleteEmptySrcDirs|TestMoveWithoutDeleteEmptySrcDirs|TestNothingToTransferWithEmptyDirs|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestTransformFile)$'" - Starting (try 2/5) 2026/02/04 02:01:03 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-viyuret2pisa" 2026/02/04 02:01:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/02/04 02:01:04 DEBUG : Starting OpenDrive session with ID: fccc33f24648e6a0fe576dc5de158b1de864c624d83510ca9527469e3c24142f 2026/02/04 02:01:04 DEBUG : Creating backend with remote "/tmp/rclone1482802323" === RUN TestServerSideCopyOverSelf run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:01:06 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2026/02/04 02:01:07 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-nimicij0xuka" 2026/02/04 02:01:09 DEBUG : Starting OpenDrive session with ID: c591b69a22658ff6abde387580fb2f4c729d63488357b9020fa6dff4fdfd6b7f sync_test.go:656: Server side copy (if possible) OpenDrive root 'rclone-test-viyuret2pisa' -> OpenDrive root 'rclone-test-nimicij0xuka' 2026/02/04 02:01:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/04 02:01:10 DEBUG : OpenDrive root 'rclone-test-nimicij0xuka': Waiting for checks to finish 2026/02/04 02:01:10 DEBUG : OpenDrive root 'rclone-test-nimicij0xuka': Waiting for transfers to finish 2026/02/04 02:01:11 DEBUG : sub dir/hello world: size = 11 OK 2026/02/04 02:01:11 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2026/02/04 02:01:11 INFO : sub dir/hello world: Copied (server-side copy) 2026/02/04 02:01:12 DEBUG : sub dir/hello world: Uploading chunk 0, size=17, remain=0 2026/02/04 02:01:14 DEBUG : sub dir/hello world: size = 17 (OpenDrive root 'rclone-test-viyuret2pisa') 2026/02/04 02:01:14 DEBUG : sub dir/hello world: size = 11 (OpenDrive root 'rclone-test-nimicij0xuka') 2026/02/04 02:01:14 DEBUG : sub dir/hello world: Sizes differ 2026/02/04 02:01:14 DEBUG : OpenDrive root 'rclone-test-nimicij0xuka': Waiting for checks to finish 2026/02/04 02:01:14 DEBUG : OpenDrive root 'rclone-test-nimicij0xuka': Waiting for transfers to finish 2026/02/04 02:01:15 DEBUG : sub dir/hello world: size = 17 OK 2026/02/04 02:01:15 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2026/02/04 02:01:15 INFO : sub dir/hello world: Copied (server-side copy) 2026/02/04 02:01:15 DEBUG : OpenDrive root 'rclone-test-nimicij0xuka': Purge remote 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: TestServerSideCopyOverSelf (20.09s) === RUN TestServerSideMoveOverSelf run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:01:26 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2026/02/04 02:01:27 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-nuguyiq8zeku" 2026/02/04 02:01:28 DEBUG : Starting OpenDrive session with ID: a0876d39242bcd13f6d2a3880f30844c95989d564a77cc5de275f451025500c8 sync_test.go:701: Server side copy (if possible) OpenDrive root 'rclone-test-viyuret2pisa' -> OpenDrive root 'rclone-test-nuguyiq8zeku' 2026/02/04 02:01:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/04 02:01:29 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Waiting for checks to finish 2026/02/04 02:01:29 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Waiting for transfers to finish 2026/02/04 02:01:30 DEBUG : sub dir/hello world: size = 11 OK 2026/02/04 02:01:30 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2026/02/04 02:01:30 INFO : sub dir/hello world: Copied (server-side copy) 2026/02/04 02:01:32 DEBUG : sub dir/hello world: Uploading chunk 0, size=17, remain=0 2026/02/04 02:01:34 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Using server-side directory move 2026/02/04 02:01:34 INFO : OpenDrive root 'rclone-test-nuguyiq8zeku': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2026/02/04 02:01:34 DEBUG : sub dir/hello world: size = 17 (OpenDrive root 'rclone-test-viyuret2pisa') 2026/02/04 02:01:34 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Waiting for checks to finish 2026/02/04 02:01:34 DEBUG : sub dir/hello world: size = 11 (OpenDrive root 'rclone-test-nuguyiq8zeku') 2026/02/04 02:01:34 DEBUG : sub dir/hello world: Sizes differ 2026/02/04 02:01:34 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Waiting for transfers to finish 2026/02/04 02:01:34 INFO : sub dir/hello world: Deleted 2026/02/04 02:01:35 INFO : sub dir/hello world: Moved (server-side) 2026/02/04 02:01:36 DEBUG : sub dir/hello world: Uploading chunk 0, size=24, remain=0 2026/02/04 02:01:38 DEBUG : testing file moves 2026/02/04 02:01:38 DEBUG : sub dir/hello world: size = 24 (OpenDrive root 'rclone-test-viyuret2pisa') 2026/02/04 02:01:38 DEBUG : sub dir/hello world: size = 17 (OpenDrive root 'rclone-test-nuguyiq8zeku') 2026/02/04 02:01:38 DEBUG : sub dir/hello world: Sizes differ 2026/02/04 02:01:38 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Waiting for checks to finish 2026/02/04 02:01:38 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Waiting for transfers to finish 2026/02/04 02:01:38 INFO : sub dir/hello world: Deleted 2026/02/04 02:01:39 INFO : sub dir/hello world: Moved (server-side) 2026/02/04 02:01:40 DEBUG : OpenDrive root 'rclone-test-nuguyiq8zeku': Purge remote --- PASS: TestServerSideMoveOverSelf (17.11s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:01:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/04 02:01:42 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/02/04 02:01:42 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for checks to finish 2026/02/04 02:01:42 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for transfers to finish 2026/02/04 02:01:43 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2026/02/04 02:01:44 DEBUG : nested/sub dir/file: Uploading chunk 0, size=6, remain=0 2026/02/04 02:01:44 DEBUG : sub dir/hello world: size = 11 OK 2026/02/04 02:01:44 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/02/04 02:01:44 INFO : sub dir/hello world: Copied (new) 2026/02/04 02:01:44 INFO : sub dir/hello world: Deleted 2026/02/04 02:01:45 DEBUG : nested/sub dir/file: size = 6 OK 2026/02/04 02:01:45 DEBUG : nested/sub dir/file: md5 = 83d3784ea62518eafc60e98d84f877ad OK 2026/02/04 02:01:45 INFO : nested/sub dir/file: Copied (new) 2026/02/04 02:01:45 INFO : nested/sub dir/file: Deleted 2026/02/04 02:01:45 INFO : sub dir: Removing directory 2026/02/04 02:01:45 INFO : nested/sub dir: Removing directory 2026/02/04 02:01:45 INFO : nested: Removing directory 2026/02/04 02:01:45 DEBUG : Local file system at /tmp/rclone1482802323: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (6.41s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:01:48 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/04 02:01:48 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/02/04 02:01:48 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for checks to finish 2026/02/04 02:01:48 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for transfers to finish 2026/02/04 02:01:49 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2026/02/04 02:01:50 DEBUG : sub dir/hello world: size = 11 OK 2026/02/04 02:01:50 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/02/04 02:01:50 INFO : sub dir/hello world: Copied (new) 2026/02/04 02:01:50 INFO : sub dir/hello world: Deleted 2026/02/04 02:01:50 DEBUG : nested/sub dir/file: Uploading chunk 0, size=6, remain=0 2026/02/04 02:01:52 DEBUG : nested/sub dir/file: size = 6 OK 2026/02/04 02:01:52 DEBUG : nested/sub dir/file: md5 = 83d3784ea62518eafc60e98d84f877ad OK 2026/02/04 02:01:52 INFO : nested/sub dir/file: Copied (new) 2026/02/04 02:01:52 INFO : nested/sub dir/file: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (6.47s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:01:56 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2026/02/04 02:01:57 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2026/02/04 02:01:59 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2026/02/04 02:02:00 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-viyuret2pisa/dst" 2026/02/04 02:02:01 DEBUG : Starting OpenDrive session with ID: 9290f9738ffeede533d20bd8d4852ffbe045993237271d4c9a9b20c0882c80ad 2026/02/04 02:02:02 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-viyuret2pisa/backup" 2026/02/04 02:02:04 DEBUG : Starting OpenDrive session with ID: ccc670836f4d106c1cc901318e31ee5b2c0cc7339161ffd65c1ea89330f7c432 2026/02/04 02:02:06 DEBUG : one: size = 4 (Local file system at /tmp/rclone1482802323) 2026/02/04 02:02:06 DEBUG : two: size = 3 OK 2026/02/04 02:02:06 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa/dst': Waiting for checks to finish 2026/02/04 02:02:06 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/02/04 02:02:06 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-viyuret2pisa/dst') 2026/02/04 02:02:06 DEBUG : one: Sizes differ 2026/02/04 02:02:06 DEBUG : two: Unchanged skipping 2026/02/04 02:02:07 INFO : one: Moved (server-side) to: one-2019-01-01 2026/02/04 02:02:07 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa/dst': Waiting for transfers to finish 2026/02/04 02:02:08 DEBUG : one: Uploading chunk 0, size=4, remain=0 2026/02/04 02:02:10 DEBUG : one: size = 4 OK 2026/02/04 02:02:10 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2026/02/04 02:02:10 INFO : one: Copied (new) 2026/02/04 02:02:10 DEBUG : Waiting for deletions to finish 2026/02/04 02:02:11 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2026/02/04 02:02:11 INFO : three.txt: Moved into backup dir 2026/02/04 02:02:12 DEBUG : dst/three.txt: Uploading chunk 0, size=6, remain=0 2026/02/04 02:02:14 DEBUG : one: size = 5 (Local file system at /tmp/rclone1482802323) 2026/02/04 02:02:14 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-viyuret2pisa/dst') 2026/02/04 02:02:14 DEBUG : one: Sizes differ 2026/02/04 02:02:14 DEBUG : two: size = 3 OK 2026/02/04 02:02:14 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/02/04 02:02:14 DEBUG : two: Unchanged skipping 2026/02/04 02:02:14 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa/dst': Waiting for checks to finish 2026/02/04 02:02:14 INFO : one-2019-01-01: Deleted 2026/02/04 02:02:15 INFO : one: Moved (server-side) to: one-2019-01-01 2026/02/04 02:02:15 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa/dst': Waiting for transfers to finish 2026/02/04 02:02:16 DEBUG : one: Uploading chunk 0, size=5, remain=0 2026/02/04 02:02:17 DEBUG : one: size = 5 OK 2026/02/04 02:02:17 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2026/02/04 02:02:17 INFO : one: Copied (new) 2026/02/04 02:02:17 DEBUG : Waiting for deletions to finish 2026/02/04 02:02:18 INFO : three-2019-01-01.txt: Deleted 2026/02/04 02:02:18 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2026/02/04 02:02:18 INFO : three.txt: Moved into backup dir 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: TestSyncBackupDirWithSuffixKeepExtension (33.99s) === RUN TestSyncSuffix run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:02:30 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2026/02/04 02:02:31 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2026/02/04 02:02:33 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2026/02/04 02:02:34 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-viyuret2pisa/dst" 2026/02/04 02:02:35 DEBUG : Starting OpenDrive session with ID: 4c819e8d4a318caa33cb1d86254f35ba13c52e7f560ed1d05a5657ea3a9e3058 2026/02/04 02:02:35 DEBUG : one: size = 4 (Local file system at /tmp/rclone1482802323) 2026/02/04 02:02:35 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-viyuret2pisa/dst') 2026/02/04 02:02:35 DEBUG : one: Sizes differ 2026/02/04 02:02:36 DEBUG : one: same parent dir (ODFfOTc3OTA0MV9DUjR6dQ) - using file/rename instead of move_copy for one.bak 2026/02/04 02:02:36 INFO : one: Moved (server-side) to: one.bak 2026/02/04 02:02:37 DEBUG : one: Uploading chunk 0, size=4, remain=0 2026/02/04 02:02:38 DEBUG : one: size = 4 OK 2026/02/04 02:02:38 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2026/02/04 02:02:38 INFO : one: Copied (new) 2026/02/04 02:02:38 DEBUG : two: size = 3 OK 2026/02/04 02:02:38 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/02/04 02:02:38 DEBUG : two: Unchanged skipping 2026/02/04 02:02:38 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone1482802323) 2026/02/04 02:02:38 DEBUG : three.txt: size = 5 (OpenDrive root 'rclone-test-viyuret2pisa/dst') 2026/02/04 02:02:38 DEBUG : three.txt: Sizes differ 2026/02/04 02:02:38 DEBUG : three.txt: same parent dir (ODFfOTc3OTA0MV9DUjR6dQ) - using file/rename instead of move_copy for three.txt.bak 2026/02/04 02:02:39 INFO : three.txt: Moved (server-side) to: three.txt.bak 2026/02/04 02:02:39 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0 2026/02/04 02:02:40 DEBUG : three.txt: size = 6 OK 2026/02/04 02:02:40 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2026/02/04 02:02:40 INFO : three.txt: Copied (new) 2026/02/04 02:02:41 DEBUG : one: size = 5 (Local file system at /tmp/rclone1482802323) 2026/02/04 02:02:41 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-viyuret2pisa/dst') 2026/02/04 02:02:41 DEBUG : one: Sizes differ 2026/02/04 02:02:42 INFO : one.bak: Deleted 2026/02/04 02:02:42 DEBUG : one: same parent dir (ODFfOTc3OTA0MV9DUjR6dQ) - using file/rename instead of move_copy for one.bak 2026/02/04 02:02:42 INFO : one: Moved (server-side) to: one.bak 2026/02/04 02:02:43 DEBUG : one: Uploading chunk 0, size=5, remain=0 2026/02/04 02:02:44 DEBUG : one: size = 5 OK 2026/02/04 02:02:44 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2026/02/04 02:02:44 INFO : one: Copied (new) 2026/02/04 02:02:44 DEBUG : two: size = 3 OK 2026/02/04 02:02:44 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/02/04 02:02:44 DEBUG : two: Unchanged skipping 2026/02/04 02:02:44 DEBUG : three.txt: size = 19 (Local file system at /tmp/rclone1482802323) 2026/02/04 02:02:44 DEBUG : three.txt: size = 6 (OpenDrive root 'rclone-test-viyuret2pisa/dst') 2026/02/04 02:02:44 DEBUG : three.txt: Sizes differ 2026/02/04 02:02:44 INFO : three.txt.bak: Deleted 2026/02/04 02:02:45 DEBUG : three.txt: same parent dir (ODFfOTc3OTA0MV9DUjR6dQ) - using file/rename instead of move_copy for three.txt.bak 2026/02/04 02:02:45 INFO : three.txt: Moved (server-side) to: three.txt.bak 2026/02/04 02:02:46 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0 2026/02/04 02:02:46 DEBUG : three.txt: size = 19 OK 2026/02/04 02:02:46 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2026/02/04 02:02:46 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (20.08s) === RUN TestSyncSuffixKeepExtension run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" run.go:290: Failed to put "dst/one" to "OpenDrive root 'rclone-test-viyuret2pisa'": failed to create file: Parent folder is trashed (Error 403) --- FAIL: TestSyncSuffixKeepExtension (0.88s) === RUN TestFixCase run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:02:50 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0 2026/02/04 02:02:52 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0 run.go:290: Failed to put "SUBDIRA/subdirb/SUBDIRC/HELLO" to "OpenDrive root 'rclone-test-viyuret2pisa'": failed to get folder list: Directory doesn't exist (Error 404) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /usr/local/go/src/testing/testing.go:1125 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:290 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:297 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2679 Error: Not equal: expected: []string{} actual : []string{"SUBDIRA"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=7) "SUBDIRA" } Test: TestFixCase Messages: directories --- FAIL: TestFixCase (13.27s) === RUN TestNothingToTransferWithEmptyDirs run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:03:03 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/02/04 02:03:03 INFO : sub dir: Making directory 2026/02/04 02:03:03 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC sync_test.go:2899: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2899 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bilib/output.go:26 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2897 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestNothingToTransferWithEmptyDirs --- FAIL: TestNothingToTransferWithEmptyDirs (13.24s) === RUN TestMove run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:03:16 DEBUG : empty_dir: Making directory with metadata 2026/02/04 02:03:16 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/02/04 02:03:16 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:16 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:16 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:16 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:16 INFO : tictacempty_dir: Making directory 2026/02/04 02:03:17 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:17 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:17 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:17 INFO : tictactoe: Making directory 2026/02/04 02:03:17 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:17 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:17 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/02/04 02:03:17 INFO : tictactoe/tictactoe: Making directory 2026/02/04 02:03:18 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/02/04 02:03:18 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/02/04 02:03:18 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:18 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/02/04 02:03:18 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:18 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:18 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for checks to finish 2026/02/04 02:03:18 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for transfers to finish 2026/02/04 02:03:18 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/02/04 02:03:20 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/02/04 02:03:20 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/02/04 02:03:20 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:20 INFO : toe/toe/toe.txt: Deleted 2026/02/04 02:03:20 ERROR : Local file system at /tmp/rclone1482802323: not deleting directories as there were IO errors sync_transform_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:409 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMove --- FAIL: TestMove (6.35s) === RUN TestTransformFile run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:03:22 DEBUG : empty_dir: Making directory with metadata 2026/02/04 02:03:22 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/02/04 02:03:22 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:22 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:22 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:23 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:23 INFO : tictacempty_dir: Making directory 2026/02/04 02:03:23 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:23 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:23 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:23 INFO : tictactoe: Making directory 2026/02/04 02:03:23 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:23 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:23 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/02/04 02:03:23 INFO : tictactoe/tictactoe: Making directory 2026/02/04 02:03:24 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/02/04 02:03:24 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/02/04 02:03:24 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:24 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/02/04 02:03:24 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:24 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:24 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for checks to finish 2026/02/04 02:03:24 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for transfers to finish 2026/02/04 02:03:24 ERROR : toe/toe/toe.txt: Failed to copy: failed to get folder list: Directory doesn't exist (Error 404) 2026/02/04 02:03:24 ERROR : toe/toe/toe.txt: Not deleting source as copy failed: failed to get folder list: Directory doesn't exist (Error 404) 2026/02/04 02:03:24 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:24 ERROR : Local file system at /tmp/rclone1482802323: not deleting directories as there were IO errors sync_transform_test.go:428: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:428 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestTransformFile fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:428 Error: Not equal: expected: []string{} actual : []string{"tictactoe"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=9) "tictactoe" } Test: TestTransformFile Messages: directories --- FAIL: TestTransformFile (11.34s) === RUN TestManualTransformFile run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:03:34 DEBUG : Reset feature "Copy" 2026/02/04 02:03:34 DEBUG : Reset feature "Move" 2026/02/04 02:03:34 DEBUG : Reset feature "Copy" 2026/02/04 02:03:34 DEBUG : Reset feature "Move" 2026/02/04 02:03:34 DEBUG : empty_dir: Making directory with metadata 2026/02/04 02:03:34 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/02/04 02:03:34 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:34 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:34 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:34 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:34 INFO : tictacempty_dir: Making directory 2026/02/04 02:03:35 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/02/04 02:03:35 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:35 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:35 DEBUG : toe: transformed to: tictactoe 2026/02/04 02:03:35 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/02/04 02:03:35 INFO : tictactoe/tictactoe: Making directory 2026/02/04 02:03:35 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/02/04 02:03:35 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/02/04 02:03:35 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:35 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/02/04 02:03:35 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:35 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:35 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for checks to finish 2026/02/04 02:03:35 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for transfers to finish 2026/02/04 02:03:36 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/02/04 02:03:37 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/02/04 02:03:37 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/02/04 02:03:37 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/02/04 02:03:37 INFO : toe/toe/toe.txt: Deleted 2026/02/04 02:03:37 ERROR : Local file system at /tmp/rclone1482802323: not deleting directories as there were IO errors sync_transform_test.go:458: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:458 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestManualTransformFile run.go:130: removing dir "tictactoe/tictactoe" failed - try 1/3: folder not empty --- FAIL: TestManualTransformFile (7.29s) === RUN TestBase64 run.go:185: Remote "OpenDrive root 'rclone-test-viyuret2pisa'", Local "Local file system at /tmp/rclone1482802323", Modify Window "1s" 2026/02/04 02:03:41 DEBUG : toe: transformed to: dG9l 2026/02/04 02:03:41 DEBUG : toe: transformed to: dG9l 2026/02/04 02:03:41 INFO : dG9l: Making directory 2026/02/04 02:03:42 DEBUG : toe: transformed to: dG9l 2026/02/04 02:03:42 DEBUG : toe: transformed to: dG9l 2026/02/04 02:03:42 DEBUG : toe/toe: transformed to: dG9l/dG9l 2026/02/04 02:03:42 INFO : dG9l/dG9l: Making directory 2026/02/04 02:03:42 DEBUG : toe/toe: transformed to: dG9l/dG9l 2026/02/04 02:03:42 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2026/02/04 02:03:42 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2026/02/04 02:03:42 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/02/04 02:03:42 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2026/02/04 02:03:42 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for checks to finish 2026/02/04 02:03:42 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Waiting for transfers to finish 2026/02/04 02:03:43 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 0, size=11, remain=0 2026/02/04 02:03:44 DEBUG : dG9l/dG9l/dG9lLnR4dA==: size = 11 OK 2026/02/04 02:03:44 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/02/04 02:03:44 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2026/02/04 02:03:44 ERROR : OpenDrive root 'rclone-test-viyuret2pisa': not deleting files as there were IO errors 2026/02/04 02:03:44 ERROR : OpenDrive root 'rclone-test-viyuret2pisa': not deleting directories as there were IO errors sync_transform_test.go:482: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:482 Error: Received unexpected error: not deleting files as there were IO errors Test: TestBase64 --- FAIL: TestBase64 (5.26s) FAIL 2026/02/04 02:03:46 DEBUG : OpenDrive root 'rclone-test-viyuret2pisa': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestBase64|TestFixCase|TestManualTransformFile|TestMove|TestMoveWithDeleteEmptySrcDirs|TestMoveWithoutDeleteEmptySrcDirs|TestNothingToTransferWithEmptyDirs|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestTransformFile)$'" - Finished ERROR in 2m43.376353524s (try 2/5): exit status 1: Failed [TestSyncSuffixKeepExtension TestFixCase TestNothingToTransferWithEmptyDirs TestMove TestTransformFile TestManualTransformFile TestBase64]