"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestServerSideMove|TestSyncOverlapWithFilter|TestSyncSuffixKeepExtension|TestSyncUTFNorm)$'" - Starting (try 4/5) 2025/04/14 05:31:52 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mumexij1puga" 2025/04/14 05:31:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/14 05:31:53 DEBUG : Creating backend with remote "/tmp/rclone570056404" === RUN TestServerSideMove run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" 2025/04/14 05:31:53 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xinunuk4woxi" sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-mumexij1puga' -> pcloud root 'rclone-test-xinunuk4woxi' 2025/04/14 05:31:55 DEBUG : pcloud root 'rclone-test-xinunuk4woxi': Using server-side directory move 2025/04/14 05:31:55 INFO : pcloud root 'rclone-test-xinunuk4woxi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/14 05:31:55 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 05:31:55 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/14 05:31:55 DEBUG : empty space: Unchanged skipping 2025/04/14 05:31:55 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/14 05:31:55 DEBUG : pcloud root 'rclone-test-xinunuk4woxi': Waiting for checks to finish 2025/04/14 05:31:56 INFO : potato2: Moved (server-side) 2025/04/14 05:31:56 INFO : empty space: Deleted 2025/04/14 05:31:56 DEBUG : pcloud root 'rclone-test-xinunuk4woxi': Waiting for transfers to finish 2025/04/14 05:31:56 INFO : potato3: Deleted 2025/04/14 05:31:56 INFO : potato3: Moved (server-side) 2025/04/14 05:31:56 DEBUG : Creating backend with remote "TestPcloud:rclone-test-colesag1kunu" 2025/04/14 05:31:57 DEBUG : pcloud root 'rclone-test-colesag1kunu': Using server-side directory move 2025/04/14 05:31:57 INFO : pcloud root 'rclone-test-colesag1kunu': Server side directory move succeeded 2025/04/14 05:31:58 DEBUG : pcloud root 'rclone-test-colesag1kunu': Purge remote 2025/04/14 05:31:58 DEBUG : pcloud root 'rclone-test-xinunuk4woxi': Purge remote 2025/04/14 05:31:59 NOTICE: purge failed: directory not found --- PASS: TestServerSideMove (6.15s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" 2025/04/14 05:31:59 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mumexij1puga/rclone-sync-test" 2025/04/14 05:32:00 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mumexij1puga/rclone-sync-test-include/layer2" 2025/04/14 05:32:01 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mumexij1puga/rclone-sync-test-ignore-file" 2025/04/14 05:32:02 DEBUG : rclone-sync-test: Excluded 2025/04/14 05:32:03 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/14 05:32:03 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/04/14 05:32:03 DEBUG : pcloud root 'rclone-test-mumexij1puga/rclone-sync-test': Waiting for checks to finish 2025/04/14 05:32:03 DEBUG : pcloud root 'rclone-test-mumexij1puga/rclone-sync-test': Waiting for transfers to finish 2025/04/14 05:32:03 DEBUG : Waiting for deletions to finish 2025/04/14 05:32:03 INFO : There was nothing to transfer 2025/04/14 05:32:03 DEBUG : rclone-sync-test: Excluded 2025/04/14 05:32:03 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/14 05:32:04 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/04/14 05:32:04 DEBUG : pcloud root 'rclone-test-mumexij1puga': Waiting for checks to finish 2025/04/14 05:32:04 DEBUG : pcloud root 'rclone-test-mumexij1puga': Waiting for transfers to finish 2025/04/14 05:32:04 DEBUG : Waiting for deletions to finish 2025/04/14 05:32:04 INFO : rclone-sync-test-include: Removing directory 2025/04/14 05:32:04 DEBUG : rclone-sync-test-include: Failed to Rmdir: rmdir failed: pcloud error: Folder is not empty. (2006) 2025/04/14 05:32:04 DEBUG : pcloud root 'rclone-test-mumexij1puga': failed to delete 1 directories 2025/04/14 05:32:04 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" 2025/04/14 05:32:04 DEBUG : rclone-sync-test: Excluded 2025/04/14 05:32:04 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/14 05:32:04 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/04/14 05:32:04 DEBUG : pcloud root 'rclone-test-mumexij1puga/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/04/14 05:32:04 DEBUG : pcloud root 'rclone-test-mumexij1puga/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/04/14 05:32:04 DEBUG : Waiting for deletions to finish 2025/04/14 05:32:04 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" 2025/04/14 05:32:04 DEBUG : rclone-sync-test: Excluded 2025/04/14 05:32:05 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/14 05:32:05 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/04/14 05:32:05 DEBUG : pcloud root 'rclone-test-mumexij1puga': Waiting for checks to finish 2025/04/14 05:32:05 DEBUG : pcloud root 'rclone-test-mumexij1puga': Waiting for transfers to finish 2025/04/14 05:32:05 DEBUG : Waiting for deletions to finish 2025/04/14 05:32:05 INFO : rclone-sync-test-include: Removing directory 2025/04/14 05:32:05 DEBUG : rclone-sync-test-include: Failed to Rmdir: rmdir failed: pcloud error: Folder is not empty. (2006) 2025/04/14 05:32:05 DEBUG : pcloud root 'rclone-test-mumexij1puga': failed to delete 1 directories 2025/04/14 05:32:05 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" 2025/04/14 05:32:05 DEBUG : : Excluded 2025/04/14 05:32:05 DEBUG : rclone-sync-test: Excluded 2025/04/14 05:32:05 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/14 05:32:05 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/04/14 05:32:05 DEBUG : pcloud root 'rclone-test-mumexij1puga/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/04/14 05:32:05 DEBUG : pcloud root 'rclone-test-mumexij1puga/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/04/14 05:32:05 DEBUG : Waiting for deletions to finish 2025/04/14 05:32:05 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" --- PASS: TestSyncOverlapWithFilter (11.08s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" 2025/04/14 05:32:11 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mumexij1puga/dst" 2025/04/14 05:32:12 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/14 05:32:12 INFO : one: Moved (server-side) to: one-2019-01-01 2025/04/14 05:32:12 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/14 05:32:12 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/14 05:32:12 INFO : one: Copied (new) 2025/04/14 05:32:12 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 05:32:12 DEBUG : two: Unchanged skipping 2025/04/14 05:32:12 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/14 05:32:13 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/04/14 05:32:13 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2025/04/14 05:32:13 DEBUG : three.txt.468f3f0c.partial: renamed to: three.txt 2025/04/14 05:32:13 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:286: Sleeping for 6s just to make sure 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:2524 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3) got fstest.go:197: Not found "dst/one" fstest.go:197: Not found "dst/three.txt" fstest.go:197: Not found "dst/one-2019-01-01" fstest.go:197: Not found "dst/two" fstest.go:197: Not found "dst/three-2019-01-01.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:2524 Error: Not equal: expected: 0 actual : 5 Test: TestSyncSuffixKeepExtension Messages: 5 objects not found 2025/04/14 05:32:28 DEBUG : one: Need to transfer - File not found at Destination 2025/04/14 05:32:28 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/14 05:32:29 DEBUG : one.1503b713.partial: renamed to: one 2025/04/14 05:32:29 INFO : one: Copied (new) 2025/04/14 05:32:29 DEBUG : two: Need to transfer - File not found at Destination 2025/04/14 05:32:29 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/14 05:32:29 DEBUG : two.b824e1ab.partial: renamed to: two 2025/04/14 05:32:29 INFO : two: Copied (new) 2025/04/14 05:32:29 DEBUG : three.txt: Need to transfer - File not found at Destination 2025/04/14 05:32:29 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2025/04/14 05:32:29 DEBUG : three.txt.ff911d53.partial: renamed to: three.txt 2025/04/14 05:32:29 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:2521 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (5), dst/one-2019-01-01 (4), dst/three-2019-01-01.txt (6), dst/three.txt (19), dst/two (3) got fstest.go:197: Not found "dst/one" fstest.go:197: Not found "dst/three.txt" fstest.go:197: Not found "dst/two" fstest.go:197: Not found "dst/three-2019-01-01.txt" fstest.go:197: Not found "dst/one-2019-01-01" 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:2521 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Not equal: expected: 0 actual : 5 Test: TestSyncSuffixKeepExtension Messages: 5 objects not found --- FAIL: TestSyncSuffixKeepExtension (28.17s) === RUN TestSyncUTFNorm run.go:180: Remote "pcloud root 'rclone-test-mumexij1puga'", Local "Local file system at /tmp/rclone570056404", Modify Window "1s" 2025/04/14 05:32:38 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/04/14 05:32:38 DEBUG : pcloud root 'rclone-test-mumexij1puga': Waiting for checks to finish 2025/04/14 05:32:38 DEBUG : pcloud root 'rclone-test-mumexij1puga': Waiting for transfers to finish 2025/04/14 05:32:39 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2025/04/14 05:32:39 DEBUG : Testêé.53508f02.partial: renamed to: Testêé 2025/04/14 05:32:39 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/04/14 05:32:39 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (0.95s) FAIL 2025/04/14 05:32:39 DEBUG : pcloud root 'rclone-test-mumexij1puga': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestServerSideMove|TestSyncOverlapWithFilter|TestSyncSuffixKeepExtension|TestSyncUTFNorm)$'" - Finished ERROR in 47.133762557s (try 4/5): exit status 1: Failed [TestSyncSuffixKeepExtension]