"./operations.test -test.v -test.timeout 2h0m0s -remote TestDrime: -list-retries 5 -verbose -test.run '^TestCopyFileCopyDest$'" - Starting (try 3/5)
2026/06/27 03:27:06 DEBUG : Creating backend with remote "TestDrime:rclone-test-tecuzix7sido"
2026/06/27 03:27:06 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/06/27 03:27:14 DEBUG : Creating backend with remote "/tmp/rclone3481439568"
=== RUN   TestCopyFileCopyDest
    run.go:198: Remote "drime root 'rclone-test-tecuzix7sido'", Local "Local file system at /tmp/rclone3481439568", Modify Window "876000h0m0s"
2026/06/27 03:27:14 DEBUG : Creating backend with remote "TestDrime:rclone-test-tecuzix7sido/dst"
2026/06/27 03:27:22 DEBUG : Creating backend with remote "TestDrime:rclone-test-tecuzix7sido/CopyDest"
2026/06/27 03:27:25 DEBUG : one: Need to transfer - File not found at Destination
2026/06/27 03:27:39 DEBUG : one: size = 3 OK
2026/06/27 03:27:39 INFO  : one: Copied (new)
2026/06/27 03:27:53 DEBUG : one: size = 5 (Local file system at /tmp/rclone3481439568)
2026/06/27 03:27:53 DEBUG : one: size = 3 (drime root 'rclone-test-tecuzix7sido/dst')
2026/06/27 03:27:53 DEBUG : one: Sizes differ
2026/06/27 03:28:02 DEBUG : one: Removing old object on successful upload
2026/06/27 03:28:04 DEBUG : one: Old object already deleted, safely ignoring
2026/06/27 03:28:04 DEBUG : one: size = 5 OK
2026/06/27 03:28:04 INFO  : one: Copied (replaced existing)
2026/06/27 03:28:11 DEBUG : dst/one: Removing old object on successful upload
2026/06/27 03:28:13 DEBUG : dst/one: Old object already deleted, safely ignoring
2026/06/27 03:28:28 DEBUG : Creating backend with remote "TestDrime:rclone-test-tecuzix7sido/BackupDir"
2026/06/27 03:28:28 DEBUG : Config file has changed externally - reloading
2026/06/27 03:28:38 DEBUG : one: size = 5 (Local file system at /tmp/rclone3481439568)
2026/06/27 03:28:38 DEBUG : one: size = 3 (drime root 'rclone-test-tecuzix7sido/dst')
2026/06/27 03:28:38 DEBUG : one: Sizes differ
2026/06/27 03:28:45 DEBUG : one: size = 5 OK
2026/06/27 03:28:45 DEBUG : one: Sizes identical
2026/06/27 03:28:45 DEBUG : one: size = 5 (Local file system at /tmp/rclone3481439568)
2026/06/27 03:28:45 DEBUG : one: size = 3 (drime root 'rclone-test-tecuzix7sido/dst')
2026/06/27 03:28:45 DEBUG : one: Sizes differ
2026/06/27 03:29:21 INFO  : one: Moved (server-side)
2026/06/27 03:29:24 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:29:24 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/06/27 03:29:26 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:29:26 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/06/27 03:29:29 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:29:29 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/06/27 03:29:30 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:29:30 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/06/27 03:29:34 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:29:34 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/06/27 03:29:37 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:29:37 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/06/27 03:29:40 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:29:40 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/06/27 03:29:42 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:29:42 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/06/27 03:29:44 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:29:44 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/06/27 03:29:47 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:29:47 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
2026/06/27 03:29:47 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 0/10
2026/06/27 03:29:51 DEBUG : pacer: Reducing sleep to 5.12s
2026/06/27 03:30:03 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:30:03 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
2026/06/27 03:30:09 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:30:09 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:30:23 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:30:37 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:30:57 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:31:18 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:31:46 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:31:57 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:32:17 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:32:37 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:32:37 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 1/10
2026/06/27 03:32:57 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:33:17 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:33:17 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:33:27 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:33:48 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:34:07 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:34:32 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:34:49 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:35:07 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:35:27 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:35:49 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:36:08 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:36:08 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 2/10
2026/06/27 03:36:28 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:36:47 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:36:47 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:36:57 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:37:17 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:37:37 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:37:57 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:38:17 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:38:37 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:38:57 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:39:25 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:39:42 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:39:42 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 3/10
2026/06/27 03:39:57 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:40:19 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:40:19 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:40:28 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:40:56 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:41:08 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:41:27 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:41:47 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:42:07 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:42:27 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:43:15 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:43:18 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:43:18 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 4/10
2026/06/27 03:43:38 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:43:59 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:43:59 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:44:09 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:44:29 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:44:48 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:45:11 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:45:28 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:45:49 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:46:08 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:46:29 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:46:47 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:46:47 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 5/10
2026/06/27 03:47:08 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:47:27 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:47:27 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:47:37 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:47:57 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:48:17 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:48:38 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:48:57 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:49:17 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:49:37 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:49:57 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:50:19 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:50:19 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 6/10
2026/06/27 03:50:37 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:50:58 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:50:58 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:51:08 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:51:27 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:51:48 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:52:08 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:52:32 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:52:48 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:53:08 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:53:27 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:53:48 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:53:48 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 7/10
2026/06/27 03:54:16 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:54:28 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:54:28 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:54:38 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:55:08 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:55:17 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:55:37 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:55:57 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:56:17 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 03:56:38 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 03:56:58 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 03:57:17 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 03:57:17 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 8/10
2026/06/27 03:57:38 DEBUG : pacer: Reducing sleep to 10s
2026/06/27 03:57:58 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/06/27 03:57:58 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/06/27 03:58:08 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/06/27 03:58:28 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/06/27 03:58:48 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/06/27 03:59:08 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/06/27 03:59:29 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/06/27 03:59:48 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/06/27 04:00:08 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/06/27 04:00:28 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/06/27 04:00:49 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/06/27 04:00:49 DEBUG : one: Received error: failed to copy item: Error "Server Error" - low level retry 9/10
2026/06/27 04:00:49 ERROR : one: Failed to copy: failed to copy item: Error "Server Error"
2026/06/27 04:00:49 ERROR : one: Destination found in --copy-dest, error copying
2026/06/27 04:00:53 INFO  : one: Deleted
2026/06/27 04:00:56 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 (2052.12s)
FAIL
2026/06/27 04:01:26 DEBUG : drime root 'rclone-test-tecuzix7sido': Purge remote
"./operations.test -test.v -test.timeout 2h0m0s -remote TestDrime: -list-retries 5 -verbose -test.run '^TestCopyFileCopyDest$'" - Finished ERROR in 34m22.267080449s (try 3/5): exit status 1: Failed [TestCopyFileCopyDest]