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