"./operations.test -test.v -test.timeout 2h0m0s -remote TestDrime: -list-retries 5 -verbose -test.run '^TestCopyFileCopyDest$'" - Starting (try 3/5)
2026/08/26 06:13:23 DEBUG : Creating backend with remote "TestDrime:rclone-test-zeqower4tece"
2026/08/26 06:13:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/26 06:13:27 DEBUG : Creating backend with remote "/tmp/rclone3867389546"
=== RUN   TestCopyFileCopyDest
    run.go:198: Remote "drime root 'rclone-test-zeqower4tece'", Local "Local file system at /tmp/rclone3867389546", Modify Window "876000h0m0s"
2026/08/26 06:13:27 DEBUG : Creating backend with remote "TestDrime:rclone-test-zeqower4tece/dst"
2026/08/26 06:13:32 DEBUG : Creating backend with remote "TestDrime:rclone-test-zeqower4tece/CopyDest"
2026/08/26 06:13:34 DEBUG : one: Need to transfer - File not found at Destination
2026/08/26 06:13:42 DEBUG : one: size = 3 OK
2026/08/26 06:13:42 INFO  : one: Copied (new)
2026/08/26 06:13:46 DEBUG : one: size = 5 (Local file system at /tmp/rclone3867389546)
2026/08/26 06:13:46 DEBUG : one: size = 3 (drime root 'rclone-test-zeqower4tece/dst')
2026/08/26 06:13:46 DEBUG : one: Sizes differ
2026/08/26 06:13:49 DEBUG : one: Removing old object on successful upload
2026/08/26 06:13:50 DEBUG : one: Old object already deleted, safely ignoring
2026/08/26 06:13:50 DEBUG : one: size = 5 OK
2026/08/26 06:13:50 INFO  : one: Copied (replaced existing)
2026/08/26 06:13:57 DEBUG : dst/one: Removing old object on successful upload
2026/08/26 06:13:58 DEBUG : dst/one: Old object already deleted, safely ignoring
2026/08/26 06:14:05 DEBUG : Creating backend with remote "TestDrime:rclone-test-zeqower4tece/BackupDir"
2026/08/26 06:14:08 DEBUG : one: size = 5 (Local file system at /tmp/rclone3867389546)
2026/08/26 06:14:08 DEBUG : one: size = 3 (drime root 'rclone-test-zeqower4tece/dst')
2026/08/26 06:14:08 DEBUG : one: Sizes differ
2026/08/26 06:14:10 DEBUG : one: size = 5 OK
2026/08/26 06:14:10 DEBUG : one: Sizes identical
2026/08/26 06:14:10 DEBUG : one: size = 5 (Local file system at /tmp/rclone3867389546)
2026/08/26 06:14:10 DEBUG : one: size = 3 (drime root 'rclone-test-zeqower4tece/dst')
2026/08/26 06:14:10 DEBUG : one: Sizes differ
2026/08/26 06:14:19 INFO  : one: Moved (server-side)
2026/08/26 06:14:22 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:14:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/08/26 06:14:24 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:14:24 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/08/26 06:14:26 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:14:26 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/08/26 06:14:28 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:14:28 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/08/26 06:14:30 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:14:30 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/08/26 06:14:32 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:14:32 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/08/26 06:14:34 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:14:34 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/08/26 06:14:36 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:14:36 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/08/26 06:14:38 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:14:38 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/08/26 06:14:41 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:14:41 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
2026/08/26 06:14:41 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 0/10
2026/08/26 06:14:46 DEBUG : pacer: Reducing sleep to 5.12s
2026/08/26 06:14:56 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:14:56 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
2026/08/26 06:15:01 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:15:01 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:15:11 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:15:31 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:15:51 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:16:11 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:16:31 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:16:52 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:17:10 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:17:30 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:17:30 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 1/10
2026/08/26 06:17:50 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:18:10 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:18:10 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:18:22 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:18:41 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:19:01 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:19:21 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:19:41 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:20:01 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:20:21 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:20:40 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:21:02 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:21:02 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 2/10
2026/08/26 06:21:20 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:21:40 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:21:40 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:21:51 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:22:10 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:22:30 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:22:51 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:23:12 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:23:30 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:23:52 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:24:11 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:24:30 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:24:30 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 3/10
2026/08/26 06:24:51 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:25:12 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:25:12 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:25:21 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:25:42 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:26:01 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:26:20 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:26:41 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:27:02 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:27:21 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:27:42 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:28:01 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:28:01 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 4/10
2026/08/26 06:28:21 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:28:41 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:28:41 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:28:51 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:29:11 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:29:31 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:29:50 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:30:12 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:30:31 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:30:50 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:31:11 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:31:31 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:31:31 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 5/10
2026/08/26 06:31:50 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:32:12 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:32:12 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:32:22 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:32:43 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:33:02 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:33:22 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:33:41 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:34:05 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:34:21 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:34:42 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:35:01 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:35:01 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 6/10
2026/08/26 06:35:22 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:35:42 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:35:42 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:35:52 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:36:13 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:36:31 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:36:50 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:37:13 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:37:32 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:37:55 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:38:12 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:38:31 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:38:31 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 7/10
2026/08/26 06:38:51 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:39:12 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:39:12 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:39:21 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:39:40 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:40:02 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:40:21 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:40:41 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:41:01 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:41:22 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:41:42 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:42:01 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:42:01 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 8/10
2026/08/26 06:42:21 DEBUG : pacer: Reducing sleep to 10s
2026/08/26 06:42:41 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/08/26 06:42:41 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/08/26 06:42:51 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/08/26 06:43:10 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/08/26 06:43:33 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/08/26 06:43:50 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/08/26 06:44:11 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/08/26 06:44:32 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/08/26 06:44:51 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/08/26 06:45:10 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/08/26 06:45:32 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/08/26 06:45:32 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 9/10
2026/08/26 06:45:32 ERROR : one: Failed to copy: failed to copy item: Error "Server Error"
2026/08/26 06:45:32 ERROR : one: Destination found in --copy-dest, error copying
2026/08/26 06:45:35 INFO  : one: Deleted
2026/08/26 06:45:35 ERROR : one: Couldn't move: failed to move item: Error "No valid entries to move"
    copy_test.go:321: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:321
        	Error:      	Received unexpected error:
        	            	moving to --backup-dir failed: failed to move item: Error "No valid entries to move"
        	Test:       	TestCopyFileCopyDest
--- FAIL: TestCopyFileCopyDest (1947.01s)
FAIL
2026/08/26 06:45:54 DEBUG : drime root 'rclone-test-zeqower4tece': Purge remote
"./operations.test -test.v -test.timeout 2h0m0s -remote TestDrime: -list-retries 5 -verbose -test.run '^TestCopyFileCopyDest$'" - Finished ERROR in 32m32.59328903s (try 3/5): exit status 1: Failed [TestCopyFileCopyDest]