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