"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestFixCase|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncSuffix)$'" - Starting (try 2/5)
2024/09/20 04:46:45 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kibaxim7gafe"
2024/09/20 04:46:45 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/09/20 04:46:45 DEBUG : Starting OpenDrive session with ID: deaf9d7d53969bddf4396275c39d6572e042cbf206b3d1dace93d89de1d81e59
2024/09/20 04:46:46 DEBUG : Creating backend with remote "/tmp/rclone268163397"
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
    run.go:180: Remote "OpenDrive root 'rclone-test-kibaxim7gafe'", Local "Local file system at /tmp/rclone268163397", Modify Window "1s"
2024/09/20 04:46:47 DEBUG : b/potato: Uploading chunk 0, size=21, remain=0
2024/09/20 04:46:49 DEBUG : c/non empty space: Uploading chunk 0, size=5, remain=0
2024/09/20 04:46:50 DEBUG : d: Making directory
2024/09/20 04:46:51 DEBUG : a/potato2: Need to transfer - File not found at Destination
2024/09/20 04:46:51 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2024/09/20 04:46:51 DEBUG : c/non empty space: Unchanged skipping
2024/09/20 04:46:51 DEBUG : OpenDrive root 'rclone-test-kibaxim7gafe': Waiting for checks to finish
2024/09/20 04:46:51 DEBUG : OpenDrive root 'rclone-test-kibaxim7gafe': Waiting for transfers to finish
2024/09/20 04:46:52 DEBUG : a/potato2: Uploading chunk 0, size=60, remain=0
2024/09/20 04:46:53 DEBUG : a/potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK
2024/09/20 04:46:53 INFO  : a/potato2: Copied (new)
2024/09/20 04:46:53 ERROR : OpenDrive root 'rclone-test-kibaxim7gafe': not deleting files as there were IO errors
2024/09/20 04:46:53 ERROR : OpenDrive root 'rclone-test-kibaxim7gafe': not deleting directories as there were IO errors
    run.go:180: Remote "OpenDrive root 'rclone-test-kibaxim7gafe'", Local "Local file system at /tmp/rclone268163397", Modify Window "1s"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (10.78s)
=== RUN   TestSyncSuffix
    run.go:180: Remote "OpenDrive root 'rclone-test-kibaxim7gafe'", Local "Local file system at /tmp/rclone268163397", Modify Window "1s"
2024/09/20 04:46:58 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2024/09/20 04:46:59 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2024/09/20 04:47:01 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2024/09/20 04:47:02 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kibaxim7gafe/dst"
2024/09/20 04:47:03 DEBUG : Starting OpenDrive session with ID: ce7963c45926ae5b2be79d2989f6d450007f6076f75dd696c2194bf0b04595a8
2024/09/20 04:47:03 DEBUG : one: Sizes differ (src 4 vs dst 3)
2024/09/20 04:47:04 DEBUG : one: same parent dir (ODFfNjUyNjkyNF9TcHpENA) - using file/rename instead of move_copy for one.bak
2024/09/20 04:47:04 INFO  : one: Moved (server-side) to: one.bak
2024/09/20 04:47:05 DEBUG : one: Uploading chunk 0, size=4, remain=0
2024/09/20 04:47:06 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2024/09/20 04:47:06 INFO  : one: Copied (new)
2024/09/20 04:47:06 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/09/20 04:47:06 DEBUG : two: Unchanged skipping
2024/09/20 04:47:06 DEBUG : three.txt: Sizes differ (src 6 vs dst 5)
2024/09/20 04:47:06 DEBUG : three.txt: same parent dir (ODFfNjUyNjkyNF9TcHpENA) - using file/rename instead of move_copy for three.txt.bak
2024/09/20 04:47:06 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2024/09/20 04:47:07 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0
2024/09/20 04:47:08 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK
2024/09/20 04:47:08 INFO  : three.txt: Copied (new)
2024/09/20 04:47:09 DEBUG : one: Sizes differ (src 5 vs dst 4)
2024/09/20 04:47:09 INFO  : one.bak: Deleted
2024/09/20 04:47:10 DEBUG : one: same parent dir (ODFfNjUyNjkyNF9TcHpENA) - using file/rename instead of move_copy for one.bak
2024/09/20 04:47:10 INFO  : one: Moved (server-side) to: one.bak
2024/09/20 04:47:11 DEBUG : one: Uploading chunk 0, size=5, remain=0
2024/09/20 04:47:12 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2024/09/20 04:47:12 INFO  : one: Copied (new)
2024/09/20 04:47:12 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/09/20 04:47:12 DEBUG : two: Unchanged skipping
2024/09/20 04:47:12 DEBUG : three.txt: Sizes differ (src 19 vs dst 6)
2024/09/20 04:47:12 INFO  : three.txt.bak: Deleted
2024/09/20 04:47:12 DEBUG : three.txt: same parent dir (ODFfNjUyNjkyNF9TcHpENA) - using file/rename instead of move_copy for three.txt.bak
2024/09/20 04:47:13 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2024/09/20 04:47:13 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0
2024/09/20 04:47:14 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK
2024/09/20 04:47:14 INFO  : three.txt: Copied (new)
    run.go:125: removing dir "dst" failed - try 1/3: folder not empty
