"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestCopyWithDryRun|TestDirTag|TestFileTag|TestFixCase|TestManualTransformFile|TestMove|TestNoTag|TestNothingToTransferWithEmptyDirs|TestRunTwice|TestServerSideCopyOverSelf|TestSyncAfterChangingModtimeOnly|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncBasedOnCheckSum|TestSyncIgnoreErrors|TestSyncReplaceDirModTime|TestSyncSuffixKeepExtension|TestSyncWithUpdateOlder|TestTransformFile)$'" - Starting (try 2/5) 2025/08/03 03:16:08 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-nehoyuc1xewa" 2025/08/03 03:16:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/03 03:16:08 DEBUG : Starting OpenDrive session with ID: 2eb4ab9f23909ad0cb591d4668a57d472cfeeb0a4df49a596babf167bdb3a910 2025/08/03 03:16:08 DEBUG : Creating backend with remote "/tmp/rclone268145879" === RUN TestCopyWithDryRun run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:16:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/03 03:16:09 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:09 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/08/03 03:16:09 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish --- PASS: TestCopyWithDryRun (1.04s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:16:11 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/08/03 03:16:12 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-mucohew4simu" 2025/08/03 03:16:12 DEBUG : Starting OpenDrive session with ID: d2b04738a1c440ebc0203787a816151202ceb67d8bf52ee2e4f7ceb0ebe7bc92 sync_test.go:656: Server side copy (if possible) OpenDrive root 'rclone-test-nehoyuc1xewa' -> OpenDrive root 'rclone-test-mucohew4simu' 2025/08/03 03:16:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/03 03:16:13 DEBUG : OpenDrive root 'rclone-test-mucohew4simu': Waiting for checks to finish 2025/08/03 03:16:13 DEBUG : OpenDrive root 'rclone-test-mucohew4simu': Waiting for transfers to finish 2025/08/03 03:16:14 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2025/08/03 03:16:14 INFO : sub dir/hello world: Copied (server-side copy) 2025/08/03 03:16:15 DEBUG : sub dir/hello world: Uploading chunk 0, size=17, remain=0 2025/08/03 03:16:17 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/03 03:16:17 DEBUG : OpenDrive root 'rclone-test-mucohew4simu': Waiting for checks to finish 2025/08/03 03:16:17 DEBUG : OpenDrive root 'rclone-test-mucohew4simu': Waiting for transfers to finish 2025/08/03 03:16:17 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2025/08/03 03:16:17 INFO : sub dir/hello world: Copied (server-side copy) Diff of "logger" and "lsf" 2c2 < 2011-12-25 12:59:59;00321a507bdb420dbbd4f53c733b1505;17;sub dir/hello world --- > 2001-02-03 04:05:06;5eb63bbbe01eeed093cb22bb8f5acdc3;11;sub dir/hello world sync_test.go:3104: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:3104 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:670 Error: Received unexpected error: logger does not match lsf! logger: 2011-12-25 12:59:59;00321a507bdb420dbbd4f53c733b1505;17;sub dir/hello world lsf: 2001-02-03 04:05:06;5eb63bbbe01eeed093cb22bb8f5acdc3;11;sub dir/hello world Test: TestServerSideCopyOverSelf 2025/08/03 03:16:18 DEBUG : OpenDrive root 'rclone-test-mucohew4simu': Purge remote run.go:125: removing dir "sub dir" failed - try 1/3: folder not empty --- FAIL: TestServerSideCopyOverSelf (10.58s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:16:20 DEBUG : check sum: Need to transfer - File not found at Destination 2025/08/03 03:16:20 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:20 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:16:21 DEBUG : check sum: Uploading chunk 0, size=1, remain=0 2025/08/03 03:16:22 DEBUG : check sum: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/08/03 03:16:22 INFO : check sum: Copied (new) 2025/08/03 03:16:22 DEBUG : Waiting for deletions to finish 2025/08/03 03:16:22 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:22 DEBUG : check sum: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/08/03 03:16:22 DEBUG : check sum: Size and md5 of src and dst objects identical 2025/08/03 03:16:22 DEBUG : check sum: Unchanged skipping 2025/08/03 03:16:22 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:16:22 DEBUG : Waiting for deletions to finish 2025/08/03 03:16:22 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (2.85s) === RUN TestSyncIgnoreErrors run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:16:24 DEBUG : b/potato: Uploading chunk 0, size=21, remain=0 2025/08/03 03:16:26 DEBUG : c/non empty space: Uploading chunk 0, size=5, remain=0 2025/08/03 03:16:27 INFO : d: Making directory 2025/08/03 03:16:28 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/08/03 03:16:29 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/08/03 03:16:29 DEBUG : c/non empty space: Unchanged skipping 2025/08/03 03:16:29 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:29 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:16:30 DEBUG : a/potato2: Uploading chunk 0, size=60, remain=0 2025/08/03 03:16:31 DEBUG : a/potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2025/08/03 03:16:31 INFO : a/potato2: Copied (new) 2025/08/03 03:16:31 DEBUG : Waiting for deletions to finish 2025/08/03 03:16:31 INFO : b/potato: Deleted 2025/08/03 03:16:31 INFO : d: Removing directory 2025/08/03 03:16:31 INFO : b: Removing directory 2025/08/03 03:16:31 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': deleted 2 directories --- PASS: TestSyncIgnoreErrors (10.48s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:16:34 DEBUG : empty space: Uploading chunk 0, size=1, remain=0 2025/08/03 03:16:36 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/08/03 03:16:36 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:36 DEBUG : empty space: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/08/03 03:16:36 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2025/08/03 03:16:36 DEBUG : empty space: Unchanged skipping 2025/08/03 03:16:36 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:16:36 DEBUG : Waiting for deletions to finish 2025/08/03 03:16:36 INFO : There was nothing to transfer 2025/08/03 03:16:36 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/08/03 03:16:36 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:36 DEBUG : empty space: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/08/03 03:16:36 INFO : empty space: Updated modification time in destination 2025/08/03 03:16:36 DEBUG : empty space: Unchanged skipping 2025/08/03 03:16:36 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:16:36 DEBUG : Waiting for deletions to finish 2025/08/03 03:16:36 INFO : There was nothing to transfer fstest.go:295: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:298: Flushing the directory cache fstest.go:289: Sleeping for 6s just to make sure --- PASS: TestSyncAfterChangingModtimeOnly (10.73s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:16:45 DEBUG : potato: Uploading chunk 0, size=21, remain=0 2025/08/03 03:16:47 DEBUG : empty space: Uploading chunk 0, size=1, remain=0 2025/08/03 03:16:48 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/03 03:16:48 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/08/03 03:16:48 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:48 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/08/03 03:16:48 DEBUG : empty space: Unchanged skipping 2025/08/03 03:16:48 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:16:48 DEBUG : Waiting for deletions to finish 2025/08/03 03:16:48 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (4.26s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:16:49 DEBUG : b/potato: Uploading chunk 0, size=21, remain=0 2025/08/03 03:16:51 DEBUG : c/non empty space: Uploading chunk 0, size=5, remain=0 2025/08/03 03:16:52 INFO : d: Making directory 2025/08/03 03:16:53 INFO : d/e: Making directory 2025/08/03 03:16:54 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/08/03 03:16:54 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/08/03 03:16:54 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:16:54 DEBUG : c/non empty space: Unchanged skipping 2025/08/03 03:16:54 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:16:55 DEBUG : a/potato2: Uploading chunk 0, size=60, remain=0 2025/08/03 03:16:56 DEBUG : a/potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2025/08/03 03:16:56 INFO : a/potato2: Copied (new) 2025/08/03 03:16:56 DEBUG : Waiting for deletions to finish 2025/08/03 03:16:56 INFO : b/potato: Deleted 2025/08/03 03:16:56 INFO : d/e: Removing directory 2025/08/03 03:16:56 INFO : d: Removing directory 2025/08/03 03:16:57 INFO : b: Removing directory 2025/08/03 03:16:57 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': deleted 3 directories --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (10.49s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:17:00 DEBUG : one: Uploading chunk 0, size=3, remain=0 2025/08/03 03:17:01 DEBUG : two: Uploading chunk 0, size=3, remain=0 2025/08/03 03:17:03 DEBUG : three: Uploading chunk 0, size=5, remain=0 2025/08/03 03:17:05 DEBUG : four: Uploading chunk 0, size=8, remain=0 2025/08/03 03:17:06 DEBUG : five: Need to transfer - File not found at Destination 2025/08/03 03:17:06 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/08/03 03:17:06 DEBUG : three: Sizes identical 2025/08/03 03:17:06 DEBUG : one: Destination is newer than source, skipping 2025/08/03 03:17:06 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:17:06 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/08/03 03:17:06 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/08/03 03:17:06 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 (Local file system at /tmp/rclone268145879) 2025/08/03 03:17:06 DEBUG : two: md5 = 0f82d86afa0f5dc965c5c15aca58dcfb (OpenDrive root 'rclone-test-nehoyuc1xewa') 2025/08/03 03:17:06 DEBUG : two: md5 differ 2025/08/03 03:17:06 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:17:06 DEBUG : four: Uploading chunk 0, size=4, remain=0 2025/08/03 03:17:07 DEBUG : two: Uploading chunk 0, size=3, remain=0 2025/08/03 03:17:07 DEBUG : five: Uploading chunk 0, size=4, remain=0 2025/08/03 03:17:08 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK 2025/08/03 03:17:08 INFO : four: Copied (replaced existing) 2025/08/03 03:17:08 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2025/08/03 03:17:08 INFO : two: Copied (replaced existing) 2025/08/03 03:17:08 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK 2025/08/03 03:17:08 INFO : five: Copied (new) 2025/08/03 03:17:08 DEBUG : Waiting for deletions to finish 2025/08/03 03:17:09 DEBUG : one: Destination is newer than source, skipping 2025/08/03 03:17:09 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:17:09 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK 2025/08/03 03:17:09 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 (Local file system at /tmp/rclone268145879) 2025/08/03 03:17:09 DEBUG : five: Size and md5 of src and dst objects identical 2025/08/03 03:17:09 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2025/08/03 03:17:09 DEBUG : three: md5 = 413af0de1f97a2155acf2b8b26ab36e2 (OpenDrive root 'rclone-test-nehoyuc1xewa') 2025/08/03 03:17:09 DEBUG : three: md5 differ 2025/08/03 03:17:09 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2025/08/03 03:17:09 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK 2025/08/03 03:17:09 DEBUG : four: Size and md5 of src and dst objects identical 2025/08/03 03:17:09 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2025/08/03 03:17:09 DEBUG : two: Size and md5 of src and dst objects identical 2025/08/03 03:17:09 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2025/08/03 03:17:09 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2025/08/03 03:17:09 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:17:09 DEBUG : three: Uploading chunk 0, size=5, remain=0 2025/08/03 03:17:10 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 OK 2025/08/03 03:17:10 INFO : three: Copied (replaced existing) 2025/08/03 03:17:10 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (12.41s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:17:12 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2025/08/03 03:17:14 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2025/08/03 03:17:16 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2025/08/03 03:17:17 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-nehoyuc1xewa/dst" 2025/08/03 03:17:18 DEBUG : Starting OpenDrive session with ID: f3066a505c295f6cddf57ffebb4e6c2287dfa1e8ff2b970555134e41e06f91f0 2025/08/03 03:17:18 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/03 03:17:19 DEBUG : one: same parent dir (ODFfOTM2NDYyN194cTZUOQ) - using file/rename instead of move_copy for one-2019-01-01 2025/08/03 03:17:19 INFO : one: Moved (server-side) to: one-2019-01-01 2025/08/03 03:17:20 DEBUG : one: Uploading chunk 0, size=4, remain=0 2025/08/03 03:17:21 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/08/03 03:17:21 INFO : one: Copied (new) 2025/08/03 03:17:21 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/03 03:17:21 DEBUG : two: Unchanged skipping 2025/08/03 03:17:21 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/08/03 03:17:21 DEBUG : three.txt: same parent dir (ODFfOTM2NDYyN194cTZUOQ) - using file/rename instead of move_copy for three-2019-01-01.txt 2025/08/03 03:17:21 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/08/03 03:17:22 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0 2025/08/03 03:17:23 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/08/03 03:17:23 INFO : three.txt: Copied (new) 2025/08/03 03:17:24 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/08/03 03:17:24 INFO : one-2019-01-01: Deleted 2025/08/03 03:17:25 DEBUG : one: same parent dir (ODFfOTM2NDYyN194cTZUOQ) - using file/rename instead of move_copy for one-2019-01-01 2025/08/03 03:17:25 INFO : one: Moved (server-side) to: one-2019-01-01 2025/08/03 03:17:26 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/08/03 03:17:26 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/08/03 03:17:26 INFO : one: Copied (new) 2025/08/03 03:17:27 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/03 03:17:27 DEBUG : two: Unchanged skipping 2025/08/03 03:17:27 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/08/03 03:17:27 INFO : three-2019-01-01.txt: Deleted 2025/08/03 03:17:27 DEBUG : three.txt: same parent dir (ODFfOTM2NDYyN194cTZUOQ) - using file/rename instead of move_copy for three-2019-01-01.txt 2025/08/03 03:17:27 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/08/03 03:17:28 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0 2025/08/03 03:17:29 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/08/03 03:17:29 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (19.84s) === RUN TestFixCase run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:17:32 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0 2025/08/03 03:17:34 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0 run.go:285: Failed to put "SUBDIRA/subdirb/SUBDIRC/HELLO" to "OpenDrive root 'rclone-test-nehoyuc1xewa'": failed to get folder list: Directory doesn't exist (Error 404) fstest.go:295: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:298: Flushing the directory cache fstest.go:295: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:298: Flushing the directory cache fstest.go:295: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:298: Flushing the directory cache fstest.go:324: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:324 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:335 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /usr/local/go/src/testing/testing.go:1125 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2678 Error: Not equal: expected: []string{} actual : []string{"SUBDIRA"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=7) "SUBDIRA" } Test: TestFixCase Messages: directories --- FAIL: TestFixCase (12.94s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:17:44 DEBUG : empty_dir: Making directory with metadata 2025/08/03 03:17:44 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/08/03 03:17:44 DEBUG : empty_on_remote: Making directory with metadata 2025/08/03 03:17:44 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/08/03 03:17:44 INFO : empty_on_remote: Making directory 2025/08/03 03:17:45 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/08/03 03:17:48 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/08/03 03:17:48 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/08/03 03:17:48 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/08/03 03:17:48 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:125: removing dir "test_dir2/sub_dir" failed - try 1/3: folder not empty --- PASS: TestSyncReplaceDirModTime (8.59s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:17:53 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/08/03 03:17:53 INFO : sub dir: Making directory 2025/08/03 03:17:53 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithEmptyDirs (15.18s) === RUN TestFileTag run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:08 INFO : toe: Making directory 2025/08/03 03:18:08 INFO : toe/toe: Making directory 2025/08/03 03:18:09 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:09 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/08/03 03:18:09 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/08/03 03:18:09 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/08/03 03:18:09 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:09 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:09 ERROR : toe/toe/toe: Failed to copy: failed to get folder list: Directory doesn't exist (Error 404) 2025/08/03 03:18:09 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/08/03 03:18:09 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting files as there were IO errors 2025/08/03 03:18:09 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting directories as there were IO errors sync_transform_test.go:273: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:273 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestFileTag fstest.go:295: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:298: Flushing the directory cache fstest.go:295: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:298: Flushing the directory cache fstest.go:295: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:298: Flushing the directory cache fstest.go:324: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:324 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:335 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:273 Error: Not equal: expected: []string{} actual : []string{"toe"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "toe" } Test: TestFileTag Messages: directories --- FAIL: TestFileTag (9.42s) === RUN TestNoTag run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:18 INFO : toe/toe: Making directory 2025/08/03 03:18:18 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:18 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/08/03 03:18:18 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/08/03 03:18:18 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/08/03 03:18:18 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:18 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:19 DEBUG : toe/toe/tictactoe: Uploading chunk 0, size=11, remain=0 2025/08/03 03:18:20 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:18:20 INFO : toe/toe/toe: Copied (new) to: toe/toe/tictactoe 2025/08/03 03:18:20 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting files as there were IO errors 2025/08/03 03:18:20 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting directories as there were IO errors sync_transform_test.go:290: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:290 Error: Received unexpected error: not deleting files as there were IO errors Test: TestNoTag --- FAIL: TestNoTag (4.15s) === RUN TestDirTag run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:21 DEBUG : empty_dir: Making directory with metadata 2025/08/03 03:18:21 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/08/03 03:18:21 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:21 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:21 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:22 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:22 INFO : tictacempty_dir: Making directory 2025/08/03 03:18:22 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:22 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:22 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:22 INFO : tictactoe: Making directory 2025/08/03 03:18:22 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:22 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:22 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:22 INFO : tictactoe/tictactoe: Making directory 2025/08/03 03:18:23 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:23 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/08/03 03:18:23 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/08/03 03:18:23 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/08/03 03:18:23 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:23 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:23 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 0, size=11, remain=0 2025/08/03 03:18:24 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:18:24 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt 2025/08/03 03:18:24 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting files as there were IO errors 2025/08/03 03:18:24 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting directories as there were IO errors sync_transform_test.go:309: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:309 Error: Received unexpected error: not deleting files as there were IO errors Test: TestDirTag --- FAIL: TestDirTag (4.70s) === RUN TestAllTag run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:26 DEBUG : empty_dir: Making directory with metadata 2025/08/03 03:18:26 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/08/03 03:18:26 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:26 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:26 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:26 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:26 INFO : tictacempty_dir: Making directory 2025/08/03 03:18:27 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:27 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:27 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:27 INFO : tictactoe: Making directory 2025/08/03 03:18:27 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:27 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:27 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:27 INFO : tictactoe/tictactoe: Making directory 2025/08/03 03:18:27 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:27 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/08/03 03:18:27 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:27 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/08/03 03:18:27 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:27 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:27 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:28 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2025/08/03 03:18:29 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:18:29 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:29 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting files as there were IO errors 2025/08/03 03:18:29 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting directories as there were IO errors sync_transform_test.go:328: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:328 Error: Received unexpected error: not deleting files as there were IO errors Test: TestAllTag fstest.go:295: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:298: Flushing the directory cache fstest.go:289: Sleeping for 6s just to make sure --- FAIL: TestAllTag (12.37s) === RUN TestRunTwice run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:38 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:39 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:39 INFO : tictactoe: Making directory 2025/08/03 03:18:39 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:39 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:39 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:39 INFO : tictactoe/tictactoe: Making directory 2025/08/03 03:18:39 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:39 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/08/03 03:18:39 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/08/03 03:18:39 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/08/03 03:18:39 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:39 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:40 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 0, size=11, remain=0 2025/08/03 03:18:41 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:18:41 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt 2025/08/03 03:18:41 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting files as there were IO errors 2025/08/03 03:18:41 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting directories as there were IO errors sync_transform_test.go:347: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:347 Error: Received unexpected error: not deleting files as there were IO errors Test: TestRunTwice --- FAIL: TestRunTwice (4.01s) === RUN TestConflicting run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:43 INFO : toe: Making directory 2025/08/03 03:18:43 INFO : toe/toe: Making directory 2025/08/03 03:18:43 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/08/03 03:18:43 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:43 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:44 DEBUG : toe/toe/toe: Uploading chunk 0, size=11, remain=0 2025/08/03 03:18:45 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:18:45 INFO : toe/toe/toe: Copied (new) 2025/08/03 03:18:45 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting files as there were IO errors 2025/08/03 03:18:45 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting directories as there were IO errors sync_transform_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:388 Error: Received unexpected error: not deleting files as there were IO errors Test: TestConflicting --- FAIL: TestConflicting (4.00s) === RUN TestMove run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:46 DEBUG : empty_dir: Making directory with metadata 2025/08/03 03:18:46 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/08/03 03:18:46 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:46 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:46 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:47 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:47 INFO : tictacempty_dir: Making directory 2025/08/03 03:18:47 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:47 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:47 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:47 INFO : tictactoe: Making directory 2025/08/03 03:18:47 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:47 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:47 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:47 INFO : tictactoe/tictactoe: Making directory 2025/08/03 03:18:48 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:48 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/08/03 03:18:48 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:48 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/08/03 03:18:48 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:48 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:48 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:48 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:48 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2025/08/03 03:18:49 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:18:49 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:49 INFO : toe/toe/toe.txt: Deleted 2025/08/03 03:18:49 ERROR : Local file system at /tmp/rclone268145879: not deleting directories as there were IO errors sync_transform_test.go:408: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:408 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMove --- FAIL: TestMove (4.66s) === RUN TestTransformFile run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:51 DEBUG : empty_dir: Making directory with metadata 2025/08/03 03:18:51 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/08/03 03:18:51 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:51 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:51 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:51 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:51 INFO : tictacempty_dir: Making directory 2025/08/03 03:18:52 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:52 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:52 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:52 INFO : tictactoe: Making directory 2025/08/03 03:18:52 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:52 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:52 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:52 INFO : tictactoe/tictactoe: Making directory 2025/08/03 03:18:53 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:53 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/08/03 03:18:53 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:53 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/08/03 03:18:53 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:53 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:53 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:53 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:53 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2025/08/03 03:18:54 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:18:54 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:54 INFO : toe/toe/toe.txt: Deleted 2025/08/03 03:18:54 ERROR : Local file system at /tmp/rclone268145879: not deleting directories as there were IO errors sync_transform_test.go:427: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:427 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestTransformFile run.go:125: removing dir "tictactoe/tictactoe" failed - try 1/3: folder not empty --- FAIL: TestTransformFile (6.36s) === RUN TestManualTransformFile run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:18:57 DEBUG : Reset feature "Copy" 2025/08/03 03:18:57 DEBUG : Reset feature "Move" 2025/08/03 03:18:57 DEBUG : Reset feature "Copy" 2025/08/03 03:18:57 DEBUG : Reset feature "Move" 2025/08/03 03:18:57 DEBUG : empty_dir: Making directory with metadata 2025/08/03 03:18:57 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/08/03 03:18:57 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:57 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:57 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:58 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:58 INFO : tictacempty_dir: Making directory 2025/08/03 03:18:58 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/08/03 03:18:58 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:58 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:58 INFO : tictactoe: Making directory 2025/08/03 03:18:58 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:58 DEBUG : toe: transformed to: tictactoe 2025/08/03 03:18:58 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:58 INFO : tictactoe/tictactoe: Making directory 2025/08/03 03:18:59 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/08/03 03:18:59 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/08/03 03:18:59 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:59 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/08/03 03:18:59 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:59 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:18:59 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:18:59 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:18:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2025/08/03 03:19:00 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:19:00 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/08/03 03:19:00 INFO : toe/toe/toe.txt: Deleted 2025/08/03 03:19:00 ERROR : Local file system at /tmp/rclone268145879: not deleting directories as there were IO errors sync_transform_test.go:457: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:457 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestManualTransformFile --- FAIL: TestManualTransformFile (4.83s) === RUN TestBase64 run.go:180: Remote "OpenDrive root 'rclone-test-nehoyuc1xewa'", Local "Local file system at /tmp/rclone268145879", Modify Window "1s" 2025/08/03 03:19:02 DEBUG : toe: transformed to: dG9l 2025/08/03 03:19:02 DEBUG : toe: transformed to: dG9l 2025/08/03 03:19:02 INFO : dG9l: Making directory 2025/08/03 03:19:03 DEBUG : toe: transformed to: dG9l 2025/08/03 03:19:03 DEBUG : toe: transformed to: dG9l 2025/08/03 03:19:03 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/08/03 03:19:03 INFO : dG9l/dG9l: Making directory 2025/08/03 03:19:03 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/08/03 03:19:03 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2025/08/03 03:19:03 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/08/03 03:19:03 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/08/03 03:19:03 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/08/03 03:19:03 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for checks to finish 2025/08/03 03:19:03 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Waiting for transfers to finish 2025/08/03 03:19:04 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 0, size=11, remain=0 2025/08/03 03:19:05 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/08/03 03:19:05 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2025/08/03 03:19:05 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': not deleting files as there were IO errors 2025/08/03 03:19:05 ERROR : OpenDrive root 'rclone-test-nehoyuc1xewa': 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 run.go:125: removing dir "dG9l/dG9l" failed - try 1/3: folder not empty --- FAIL: TestBase64 (5.21s) FAIL 2025/08/03 03:19:08 DEBUG : OpenDrive root 'rclone-test-nehoyuc1xewa': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestCopyWithDryRun|TestDirTag|TestFileTag|TestFixCase|TestManualTransformFile|TestMove|TestNoTag|TestNothingToTransferWithEmptyDirs|TestRunTwice|TestServerSideCopyOverSelf|TestSyncAfterChangingModtimeOnly|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncBasedOnCheckSum|TestSyncIgnoreErrors|TestSyncReplaceDirModTime|TestSyncSuffixKeepExtension|TestSyncWithUpdateOlder|TestTransformFile)$'" - Finished ERROR in 3m0.650051057s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf TestFixCase TestFileTag TestNoTag TestDirTag TestAllTag TestRunTwice TestConflicting TestMove TestTransformFile TestManualTransformFile TestBase64]