"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncAfterChangingContentsOnly|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncCompareDest|TestSyncCopyDest|TestSyncMultipleCompareDest)$'" - Starting (try 2/5) 2025/04/25 04:34:27 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure" 2025/04/25 04:34:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/25 04:34:28 DEBUG : Creating backend with remote "/tmp/rclone1666452506" === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:34:29 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2025/04/25 04:34:29 DEBUG : pcloud root 'rclone-test-bizomev7bure': Waiting for checks to finish 2025/04/25 04:34:29 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone1666452506) 2025/04/25 04:34:29 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (pcloud root 'rclone-test-bizomev7bure') 2025/04/25 04:34:29 DEBUG : potato: sha1 differ 2025/04/25 04:34:29 DEBUG : pcloud root 'rclone-test-bizomev7bure': Waiting for transfers to finish 2025/04/25 04:34:29 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2025/04/25 04:34:29 DEBUG : potato.706b9954.partial: renamed to: potato 2025/04/25 04:34:29 INFO : potato: Copied (replaced existing) 2025/04/25 04:34:29 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" --- PASS: TestSyncAfterChangingContentsOnly (1.97s) === RUN TestServerSideMove run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:34:30 DEBUG : Creating backend with remote "TestPcloud:rclone-test-burazed0sabe" sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-bizomev7bure' -> pcloud root 'rclone-test-burazed0sabe' 2025/04/25 04:34:33 DEBUG : pcloud root 'rclone-test-burazed0sabe': Using server-side directory move 2025/04/25 04:34:33 INFO : pcloud root 'rclone-test-burazed0sabe': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/25 04:34:33 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/25 04:34:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/25 04:34:33 DEBUG : empty space: Unchanged skipping 2025/04/25 04:34:33 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/25 04:34:33 DEBUG : pcloud root 'rclone-test-burazed0sabe': Waiting for checks to finish 2025/04/25 04:34:33 INFO : potato2: Moved (server-side) 2025/04/25 04:34:33 INFO : empty space: Deleted 2025/04/25 04:34:33 DEBUG : pcloud root 'rclone-test-burazed0sabe': Waiting for transfers to finish 2025/04/25 04:34:33 INFO : potato3: Deleted 2025/04/25 04:34:33 INFO : potato3: Moved (server-side) 2025/04/25 04:34:34 DEBUG : Creating backend with remote "TestPcloud:rclone-test-dasivot8ruzi" 2025/04/25 04:34:34 DEBUG : pcloud root 'rclone-test-dasivot8ruzi': Using server-side directory move 2025/04/25 04:34:35 INFO : pcloud root 'rclone-test-dasivot8ruzi': Server side directory move succeeded 2025/04/25 04:34:36 DEBUG : pcloud root 'rclone-test-dasivot8ruzi': Purge remote 2025/04/25 04:34:36 DEBUG : pcloud root 'rclone-test-burazed0sabe': Purge remote 2025/04/25 04:34:36 NOTICE: purge failed: directory not found --- PASS: TestServerSideMove (6.19s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:34:36 DEBUG : Creating backend with remote "TestPcloud:rclone-test-noreyof3latu" sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-bizomev7bure' -> pcloud root 'rclone-test-noreyof3latu' 2025/04/25 04:34:38 DEBUG : empty space: Excluded (Size Filter) 2025/04/25 04:34:38 DEBUG : empty space: Excluded (Size Filter) 2025/04/25 04:34:38 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/25 04:34:38 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/25 04:34:38 DEBUG : pcloud root 'rclone-test-noreyof3latu': Waiting for checks to finish 2025/04/25 04:34:38 DEBUG : pcloud root 'rclone-test-noreyof3latu': Waiting for transfers to finish 2025/04/25 04:34:39 INFO : potato2: Moved (server-side) 2025/04/25 04:34:39 INFO : potato3: Deleted 2025/04/25 04:34:39 INFO : potato3: Moved (server-side) 2025/04/25 04:34:39 DEBUG : Creating backend with remote "TestPcloud:rclone-test-daramuj0puyu" 2025/04/25 04:34:40 DEBUG : empty space: Excluded (Size Filter) 2025/04/25 04:34:40 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/25 04:34:40 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/25 04:34:40 DEBUG : pcloud root 'rclone-test-daramuj0puyu': Waiting for checks to finish 2025/04/25 04:34:40 DEBUG : pcloud root 'rclone-test-daramuj0puyu': Waiting for transfers to finish 2025/04/25 04:34:41 INFO : potato2: Moved (server-side) 2025/04/25 04:34:41 INFO : potato3: Moved (server-side) 2025/04/25 04:34:41 DEBUG : pcloud root 'rclone-test-daramuj0puyu': Purge remote 2025/04/25 04:34:41 DEBUG : pcloud root 'rclone-test-noreyof3latu': Purge remote --- PASS: TestServerSideMoveWithFilter (5.36s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:34:41 DEBUG : Creating backend with remote "TestPcloud:rclone-test-ronizen9hilu" 2025/04/25 04:34:42 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-bizomev7bure' -> pcloud root 'rclone-test-ronizen9hilu' 2025/04/25 04:34:44 DEBUG : pcloud root 'rclone-test-ronizen9hilu': Using server-side directory move 2025/04/25 04:34:44 INFO : pcloud root 'rclone-test-ronizen9hilu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/25 04:34:44 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/25 04:34:44 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/25 04:34:44 DEBUG : empty space: Unchanged skipping 2025/04/25 04:34:44 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/25 04:34:44 DEBUG : pcloud root 'rclone-test-ronizen9hilu': Waiting for checks to finish 2025/04/25 04:34:44 INFO : empty space: Deleted 2025/04/25 04:34:44 DEBUG : pcloud root 'rclone-test-ronizen9hilu': Waiting for transfers to finish 2025/04/25 04:34:44 INFO : potato2: Moved (server-side) 2025/04/25 04:34:44 INFO : potato3: Deleted 2025/04/25 04:34:44 INFO : potato3: Moved (server-side) 2025/04/25 04:34:44 INFO : tomatoDir: Removing directory 2025/04/25 04:34:44 DEBUG : pcloud root 'rclone-test-bizomev7bure': deleted 1 directories 2025/04/25 04:34:45 DEBUG : Creating backend with remote "TestPcloud:rclone-test-facipit0suye" 2025/04/25 04:34:45 INFO : tomatoDir: Making directory 2025/04/25 04:34:45 DEBUG : pcloud root 'rclone-test-facipit0suye': Using server-side directory move 2025/04/25 04:34:46 INFO : pcloud root 'rclone-test-facipit0suye': Server side directory move succeeded 2025/04/25 04:34:47 DEBUG : pcloud root 'rclone-test-facipit0suye': Purge remote 2025/04/25 04:34:47 DEBUG : pcloud root 'rclone-test-ronizen9hilu': Purge remote 2025/04/25 04:34:48 NOTICE: purge failed: directory not found --- PASS: TestServerSideMoveDeleteEmptySourceDirs (6.21s) === RUN TestSyncCompareDest run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:34:48 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/dst" 2025/04/25 04:34:48 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/CompareDest" 2025/04/25 04:34:49 DEBUG : one: Need to transfer - File not found at Destination 2025/04/25 04:34:49 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:34:49 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:34:50 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/04/25 04:34:50 DEBUG : one.b824e1ab.partial: renamed to: one 2025/04/25 04:34:50 INFO : one: Copied (new) 2025/04/25 04:34: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:2094 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:2094 Error: Not equal: expected: 0 actual : 1 Test: TestSyncCompareDest Messages: 1 objects not found 2025/04/25 04:34:58 DEBUG : one: Need to transfer - File not found at Destination 2025/04/25 04:34:58 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:34:58 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:34:58 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/25 04:34:58 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/25 04:34:58 INFO : one: Copied (new) 2025/04/25 04:34:58 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: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: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/25 04:35:15 DEBUG : one: Need to transfer - File not found at Destination 2025/04/25 04:35:15 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:35:15 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:35:15 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/25 04:35:15 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/25 04:35:15 INFO : one: Copied (new) 2025/04/25 04:35:15 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 empty space (1), potato2 (60), potato3 (68) 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:2121 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "empty space" 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:2121 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "potato2" 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:2121 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "potato3" fstest.go:197: Not found "CompareDest/one" 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:2121 Error: Not equal: expected: 0 actual : 2 Test: TestSyncCompareDest Messages: 2 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: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-bizomev7bure'/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-bizomev7bure'/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/25 04:35:32 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:35:32 DEBUG : one: Unchanged skipping 2025/04/25 04:35:33 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:35:33 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/25 04:35:33 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:35:33 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:35:33 DEBUG : Waiting for deletions to finish 2025/04/25 04:35:33 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-bizomev7bure'/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-bizomev7bure'/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/25 04:35:41 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:35:41 DEBUG : one: Unchanged skipping 2025/04/25 04:35:42 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:35:42 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/25 04:35:42 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:35:42 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:35:42 DEBUG : Waiting for deletions to finish 2025/04/25 04:35:42 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-bizomev7bure'/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-bizomev7bure'/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/25 04:35:51 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:35:51 DEBUG : one: Unchanged skipping 2025/04/25 04:35:51 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/25 04:35:51 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/25 04:35:51 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/25 04:35:51 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:35:51 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:35:51 DEBUG : Waiting for deletions to finish 2025/04/25 04:35:51 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-bizomev7bure'/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-bizomev7bure'/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 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:2180 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-bizomev7bure'/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:2180 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-bizomev7bure'/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:2180 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:2180 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/25 04:36:08 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:08 DEBUG : one: Unchanged skipping 2025/04/25 04:36:08 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/04/25 04:36:08 DEBUG : two: Need to transfer - File not found at Destination 2025/04/25 04:36:08 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:08 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:09 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2025/04/25 04:36:09 DEBUG : two.1503b713.partial: renamed to: two 2025/04/25 04:36:09 INFO : two: Copied (new) 2025/04/25 04:36:09 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 CompareDest/one (5), CompareDest/two (3), dst/one (5), dst/two (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:2192 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-bizomev7bure'/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:2192 Error: Should be true Test: TestSyncCompareDest Messages: pcloud root 'rclone-test-bizomev7bure'/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:2192 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:2192 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) --- FAIL: TestSyncCompareDest (91.28s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", 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 CompareDest/one (5), CompareDest/two (3), dst/one (5) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2212 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:2212 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:2212 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "dst/one" 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/25 04:36:28 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/dest" 2025/04/25 04:36:29 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/pre-dest1" 2025/04/25 04:36:29 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/pre-dest2" 2025/04/25 04:36:30 DEBUG : 1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/25 04:36:30 DEBUG : 1: Destination found in --compare-dest, skipping 2025/04/25 04:36:30 DEBUG : 2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/25 04:36:30 DEBUG : 2: Destination found in --compare-dest, skipping 2025/04/25 04:36:30 DEBUG : 3: Need to transfer - File not found at Destination 2025/04/25 04:36:30 DEBUG : pcloud root 'rclone-test-bizomev7bure/dest': Waiting for checks to finish 2025/04/25 04:36:30 DEBUG : pcloud root 'rclone-test-bizomev7bure/dest': Waiting for transfers to finish 2025/04/25 04:36:30 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2025/04/25 04:36:30 DEBUG : 3.b37ac6a8.partial: renamed to: 3 2025/04/25 04:36:30 INFO : 3: Copied (new) 2025/04/25 04:36:30 DEBUG : Waiting for deletions to finish --- FAIL: TestSyncMultipleCompareDest (13.14s) === RUN TestSyncCopyDest run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:36:32 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/dst" 2025/04/25 04:36:33 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/CopyDest" 2025/04/25 04:36:34 DEBUG : one: Need to transfer - File not found at Destination 2025/04/25 04:36:34 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:34 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:34 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/04/25 04:36:35 DEBUG : one.b824e1ab.partial: renamed to: one 2025/04/25 04:36:35 INFO : one: Copied (new) 2025/04/25 04:36:35 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:35 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/25 04:36:35 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:35 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:35 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/25 04:36:35 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/25 04:36:35 INFO : one: Copied (replaced existing) 2025/04/25 04:36:35 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:36 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/BackupDir" 2025/04/25 04:36:37 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:37 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/25 04:36:37 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:37 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/25 04:36:37 INFO : one: Moved (server-side) 2025/04/25 04:36:38 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/25 04:36:38 DEBUG : one.d88fe5df.partial: renamed to: one 2025/04/25 04:36:38 INFO : one: Copied (server-side copy) 2025/04/25 04:36:38 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/04/25 04:36:38 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:38 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:39 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:39 DEBUG : one: Unchanged skipping 2025/04/25 04:36:39 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:39 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/25 04:36:39 DEBUG : two.19d5dbaa.partial: renamed to: two 2025/04/25 04:36:39 INFO : two: Copied (server-side copy) 2025/04/25 04:36:39 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/04/25 04:36:39 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:39 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:39 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:40 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:40 DEBUG : one: Unchanged skipping 2025/04/25 04:36:40 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:40 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:40 DEBUG : two: Unchanged skipping 2025/04/25 04:36:40 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:40 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:40 INFO : There was nothing to transfer 2025/04/25 04:36:41 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:41 DEBUG : one: Unchanged skipping 2025/04/25 04:36:41 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/04/25 04:36:41 DEBUG : three: Destination not found in --copy-dest 2025/04/25 04:36:41 DEBUG : three: Need to transfer - File not found at Destination 2025/04/25 04:36:41 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/25 04:36:41 DEBUG : two: Unchanged skipping 2025/04/25 04:36:41 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:41 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:41 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2025/04/25 04:36:41 DEBUG : three.8cc66b1.partial: renamed to: three 2025/04/25 04:36:41 INFO : three: Copied (new) 2025/04/25 04:36:41 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (10.86s) === RUN TestSyncBackupDir run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:36:44 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/dst" 2025/04/25 04:36:44 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/backup" 2025/04/25 04:36:45 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/25 04:36:45 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/25 04:36:45 DEBUG : two: Unchanged skipping 2025/04/25 04:36:45 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:46 INFO : one: Moved (server-side) 2025/04/25 04:36:46 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:46 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/25 04:36:46 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/25 04:36:46 INFO : one: Copied (new) 2025/04/25 04:36:46 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:46 INFO : three.txt: Moved (server-side) 2025/04/25 04:36:46 INFO : three.txt: Moved into backup dir 2025/04/25 04:36:47 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/25 04:36:47 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:47 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/25 04:36:47 DEBUG : two: Unchanged skipping 2025/04/25 04:36:47 INFO : one: Deleted 2025/04/25 04:36:47 INFO : one: Moved (server-side) 2025/04/25 04:36:47 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:47 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/25 04:36:47 DEBUG : one.1503b713.partial: renamed to: one 2025/04/25 04:36:47 INFO : one: Copied (new) 2025/04/25 04:36:47 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:48 INFO : three.txt: Deleted 2025/04/25 04:36:48 INFO : three.txt: Moved (server-side) 2025/04/25 04:36:48 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (5.84s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "pcloud root 'rclone-test-bizomev7bure'", Local "Local file system at /tmp/rclone1666452506", Modify Window "1s" 2025/04/25 04:36:50 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/dst" 2025/04/25 04:36:50 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bizomev7bure/backup" 2025/04/25 04:36:51 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/25 04:36:51 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/25 04:36:51 DEBUG : two: Unchanged skipping 2025/04/25 04:36:51 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:51 INFO : one: Moved (server-side) to: one.bak 2025/04/25 04:36:51 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:52 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/25 04:36:52 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/25 04:36:52 INFO : one: Copied (new) 2025/04/25 04:36:52 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:52 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/25 04:36:52 INFO : three.txt: Moved into backup dir 2025/04/25 04:36:53 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for checks to finish 2025/04/25 04:36:53 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/25 04:36:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/25 04:36:53 DEBUG : two: Unchanged skipping 2025/04/25 04:36:53 INFO : one.bak: Deleted 2025/04/25 04:36:53 INFO : one: Moved (server-side) to: one.bak 2025/04/25 04:36:53 DEBUG : pcloud root 'rclone-test-bizomev7bure/dst': Waiting for transfers to finish 2025/04/25 04:36:53 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/25 04:36:53 DEBUG : one.1503b713.partial: renamed to: one 2025/04/25 04:36:53 INFO : one: Copied (new) 2025/04/25 04:36:53 DEBUG : Waiting for deletions to finish 2025/04/25 04:36:54 INFO : three.txt.bak: Deleted 2025/04/25 04:36:54 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/25 04:36:54 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (5.93s) FAIL 2025/04/25 04:36:55 DEBUG : pcloud root 'rclone-test-bizomev7bure': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncAfterChangingContentsOnly|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncCompareDest|TestSyncCopyDest|TestSyncMultipleCompareDest)$'" - Finished ERROR in 2m27.960842494s (try 2/5): exit status 1: Failed [TestSyncCompareDest TestSyncMultipleCompareDest]