"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestServerSideMoveWithFilter|TestSyncOverlapWithFilter|TestSyncSuffix)$'" - Starting (try 2/5) 2025/03/26 04:13:02 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-divaqiz5zine" 2025/03/26 04:13:02 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/26 04:13:02 DEBUG : Starting OpenDrive session with ID: 1cd3b4bde1cdd508c510433fa10ac9ebdc0373ce47f9a7e3c831a63b7b7960e9 2025/03/26 04:13:03 DEBUG : Creating backend with remote "/tmp/rclone644609557" === RUN TestServerSideMoveWithFilter run.go:180: Remote "OpenDrive root 'rclone-test-divaqiz5zine'", Local "Local file system at /tmp/rclone644609557", Modify Window "1s" 2025/03/26 04:13:03 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-xupidut6diyo" 2025/03/26 04:13:03 DEBUG : Starting OpenDrive session with ID: 0962879281faa793aa028d6df2477b196ea1a877db292ecad92834427be5855b 2025/03/26 04:13:05 DEBUG : potato2: Uploading chunk 0, size=60, remain=0 2025/03/26 04:13:06 DEBUG : empty space: Uploading chunk 0, size=1, remain=0 2025/03/26 04:13:08 DEBUG : potato3: Uploading chunk 0, size=68, remain=0 sync_test.go:1705: Server side move (if possible) OpenDrive root 'rclone-test-divaqiz5zine' -> OpenDrive root 'rclone-test-xupidut6diyo' 2025/03/26 04:13:10 DEBUG : empty space: Uploading chunk 0, size=1, remain=0 2025/03/26 04:13:12 DEBUG : potato3: Uploading chunk 0, size=60, remain=0 2025/03/26 04:13:13 DEBUG : empty space: Excluded (Size Filter) 2025/03/26 04:13:13 DEBUG : empty space: Excluded 2025/03/26 04:13:13 DEBUG : empty space: Excluded (Size Filter) 2025/03/26 04:13:13 DEBUG : empty space: Excluded 2025/03/26 04:13:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/26 04:13:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/26 04:13:13 DEBUG : OpenDrive root 'rclone-test-xupidut6diyo': Waiting for checks to finish 2025/03/26 04:13:13 DEBUG : OpenDrive root 'rclone-test-xupidut6diyo': Waiting for transfers to finish 2025/03/26 04:13:13 INFO : potato3: Deleted 2025/03/26 04:13:13 INFO : potato2: Moved (server-side) 2025/03/26 04:13:14 INFO : potato3: Moved (server-side) 2025/03/26 04:13:14 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-diyekaz6zozi" 2025/03/26 04:13:14 DEBUG : Starting OpenDrive session with ID: 2026196769ff0347502390f83783581863e627ea5e7b4292aefa5eb16b1ca337 2025/03/26 04:13:15 DEBUG : empty space: Excluded (Size Filter) 2025/03/26 04:13:15 DEBUG : empty space: Excluded 2025/03/26 04:13:15 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/26 04:13:15 DEBUG : potato3: Need to transfer - File not found at Destination 2025/03/26 04:13:15 DEBUG : OpenDrive root 'rclone-test-diyekaz6zozi': Waiting for checks to finish 2025/03/26 04:13:15 DEBUG : OpenDrive root 'rclone-test-diyekaz6zozi': Waiting for transfers to finish 2025/03/26 04:13:16 INFO : potato3: Moved (server-side) 2025/03/26 04:13:16 INFO : potato2: Moved (server-side) 2025/03/26 04:13:16 DEBUG : OpenDrive root 'rclone-test-diyekaz6zozi': Purge remote 2025/03/26 04:13:17 DEBUG : OpenDrive root 'rclone-test-xupidut6diyo': Purge remote --- PASS: TestServerSideMoveWithFilter (14.83s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "OpenDrive root 'rclone-test-divaqiz5zine'", Local "Local file system at /tmp/rclone644609557", Modify Window "1s" 2025/03/26 04:13:17 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-divaqiz5zine/rclone-sync-test" 2025/03/26 04:13:18 DEBUG : Starting OpenDrive session with ID: 205978c9978754b043830903ad506932259e603f1dd89fa9c94615c9860a78b0 2025/03/26 04:13:19 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-divaqiz5zine/rclone-sync-test-include/layer2" 2025/03/26 04:13:19 DEBUG : Starting OpenDrive session with ID: 247e7876e86ee942f00e269c8077a82c5cf3f229fd7fffbe72655c3f8d2fbde7 sync_test.go:1986: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1986 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestSyncOverlapWithFilter 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:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1986 Error: Not equal: expected: []string{} actual : []string{"rclone-sync-test-include"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=24) "rclone-sync-test-include" } Test: TestSyncOverlapWithFilter Messages: directories --- FAIL: TestSyncOverlapWithFilter (12.20s) === RUN TestSyncSuffix run.go:180: Remote "OpenDrive root 'rclone-test-divaqiz5zine'", Local "Local file system at /tmp/rclone644609557", Modify Window "1s" 2025/03/26 04:13:31 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2025/03/26 04:13:33 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2025/03/26 04:13:34 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2025/03/26 04:13:36 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-divaqiz5zine/dst" 2025/03/26 04:13:36 DEBUG : Starting OpenDrive session with ID: 7b8a688a0ac9f43d5d1d385b16f9e3803510c1e7ad4e3135e37b5c6e39a10928 2025/03/26 04:13:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/26 04:13:37 DEBUG : one: same parent dir (ODFfODE5MjQ3NV9GcEtUVg) - using file/rename instead of move_copy for one.bak 2025/03/26 04:13:37 INFO : one: Moved (server-side) to: one.bak 2025/03/26 04:13:38 DEBUG : one: Uploading chunk 0, size=4, remain=0 2025/03/26 04:13:39 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/03/26 04:13:39 INFO : one: Copied (new) 2025/03/26 04:13:39 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/26 04:13:39 DEBUG : two: Unchanged skipping 2025/03/26 04:13:39 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/03/26 04:13:40 DEBUG : three.txt: same parent dir (ODFfODE5MjQ3NV9GcEtUVg) - using file/rename instead of move_copy for three.txt.bak 2025/03/26 04:13:40 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/26 04:13:40 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0 2025/03/26 04:13:41 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/03/26 04:13:41 INFO : three.txt: Copied (new) 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:2491 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Should be true Test: TestSyncSuffix Messages: listing wrong, want dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3) got dst/one (4), dst/one.bak (3), dst/three.txt.bak (6), dst/two (3) fstest.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:137 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /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:2491 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Should be true Test: TestSyncSuffix Messages: OpenDrive root 'rclone-test-divaqiz5zine'/dst/three.txt.bak: md5 hash incorrect - expecting "35d6d33467aae9a2e3dccb4b6b027878" got "91341eed84691a83caea73aa785736d5" fstest.go:144: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:144 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /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:2491 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Not equal: expected: 5 actual : 6 Test: TestSyncSuffix Messages: dst/three.txt.bak: size incorrect file=5 vs obj=6 fstest.go:197: Not found "dst/three.txt" 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:2491 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Not equal: expected: 0 actual : 1 Test: TestSyncSuffix Messages: 1 objects not found 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:2497 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Should be true Test: TestSyncSuffix Messages: listing wrong, want dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3) got dst/one (4), dst/one.bak (3), dst/three.txt.bak (6), dst/two (3) fstest.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:137 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /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:2497 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Should be true Test: TestSyncSuffix Messages: OpenDrive root 'rclone-test-divaqiz5zine'/dst/three.txt.bak: md5 hash incorrect - expecting "35d6d33467aae9a2e3dccb4b6b027878" got "91341eed84691a83caea73aa785736d5" fstest.go:144: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:144 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /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:2497 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Not equal: expected: 5 actual : 6 Test: TestSyncSuffix Messages: dst/three.txt.bak: size incorrect file=5 vs obj=6 fstest.go:197: Not found "dst/three.txt" 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:2497 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Not equal: expected: 0 actual : 1 Test: TestSyncSuffix Messages: 1 objects not found 2025/03/26 04:13:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/26 04:13:59 INFO : one.bak: Deleted 2025/03/26 04:13:59 DEBUG : one: same parent dir (ODFfODE5MjQ3NV9GcEtUVg) - using file/rename instead of move_copy for one.bak 2025/03/26 04:13:59 INFO : one: Moved (server-side) to: one.bak 2025/03/26 04:14:00 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/03/26 04:14:01 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/03/26 04:14:01 INFO : one: Copied (new) 2025/03/26 04:14:01 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/26 04:14:01 DEBUG : two: Unchanged skipping 2025/03/26 04:14:01 DEBUG : three.txt: Need to transfer - File not found at Destination 2025/03/26 04:14:02 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0 2025/03/26 04:14:03 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/03/26 04:14:03 INFO : three.txt: Copied (new) --- FAIL: TestSyncSuffix (36.30s) FAIL 2025/03/26 04:14:06 DEBUG : OpenDrive root 'rclone-test-divaqiz5zine': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestServerSideMoveWithFilter|TestSyncOverlapWithFilter|TestSyncSuffix)$'" - Finished ERROR in 1m4.57545171s (try 2/5): exit status 1: Failed [TestSyncOverlapWithFilter TestSyncSuffix]