"./sync.test -test.v -test.timeout 2h0m0s -remote TestDrime: -verbose -test.run '^(TestCopy|TestCopyAfterDelete|TestCopyDeleteBefore|TestCopyEmptyDirectories|TestCopyNoEmptyDirectories|TestCopyNoTraverse|TestCopyOverSelf|TestCopyWithFilesFromAndNoTraverse|TestMoveOverSelf|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteBefore|TestSyncDeleteDuring|TestSyncEmptyDirectories|TestSyncIgnoreErrors|TestSyncIgnoreExisting|TestSyncNoEmptyDirectories|TestSyncWithTrackRenamesStrategyLeaf)$'" - Starting (try 4/5)
2026/02/03 06:18:14 DEBUG : Creating backend with remote "TestDrime:rclone-test-xiwoluy9gibi"
2026/02/03 06:18:14 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/03 06:18:15 DEBUG : Creating backend with remote "/tmp/rclone2151365684"
=== RUN TestCopy
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:18:15 INFO : sub dir: Set directory modification time (using DirSetModTime)
2026/02/03 06:18:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:18:16 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:18:16 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:18:23 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:18:23 INFO : sub dir/hello world: Copied (new)
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
2026/02/03 06:18:35 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
--- PASS: TestCopy (23.54s)
=== RUN TestCopyNoTraverse
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:18:39 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:18:39 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:18:39 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:18:42 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:18:42 INFO : sub dir/hello world: Copied (new)
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:216
Error: Should be true
Test: TestCopyNoTraverse
Messages: listing wrong, want
sub dir/hello world (11) got
fstest.go:203: Not found "sub dir/hello world"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:216
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Not equal:
expected: 0
actual : 1
Test: TestCopyNoTraverse
Messages: 1 objects not found
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestCopyNoTraverse
Messages: listing wrong, want
got
sub dir/hello world (11)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestCopyNoTraverse
Messages: Unexpected file "sub dir/hello world"
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=7) "sub dir"
}
Test: TestCopyNoTraverse
Messages: directories
--- FAIL: TestCopyNoTraverse (25.37s)
=== RUN TestCopyWithFilesFromAndNoTraverse
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:19:05 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/03 06:19:05 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:19:05 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:19:08 DEBUG : potato2: size = 11 OK
2026/02/03 06:19:08 INFO : potato2: Copied (new)
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:332
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:335
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Should be true
Test: TestCopyWithFilesFromAndNoTraverse
Messages: listing wrong, want
potato2 (11) got
fstest.go:203: Not found "potato2"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:332
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:335
Error: Not equal:
expected: 0
actual : 1
Test: TestCopyWithFilesFromAndNoTraverse
Messages: 1 objects not found
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestCopyWithFilesFromAndNoTraverse
Messages: listing wrong, want
got
potato2 (11)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestCopyWithFilesFromAndNoTraverse
Messages: Unexpected file "potato2"
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=7) "sub dir"
}
Test: TestCopyWithFilesFromAndNoTraverse
Messages: directories
--- FAIL: TestCopyWithFilesFromAndNoTraverse (22.64s)
=== RUN TestCopyEmptyDirectories
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:19:27 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2026/02/03 06:19:27 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/02/03 06:19:27 INFO : sub dir2: Set directory modification time (using DirSetModTime)
2026/02/03 06:19:27 INFO : sub dir: Set directory modification time (using DirSetModTime)
2026/02/03 06:19:28 INFO : sub dir2: Making directory
2026/02/03 06:19:29 INFO : sub dir: Making directory
2026/02/03 06:19:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:19:29 INFO : sub dir2/sub sub dir2: Making directory
2026/02/03 06:19:30 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:19:30 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:19:34 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:19:34 INFO : sub dir/hello world: Copied (new)
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:358
Error: Should be true
Test: TestCopyEmptyDirectories
Messages: listing wrong, want
sub dir/hello world (11) got
fstest.go:203: Not found "sub dir/hello world"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:358
Error: Not equal:
expected: 0
actual : 1
Test: TestCopyEmptyDirectories
Messages: 1 objects not found
2026/02/03 06:19:43 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
run.go:130: removing dir "sub dir2" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir2" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir2" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir2" failed: directory not empty
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir", "sub dir2"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,4 @@
-([]string) {
+([]string) (len=2) {
+ (string) (len=7) "sub dir",
+ (string) (len=8) "sub dir2"
}
Test: TestCopyEmptyDirectories
Messages: directories
--- FAIL: TestCopyEmptyDirectories (34.09s)
=== RUN TestCopyNoEmptyDirectories
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:20:01 INFO : sub dir2: Making directory
2026/02/03 06:20:01 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2026/02/03 06:20:01 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/02/03 06:20:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:20:02 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:20:02 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:20:06 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:20:06 INFO : sub dir/hello world: Copied (new)
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:388
Error: Not equal:
expected: []string{"sub dir"}
actual : []string{"sub dir", "sub dir2"}
Diff:
--- Expected
+++ Actual
@@ -1,3 +1,4 @@
-([]string) (len=1) {
- (string) (len=7) "sub dir"
+([]string) (len=2) {
+ (string) (len=7) "sub dir",
+ (string) (len=8) "sub dir2"
}
Test: TestCopyNoEmptyDirectories
Messages: directories
--- FAIL: TestCopyNoEmptyDirectories (16.29s)
=== RUN TestSyncEmptyDirectories
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:20:17 DEBUG : sub dir2: Making directory with metadata
2026/02/03 06:20:17 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/02/03 06:20:17 INFO : sub dir: Set directory modification time (using DirSetModTime)
2026/02/03 06:20:18 INFO : sub dir2: Making directory
2026/02/03 06:20:18 INFO : sub dir: Making directory
2026/02/03 06:20:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:20:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:20:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:20:21 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:20:21 INFO : sub dir/hello world: Copied (new)
2026/02/03 06:20:21 DEBUG : Waiting for deletions to finish
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:516
Error: Should be true
Test: TestSyncEmptyDirectories
Messages: listing wrong, want
sub dir/hello world (11) got
fstest.go:203: Not found "sub dir/hello world"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:516
Error: Not equal:
expected: 0
actual : 1
Test: TestSyncEmptyDirectories
Messages: 1 objects not found
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:516
Error: Not equal:
expected: []string{"sub dir", "sub dir2"}
actual : []string{}
Diff:
--- Expected
+++ Actual
@@ -1,4 +1,2 @@
-([]string) (len=2) {
- (string) (len=7) "sub dir",
- (string) (len=8) "sub dir2"
+([]string) {
}
Test: TestSyncEmptyDirectories
Messages: directories
2026/02/03 06:20:29 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=7) "sub dir"
}
Test: TestSyncEmptyDirectories
Messages: directories
--- FAIL: TestSyncEmptyDirectories (27.72s)
=== RUN TestSyncNoEmptyDirectories
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:20:45 INFO : sub dir2: Making directory
2026/02/03 06:20:46 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:20:46 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:20:46 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:20:48 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:20:48 INFO : sub dir/hello world: Copied (new)
2026/02/03 06:20:48 DEBUG : Waiting for deletions to finish
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
--- PASS: TestSyncNoEmptyDirectories (19.51s)
=== RUN TestServerSideCopy
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
2026/02/03 06:21:24 DEBUG : Creating backend with remote "TestDrime:rclone-test-toduvov9hufa"
2026/02/03 06:21:24 DEBUG : Config file has changed externally - reloading
sync_test.go:620: Server side copy (if possible) drime root 'rclone-test-xiwoluy9gibi' -> drime root 'rclone-test-toduvov9hufa'
2026/02/03 06:21:26 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:21:26 DEBUG : drime root 'rclone-test-toduvov9hufa': Waiting for checks to finish
2026/02/03 06:21:26 DEBUG : drime root 'rclone-test-toduvov9hufa': Waiting for transfers to finish
2026/02/03 06:21:29 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:21:29 INFO : sub dir/hello world: Copied (server-side copy)
2026/02/03 06:21:30 DEBUG : drime root 'rclone-test-toduvov9hufa': Purge remote
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestServerSideCopy
Messages: listing wrong, want
got
sub dir/hello world (11)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestServerSideCopy
Messages: Unexpected file "sub dir/hello world"
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=7) "sub dir"
}
Test: TestServerSideCopy
Messages: directories
--- FAIL: TestServerSideCopy (40.03s)
=== RUN TestCopyOverSelf
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
2026/02/03 06:22:05 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:22:05 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone2151365684)
2026/02/03 06:22:05 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-xiwoluy9gibi')
2026/02/03 06:22:05 DEBUG : sub dir/hello world: Sizes differ
2026/02/03 06:22:05 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:22:14 DEBUG : sub dir/hello world: Removing old object on successful upload
2026/02/03 06:22:15 DEBUG : sub dir/hello world: size = 17 OK
2026/02/03 06:22:15 INFO : sub dir/hello world: Copied (replaced existing)
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=7) "sub dir"
}
Test: TestCopyOverSelf
Messages: directories
--- FAIL: TestCopyOverSelf (45.22s)
=== RUN TestServerSideCopyOverSelf
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:22:41 DEBUG : Creating backend with remote "TestDrime:rclone-test-qimefic0jixa"
sync_test.go:656: Server side copy (if possible) drime root 'rclone-test-xiwoluy9gibi' -> drime root 'rclone-test-qimefic0jixa'
2026/02/03 06:22:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:22:42 DEBUG : drime root 'rclone-test-qimefic0jixa': Waiting for checks to finish
2026/02/03 06:22:42 DEBUG : drime root 'rclone-test-qimefic0jixa': Waiting for transfers to finish
2026/02/03 06:22:45 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:22:45 INFO : sub dir/hello world: Copied (server-side copy)
2026/02/03 06:22:53 DEBUG : sub dir/hello world: Removing old object on successful upload
2026/02/03 06:22:54 DEBUG : sub dir/hello world: size = 17 (drime root 'rclone-test-xiwoluy9gibi')
2026/02/03 06:22:54 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-qimefic0jixa')
2026/02/03 06:22:54 DEBUG : sub dir/hello world: Sizes differ
2026/02/03 06:22:54 DEBUG : drime root 'rclone-test-qimefic0jixa': Waiting for checks to finish
2026/02/03 06:22:54 DEBUG : drime root 'rclone-test-qimefic0jixa': Waiting for transfers to finish
2026/02/03 06:22:55 DEBUG : sub dir/hello world: Server side copy: removing existing object after successful copy
2026/02/03 06:22:56 DEBUG : sub dir/hello world: size = 17 OK
2026/02/03 06:22:56 INFO : sub dir/hello world: Copied (server-side copy)
2026/02/03 06:22:56 DEBUG : drime root 'rclone-test-qimefic0jixa': Purge remote
2026/02/03 06:22:56 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:22:56 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 06:22:57 DEBUG : pacer: Reducing sleep to 10ms
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=7) "sub dir"
}
Test: TestServerSideCopyOverSelf
Messages: directories
--- FAIL: TestServerSideCopyOverSelf (41.25s)
=== RUN TestMoveOverSelf
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:23:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:23:19 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone2151365684)
2026/02/03 06:23:19 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-xiwoluy9gibi')
2026/02/03 06:23:19 DEBUG : sub dir/hello world: Sizes differ
2026/02/03 06:23:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:23:25 DEBUG : sub dir/hello world: Removing old object on successful upload
2026/02/03 06:23:25 DEBUG : sub dir/hello world: size = 17 OK
2026/02/03 06:23:25 INFO : sub dir/hello world: Copied (replaced existing)
2026/02/03 06:23:25 INFO : sub dir/hello world: Deleted
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
--- PASS: TestMoveOverSelf (30.82s)
=== RUN TestServerSideMoveOverSelf
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:696
Error: Should be true
Test: TestServerSideMoveOverSelf
Messages: listing wrong, want
sub dir/hello world (11) got
fstest.go:203: Not found "sub dir/hello world"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:696
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Not equal:
expected: 0
actual : 1
Test: TestServerSideMoveOverSelf
Messages: 1 objects not found
2026/02/03 06:23:53 DEBUG : Creating backend with remote "TestDrime:rclone-test-hitanic4gide"
sync_test.go:701: Server side copy (if possible) drime root 'rclone-test-xiwoluy9gibi' -> drime root 'rclone-test-hitanic4gide'
2026/02/03 06:23:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:23:54 DEBUG : drime root 'rclone-test-hitanic4gide': Waiting for checks to finish
2026/02/03 06:23:54 DEBUG : drime root 'rclone-test-hitanic4gide': Waiting for transfers to finish
2026/02/03 06:23:56 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:23:56 INFO : sub dir/hello world: Copied (server-side copy)
2026/02/03 06:24:03 DEBUG : sub dir/hello world: Removing old object on successful upload
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 6s just to make sure
2026/02/03 06:24:11 DEBUG : drime root 'rclone-test-hitanic4gide': Using server-side directory move
2026/02/03 06:24:11 INFO : drime root 'rclone-test-hitanic4gide': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2026/02/03 06:24:12 DEBUG : drime root 'rclone-test-hitanic4gide': Waiting for checks to finish
2026/02/03 06:24:12 DEBUG : sub dir/hello world: size = 17 (drime root 'rclone-test-xiwoluy9gibi')
2026/02/03 06:24:12 DEBUG : sub dir/hello world: size = 11 (drime root 'rclone-test-hitanic4gide')
2026/02/03 06:24:12 DEBUG : sub dir/hello world: Sizes differ
2026/02/03 06:24:12 DEBUG : drime root 'rclone-test-hitanic4gide': Waiting for transfers to finish
2026/02/03 06:24:13 INFO : sub dir/hello world: Deleted
2026/02/03 06:24:13 ERROR : sub dir/hello world: Couldn't move: object not found
sync_test.go:714:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:714
Error: Received unexpected error:
object not found
Test: TestServerSideMoveOverSelf
2026/02/03 06:24:13 DEBUG : drime root 'rclone-test-hitanic4gide': Purge remote
2026/02/03 06:24:15 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:24:15 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 06:24:15 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:24:15 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/03 06:24:15 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:24:15 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/03 06:24:15 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:24:15 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/03 06:24:16 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:24:16 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/02/03 06:24:16 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:24:16 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/02/03 06:24:17 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:24:17 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/02/03 06:24:17 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:24:17 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/02/03 06:24:18 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:24:18 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/02/03 06:24:21 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/02/03 06:24:21 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
run.go:130: removing file "sub dir/hello world" failed - try 1/3: failed to delete item: Error "Server Error"
2026/02/03 06:24:26 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:24:26 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/02/03 06:24:36 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:24:56 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:25:16 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:25:36 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:25:56 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:26:17 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:26:36 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:26:57 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:27:17 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "sub dir/hello world" failed - try 2/3: failed to delete item: Error "Server Error"
2026/02/03 06:27:37 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:27:57 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:28:17 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:28:37 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:28:57 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:29:17 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:29:37 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:29:57 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:30:17 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:30:37 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "sub dir/hello world" failed - try 3/3: failed to delete item: Error "Server Error"
run.go:133: removing file "sub dir/hello world" failed: failed to delete item: Error "Server Error"
2026/02/03 06:30:57 DEBUG : pacer: Reducing sleep to 10s
2026/02/03 06:31:17 DEBUG : pacer: Reducing sleep to 5s
2026/02/03 06:31:27 DEBUG : pacer: Reducing sleep to 2.5s
--- FAIL: TestServerSideMoveOverSelf (464.70s)
=== RUN TestCopyAfterDelete
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:31:32 DEBUG : pacer: Reducing sleep to 1.25s
2026/02/03 06:31:34 DEBUG : pacer: Reducing sleep to 625ms
2026/02/03 06:31:35 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/03 06:31:35 DEBUG : pacer: low level retry 1/10 (error Error "500 Internal Server Error (500): \r\n500 Internal Server Error\r\n\r\n500 Internal Server Error
\r\n
nginx\r\n\r\n\r\n")
2026/02/03 06:31:35 DEBUG : pacer: Rate limited, increasing sleep to 1.25s
2026/02/03 06:31:36 DEBUG : pacer: Reducing sleep to 625ms
2026/02/03 06:31:40 DEBUG : pacer: Reducing sleep to 312.5ms
2026/02/03 06:31:40 ERROR : error listing: directory not found
2026/02/03 06:31:41 DEBUG : pacer: Reducing sleep to 156.25ms
2026/02/03 06:31:41 DEBUG : pacer: Reducing sleep to 78.125ms
2026/02/03 06:31:41 INFO : Local file system at /tmp/rclone2151365684: Making directory
2026/02/03 06:31:42 DEBUG : pacer: Reducing sleep to 39.0625ms
2026/02/03 06:31:42 DEBUG : pacer: Reducing sleep to 19.53125ms
2026/02/03 06:31:42 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:31:42 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:31:42 DEBUG : pacer: Reducing sleep to 10ms
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
2026/02/03 06:31:51 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/03 06:31:51 DEBUG : pacer: low level retry 1/10 (error Error "500 Internal Server Error (500): \r\n500 Internal Server Error\r\n\r\n500 Internal Server Error
\r\n
nginx\r\n\r\n\r\n")
2026/02/03 06:31:51 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 06:31:51 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/03 06:31:51 DEBUG : pacer: low level retry 2/10 (error Error "500 Internal Server Error (500): \r\n500 Internal Server Error\r\n\r\n500 Internal Server Error
\r\n
nginx\r\n\r\n\r\n")
2026/02/03 06:31:51 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/03 06:31:51 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/03 06:31:51 DEBUG : pacer: low level retry 3/10 (error Error "500 Internal Server Error (500): \r\n500 Internal Server Error\r\n\r\n500 Internal Server Error
\r\n
nginx\r\n\r\n\r\n")
2026/02/03 06:31:51 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/03 06:31:52 DEBUG : pacer: Reducing sleep to 40ms
2026/02/03 06:31:52 DEBUG : pacer: Reducing sleep to 20ms
2026/02/03 06:31:52 DEBUG : pacer: Reducing sleep to 10ms
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=7) "sub dir"
}
Test: TestCopyAfterDelete
Messages: directories
--- FAIL: TestCopyAfterDelete (29.52s)
=== RUN TestSyncIgnoreExisting
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:31:57 DEBUG : existing: Need to transfer - File not found at Destination
2026/02/03 06:31:57 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:31:57 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:31:59 DEBUG : existing: size = 6 OK
2026/02/03 06:31:59 INFO : existing: Copied (new)
2026/02/03 06:31:59 DEBUG : Waiting for deletions to finish
2026/02/03 06:31:59 INFO : sub dir: Removing directory
2026/02/03 06:31:59 DEBUG : drime root 'rclone-test-xiwoluy9gibi': deleted 1 directories
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
2026/02/03 06:32:02 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/03 06:32:02 DEBUG : pacer: low level retry 1/10 (error Error "500 Internal Server Error (500): \r\n500 Internal Server Error\r\n\r\n500 Internal Server Error
\r\n
nginx\r\n\r\n\r\n")
2026/02/03 06:32:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 06:32:02 DEBUG : pacer: Reducing sleep to 10ms
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
2026/02/03 06:32:12 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:32:12 DEBUG : existing: Destination exists, skipping
2026/02/03 06:32:12 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:32:12 DEBUG : Waiting for deletions to finish
2026/02/03 06:32:12 INFO : There was nothing to transfer
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 6s just to make sure
--- PASS: TestSyncIgnoreExisting (24.84s)
=== RUN TestSyncIgnoreErrors
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:32:39 INFO : d: Making directory
2026/02/03 06:32:41 DEBUG : a/potato2: Need to transfer - File not found at Destination
2026/02/03 06:32:41 DEBUG : c/non empty space: size = 5 OK
2026/02/03 06:32:41 DEBUG : c/non empty space: Sizes identical
2026/02/03 06:32:41 DEBUG : c/non empty space: Unchanged skipping
2026/02/03 06:32:41 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:32:41 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:32:45 DEBUG : a/potato2: size = 60 OK
2026/02/03 06:32:45 INFO : a/potato2: Copied (new)
2026/02/03 06:32:45 DEBUG : Waiting for deletions to finish
2026/02/03 06:32:46 INFO : b/potato: Deleted
2026/02/03 06:32:46 INFO : d: Removing directory
2026/02/03 06:32:47 INFO : b: Removing directory
2026/02/03 06:32:47 DEBUG : b: Failed to Rmdir: directory not empty
2026/02/03 06:32:47 DEBUG : drime root 'rclone-test-xiwoluy9gibi': failed to delete 1 directories
2026/02/03 06:32:47 DEBUG : drime root 'rclone-test-xiwoluy9gibi': deleted 1 directories
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:994
Error: Not equal:
expected: []string{"a", "c"}
actual : []string{"a", "b", "c"}
Diff:
--- Expected
+++ Actual
@@ -1,3 +1,4 @@
-([]string) (len=2) {
+([]string) (len=3) {
(string) (len=1) "a",
+ (string) (len=1) "b",
(string) (len=1) "c"
Test: TestSyncIgnoreErrors
Messages: directories
run.go:130: removing dir "c" failed - try 1/3: directory not empty
run.go:130: removing dir "c" failed - try 2/3: directory not empty
run.go:130: removing dir "c" failed - try 3/3: directory not empty
run.go:133: removing dir "c" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"c"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=1) "c"
}
Test: TestSyncIgnoreErrors
Messages: directories
--- FAIL: TestSyncIgnoreErrors (51.89s)
=== RUN TestSyncAfterAddingAFile
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:33:17 DEBUG : empty space: size = 1 OK
2026/02/03 06:33:17 DEBUG : empty space: Sizes identical
2026/02/03 06:33:17 DEBUG : potato: Need to transfer - File not found at Destination
2026/02/03 06:33:17 DEBUG : empty space: Unchanged skipping
2026/02/03 06:33:17 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:33:17 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:33:19 DEBUG : potato: size = 60 OK
2026/02/03 06:33:19 INFO : potato: Copied (new)
2026/02/03 06:33:19 DEBUG : Waiting for deletions to finish
2026/02/03 06:33:19 INFO : c: Removing directory
2026/02/03 06:33:20 DEBUG : drime root 'rclone-test-xiwoluy9gibi': deleted 1 directories
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1109
Error: Should be true
Test: TestSyncAfterAddingAFile
Messages: listing wrong, want
empty space (1), potato (60) got
empty space (1)
fstest.go:203: Not found "potato"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1109
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Not equal:
expected: 0
actual : 1
Test: TestSyncAfterAddingAFile
Messages: 1 objects not found
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncAfterAddingAFile
Messages: listing wrong, want
got
empty space (1), potato (60)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncAfterAddingAFile
Messages: Unexpected file "empty space"
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncAfterAddingAFile
Messages: Unexpected file "potato"
--- FAIL: TestSyncAfterAddingAFile (26.36s)
=== RUN TestSyncAfterRemovingAFileAndAddingAFile
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:33:43 DEBUG : potato: Removing old object on successful upload
2026/02/03 06:33:44 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:33:44 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 06:33:44 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:33:44 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/03 06:33:44 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:33:44 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/03 06:33:45 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:33:45 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/03 06:33:45 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:33:45 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/02/03 06:33:45 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:33:45 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/02/03 06:33:46 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:33:46 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/02/03 06:33:46 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:33:46 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/02/03 06:33:48 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:33:48 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/02/03 06:33:50 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/02/03 06:33:50 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
run.go:286: Retry Put of "potato" to drime root 'rclone-test-xiwoluy9gibi': 1/10 (failed to delete existing object: failed to delete item: Error "Server Error")
2026/02/03 06:33:55 DEBUG : pacer: Reducing sleep to 5.12s
2026/02/03 06:34:09 DEBUG : pacer: Reducing sleep to 2.56s
2026/02/03 06:34:09 DEBUG : potato: Removing old object on successful upload
2026/02/03 06:34:11 DEBUG : pacer: Reducing sleep to 1.28s
2026/02/03 06:34:13 DEBUG : pacer: Reducing sleep to 640ms
2026/02/03 06:34:16 DEBUG : pacer: Reducing sleep to 320ms
2026/02/03 06:34:16 DEBUG : pacer: Reducing sleep to 160ms
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
2026/02/03 06:34:18 DEBUG : pacer: Reducing sleep to 80ms
2026/02/03 06:34:18 DEBUG : pacer: Reducing sleep to 40ms
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
2026/02/03 06:34:21 DEBUG : pacer: Reducing sleep to 20ms
2026/02/03 06:34:21 DEBUG : pacer: Reducing sleep to 10ms
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1181
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Should be true
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: listing wrong, want
empty space (1), potato (21) got
potato (21)
fstest.go:203: Not found "empty space"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1181
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194
Error: Not equal:
expected: 0
actual : 1
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: 1 objects not found
2026/02/03 06:34:26 DEBUG : empty space: size = 1 OK
2026/02/03 06:34:26 DEBUG : empty space: Sizes identical
2026/02/03 06:34:26 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/03 06:34:26 DEBUG : empty space: Unchanged skipping
2026/02/03 06:34:26 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:34:26 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:34:28 DEBUG : potato2: size = 60 OK
2026/02/03 06:34:28 INFO : potato2: Copied (new)
2026/02/03 06:34:28 DEBUG : Waiting for deletions to finish
2026/02/03 06:34:29 INFO : potato: Deleted
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1190
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Should be true
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: listing wrong, want
empty space (1), potato2 (60) got
empty space (1), potato (21)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1190
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194
Error: Should be true
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: Unexpected file "potato"
fstest.go:203: Not found "potato2"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1190
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194
Error: Not equal:
expected: 0
actual : 1
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: 1 objects not found
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: listing wrong, want
got
empty space (1), potato2 (60)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: Unexpected file "empty space"
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncAfterRemovingAFileAndAddingAFile
Messages: Unexpected file "potato2"
--- FAIL: TestSyncAfterRemovingAFileAndAddingAFile (68.02s)
=== RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:35:01 INFO : d: Making directory
2026/02/03 06:35:02 INFO : d/e: Making directory
2026/02/03 06:35:04 DEBUG : a/potato2: Need to transfer - File not found at Destination
2026/02/03 06:35:04 DEBUG : c/non empty space: size = 5 OK
2026/02/03 06:35:04 DEBUG : c/non empty space: Sizes identical
2026/02/03 06:35:04 DEBUG : c/non empty space: Unchanged skipping
2026/02/03 06:35:06 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:35:06 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:35:08 DEBUG : a/potato2: size = 60 OK
2026/02/03 06:35:08 INFO : a/potato2: Copied (new)
2026/02/03 06:35:08 DEBUG : Waiting for deletions to finish
2026/02/03 06:35:08 INFO : b/potato: Deleted
2026/02/03 06:35:08 INFO : d/e: Removing directory
2026/02/03 06:35:09 INFO : d: Removing directory
2026/02/03 06:35:09 DEBUG : d: Failed to Rmdir: directory not empty
2026/02/03 06:35:09 INFO : b: Removing directory
2026/02/03 06:35:10 DEBUG : b: Failed to Rmdir: directory not empty
2026/02/03 06:35:10 DEBUG : drime root 'rclone-test-xiwoluy9gibi': failed to delete 2 directories
2026/02/03 06:35:10 DEBUG : drime root 'rclone-test-xiwoluy9gibi': deleted 1 directories
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1248
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1262
Error: Not equal:
expected: []string{"a", "c"}
actual : []string{"a", "b", "c", "d"}
Diff:
--- Expected
+++ Actual
@@ -1,4 +1,6 @@
-([]string) (len=2) {
+([]string) (len=4) {
(string) (len=1) "a",
- (string) (len=1) "c"
+ (string) (len=1) "b",
+ (string) (len=1) "c",
+ (string) (len=1) "d"
}
Test: TestSyncAfterRemovingAFileAndAddingAFileSubDir
Messages: directories
run.go:130: removing dir "c" failed - try 1/3: directory not empty
run.go:130: removing dir "c" failed - try 2/3: directory not empty
run.go:130: removing dir "c" failed - try 3/3: directory not empty
run.go:133: removing dir "c" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"c"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=1) "c"
}
Test: TestSyncAfterRemovingAFileAndAddingAFileSubDir
Messages: directories
--- FAIL: TestSyncAfterRemovingAFileAndAddingAFileSubDir (50.46s)
=== RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:35:45 INFO : d: Making directory
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1285
Error: Should be true
Test: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
Messages: listing wrong, want
b/potato (21), c/non empty space (5) got
b/potato (21)
fstest.go:203: Not found "c/non empty space"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1285
Error: Not equal:
expected: 0
actual : 1
Test: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
Messages: 1 objects not found
2026/02/03 06:35:56 DEBUG : a/potato2: Need to transfer - File not found at Destination
2026/02/03 06:35:56 DEBUG : c/non empty space: size = 5 OK
2026/02/03 06:35:56 DEBUG : c/non empty space: Sizes identical
2026/02/03 06:35:56 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:35:56 DEBUG : c/non empty space: Unchanged skipping
2026/02/03 06:35:56 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:36:06 DEBUG : a/potato2: size = 60 OK
2026/02/03 06:36:06 INFO : a/potato2: Copied (new)
2026/02/03 06:36:06 ERROR : drime root 'rclone-test-xiwoluy9gibi': not deleting files as there were IO errors
2026/02/03 06:36:06 ERROR : drime root 'rclone-test-xiwoluy9gibi': not deleting directories as there were IO errors
run.go:130: removing dir "c" failed - try 1/3: directory not empty
run.go:130: removing dir "c" failed - try 2/3: directory not empty
run.go:130: removing dir "c" failed - try 3/3: directory not empty
run.go:133: removing dir "c" failed: directory not empty
run.go:130: removing dir "b" failed - try 1/3: directory not empty
run.go:130: removing dir "b" failed - try 2/3: directory not empty
run.go:130: removing dir "b" failed - try 3/3: directory not empty
run.go:133: removing dir "b" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"b", "c"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,4 @@
-([]string) {
+([]string) (len=2) {
+ (string) (len=1) "b",
+ (string) (len=1) "c"
}
Test: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
Messages: directories
--- FAIL: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (49.02s)
=== RUN TestSyncDeleteDuring
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
2026/02/03 06:36:45 DEBUG : Waiting for deletions to finish
2026/02/03 06:36:46 DEBUG : empty space: size = 1 OK
2026/02/03 06:36:46 DEBUG : empty space: Sizes identical
2026/02/03 06:36:46 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/03 06:36:46 DEBUG : empty space: Unchanged skipping
2026/02/03 06:36:46 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:36:46 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:36:46 INFO : potato: Deleted
2026/02/03 06:36:48 DEBUG : potato2: size = 60 OK
2026/02/03 06:36:48 INFO : potato2: Copied (new)
2026/02/03 06:36:48 INFO : c: Removing directory
2026/02/03 06:36:49 INFO : b: Removing directory
2026/02/03 06:36:49 DEBUG : drime root 'rclone-test-xiwoluy9gibi': deleted 2 directories
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncDeleteDuring
Messages: listing wrong, want
got
empty space (1), potato2 (60)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncDeleteDuring
Messages: Unexpected file "empty space"
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestSyncDeleteDuring
Messages: Unexpected file "potato2"
--- FAIL: TestSyncDeleteDuring (32.42s)
=== RUN TestSyncDeleteBefore
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
2026/02/03 06:37:18 DEBUG : Waiting for deletions to finish
2026/02/03 06:37:18 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:37:18 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:37:18 INFO : potato: Deleted
2026/02/03 06:37:19 DEBUG : empty space: size = 1 OK
2026/02/03 06:37:19 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/03 06:37:19 DEBUG : empty space: Sizes identical
2026/02/03 06:37:19 DEBUG : empty space: Unchanged skipping
2026/02/03 06:37:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:37:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:37:21 DEBUG : potato2: size = 60 OK
2026/02/03 06:37:21 INFO : potato2: Copied (new)
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 6s just to make sure
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
--- PASS: TestSyncDeleteBefore (42.90s)
=== RUN TestCopyDeleteBefore
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:37:48 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/03 06:37:48 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:37:48 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:37:51 DEBUG : potato2: size = 19 OK
2026/02/03 06:37:51 INFO : potato2: Copied (new)
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1379
Error: Should be true
Test: TestCopyDeleteBefore
Messages: listing wrong, want
potato (21), potato2 (19) got
potato (21)
fstest.go:203: Not found "potato2"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1379
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Not equal:
expected: 0
actual : 1
Test: TestCopyDeleteBefore
Messages: 1 objects not found
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestCopyDeleteBefore
Messages: listing wrong, want
got
potato (21), potato2 (19)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestCopyDeleteBefore
Messages: Unexpected file "potato"
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Should be true
Test: TestCopyDeleteBefore
Messages: Unexpected file "potato2"
--- FAIL: TestCopyDeleteBefore (27.84s)
=== RUN TestSyncWithTrackRenamesStrategyLeaf
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
sync_test.go:1680: Can track renames: false
2026/02/03 06:38:10 INFO : drime root 'rclone-test-xiwoluy9gibi': Making map for --track-renames
2026/02/03 06:38:10 INFO : drime root 'rclone-test-xiwoluy9gibi': Finished making map for --track-renames
2026/02/03 06:38:10 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:38:10 DEBUG : potato: Need to transfer - No matching file found at Destination
2026/02/03 06:38:10 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for renames to finish
2026/02/03 06:38:10 DEBUG : sub/yam: Need to transfer - No matching file found at Destination
2026/02/03 06:38:10 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:38:15 DEBUG : sub/yam: size = 11 OK
2026/02/03 06:38:15 INFO : sub/yam: Copied (new)
2026/02/03 06:38:18 DEBUG : potato: size = 14 OK
2026/02/03 06:38:18 INFO : potato: Copied (new)
2026/02/03 06:38:18 DEBUG : Waiting for deletions to finish
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 7s just to make sure
2026/02/03 06:38:30 DEBUG : potato: size = 14 OK
2026/02/03 06:38:30 DEBUG : potato: Sizes identical
2026/02/03 06:38:30 DEBUG : potato: Unchanged skipping
2026/02/03 06:38:31 INFO : drime root 'rclone-test-xiwoluy9gibi': Making map for --track-renames
2026/02/03 06:38:31 INFO : drime root 'rclone-test-xiwoluy9gibi': Finished making map for --track-renames
2026/02/03 06:38:31 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:38:31 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for renames to finish
2026/02/03 06:38:32 ERROR : sub/yam: Couldn't move: object not found
2026/02/03 06:38:32 DEBUG : yam: Failed to rename to "sub/yam": object not found
2026/02/03 06:38:32 DEBUG : yam: Need to transfer - No matching file found at Destination
2026/02/03 06:38:32 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:38:34 DEBUG : yam: size = 11 OK
2026/02/03 06:38:34 INFO : yam: Copied (new)
2026/02/03 06:38:34 ERROR : drime root 'rclone-test-xiwoluy9gibi': not deleting files as there were IO errors
2026/02/03 06:38:34 ERROR : drime root 'rclone-test-xiwoluy9gibi': not deleting directories as there were IO errors
sync_test.go:1698:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1698
Error: Received unexpected error:
not deleting files as there were IO errors
Test: TestSyncWithTrackRenamesStrategyLeaf
2026/02/03 06:38:35 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:38:35 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 06:38:35 DEBUG : pacer: Reducing sleep to 10ms
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
/usr/local/go/src/runtime/panic.go:636
/usr/local/go/src/testing/testing.go:1041
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1698
Error: Should be true
Test: TestSyncWithTrackRenamesStrategyLeaf
Messages: listing wrong, want
got
potato (14), yam (11), yam (11)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
/usr/local/go/src/runtime/panic.go:636
/usr/local/go/src/testing/testing.go:1041
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1698
Error: Should be true
Test: TestSyncWithTrackRenamesStrategyLeaf
Messages: Unexpected file "potato"
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
/usr/local/go/src/runtime/panic.go:636
/usr/local/go/src/testing/testing.go:1041
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1698
Error: Should be true
Test: TestSyncWithTrackRenamesStrategyLeaf
Messages: Unexpected file "yam"
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
/usr/local/go/src/runtime/panic.go:636
/usr/local/go/src/testing/testing.go:1041
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1698
Error: Should be true
Test: TestSyncWithTrackRenamesStrategyLeaf
Messages: Unexpected file "yam"
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
/usr/local/go/src/runtime/panic.go:636
/usr/local/go/src/testing/testing.go:1041
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1698
Error: Not equal:
expected: []string{}
actual : []string{"sub"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=3) "sub"
}
Test: TestSyncWithTrackRenamesStrategyLeaf
Messages: directories
--- FAIL: TestSyncWithTrackRenamesStrategyLeaf (35.83s)
=== RUN TestMoveWithDeleteEmptySrcDirs
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:38:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:38:47 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2026/02/03 06:38:47 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:38:47 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:38:52 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:38:52 INFO : sub dir/hello world: Copied (new)
2026/02/03 06:38:52 INFO : sub dir/hello world: Deleted
2026/02/03 06:38:56 DEBUG : nested/sub dir/file: size = 6 OK
2026/02/03 06:38:56 INFO : nested/sub dir/file: Copied (new)
2026/02/03 06:38:56 INFO : nested/sub dir/file: Deleted
2026/02/03 06:38:56 ERROR : Local file system at /tmp/rclone2151365684: not deleting directories as there were IO errors
sync_test.go:1819:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1819
Error: Received unexpected error:
not deleting directories as there were IO errors
Test: TestMoveWithDeleteEmptySrcDirs
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
run.go:130: removing dir "nested/sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "nested/sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "nested/sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "nested/sub dir" failed: directory not empty
run.go:130: removing dir "nested" failed - try 1/3: directory not empty
run.go:130: removing dir "nested" failed - try 2/3: directory not empty
run.go:130: removing dir "nested" failed - try 3/3: directory not empty
run.go:133: removing dir "nested" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
/usr/local/go/src/runtime/panic.go:636
/usr/local/go/src/testing/testing.go:1041
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1819
Error: Not equal:
expected: []string{}
actual : []string{"nested", "nested/sub dir", "sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,5 @@
-([]string) {
+([]string) (len=3) {
+ (string) (len=6) "nested",
+ (string) (len=14) "nested/sub dir",
+ (string) (len=7) "sub dir"
}
Test: TestMoveWithDeleteEmptySrcDirs
Messages: directories
--- FAIL: TestMoveWithDeleteEmptySrcDirs (34.28s)
=== RUN TestMoveWithoutDeleteEmptySrcDirs
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:39:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/02/03 06:39:21 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2026/02/03 06:39:21 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:39:21 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:39:23 DEBUG : sub dir/hello world: size = 11 OK
2026/02/03 06:39:23 INFO : sub dir/hello world: Copied (new)
2026/02/03 06:39:23 INFO : sub dir/hello world: Deleted
2026/02/03 06:39:24 DEBUG : nested/sub dir/file: size = 6 OK
2026/02/03 06:39:24 INFO : nested/sub dir/file: Copied (new)
2026/02/03 06:39:24 INFO : nested/sub dir/file: Deleted
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1851
Error: Should be true
Test: TestMoveWithoutDeleteEmptySrcDirs
Messages: listing wrong, want
nested/sub dir/file (6), sub dir/hello world (11) got
fstest.go:203: Not found "sub dir/hello world"
fstest.go:203: Not found "nested/sub dir/file"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1851
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Not equal:
expected: 0
actual : 2
Test: TestMoveWithoutDeleteEmptySrcDirs
Messages: 2 objects not found
run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "sub dir" failed: directory not empty
run.go:130: removing dir "nested/sub dir" failed - try 1/3: directory not empty
run.go:130: removing dir "nested/sub dir" failed - try 2/3: directory not empty
run.go:130: removing dir "nested/sub dir" failed - try 3/3: directory not empty
run.go:133: removing dir "nested/sub dir" failed: directory not empty
run.go:130: removing dir "nested" failed - try 1/3: directory not empty
run.go:130: removing dir "nested" failed - try 2/3: directory not empty
run.go:130: removing dir "nested" failed - try 3/3: directory not empty
run.go:133: removing dir "nested" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"nested", "nested/sub dir", "sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,5 @@
-([]string) {
+([]string) (len=3) {
+ (string) (len=6) "nested",
+ (string) (len=14) "nested/sub dir",
+ (string) (len=7) "sub dir"
}
Test: TestMoveWithoutDeleteEmptySrcDirs
Messages: directories
--- FAIL: TestMoveWithoutDeleteEmptySrcDirs (38.27s)
=== RUN TestMoveWithIgnoreExisting
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:39:59 DEBUG : existing-b: Need to transfer - File not found at Destination
2026/02/03 06:39:59 DEBUG : existing: Need to transfer - File not found at Destination
2026/02/03 06:39:59 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:39:59 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:40:04 DEBUG : existing-b: size = 6 OK
2026/02/03 06:40:04 INFO : existing-b: Copied (new)
2026/02/03 06:40:04 INFO : existing-b: Deleted
2026/02/03 06:40:07 DEBUG : existing: size = 6 OK
2026/02/03 06:40:07 INFO : existing: Copied (new)
2026/02/03 06:40:07 INFO : existing: Deleted
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1873
Error: Not equal:
expected: []string{}
actual : []string{"nested", "nested/sub dir", "sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,5 @@
-([]string) {
+([]string) (len=3) {
+ (string) (len=6) "nested",
+ (string) (len=14) "nested/sub dir",
+ (string) (len=7) "sub dir"
}
Test: TestMoveWithIgnoreExisting
Messages: directories
2026/02/03 06:40:18 DEBUG : existing: Destination exists, skipping
2026/02/03 06:40:18 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set
2026/02/03 06:40:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for checks to finish
2026/02/03 06:40:19 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Waiting for transfers to finish
2026/02/03 06:40:19 INFO : There was nothing to transfer
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:365
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1898
Error: Not equal:
expected: []string{}
actual : []string{"nested", "nested/sub dir", "sub dir"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,5 @@
-([]string) {
+([]string) (len=3) {
+ (string) (len=6) "nested",
+ (string) (len=14) "nested/sub dir",
+ (string) (len=7) "sub dir"
}
Test: TestMoveWithIgnoreExisting
Messages: directories
run.go:130: removing dir "nested" failed - try 1/3: directory not empty
run.go:130: removing dir "nested" failed - try 2/3: directory not empty
run.go:130: removing dir "nested" failed - try 3/3: directory not empty
run.go:133: removing dir "nested" failed: directory not empty
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:327:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393
/usr/local/go/src/testing/testing.go:1211
/usr/local/go/src/testing/testing.go:1445
/usr/local/go/src/testing/testing.go:1786
Error: Not equal:
expected: []string{}
actual : []string{"nested"}
Diff:
--- Expected
+++ Actual
@@ -1,2 +1,3 @@
-([]string) {
+([]string) (len=1) {
+ (string) (len=6) "nested"
}
Test: TestMoveWithIgnoreExisting
Messages: directories
--- FAIL: TestMoveWithIgnoreExisting (47.60s)
=== RUN TestServerSideMove
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 06:40:46 DEBUG : Creating backend with remote "TestDrime:rclone-test-cidonat5sahu"
2026/02/03 06:40:46 DEBUG : Config file has changed externally - reloading
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1734
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1912
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Should be true
Test: TestServerSideMove
Messages: listing wrong, want
empty space (1), potato2 (60), potato3 (68) got
empty space (1), potato2 (60)
fstest.go:203: Not found "potato3"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1734
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1912
Error: Not equal:
expected: 0
actual : 1
Test: TestServerSideMove
Messages: 1 objects not found
sync_test.go:1736: Server side move (if possible) drime root 'rclone-test-xiwoluy9gibi' -> drime root 'rclone-test-cidonat5sahu'
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:292: Sleeping for 6s just to make sure
2026/02/03 06:41:28 DEBUG : drime root 'rclone-test-cidonat5sahu': Using server-side directory move
2026/02/03 06:41:28 INFO : drime root 'rclone-test-cidonat5sahu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2026/02/03 06:41:28 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/03 06:41:28 DEBUG : empty space: size = 1 OK
2026/02/03 06:41:28 DEBUG : empty space: Sizes identical
2026/02/03 06:41:28 DEBUG : empty space: Unchanged skipping
2026/02/03 06:41:28 DEBUG : potato3: size = 68 (drime root 'rclone-test-xiwoluy9gibi')
2026/02/03 06:41:28 DEBUG : potato3: size = 60 (drime root 'rclone-test-cidonat5sahu')
2026/02/03 06:41:28 DEBUG : potato3: Sizes differ
2026/02/03 06:41:29 INFO : potato3: Deleted
2026/02/03 06:41:29 DEBUG : drime root 'rclone-test-cidonat5sahu': Waiting for checks to finish
2026/02/03 06:41:29 INFO : empty space: Deleted
2026/02/03 06:41:29 DEBUG : drime root 'rclone-test-cidonat5sahu': Waiting for transfers to finish
2026/02/03 06:41:29 ERROR : potato2: Couldn't move: object not found
2026/02/03 06:41:29 ERROR : potato3: Couldn't move: object not found
sync_test.go:1747:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1747
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1912
Error: Received unexpected error:
object not found
Test: TestServerSideMove
2026/02/03 06:41:29 DEBUG : drime root 'rclone-test-cidonat5sahu': Purge remote
2026/02/03 06:41:30 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:41:30 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 06:41:31 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:41:31 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/03 06:41:31 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:41:31 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/03 06:41:31 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:41:31 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/03 06:41:32 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:41:32 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/02/03 06:41:32 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:41:32 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/02/03 06:41:32 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:41:32 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/02/03 06:41:33 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:41:33 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/02/03 06:41:34 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:41:34 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/02/03 06:41:37 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/02/03 06:41:37 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
run.go:130: removing file "empty space" failed - try 1/3: failed to delete item: Error "Server Error"
2026/02/03 06:41:42 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:41:42 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/02/03 06:41:52 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:42:12 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:42:32 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:42:53 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:43:13 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:43:32 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:43:52 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:44:12 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:44:32 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "empty space" failed - try 2/3: failed to delete item: Error "Server Error"
2026/02/03 06:44:52 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:45:12 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:45:32 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:45:52 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:46:12 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:46:33 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:46:52 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:47:12 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:47:32 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/03 06:47:32 DEBUG : pacer: low level retry 9/10 (error Error "500 Internal Server Error (500): \r\n500 Internal Server Error\r\n\r\n500 Internal Server Error
\r\n
nginx\r\n\r\n\r\n")
2026/02/03 06:47:52 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "empty space" failed - try 3/3: failed to delete item: Error "Server Error"
run.go:133: removing file "empty space" failed: failed to delete item: Error "Server Error"
2026/02/03 06:48:13 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:48:33 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:48:54 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:49:13 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:49:32 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:49:53 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:50:13 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:50:33 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:50:53 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:51:13 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato2" failed - try 1/3: failed to delete item: Error "Server Error"
2026/02/03 06:51:33 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:51:53 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:52:13 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:52:33 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:52:53 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:53:13 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:53:33 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:53:53 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:54:13 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:54:33 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato2" failed - try 2/3: failed to delete item: Error "Server Error"
2026/02/03 06:54:53 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:55:13 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:55:33 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:55:53 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:56:13 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:56:33 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 06:56:53 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 06:57:13 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 06:57:33 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 06:57:53 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato2" failed - try 3/3: failed to delete item: Error "Server Error"
run.go:133: removing file "potato2" failed: failed to delete item: Error "Server Error"
2026/02/03 06:58:13 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 06:58:33 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 06:58:53 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 06:59:13 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 06:59:33 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 06:59:53 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:00:13 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:00:33 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:00:53 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:01:13 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato3" failed - try 1/3: failed to delete item: Error "Server Error"
2026/02/03 07:01:33 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 07:01:53 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:02:13 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:02:33 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:02:53 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:03:13 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:03:33 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:03:53 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:04:13 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:04:33 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato3" failed - try 2/3: failed to delete item: Error "Server Error"
2026/02/03 07:04:53 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 07:05:13 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:05:33 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:05:53 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:06:13 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:06:33 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:06:53 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:07:13 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:07:33 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:07:53 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato3" failed - try 3/3: failed to delete item: Error "Server Error"
run.go:133: removing file "potato3" failed: failed to delete item: Error "Server Error"
2026/02/03 07:08:13 DEBUG : pacer: Reducing sleep to 10s
2026/02/03 07:08:34 DEBUG : pacer: Reducing sleep to 5s
2026/02/03 07:08:43 DEBUG : pacer: Reducing sleep to 2.5s
2026/02/03 07:08:48 DEBUG : pacer: Reducing sleep to 1.25s
--- FAIL: TestServerSideMove (1682.66s)
=== RUN TestServerSideMoveWithFilter
run.go:185: Remote "drime root 'rclone-test-xiwoluy9gibi'", Local "Local file system at /tmp/rclone2151365684", Modify Window "876000h0m0s"
2026/02/03 07:08:48 DEBUG : Creating backend with remote "TestDrime:rclone-test-cikanif5peko"
2026/02/03 07:08:51 DEBUG : pacer: Reducing sleep to 625ms
2026/02/03 07:08:56 DEBUG : pacer: Reducing sleep to 312.5ms
2026/02/03 07:08:57 DEBUG : pacer: Reducing sleep to 156.25ms
2026/02/03 07:09:02 DEBUG : pacer: Reducing sleep to 78.125ms
2026/02/03 07:09:02 DEBUG : pacer: Reducing sleep to 39.0625ms
2026/02/03 07:09:04 DEBUG : pacer: Reducing sleep to 19.53125ms
2026/02/03 07:09:04 DEBUG : pacer: Reducing sleep to 10ms
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1734
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1925
/usr/local/go/src/runtime/asm_amd64.s:1700
Error: Should be true
Test: TestServerSideMoveWithFilter
Messages: listing wrong, want
empty space (1), potato2 (60), potato3 (68) got
empty space (1), potato2 (60)
fstest.go:203: Not found "potato3"
fstest.go:206:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1734
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1925
Error: Not equal:
expected: 0
actual : 1
Test: TestServerSideMoveWithFilter
Messages: 1 objects not found
sync_test.go:1736: Server side move (if possible) drime root 'rclone-test-xiwoluy9gibi' -> drime root 'rclone-test-cikanif5peko'
2026/02/03 07:09:25 DEBUG : empty space: Excluded (Size Filter)
2026/02/03 07:09:25 DEBUG : empty space: Excluded
2026/02/03 07:09:26 DEBUG : empty space: Excluded (Size Filter)
2026/02/03 07:09:26 DEBUG : empty space: Excluded
2026/02/03 07:09:26 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/03 07:09:26 DEBUG : potato3: size = 68 (drime root 'rclone-test-xiwoluy9gibi')
2026/02/03 07:09:26 DEBUG : potato3: size = 60 (drime root 'rclone-test-cikanif5peko')
2026/02/03 07:09:26 DEBUG : potato3: Sizes differ
2026/02/03 07:09:26 DEBUG : drime root 'rclone-test-cikanif5peko': Waiting for checks to finish
2026/02/03 07:09:26 DEBUG : drime root 'rclone-test-cikanif5peko': Waiting for transfers to finish
2026/02/03 07:09:26 INFO : potato3: Deleted
2026/02/03 07:09:27 ERROR : potato2: Couldn't move: object not found
2026/02/03 07:09:27 ERROR : potato3: Couldn't move: object not found
sync_test.go:1747:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1747
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1925
Error: Received unexpected error:
object not found
Test: TestServerSideMoveWithFilter
2026/02/03 07:09:27 DEBUG : drime root 'rclone-test-cikanif5peko': Purge remote
2026/02/03 07:09:29 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 07:09:29 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/03 07:09:29 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:09:29 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/03 07:09:30 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:09:30 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/03 07:09:30 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:09:30 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/03 07:09:30 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:09:30 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/02/03 07:09:31 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:09:31 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/02/03 07:09:31 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:09:31 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/02/03 07:09:32 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:09:32 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/02/03 07:09:33 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:09:33 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/02/03 07:09:36 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
2026/02/03 07:09:36 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
run.go:130: removing file "potato2" failed - try 1/3: failed to delete item: Error "Server Error"
2026/02/03 07:09:41 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 07:09:41 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/02/03 07:09:51 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:10:11 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:10:31 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:10:51 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:11:11 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:11:31 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:11:51 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:12:11 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:12:31 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato2" failed - try 2/3: failed to delete item: Error "Server Error"
2026/02/03 07:12:51 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 07:13:11 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:13:31 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:13:51 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:14:11 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:14:31 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:14:51 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:15:11 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:15:31 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:15:51 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato2" failed - try 3/3: failed to delete item: Error "Server Error"
run.go:133: removing file "potato2" failed: failed to delete item: Error "Server Error"
2026/02/03 07:16:11 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/03 07:16:11 DEBUG : pacer: low level retry 1/10 (error Error "500 Internal Server Error (500): \r\n500 Internal Server Error\r\n\r\n500 Internal Server Error
\r\n
nginx\r\n\r\n\r\n")
2026/02/03 07:16:31 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:16:51 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:17:11 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:17:31 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:17:51 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:18:11 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:18:31 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:18:51 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:19:11 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato3" failed - try 1/3: failed to delete item: Error "Server Error"
2026/02/03 07:19:31 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 07:19:51 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:20:11 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:20:31 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:20:51 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:21:11 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:21:31 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:21:51 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:22:11 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:22:31 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato3" failed - try 2/3: failed to delete item: Error "Server Error"
2026/02/03 07:22:51 DEBUG : pacer: low level retry 1/10 (error Error "Server Error")
2026/02/03 07:23:11 DEBUG : pacer: low level retry 2/10 (error Error "Server Error")
2026/02/03 07:23:31 DEBUG : pacer: low level retry 3/10 (error Error "Server Error")
2026/02/03 07:23:51 DEBUG : pacer: low level retry 4/10 (error Error "Server Error")
2026/02/03 07:24:11 DEBUG : pacer: low level retry 5/10 (error Error "Server Error")
2026/02/03 07:24:31 DEBUG : pacer: low level retry 6/10 (error Error "Server Error")
2026/02/03 07:24:51 DEBUG : pacer: low level retry 7/10 (error Error "Server Error")
2026/02/03 07:25:11 DEBUG : pacer: low level retry 8/10 (error Error "Server Error")
2026/02/03 07:25:31 DEBUG : pacer: low level retry 9/10 (error Error "Server Error")
2026/02/03 07:25:51 DEBUG : pacer: low level retry 10/10 (error Error "Server Error")
run.go:130: removing file "potato3" failed - try 3/3: failed to delete item: Error "Server Error"
run.go:133: removing file "potato3" failed: failed to delete item: Error "Server Error"
2026/02/03 07:26:11 DEBUG : pacer: Reducing sleep to 10s
--- FAIL: TestServerSideMoveWithFilter (1042.90s)
FAIL
2026/02/03 07:26:11 DEBUG : drime root 'rclone-test-xiwoluy9gibi': Purge remote
2026/02/03 07:26:32 DEBUG : pacer: Reducing sleep to 5s
"./sync.test -test.v -test.timeout 2h0m0s -remote TestDrime: -verbose -test.run '^(TestCopy|TestCopyAfterDelete|TestCopyDeleteBefore|TestCopyEmptyDirectories|TestCopyNoEmptyDirectories|TestCopyNoTraverse|TestCopyOverSelf|TestCopyWithFilesFromAndNoTraverse|TestMoveOverSelf|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteBefore|TestSyncDeleteDuring|TestSyncEmptyDirectories|TestSyncIgnoreErrors|TestSyncIgnoreExisting|TestSyncNoEmptyDirectories|TestSyncWithTrackRenamesStrategyLeaf)$'" - Finished ERROR in 1h8m17.344958342s (try 4/5): exit status 1: Failed [TestCopyNoTraverse TestCopyWithFilesFromAndNoTraverse TestCopyEmptyDirectories TestCopyNoEmptyDirectories TestSyncEmptyDirectories TestServerSideCopy TestCopyOverSelf TestServerSideCopyOverSelf TestServerSideMoveOverSelf TestCopyAfterDelete TestSyncIgnoreErrors TestSyncAfterAddingAFile TestSyncAfterRemovingAFileAndAddingAFile TestSyncAfterRemovingAFileAndAddingAFileSubDir TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring TestCopyDeleteBefore TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestMoveWithoutDeleteEmptySrcDirs TestMoveWithIgnoreExisting TestServerSideMove TestServerSideMoveWithFilter]