"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestFixCase|TestNothingToTransferWithEmptyDirs|TestSyncSuffix)$'" - Starting (try 4/5) 2025/01/29 01:47:36 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-johiqef6huco" 2025/01/29 01:47:36 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/29 01:47:36 DEBUG : Starting OpenDrive session with ID: f725cb9a070cb574ba66004e048315914c15cf0ecec2af0689aa44c6592099ad 2025/01/29 01:47:37 DEBUG : Creating backend with remote "/tmp/rclone607935798" === RUN TestSyncSuffix run.go:180: Remote "OpenDrive root 'rclone-test-johiqef6huco'", Local "Local file system at /tmp/rclone607935798", Modify Window "1s" 2025/01/29 01:47:38 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2025/01/29 01:47:40 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2025/01/29 01:47:42 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2025/01/29 01:47:44 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-johiqef6huco/dst" 2025/01/29 01:47:44 DEBUG : Starting OpenDrive session with ID: e55d7f4c6973a06d1c6dccfe84fb1b450ccec5c671255ae0d537132835d35ed0 2025/01/29 01:47:45 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/29 01:47:45 DEBUG : one: same parent dir (ODFfNzk5NzE0MV9WSFRSUg) - using file/rename instead of move_copy for one.bak 2025/01/29 01:47:45 INFO : one: Moved (server-side) to: one.bak 2025/01/29 01:47:46 DEBUG : one: Uploading chunk 0, size=4, remain=0 2025/01/29 01:47:47 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/01/29 01:47:47 INFO : one: Copied (new) 2025/01/29 01:47:47 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/01/29 01:47:47 DEBUG : two: Unchanged skipping 2025/01/29 01:47:47 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/01/29 01:47:48 DEBUG : three.txt: same parent dir (ODFfNzk5NzE0MV9WSFRSUg) - using file/rename instead of move_copy for three.txt.bak 2025/01/29 01:47:48 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/01/29 01:47:49 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0 2025/01/29 01:47:50 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/01/29 01:47:50 INFO : three.txt: Copied (new) 2025/01/29 01:47:51 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/29 01:47:51 INFO : one.bak: Deleted 2025/01/29 01:47:51 DEBUG : one: same parent dir (ODFfNzk5NzE0MV9WSFRSUg) - using file/rename instead of move_copy for one.bak 2025/01/29 01:47:51 INFO : one: Moved (server-side) to: one.bak 2025/01/29 01:47:52 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/01/29 01:47:53 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/01/29 01:47:53 INFO : one: Copied (new) 2025/01/29 01:47:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/01/29 01:47:53 DEBUG : two: Unchanged skipping 2025/01/29 01:47:53 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/01/29 01:47:54 INFO : three.txt.bak: Deleted 2025/01/29 01:47:54 DEBUG : three.txt: same parent dir (ODFfNzk5NzE0MV9WSFRSUg) - using file/rename instead of move_copy for three.txt.bak 2025/01/29 01:47:54 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/01/29 01:47:55 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0 2025/01/29 01:47:56 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/01/29 01:47:56 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (21.09s) === RUN TestFixCase run.go:180: Remote "OpenDrive root 'rclone-test-johiqef6huco'", Local "Local file system at /tmp/rclone607935798", Modify Window "1s" 2025/01/29 01:47:58 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0 2025/01/29 01:48:00 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0 2025/01/29 01:48:03 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 0, size=8, remain=0 2025/01/29 01:48:05 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 0, size=8, remain=0 2025/01/29 01:48:08 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/01/29 01:48:08 DEBUG : existing: Unchanged skipping 2025/01/29 01:48:08 DEBUG : existingbutdifferent: Sizes differ (src 5 vs dst 8) 2025/01/29 01:48:08 DEBUG : subdira-rclone-move-teqoyot2: same parent dir (ODFfNzk5NzE0MF9FaGJNTQ) - using folder/rename instead of move_copy 2025/01/29 01:48:08 DEBUG : EXISTING: moving to existing-rclone-move-loleniz9 2025/01/29 01:48:08 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-guziquj0 2025/01/29 01:48:09 DEBUG : subdira: same parent dir (ODFfNzk5NzE0MF9FaGJNTQ) - using folder/rename instead of move_copy 2025/01/29 01:48:09 DEBUG : EXISTINGBUTDIFFERENT: same parent dir (ODFfNzk5NzE0MF9FaGJNTQ) - using file/rename instead of move_copy for existingbutdifferent-rclone-move-guziquj0 2025/01/29 01:48:09 INFO : SUBDIRA: Fixed case by renaming to: subdira 2025/01/29 01:48:09 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-guziquj0 2025/01/29 01:48:09 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent 2025/01/29 01:48:09 DEBUG : EXISTING: same parent dir (ODFfNzk5NzE0MF9FaGJNTQ) - using file/rename instead of move_copy for existing-rclone-move-loleniz9 2025/01/29 01:48:09 DEBUG : subdira/subdirb/subdirc/hello: Need to transfer - File not found at Destination 2025/01/29 01:48:09 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Need to transfer - File not found at Destination 2025/01/29 01:48:09 DEBUG : OpenDrive root 'rclone-test-johiqef6huco': Waiting for checks to finish 2025/01/29 01:48:09 INFO : EXISTING: Moved (server-side) to: existing-rclone-move-loleniz9 2025/01/29 01:48:09 DEBUG : EXISTING: moving to existing 2025/01/29 01:48:10 DEBUG : existingbutdifferent-rclone-move-guziquj0: same parent dir (ODFfNzk5NzE0MF9FaGJNTQ) - using file/rename instead of move_copy for existingbutdifferent 2025/01/29 01:48:10 DEBUG : existing-rclone-move-loleniz9: same parent dir (ODFfNzk5NzE0MF9FaGJNTQ) - using file/rename instead of move_copy for existing 2025/01/29 01:48:10 INFO : existingbutdifferent-rclone-move-guziquj0: Moved (server-side) to: existingbutdifferent 2025/01/29 01:48:10 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent 2025/01/29 01:48:10 INFO : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent 2025/01/29 01:48:10 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 0, size=5, remain=0 2025/01/29 01:48:10 INFO : existing-rclone-move-loleniz9: Moved (server-side) to: existing 2025/01/29 01:48:10 INFO : EXISTING: Moved (server-side) to: existing 2025/01/29 01:48:10 INFO : EXISTING: Fixed case by renaming to: existing 2025/01/29 01:48:10 DEBUG : OpenDrive root 'rclone-test-johiqef6huco': Waiting for transfers to finish 2025/01/29 01:48:11 DEBUG : existingbutdifferent: Uploading chunk 0, size=5, remain=0 2025/01/29 01:48:11 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 0, size=5, remain=0 2025/01/29 01:48:11 DEBUG : subdira/subdirb/subdirc/hello: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/01/29 01:48:11 INFO : subdira/subdirb/subdirc/hello: Copied (new) 2025/01/29 01:48:12 DEBUG : existingbutdifferent: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/01/29 01:48:12 INFO : existingbutdifferent: Copied (replaced existing) 2025/01/29 01:48:12 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK 2025/01/29 01:48:12 INFO : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (new) 2025/01/29 01:48:12 DEBUG : Waiting for deletions to finish fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /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:2657 Error: Should be true Test: TestFixCase Messages: listing wrong, want existing (6), existingbutdifferent (5), subdira/subdirb/subdirc/hello (5), subdira/subdirb/subdirc/subdird/filewithoutcasedifferences (5) got existing (6), existingbutdifferent (5), subdira/subdirb/SUBDIRC/HELLO (5), subdira/subdirb/SUBDIRC/subdird/filewithoutcasedifferences (5) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /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:2657 Error: Should be true Test: TestFixCase Messages: Unexpected file "subdira/subdirb/SUBDIRC/HELLO" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /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:2657 Error: Should be true Test: TestFixCase Messages: Unexpected file "subdira/subdirb/SUBDIRC/subdird/filewithoutcasedifferences" fstest.go:197: Not found "subdira/subdirb/subdirc/hello" fstest.go:197: Not found "subdira/subdirb/subdirc/subdird/filewithoutcasedifferences" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /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:2657 Error: Not equal: expected: 0 actual : 2 Test: TestFixCase Messages: 2 objects not found --- FAIL: TestFixCase (28.45s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "OpenDrive root 'rclone-test-johiqef6huco'", Local "Local file system at /tmp/rclone607935798", Modify Window "1s" 2025/01/29 01:48:26 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/01/29 01:48:26 INFO : sub dir: Making directory 2025/01/29 01:48:27 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC sync_test.go:2793: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bilib/output.go:18 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2791 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2871 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestNothingToTransferWithEmptyDirs --- FAIL: TestNothingToTransferWithEmptyDirs (11.31s) FAIL "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestFixCase|TestNothingToTransferWithEmptyDirs|TestSyncSuffix)$'" - Finished ERROR in 1m2.267743985s (try 4/5): exit status 1: Failed [TestFixCase TestNothingToTransferWithEmptyDirs]