"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestDirTag|TestDoubleTransform|TestFileTag|TestFixCase|TestManualTransformFile|TestMove|TestNoTag|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestRunTwice|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncIgnoreErrors|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithUpdateOlder|TestTransformCopy|TestTransformFile)$|^TestTransform$/^(ISO-8859-1|NFC|NFD|ascii|base64|charmap|encoder|lowercase|prefix|suffix|truncate)$'" - Starting (try 5/5) 2025/09/30 02:07:32 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-celelub6hawi" 2025/09/30 02:07:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/30 02:07:33 DEBUG : Starting OpenDrive session with ID: 6de98af4e76841f9101093a13447947e29a2e8f0d772ba271d60033bc089224c 2025/09/30 02:07:33 DEBUG : pacer: low level retry 1/10 (error Session does not exist, please re-login. (Error 401)) 2025/09/30 02:07:33 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/09/30 02:07:33 DEBUG : pacer: Reducing sleep to 10ms 2025/09/30 02:07:34 DEBUG : Creating backend with remote "/tmp/rclone2672555095" === RUN TestServerSideCopyOverSelf run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:07:35 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/09/30 02:07:37 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-wiwarax9pufa" 2025/09/30 02:07:37 DEBUG : Starting OpenDrive session with ID: c4485b62b438f79cd56b554515b4f799570c8c02edbe0c004c7efcc110d705dd 2025/09/30 02:07:38 DEBUG : pacer: low level retry 1/10 (error Session does not exist, please re-login. (Error 401)) 2025/09/30 02:07:38 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/09/30 02:07:38 DEBUG : pacer: low level retry 2/10 (error Session does not exist, please re-login. (Error 401)) 2025/09/30 02:07:38 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/09/30 02:07:38 DEBUG : pacer: low level retry 3/10 (error Session does not exist, please re-login. (Error 401)) 2025/09/30 02:07:38 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/09/30 02:07:38 DEBUG : pacer: Reducing sleep to 40ms sync_test.go:656: Server side copy (if possible) OpenDrive root 'rclone-test-celelub6hawi' -> OpenDrive root 'rclone-test-wiwarax9pufa' 2025/09/30 02:07:38 DEBUG : pacer: Reducing sleep to 20ms 2025/09/30 02:07:39 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/30 02:07:39 DEBUG : OpenDrive root 'rclone-test-wiwarax9pufa': Waiting for checks to finish 2025/09/30 02:07:39 DEBUG : OpenDrive root 'rclone-test-wiwarax9pufa': Waiting for transfers to finish 2025/09/30 02:07:39 DEBUG : pacer: Reducing sleep to 10ms 2025/09/30 02:07:39 ERROR : sub dir/hello world: Failed to copy: failed to get folder list: Directory does not exist (Error 404) sync_test.go:660: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:660 Error: Received unexpected error: failed to get folder list: Directory does not exist (Error 404) Test: TestServerSideCopyOverSelf 2025/09/30 02:07:39 DEBUG : OpenDrive root 'rclone-test-wiwarax9pufa': Purge remote --- FAIL: TestServerSideCopyOverSelf (7.44s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "sub dir/hello world" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) --- FAIL: TestServerSideMoveOverSelf (0.97s) === RUN TestSyncIgnoreErrors run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:07:43 DEBUG : b/potato: Uploading chunk 0, size=21, remain=0 2025/09/30 02:07:46 DEBUG : c/non empty space: Uploading chunk 0, size=5, remain=0 2025/09/30 02:07:47 INFO : d: Making directory fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2025/09/30 02:07:56 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/09/30 02:07:57 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/09/30 02:07:57 DEBUG : c/non empty space: Unchanged skipping 2025/09/30 02:07:57 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:07:57 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:07:57 DEBUG : a/potato2: Uploading chunk 0, size=60, remain=0 2025/09/30 02:07:58 ERROR : a/potato2: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2672555095) 60 vs dst(OpenDrive root 'rclone-test-celelub6hawi') 0 2025/09/30 02:07:58 INFO : a/potato2: Removing failed copy 2025/09/30 02:07:58 DEBUG : Waiting for deletions to finish 2025/09/30 02:07:58 INFO : b/potato: Deleted 2025/09/30 02:07:58 INFO : d: Removing directory 2025/09/30 02:07:59 INFO : b: Removing directory 2025/09/30 02:07:59 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': deleted 2 directories sync_test.go:980: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:980 Error: Received unexpected error: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2672555095) 60 vs dst(OpenDrive root 'rclone-test-celelub6hawi') 0 Test: TestSyncIgnoreErrors fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:360 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:994 Error: Should be true Test: TestSyncIgnoreErrors Messages: listing wrong, want a/potato2 (60), c/non empty space (5) got c/non empty space (5) fstest.go:203: Not found "a/potato2" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:360 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:994 Error: Not equal: expected: 0 actual : 1 Test: TestSyncIgnoreErrors Messages: 1 objects not found run.go:125: removing dir "c" failed - try 1/3: folder not empty --- FAIL: TestSyncIgnoreErrors (28.71s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:08:12 DEBUG : one: Uploading chunk 0, size=3, remain=0 2025/09/30 02:08:14 DEBUG : two: Uploading chunk 0, size=3, remain=0 2025/09/30 02:08:16 DEBUG : three: Uploading chunk 0, size=5, remain=0 2025/09/30 02:08:17 DEBUG : four: Uploading chunk 0, size=8, remain=0 fstest.go:127: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:132 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:151 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1467 Error: Should be true Test: TestSyncWithUpdateOlder Messages: four: Modification time difference too big |-120661h8m18.376543211s| > 1s (want 2011-12-25 12:59:59.623456789 +0000 UTC vs got 2025-09-30 02:08:18 +0000 UTC) (precision 1s) 2025/09/30 02:08:19 DEBUG : five: Need to transfer - File not found at Destination 2025/09/30 02:08:19 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/09/30 02:08:19 DEBUG : one: Destination is newer than source, skipping 2025/09/30 02:08:19 DEBUG : three: Sizes identical 2025/09/30 02:08:19 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:08:19 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/09/30 02:08:19 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/09/30 02:08:19 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 (Local file system at /tmp/rclone2672555095) 2025/09/30 02:08:19 DEBUG : two: md5 = 0f82d86afa0f5dc965c5c15aca58dcfb (OpenDrive root 'rclone-test-celelub6hawi') 2025/09/30 02:08:19 DEBUG : two: md5 differ 2025/09/30 02:08:19 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:08:19 DEBUG : four: Uploading chunk 0, size=4, remain=0 2025/09/30 02:08:19 DEBUG : two: Uploading chunk 0, size=3, remain=0 2025/09/30 02:08:20 DEBUG : five: Uploading chunk 0, size=4, remain=0 2025/09/30 02:08:20 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2025/09/30 02:08:20 INFO : two: Copied (replaced existing) 2025/09/30 02:08:20 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK 2025/09/30 02:08:20 INFO : four: Copied (replaced existing) 2025/09/30 02:08:22 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK 2025/09/30 02:08:22 INFO : five: Copied (new) 2025/09/30 02:08:22 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:08:22 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting directories as there were IO errors sync_test.go:1474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1474 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithUpdateOlder fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestSyncWithUpdateOlder (19.68s) === RUN TestSyncCopyDest run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:08:30 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-celelub6hawi/dst" 2025/09/30 02:08:31 DEBUG : Starting OpenDrive session with ID: f56f4a204561da3566c92e7779e70f97e0c688851b80f8e5841eda4d836aeb59 2025/09/30 02:08:32 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-celelub6hawi/CopyDest" 2025/09/30 02:08:32 DEBUG : Starting OpenDrive session with ID: 362b6e65acbb90b8459f8fad6a3cbc92df4835c7a969eab8398c9613d38c63a8 2025/09/30 02:08:33 DEBUG : one: Need to transfer - File not found at Destination 2025/09/30 02:08:33 DEBUG : OpenDrive root 'rclone-test-celelub6hawi/dst': Waiting for checks to finish 2025/09/30 02:08:33 DEBUG : OpenDrive root 'rclone-test-celelub6hawi/dst': Waiting for transfers to finish 2025/09/30 02:08:34 DEBUG : one: Uploading chunk 0, size=3, remain=0 2025/09/30 02:08:35 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/09/30 02:08:35 INFO : one: Copied (new) 2025/09/30 02:08:35 DEBUG : Waiting for deletions to finish 2025/09/30 02:08:36 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/09/30 02:08:36 DEBUG : OpenDrive root 'rclone-test-celelub6hawi/dst': Waiting for checks to finish 2025/09/30 02:08:36 DEBUG : OpenDrive root 'rclone-test-celelub6hawi/dst': Waiting for transfers to finish 2025/09/30 02:08:37 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/09/30 02:08:38 ERROR : one: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2672555095) 5 vs dst(OpenDrive root 'rclone-test-celelub6hawi/dst') 3 2025/09/30 02:08:38 INFO : one: Removing failed copy 2025/09/30 02:08:38 ERROR : OpenDrive root 'rclone-test-celelub6hawi/dst': not deleting files as there were IO errors 2025/09/30 02:08:38 ERROR : OpenDrive root 'rclone-test-celelub6hawi/dst': not deleting directories as there were IO errors sync_test.go:2297: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2297 Error: Received unexpected error: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2672555095) 5 vs dst(OpenDrive root 'rclone-test-celelub6hawi/dst') 3 Test: TestSyncCopyDest --- FAIL: TestSyncCopyDest (8.49s) === RUN TestSyncSuffix run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dst/one" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) run.go:125: removing dir "dst" failed - try 1/3: Folder is already deleted (Error 403) run.go:125: removing dir "dst" failed - try 2/3: Folder is already deleted (Error 403) run.go:125: removing dir "dst" failed - try 3/3: Folder is already deleted (Error 403) run.go:128: removing dir "dst" failed: Folder is already deleted (Error 403) --- FAIL: TestSyncSuffix (4.75s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dst/one" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) --- FAIL: TestSyncSuffixKeepExtension (0.77s) === RUN TestFixCase run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:08:45 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0 run.go:285: Failed to put "EXISTING" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to get fileinfo: File was not found (Error 404) --- FAIL: TestFixCase (2.52s) === RUN TestSyncConcurrentDelete run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:08:48 DEBUG : both0: Uploading chunk 0, size=6, remain=0 run.go:285: Failed to put "both0" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to get fileinfo: File was not found (Error 404) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/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/fstest/run.go:303 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2761 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2788 Error: Should be true Test: TestSyncConcurrentDelete Messages: listing wrong, want got both0 (6) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/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/fstest/run.go:303 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2761 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2788 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestSyncConcurrentDelete Messages: Unexpected file "both0" --- FAIL: TestSyncConcurrentDelete (10.10s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:08:58 DEBUG : both0: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:00 DEBUG : only0: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:01 DEBUG : both1: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:03 DEBUG : only1: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:05 DEBUG : both2: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:07 DEBUG : only2: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:09 DEBUG : both3: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:11 DEBUG : only3: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:13 DEBUG : both4: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:15 DEBUG : only4: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:17 DEBUG : both5: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:19 DEBUG : only5: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:21 DEBUG : both6: Uploading chunk 0, size=6, remain=0 2025/09/30 02:09:23 DEBUG : only6: Uploading chunk 0, size=6, remain=0 run.go:285: Failed to put "only6" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to get fileinfo: File was not found (Error 404) --- FAIL: TestSyncConcurrentTruncate (30.27s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:09:27 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/30 02:09:27 INFO : sub dir: Making directory 2025/09/30 02:09:28 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC sync_test.go:2898: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2898 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bilib/output.go:26 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2896 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2976 Error: Received unexpected error: failed to get folder list: Directory does not exist (Error 404) Test: TestNothingToTransferWithEmptyDirs --- FAIL: TestNothingToTransferWithEmptyDirs (13.04s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:09:40 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/30 02:09:40 INFO : sub dir: Making directory 2025/09/30 02:09:41 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC sync_test.go:2898: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2898 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bilib/output.go:26 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2896 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2980 Error: Received unexpected error: failed to get folder list: Directory does not exist (Error 404) Test: TestNothingToTransferWithoutEmptyDirs --- FAIL: TestNothingToTransferWithoutEmptyDirs (6.44s) === RUN TestTransform === RUN TestTransform/NFC run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:09:48 DEBUG : dir1/0000-abcdefg.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:09:50 DEBUG : dir1/0001-bcdefgh.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:09:52 DEBUG : dir1/0002-cdefghi.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:09:54 DEBUG : dir1/0003-defghij.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:09:56 DEBUG : dir1/0004-efghijk.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:09:58 DEBUG : dir1/0005-fghijkl.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:00 DEBUG : dir1/0006-ghijklm.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:02 DEBUG : dir1/0007-1234567.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:04 DEBUG : dir1/0008-2345678.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:06 DEBUG : dir1/0009-3456789.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:09 DEBUG : dir1/0010-456789.txt: Uploading chunk 0, size=20, remain=0 2025/09/30 02:10:10 DEBUG : dir1/0011-56789;.txt: Uploading chunk 0, size=20, remain=0 run.go:285: Failed to put "dir1/0011-56789;.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to get fileinfo: File was not found (Error 404) run.go:125: removing dir "dir1" failed - try 1/3: folder not empty run.go:125: removing dir "dir1" failed - try 2/3: folder not empty === RUN TestTransform/NFD run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:10:19 DEBUG : dir1/0000-abcdefg.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:21 DEBUG : dir1/0001-bcdefgh.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:23 DEBUG : dir1/0002-cdefghi.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:25 DEBUG : dir1/0003-defghij.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:27 DEBUG : dir1/0004-efghijk.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:29 DEBUG : dir1/0005-fghijkl.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:31 DEBUG : dir1/0006-ghijklm.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:33 DEBUG : dir1/0007-1234567.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:35 DEBUG : dir1/0008-2345678.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:37 DEBUG : dir1/0009-3456789.txt: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:39 DEBUG : dir1/0010-456789.txt: Uploading chunk 0, size=20, remain=0 2025/09/30 02:10:41 DEBUG : dir1/0011-56789;.txt: Uploading chunk 0, size=20, remain=0 2025/09/30 02:10:43 DEBUG : dir1/0012-6789;.txt: Uploading chunk 0, size=19, remain=0 2025/09/30 02:10:45 DEBUG : dir1/0013-789;=.txt: Uploading chunk 0, size=19, remain=0 2025/09/30 02:10:47 DEBUG : dir1/0014-89;=.txt: Uploading chunk 0, size=18, remain=0 2025/09/30 02:10:49 DEBUG : dir1/0015-9;=.txt: Uploading chunk 0, size=17, remain=0 2025/09/30 02:10:51 DEBUG : apple: Uploading chunk 0, size=5, remain=0 2025/09/30 02:10:53 DEBUG : banana: Uploading chunk 0, size=6, remain=0 2025/09/30 02:10:55 DEBUG : appleappleapplebanana: Uploading chunk 0, size=21, remain=0 2025/09/30 02:10:57 DEBUG : splitbananasplit: Uploading chunk 0, size=16, remain=0 2025/09/30 02:10:58 DEBUG : Waiting for deletions to finish 2025/09/30 02:10:58 DEBUG : apple: Excluded (Path Filter) 2025/09/30 02:10:58 DEBUG : apple: Excluded 2025/09/30 02:10:58 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/09/30 02:10:58 DEBUG : appleappleapplebanana: Excluded 2025/09/30 02:10:58 DEBUG : banana: Excluded (Path Filter) 2025/09/30 02:10:58 DEBUG : banana: Excluded 2025/09/30 02:10:58 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/09/30 02:10:58 DEBUG : splitbananasplit: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0000-abcdefg.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0001-bcdefgh.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0002-cdefghi.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0003-defghij.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0004-efghijk.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0005-fghijkl.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0006-ghijklm.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0007-1234567.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0008-2345678.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0009-3456789.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0010-456789.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0011-56789;.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0012-6789;.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0013-789;=.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0014-89;=.txt: Excluded 2025/09/30 02:10:59 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/09/30 02:10:59 DEBUG : dir1/0015-9;=.txt: Excluded 2025/09/30 02:11:00 DEBUG : apple: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : apple: Unchanged skipping 2025/09/30 02:11:00 DEBUG : appleappleapplebanana: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : appleappleapplebanana: Unchanged skipping 2025/09/30 02:11:00 DEBUG : banana: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : banana: Unchanged skipping 2025/09/30 02:11:00 DEBUG : splitbananasplit: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : splitbananasplit: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:00 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:00 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/09/30 02:11:00 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:00 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:00 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting directories as there were IO errors sync_transform_test.go:111: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:111 Error: Received unexpected error: not deleting files as there were IO errors Test: TestTransform/NFD 2025/09/30 02:11:00 DEBUG : Waiting for deletions to finish 2025/09/30 02:11:00 DEBUG : apple: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : apple: Excluded 2025/09/30 02:11:00 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : appleappleapplebanana: Excluded 2025/09/30 02:11:00 DEBUG : banana: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : banana: Excluded 2025/09/30 02:11:00 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : splitbananasplit: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0000-abcdefg.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0001-bcdefgh.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0002-cdefghi.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0003-defghij.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0004-efghijk.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0005-fghijkl.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0006-ghijklm.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0007-1234567.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0008-2345678.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0009-3456789.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0010-456789.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0011-56789;.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0012-6789;.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0013-789;=.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0014-89;=.txt: Excluded 2025/09/30 02:11:00 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/09/30 02:11:00 DEBUG : dir1/0015-9;=.txt: Excluded 2025/09/30 02:11:01 DEBUG : apple: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : apple: Unchanged skipping 2025/09/30 02:11:01 DEBUG : appleappleapplebanana: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : banana: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : appleappleapplebanana: Unchanged skipping 2025/09/30 02:11:01 DEBUG : banana: Unchanged skipping 2025/09/30 02:11:01 DEBUG : splitbananasplit: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : splitbananasplit: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/30 02:11:01 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/09/30 02:11:01 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:01 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:01 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:01 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting directories as there were IO errors sync_transform_test.go:117: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:117 Error: Received unexpected error: not deleting files as there were IO errors Test: TestTransform/NFD 2025/09/30 02:11:01 DEBUG : Waiting for deletions to finish 2025/09/30 02:11:02 DEBUG : apple: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : apple: Excluded 2025/09/30 02:11:02 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : appleappleapplebanana: Excluded 2025/09/30 02:11:02 DEBUG : banana: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : banana: Excluded 2025/09/30 02:11:02 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : splitbananasplit: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0000-abcdefg.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0001-bcdefgh.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0002-cdefghi.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0003-defghij.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0004-efghijk.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0005-fghijkl.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0006-ghijklm.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0007-1234567.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0008-2345678.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0009-3456789.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0010-456789.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0011-56789;.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0012-6789;.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0013-789;=.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0014-89;=.txt: Excluded 2025/09/30 02:11:02 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/09/30 02:11:02 DEBUG : dir1/0015-9;=.txt: Excluded run.go:125: removing dir "dir1" failed - try 1/3: Folder is already deleted (Error 403) run.go:125: removing dir "dir1" failed - try 2/3: Folder is already deleted (Error 403) run.go:125: removing dir "dir1" failed - try 3/3: Folder is already deleted (Error 403) run.go:128: removing dir "dir1" failed: Folder is already deleted (Error 403) === RUN TestTransform/base64 run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/prefix run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/suffix run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/truncate run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/encoder run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/ISO-8859-1 run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/charmap run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/lowercase run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) === RUN TestTransform/ascii run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" run.go:285: Failed to put "dir1/0000-abcdefg.txt" to "OpenDrive root 'rclone-test-celelub6hawi'": failed to create file: Parent folder is trashed (Error 403) --- FAIL: TestTransform (95.42s) --- FAIL: TestTransform/NFC (31.16s) --- FAIL: TestTransform/NFD (53.73s) --- FAIL: TestTransform/base64 (1.18s) --- FAIL: TestTransform/prefix (1.17s) --- FAIL: TestTransform/suffix (1.18s) --- FAIL: TestTransform/truncate (1.15s) --- FAIL: TestTransform/encoder (1.17s) --- FAIL: TestTransform/ISO-8859-1 (1.18s) --- FAIL: TestTransform/charmap (1.18s) --- FAIL: TestTransform/lowercase (1.16s) --- FAIL: TestTransform/ascii (1.15s) === RUN TestTransformCopy run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:11:22 DEBUG : sub dir: transformed to: sub dir_somesuffix 2025/09/30 02:11:22 DEBUG : sub dir: transformed to: sub dir_somesuffix 2025/09/30 02:11:22 INFO : sub dir_somesuffix: Making directory 2025/09/30 02:11:23 DEBUG : sub dir: transformed to: sub dir_somesuffix 2025/09/30 02:11:23 DEBUG : hello world.txt: transformed to: hello world_somesuffix.txt 2025/09/30 02:11:23 DEBUG : sub dir/hello world.txt: transformed to: sub dir_somesuffix/hello world_somesuffix.txt 2025/09/30 02:11:23 DEBUG : sub dir/hello world.txt: Need to transfer - File not found at Destination 2025/09/30 02:11:23 DEBUG : sub dir/hello world.txt: transformed to: sub dir_somesuffix/hello world_somesuffix.txt 2025/09/30 02:11:23 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:23 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:24 DEBUG : sub dir_somesuffix/hello world_somesuffix.txt: Uploading chunk 0, size=11, remain=0 2025/09/30 02:11:25 DEBUG : sub dir/hello world.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/09/30 02:11:25 INFO : sub dir/hello world.txt: Copied (new) to: sub dir_somesuffix/hello world_somesuffix.txt 2025/09/30 02:11:25 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:25 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting directories as there were IO errors sync_transform_test.go:239: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:239 Error: Received unexpected error: not deleting files as there were IO errors Test: TestTransformCopy --- FAIL: TestTransformCopy (3.89s) === RUN TestDoubleTransform run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:11:26 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:26 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:26 INFO : tictactoe: Making directory 2025/09/30 02:11:27 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:27 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:27 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:27 DEBUG : toe/toe: Need to transfer - File not found at Destination 2025/09/30 02:11:27 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:27 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:27 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:28 DEBUG : tictactoe/tictactoe: Uploading chunk 0, size=11, remain=0 2025/09/30 02:11:29 DEBUG : toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/09/30 02:11:29 INFO : toe/toe: Copied (new) to: tictactoe/tictactoe 2025/09/30 02:11:29 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:29 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting directories as there were IO errors sync_transform_test.go:256: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:256 Error: Received unexpected error: not deleting files as there were IO errors Test: TestDoubleTransform --- FAIL: TestDoubleTransform (3.86s) === RUN TestFileTag run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:11:30 INFO : toe: Making directory 2025/09/30 02:11:31 INFO : toe/toe: Making directory 2025/09/30 02:11:31 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:31 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/09/30 02:11:31 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/09/30 02:11:31 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/09/30 02:11:31 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:31 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:32 DEBUG : toe/toe/tictactoe: Uploading chunk 0, size=11, remain=0 2025/09/30 02:11:33 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/09/30 02:11:33 INFO : toe/toe/toe: Copied (new) to: toe/toe/tictactoe 2025/09/30 02:11:33 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:33 ERROR : OpenDrive root 'rclone-test-celelub6hawi': 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: not deleting files as there were IO errors Test: TestFileTag run.go:125: removing dir "toe/toe" failed - try 1/3: folder not empty --- FAIL: TestFileTag (6.08s) === RUN TestNoTag run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:11:36 INFO : toe: Making directory 2025/09/30 02:11:37 INFO : toe/toe: Making directory 2025/09/30 02:11:37 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:37 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/09/30 02:11:37 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/09/30 02:11:37 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe 2025/09/30 02:11:37 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:37 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:38 DEBUG : toe/toe/tictactoe: Uploading chunk 0, size=11, remain=0 2025/09/30 02:11:39 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/09/30 02:11:39 INFO : toe/toe/toe: Copied (new) to: toe/toe/tictactoe 2025/09/30 02:11:39 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:39 ERROR : OpenDrive root 'rclone-test-celelub6hawi': 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.70s) === RUN TestDirTag run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:11:41 DEBUG : empty_dir: Making directory with metadata 2025/09/30 02:11:41 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/09/30 02:11:41 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:41 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:41 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:41 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:41 INFO : tictacempty_dir: Making directory 2025/09/30 02:11:41 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:41 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:41 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:41 INFO : tictactoe: Making directory 2025/09/30 02:11:42 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:42 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:42 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:42 INFO : tictactoe/tictactoe: Making directory 2025/09/30 02:11:42 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:42 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/09/30 02:11:42 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/30 02:11:42 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/09/30 02:11:42 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:42 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:43 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 0, size=11, remain=0 2025/09/30 02:11:44 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/09/30 02:11:44 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt 2025/09/30 02:11:44 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:44 ERROR : OpenDrive root 'rclone-test-celelub6hawi': 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 (5.53s) === RUN TestAllTag run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:11:46 DEBUG : empty_dir: Making directory with metadata 2025/09/30 02:11:46 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/09/30 02:11:46 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:46 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:46 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:47 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:47 INFO : tictacempty_dir: Making directory 2025/09/30 02:11:47 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:11:47 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:47 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:47 INFO : tictactoe: Making directory 2025/09/30 02:11:47 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:47 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:47 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:47 INFO : tictactoe/tictactoe: Making directory 2025/09/30 02:11:48 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:48 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/09/30 02:11:48 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:11:48 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/30 02:11:48 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:48 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:48 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:11:48 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2025/09/30 02:11:49 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/09/30 02:11:49 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:11:49 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:49 ERROR : OpenDrive root 'rclone-test-celelub6hawi': 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 --- FAIL: TestAllTag (5.04s) === RUN TestRunTwice run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:11:51 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:52 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:52 INFO : tictactoe: Making directory 2025/09/30 02:11:52 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:52 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:11:52 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:52 INFO : tictactoe/tictactoe: Making directory 2025/09/30 02:11:52 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:11:52 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/09/30 02:11:52 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/30 02:11:52 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/09/30 02:11:52 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:11:52 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:11:52 ERROR : toe/toe/toe.txt: Failed to copy: failed to get folder list: Directory does not exist (Error 404) 2025/09/30 02:11:52 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/09/30 02:11:52 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:11:52 ERROR : OpenDrive root 'rclone-test-celelub6hawi': 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: failed to get folder list: Directory does not exist (Error 404) Test: TestRunTwice fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go: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:347 Error: Not equal: expected: []string{} actual : []string{"tictactoe"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=9) "tictactoe" } Test: TestRunTwice Messages: directories --- FAIL: TestRunTwice (9.55s) === RUN TestConflicting run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:12:01 INFO : toe: Making directory 2025/09/30 02:12:02 INFO : toe/toe: Making directory 2025/09/30 02:12:02 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/09/30 02:12:02 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:12:02 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:12:02 ERROR : toe/toe/toe: Failed to copy: failed to get folder list: Directory does not exist (Error 404) 2025/09/30 02:12:02 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:12:02 ERROR : OpenDrive root 'rclone-test-celelub6hawi': 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: failed to get folder list: Directory does not exist (Error 404) Test: TestConflicting fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 7s just to make sure --- FAIL: TestConflicting (13.62s) === RUN TestMove run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:12:15 DEBUG : empty_dir: Making directory with metadata 2025/09/30 02:12:15 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/09/30 02:12:15 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:15 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:15 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:15 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:15 INFO : tictacempty_dir: Making directory 2025/09/30 02:12:15 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:15 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:15 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:15 INFO : tictactoe: Making directory 2025/09/30 02:12:16 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:16 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:16 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:12:16 INFO : tictactoe/tictactoe: Making directory 2025/09/30 02:12:16 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:12:16 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/09/30 02:12:16 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:16 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/30 02:12:16 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:16 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:16 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:12:16 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:12:16 ERROR : toe/toe/toe.txt: Failed to copy: failed to get folder list: Directory does not exist (Error 404) 2025/09/30 02:12:16 ERROR : toe/toe/toe.txt: Not deleting source as copy failed: failed to get folder list: Directory does not exist (Error 404) 2025/09/30 02:12:16 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:16 ERROR : Local file system at /tmp/rclone2672555095: 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 (1.75s) === RUN TestTransformFile run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:12:16 DEBUG : empty_dir: Making directory with metadata 2025/09/30 02:12:16 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/09/30 02:12:16 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:16 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:16 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:16 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:16 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:16 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:16 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:17 ERROR : tictacempty_dir: error reading destination directory: failed to get folder list: Directory does not exist (Error 404) 2025/09/30 02:12:17 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:12:17 INFO : tictactoe/tictactoe: Making directory 2025/09/30 02:12:17 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:12:17 ERROR : tictactoe: error reading destination directory: failed to get folder list: Directory does not exist (Error 404) 2025/09/30 02:12:17 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:12:17 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:12:17 ERROR : Local file system at /tmp/rclone2672555095: 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 2025/09/30 02:12:17 ERROR : tictactoe: error listing: failed to get folder list: Directory does not exist (Error 404) 2025/09/30 02:12:17 ERROR : tictacempty_dir: error listing: failed to get folder list: Directory does not exist (Error 404) fstest.go:282: Error listing: failed to get folder list: Directory does not exist (Error 404) --- FAIL: TestTransformFile (1.15s) === RUN TestManualTransformFile run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:12:17 DEBUG : Reset feature "Copy" 2025/09/30 02:12:17 DEBUG : Reset feature "Move" 2025/09/30 02:12:17 DEBUG : Reset feature "Copy" 2025/09/30 02:12:17 DEBUG : Reset feature "Move" 2025/09/30 02:12:17 DEBUG : empty_dir: Making directory with metadata 2025/09/30 02:12:17 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/09/30 02:12:17 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:17 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:17 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:18 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:18 INFO : tictacempty_dir: Making directory 2025/09/30 02:12:18 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/09/30 02:12:18 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:18 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:18 INFO : tictactoe: Making directory 2025/09/30 02:12:18 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:18 DEBUG : toe: transformed to: tictactoe 2025/09/30 02:12:18 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:12:18 INFO : tictactoe/tictactoe: Making directory 2025/09/30 02:12:18 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/09/30 02:12:18 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/09/30 02:12:18 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:18 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/30 02:12:18 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:18 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:18 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:12:18 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:12:19 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0 2025/09/30 02:12:20 ERROR : toe/toe/toe.txt: Failed to copy: failed to get fileinfo: File was not found (Error 404) 2025/09/30 02:12:20 ERROR : toe/toe/toe.txt: Not deleting source as copy failed: failed to get fileinfo: File was not found (Error 404) 2025/09/30 02:12:20 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/09/30 02:12:20 ERROR : Local file system at /tmp/rclone2672555095: 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 fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 7s just to make sure --- FAIL: TestManualTransformFile (14.76s) === RUN TestBase64 run.go:180: Remote "OpenDrive root 'rclone-test-celelub6hawi'", Local "Local file system at /tmp/rclone2672555095", Modify Window "1s" 2025/09/30 02:12:32 DEBUG : toe: transformed to: dG9l 2025/09/30 02:12:32 DEBUG : toe: transformed to: dG9l 2025/09/30 02:12:32 INFO : dG9l: Making directory 2025/09/30 02:12:33 DEBUG : toe: transformed to: dG9l 2025/09/30 02:12:33 DEBUG : toe: transformed to: dG9l 2025/09/30 02:12:33 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/09/30 02:12:33 INFO : dG9l/dG9l: Making directory 2025/09/30 02:12:33 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/09/30 02:12:33 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2025/09/30 02:12:33 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/09/30 02:12:33 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/09/30 02:12:33 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/09/30 02:12:33 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for checks to finish 2025/09/30 02:12:33 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Waiting for transfers to finish 2025/09/30 02:12:34 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 0, size=11, remain=0 2025/09/30 02:12:35 ERROR : dG9l/dG9l/dG9lLnR4dA==: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2672555095) 11 vs dst(OpenDrive root 'rclone-test-celelub6hawi') 0 2025/09/30 02:12:35 INFO : dG9l/dG9l/dG9lLnR4dA==: Removing failed copy 2025/09/30 02:12:35 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/09/30 02:12:35 ERROR : OpenDrive root 'rclone-test-celelub6hawi': not deleting files as there were IO errors 2025/09/30 02:12:35 ERROR : OpenDrive root 'rclone-test-celelub6hawi': 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: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2672555095) 11 vs dst(OpenDrive root 'rclone-test-celelub6hawi') 0 Test: TestBase64 --- FAIL: TestBase64 (4.75s) FAIL 2025/09/30 02:12:37 DEBUG : OpenDrive root 'rclone-test-celelub6hawi': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestDirTag|TestDoubleTransform|TestFileTag|TestFixCase|TestManualTransformFile|TestMove|TestNoTag|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestRunTwice|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncIgnoreErrors|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithUpdateOlder|TestTransformCopy|TestTransformFile)$|^TestTransform$/^(ISO-8859-1|NFC|NFD|ascii|base64|charmap|encoder|lowercase|prefix|suffix|truncate)$'" - Finished ERROR in 5m5.227528172s (try 5/5): exit status 1: Failed [TestServerSideCopyOverSelf TestServerSideMoveOverSelf TestSyncIgnoreErrors TestSyncWithUpdateOlder TestSyncCopyDest TestSyncSuffix TestSyncSuffixKeepExtension TestFixCase TestSyncConcurrentDelete TestSyncConcurrentTruncate TestNothingToTransferWithEmptyDirs TestNothingToTransferWithoutEmptyDirs TestTransform/NFC TestTransform/NFD TestTransform/base64 TestTransform/prefix TestTransform/suffix TestTransform/truncate TestTransform/encoder TestTransform/ISO-8859-1 TestTransform/charmap TestTransform/lowercase TestTransform/ascii TestTransformCopy TestDoubleTransform TestFileTag TestNoTag TestDirTag TestAllTag TestRunTwice TestConflicting TestMove TestTransformFile TestManualTransformFile TestBase64]