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