"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list -test.run '^(TestCopyAfterDelete|TestCopyRedownload|TestServerSideMove|TestServerSideMoveOverSelf|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncBasedOnCheckSum|TestSyncCompareDest|TestSyncMultipleCompareDest|TestSyncOverlapWithFilter|TestSyncWithExclude|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithUpdateOlder)$'" - Starting (try 3/5) 2025/04/13 06:52:50 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe" 2025/04/13 06:52:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/13 06:52:51 DEBUG : Creating backend with remote "/tmp/rclone3434949151" === RUN TestServerSideMoveOverSelf run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:52:51 DEBUG : Creating backend with remote "TestPcloud:rclone-test-ninajez2siti" sync_test.go:671: Server side copy (if possible) pcloud root 'rclone-test-mabaweh5dawe' -> pcloud root 'rclone-test-ninajez2siti' 2025/04/13 06:52:53 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/13 06:52:53 DEBUG : pcloud root 'rclone-test-ninajez2siti': Waiting for checks to finish 2025/04/13 06:52:53 DEBUG : pcloud root 'rclone-test-ninajez2siti': Waiting for transfers to finish 2025/04/13 06:52:54 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/13 06:52:54 DEBUG : sub dir/hello world.e0e42c92.partial: renamed to: sub dir/hello world 2025/04/13 06:52:54 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:52:54 DEBUG : pcloud root 'rclone-test-ninajez2siti': Using server-side directory move 2025/04/13 06:52:54 INFO : pcloud root 'rclone-test-ninajez2siti': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/13 06:52:54 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/13 06:52:54 DEBUG : pcloud root 'rclone-test-ninajez2siti': Waiting for checks to finish 2025/04/13 06:52:54 DEBUG : pcloud root 'rclone-test-ninajez2siti': Waiting for transfers to finish 2025/04/13 06:52:54 INFO : sub dir/hello world: Deleted 2025/04/13 06:52:54 INFO : sub dir/hello world: Moved (server-side) 2025/04/13 06:52:55 DEBUG : testing file moves 2025/04/13 06:52:55 DEBUG : pcloud root 'rclone-test-ninajez2siti': Waiting for checks to finish 2025/04/13 06:52:55 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/04/13 06:52:55 DEBUG : pcloud root 'rclone-test-ninajez2siti': Waiting for transfers to finish 2025/04/13 06:52:55 INFO : sub dir/hello world: Deleted 2025/04/13 06:52:55 INFO : sub dir/hello world: Moved (server-side) run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:52:55 DEBUG : pcloud root 'rclone-test-ninajez2siti': Purge remote --- PASS: TestServerSideMoveOverSelf (5.39s) === RUN TestCopyAfterDelete run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:52:56 ERROR : : error listing: directory not found 2025/04/13 06:52:57 INFO : Local file system at /tmp/rclone3434949151: Making directory 2025/04/13 06:52:57 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:52:57 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" --- PASS: TestCopyAfterDelete (1.17s) === RUN TestCopyRedownload run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:52:58 DEBUG : Added delayed dir = "sub dir", newDst= 2025/04/13 06:52:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/13 06:52:58 DEBUG : Local file system at /tmp/rclone3434949151: Waiting for checks to finish 2025/04/13 06:52:58 DEBUG : Local file system at /tmp/rclone3434949151: Waiting for transfers to finish 2025/04/13 06:52:58 DEBUG : Couldn't parse Date: from server edef5.pcloud.com: "Sun, 13 Apr 2025 06:52:58 +0000": parsing time "Sun, 13 Apr 2025 06:52:58 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Apr 2025 06:52:58 +0000" as " " 2025/04/13 06:52:58 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/13 06:52:58 DEBUG : sub dir/hello world.e0e42c92.partial: renamed to: sub dir/hello world 2025/04/13 06:52:58 INFO : sub dir/hello world: Copied (new) 2025/04/13 06:52:58 INFO : sub dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" --- PASS: TestCopyRedownload (1.26s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:52:59 DEBUG : check sum: Need to transfer - File not found at Destination 2025/04/13 06:52:59 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:52:59 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:52:59 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/13 06:52:59 DEBUG : check sum.b37ac6a8.partial: renamed to: check sum 2025/04/13 06:52:59 INFO : check sum: Copied (new) 2025/04/13 06:52:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:52:59 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:52:59 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/13 06:52:59 DEBUG : check sum: Size and sha1 of src and dst objects identical 2025/04/13 06:52:59 DEBUG : check sum: Unchanged skipping 2025/04/13 06:52:59 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:52:59 DEBUG : Waiting for deletions to finish 2025/04/13 06:52:59 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" --- PASS: TestSyncBasedOnCheckSum (1.76s) === RUN TestSyncWithExclude run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:01 DEBUG : enormous: Excluded (Size Filter) 2025/04/13 06:53:01 DEBUG : enormous: Excluded 2025/04/13 06:53:01 DEBUG : potato2: Excluded (Size Filter) 2025/04/13 06:53:01 DEBUG : potato2: Excluded 2025/04/13 06:53:01 DEBUG : potato2: Excluded (Size Filter) 2025/04/13 06:53:01 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/13 06:53:01 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:53:01 DEBUG : empty space: Unchanged skipping 2025/04/13 06:53:01 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:53:01 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:01 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:01 DEBUG : enormous: Excluded (Size Filter) 2025/04/13 06:53:01 DEBUG : enormous: Excluded 2025/04/13 06:53:01 DEBUG : potato2: Excluded (Size Filter) 2025/04/13 06:53:01 DEBUG : potato2: Excluded 2025/04/13 06:53:02 DEBUG : Local file system at /tmp/rclone3434949151: Waiting for checks to finish 2025/04/13 06:53:02 DEBUG : Local file system at /tmp/rclone3434949151: Waiting for transfers to finish 2025/04/13 06:53:02 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:02 INFO : empty space: Deleted 2025/04/13 06:53:02 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 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:334 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1381 Error: Should be true Test: TestSyncWithExclude Messages: listing wrong, want empty space (1), enormous (100), potato2 (60) got enormous (100), potato2 (60) fstest.go:197: Not found "empty space" 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:334 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1381 Error: Not equal: expected: 0 actual : 1 Test: TestSyncWithExclude Messages: 1 objects not found --- FAIL: TestSyncWithExclude (8.73s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:10 DEBUG : enormous: Excluded (Size Filter) 2025/04/13 06:53:10 DEBUG : enormous: Excluded 2025/04/13 06:53:10 DEBUG : potato2: Excluded (Size Filter) 2025/04/13 06:53:10 DEBUG : potato2: Excluded 2025/04/13 06:53:10 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/13 06:53:10 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:53:10 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:53:10 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/13 06:53:10 DEBUG : empty space.56d1852a.partial: renamed to: empty space 2025/04/13 06:53:10 INFO : empty space: Copied (new) 2025/04/13 06:53:10 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 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:1405 Error: Should be true Test: TestSyncWithExcludeAndDeleteExcluded Messages: listing wrong, want empty space (1) got empty space (1), enormous (100), potato2 (60) 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:1405 Error: Should be true Test: TestSyncWithExcludeAndDeleteExcluded Messages: Unexpected file "enormous" 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:1405 Error: Should be true Test: TestSyncWithExcludeAndDeleteExcluded Messages: Unexpected file "potato2" 2025/04/13 06:53:18 DEBUG : enormous: Excluded (Size Filter) 2025/04/13 06:53:18 DEBUG : potato2: Excluded (Size Filter) 2025/04/13 06:53:18 DEBUG : empty space: Size and modification time the same (differ by 123.456789ms, within tolerance 1s) 2025/04/13 06:53:18 DEBUG : empty space: Unchanged skipping 2025/04/13 06:53:18 DEBUG : Local file system at /tmp/rclone3434949151: Waiting for checks to finish 2025/04/13 06:53:18 DEBUG : Local file system at /tmp/rclone3434949151: Waiting for transfers to finish 2025/04/13 06:53:18 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:18 INFO : enormous: Deleted 2025/04/13 06:53:18 INFO : potato2: Deleted 2025/04/13 06:53:18 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" --- FAIL: TestSyncWithExcludeAndDeleteExcluded (10.12s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:20 DEBUG : five: Need to transfer - File not found at Destination 2025/04/13 06:53:20 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/04/13 06:53:20 DEBUG : three: Sizes identical 2025/04/13 06:53:20 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:53:20 DEBUG : one: Destination is newer than source, skipping 2025/04/13 06:53:20 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/04/13 06:53:20 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/04/13 06:53:20 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone3434949151) 2025/04/13 06:53:20 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (pcloud root 'rclone-test-mabaweh5dawe') 2025/04/13 06:53:20 DEBUG : two: sha1 differ 2025/04/13 06:53:20 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:53:20 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2025/04/13 06:53:20 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2025/04/13 06:53:20 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/13 06:53:20 DEBUG : five.a87a5b8d.partial: renamed to: five 2025/04/13 06:53:20 INFO : five: Copied (new) 2025/04/13 06:53:20 DEBUG : four.a87a5b8d.partial: renamed to: four 2025/04/13 06:53:20 INFO : four: Copied (replaced existing) 2025/04/13 06:53:20 DEBUG : two.3353c5f5.partial: renamed to: two 2025/04/13 06:53:20 INFO : two: Copied (replaced existing) 2025/04/13 06:53:20 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:21 DEBUG : one: Destination is newer than source, skipping 2025/04/13 06:53:21 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:53:21 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2025/04/13 06:53:21 DEBUG : five: Size and sha1 of src and dst objects identical 2025/04/13 06:53:21 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2025/04/13 06:53:21 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2025/04/13 06:53:21 DEBUG : four: Size and sha1 of src and dst objects identical 2025/04/13 06:53:21 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2025/04/13 06:53:21 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone3434949151) 2025/04/13 06:53:21 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (pcloud root 'rclone-test-mabaweh5dawe') 2025/04/13 06:53:21 DEBUG : three: sha1 differ 2025/04/13 06:53:21 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2025/04/13 06:53:21 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/13 06:53:21 DEBUG : two: Size and sha1 of src and dst objects identical 2025/04/13 06:53:21 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2025/04/13 06:53:21 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:53:21 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2025/04/13 06:53:21 DEBUG : three.406dcb2c.partial: renamed to: three 2025/04/13 06:53:21 INFO : three: Copied (replaced existing) 2025/04/13 06:53:21 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (3.09s) === RUN TestServerSideMove run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:22 DEBUG : Creating backend with remote "TestPcloud:rclone-test-suvapep0reja" sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-mabaweh5dawe' -> pcloud root 'rclone-test-suvapep0reja' 2025/04/13 06:53:25 DEBUG : pcloud root 'rclone-test-suvapep0reja': Using server-side directory move 2025/04/13 06:53:25 INFO : pcloud root 'rclone-test-suvapep0reja': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/13 06:53:25 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/13 06:53:25 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/13 06:53:25 DEBUG : empty space: Unchanged skipping 2025/04/13 06:53:25 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/13 06:53:25 DEBUG : pcloud root 'rclone-test-suvapep0reja': Waiting for checks to finish 2025/04/13 06:53:25 INFO : potato3: Deleted 2025/04/13 06:53:25 INFO : empty space: Deleted 2025/04/13 06:53:25 DEBUG : pcloud root 'rclone-test-suvapep0reja': Waiting for transfers to finish 2025/04/13 06:53:25 INFO : potato2: Moved (server-side) 2025/04/13 06:53:25 INFO : potato3: Moved (server-side) 2025/04/13 06:53:25 DEBUG : Creating backend with remote "TestPcloud:rclone-test-lafucow5gejo" 2025/04/13 06:53:26 DEBUG : pcloud root 'rclone-test-lafucow5gejo': Using server-side directory move 2025/04/13 06:53:26 INFO : pcloud root 'rclone-test-lafucow5gejo': Server side directory move succeeded 2025/04/13 06:53:27 DEBUG : pcloud root 'rclone-test-lafucow5gejo': Purge remote 2025/04/13 06:53:27 DEBUG : pcloud root 'rclone-test-suvapep0reja': Purge remote 2025/04/13 06:53:28 NOTICE: purge failed: directory not found --- PASS: TestServerSideMove (5.51s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:28 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/rclone-sync-test" 2025/04/13 06:53:29 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/rclone-sync-test-include/layer2" 2025/04/13 06:53:30 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/rclone-sync-test-ignore-file" 2025/04/13 06:53:31 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/rclone-sync-test': Waiting for checks to finish 2025/04/13 06:53:31 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/rclone-sync-test': Waiting for transfers to finish 2025/04/13 06:53:31 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:31 INFO : There was nothing to transfer 2025/04/13 06:53:32 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:53:32 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:53:32 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:32 INFO : rclone-sync-test-include: Removing directory 2025/04/13 06:53:32 DEBUG : rclone-sync-test-include: Failed to Rmdir: rmdir failed: pcloud error: Folder is not empty. (2006) 2025/04/13 06:53:32 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': failed to delete 1 directories 2025/04/13 06:53:32 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:32 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/04/13 06:53:32 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/04/13 06:53:32 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:32 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:33 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for checks to finish 2025/04/13 06:53:33 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Waiting for transfers to finish 2025/04/13 06:53:33 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:33 INFO : rclone-sync-test-include: Removing directory 2025/04/13 06:53:33 DEBUG : rclone-sync-test-include: Failed to Rmdir: rmdir failed: pcloud error: Folder is not empty. (2006) 2025/04/13 06:53:33 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': failed to delete 1 directories 2025/04/13 06:53:33 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:34 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/04/13 06:53:34 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/04/13 06:53:34 DEBUG : Waiting for deletions to finish 2025/04/13 06:53:34 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" --- PASS: TestSyncOverlapWithFilter (10.62s) === RUN TestSyncCompareDest run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:53:38 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/dst" 2025/04/13 06:53:39 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/CompareDest" 2025/04/13 06:53:40 DEBUG : one: Need to transfer - File not found at Destination 2025/04/13 06:53:40 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:53:40 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:53:41 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/04/13 06:53:41 DEBUG : one.b824e1ab.partial: renamed to: one 2025/04/13 06:53:41 INFO : one: Copied (new) 2025/04/13 06:53:41 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:2090 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want dst/one (3) got fstest.go:197: Not found "dst/one" 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:2090 Error: Not equal: expected: 0 actual : 1 Test: TestSyncCompareDest 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:286: Sleeping for 6s just to make sure 2025/04/13 06:53:56 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/13 06:53:56 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:53:56 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:53:56 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/13 06:53:57 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/13 06:53:57 INFO : one: Copied (replaced existing) 2025/04/13 06:53:57 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:2106 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want dst/one (5) got fstest.go:197: Not found "dst/one" 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:2106 Error: Not equal: expected: 0 actual : 1 Test: TestSyncCompareDest 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:2112 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), dst/one (3) got fstest.go:197: Not found "dst/one" fstest.go:197: Not found "CompareDest/one" 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:2112 Error: Not equal: expected: 0 actual : 2 Test: TestSyncCompareDest Messages: 2 objects not found 2025/04/13 06:54:13 DEBUG : one: Need to transfer - File not found at Destination 2025/04/13 06:54:13 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:54:13 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:54:13 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/13 06:54:13 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/13 06:54:13 INFO : one: Copied (new) 2025/04/13 06:54:13 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:2121 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), dst/one (3) got CompareDest/one (5), dst/one (5) 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:2121 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha1 hash incorrect - expecting "fe05bcdcdc4928012781a5f1a2a77cbb5398e106" got "7f376fd65843a1267de8f986d40e164e5a321c13" 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:2121 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha256 hash incorrect - expecting "7692c3ad3540bb803c020b3aee66cd8887123234ea0c6e7143c0add73ff431ed" got "2b82f49cc03d076e84d5a393c42909b1fc2227c143ab8f84620f261fa795dec9" 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:2121 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /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:2121 Error: Should be true Test: TestSyncCompareDest Messages: dst/one: Modification time difference too big |-95456h54m52.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2011-12-25 12:59:59 +0000 UTC) (precision 1s) 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:2126 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (5) 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:2126 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha1 hash incorrect - expecting "fe05bcdcdc4928012781a5f1a2a77cbb5398e106" got "7f376fd65843a1267de8f986d40e164e5a321c13" 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:2126 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha256 hash incorrect - expecting "7692c3ad3540bb803c020b3aee66cd8887123234ea0c6e7143c0add73ff431ed" got "2b82f49cc03d076e84d5a393c42909b1fc2227c143ab8f84620f261fa795dec9" 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:2126 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /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:2126 Error: Should be true Test: TestSyncCompareDest Messages: dst/one: Modification time difference too big |-95456h54m52.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2011-12-25 12:59:59 +0000 UTC) (precision 1s) 2025/04/13 06:54:30 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/13 06:54:30 DEBUG : one: Unchanged skipping 2025/04/13 06:54:30 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/13 06:54:30 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/13 06:54:30 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:54:30 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:54:30 DEBUG : Waiting for deletions to finish 2025/04/13 06:54:30 INFO : There was nothing to transfer 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:2135 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (5) 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:2135 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha1 hash incorrect - expecting "fe05bcdcdc4928012781a5f1a2a77cbb5398e106" got "7f376fd65843a1267de8f986d40e164e5a321c13" 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:2135 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha256 hash incorrect - expecting "7692c3ad3540bb803c020b3aee66cd8887123234ea0c6e7143c0add73ff431ed" got "2b82f49cc03d076e84d5a393c42909b1fc2227c143ab8f84620f261fa795dec9" 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:2135 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /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:2135 Error: Should be true Test: TestSyncCompareDest Messages: dst/one: Modification time difference too big |-95456h54m52.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2011-12-25 12:59:59 +0000 UTC) (precision 1s) 2025/04/13 06:54:39 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/13 06:54:39 DEBUG : one: Unchanged skipping 2025/04/13 06:54:39 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/13 06:54:39 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/13 06:54:39 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:54:39 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:54:39 DEBUG : Waiting for deletions to finish 2025/04/13 06:54:39 INFO : There was nothing to transfer 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:2144 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (5) 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:2144 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha1 hash incorrect - expecting "fe05bcdcdc4928012781a5f1a2a77cbb5398e106" got "7f376fd65843a1267de8f986d40e164e5a321c13" 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:2144 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha256 hash incorrect - expecting "7692c3ad3540bb803c020b3aee66cd8887123234ea0c6e7143c0add73ff431ed" got "2b82f49cc03d076e84d5a393c42909b1fc2227c143ab8f84620f261fa795dec9" 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:2144 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /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:2144 Error: Should be true Test: TestSyncCompareDest Messages: dst/one: Modification time difference too big |-95456h54m52.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2011-12-25 12:59:59 +0000 UTC) (precision 1s) 2025/04/13 06:54:47 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/13 06:54:47 DEBUG : one: Unchanged skipping 2025/04/13 06:54:47 DEBUG : two: Modification times differ by -120h0m0s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59 +0000 UTC 2025/04/13 06:54:48 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/13 06:54:48 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/13 06:54:48 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:54:48 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:54:48 DEBUG : Waiting for deletions to finish 2025/04/13 06:54:48 INFO : There was nothing to transfer 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:2173 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (5) 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:2173 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha1 hash incorrect - expecting "fe05bcdcdc4928012781a5f1a2a77cbb5398e106" got "7f376fd65843a1267de8f986d40e164e5a321c13" 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:2173 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-mabaweh5dawe'/dst/one: sha256 hash incorrect - expecting "7692c3ad3540bb803c020b3aee66cd8887123234ea0c6e7143c0add73ff431ed" got "2b82f49cc03d076e84d5a393c42909b1fc2227c143ab8f84620f261fa795dec9" 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:2173 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /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:2173 Error: Should be true Test: TestSyncCompareDest Messages: dst/one: Modification time difference too big |-95456h54m52.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2011-12-25 12:59:59 +0000 UTC) (precision 1s) 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:2180 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got fstest.go:197: Not found "dst/one" fstest.go:197: Not found "CompareDest/two" fstest.go:197: Not found "CompareDest/one" 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:2180 Error: Not equal: expected: 0 actual : 3 Test: TestSyncCompareDest Messages: 3 objects not found 2025/04/13 06:55:04 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/13 06:55:04 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/13 06:55:04 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/04/13 06:55:04 DEBUG : two: Need to transfer - File not found at Destination 2025/04/13 06:55:04 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:55:04 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:55:04 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2025/04/13 06:55:04 DEBUG : two.1503b713.partial: renamed to: two 2025/04/13 06:55:04 INFO : two: Copied (new) 2025/04/13 06:55:04 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:2192 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3), dst/two (5) got fstest.go:197: Not found "CompareDest/one" fstest.go:197: Not found "dst/one" fstest.go:197: Not found "CompareDest/two" fstest.go:197: Not found "dst/two" 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:2192 Error: Not equal: expected: 0 actual : 4 Test: TestSyncCompareDest Messages: 4 objects not found --- FAIL: TestSyncCompareDest (94.07s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 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:2212 Error: Should be true Test: TestSyncMultipleCompareDest Messages: listing wrong, want pre-dest1/1 (1), pre-dest2/2 (1) got fstest.go:197: Not found "pre-dest1/1" fstest.go:197: Not found "pre-dest2/2" 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:2212 Error: Not equal: expected: 0 actual : 2 Test: TestSyncMultipleCompareDest Messages: 2 objects not found 2025/04/13 06:55:21 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/dest" 2025/04/13 06:55:22 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/pre-dest1" 2025/04/13 06:55:22 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/pre-dest2" 2025/04/13 06:55:23 DEBUG : 1: Need to transfer - File not found at Destination 2025/04/13 06:55:24 DEBUG : 1: sha1 = 356a192b7913b04c54574d18c28d46e6395428ab OK 2025/04/13 06:55:24 DEBUG : 1.b37ac6a8.partial: renamed to: 1 2025/04/13 06:55:24 INFO : 1: Copied (new) 2025/04/13 06:55:24 DEBUG : 2: Need to transfer - File not found at Destination 2025/04/13 06:55:24 DEBUG : 2: sha1 = da4b9237bacccdf19c0760cab7aec4a8359010b0 OK 2025/04/13 06:55:24 DEBUG : 3: Need to transfer - File not found at Destination 2025/04/13 06:55:24 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dest': Waiting for checks to finish 2025/04/13 06:55:24 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dest': Waiting for transfers to finish 2025/04/13 06:55:24 DEBUG : 2.b37ac6a8.partial: renamed to: 2 2025/04/13 06:55:24 INFO : 2: Copied (new) 2025/04/13 06:55:24 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2025/04/13 06:55:24 DEBUG : 3.b37ac6a8.partial: renamed to: 3 2025/04/13 06:55:24 INFO : 3: Copied (new) 2025/04/13 06:55:24 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/fs/sync/sync_test.go:2224 Error: Should be true Test: TestSyncMultipleCompareDest Messages: listing wrong, want 3 (1) got 1 (1), 2 (1), 3 (1) 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/fs/sync/sync_test.go:2224 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "1" 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/fs/sync/sync_test.go:2224 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "2" 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:2225 Error: Should be true Test: TestSyncMultipleCompareDest Messages: listing wrong, want dest/3 (1), pre-dest1/1 (1), pre-dest2/2 (1) got CompareDest/one (5), CompareDest/two (3), dest/1 (1), dest/2 (1), dest/3 (1), dst/one (5), dst/two (5), pre-dest1/1 (1), pre-dest2/2 (1) 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:2225 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "CompareDest/one" 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:2225 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "CompareDest/two" 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:2225 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "dest/1" 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:2225 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "dest/2" 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:2225 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "dst/one" 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:2225 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "dst/two" --- FAIL: TestSyncMultipleCompareDest (29.54s) === RUN TestSyncBackupDir run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:55:43 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/dst" 2025/04/13 06:55:43 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/backup" 2025/04/13 06:55:44 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/13 06:55:44 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/13 06:55:44 DEBUG : two: Unchanged skipping 2025/04/13 06:55:44 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:55:44 INFO : one: Moved (server-side) 2025/04/13 06:55:44 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:55:45 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/13 06:55:45 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/13 06:55:45 INFO : one: Copied (new) 2025/04/13 06:55:45 DEBUG : Waiting for deletions to finish 2025/04/13 06:55:45 INFO : three.txt: Moved (server-side) 2025/04/13 06:55:45 INFO : three.txt: Moved into backup dir 2025/04/13 06:55:46 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/13 06:55:46 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/13 06:55:46 DEBUG : two: Unchanged skipping 2025/04/13 06:55:46 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:55:46 INFO : one: Deleted 2025/04/13 06:55:46 INFO : one: Moved (server-side) 2025/04/13 06:55:46 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:55:46 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/13 06:55:46 DEBUG : one.1503b713.partial: renamed to: one 2025/04/13 06:55:46 INFO : one: Copied (new) 2025/04/13 06:55:46 DEBUG : Waiting for deletions to finish 2025/04/13 06:55:47 INFO : three.txt: Deleted 2025/04/13 06:55:47 INFO : three.txt: Moved (server-side) 2025/04/13 06:55:47 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (5.74s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "pcloud root 'rclone-test-mabaweh5dawe'", Local "Local file system at /tmp/rclone3434949151", Modify Window "1s" 2025/04/13 06:55:49 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/dst" 2025/04/13 06:55:49 DEBUG : Creating backend with remote "TestPcloud:rclone-test-mabaweh5dawe/backup" 2025/04/13 06:55:50 DEBUG : one: Need to transfer - File not found at Destination 2025/04/13 06:55:50 DEBUG : two: Need to transfer - File not found at Destination 2025/04/13 06:55:50 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for checks to finish 2025/04/13 06:55:50 DEBUG : pcloud root 'rclone-test-mabaweh5dawe/dst': Waiting for transfers to finish 2025/04/13 06:55:50 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/13 06:55:50 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/13 06:55:50 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/13 06:55:50 INFO : one: Copied (new) 2025/04/13 06:55:50 DEBUG : two.b824e1ab.partial: renamed to: two 2025/04/13 06:55:50 INFO : two: Copied (new) 2025/04/13 06:55:50 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:2398 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: listing wrong, want backup/one.bak (3), backup/three.txt.bak (5), dst/one (4), dst/two (3) got dst/one (4), dst/three.txt (5), dst/two (3) 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:2398 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "dst/three.txt" fstest.go:197: Not found "backup/one.bak" fstest.go:197: Not found "backup/three.txt.bak" 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:2398 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Not equal: expected: 0 actual : 2 Test: TestSyncBackupDirWithSuffix Messages: 2 objects not found run.go:285: Failed to put "dst/three.txt" to "pcloud root 'rclone-test-mabaweh5dawe'": pcloud error: Directory does not exist. (2005) --- FAIL: TestSyncBackupDirWithSuffix (16.32s) FAIL 2025/04/13 06:56:04 DEBUG : pcloud root 'rclone-test-mabaweh5dawe': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list -test.run '^(TestCopyAfterDelete|TestCopyRedownload|TestServerSideMove|TestServerSideMoveOverSelf|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncBasedOnCheckSum|TestSyncCompareDest|TestSyncMultipleCompareDest|TestSyncOverlapWithFilter|TestSyncWithExclude|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithUpdateOlder)$'" - Finished ERROR in 3m14.074462338s (try 3/5): exit status 1: Failed [TestSyncWithExclude TestSyncWithExcludeAndDeleteExcluded TestSyncCompareDest TestSyncMultipleCompareDest TestSyncBackupDirWithSuffix]