"./sync.test -test.v -test.timeout 1h0m0s -remote TestSugarSync:Test -verbose -test.run '^(TestMoveOverSelf|TestServerSideCopyOverSelf)$'" - Starting (try 2/5) 2024/11/05 02:30:56 DEBUG : Creating backend with remote "TestSugarSync:Test/rclone-test-puxaxep4giwi" 2024/11/05 02:30:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/05 02:31:00 DEBUG : Creating backend with remote "/tmp/rclone4243153362" === RUN TestServerSideCopyOverSelf run.go:180: Remote "sugarsync root 'Test/rclone-test-puxaxep4giwi'", Local "Local file system at /tmp/rclone4243153362", Modify Window "876000h0m0s" 2024/11/05 02:31:06 DEBUG : Creating backend with remote "TestSugarSync:Test/rclone-test-birarem1duko" sync_test.go:626: Server side copy (if possible) sugarsync root 'Test/rclone-test-puxaxep4giwi' -> sugarsync root 'Test/rclone-test-birarem1duko' 2024/11/05 02:31:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/05 02:31:10 DEBUG : sugarsync root 'Test/rclone-test-birarem1duko': Waiting for checks to finish 2024/11/05 02:31:10 DEBUG : sugarsync root 'Test/rclone-test-birarem1duko': Waiting for transfers to finish 2024/11/05 02:31:14 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "sugarsync root 'Test/rclone-test-puxaxep4giwi'", Local "Local file system at /tmp/rclone4243153362", Modify Window "876000h0m0s" 2024/11/05 02:31:20 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/05 02:31:20 DEBUG : sugarsync root 'Test/rclone-test-birarem1duko': Waiting for checks to finish 2024/11/05 02:31:20 DEBUG : sugarsync root 'Test/rclone-test-birarem1duko': Waiting for transfers to finish 2024/11/05 02:31:21 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "sugarsync root 'Test/rclone-test-puxaxep4giwi'", Local "Local file system at /tmp/rclone4243153362", Modify Window "876000h0m0s" 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:350 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:641 Error: Should be true Test: TestServerSideCopyOverSelf Messages: listing wrong, want sub dir/hello world (17) got sub dir/hello world (11), sub dir/hello world (17) 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:350 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:641 Error: Not equal: expected: 17 actual : 11 Test: TestServerSideCopyOverSelf Messages: sub dir/hello world: size incorrect file=17 vs obj=11 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:350 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:641 Error: Should be true Test: TestServerSideCopyOverSelf Messages: Unexpected file "sub dir/hello world" 2024/11/05 02:31:36 DEBUG : sugarsync root 'Test/rclone-test-birarem1duko': Purge remote --- FAIL: TestServerSideCopyOverSelf (45.26s) === RUN TestMoveOverSelf run.go:180: Remote "sugarsync root 'Test/rclone-test-puxaxep4giwi'", Local "Local file system at /tmp/rclone4243153362", Modify Window "876000h0m0s" 2024/11/05 02:31:51 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/05 02:31:51 DEBUG : sugarsync root 'Test/rclone-test-puxaxep4giwi': Waiting for checks to finish 2024/11/05 02:31:51 DEBUG : sugarsync root 'Test/rclone-test-puxaxep4giwi': Waiting for transfers to finish 2024/11/05 02:31:53 INFO : sub dir/hello world: Copied (replaced existing) 2024/11/05 02:31:53 INFO : sub dir/hello world: Deleted run.go:180: Remote "sugarsync root 'Test/rclone-test-puxaxep4giwi'", Local "Local file system at /tmp/rclone4243153362", Modify Window "876000h0m0s" --- PASS: TestMoveOverSelf (14.62s) FAIL 2024/11/05 02:32:00 DEBUG : sugarsync root 'Test/rclone-test-puxaxep4giwi': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestSugarSync:Test -verbose -test.run '^(TestMoveOverSelf|TestServerSideCopyOverSelf)$'" - Finished ERROR in 1m3.999011071s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf]