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