"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyEmptyDirectories|TestCopyNoTraverse|TestCopyWithFilesFrom|TestMoveOverSelf|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveLocal|TestServerSideMoveOverSelf|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingModtimeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncBasedOnCheckSum|TestSyncCompareDest|TestSyncDoesntUpdateModtime|TestSyncEmptyDirectories|TestSyncIgnoreErrors|TestSyncIgnoreTimes|TestSyncNoEmptyDirectories|TestSyncSizeOnly|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 2/5) 2026/08/04 03:56:07 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yuvuhel6sefi" 2026/08/04 03:56:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/04 03:56:07 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Using cached web token 2026/08/04 03:56:08 DEBUG : Creating backend with remote "/tmp/rclone457739820" === RUN TestCopyNoTraverse run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 03:56:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/08/04 03:56:09 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 03:56:09 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 03:56:12 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:12 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 03:56:12 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:12 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 03:56:13 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:13 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 03:56:13 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:13 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 03:56:15 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:17 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:19 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:21 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:23 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:25 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:27 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:56:29 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:56:32 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 03:56:33 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:56:33 DEBUG : sub dir/hello world: size = 11 OK 2026/08/04 03:56:33 INFO : sub dir/hello world: Copied (new) 2026/08/04 03:56:34 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:56:35 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:56:35 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:56:36 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 03:56:37 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:56:37 DEBUG : pacer: Reducing sleep to 200ms --- PASS: TestCopyNoTraverse (30.61s) === RUN TestCopyWithFilesFrom run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 03:56:39 DEBUG : potato2: Need to transfer - File not found at Destination 2026/08/04 03:56:39 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 03:56:39 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 03:56:41 DEBUG : potato2: size = 11 OK 2026/08/04 03:56:41 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (4.34s) === RUN TestCopyEmptyDirectories run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 03:56:43 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2026/08/04 03:56:43 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/08/04 03:56:43 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2026/08/04 03:56:43 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/08/04 03:56:44 INFO : sub dir2: Making directory 2026/08/04 03:56:45 INFO : sub dir: Making directory 2026/08/04 03:56:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/08/04 03:56:47 INFO : sub dir2/sub sub dir2: Making directory 2026/08/04 03:56:49 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 03:56:49 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 03:56:50 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:56:50 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:56:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 03:56:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 03:56:52 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 03:56:54 DEBUG : sub dir/hello world: size = 11 OK 2026/08/04 03:56:54 INFO : sub dir/hello world: Copied (new) 2026/08/04 03:56:55 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (18.62s) === RUN TestSyncEmptyDirectories run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 03:57:02 DEBUG : sub dir2: Making directory with metadata 2026/08/04 03:57:02 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/08/04 03:57:02 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/08/04 03:57:02 INFO : sub dir2: Making directory 2026/08/04 03:57:04 INFO : sub dir: Making directory 2026/08/04 03:57:04 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:04 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 03:57:04 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:04 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 03:57:05 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:05 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 03:57:05 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:05 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 03:57:07 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:09 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:11 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:13 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:15 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:17 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/08/04 03:57:17 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 03:57:17 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 03:57:19 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:21 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:23 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:25 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:27 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:57:29 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:57:32 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 03:57:33 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:57:34 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:57:36 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:57:36 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:57:36 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:57:36 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 03:57:36 DEBUG : sub dir/hello world: size = 11 OK 2026/08/04 03:57:36 INFO : sub dir/hello world: Copied (new) 2026/08/04 03:57:36 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting files as there were IO errors 2026/08/04 03:57:36 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:513: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:513 Error: Received unexpected error: failed to make directory: CreateDir failed: invalid character '<' looking for beginning of value Test: TestSyncEmptyDirectories 2026/08/04 03:57:37 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:57:37 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestSyncEmptyDirectories (39.89s) === RUN TestSyncNoEmptyDirectories run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 03:57:42 INFO : sub dir2: Making directory 2026/08/04 03:57:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/08/04 03:57:42 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 03:57:42 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 03:57:46 DEBUG : sub dir/hello world: size = 11 OK 2026/08/04 03:57:46 INFO : sub dir/hello world: Copied (new) 2026/08/04 03:57:46 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting files as there were IO errors 2026/08/04 03:57:46 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:597: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:597 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncNoEmptyDirectories run.go:186: removing dir "sub dir" failed - try 1/3: sleeping 1s: directory not empty run.go:186: removing dir "sub dir" failed - try 2/3: sleeping 1.5s: directory not empty --- FAIL: TestSyncNoEmptyDirectories (10.25s) === RUN TestServerSideCopyOverSelf run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 03:57:56 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:57:56 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:57:56 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 03:57:57 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-watulum9qoba" 2026/08/04 03:57:57 DEBUG : Linkbox root 'rclone-test-watulum9qoba': Using cached web token sync_test.go:656: Server side copy (if possible) Linkbox root 'rclone-test-yuvuhel6sefi' -> Linkbox root 'rclone-test-watulum9qoba' 2026/08/04 03:57:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/08/04 03:57:59 DEBUG : Linkbox root 'rclone-test-watulum9qoba': Waiting for checks to finish 2026/08/04 03:57:59 DEBUG : Linkbox root 'rclone-test-watulum9qoba': Waiting for transfers to finish 2026/08/04 03:57:59 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1272h55m22.761893158s different from this computer 2026/08/04 03:58:05 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:58:05 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:58:06 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 03:58:06 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:06 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 03:58:06 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:06 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 03:58:07 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:07 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 03:58:07 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:07 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 03:58:09 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:11 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:13 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:15 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:17 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:19 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:19 DEBUG : sub dir/hello world: Received error: Update failed to read object: getting files failed: invalid character '<' looking for beginning of value - low level retry 0/10 2026/08/04 03:58:21 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:23 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:25 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:27 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:58:29 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:58:29 DEBUG : sub dir/hello world: Update: removing old file 2026/08/04 03:58:32 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 03:58:33 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:58:35 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:58:35 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:58:35 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:58:36 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:58:36 DEBUG : sub dir/hello world: size = 11 OK 2026/08/04 03:58:36 INFO : sub dir/hello world: Copied (new) 2026/08/04 03:58:36 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 03:58:37 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:58:37 DEBUG : sub dir/hello world: Update: removing old file 2026/08/04 03:58:40 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:58:40 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:58:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 03:58:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 03:58:43 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 03:58:43 DEBUG : Linkbox root 'rclone-test-watulum9qoba': Waiting for checks to finish 2026/08/04 03:58:43 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-yuvuhel6sefi') 2026/08/04 03:58:43 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-watulum9qoba') 2026/08/04 03:58:43 DEBUG : sub dir/hello world: Sizes differ 2026/08/04 03:58:43 DEBUG : Linkbox root 'rclone-test-watulum9qoba': Waiting for transfers to finish 2026/08/04 03:58:43 DEBUG : sub dir/hello world: Update: removing old file 2026/08/04 03:58:46 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:58:47 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:58:47 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 03:58:48 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 03:58:49 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 03:58:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 03:58:54 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 03:59:01 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 03:59:13 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:13 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 03:59:14 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:14 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 03:59:14 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:14 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 03:59:15 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:15 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 03:59:16 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:18 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:20 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:23 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:25 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:27 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:27 DEBUG : sub dir/hello world: Received error: Update failed to read object: getting files failed: invalid character '<' looking for beginning of value - low level retry 0/10 2026/08/04 03:59:29 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:59:31 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:59:33 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 03:59:35 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:59:36 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:59:36 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:59:36 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:59:36 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:59:37 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:59:37 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 03:59:38 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 03:59:38 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 03:59:39 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:59:39 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 03:59:41 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 03:59:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 03:59:44 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 03:59:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 04:00:04 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/04 04:00:29 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:00:29 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:00:30 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:00:30 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:00:30 DEBUG : pacer: Reducing sleep to 600ms 2026/08/04 04:00:30 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 51.2s (10/10) 2026/08/04 04:01:21 ERROR : sub dir/hello world: Failed to copy: object not found sync_test.go:669: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:669 Error: Received unexpected error: object not found Test: TestServerSideCopyOverSelf 2026/08/04 04:01:21 DEBUG : Linkbox root 'rclone-test-watulum9qoba': Purge remote 2026/08/04 04:01:21 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:01:21 DEBUG : pacer: Rate limited, increasing sleep to 1.2s 2026/08/04 04:01:22 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:01:22 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:01:23 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:01:25 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:01:27 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:01:29 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:01:32 DEBUG : pacer: Reducing sleep to 1.5s run.go:186: removing dir "sub dir" failed - try 1/3: sleeping 1s: directory not empty --- FAIL: TestServerSideCopyOverSelf (225.36s) === RUN TestMoveOverSelf run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:01:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:01:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:01:42 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:01:43 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone457739820) 2026/08/04 04:01:43 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-yuvuhel6sefi') 2026/08/04 04:01:43 DEBUG : sub dir/hello world: Sizes differ 2026/08/04 04:01:43 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:01:43 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:01:43 DEBUG : sub dir/hello world: Update: removing old file 2026/08/04 04:01:47 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:01:47 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:01:47 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:01:48 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:01:49 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 04:01:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 04:01:54 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 04:02:01 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 04:02:14 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:14 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:02:14 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:14 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:02:14 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:14 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:02:15 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:15 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:02:17 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:19 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:21 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:23 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:25 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:27 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:27 DEBUG : sub dir/hello world: Received error: Update failed to read object: getting files failed: invalid character '<' looking for beginning of value - low level retry 0/10 2026/08/04 04:02:29 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:02:31 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:02:33 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:02:35 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:02:36 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:02:36 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:02:37 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:02:37 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:02:37 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:02:37 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:02:38 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:02:38 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:02:39 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:02:39 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 04:02:41 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 04:02:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 04:02:44 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 04:02:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 04:03:04 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/04 04:03:30 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 51.2s (10/10) 2026/08/04 04:04:21 ERROR : sub dir/hello world: Failed to copy: object not found 2026/08/04 04:04:21 ERROR : sub dir/hello world: Not deleting source as copy failed: object not found sync_test.go:685: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:685 Error: Received unexpected error: object not found Test: TestMoveOverSelf run.go:186: removing dir "sub dir" failed - try 1/3: sleeping 1s: directory not empty --- FAIL: TestMoveOverSelf (169.23s) === RUN TestServerSideMoveOverSelf run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:04:31 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-godunul9zisi" 2026/08/04 04:04:31 DEBUG : Config file has changed externally - reloading 2026/08/04 04:04:31 DEBUG : Linkbox root 'rclone-test-godunul9zisi': Using cached web token 2026/08/04 04:04:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:04:31 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:04:31 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:04:31 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:04:32 DEBUG : pacer: Reducing sleep to 600ms 2026/08/04 04:04:32 DEBUG : pacer: Reducing sleep to 450ms sync_test.go:701: Server side copy (if possible) Linkbox root 'rclone-test-yuvuhel6sefi' -> Linkbox root 'rclone-test-godunul9zisi' 2026/08/04 04:04:33 DEBUG : pacer: Reducing sleep to 337.5ms 2026/08/04 04:04:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/08/04 04:04:33 DEBUG : Linkbox root 'rclone-test-godunul9zisi': Waiting for checks to finish 2026/08/04 04:04:33 DEBUG : Linkbox root 'rclone-test-godunul9zisi': Waiting for transfers to finish 2026/08/04 04:04:34 DEBUG : pacer: Reducing sleep to 253.125ms 2026/08/04 04:04:35 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 04:04:39 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:04:39 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:04:39 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:04:40 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:04:41 DEBUG : sub dir/hello world: size = 11 OK 2026/08/04 04:04:41 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:292: Sleeping for 6s just to make sure 2026/08/04 04:04:49 DEBUG : sub dir/hello world: Update: removing old file 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:710 Error: Should be true Test: TestServerSideMoveOverSelf Messages: listing wrong, want sub dir/hello world (17) got sub dir/hello world(1) (17) 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:710 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestServerSideMoveOverSelf Messages: Unexpected file "sub dir/hello world(1)" 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:710 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Not equal: expected: 0 actual : 1 Test: TestServerSideMoveOverSelf Messages: 1 objects not found 2026/08/04 04:05:02 DEBUG : sub dir/hello world(1): Need to transfer - File not found at Destination 2026/08/04 04:05:02 DEBUG : Linkbox root 'rclone-test-godunul9zisi': Waiting for checks to finish 2026/08/04 04:05:02 DEBUG : Linkbox root 'rclone-test-godunul9zisi': Waiting for transfers to finish 2026/08/04 04:05:05 DEBUG : sub dir/hello world(1): Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:05:05 DEBUG : sub dir/hello world(1): Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:05:05 DEBUG : sub dir/hello world(1): Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:05:06 DEBUG : sub dir/hello world(1): size = 17 OK 2026/08/04 04:05:06 INFO : sub dir/hello world(1): Copied (new) 2026/08/04 04:05:07 INFO : sub dir/hello world(1): Deleted 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/08/04 04:05:16 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:16 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:05:16 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:16 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:05:16 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:16 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:05:17 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:17 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:05:19 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:21 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:23 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:25 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:27 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:29 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:29 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:282: Error listing: getting files failed: invalid character '<' looking for beginning of value 2026/08/04 04:05:29 DEBUG : Linkbox root 'rclone-test-godunul9zisi': Purge remote 2026/08/04 04:05:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:05:34 DEBUG : pacer: Reducing sleep to 1.5s --- FAIL: TestServerSideMoveOverSelf (69.41s) === RUN TestSyncBasedOnCheckSum run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:05:36 DEBUG : check sum: Need to transfer - File not found at Destination 2026/08/04 04:05:36 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:05:36 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:05:38 DEBUG : check sum: size = 1 OK 2026/08/04 04:05:38 INFO : check sum: Copied (new) 2026/08/04 04:05:38 DEBUG : Waiting for deletions to finish 2026/08/04 04:05:39 DEBUG : check sum: size = 1 OK 2026/08/04 04:05:39 NOTICE: Linkbox root 'rclone-test-yuvuhel6sefi': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2026/08/04 04:05:39 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:05:39 DEBUG : check sum: Size of src and dst objects identical 2026/08/04 04:05:39 DEBUG : check sum: Unchanged skipping 2026/08/04 04:05:39 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:05:39 DEBUG : Waiting for deletions to finish 2026/08/04 04:05:39 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: TestSyncBasedOnCheckSum (12.23s) === RUN TestSyncSizeOnly run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:05:49 DEBUG : sizeonly: Need to transfer - File not found at Destination 2026/08/04 04:05:49 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:05:49 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:05:51 DEBUG : sizeonly: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:05:51 DEBUG : sizeonly: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:05:51 DEBUG : sizeonly: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:05:52 DEBUG : sizeonly: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:05:53 DEBUG : sizeonly: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 04:05:55 DEBUG : sizeonly: size = 6 OK 2026/08/04 04:05:55 INFO : sizeonly: Copied (new) 2026/08/04 04:05:55 DEBUG : Waiting for deletions to finish 2026/08/04 04:05:55 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:05:55 DEBUG : sizeonly: size = 6 OK 2026/08/04 04:05:55 DEBUG : sizeonly: Sizes identical 2026/08/04 04:05:55 DEBUG : sizeonly: Unchanged skipping 2026/08/04 04:05:55 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:05:55 DEBUG : Waiting for deletions to finish 2026/08/04 04:05:55 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (8.68s) === RUN TestSyncIgnoreTimes run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:06:00 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:06:00 DEBUG : existing: size = 6 OK 2026/08/04 04:06:00 DEBUG : existing: Sizes identical 2026/08/04 04:06:00 DEBUG : existing: Unchanged skipping 2026/08/04 04:06:00 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:06:00 DEBUG : Waiting for deletions to finish 2026/08/04 04:06:00 INFO : There was nothing to transfer 2026/08/04 04:06:00 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:06:00 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2026/08/04 04:06:00 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:06:00 DEBUG : existing: Update: removing old file 2026/08/04 04:06:03 DEBUG : existing: size = 6 OK 2026/08/04 04:06:03 INFO : existing: Copied (replaced existing) 2026/08/04 04:06:03 DEBUG : Waiting for deletions to finish run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestSyncIgnoreTimes Messages: listing wrong, want got existing (6), existing(1) (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestSyncIgnoreTimes Messages: Unexpected file "existing" 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestSyncIgnoreTimes Messages: Unexpected file "existing(1)" --- FAIL: TestSyncIgnoreTimes (18.15s) === RUN TestSyncIgnoreErrors run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:06:15 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:15 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:06:15 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:15 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:06:16 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:16 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:06:17 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:17 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:06:18 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:20 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:22 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:24 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:26 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:28 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "b/potato" to Linkbox root 'rclone-test-yuvuhel6sefi': 1/10 (getting files failed: invalid character '<' looking for beginning of value) 2026/08/04 04:06:30 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:06:33 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:06:34 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:06:37 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:06:37 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:06:38 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:06:40 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:06:40 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:06:40 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:06:42 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 04:06:44 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:378 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:964 Error: Should be true Test: TestSyncIgnoreErrors Messages: listing wrong, want b/potato (21), c/non empty space (5) got b/potato (21), c/non empty space (5), existing (6), existing(1) (6) 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:378 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:964 Error: Should be true Test: TestSyncIgnoreErrors Messages: Unexpected file "existing" 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:378 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:964 Error: Should be true Test: TestSyncIgnoreErrors Messages: Unexpected file "existing(1)" 2026/08/04 04:06:56 DEBUG : a/potato2: Need to transfer - File not found at Destination 2026/08/04 04:06:57 DEBUG : c/non empty space: size = 5 OK 2026/08/04 04:06:57 DEBUG : c/non empty space: Sizes identical 2026/08/04 04:06:57 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:06:57 DEBUG : c/non empty space: Unchanged skipping 2026/08/04 04:06:57 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:07:00 DEBUG : a/potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:07:01 DEBUG : a/potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:07:01 DEBUG : a/potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:07:02 DEBUG : a/potato2: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:07:03 DEBUG : a/potato2: size = 60 OK 2026/08/04 04:07:03 INFO : a/potato2: Copied (new) 2026/08/04 04:07:03 DEBUG : Waiting for deletions to finish 2026/08/04 04:07:03 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:07:04 INFO : b/potato: Deleted 2026/08/04 04:07:04 INFO : existing(1): Deleted 2026/08/04 04:07:04 INFO : d: Removing directory 2026/08/04 04:07:06 INFO : b: Removing directory 2026/08/04 04:07:08 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': deleted 2 directories sync_test.go:980: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:980 Error: Received unexpected error: failed to delete 1 files Test: TestSyncIgnoreErrors 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:378 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:994 Error: Should be true Test: TestSyncIgnoreErrors Messages: listing wrong, want a/potato2 (60), c/non empty space (5) got a/potato2 (60), c/non empty space (5), existing (6) 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:378 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:994 Error: Should be true Test: TestSyncIgnoreErrors Messages: Unexpected file "existing" run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:07:21 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:21 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:07:21 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:21 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:07:21 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:21 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:07:22 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:22 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:07:24 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:26 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:28 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:30 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:32 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:07:34 DEBUG : pacer: Reducing sleep to 1.5s run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:07:36 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:07:37 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:07:40 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:07:41 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:07:41 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:07:43 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:07:43 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:07:44 DEBUG : pacer: Reducing sleep to 200ms 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestSyncIgnoreErrors Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestSyncIgnoreErrors Messages: Unexpected file "existing" --- FAIL: TestSyncIgnoreErrors (97.56s) === RUN TestSyncAfterChangingModtimeOnly run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1015 Error: Should be true Test: TestSyncAfterChangingModtimeOnly Messages: listing wrong, want empty space (1) got empty space (1), existing (6) 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1015 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncAfterChangingModtimeOnly Messages: Unexpected file "existing" 2026/08/04 04:08:04 DEBUG : empty space: size = 1 OK 2026/08/04 04:08:04 DEBUG : empty space: Sizes identical 2026/08/04 04:08:04 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:08:04 DEBUG : empty space: Unchanged skipping 2026/08/04 04:08:04 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:08:04 DEBUG : Waiting for deletions to finish 2026/08/04 04:08:04 NOTICE: existing: Skipped delete as --dry-run is set (size 6) 2026/08/04 04:08:04 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: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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1026 Error: Should be true Test: TestSyncAfterChangingModtimeOnly Messages: listing wrong, want empty space (1) got empty space (1), existing (6) 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1026 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncAfterChangingModtimeOnly Messages: Unexpected file "existing" 2026/08/04 04:08:13 DEBUG : empty space: size = 1 OK 2026/08/04 04:08:13 DEBUG : empty space: Sizes identical 2026/08/04 04:08:13 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:08:13 DEBUG : empty space: Unchanged skipping 2026/08/04 04:08:13 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:08:13 DEBUG : Waiting for deletions to finish 2026/08/04 04:08:13 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:08:13 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:1033: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1033 Error: Received unexpected error: failed to delete 1 files Test: TestSyncAfterChangingModtimeOnly run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/08/04 04:08:19 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:19 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:08:20 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:20 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:08:20 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:20 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:08:21 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:08:22 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:24 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:26 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:28 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:30 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:32 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:08:32 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:282: Error listing: getting files failed: invalid character '<' looking for beginning of value --- FAIL: TestSyncAfterChangingModtimeOnly (39.76s) === RUN TestSyncDoesntUpdateModtime run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" sync_test.go:1072: Can't run this test on fs which doesn't support mod time 2026/08/04 04:08:35 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:08:37 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:08:38 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:08:39 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:08:41 DEBUG : pacer: Reducing sleep to 474.609375ms run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:08:42 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/08/04 04:08:43 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:08:43 DEBUG : pacer: Reducing sleep to 200.225829ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/08/04 04:08:46 DEBUG : pacer: Reducing sleep to 200ms 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1259 /usr/local/go/src/testing/testing.go:1235 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1072 Error: Should be true Test: TestSyncDoesntUpdateModtime Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1259 /usr/local/go/src/testing/testing.go:1235 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1072 Error: Should be true Test: TestSyncDoesntUpdateModtime Messages: Unexpected file "existing" --- FAIL: TestSyncDoesntUpdateModtime (17.40s) === RUN TestSyncAfterChangingContentsOnly run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" sync_test.go:1136: ModTimeNotSupported so forcing file to be a different size 2026/08/04 04:08:52 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:08:53 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1142 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: listing wrong, want potato (36) got existing (6), potato (36) 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1142 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: Unexpected file "existing" 2026/08/04 04:09:02 DEBUG : potato: size = 21 (Local file system at /tmp/rclone457739820) 2026/08/04 04:09:02 DEBUG : potato: size = 36 (Linkbox root 'rclone-test-yuvuhel6sefi') 2026/08/04 04:09:02 DEBUG : potato: Sizes differ 2026/08/04 04:09:02 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:09:02 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:09:02 DEBUG : potato: Update: removing old file 2026/08/04 04:09:05 DEBUG : potato: size = 21 (Local file system at /tmp/rclone457739820) 2026/08/04 04:09:05 DEBUG : potato: size = 36 (Linkbox root 'rclone-test-yuvuhel6sefi') 2026/08/04 04:09:05 ERROR : potato: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone457739820) 21 vs dst(Linkbox root 'rclone-test-yuvuhel6sefi') 36 2026/08/04 04:09:05 INFO : potato: Removing failed copy 2026/08/04 04:09:05 INFO : potato: Failed to remove failed copy: could not Remove: Linkbox error 403: not permit 2026/08/04 04:09:05 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting files as there were IO errors 2026/08/04 04:09:05 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:1148: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1148 Error: Received unexpected error: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone457739820) 21 vs dst(Linkbox root 'rclone-test-yuvuhel6sefi') 36 Test: TestSyncAfterChangingContentsOnly run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit run.go:172: removing file "potato" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "potato" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "potato" failed: could not Remove: Linkbox error 403: not permit 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1148 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: listing wrong, want got existing (6), potato(1) (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/run.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1148 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: Unexpected file "existing" 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1148 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: Unexpected file "potato(1)" --- FAIL: TestSyncAfterChangingContentsOnly (30.31s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:09:20 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:20 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:09:20 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:20 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:09:21 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:21 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:09:22 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:22 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:09:23 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:25 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:27 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:29 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:31 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:09:33 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "potato" to Linkbox root 'rclone-test-yuvuhel6sefi': 1/10 (getting files failed: invalid character '<' looking for beginning of value) 2026/08/04 04:09:36 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:09:37 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:09:39 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:09:41 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:09:41 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:09:41 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:09:42 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:09:42 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:09:43 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:09:43 DEBUG : potato: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:09:43 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:09:43 DEBUG : potato: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:09:44 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 04:09:44 DEBUG : potato: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 04:09:46 DEBUG : potato: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 04:09:49 DEBUG : potato: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 04:09:56 DEBUG : potato: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 04:10:09 DEBUG : potato: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/04 04:10:35 DEBUG : potato: Trying to read object after upload: try again in 51.2s (10/10) run.go:303: Failed to put "potato" to "Linkbox root 'rclone-test-yuvuhel6sefi'": object not found run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:11:28 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:11:28 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:11:28 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:11:28 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:11:28 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:11:28 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:11:29 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:11:29 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:11:31 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:11:33 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:11:35 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:11:37 DEBUG : pacer: Reducing sleep to 1.5s run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:11:39 DEBUG : pacer: Reducing sleep to 1.125s run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:11:41 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:11:43 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:11:43 DEBUG : pacer: Reducing sleep to 474.609375ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/08/04 04:11:44 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:11:45 DEBUG : pacer: Reducing sleep to 266.967773ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/08/04 04:11:47 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:11:47 DEBUG : pacer: Reducing sleep to 200ms 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /usr/local/go/src/testing/testing.go:1228 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:303 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:310 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1160 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileDryRun Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /usr/local/go/src/testing/testing.go:1228 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:303 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:310 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1160 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileDryRun Messages: Unexpected file "existing" --- FAIL: TestSyncAfterRemovingAFileAndAddingAFileDryRun (151.01s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:11:54 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:11:56 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:11:56 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:11:57 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:11:57 DEBUG : empty space: Trying to read object after upload: try again in 800ms (4/10) 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:358 /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:1771 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFile Messages: listing wrong, want empty space (1), potato (21) got empty space (1), existing (6), 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:358 /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: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFile Messages: Unexpected file "existing" 2026/08/04 04:12:08 DEBUG : empty space: size = 1 OK 2026/08/04 04:12:08 DEBUG : empty space: Sizes identical 2026/08/04 04:12:08 DEBUG : potato2: Need to transfer - File not found at Destination 2026/08/04 04:12:08 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:12:08 DEBUG : empty space: Unchanged skipping 2026/08/04 04:12:08 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:12:10 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:12:10 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:12:11 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:12:11 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:12:12 DEBUG : potato2: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 04:12:14 DEBUG : potato2: size = 60 OK 2026/08/04 04:12:14 INFO : potato2: Copied (new) 2026/08/04 04:12:14 DEBUG : Waiting for deletions to finish 2026/08/04 04:12:14 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:12:16 INFO : potato: Deleted 2026/08/04 04:12:16 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:1187: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1187 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194 Error: Received unexpected error: failed to delete 1 files Test: TestSyncAfterRemovingAFileAndAddingAFile run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:12:18 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:18 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:12:19 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:19 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:12:19 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:19 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:12:20 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:20 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:12:21 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:23 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:25 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:27 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:29 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:31 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: invalid character '<' looking for beginning of value 2026/08/04 04:12:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:12:37 DEBUG : pacer: Reducing sleep to 1.5s run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:12:40 DEBUG : pacer: Reducing sleep to 1.125s run.go:172: removing file "potato" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:12:41 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "potato" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:12:43 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "potato" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:12:45 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:12:45 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/08/04 04:12:46 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:12:46 DEBUG : pacer: Reducing sleep to 200.225829ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/08/04 04:12:49 DEBUG : pacer: Reducing sleep to 200ms 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1187 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFile Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1187 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1194 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFile Messages: Unexpected file "existing" --- FAIL: TestSyncAfterRemovingAFileAndAddingAFile (61.86s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:12:57 DEBUG : b/potato: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:12:57 DEBUG : b/potato: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:12:58 DEBUG : b/potato: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:13:02 INFO : d: Making directory 2026/08/04 04:13:04 INFO : d/e: 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:378 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1217 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1262 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileSubDir Messages: listing wrong, want b/potato (21), c/non empty space (5) got b/potato (21), c/non empty space (5), existing (6) 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:378 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1217 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1262 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileSubDir Messages: Unexpected file "existing" 2026/08/04 04:13:16 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:16 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:13:16 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:16 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:13:16 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:16 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:13:17 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:17 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:13:19 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:21 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:23 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:25 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:27 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:29 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:29 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': error reading destination root directory: getting files failed: invalid character '<' looking for beginning of value 2026/08/04 04:13:29 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:13:29 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:13:29 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting files as there were IO errors 2026/08/04 04:13:29 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:1234: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1234 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1262 Error: Received unexpected error: getting files failed: invalid character '<' looking for beginning of value Test: TestSyncAfterRemovingAFileAndAddingAFileSubDir 2026/08/04 04:13:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:33 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:35 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:37 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:13:39 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:13:41 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:13:43 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:13:44 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:13:45 DEBUG : pacer: Reducing sleep to 474.609375ms run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:13:46 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:13:47 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:13:47 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:13:47 DEBUG : pacer: Reducing sleep to 200ms 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1234 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1262 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileSubDir Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1234 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1262 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileSubDir Messages: Unexpected file "existing" --- FAIL: TestSyncAfterRemovingAFileAndAddingAFileSubDir (71.40s) === RUN TestSyncWithTrackRenames run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" sync_test.go:1569: Can track renames: false 2026/08/04 04:14:04 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': Ignoring --track-renames as the destination does not support server-side move or copy 2026/08/04 04:14:04 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': Ignoring --track-renames as the source and destination do not have a common hash 2026/08/04 04:14:05 DEBUG : potato: Need to transfer - File not found at Destination 2026/08/04 04:14:05 DEBUG : yam: Need to transfer - File not found at Destination 2026/08/04 04:14:05 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:14:05 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:14:07 DEBUG : yam: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:14:08 DEBUG : potato: size = 14 OK 2026/08/04 04:14:08 INFO : potato: Copied (new) 2026/08/04 04:14:08 DEBUG : yam: size = 11 OK 2026/08/04 04:14:08 INFO : yam: Copied (new) 2026/08/04 04:14:08 DEBUG : Waiting for deletions to finish 2026/08/04 04:14:08 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:14:08 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:1576: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1576 Error: Received unexpected error: failed to delete 1 files Test: TestSyncWithTrackRenames run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 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/08/04 04:14:18 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:18 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:14:18 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:18 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:14:18 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:18 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:14:19 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:19 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:14:21 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:23 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:25 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:27 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:29 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:31 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:31 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:282: Error listing: getting files failed: invalid character '<' looking for beginning of value --- FAIL: TestSyncWithTrackRenames (26.38s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" sync_test.go:1641: Can track renames: false 2026/08/04 04:14:31 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': Ignoring --track-renames as the destination does not support server-side move or copy 2026/08/04 04:14:31 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': Ignoring --track-renames as either the source or destination do not support modtime 2026/08/04 04:14:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:37 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:14:39 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:14:41 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:14:41 DEBUG : potato: Need to transfer - File not found at Destination 2026/08/04 04:14:41 DEBUG : yam: Need to transfer - File not found at Destination 2026/08/04 04:14:41 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:14:41 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:14:42 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:14:44 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:14:44 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:14:45 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:14:47 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:14:47 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:14:47 DEBUG : potato: size = 14 OK 2026/08/04 04:14:47 INFO : potato: Copied (new) 2026/08/04 04:14:47 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 04:14:47 DEBUG : yam: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:14:48 DEBUG : yam: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:14:48 DEBUG : yam: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:14:49 DEBUG : yam: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:14:50 DEBUG : yam: size = 11 OK 2026/08/04 04:14:50 INFO : yam: Copied (new) 2026/08/04 04:14:50 DEBUG : Waiting for deletions to finish 2026/08/04 04:14:50 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:14:50 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:1648: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1648 Error: Received unexpected error: failed to delete 1 files Test: TestSyncWithTrackRenamesStrategyModtime run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1648 Error: Should be true Test: TestSyncWithTrackRenamesStrategyModtime Messages: listing wrong, want got existing (6), 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1648 Error: Should be true Test: TestSyncWithTrackRenamesStrategyModtime Messages: Unexpected file "existing" 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1648 Error: Should be true Test: TestSyncWithTrackRenamesStrategyModtime Messages: Unexpected file "yam" --- FAIL: TestSyncWithTrackRenamesStrategyModtime (33.39s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" sync_test.go:1680: Can track renames: false 2026/08/04 04:15:04 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': Ignoring --track-renames as the destination does not support server-side move or copy 2026/08/04 04:15:05 DEBUG : potato: Need to transfer - File not found at Destination 2026/08/04 04:15:05 DEBUG : sub/yam: Need to transfer - File not found at Destination 2026/08/04 04:15:05 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:15:05 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:15:09 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:15:09 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:15:09 DEBUG : sub/yam: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:15:09 DEBUG : sub/yam: size = 11 OK 2026/08/04 04:15:09 INFO : sub/yam: Copied (new) 2026/08/04 04:15:10 DEBUG : potato: size = 14 OK 2026/08/04 04:15:10 INFO : potato: Copied (new) 2026/08/04 04:15:10 DEBUG : Waiting for deletions to finish 2026/08/04 04:15:10 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:15:10 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors sync_test.go:1687: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1687 Error: Received unexpected error: failed to delete 1 files Test: TestSyncWithTrackRenamesStrategyLeaf run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:15:15 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:15 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:15:15 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:15 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:15:15 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:15 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:15:16 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:16 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:15:18 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:20 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:22 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:24 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:26 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:28 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:28 ERROR : sub: error listing: getting files failed: invalid character '<' looking for beginning of value run.go:182: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:182 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1687 Error: Received unexpected error: getting files failed: invalid character '<' looking for beginning of value Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (23.35s) === RUN TestServerSideMoveLocal run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:352 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1798 Error: Should be true Test: TestServerSideMoveLocal Messages: listing wrong, want dir1/file1.txt (5), dir2/file2.txt (11) got dir1/file1.txt (5), dir2/file2.txt (11), potato (14), sub/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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:352 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1798 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestServerSideMoveLocal 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:352 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1798 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestServerSideMoveLocal Messages: Unexpected file "sub/yam" 2026/08/04 04:15:35 DEBUG : Creating backend with remote "/tmp/rclone457739820/dir1" 2026/08/04 04:15:35 DEBUG : Config file has changed externally - reloading 2026/08/04 04:15:35 DEBUG : Creating backend with remote "/tmp/rclone457739820/dir2" 2026/08/04 04:15:35 DEBUG : Local file system at /tmp/rclone457739820/dir2: Using server-side directory move 2026/08/04 04:15:35 INFO : Local file system at /tmp/rclone457739820/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2026/08/04 04:15:35 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/08/04 04:15:35 DEBUG : Local file system at /tmp/rclone457739820/dir2: Waiting for checks to finish 2026/08/04 04:15:35 DEBUG : Local file system at /tmp/rclone457739820/dir2: Waiting for transfers to finish 2026/08/04 04:15:35 INFO : file1.txt: Moved (server-side) 2026/08/04 04:15:35 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:37 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:39 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:15:41 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:15:43 DEBUG : pacer: Reducing sleep to 1.125s run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:15:44 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/08/04 04:15:46 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 2026/08/04 04:15:47 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:15:49 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:15:49 DEBUG : pacer: Reducing sleep to 266.967773ms run.go:186: removing dir "sub" failed - try 1/3: sleeping 1s: directory not empty 2026/08/04 04:15:50 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:15:51 DEBUG : pacer: Reducing sleep to 200ms 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestServerSideMoveLocal Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestServerSideMoveLocal Messages: Unexpected file "existing" --- FAIL: TestServerSideMoveLocal (32.18s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:16:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/08/04 04:16:00 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/08/04 04:16:00 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:16:00 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:16:07 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:16:07 DEBUG : sub dir/hello world: size = 11 OK 2026/08/04 04:16:07 INFO : sub dir/hello world: Copied (new) 2026/08/04 04:16:07 INFO : sub dir/hello world: Deleted 2026/08/04 04:16:08 DEBUG : nested/sub dir/file: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:16:08 DEBUG : nested/sub dir/file: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:16:08 DEBUG : nested/sub dir/file: size = 6 OK 2026/08/04 04:16:08 INFO : nested/sub dir/file: Copied (new) 2026/08/04 04:16:08 INFO : nested/sub dir/file: Deleted 2026/08/04 04:16:08 ERROR : Local file system at /tmp/rclone457739820: 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:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit run.go:186: removing dir "nested/sub dir" failed - try 1/3: sleeping 1s: directory not empty 2026/08/04 04:16:21 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:21 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:16:21 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:21 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:16:21 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:21 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:16:22 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:22 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:16:24 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:26 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:28 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:30 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:32 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:34 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:34 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:282: Error listing: getting files failed: invalid character '<' looking for beginning of value --- FAIL: TestMoveWithDeleteEmptySrcDirs (34.01s) === RUN TestMoveWithIgnoreExisting run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:16:36 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:38 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:16:40 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:16:40 DEBUG : existing-b: Need to transfer - File not found at Destination 2026/08/04 04:16:40 DEBUG : existing: Destination exists, skipping 2026/08/04 04:16:40 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2026/08/04 04:16:40 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:16:40 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:16:42 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:16:43 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:16:46 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:16:46 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:16:46 DEBUG : existing-b: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:16:47 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:16:47 DEBUG : existing-b: size = 6 OK 2026/08/04 04:16:47 INFO : existing-b: Copied (new) 2026/08/04 04:16:47 INFO : existing-b: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:368 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1868 Error: Should be true Test: TestMoveWithIgnoreExisting Messages: listing wrong, want got existing (6) 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:368 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1868 Error: Should be true Test: TestMoveWithIgnoreExisting Messages: Unexpected file "existing" 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:368 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1868 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/08/04 04:16:54 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:16:54 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:16:54 DEBUG : existing: Destination exists, skipping 2026/08/04 04:16:54 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2026/08/04 04:16:54 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for checks to finish 2026/08/04 04:16:54 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Waiting for transfers to finish 2026/08/04 04:16:54 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:368 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1890 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/08/04 04:17:01 DEBUG : pacer: Reducing sleep to 200ms run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestMoveWithIgnoreExisting Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestMoveWithIgnoreExisting Messages: Unexpected file "existing" --- FAIL: TestMoveWithIgnoreExisting (40.85s) === RUN TestServerSideMove run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:17:15 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-dotohar6nuze" 2026/08/04 04:17:15 DEBUG : Linkbox root 'rclone-test-dotohar6nuze': Using cached web token 2026/08/04 04:17:18 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:18 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:17:18 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:18 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:17:19 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:19 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:17:19 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:19 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:17:21 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:23 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:25 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:27 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:29 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:31 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "potato2" to Linkbox root 'rclone-test-yuvuhel6sefi': 1/10 (Update failed to read object: getting files failed: invalid character '<' looking for beginning of value) 2026/08/04 04:17:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:37 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:39 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:17:41 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:17:41 DEBUG : potato2: Update: removing old file 2026/08/04 04:17:44 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:17:45 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:17:47 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:17:47 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:17:47 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:17:48 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 04:17:48 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:17:48 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 04:17:49 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 04:17:49 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 04:17:51 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:17:51 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:17:53 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:17:54 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:17:54 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10) 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:358 /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:1771 Error: Should be true Test: TestServerSideMove Messages: listing wrong, want empty space (1), potato2 (60), potato3 (68) got empty space (1), existing (6), potato2 (60), potato3 (68) 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:358 /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: Should be true Test: TestServerSideMove Messages: Unexpected file "existing" sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-yuvuhel6sefi' -> Linkbox root 'rclone-test-dotohar6nuze' 2026/08/04 04:18:07 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:18:07 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:18:08 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:18:10 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:18:11 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:18:11 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:18:12 DEBUG : existing: Need to transfer - File not found at Destination 2026/08/04 04:18:12 DEBUG : potato2: Need to transfer - File not found at Destination 2026/08/04 04:18:12 DEBUG : empty space: size = 1 OK 2026/08/04 04:18:12 DEBUG : empty space: Sizes identical 2026/08/04 04:18:12 DEBUG : empty space: Unchanged skipping 2026/08/04 04:18:12 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-yuvuhel6sefi') 2026/08/04 04:18:12 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-dotohar6nuze') 2026/08/04 04:18:12 DEBUG : potato3: Sizes differ 2026/08/04 04:18:12 DEBUG : Linkbox root 'rclone-test-dotohar6nuze': Waiting for checks to finish 2026/08/04 04:18:13 DEBUG : potato3: Update: removing old file 2026/08/04 04:18:14 INFO : empty space: Deleted 2026/08/04 04:18:14 DEBUG : Linkbox root 'rclone-test-dotohar6nuze': Waiting for transfers to finish 2026/08/04 04:18:14 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:14 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:18:15 DEBUG : pacer: Reducing sleep to 300ms 2026/08/04 04:18:15 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:15 DEBUG : pacer: Rate limited, increasing sleep to 600ms 2026/08/04 04:18:15 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:15 DEBUG : pacer: Rate limited, increasing sleep to 1.2s 2026/08/04 04:18:15 DEBUG : pacer: Reducing sleep to 900ms 2026/08/04 04:18:16 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:16 DEBUG : pacer: Rate limited, increasing sleep to 1.8s 2026/08/04 04:18:16 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:16 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 04:18:18 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:20 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:22 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:24 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:26 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:28 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:30 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:32 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:34 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:36 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:38 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:18:41 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 04:18:42 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 04:18:42 DEBUG : potato2: size = 60 OK 2026/08/04 04:18:42 INFO : potato2: Copied (new) 2026/08/04 04:18:44 INFO : potato2: Deleted 2026/08/04 04:18:44 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 04:18:44 DEBUG : existing: size = 6 OK 2026/08/04 04:18:44 INFO : existing: Copied (new) 2026/08/04 04:18:44 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:18:46 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 04:18:47 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 04:18:47 DEBUG : potato3: size = 68 OK 2026/08/04 04:18:47 INFO : potato3: Copied (replaced existing) 2026/08/04 04:18:48 INFO : potato3: Deleted 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: could not Remove: Linkbox error 403: not permit Test: TestServerSideMove 2026/08/04 04:18:48 DEBUG : Linkbox root 'rclone-test-dotohar6nuze': Purge remote 2026/08/04 04:18:49 DEBUG : pacer: Reducing sleep to 355.957031ms run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /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: Should be true Test: TestServerSideMove Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /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: Should be true Test: TestServerSideMove Messages: Unexpected file "existing" --- FAIL: TestServerSideMove (106.28s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:19:01 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-xifivec7gafu" 2026/08/04 04:19:01 DEBUG : Linkbox root 'rclone-test-xifivec7gafu': Using cached web token 2026/08/04 04:19:08 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:19:09 INFO : tomatoDir: 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /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:1932 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want empty space (1), potato2 (60), potato3 (68) got empty space (1), existing (6), potato2 (60), potato3 (68) 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:358 /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:1932 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "existing" sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-yuvuhel6sefi' -> Linkbox root 'rclone-test-xifivec7gafu' 2026/08/04 04:19:23 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:19:24 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 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/08/04 04:19:34 DEBUG : existing: Need to transfer - File not found at Destination 2026/08/04 04:19:34 DEBUG : potato2: Need to transfer - File not found at Destination 2026/08/04 04:19:34 DEBUG : empty space: size = 1 OK 2026/08/04 04:19:34 DEBUG : empty space: Sizes identical 2026/08/04 04:19:34 DEBUG : empty space: Unchanged skipping 2026/08/04 04:19:34 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-yuvuhel6sefi') 2026/08/04 04:19:34 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-xifivec7gafu') 2026/08/04 04:19:34 DEBUG : potato3: Sizes differ 2026/08/04 04:19:35 DEBUG : Linkbox root 'rclone-test-xifivec7gafu': Waiting for checks to finish 2026/08/04 04:19:35 DEBUG : potato3: Update: removing old file 2026/08/04 04:19:36 INFO : empty space: Deleted 2026/08/04 04:19:36 DEBUG : Linkbox root 'rclone-test-xifivec7gafu': Waiting for transfers to finish 2026/08/04 04:19:38 DEBUG : existing: size = 6 OK 2026/08/04 04:19:38 INFO : existing: Copied (new) 2026/08/04 04:19:38 ERROR : existing: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/08/04 04:19:38 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:19:38 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:19:39 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:19:39 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:19:39 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:19:39 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:19:39 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 04:19:39 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:19:39 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 04:19:40 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 04:19:40 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 04:19:41 DEBUG : pacer: Reducing sleep to 1.2s 2026/08/04 04:19:41 DEBUG : potato2: size = 60 OK 2026/08/04 04:19:41 INFO : potato2: Copied (new) 2026/08/04 04:19:42 INFO : potato2: Deleted 2026/08/04 04:19:42 DEBUG : pacer: Reducing sleep to 900ms 2026/08/04 04:19:42 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 04:19:44 DEBUG : pacer: Reducing sleep to 675ms 2026/08/04 04:19:44 DEBUG : potato3: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 04:19:45 DEBUG : pacer: Reducing sleep to 506.25ms 2026/08/04 04:19:45 DEBUG : potato3: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 04:19:46 DEBUG : pacer: Reducing sleep to 379.6875ms 2026/08/04 04:19:46 DEBUG : potato3: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 04:19:50 DEBUG : pacer: Reducing sleep to 284.765625ms 2026/08/04 04:19:50 DEBUG : potato3: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 04:19:56 DEBUG : pacer: Reducing sleep to 213.574218ms 2026/08/04 04:19:56 DEBUG : potato3: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 04:20:09 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 04:20:09 DEBUG : potato3: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/04 04:20:35 DEBUG : potato3: Trying to read object after upload: try again in 51.2s (10/10) 2026/08/04 04:21:26 ERROR : potato3: Failed to copy: object not found 2026/08/04 04:21:26 ERROR : potato3: Not deleting source as copy failed: object not found 2026/08/04 04:21:26 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi': not deleting directories as there were IO errors 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:1932 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2026/08/04 04:21:26 DEBUG : Linkbox root 'rclone-test-xifivec7gafu': Purge remote run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /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:1932 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /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:1932 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "existing" --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (161.79s) === RUN TestSyncCompareDest run.go:198: Remote "Linkbox root 'rclone-test-yuvuhel6sefi'", Local "Local file system at /tmp/rclone457739820", Modify Window "876000h0m0s" 2026/08/04 04:21:43 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yuvuhel6sefi/dst" 2026/08/04 04:21:43 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi/dst': Using cached web token 2026/08/04 04:21:44 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yuvuhel6sefi/CompareDest" 2026/08/04 04:21:44 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi/CompareDest': Using cached web token 2026/08/04 04:21:46 DEBUG : one: Need to transfer - File not found at Destination 2026/08/04 04:21:46 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi/dst': Waiting for checks to finish 2026/08/04 04:21:46 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi/dst': Waiting for transfers to finish 2026/08/04 04:21:49 DEBUG : one: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 04:21:50 DEBUG : one: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 04:21:50 DEBUG : one: size = 3 OK 2026/08/04 04:21:50 INFO : one: Copied (new) 2026/08/04 04:21:50 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2121 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want dst/one (3) got dst/one (3), existing (6) 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2121 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "existing" 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2125 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want dst/one (3) got dst/one (3), existing (6) 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:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2125 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "existing" 2026/08/04 04:22:09 DEBUG : one: size = 5 (Local file system at /tmp/rclone457739820) 2026/08/04 04:22:09 DEBUG : one: size = 3 (Linkbox root 'rclone-test-yuvuhel6sefi/dst') 2026/08/04 04:22:09 DEBUG : one: Sizes differ 2026/08/04 04:22:09 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi/dst': Waiting for checks to finish 2026/08/04 04:22:09 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi/dst': Waiting for transfers to finish 2026/08/04 04:22:09 DEBUG : one: Update: removing old file 2026/08/04 04:22:13 DEBUG : one: size = 5 (Local file system at /tmp/rclone457739820) 2026/08/04 04:22:13 DEBUG : one: size = 3 (Linkbox root 'rclone-test-yuvuhel6sefi/dst') 2026/08/04 04:22:13 ERROR : one: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone457739820) 5 vs dst(Linkbox root 'rclone-test-yuvuhel6sefi/dst') 3 2026/08/04 04:22:13 INFO : one: Removing failed copy 2026/08/04 04:22:13 INFO : one: Failed to remove failed copy: could not Remove: Linkbox error 403: not permit 2026/08/04 04:22:13 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi/dst': not deleting files as there were IO errors 2026/08/04 04:22:13 ERROR : Linkbox root 'rclone-test-yuvuhel6sefi/dst': not deleting directories as there were IO errors sync_test.go:2132: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2132 Error: Received unexpected error: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone457739820) 5 vs dst(Linkbox root 'rclone-test-yuvuhel6sefi/dst') 3 Test: TestSyncCompareDest run.go:172: removing file "existing" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "existing" failed: could not Remove: Linkbox error 403: not permit 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2132 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want got existing (6) 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:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2132 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "existing" --- FAIL: TestSyncCompareDest (45.09s) FAIL 2026/08/04 04:22:28 DEBUG : Linkbox root 'rclone-test-yuvuhel6sefi': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyEmptyDirectories|TestCopyNoTraverse|TestCopyWithFilesFrom|TestMoveOverSelf|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveLocal|TestServerSideMoveOverSelf|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingModtimeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncBasedOnCheckSum|TestSyncCompareDest|TestSyncDoesntUpdateModtime|TestSyncEmptyDirectories|TestSyncIgnoreErrors|TestSyncIgnoreTimes|TestSyncNoEmptyDirectories|TestSyncSizeOnly|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 26m22.265575137s (try 2/5): exit status 1: Failed [TestSyncEmptyDirectories TestSyncNoEmptyDirectories TestServerSideCopyOverSelf TestMoveOverSelf TestServerSideMoveOverSelf TestSyncIgnoreTimes TestSyncIgnoreErrors TestSyncAfterChangingModtimeOnly TestSyncDoesntUpdateModtime TestSyncAfterChangingContentsOnly TestSyncAfterRemovingAFileAndAddingAFileDryRun TestSyncAfterRemovingAFileAndAddingAFile TestSyncAfterRemovingAFileAndAddingAFileSubDir TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestServerSideMoveLocal TestMoveWithDeleteEmptySrcDirs TestMoveWithIgnoreExisting TestServerSideMove TestServerSideMoveDeleteEmptySourceDirs TestSyncCompareDest]