"./sync.test -test.v -test.timeout 1h0m0s -remote TestSugarSync:Test -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncDeleteDuring)$'" - Starting (try 2/5)
2024/11/07 03:00:33 DEBUG : Creating backend with remote "TestSugarSync:Test/rclone-test-nusaboq6vuko"
2024/11/07 03:00:33 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/07 03:00:36 DEBUG : Creating backend with remote "/tmp/rclone2512195867"
=== RUN   TestServerSideCopyOverSelf
    run.go:180: Remote "sugarsync root 'Test/rclone-test-nusaboq6vuko'", Local "Local file system at /tmp/rclone2512195867", Modify Window "876000h0m0s"
2024/11/07 03:00:42 DEBUG : Creating backend with remote "TestSugarSync:Test/rclone-test-rudoyoc6tifi"
    sync_test.go:626: Server side copy (if possible) sugarsync root 'Test/rclone-test-nusaboq6vuko' -> sugarsync root 'Test/rclone-test-rudoyoc6tifi'
2024/11/07 03:00:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/07 03:00:47 DEBUG : sugarsync root 'Test/rclone-test-rudoyoc6tifi': Waiting for checks to finish
2024/11/07 03:00:47 DEBUG : sugarsync root 'Test/rclone-test-rudoyoc6tifi': Waiting for transfers to finish
2024/11/07 03:00:50 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "sugarsync root 'Test/rclone-test-nusaboq6vuko'", Local "Local file system at /tmp/rclone2512195867", Modify Window "876000h0m0s"
2024/11/07 03:00:57 DEBUG : sugarsync root 'Test/rclone-test-rudoyoc6tifi': Waiting for checks to finish
2024/11/07 03:00:57 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2024/11/07 03:00:57 DEBUG : sugarsync root 'Test/rclone-test-rudoyoc6tifi': Waiting for transfers to finish
2024/11/07 03:00:58 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "sugarsync root 'Test/rclone-test-nusaboq6vuko'", Local "Local file system at /tmp/rclone2512195867", 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/07 03:01:12 DEBUG : sugarsync root 'Test/rclone-test-rudoyoc6tifi': Purge remote
--- FAIL: TestServerSideCopyOverSelf (45.29s)
=== RUN   TestSyncDeleteDuring
    run.go:180: Remote "sugarsync root 'Test/rclone-test-nusaboq6vuko'", Local "Local file system at /tmp/rclone2512195867", Modify Window "876000h0m0s"
2024/11/07 03:01:27 DEBUG : Waiting for deletions to finish
2024/11/07 03:01:27 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/07 03:01:27 DEBUG : sugarsync root 'Test/rclone-test-nusaboq6vuko': Waiting for checks to finish
2024/11/07 03:01:27 DEBUG : empty space: Sizes identical
2024/11/07 03:01:27 DEBUG : empty space: Unchanged skipping
2024/11/07 03:01:27 DEBUG : sugarsync root 'Test/rclone-test-nusaboq6vuko': Waiting for transfers to finish
2024/11/07 03:01:28 INFO  : potato: Deleted
2024/11/07 03:01:30 INFO  : potato2: Copied (new)
    run.go:180: Remote "sugarsync root 'Test/rclone-test-nusaboq6vuko'", Local "Local file system at /tmp/rclone2512195867", Modify Window "876000h0m0s"
--- PASS: TestSyncDeleteDuring (13.73s)
FAIL
2024/11/07 03:01:35 DEBUG : sugarsync root 'Test/rclone-test-nusaboq6vuko': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestSugarSync:Test -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncDeleteDuring)$'" - Finished ERROR in 1m3.116734507s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf]