"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestBase64|TestConflicting|TestManualTransformFile|TestMove|TestRunTwice|TestSyncAfterChangingContentsOnly|TestSyncSuffixKeepExtension|TestSyncWithUpdateOlder|TestTransformFile)$'" - Starting (try 2/5) 2026/03/28 04:09:44 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-refobul0sepe" 2026/03/28 04:09:44 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/03/28 04:09:45 DEBUG : Starting OpenDrive session with ID: 520c830e268e7c73ce90602e8ae640ad9bdfea07d9f31d42d46a66d1ebd869ba 2026/03/28 04:09:45 DEBUG : Creating backend with remote "/tmp/rclone713955750" === RUN TestSyncAfterChangingContentsOnly run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:09:46 DEBUG : potato: Uploading chunk 0, size=21, remain=0 2026/03/28 04:09:47 DEBUG : potato: size = 21 OK 2026/03/28 04:09:47 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2026/03/28 04:09:47 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:09:47 DEBUG : potato: md5 = e4cb6955d9106df6263c45fcfc10f163 (Local file system at /tmp/rclone713955750) 2026/03/28 04:09:47 DEBUG : potato: md5 = 100defcf18c42a1e0dc42a789b107cd2 (OpenDrive root 'rclone-test-refobul0sepe') 2026/03/28 04:09:47 DEBUG : potato: md5 differ 2026/03/28 04:09:47 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:09:48 DEBUG : potato: Uploading chunk 0, size=21, remain=0 2026/03/28 04:09:49 DEBUG : potato: size = 21 OK 2026/03/28 04:09:49 DEBUG : potato: md5 = e4cb6955d9106df6263c45fcfc10f163 OK 2026/03/28 04:09:49 INFO : potato: Copied (replaced existing) 2026/03/28 04:09:49 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (4.22s) === RUN TestSyncWithUpdateOlder run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:09:50 DEBUG : one: Uploading chunk 0, size=3, remain=0 2026/03/28 04:09:52 DEBUG : two: Uploading chunk 0, size=3, remain=0 2026/03/28 04:09:54 DEBUG : three: Uploading chunk 0, size=5, remain=0 2026/03/28 04:09:55 DEBUG : four: Uploading chunk 0, size=8, remain=0 2026/03/28 04:09:57 DEBUG : five: Need to transfer - File not found at Destination 2026/03/28 04:09:57 DEBUG : four: size = 4 (Local file system at /tmp/rclone713955750) 2026/03/28 04:09:57 DEBUG : four: size = 8 (OpenDrive root 'rclone-test-refobul0sepe') 2026/03/28 04:09:57 DEBUG : four: Sizes differ 2026/03/28 04:09:57 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2026/03/28 04:09:57 DEBUG : one: Destination is newer than source, skipping 2026/03/28 04:09:57 DEBUG : three: size = 5 OK 2026/03/28 04:09:57 DEBUG : three: Sizes identical 2026/03/28 04:09:57 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2026/03/28 04:09:57 DEBUG : two: size = 3 OK 2026/03/28 04:09:57 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:09:57 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 (Local file system at /tmp/rclone713955750) 2026/03/28 04:09:57 DEBUG : two: md5 = 0f82d86afa0f5dc965c5c15aca58dcfb (OpenDrive root 'rclone-test-refobul0sepe') 2026/03/28 04:09:57 DEBUG : two: md5 differ 2026/03/28 04:09:57 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:09:57 DEBUG : four: Uploading chunk 0, size=4, remain=0 2026/03/28 04:09:57 DEBUG : two: Uploading chunk 0, size=3, remain=0 2026/03/28 04:09:58 DEBUG : five: Uploading chunk 0, size=4, remain=0 2026/03/28 04:09:58 DEBUG : four: size = 4 OK 2026/03/28 04:09:58 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK 2026/03/28 04:09:58 INFO : four: Copied (replaced existing) 2026/03/28 04:09:59 DEBUG : two: size = 3 OK 2026/03/28 04:09:59 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2026/03/28 04:09:59 INFO : two: Copied (replaced existing) 2026/03/28 04:09:59 DEBUG : five: size = 4 OK 2026/03/28 04:09:59 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK 2026/03/28 04:09:59 INFO : five: Copied (new) 2026/03/28 04:09:59 DEBUG : Waiting for deletions to finish 2026/03/28 04:09:59 DEBUG : five: size = 4 OK 2026/03/28 04:09:59 DEBUG : four: size = 4 OK 2026/03/28 04:09:59 DEBUG : one: Destination is newer than source, skipping 2026/03/28 04:09:59 DEBUG : three: size = 5 OK 2026/03/28 04:09:59 DEBUG : two: size = 3 OK 2026/03/28 04:09:59 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:09:59 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK 2026/03/28 04:09:59 DEBUG : five: Size and md5 of src and dst objects identical 2026/03/28 04:09:59 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2026/03/28 04:09:59 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK 2026/03/28 04:09:59 DEBUG : four: Size and md5 of src and dst objects identical 2026/03/28 04:09:59 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2026/03/28 04:09:59 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 (Local file system at /tmp/rclone713955750) 2026/03/28 04:09:59 DEBUG : three: md5 = 413af0de1f97a2155acf2b8b26ab36e2 (OpenDrive root 'rclone-test-refobul0sepe') 2026/03/28 04:09:59 DEBUG : three: md5 differ 2026/03/28 04:09:59 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2026/03/28 04:09:59 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2026/03/28 04:09:59 DEBUG : two: Size and md5 of src and dst objects identical 2026/03/28 04:09:59 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2026/03/28 04:09:59 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:09:59 DEBUG : three: Uploading chunk 0, size=5, remain=0 2026/03/28 04:10:00 DEBUG : three: size = 5 OK 2026/03/28 04:10:00 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 OK 2026/03/28 04:10:00 INFO : three: Copied (replaced existing) 2026/03/28 04:10:00 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (12.28s) === RUN TestSyncSuffixKeepExtension run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:10:03 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2026/03/28 04:10:04 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2026/03/28 04:10:06 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2026/03/28 04:10:07 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-refobul0sepe/dst" 2026/03/28 04:10:08 DEBUG : Starting OpenDrive session with ID: 00f688805a589288f644ef940ca85e9ca9e5f4e14a737b56071e60df7fbbcf79 2026/03/28 04:10:08 DEBUG : one: size = 4 (Local file system at /tmp/rclone713955750) 2026/03/28 04:10:08 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-refobul0sepe/dst') 2026/03/28 04:10:08 DEBUG : one: Sizes differ 2026/03/28 04:10:08 DEBUG : one: same parent dir (ODFfMTEwMzYyMjlfczRsTWU) - using file/rename instead of move_copy for one-2019-01-01 2026/03/28 04:10:09 INFO : one: Moved (server-side) to: one-2019-01-01 2026/03/28 04:10:09 DEBUG : one: Uploading chunk 0, size=4, remain=0 2026/03/28 04:10:10 DEBUG : one: size = 4 OK 2026/03/28 04:10:10 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2026/03/28 04:10:10 INFO : one: Copied (new) 2026/03/28 04:10:10 DEBUG : two: size = 3 OK 2026/03/28 04:10:10 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/03/28 04:10:10 DEBUG : two: Unchanged skipping 2026/03/28 04:10:10 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone713955750) 2026/03/28 04:10:10 DEBUG : three.txt: size = 5 (OpenDrive root 'rclone-test-refobul0sepe/dst') 2026/03/28 04:10:10 DEBUG : three.txt: Sizes differ 2026/03/28 04:10:11 DEBUG : three.txt: same parent dir (ODFfMTEwMzYyMjlfczRsTWU) - using file/rename instead of move_copy for three-2019-01-01.txt 2026/03/28 04:10:11 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2026/03/28 04:10:12 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0 2026/03/28 04:10:13 DEBUG : three.txt: size = 6 OK 2026/03/28 04:10:13 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2026/03/28 04:10:13 INFO : three.txt: Copied (new) 2026/03/28 04:10:13 DEBUG : one: size = 5 (Local file system at /tmp/rclone713955750) 2026/03/28 04:10:13 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-refobul0sepe/dst') 2026/03/28 04:10:13 DEBUG : one: Sizes differ 2026/03/28 04:10:14 INFO : one-2019-01-01: Deleted 2026/03/28 04:10:14 DEBUG : one: same parent dir (ODFfMTEwMzYyMjlfczRsTWU) - using file/rename instead of move_copy for one-2019-01-01 2026/03/28 04:10:14 INFO : one: Moved (server-side) to: one-2019-01-01 2026/03/28 04:10:15 DEBUG : one: Uploading chunk 0, size=5, remain=0 2026/03/28 04:10:16 DEBUG : one: size = 5 OK 2026/03/28 04:10:16 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2026/03/28 04:10:16 INFO : one: Copied (new) 2026/03/28 04:10:16 DEBUG : two: size = 3 OK 2026/03/28 04:10:16 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/03/28 04:10:16 DEBUG : two: Unchanged skipping 2026/03/28 04:10:16 DEBUG : three.txt: size = 19 (Local file system at /tmp/rclone713955750) 2026/03/28 04:10:16 DEBUG : three.txt: size = 6 (OpenDrive root 'rclone-test-refobul0sepe/dst') 2026/03/28 04:10:16 DEBUG : three.txt: Sizes differ 2026/03/28 04:10:16 INFO : three-2019-01-01.txt: Deleted 2026/03/28 04:10:17 DEBUG : three.txt: same parent dir (ODFfMTEwMzYyMjlfczRsTWU) - using file/rename instead of move_copy for three-2019-01-01.txt 2026/03/28 04:10:17 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2026/03/28 04:10:17 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0 2026/03/28 04:10:18 DEBUG : three.txt: size = 19 OK 2026/03/28 04:10:18 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2026/03/28 04:10:18 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:2552 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (5), dst/one-2019-01-01 (4), dst/three-2019-01-01.txt (6), dst/three.txt (19), dst/two (3) got dst/one (5), dst/one-2019-01-01 (4), dst/three-2019-01-01.txt (19), 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:2552 /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-refobul0sepe'/dst/three-2019-01-01.txt: md5 hash incorrect - expecting "91341eed84691a83caea73aa785736d5" got "423e01c5e84a30d129b97aedb6e219a9" 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:2552 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Not equal: expected: 6 actual : 19 Test: TestSyncSuffixKeepExtension Messages: dst/three-2019-01-01.txt: size incorrect file=6 vs obj=19 fstest.go:127: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:132 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:151 /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:2552 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2555 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: dst/three-2019-01-01.txt: Modification time difference too big |-95576h54m52.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2011-12-30 12:59:59 +0000 UTC) (precision 1s) 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:2552 /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 --- FAIL: TestSyncSuffixKeepExtension (26.34s) === RUN TestRunTwice run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:10:28 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:28 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:28 INFO : tictactoe: Making directory 2026/03/28 04:10:28 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:28 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:28 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:28 INFO : tictactoe/tictactoe: Making directory 2026/03/28 04:10:29 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:29 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2026/03/28 04:10:29 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/03/28 04:10:29 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:10:29 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:10:29 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2026/03/28 04:10:29 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 0, size=11, remain=0 2026/03/28 04:10:31 DEBUG : tictactoe/tictactoe/toe.txt: size = 11 OK 2026/03/28 04:10:31 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/03/28 04:10:31 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt 2026/03/28 04:10:31 DEBUG : Waiting for deletions to finish 2026/03/28 04:10:31 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:31 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:31 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:31 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:32 DEBUG : tictactoe/tictactoe/toe.txt: size = 11 OK 2026/03/28 04:10:32 DEBUG : toe/toe/toe.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/03/28 04:10:32 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2026/03/28 04:10:32 DEBUG : toe/toe/toe.txt: Unchanged skipping 2026/03/28 04:10:32 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:10:32 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:10:32 DEBUG : Waiting for deletions to finish --- PASS: TestRunTwice (5.77s) === RUN TestConflicting run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:10:34 INFO : toe: Making directory 2026/03/28 04:10:35 INFO : toe/toe: Making directory 2026/03/28 04:10:35 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2026/03/28 04:10:35 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:10:35 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:10:36 DEBUG : toe/toe/toe: Uploading chunk 0, size=11, remain=0 2026/03/28 04:10:37 DEBUG : toe/toe/toe: size = 11 OK 2026/03/28 04:10:37 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/03/28 04:10:37 INFO : toe/toe/toe: Copied (new) 2026/03/28 04:10:37 DEBUG : Waiting for deletions to finish --- PASS: TestConflicting (5.25s) === RUN TestMove run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:10:39 DEBUG : empty_dir: Making directory with metadata 2026/03/28 04:10:39 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/03/28 04:10:39 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:39 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:39 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:39 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:39 INFO : tictacempty_dir: Making directory 2026/03/28 04:10:39 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:39 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:39 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:39 INFO : tictactoe: Making directory 2026/03/28 04:10:40 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:40 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:40 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:40 INFO : tictactoe/tictactoe: Making directory 2026/03/28 04:10:40 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:40 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/03/28 04:10:40 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:40 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/03/28 04:10:40 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:40 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:40 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:10:40 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:10:41 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/03/28 04:10:42 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/03/28 04:10:42 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/03/28 04:10:42 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:42 INFO : toe/toe/toe.txt: Deleted 2026/03/28 04:10:42 INFO : toe/toe: Removing directory 2026/03/28 04:10:42 INFO : toe: Removing directory 2026/03/28 04:10:42 INFO : empty_dir: Removing directory 2026/03/28 04:10:42 DEBUG : Local file system at /tmp/rclone713955750: deleted 3 directories --- PASS: TestMove (5.27s) === RUN TestTransformFile run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:10:44 DEBUG : empty_dir: Making directory with metadata 2026/03/28 04:10:44 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/03/28 04:10:44 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:44 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:44 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:44 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:44 INFO : tictacempty_dir: Making directory 2026/03/28 04:10:45 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:45 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:45 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:45 INFO : tictactoe: Making directory 2026/03/28 04:10:45 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:45 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:45 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:45 INFO : tictactoe/tictactoe: Making directory 2026/03/28 04:10:45 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:45 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/03/28 04:10:45 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:45 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/03/28 04:10:45 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:10:45 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:45 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:45 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:10:46 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/03/28 04:10:47 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/03/28 04:10:47 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/03/28 04:10:47 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:47 INFO : toe/toe/toe.txt: Deleted 2026/03/28 04:10:47 ERROR : Local file system at /tmp/rclone713955750: 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 run.go:130: removing dir "tictactoe/tictactoe" failed - try 1/3: folder not empty --- FAIL: TestTransformFile (6.08s) === RUN TestManualTransformFile run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:10:50 DEBUG : Reset feature "Copy" 2026/03/28 04:10:50 DEBUG : Reset feature "Move" 2026/03/28 04:10:50 DEBUG : Reset feature "Copy" 2026/03/28 04:10:50 DEBUG : Reset feature "Move" 2026/03/28 04:10:50 DEBUG : empty_dir: Making directory with metadata 2026/03/28 04:10:50 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/03/28 04:10:50 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:50 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:50 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:50 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:50 INFO : tictacempty_dir: Making directory 2026/03/28 04:10:51 DEBUG : empty_dir: transformed to: tictacempty_dir 2026/03/28 04:10:51 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:51 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:51 INFO : tictactoe: Making directory 2026/03/28 04:10:51 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:51 DEBUG : toe: transformed to: tictactoe 2026/03/28 04:10:51 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:51 INFO : tictactoe/tictactoe: Making directory 2026/03/28 04:10:51 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2026/03/28 04:10:51 DEBUG : toe.txt: transformed to: tictactoe.txt 2026/03/28 04:10:51 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:51 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/03/28 04:10:51 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:51 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:51 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:10:51 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:10:52 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2026/03/28 04:10:53 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK 2026/03/28 04:10:53 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/03/28 04:10:53 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2026/03/28 04:10:53 INFO : toe/toe/toe.txt: Deleted 2026/03/28 04:10:53 ERROR : Local file system at /tmp/rclone713955750: 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.80s) === RUN TestBase64 run.go:185: Remote "OpenDrive root 'rclone-test-refobul0sepe'", Local "Local file system at /tmp/rclone713955750", Modify Window "1s" 2026/03/28 04:10:55 DEBUG : toe: transformed to: dG9l 2026/03/28 04:10:55 DEBUG : toe: transformed to: dG9l 2026/03/28 04:10:55 INFO : dG9l: Making directory 2026/03/28 04:10:55 DEBUG : toe: transformed to: dG9l 2026/03/28 04:10:55 DEBUG : toe: transformed to: dG9l 2026/03/28 04:10:55 DEBUG : toe/toe: transformed to: dG9l/dG9l 2026/03/28 04:10:55 INFO : dG9l/dG9l: Making directory 2026/03/28 04:10:56 DEBUG : toe/toe: transformed to: dG9l/dG9l 2026/03/28 04:10:56 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2026/03/28 04:10:56 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2026/03/28 04:10:56 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2026/03/28 04:10:56 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2026/03/28 04:10:56 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for checks to finish 2026/03/28 04:10:56 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Waiting for transfers to finish 2026/03/28 04:10:57 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 0, size=11, remain=0 2026/03/28 04:10:58 DEBUG : dG9l/dG9l/dG9lLnR4dA==: size = 11 OK 2026/03/28 04:10:58 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2026/03/28 04:10:58 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2026/03/28 04:10:58 ERROR : OpenDrive root 'rclone-test-refobul0sepe': not deleting files as there were IO errors 2026/03/28 04:10:58 ERROR : OpenDrive root 'rclone-test-refobul0sepe': 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 (4.33s) FAIL 2026/03/28 04:10:59 DEBUG : OpenDrive root 'rclone-test-refobul0sepe': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestBase64|TestConflicting|TestManualTransformFile|TestMove|TestRunTwice|TestSyncAfterChangingContentsOnly|TestSyncSuffixKeepExtension|TestSyncWithUpdateOlder|TestTransformFile)$'" - Finished ERROR in 1m15.705057808s (try 2/5): exit status 1: Failed [TestSyncSuffixKeepExtension TestTransformFile TestManualTransformFile TestBase64]