"./sync.test -test.v -test.timeout 2h0m0s -remote TestDrime: -list-retries 5 -verbose -test.run '^TestServerSideCopyOverSelf$'" - Starting (try 2/5)
2026/09/23 01:56:42 DEBUG : Creating backend with remote "TestDrime:rclone-test-yasifob1dunu"
2026/09/23 01:56:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/09/23 01:56:43 DEBUG : Creating backend with remote "/tmp/rclone1309607225"
=== RUN   TestServerSideCopyOverSelf
    run.go:198: Remote "drime root 'rclone-test-yasifob1dunu'", Local "Local file system at /tmp/rclone1309607225", Modify Window "876000h0m0s"
2026/09/23 01:56:44 DEBUG : Creating backend with remote "TestDrime:rclone-test-zucewup6jope"
    sync_test.go:656: Server side copy (if possible) drime root 'rclone-test-yasifob1dunu' -> drime root 'rclone-test-zucewup6jope'
2026/09/23 01:56:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/09/23 01:56:44 DEBUG : drime root 'rclone-test-zucewup6jope': Waiting for checks to finish
2026/09/23 01:56:44 DEBUG : drime root 'rclone-test-zucewup6jope': Waiting for transfers to finish
2026/09/23 01:56:45 DEBUG : sub dir/hello world: size = 11 OK
2026/09/23 01:56:45 INFO  : sub dir/hello world: Copied (server-side copy)
2026/09/23 01:56:46 DEBUG : sub dir/hello world: Removing old object on successful upload
2026/09/23 01:56:46 DEBUG : sub dir/hello world: Old object already deleted, safely ignoring
2026/09/23 01:56:47 DEBUG : drime root 'rclone-test-zucewup6jope': Waiting for checks to finish
2026/09/23 01:56:47 DEBUG : sub dir/hello world: size = 17 (drime root 'rclone-test-yasifob1dunu')
2026/09/23 01:56:47 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-zucewup6jope')
2026/09/23 01:56:47 DEBUG : sub dir/hello world: Sizes differ
2026/09/23 01:56:47 DEBUG : drime root 'rclone-test-zucewup6jope': Waiting for transfers to finish
2026/09/23 01:56:47 DEBUG : sub dir/hello world: Server side copy: removing existing object after successful copy
2026/09/23 01:56:47 DEBUG : sub dir/hello world: size = 17 OK
2026/09/23 01:56:47 INFO  : sub dir/hello world: Copied (server-side copy)
    fstest.go:299: Sleeping for 1s for list eventual consistency: 1/5
    fstest.go:302: Flushing the directory cache
    fstest.go:299: Sleeping for 2s for list eventual consistency: 2/5
    fstest.go:302: Flushing the directory cache
    fstest.go:299: Sleeping for 4s for list eventual consistency: 3/5
    fstest.go:302: Flushing the directory cache
    fstest.go:299: Sleeping for 8s for list eventual consistency: 4/5
    fstest.go:302: Flushing the directory cache
    fstest.go:299: Sleeping for 16s for list eventual consistency: 5/5
    fstest.go:302: Flushing the directory cache
    fstest.go:306: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:357
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:671
        	Error:      	Should be true
        	Test:       	TestServerSideCopyOverSelf
        	Messages:   	listing wrong, want
        	            	  sub dir/hello world (17) got
        	            	  sub dir/hello world (1) (17)
    fstest.go:192: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:357
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:671
        	Error:      	Should be true
        	Test:       	TestServerSideCopyOverSelf
        	Messages:   	Unexpected file "sub dir/hello world (1)"
    fstest.go:204: Not found "sub dir/hello world"
    fstest.go:207: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:207
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:311
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:357
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:671
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestServerSideCopyOverSelf
        	Messages:   	1 objects not found
2026/09/23 01:57:20 DEBUG : drime root 'rclone-test-zucewup6jope': Purge remote
    run.go:186: removing dir "sub dir" failed - try 1/5: sleeping 1s: directory not empty
--- FAIL: TestServerSideCopyOverSelf (40.18s)
FAIL
2026/09/23 01:57:23 DEBUG : drime root 'rclone-test-yasifob1dunu': Purge remote
"./sync.test -test.v -test.timeout 2h0m0s -remote TestDrime: -list-retries 5 -verbose -test.run '^TestServerSideCopyOverSelf$'" - Finished ERROR in 40.751270154s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf]