"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestDirTag|TestFileTag|TestFixCase|TestManualTransformFile|TestMove|TestNoTag|TestRunTwice|TestSyncBackupDirSuffixOnly|TestSyncConcurrentTruncate|TestSyncIgnoreExisting|TestSyncSuffix|TestTransformFile)$'" - Starting (try 2/5)
2025/12/07 03:28:15 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qefejon9faco"
2025/12/07 03:28:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/07 03:28:15 DEBUG : Starting OpenDrive session with ID: f58269d2141636124329b0f853a2c52701887863329143d07d097f1003100c0c
2025/12/07 03:28:16 DEBUG : Creating backend with remote "/tmp/rclone1079497815"
=== RUN   TestSyncIgnoreExisting
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:28:16 DEBUG : existing: Need to transfer - File not found at Destination
2025/12/07 03:28:16 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:28:16 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:28:17 DEBUG : existing: Uploading chunk 0, size=6, remain=0
2025/12/07 03:28:18 DEBUG : existing: size = 6 OK
2025/12/07 03:28:18 DEBUG : existing: md5 = 8ee2027983915ec78acc45027d874316 OK
2025/12/07 03:28:18 INFO  : existing: Copied (new)
2025/12/07 03:28:18 DEBUG : Waiting for deletions to finish
2025/12/07 03:28:19 DEBUG : existing: Destination exists, skipping
2025/12/07 03:28:19 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:28:19 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:28:19 DEBUG : Waiting for deletions to finish
2025/12/07 03:28:19 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreExisting (3.70s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:28:21 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/12/07 03:28:22 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2025/12/07 03:28:24 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2025/12/07 03:28:26 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qefejon9faco/dst"
2025/12/07 03:28:26 DEBUG : Starting OpenDrive session with ID: 3df0420e6316bbeb9c858ec89c66e4cec71b145107436ff0be5ded4c6d6637fc
2025/12/07 03:28:27 DEBUG : one: size = 4 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:28:27 DEBUG : two: size = 3 OK
2025/12/07 03:28:27 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:28:27 DEBUG : OpenDrive root 'rclone-test-qefejon9faco/dst': Waiting for checks to finish
2025/12/07 03:28:27 DEBUG : two: Unchanged skipping
2025/12/07 03:28:27 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-qefejon9faco/dst')
2025/12/07 03:28:27 DEBUG : one: Sizes differ
2025/12/07 03:28:27 DEBUG : one: same parent dir (ODFfOTYzODM5MF8yYkg0cQ) - using file/rename instead of move_copy for one.bak
2025/12/07 03:28:28 INFO  : one: Moved (server-side) to: one.bak
2025/12/07 03:28:28 DEBUG : OpenDrive root 'rclone-test-qefejon9faco/dst': Waiting for transfers to finish
2025/12/07 03:28:28 DEBUG : one: Uploading chunk 0, size=4, remain=0
2025/12/07 03:28:30 DEBUG : one: size = 4 OK
2025/12/07 03:28:30 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/12/07 03:28:30 INFO  : one: Copied (new)
2025/12/07 03:28:30 DEBUG : Waiting for deletions to finish
2025/12/07 03:28:30 DEBUG : three.txt: same parent dir (ODFfOTYzODM5MF8yYkg0cQ) - using file/rename instead of move_copy for three.txt.bak
2025/12/07 03:28:30 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/12/07 03:28:30 INFO  : three.txt: Moved into backup dir
2025/12/07 03:28:31 DEBUG : dst/three.txt: Uploading chunk 0, size=6, remain=0
2025/12/07 03:28:33 DEBUG : one.bak: Excluded (Path Filter)
2025/12/07 03:28:33 DEBUG : one.bak: Excluded
2025/12/07 03:28:33 DEBUG : three.txt.bak: Excluded (Path Filter)
2025/12/07 03:28:33 DEBUG : three.txt.bak: Excluded
2025/12/07 03:28:33 DEBUG : one: size = 5 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:28:33 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-qefejon9faco/dst')
2025/12/07 03:28:33 DEBUG : one: Sizes differ
2025/12/07 03:28:33 DEBUG : two: size = 3 OK
2025/12/07 03:28:33 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:28:33 DEBUG : two: Unchanged skipping
2025/12/07 03:28:33 DEBUG : OpenDrive root 'rclone-test-qefejon9faco/dst': Waiting for checks to finish
2025/12/07 03:28:33 INFO  : one.bak: Deleted
2025/12/07 03:28:33 DEBUG : one: same parent dir (ODFfOTYzODM5MF8yYkg0cQ) - using file/rename instead of move_copy for one.bak
2025/12/07 03:28:34 INFO  : one: Moved (server-side) to: one.bak
2025/12/07 03:28:34 DEBUG : OpenDrive root 'rclone-test-qefejon9faco/dst': Waiting for transfers to finish
2025/12/07 03:28:34 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/12/07 03:28:35 DEBUG : one: size = 5 OK
2025/12/07 03:28:35 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/12/07 03:28:35 INFO  : one: Copied (new)
2025/12/07 03:28:35 DEBUG : Waiting for deletions to finish
2025/12/07 03:28:36 INFO  : three.txt.bak: Deleted
2025/12/07 03:28:36 DEBUG : three.txt: same parent dir (ODFfOTYzODM5MF8yYkg0cQ) - using file/rename instead of move_copy for three.txt.bak
2025/12/07 03:28:36 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/12/07 03:28:36 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirSuffixOnly (18.88s)
=== RUN   TestSyncSuffix
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:28:40 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/12/07 03:28:41 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2025/12/07 03:28:43 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2025/12/07 03:28:45 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qefejon9faco/dst"
2025/12/07 03:28:45 DEBUG : Starting OpenDrive session with ID: 5b69898acf01c290bc119127c2410d7797a5d3847a20f5d14d28a925877ab355
2025/12/07 03:28:46 DEBUG : one: size = 4 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:28:46 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-qefejon9faco/dst')
2025/12/07 03:28:46 DEBUG : one: Sizes differ
2025/12/07 03:28:46 DEBUG : one: same parent dir (ODFfOTYzODM5MV9udVNCbg) - using file/rename instead of move_copy for one.bak
2025/12/07 03:28:46 INFO  : one: Moved (server-side) to: one.bak
2025/12/07 03:28:47 DEBUG : one: Uploading chunk 0, size=4, remain=0
2025/12/07 03:28:48 DEBUG : one: size = 4 OK
2025/12/07 03:28:48 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/12/07 03:28:48 INFO  : one: Copied (new)
2025/12/07 03:28:48 DEBUG : two: size = 3 OK
2025/12/07 03:28:48 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:28:48 DEBUG : two: Unchanged skipping
2025/12/07 03:28:48 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:28:48 DEBUG : three.txt: size = 5 (OpenDrive root 'rclone-test-qefejon9faco/dst')
2025/12/07 03:28:48 DEBUG : three.txt: Sizes differ
2025/12/07 03:28:49 DEBUG : three.txt: same parent dir (ODFfOTYzODM5MV9udVNCbg) - using file/rename instead of move_copy for three.txt.bak
2025/12/07 03:28:49 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/12/07 03:28:49 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0
2025/12/07 03:28:51 DEBUG : three.txt: size = 6 OK
2025/12/07 03:28:51 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK
2025/12/07 03:28:51 INFO  : three.txt: Copied (new)
2025/12/07 03:28:51 DEBUG : one: size = 5 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:28:51 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-qefejon9faco/dst')
2025/12/07 03:28:51 DEBUG : one: Sizes differ
2025/12/07 03:28:52 INFO  : one.bak: Deleted
2025/12/07 03:28:52 DEBUG : one: same parent dir (ODFfOTYzODM5MV9udVNCbg) - using file/rename instead of move_copy for one.bak
2025/12/07 03:28:52 INFO  : one: Moved (server-side) to: one.bak
2025/12/07 03:28:53 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/12/07 03:28:54 DEBUG : one: size = 5 OK
2025/12/07 03:28:54 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/12/07 03:28:54 INFO  : one: Copied (new)
2025/12/07 03:28:54 DEBUG : two: size = 3 OK
2025/12/07 03:28:54 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:28:54 DEBUG : two: Unchanged skipping
2025/12/07 03:28:54 DEBUG : three.txt: size = 19 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:28:54 DEBUG : three.txt: size = 6 (OpenDrive root 'rclone-test-qefejon9faco/dst')
2025/12/07 03:28:54 DEBUG : three.txt: Sizes differ
2025/12/07 03:28:55 INFO  : three.txt.bak: Deleted
2025/12/07 03:28:55 DEBUG : three.txt: same parent dir (ODFfOTYzODM5MV9udVNCbg) - using file/rename instead of move_copy for three.txt.bak
2025/12/07 03:28:55 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/12/07 03:28:56 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0
2025/12/07 03:28:57 DEBUG : three.txt: size = 19 OK
2025/12/07 03:28:57 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK
2025/12/07 03:28:57 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffix (20.60s)
=== RUN   TestFixCase
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:29:00 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:02 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0
2025/12/07 03:29:05 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 0, size=8, remain=0
2025/12/07 03:29:07 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 0, size=8, remain=0
2025/12/07 03:29:09 DEBUG : EXISTING: size = 6 OK
2025/12/07 03:29:09 DEBUG : existingbutdifferent: size = 5 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:29:09 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:29:09 DEBUG : EXISTINGBUTDIFFERENT: size = 8 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:29:09 DEBUG : existing: Unchanged skipping
2025/12/07 03:29:09 DEBUG : existingbutdifferent: Sizes differ
2025/12/07 03:29:09 DEBUG : subdira-rclone-move-jezomuj7: same parent dir (ODFfOTYzODM4OV9Ram5BVA) - using folder/rename instead of move_copy
2025/12/07 03:29:10 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-divohoz1
2025/12/07 03:29:10 DEBUG : EXISTING: moving to existing-rclone-move-navodag9
2025/12/07 03:29:10 DEBUG : subdira: same parent dir (ODFfOTYzODM4OV9Ram5BVA) - using folder/rename instead of move_copy
2025/12/07 03:29:10 DEBUG : EXISTING: same parent dir (ODFfOTYzODM4OV9Ram5BVA) - using file/rename instead of move_copy for existing-rclone-move-navodag9
2025/12/07 03:29:10 DEBUG : EXISTINGBUTDIFFERENT: same parent dir (ODFfOTYzODM4OV9Ram5BVA) - using file/rename instead of move_copy for existingbutdifferent-rclone-move-divohoz1
2025/12/07 03:29:10 INFO  : SUBDIRA: Fixed case by renaming to: subdira
2025/12/07 03:29:11 INFO  : EXISTING: Moved (server-side) to: existing-rclone-move-navodag9
2025/12/07 03:29:11 DEBUG : EXISTING: moving to existing
2025/12/07 03:29:11 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-divohoz1
2025/12/07 03:29:11 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent
2025/12/07 03:29:11 DEBUG : existing-rclone-move-navodag9: same parent dir (ODFfOTYzODM4OV9Ram5BVA) - using file/rename instead of move_copy for existing
2025/12/07 03:29:11 INFO  : existing-rclone-move-navodag9: Moved (server-side) to: existing
2025/12/07 03:29:11 INFO  : EXISTING: Moved (server-side) to: existing
2025/12/07 03:29:11 INFO  : EXISTING: Fixed case by renaming to: existing
2025/12/07 03:29:11 DEBUG : existingbutdifferent-rclone-move-divohoz1: same parent dir (ODFfOTYzODM4OV9Ram5BVA) - using file/rename instead of move_copy for existingbutdifferent
2025/12/07 03:29:11 DEBUG : subdira/subdirb-rclone-move-rufigin9: same parent dir (ODFfOTYzODM5Ml95SExxdA) - using folder/rename instead of move_copy
2025/12/07 03:29:12 INFO  : existingbutdifferent-rclone-move-divohoz1: Moved (server-side) to: existingbutdifferent
2025/12/07 03:29:12 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent
2025/12/07 03:29:12 INFO  : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent
2025/12/07 03:29:12 DEBUG : existingbutdifferent: Uploading chunk 0, size=5, remain=0
2025/12/07 03:29:12 DEBUG : subdira/subdirb: same parent dir (ODFfOTYzODM5Ml95SExxdA) - using folder/rename instead of move_copy
2025/12/07 03:29:12 INFO  : SUBDIRA/subdirb: Fixed case by renaming to: subdira/subdirb
2025/12/07 03:29:13 DEBUG : subdira/subdirb/subdirc-rclone-move-cawuxem0: same parent dir (ODFfOTYzODM5M19zY1pUTQ) - using folder/rename instead of move_copy
2025/12/07 03:29:13 DEBUG : existingbutdifferent: size = 5 OK
2025/12/07 03:29:13 DEBUG : existingbutdifferent: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2025/12/07 03:29:13 INFO  : existingbutdifferent: Copied (replaced existing)
2025/12/07 03:29:13 DEBUG : subdira/subdirb/subdirc: same parent dir (ODFfOTYzODM5M19zY1pUTQ) - using folder/rename instead of move_copy
2025/12/07 03:29:14 INFO  : SUBDIRA/subdirb/SUBDIRC: Fixed case by renaming to: subdira/subdirb/subdirc
2025/12/07 03:29:14 DEBUG : subdira/subdirb/subdirc/hello: Need to transfer - File not found at Destination
2025/12/07 03:29:14 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Need to transfer - File not found at Destination
2025/12/07 03:29:14 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:29:14 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:29:14 ERROR : subdira/subdirb/subdirc/hello: Failed to copy: failed to make directory: File or folder with such name already exists (Error 409)
2025/12/07 03:29:15 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 0, size=5, remain=0
2025/12/07 03:29:16 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: size = 5 OK
2025/12/07 03:29:16 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2025/12/07 03:29:16 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (new)
2025/12/07 03:29:16 ERROR : OpenDrive root 'rclone-test-qefejon9faco': not deleting files as there were IO errors
2025/12/07 03:29:16 ERROR : OpenDrive root 'rclone-test-qefejon9faco': 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:
        	            	failed to make directory: File or folder with such name already exists (Error 409)
        	Test:       	TestFixCase
--- FAIL: TestFixCase (20.55s)
=== RUN   TestSyncConcurrentTruncate
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:29:20 DEBUG : both0: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:22 DEBUG : only0: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:24 DEBUG : both1: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:26 DEBUG : only1: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:28 DEBUG : both2: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:30 DEBUG : only2: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:32 DEBUG : both3: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:34 DEBUG : only3: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:36 DEBUG : both4: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:38 DEBUG : only4: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:39 DEBUG : both5: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:41 DEBUG : only5: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:43 DEBUG : both6: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:45 DEBUG : only6: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:47 DEBUG : both7: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:49 DEBUG : only7: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:51 DEBUG : both8: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:53 DEBUG : only8: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:55 DEBUG : both9: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:57 DEBUG : only9: Uploading chunk 0, size=6, remain=0
2025/12/07 03:29:59 DEBUG : both10: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:01 DEBUG : only10: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:03 DEBUG : both11: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:05 DEBUG : only11: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:07 DEBUG : both12: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:09 DEBUG : only12: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:10 DEBUG : both13: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:12 DEBUG : only13: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:14 DEBUG : both14: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:16 DEBUG : only14: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:18 DEBUG : both15: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:20 DEBUG : only15: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:22 DEBUG : both16: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:24 DEBUG : only16: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:25 DEBUG : both17: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:27 DEBUG : only17: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:29 DEBUG : both18: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:31 DEBUG : only18: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:33 DEBUG : both19: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:35 DEBUG : only19: Uploading chunk 0, size=6, remain=0
2025/12/07 03:30:37 DEBUG : both0: size = 6 OK
2025/12/07 03:30:37 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:30:37 DEBUG : both11: size = 6 OK
2025/12/07 03:30:37 DEBUG : both12: size = 6 OK
2025/12/07 03:30:37 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both10: size = 6 OK
2025/12/07 03:30:37 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both11: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both13: size = 6 OK
2025/12/07 03:30:37 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both13: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both14: size = 6 OK
2025/12/07 03:30:37 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both14: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both15: size = 6 OK
2025/12/07 03:30:37 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both15: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both16: size = 6 OK
2025/12/07 03:30:37 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both16: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both17: size = 6 OK
2025/12/07 03:30:37 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both12: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both18: size = 6 OK
2025/12/07 03:30:37 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both0: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both19: size = 6 OK
2025/12/07 03:30:37 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both10: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both1: size = 6 OK
2025/12/07 03:30:37 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both17: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both2: size = 6 OK
2025/12/07 03:30:37 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both2: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both3: size = 6 OK
2025/12/07 03:30:37 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both18: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both4: size = 6 OK
2025/12/07 03:30:37 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both19: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both5: size = 6 OK
2025/12/07 03:30:37 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both5: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both6: size = 6 OK
2025/12/07 03:30:37 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both6: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both7: size = 6 OK
2025/12/07 03:30:37 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both7: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both8: size = 6 OK
2025/12/07 03:30:37 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both8: Unchanged skipping
2025/12/07 03:30:37 DEBUG : both9: size = 6 OK
2025/12/07 03:30:37 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:30:37 DEBUG : both9: Unchanged skipping
2025/12/07 03:30:37 DEBUG : only0: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only0: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only0: Sizes differ
2025/12/07 03:30:37 DEBUG : only10: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only10: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only10: Sizes differ
2025/12/07 03:30:37 DEBUG : only11: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only11: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only11: Sizes differ
2025/12/07 03:30:37 DEBUG : only12: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only12: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only12: Sizes differ
2025/12/07 03:30:37 DEBUG : only13: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only13: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only13: Sizes differ
2025/12/07 03:30:37 DEBUG : only14: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only14: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only14: Sizes differ
2025/12/07 03:30:37 DEBUG : only15: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only15: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only15: Sizes differ
2025/12/07 03:30:37 DEBUG : only16: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only16: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only16: Sizes differ
2025/12/07 03:30:37 DEBUG : only17: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only17: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only17: Sizes differ
2025/12/07 03:30:37 DEBUG : both1: Unchanged skipping
2025/12/07 03:30:37 DEBUG : only18: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only18: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only18: Sizes differ
2025/12/07 03:30:37 DEBUG : both3: Unchanged skipping
2025/12/07 03:30:37 DEBUG : only19: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only19: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only19: Sizes differ
2025/12/07 03:30:37 DEBUG : both4: Unchanged skipping
2025/12/07 03:30:37 DEBUG : only1: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only1: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only2: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only1: Sizes differ
2025/12/07 03:30:37 DEBUG : only2: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only2: Sizes differ
2025/12/07 03:30:37 DEBUG : only3: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only3: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only3: Sizes differ
2025/12/07 03:30:37 DEBUG : only4: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only4: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only4: Sizes differ
2025/12/07 03:30:37 DEBUG : only5: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only5: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only5: Sizes differ
2025/12/07 03:30:37 DEBUG : only6: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only6: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only6: Sizes differ
2025/12/07 03:30:37 DEBUG : only7: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only7: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only7: Sizes differ
2025/12/07 03:30:37 DEBUG : only8: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only8: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only8: Sizes differ
2025/12/07 03:30:37 DEBUG : only9: size = 0 (Local file system at /tmp/rclone1079497815)
2025/12/07 03:30:37 DEBUG : only9: size = 6 (OpenDrive root 'rclone-test-qefejon9faco')
2025/12/07 03:30:37 DEBUG : only9: Sizes differ
2025/12/07 03:30:37 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:30:38 DEBUG : only11: size = 0 OK
2025/12/07 03:30:38 DEBUG : only11: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:38 INFO  : only11: Copied (replaced existing)
2025/12/07 03:30:38 DEBUG : only10: size = 0 OK
2025/12/07 03:30:38 DEBUG : only10: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:38 INFO  : only10: Copied (replaced existing)
2025/12/07 03:30:38 DEBUG : only12: size = 0 OK
2025/12/07 03:30:38 DEBUG : only12: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:38 INFO  : only12: Copied (replaced existing)
2025/12/07 03:30:38 DEBUG : only0: size = 0 OK
2025/12/07 03:30:38 DEBUG : only0: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:38 INFO  : only0: Copied (replaced existing)
2025/12/07 03:30:39 DEBUG : only13: size = 0 OK
2025/12/07 03:30:39 DEBUG : only13: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:39 INFO  : only13: Copied (replaced existing)
2025/12/07 03:30:39 DEBUG : only15: size = 0 OK
2025/12/07 03:30:39 DEBUG : only15: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:39 INFO  : only15: Copied (replaced existing)
2025/12/07 03:30:39 DEBUG : only14: size = 0 OK
2025/12/07 03:30:39 DEBUG : only14: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:39 INFO  : only14: Copied (replaced existing)
2025/12/07 03:30:40 DEBUG : only16: size = 0 OK
2025/12/07 03:30:40 DEBUG : only16: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:40 INFO  : only16: Copied (replaced existing)
2025/12/07 03:30:40 DEBUG : only17: size = 0 OK
2025/12/07 03:30:40 DEBUG : only17: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:40 INFO  : only17: Copied (replaced existing)
2025/12/07 03:30:40 DEBUG : only1: size = 0 OK
2025/12/07 03:30:40 DEBUG : only1: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:40 INFO  : only1: Copied (replaced existing)
2025/12/07 03:30:40 DEBUG : only3: size = 0 OK
2025/12/07 03:30:40 DEBUG : only3: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:40 INFO  : only3: Copied (replaced existing)
2025/12/07 03:30:41 DEBUG : only4: size = 0 OK
2025/12/07 03:30:41 DEBUG : only4: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:41 INFO  : only4: Copied (replaced existing)
2025/12/07 03:30:41 DEBUG : only5: size = 0 OK
2025/12/07 03:30:41 DEBUG : only5: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:41 INFO  : only5: Copied (replaced existing)
2025/12/07 03:30:42 DEBUG : only6: size = 0 OK
2025/12/07 03:30:42 DEBUG : only6: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:42 INFO  : only6: Copied (replaced existing)
2025/12/07 03:30:42 DEBUG : only7: size = 0 OK
2025/12/07 03:30:42 DEBUG : only7: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:42 INFO  : only7: Copied (replaced existing)
2025/12/07 03:30:42 DEBUG : only8: size = 0 OK
2025/12/07 03:30:42 DEBUG : only8: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:42 INFO  : only8: Copied (replaced existing)
2025/12/07 03:30:42 DEBUG : only9: size = 0 OK
2025/12/07 03:30:42 DEBUG : only9: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:42 INFO  : only9: Copied (replaced existing)
2025/12/07 03:30:43 DEBUG : only19: size = 0 OK
2025/12/07 03:30:43 DEBUG : only19: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:43 INFO  : only19: Copied (replaced existing)
2025/12/07 03:30:43 DEBUG : only18: size = 0 OK
2025/12/07 03:30:43 DEBUG : only18: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:43 INFO  : only18: Copied (replaced existing)
2025/12/07 03:30:43 DEBUG : only2: size = 0 OK
2025/12/07 03:30:43 DEBUG : only2: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/12/07 03:30:43 INFO  : only2: Copied (replaced existing)
2025/12/07 03:30:43 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncConcurrentTruncate (91.46s)
=== RUN   TestFileTag
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:30:51 INFO  : toe: Making directory
2025/12/07 03:30:51 INFO  : toe/toe: Making directory
2025/12/07 03:30:52 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:30:52 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/12/07 03:30:52 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination
2025/12/07 03:30:52 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/12/07 03:30:52 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:30:52 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:30:53 DEBUG : toe/toe/tictactoe: Uploading chunk 0, size=11, remain=0
2025/12/07 03:30:54 DEBUG : toe/toe/tictactoe: size = 11 OK
2025/12/07 03:30:54 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:30:54 INFO  : toe/toe/toe: Copied (new) to: toe/toe/tictactoe
2025/12/07 03:30:54 DEBUG : Waiting for deletions to finish
--- PASS: TestFileTag (4.93s)
=== RUN   TestNoTag
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:30:56 INFO  : toe: Making directory
2025/12/07 03:30:56 INFO  : toe/toe: Making directory
2025/12/07 03:30:57 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:30:57 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/12/07 03:30:57 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination
2025/12/07 03:30:57 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/12/07 03:30:57 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:30:57 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:30:58 DEBUG : toe/toe/tictactoe: Uploading chunk 0, size=11, remain=0
2025/12/07 03:30:58 DEBUG : toe/toe/tictactoe: size = 11 OK
2025/12/07 03:30:58 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:30:58 INFO  : toe/toe/toe: Copied (new) to: toe/toe/tictactoe
2025/12/07 03:30:58 DEBUG : Waiting for deletions to finish
--- PASS: TestNoTag (4.80s)
=== RUN   TestDirTag
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:01 DEBUG : empty_dir: Making directory with metadata
2025/12/07 03:31:01 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/12/07 03:31:01 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:01 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:01 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:01 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:01 INFO  : tictacempty_dir: Making directory
2025/12/07 03:31:01 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:01 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:01 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:01 INFO  : tictactoe: Making directory
2025/12/07 03:31:02 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:02 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:02 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:02 INFO  : tictactoe/tictactoe: Making directory
2025/12/07 03:31:02 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:02 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/12/07 03:31:02 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/12/07 03:31:02 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/12/07 03:31:02 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:02 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:03 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:04 DEBUG : tictactoe/tictactoe/toe.txt: size = 11 OK
2025/12/07 03:31:04 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:04 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt
2025/12/07 03:31:04 DEBUG : Waiting for deletions to finish
    run.go:130: removing dir "tictactoe/tictactoe" failed - try 1/3: folder not empty
--- PASS: TestDirTag (7.16s)
=== RUN   TestAllTag
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:08 DEBUG : empty_dir: Making directory with metadata
2025/12/07 03:31:08 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/12/07 03:31:08 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:08 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:08 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:08 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:08 INFO  : tictacempty_dir: Making directory
2025/12/07 03:31:08 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:08 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:08 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:08 INFO  : tictactoe: Making directory
2025/12/07 03:31:09 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:09 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:09 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:09 INFO  : tictactoe/tictactoe: Making directory
2025/12/07 03:31:09 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:09 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/12/07 03:31:09 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:09 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/12/07 03:31:09 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:09 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:09 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:10 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:11 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/12/07 03:31:11 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:11 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:11 DEBUG : Waiting for deletions to finish
2025/12/07 03:31:11 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:11 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:11 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:11 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:11 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:11 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:12 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/12/07 03:31:12 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/12/07 03:31:12 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:12 DEBUG : tictactoe/tictactoe/tictactoe.txt: OK
2025/12/07 03:31:12 NOTICE: OpenDrive root 'rclone-test-qefejon9faco': 0 differences found
2025/12/07 03:31:12 NOTICE: OpenDrive root 'rclone-test-qefejon9faco': 1 matching files
--- PASS: TestAllTag (6.07s)
=== RUN   TestRunTwice
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:14 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:14 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:14 INFO  : tictactoe: Making directory
2025/12/07 03:31:14 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:14 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:14 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:14 INFO  : tictactoe/tictactoe: Making directory
2025/12/07 03:31:15 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:15 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/12/07 03:31:15 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/12/07 03:31:15 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/12/07 03:31:15 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:15 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:16 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:17 DEBUG : tictactoe/tictactoe/toe.txt: size = 11 OK
2025/12/07 03:31:17 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:17 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt
2025/12/07 03:31:17 DEBUG : Waiting for deletions to finish
2025/12/07 03:31:17 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:17 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:17 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:18 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:18 DEBUG : tictactoe/tictactoe/toe.txt: size = 11 OK
2025/12/07 03:31:18 DEBUG : toe/toe/toe.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/12/07 03:31:18 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:18 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/12/07 03:31:18 DEBUG : toe/toe/toe.txt: Unchanged skipping
2025/12/07 03:31:18 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:18 DEBUG : Waiting for deletions to finish
--- PASS: TestRunTwice (6.01s)
=== RUN   TestConflicting
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:20 INFO  : toe: Making directory
2025/12/07 03:31:20 INFO  : toe/toe: Making directory
2025/12/07 03:31:21 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination
2025/12/07 03:31:21 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:21 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:22 DEBUG : toe/toe/toe: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:23 DEBUG : toe/toe/toe: size = 11 OK
2025/12/07 03:31:23 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:23 INFO  : toe/toe/toe: Copied (new)
2025/12/07 03:31:23 DEBUG : Waiting for deletions to finish
--- PASS: TestConflicting (4.98s)
=== RUN   TestMove
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:25 DEBUG : empty_dir: Making directory with metadata
2025/12/07 03:31:25 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/12/07 03:31:25 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:25 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:25 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:25 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:25 INFO  : tictacempty_dir: Making directory
2025/12/07 03:31:25 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:25 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:25 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:25 INFO  : tictactoe: Making directory
2025/12/07 03:31:26 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:26 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:26 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:26 INFO  : tictactoe/tictactoe: Making directory
2025/12/07 03:31:26 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:26 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/12/07 03:31:26 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:26 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/12/07 03:31:26 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:26 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:26 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:26 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:27 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:28 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/12/07 03:31:28 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:28 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:28 INFO  : toe/toe/toe.txt: Deleted
2025/12/07 03:31:28 INFO  : toe/toe: Removing directory
2025/12/07 03:31:28 INFO  : toe: Removing directory
2025/12/07 03:31:28 INFO  : empty_dir: Removing directory
2025/12/07 03:31:28 DEBUG : Local file system at /tmp/rclone1079497815: deleted 3 directories
--- PASS: TestMove (5.68s)
=== RUN   TestTransformFile
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:31 DEBUG : empty_dir: Making directory with metadata
2025/12/07 03:31:31 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/12/07 03:31:31 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:31 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:31 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:31 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:31 INFO  : tictacempty_dir: Making directory
2025/12/07 03:31:31 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:31 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:31 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:31 INFO  : tictactoe: Making directory
2025/12/07 03:31:31 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:31 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:31 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:31 INFO  : tictactoe/tictactoe: Making directory
2025/12/07 03:31:32 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:32 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/12/07 03:31:32 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:32 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/12/07 03:31:32 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:32 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:32 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:32 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:33 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:34 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/12/07 03:31:34 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:34 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:34 INFO  : toe/toe/toe.txt: Deleted
2025/12/07 03:31:34 INFO  : toe/toe: Removing directory
2025/12/07 03:31:34 INFO  : toe: Removing directory
2025/12/07 03:31:34 INFO  : empty_dir: Removing directory
2025/12/07 03:31:34 DEBUG : Local file system at /tmp/rclone1079497815: deleted 3 directories
2025/12/07 03:31:35 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/12/07 03:31:35 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s)
2025/12/07 03:31:35 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/12/07 03:31:35 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/12/07 03:31:35 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/12/07 03:31:36 INFO  : tictactoe/tictactoe/tictactoe.txt: Moved (server-side) to: toe/toe/toe.txt
--- PASS: TestTransformFile (8.67s)
=== RUN   TestManualTransformFile
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:39 DEBUG : Reset feature "Copy"
2025/12/07 03:31:39 DEBUG : Reset feature "Move"
2025/12/07 03:31:39 DEBUG : Reset feature "Copy"
2025/12/07 03:31:39 DEBUG : Reset feature "Move"
2025/12/07 03:31:39 DEBUG : empty_dir: Making directory with metadata
2025/12/07 03:31:39 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/12/07 03:31:39 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:39 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:39 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:39 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:39 INFO  : tictacempty_dir: Making directory
2025/12/07 03:31:40 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/12/07 03:31:40 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:40 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:40 INFO  : tictactoe: Making directory
2025/12/07 03:31:40 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:40 DEBUG : toe: transformed to: tictactoe
2025/12/07 03:31:40 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:40 INFO  : tictactoe/tictactoe: Making directory
2025/12/07 03:31:41 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/12/07 03:31:41 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/12/07 03:31:41 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:41 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/12/07 03:31:41 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:41 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:41 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:41 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:41 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:42 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/12/07 03:31:42 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:42 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/12/07 03:31:42 INFO  : toe/toe/toe.txt: Deleted
2025/12/07 03:31:42 INFO  : toe/toe: Removing directory
2025/12/07 03:31:42 INFO  : toe: Removing directory
2025/12/07 03:31:42 INFO  : empty_dir: Removing directory
2025/12/07 03:31:42 DEBUG : Local file system at /tmp/rclone1079497815: deleted 3 directories
2025/12/07 03:31:43 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/12/07 03:31:43 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s)
2025/12/07 03:31:43 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/12/07 03:31:43 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/12/07 03:31:43 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/12/07 03:31:44 ERROR : tictactoe/tictactoe/tictactoe.txt: Failed to copy: failed to get folder list: Directory doesn't exist (Error 404)
2025/12/07 03:31:44 ERROR : tictactoe/tictactoe/tictactoe.txt: Not deleting source as copy failed: failed to get folder list: Directory doesn't exist (Error 404)
    sync_transform_test.go:465: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:465
        	Error:      	Received unexpected error:
        	            	failed to get folder list: Directory doesn't exist (Error 404)
        	Test:       	TestManualTransformFile
--- FAIL: TestManualTransformFile (7.61s)
=== RUN   TestBase64
    run.go:185: Remote "OpenDrive root 'rclone-test-qefejon9faco'", Local "Local file system at /tmp/rclone1079497815", Modify Window "1s"
2025/12/07 03:31:47 DEBUG : toe: transformed to: dG9l
2025/12/07 03:31:47 DEBUG : toe: transformed to: dG9l
2025/12/07 03:31:47 INFO  : dG9l: Making directory
2025/12/07 03:31:47 DEBUG : toe: transformed to: dG9l
2025/12/07 03:31:47 DEBUG : toe: transformed to: dG9l
2025/12/07 03:31:47 DEBUG : toe/toe: transformed to: dG9l/dG9l
2025/12/07 03:31:47 INFO  : dG9l/dG9l: Making directory
2025/12/07 03:31:48 DEBUG : toe/toe: transformed to: dG9l/dG9l
2025/12/07 03:31:48 DEBUG : toe.txt: transformed to: dG9lLnR4dA==
2025/12/07 03:31:48 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2025/12/07 03:31:48 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/12/07 03:31:48 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2025/12/07 03:31:48 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for checks to finish
2025/12/07 03:31:48 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Waiting for transfers to finish
2025/12/07 03:31:48 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 0, size=11, remain=0
2025/12/07 03:31:50 DEBUG : dG9l/dG9l/dG9lLnR4dA==: size = 11 OK
2025/12/07 03:31:50 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/12/07 03:31:50 INFO  : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA==
2025/12/07 03:31:50 ERROR : OpenDrive root 'rclone-test-qefejon9faco': not deleting files as there were IO errors
2025/12/07 03:31:50 ERROR : OpenDrive root 'rclone-test-qefejon9faco': not deleting directories as there were IO errors
    sync_transform_test.go:481: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:481
        	Error:      	Received unexpected error:
        	            	not deleting files as there were IO errors
        	Test:       	TestBase64
--- FAIL: TestBase64 (4.36s)
FAIL
2025/12/07 03:31:51 DEBUG : OpenDrive root 'rclone-test-qefejon9faco': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestDirTag|TestFileTag|TestFixCase|TestManualTransformFile|TestMove|TestNoTag|TestRunTwice|TestSyncBackupDirSuffixOnly|TestSyncConcurrentTruncate|TestSyncIgnoreExisting|TestSyncSuffix|TestTransformFile)$'" - Finished ERROR in 3m37.064829058s (try 2/5): exit status 1: Failed [TestFixCase TestManualTransformFile TestBase64]