--- PASS: TestSyncSuffix (21.11s)
=== RUN   TestFixCase
    run.go:180: Remote "OpenDrive root 'rclone-test-kibaxim7gafe'", Local "Local file system at /tmp/rclone268163397", Modify Window "1s"
2024/09/20 04:47:18 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0
2024/09/20 04:47:20 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0
2024/09/20 04:47:23 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 0, size=8, remain=0
2024/09/20 04:47:25 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 0, size=8, remain=0
2024/09/20 04:47:27 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/09/20 04:47:27 DEBUG : existing: Unchanged skipping
2024/09/20 04:47:27 DEBUG : existingbutdifferent: Sizes differ (src 5 vs dst 8)
2024/09/20 04:47:27 DEBUG : subdira-rclone-move-rizamul2: same parent dir (ODFfNjUyNjkxOV8wblpkRg) - using folder/rename instead of move_copy
2024/09/20 04:47:27 DEBUG : EXISTING: moving to existing-rclone-move-zehixol4
2024/09/20 04:47:27 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-wenahay1
2024/09/20 04:47:28 DEBUG : subdira: same parent dir (ODFfNjUyNjkxOV8wblpkRg) - using folder/rename instead of move_copy
2024/09/20 04:47:28 DEBUG : EXISTINGBUTDIFFERENT: same parent dir (ODFfNjUyNjkxOV8wblpkRg) - using file/rename instead of move_copy for existingbutdifferent-rclone-move-wenahay1
2024/09/20 04:47:28 INFO  : SUBDIRA: Fixed case by renaming to: subdira
2024/09/20 04:47:28 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-wenahay1
2024/09/20 04:47:28 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent
2024/09/20 04:47:28 DEBUG : EXISTING: same parent dir (ODFfNjUyNjkxOV8wblpkRg) - using file/rename instead of move_copy for existing-rclone-move-zehixol4
2024/09/20 04:47:28 INFO  : EXISTING: Moved (server-side) to: existing-rclone-move-zehixol4
2024/09/20 04:47:28 DEBUG : EXISTING: moving to existing
2024/09/20 04:47:28 DEBUG : subdira/subdirb-rclone-move-juzasul5: same parent dir (ODFfNjUyNjkyNV9yMkRrZw) - using folder/rename instead of move_copy
2024/09/20 04:47:28 DEBUG : existingbutdifferent-rclone-move-wenahay1: same parent dir (ODFfNjUyNjkxOV8wblpkRg) - using file/rename instead of move_copy for existingbutdifferent
2024/09/20 04:47:29 DEBUG : existing-rclone-move-zehixol4: same parent dir (ODFfNjUyNjkxOV8wblpkRg) - using file/rename instead of move_copy for existing
2024/09/20 04:47:29 INFO  : existingbutdifferent-rclone-move-wenahay1: Moved (server-side) to: existingbutdifferent
2024/09/20 04:47:29 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent
2024/09/20 04:47:29 INFO  : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent
2024/09/20 04:47:29 INFO  : existing-rclone-move-zehixol4: Moved (server-side) to: existing
2024/09/20 04:47:29 INFO  : EXISTING: Moved (server-side) to: existing
2024/09/20 04:47:29 INFO  : EXISTING: Fixed case by renaming to: existing
2024/09/20 04:47:29 DEBUG : existingbutdifferent: Uploading chunk 0, size=5, remain=0
2024/09/20 04:47:29 DEBUG : subdira/subdirb: same parent dir (ODFfNjUyNjkyNV9yMkRrZw) - using folder/rename instead of move_copy
2024/09/20 04:47:29 INFO  : SUBDIRA/subdirb: Fixed case by renaming to: subdira/subdirb
2024/09/20 04:47:30 DEBUG : subdira/subdirb/subdirc-rclone-move-dovoces5: same parent dir (ODFfNjUyNjkyNl9qS1lQWg) - using folder/rename instead of move_copy
2024/09/20 04:47:30 DEBUG : existingbutdifferent: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2024/09/20 04:47:30 INFO  : existingbutdifferent: Copied (replaced existing)
2024/09/20 04:47:31 DEBUG : subdira/subdirb/subdirc: same parent dir (ODFfNjUyNjkyNl9qS1lQWg) - using folder/rename instead of move_copy
2024/09/20 04:47:31 INFO  : SUBDIRA/subdirb/SUBDIRC: Fixed case by renaming to: subdira/subdirb/subdirc
2024/09/20 04:47:31 DEBUG : subdira/subdirb/subdirc/hello: Sizes differ (src 5 vs dst 8)
2024/09/20 04:47:31 DEBUG : subdira/subdirb/subdirc/subdird-rclone-move-jowigax0: same parent dir (ODFfNjUyNjkyN19LUW9GaQ) - using folder/rename instead of move_copy
2024/09/20 04:47:32 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello-rclone-move-xubutaq1
2024/09/20 04:47:32 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: same parent dir (ODFfNjUyNjkyN19LUW9GaQ) - using file/rename instead of move_copy for subdira/subdirb/subdirc/hello-rclone-move-xubutaq1
2024/09/20 04:47:32 DEBUG : subdira/subdirb/subdirc/subdird: same parent dir (ODFfNjUyNjkyN19LUW9GaQ) - using folder/rename instead of move_copy
2024/09/20 04:47:32 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello-rclone-move-xubutaq1
2024/09/20 04:47:32 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello
2024/09/20 04:47:32 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird: Fixed case by renaming to: subdira/subdirb/subdirc/subdird
2024/09/20 04:47:32 DEBUG : subdira/subdirb/subdirc/hello-rclone-move-xubutaq1: same parent dir (ODFfNjUyNjkyN19LUW9GaQ) - using file/rename instead of move_copy for subdira/subdirb/subdirc/hello
2024/09/20 04:47:33 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Sizes differ (src 5 vs dst 8)
2024/09/20 04:47:33 DEBUG : OpenDrive root 'rclone-test-kibaxim7gafe': Waiting for checks to finish
2024/09/20 04:47:33 INFO  : subdira/subdirb/subdirc/hello-rclone-move-xubutaq1: Moved (server-side) to: subdira/subdirb/subdirc/hello
2024/09/20 04:47:33 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello
2024/09/20 04:47:33 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Fixed case by renaming to: subdira/subdirb/subdirc/hello
2024/09/20 04:47:33 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 0, size=5, remain=0
2024/09/20 04:47:33 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-ficafuz5
2024/09/20 04:47:33 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: same parent dir (ODFfNjUyNjkyOF9pNHhrWA) - using file/rename instead of move_copy for subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-ficafuz5
2024/09/20 04:47:33 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-ficafuz5
2024/09/20 04:47:33 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/09/20 04:47:34 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-ficafuz5: same parent dir (ODFfNjUyNjkyOF9pNHhrWA) - using file/rename instead of move_copy for subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/09/20 04:47:34 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-ficafuz5: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/09/20 04:47:34 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/09/20 04:47:34 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Fixed case by renaming to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/09/20 04:47:34 DEBUG : OpenDrive root 'rclone-test-kibaxim7gafe': Waiting for transfers to finish
2024/09/20 04:47:34 DEBUG : subdira/subdirb/subdirc/hello: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2024/09/20 04:47:34 INFO  : subdira/subdirb/subdirc/hello: Copied (replaced existing)
2024/09/20 04:47:34 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 0, size=5, remain=0
2024/09/20 04:47:35 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2024/09/20 04:47:35 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (replaced existing)
2024/09/20 04:47:35 DEBUG : Waiting for deletions to finish
--- PASS: TestFixCase (21.30s)
PASS
2024/09/20 04:47:39 DEBUG : OpenDrive root 'rclone-test-kibaxim7gafe': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestFixCase|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncSuffix)$'" - Finished OK in 54.685180661s (try 2/5)