"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestManualTransformFile|TestMove|TestRunTwice|TestSyncOverlapWithFilter|TestSyncSuffixKeepExtension|TestTransformFile)$'" - Starting (try 4/5) 2026/01/22 01:57:45 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-fatifuf9jata" 2026/01/22 01:57:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/22 01:57:46 DEBUG : Starting OpenDrive session with ID: 61ca97f10faf5f9e727a5439c299594c13ebad00391970e359c32c5feac527ff 2026/01/22 01:57:46 DEBUG : Creating backend with remote "/tmp/rclone3921783807" === RUN TestSyncOverlapWithFilter run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:57:46 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-fatifuf9jata/rclone-sync-test" 2026/01/22 01:57:46 DEBUG : Starting OpenDrive session with ID: 9d16005c9a4b4daaf0e31b3603bd2f28734e5b6c301037f74702225a7a914c4d 2026/01/22 01:57:47 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-fatifuf9jata/rclone-sync-test-include/layer2" 2026/01/22 01:57:48 DEBUG : Starting OpenDrive session with ID: b9f65c9fd4cc746285a50d29612a506e2ae062326b3273afe4eb03f65dac734c 2026/01/22 01:57:49 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-fatifuf9jata/rclone-sync-test-ignore-file" 2026/01/22 01:57:50 DEBUG : Starting OpenDrive session with ID: d7fbacbb69e3c46638bf5a291e85dd8acc392db940fac4825df983d3159a98e6 2026/01/22 01:57:52 DEBUG : rclone-sync-test-ignore-file/.ignore: Uploading chunk 0, size=1, remain=0 2026/01/22 01:57:54 DEBUG : rclone-sync-test: Excluded 2026/01/22 01:57:54 DEBUG : rclone-sync-test-ignore-file: Excluded 2026/01/22 01:57:54 DEBUG : rclone-sync-test-include/layer2: Excluded 2026/01/22 01:57:54 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata/rclone-sync-test': Waiting for checks to finish 2026/01/22 01:57:54 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata/rclone-sync-test': Waiting for transfers to finish 2026/01/22 01:57:54 DEBUG : Waiting for deletions to finish 2026/01/22 01:57:54 INFO : There was nothing to transfer 2026/01/22 01:57:55 DEBUG : rclone-sync-test: Excluded 2026/01/22 01:57:55 DEBUG : rclone-sync-test-ignore-file: Excluded 2026/01/22 01:57:56 DEBUG : rclone-sync-test-include/layer2: Excluded 2026/01/22 01:57:56 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:57:56 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:57:56 DEBUG : Waiting for deletions to finish 2026/01/22 01:57:56 INFO : rclone-sync-test-include: Removing directory 2026/01/22 01:57:56 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': deleted 1 directories 2026/01/22 01:57:56 INFO : There was nothing to transfer 2026/01/22 01:57:56 DEBUG : rclone-sync-test: Excluded 2026/01/22 01:57:57 DEBUG : rclone-sync-test-ignore-file: Excluded 2026/01/22 01:57:57 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata/rclone-sync-test-include/layer2': Waiting for checks to finish 2026/01/22 01:57:57 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata/rclone-sync-test-include/layer2': Waiting for transfers to finish 2026/01/22 01:57:57 DEBUG : Waiting for deletions to finish 2026/01/22 01:57:57 INFO : There was nothing to transfer 2026/01/22 01:57:57 DEBUG : rclone-sync-test: Excluded 2026/01/22 01:57:57 DEBUG : rclone-sync-test-ignore-file: Excluded 2026/01/22 01:57:57 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:57:57 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:57:57 DEBUG : Waiting for deletions to finish 2026/01/22 01:57:57 INFO : There was nothing to transfer 2026/01/22 01:57:58 DEBUG : Excluded 2026/01/22 01:57:58 DEBUG : rclone-sync-test: Excluded 2026/01/22 01:57:58 DEBUG : rclone-sync-test-ignore-file: Excluded 2026/01/22 01:57:58 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata/rclone-sync-test-ignore-file': Waiting for checks to finish 2026/01/22 01:57:58 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata/rclone-sync-test-ignore-file': Waiting for transfers to finish 2026/01/22 01:57:58 DEBUG : Waiting for deletions to finish 2026/01/22 01:57:58 INFO : There was nothing to transfer --- PASS: TestSyncOverlapWithFilter (13.55s) === RUN TestSyncSuffixKeepExtension run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:58:01 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2026/01/22 01:58:03 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2026/01/22 01:58:05 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2026/01/22 01:58:07 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-fatifuf9jata/dst" 2026/01/22 01:58:07 DEBUG : Starting OpenDrive session with ID: a6538b3448a5c4e2ac19ea1e075279626b95870ea52a3e1910a1e0e81e3952f5 2026/01/22 01:58:08 DEBUG : one: size = 4 (Local file system at /tmp/rclone3921783807) 2026/01/22 01:58:08 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-fatifuf9jata/dst') 2026/01/22 01:58:08 DEBUG : one: Sizes differ 2026/01/22 01:58:08 DEBUG : one: same parent dir (ODFfOTcxMTc1NF9nenNjRA) - using file/rename instead of move_copy for one-2019-01-01 2026/01/22 01:58:08 INFO : one: Moved (server-side) to: one-2019-01-01 2026/01/22 01:58:09 DEBUG : one: Uploading chunk 0, size=4, remain=0 2026/01/22 01:58:10 DEBUG : one: size = 4 OK 2026/01/22 01:58:10 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2026/01/22 01:58:10 INFO : one: Copied (new) 2026/01/22 01:58:10 DEBUG : two: size = 3 OK 2026/01/22 01:58:10 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/22 01:58:10 DEBUG : two: Unchanged skipping 2026/01/22 01:58:10 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone3921783807) 2026/01/22 01:58:10 DEBUG : three.txt: size = 5 (OpenDrive root 'rclone-test-fatifuf9jata/dst') 2026/01/22 01:58:10 DEBUG : three.txt: Sizes differ 2026/01/22 01:58:11 DEBUG : three.txt: same parent dir (ODFfOTcxMTc1NF9nenNjRA) - using file/rename instead of move_copy for three-2019-01-01.txt 2026/01/22 01:58:11 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2026/01/22 01:58:11 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0 2026/01/22 01:58:12 DEBUG : three.txt: size = 6 OK 2026/01/22 01:58:12 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2026/01/22 01:58:12 INFO : three.txt: Copied (new) 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:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2522 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3) got dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (6), dst/two (3) fstest.go:143: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:149 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2522 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: OpenDrive root 'rclone-test-fatifuf9jata'/dst/three-2019-01-01.txt: md5 hash incorrect - expecting "35d6d33467aae9a2e3dccb4b6b027878" got "91341eed84691a83caea73aa785736d5" fstest.go:150: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:150 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2522 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Not equal: expected: 5 actual : 6 Test: TestSyncSuffixKeepExtension Messages: dst/three-2019-01-01.txt: size incorrect file=5 vs obj=6 fstest.go:203: Not found "dst/three.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2522 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Not equal: expected: 0 actual : 1 Test: TestSyncSuffixKeepExtension Messages: 1 objects not found 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:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2528 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3) got dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (6), dst/two (3) fstest.go:143: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:149 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2528 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: OpenDrive root 'rclone-test-fatifuf9jata'/dst/three-2019-01-01.txt: md5 hash incorrect - expecting "35d6d33467aae9a2e3dccb4b6b027878" got "91341eed84691a83caea73aa785736d5" fstest.go:150: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:150 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2528 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Not equal: expected: 5 actual : 6 Test: TestSyncSuffixKeepExtension Messages: dst/three-2019-01-01.txt: size incorrect file=5 vs obj=6 fstest.go:203: Not found "dst/three.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2528 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Not equal: expected: 0 actual : 1 Test: TestSyncSuffixKeepExtension Messages: 1 objects not found 2026/01/22 01:58:30 DEBUG : one: size = 5 (Local file system at /tmp/rclone3921783807) 2026/01/22 01:58:30 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-fatifuf9jata/dst') 2026/01/22 01:58:30 DEBUG : one: Sizes differ 2026/01/22 01:58:30 INFO : one-2019-01-01: Deleted 2026/01/22 01:58:30 DEBUG : one: same parent dir (ODFfOTcxMTc1NF9nenNjRA) - using file/rename instead of move_copy for one-2019-01-01 2026/01/22 01:58:30 INFO : one: Moved (server-side) to: one-2019-01-01 2026/01/22 01:58:31 DEBUG : one: Uploading chunk 0, size=5, remain=0 2026/01/22 01:58:32 DEBUG : one: size = 5 OK 2026/01/22 01:58:32 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2026/01/22 01:58:32 INFO : one: Copied (new) 2026/01/22 01:58:32 DEBUG : two: size = 3 OK 2026/01/22 01:58:32 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/22 01:58:32 DEBUG : two: Unchanged skipping 2026/01/22 01:58:32 DEBUG : three.txt: Need to transfer - File not found at Destination 2026/01/22 01:58:33 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0 2026/01/22 01:58:34 DEBUG : three.txt: size = 19 OK 2026/01/22 01:58:34 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2026/01/22 01:58:34 INFO : three.txt: Copied (new) run.go:130: removing dir "dst" failed - try 1/3: folder not empty 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 --- FAIL: TestSyncSuffixKeepExtension (45.64s) === RUN TestAllTag run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:58:45 DEBUG : empty_dir: Making directory with metadata 2026/01/22 01:58:45 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/01/22 01:58:45 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:45 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:58:45 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:58:45 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:58:45 INFO : tictacempty_dir: Making directory 2026/01/22 01:58:46 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:58:46 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:46 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:46 INFO : tictactoe: Making directory 2026/01/22 01:58:46 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:46 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:46 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:58:46 INFO : tictactoe/tictactoe: Making directory 2026/01/22 01:58:46 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:58:46 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/01/22 01:58:46 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:58:46 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/01/22 01:58:46 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:58:46 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:58:46 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:58:48 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/01/22 01:58:49 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/01/22 01:58:49 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/01/22 01:58:49 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:58:49 DEBUG : Waiting for deletions to finish 2026/01/22 01:58:49 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:58:49 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:49 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:58:49 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:58:49 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:49 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:50 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/01/22 01:58:50 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/01/22 01:58:50 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/01/22 01:58:50 DEBUG : tictactoe/tictactoe/tictactoe.txt: OK 2026/01/22 01:58:50 NOTICE: OpenDrive root 'rclone-test-fatifuf9jata': 0 differences found 2026/01/22 01:58:50 NOTICE: OpenDrive root 'rclone-test-fatifuf9jata': 1 matching files --- PASS: TestAllTag (6.81s) === RUN TestRunTwice run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:58:52 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:52 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:52 INFO : tictactoe: Making directory 2026/01/22 01:58:52 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:52 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:52 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:58:52 INFO : tictactoe/tictactoe: Making directory 2026/01/22 01:58:53 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:58:53 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2026/01/22 01:58:53 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/01/22 01:58:53 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2026/01/22 01:58:53 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:58:53 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:58:54 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 0, size=11, remain=0 2026/01/22 01:58:55 DEBUG : tictactoe/tictactoe/toe.txt: size = 11 OK 2026/01/22 01:58:55 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/01/22 01:58:55 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt 2026/01/22 01:58:55 DEBUG : Waiting for deletions to finish 2026/01/22 01:58:55 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:56 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:56 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:58:56 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:58:56 DEBUG : tictactoe/tictactoe/toe.txt: size = 11 OK 2026/01/22 01:58:56 DEBUG : toe/toe/toe.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/22 01:58:56 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:58:56 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2026/01/22 01:58:56 DEBUG : toe/toe/toe.txt: Unchanged skipping 2026/01/22 01:58:56 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:58:56 DEBUG : Waiting for deletions to finish --- PASS: TestRunTwice (6.35s) === RUN TestConflicting run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:58:58 INFO : toe: Making directory 2026/01/22 01:58:59 INFO : toe/toe: Making directory 2026/01/22 01:59:00 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2026/01/22 01:59:00 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:59:00 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:59:00 DEBUG : toe/toe/toe: Uploading chunk 0, size=11, remain=0 2026/01/22 01:59:01 DEBUG : toe/toe/toe: size = 11 OK 2026/01/22 01:59:01 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/01/22 01:59:01 INFO : toe/toe/toe: Copied (new) 2026/01/22 01:59:01 DEBUG : Waiting for deletions to finish --- PASS: TestConflicting (5.51s) === RUN TestMove run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:59:04 DEBUG : empty_dir: Making directory with metadata 2026/01/22 01:59:04 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/01/22 01:59:04 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:04 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:04 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:04 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:04 INFO : tictacempty_dir: Making directory 2026/01/22 01:59:04 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:04 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:04 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:04 INFO : tictactoe: Making directory 2026/01/22 01:59:05 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:05 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:05 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:59:05 INFO : tictactoe/tictactoe: Making directory 2026/01/22 01:59:05 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:59:05 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/01/22 01:59:05 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:05 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/01/22 01:59:05 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:05 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:05 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:59:05 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:59:06 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/01/22 01:59:07 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/01/22 01:59:07 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/01/22 01:59:07 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:07 INFO : toe/toe/toe.txt: Deleted 2026/01/22 01:59:07 INFO : toe/toe: Removing directory 2026/01/22 01:59:07 INFO : toe: Removing directory 2026/01/22 01:59:07 INFO : empty_dir: Removing directory 2026/01/22 01:59:07 DEBUG : Local file system at /tmp/rclone3921783807: deleted 3 directories --- PASS: TestMove (6.69s) === RUN TestTransformFile run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:59:10 DEBUG : empty_dir: Making directory with metadata 2026/01/22 01:59:10 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/01/22 01:59:10 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:10 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:10 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:11 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:11 INFO : tictacempty_dir: Making directory 2026/01/22 01:59:11 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:11 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:11 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:11 INFO : tictactoe: Making directory 2026/01/22 01:59:11 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:11 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:11 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:59:11 INFO : tictactoe/tictactoe: Making directory 2026/01/22 01:59:12 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:59:12 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/01/22 01:59:12 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:12 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/01/22 01:59:12 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:12 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:12 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:59:12 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:59:12 ERROR : toe/toe/toe.txt: Failed to copy: failed to get folder list: Directory doesn't exist (Error 404) 2026/01/22 01:59:12 ERROR : toe/toe/toe.txt: Not deleting source as copy failed: failed to get folder list: Directory doesn't exist (Error 404) 2026/01/22 01:59:12 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:12 ERROR : Local file system at /tmp/rclone3921783807: 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:292: Sleeping for 6s just to make sure --- FAIL: TestTransformFile (10.05s) === RUN TestManualTransformFile run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:59:21 DEBUG : Reset feature "Copy" 2026/01/22 01:59:21 DEBUG : Reset feature "Move" 2026/01/22 01:59:21 DEBUG : Reset feature "Copy" 2026/01/22 01:59:21 DEBUG : Reset feature "Move" 2026/01/22 01:59:21 DEBUG : empty_dir: Making directory with metadata 2026/01/22 01:59:21 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/01/22 01:59:21 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:21 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:21 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:21 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:21 INFO : tictacempty_dir: Making directory 2026/01/22 01:59:21 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/01/22 01:59:21 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:21 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:21 INFO : tictactoe: Making directory 2026/01/22 01:59:21 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:21 DEBUG : toe: transformed to: tictactoe 2026/01/22 01:59:21 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:59:21 INFO : tictactoe/tictactoe: Making directory 2026/01/22 01:59:22 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/01/22 01:59:22 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/01/22 01:59:22 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:22 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/01/22 01:59:22 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:22 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:22 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:59:22 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:59:22 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/01/22 01:59:23 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/01/22 01:59:23 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/01/22 01:59:23 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/01/22 01:59:23 INFO : toe/toe/toe.txt: Deleted 2026/01/22 01:59:23 ERROR : Local file system at /tmp/rclone3921783807: 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 --- FAIL: TestManualTransformFile (4.66s) === RUN TestBase64 run.go:185: Remote "OpenDrive root 'rclone-test-fatifuf9jata'", Local "Local file system at /tmp/rclone3921783807", Modify Window "1s" 2026/01/22 01:59:25 DEBUG : toe: transformed to: dG9l 2026/01/22 01:59:25 DEBUG : toe: transformed to: dG9l 2026/01/22 01:59:25 INFO : dG9l: Making directory 2026/01/22 01:59:26 DEBUG : toe: transformed to: dG9l 2026/01/22 01:59:26 DEBUG : toe: transformed to: dG9l 2026/01/22 01:59:26 DEBUG : toe/toe: transformed to: dG9l/dG9l 2026/01/22 01:59:26 INFO : dG9l/dG9l: Making directory 2026/01/22 01:59:26 DEBUG : toe/toe: transformed to: dG9l/dG9l 2026/01/22 01:59:26 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2026/01/22 01:59:26 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2026/01/22 01:59:26 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/01/22 01:59:26 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for checks to finish 2026/01/22 01:59:26 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Waiting for transfers to finish 2026/01/22 01:59:26 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2026/01/22 01:59:27 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 0, size=11, remain=0 2026/01/22 01:59:28 DEBUG : dG9l/dG9l/dG9lLnR4dA==: size = 11 OK 2026/01/22 01:59:28 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/01/22 01:59:28 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2026/01/22 01:59:28 ERROR : OpenDrive root 'rclone-test-fatifuf9jata': not deleting files as there were IO errors 2026/01/22 01:59:28 ERROR : OpenDrive root 'rclone-test-fatifuf9jata': 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 (3.96s) FAIL 2026/01/22 01:59:29 DEBUG : OpenDrive root 'rclone-test-fatifuf9jata': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestManualTransformFile|TestMove|TestRunTwice|TestSyncOverlapWithFilter|TestSyncSuffixKeepExtension|TestTransformFile)$'" - Finished ERROR in 1m44.540093126s (try 4/5): exit status 1: Failed [TestSyncSuffixKeepExtension TestTransformFile TestManualTransformFile TestBase64]