"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyOverSelf|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMove|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncIgnoreCase|TestSyncIgnoreErrors|TestSyncIgnoreExisting|TestSyncIgnoreTimes|TestSyncImmutable|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncUTFNorm)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Starting (try 4/5) 2026/07/31 05:25:37 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-togalen6boxi" 2026/07/31 05:25:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/07/31 05:25:37 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Using cached web token 2026/07/31 05:25:38 DEBUG : Creating backend with remote "/tmp/rclone2406418603" === RUN TestCopyOverSelf run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:25:44 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:25:44 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:25:44 DEBUG : sub dir/hello world: Sizes differ 2026/07/31 05:25:44 DEBUG : sub dir/hello world: Update: removing old file 2026/07/31 05:25:44 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:25:44 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:25:48 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:25:48 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:25:48 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:25:49 DEBUG : sub dir/hello world: size = 17 OK 2026/07/31 05:25:49 INFO : sub dir/hello world: Copied (replaced existing) 2026/07/31 05:25:49 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:25:49 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:25:49 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:25:49 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:25:49 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:25:49 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:25:50 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:25:50 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:25:52 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:25:54 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:25:56 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:25:58 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:00 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:02 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:02 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/07/31 05:26:04 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:06 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:08 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:10 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:12 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:14 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:16 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:18 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:20 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:26:22 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:26:24 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:26:27 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:26:27 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:26:29 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:26:29 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:26:30 DEBUG : pacer: Reducing sleep to 266.967773ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/07/31 05:26:31 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:26:31 DEBUG : pacer: Reducing sleep to 200ms fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestCopyOverSelf (58.86s) === RUN TestServerSideMoveOverSelf run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:26:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:26:41 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:26:42 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-zoxorak2nina" 2026/07/31 05:26:42 DEBUG : Config file has changed externally - reloading 2026/07/31 05:26:42 DEBUG : Linkbox root 'rclone-test-zoxorak2nina': Using cached web token sync_test.go:701: Server side copy (if possible) Linkbox root 'rclone-test-togalen6boxi' -> Linkbox root 'rclone-test-zoxorak2nina' 2026/07/31 05:26:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/07/31 05:26:43 DEBUG : Linkbox root 'rclone-test-zoxorak2nina': Waiting for checks to finish 2026/07/31 05:26:43 DEBUG : Linkbox root 'rclone-test-zoxorak2nina': Waiting for transfers to finish 2026/07/31 05:26:44 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1178h24m7.178111124s different from this computer 2026/07/31 05:26:49 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:26:49 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:26:50 DEBUG : sub dir/hello world: size = 11 OK 2026/07/31 05:26:50 INFO : sub dir/hello world: Copied (new) 2026/07/31 05:26:50 DEBUG : sub dir/hello world: Update: removing old file 2026/07/31 05:26:53 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:26:54 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:26:55 DEBUG : Linkbox root 'rclone-test-zoxorak2nina': Waiting for checks to finish 2026/07/31 05:26:55 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:26:55 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-zoxorak2nina') 2026/07/31 05:26:55 DEBUG : sub dir/hello world: Sizes differ 2026/07/31 05:26:55 DEBUG : Linkbox root 'rclone-test-zoxorak2nina': Waiting for transfers to finish 2026/07/31 05:26:55 DEBUG : sub dir/hello world: Update: removing old file 2026/07/31 05:26:58 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:26:59 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:26:59 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:27:00 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:27:01 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2026/07/31 05:27:02 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 3.2s (6/10) 2026/07/31 05:27:06 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 6.4s (7/10) 2026/07/31 05:27:12 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 12.8s (8/10) 2026/07/31 05:27:25 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 25.6s (9/10) 2026/07/31 05:27:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 51.2s (10/10) 2026/07/31 05:28:42 ERROR : sub dir/hello world: Failed to copy: object not found 2026/07/31 05:28:42 ERROR : sub dir/hello world: Not deleting source as copy failed: object not found sync_test.go:714: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:714 Error: Received unexpected error: object not found Test: TestServerSideMoveOverSelf 2026/07/31 05:28:42 DEBUG : Linkbox root 'rclone-test-zoxorak2nina': Purge remote run.go:186: removing dir "sub dir" failed - try 1/3: sleeping 1s: directory not empty 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 --- FAIL: TestServerSideMoveOverSelf (139.37s) === RUN TestSyncIgnoreTimes run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:28:58 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:28:59 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:28:59 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:29:00 DEBUG : existing: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:29:01 DEBUG : existing: size = 6 OK 2026/07/31 05:29:01 DEBUG : existing: Sizes identical 2026/07/31 05:29:01 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:29:01 DEBUG : existing: Unchanged skipping 2026/07/31 05:29:01 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:29:01 DEBUG : Waiting for deletions to finish 2026/07/31 05:29:01 INFO : There was nothing to transfer 2026/07/31 05:29:02 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2026/07/31 05:29:02 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:29:02 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:29:02 DEBUG : existing: Update: removing old file 2026/07/31 05:29:05 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:29:05 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:29:06 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:29:06 DEBUG : existing: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:29:07 DEBUG : existing: Trying to read object after upload: try again in 1.6s (5/10) 2026/07/31 05:29:09 DEBUG : existing: Trying to read object after upload: try again in 3.2s (6/10) 2026/07/31 05:29:12 DEBUG : existing: Trying to read object after upload: try again in 6.4s (7/10) 2026/07/31 05:29:19 DEBUG : existing: Trying to read object after upload: try again in 12.8s (8/10) 2026/07/31 05:29:32 DEBUG : existing: Trying to read object after upload: try again in 25.6s (9/10) 2026/07/31 05:29:58 DEBUG : existing: Trying to read object after upload: try again in 51.2s (10/10) 2026/07/31 05:30:49 ERROR : existing: Failed to copy: object not found 2026/07/31 05:30:49 ERROR : Linkbox root 'rclone-test-togalen6boxi': not deleting files as there were IO errors 2026/07/31 05:30:49 ERROR : Linkbox root 'rclone-test-togalen6boxi': not deleting directories as there were IO errors sync_test.go:905: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:905 Error: Received unexpected error: object not found Test: TestSyncIgnoreTimes 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 --- FAIL: TestSyncIgnoreTimes (121.86s) === RUN TestSyncIgnoreExisting run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:30:59 DEBUG : existing: Need to transfer - File not found at Destination 2026/07/31 05:30:59 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:30:59 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:31:01 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:31:01 DEBUG : existing: size = 6 OK 2026/07/31 05:31:01 INFO : existing: Copied (new) 2026/07/31 05:31:01 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:292: Sleeping for 6s just to make sure 2026/07/31 05:31:09 DEBUG : existing: Destination exists, skipping 2026/07/31 05:31:09 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:31:09 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:31:09 DEBUG : Waiting for deletions to finish 2026/07/31 05:31:09 INFO : There was nothing to transfer 2026/07/31 05:31:11 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:11 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:31:11 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:11 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:31:11 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:11 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:31:12 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:12 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:31:14 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:16 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:18 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:20 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:22 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:24 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:24 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: TestSyncIgnoreExisting (25.48s) === RUN TestSyncIgnoreErrors run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:31:26 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:31:28 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:31:31 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:31:32 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:31:33 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:31:35 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:31:35 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:31:35 DEBUG : b/potato: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:31:36 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:31:36 DEBUG : b/potato: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:31:36 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:31:36 DEBUG : pacer: Reducing sleep to 200ms 2026/07/31 05:31:40 DEBUG : c/non empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:31:40 DEBUG : c/non empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:31:41 INFO : d: Making directory 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:953 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 (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:368 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:953 Error: Should be true Test: TestSyncIgnoreErrors Messages: Unexpected file "existing" 2026/07/31 05:31:50 DEBUG : existing: Need to transfer - File not found at Destination 2026/07/31 05:31:50 DEBUG : a/potato2: Need to transfer - File not found at Destination 2026/07/31 05:31:51 DEBUG : c/non empty space: size = 5 OK 2026/07/31 05:31:51 DEBUG : c/non empty space: Sizes identical 2026/07/31 05:31:51 DEBUG : c/non empty space: Unchanged skipping 2026/07/31 05:31:51 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:31:51 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:31:55 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:31:55 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:31:55 DEBUG : a/potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:31:55 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:31:55 DEBUG : a/potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:31:56 DEBUG : existing: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:31:56 DEBUG : a/potato2: size = 60 OK 2026/07/31 05:31:56 INFO : a/potato2: Copied (new) 2026/07/31 05:31:57 DEBUG : existing: size = 11 OK 2026/07/31 05:31:57 INFO : existing: Copied (new) 2026/07/31 05:31:57 DEBUG : Waiting for deletions to finish 2026/07/31 05:31:58 INFO : b/potato: Deleted 2026/07/31 05:31:58 INFO : d: Removing directory 2026/07/31 05:32:00 INFO : b: Removing directory 2026/07/31 05:32:01 DEBUG : Linkbox root 'rclone-test-togalen6boxi': deleted 2 directories 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:983 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 (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:368 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:983 Error: Should be true Test: TestSyncIgnoreErrors Messages: Unexpected file "existing" 2026/07/31 05:32:08 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:08 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:32:08 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:08 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:32:09 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:09 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:32:10 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:10 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:32:11 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:13 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:15 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:17 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:19 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:21 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:21 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/07/31 05:32:23 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:25 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:32:27 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:32:31 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:32:31 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:32:32 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:32:34 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:32:35 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:32:36 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:32:37 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:32:37 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestSyncIgnoreErrors (75.12s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:32:41 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:32:42 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:32:42 DEBUG : potato: size = 21 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:32:42 DEBUG : potato: size = 60 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:32:42 DEBUG : potato: Sizes differ 2026/07/31 05:32:42 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:32:42 DEBUG : potato: Update: removing old file 2026/07/31 05:32:45 DEBUG : potato: size = 21 OK 2026/07/31 05:32:45 INFO : potato: Copied (replaced existing) 2026/07/31 05:32:45 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go: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: TestSyncAfterChangingFilesSizeOnly Messages: listing wrong, want got 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/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: TestSyncAfterChangingFilesSizeOnly Messages: Unexpected file "potato" --- FAIL: TestSyncAfterChangingFilesSizeOnly (16.35s) === RUN TestSyncAfterChangingContentsOnly run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" sync_test.go:1136: ModTimeNotSupported so forcing file to be a different size 2026/07/31 05:32:56 DEBUG : potato: Update: removing old file 2026/07/31 05:32:56 ERROR : potato: Update: failed to remove existing file: 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/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 potato (21), potato(1) (36) fstest.go:150: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:150 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /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 Error: Not equal: expected: 36 actual : 21 Test: TestSyncAfterChangingContentsOnly Messages: potato: size incorrect file=36 vs obj=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:1142 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: Unexpected file "potato(1)" 2026/07/31 05:33:07 DEBUG : potato: size = 21 OK 2026/07/31 05:33:07 DEBUG : potato: Sizes identical 2026/07/31 05:33:07 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:33:07 DEBUG : potato: Unchanged skipping 2026/07/31 05:33:07 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:33:07 DEBUG : Waiting for deletions to finish 2026/07/31 05:33:08 INFO : potato(1): Deleted 2026/07/31 05:33:08 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 2026/07/31 05:33:12 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:12 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:33:12 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:12 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:33:13 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:13 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:33:14 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:14 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:33:15 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:17 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:19 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:21 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:23 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:25 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:25 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/07/31 05:33:27 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:33:29 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:33:31 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:33:33 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "potato" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:33:34 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "potato" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:33:36 DEBUG : pacer: Reducing sleep to 474.609375ms run.go:172: removing file "potato" failed: could not Remove: Linkbox error 403: not permit 2026/07/31 05:33:36 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/07/31 05:33:38 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:33:38 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/07/31 05:33:40 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/fstest.go:282 /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:1151 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: listing wrong, want got 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/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/fstest.go:282 /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:1151 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncAfterChangingContentsOnly Messages: Unexpected file "potato" --- FAIL: TestSyncAfterChangingContentsOnly (49.29s) === RUN TestServerSideMove run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:33:45 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-mojehof8doqi" 2026/07/31 05:33:45 DEBUG : Config file has changed externally - reloading 2026/07/31 05:33:45 DEBUG : Linkbox root 'rclone-test-mojehof8doqi': Using cached web token 2026/07/31 05:33:48 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:33:48 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:33:49 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:33:51 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:33:52 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:33:52 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:33:53 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: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), potato (21), 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 "potato" sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-togalen6boxi' -> Linkbox root 'rclone-test-mojehof8doqi' 2026/07/31 05:34:08 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:34:08 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:34:09 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:34:09 DEBUG : empty space: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:34:10 DEBUG : empty space: Trying to read object after upload: try again in 1.6s (5/10) 2026/07/31 05:34:12 DEBUG : empty space: Trying to read object after upload: try again in 3.2s (6/10) 2026/07/31 05:34:19 DEBUG : potato2: Need to transfer - File not found at Destination 2026/07/31 05:34:19 DEBUG : potato: Need to transfer - File not found at Destination 2026/07/31 05:34:19 DEBUG : empty space: size = 1 OK 2026/07/31 05:34:19 DEBUG : empty space: Sizes identical 2026/07/31 05:34:19 DEBUG : empty space: Unchanged skipping 2026/07/31 05:34:19 DEBUG : Linkbox root 'rclone-test-mojehof8doqi': Waiting for checks to finish 2026/07/31 05:34:19 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:34:19 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-mojehof8doqi') 2026/07/31 05:34:19 DEBUG : potato3: Sizes differ 2026/07/31 05:34:20 DEBUG : potato3: Update: removing old file 2026/07/31 05:34:20 INFO : empty space: Deleted 2026/07/31 05:34:20 DEBUG : Linkbox root 'rclone-test-mojehof8doqi': Waiting for transfers to finish 2026/07/31 05:34:22 DEBUG : potato: size = 21 OK 2026/07/31 05:34:22 INFO : potato: Copied (new) 2026/07/31 05:34:23 ERROR : potato: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/07/31 05:34:23 DEBUG : potato2: size = 60 OK 2026/07/31 05:34:23 INFO : potato2: Copied (new) 2026/07/31 05:34:23 DEBUG : potato3: size = 68 OK 2026/07/31 05:34:23 INFO : potato3: Copied (replaced existing) 2026/07/31 05:34:24 INFO : potato2: Deleted 2026/07/31 05:34:24 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/07/31 05:34:24 DEBUG : Linkbox root 'rclone-test-mojehof8doqi': Purge remote 2026/07/31 05:34:26 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:34:26 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:34:26 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:34:26 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:34:26 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:34:26 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:34:27 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:34:27 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:34:29 DEBUG : pacer: Reducing sleep to 1.5s run.go:172: removing file "potato" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:34:31 DEBUG : pacer: Reducing sleep to 1.125s run.go:172: removing file "potato" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:34:33 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "potato" failed: could not Remove: Linkbox error 403: not permit 2026/07/31 05:34:34 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/07/31 05:34:35 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:34:36 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/07/31 05:34:38 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:34:38 DEBUG : pacer: Reducing sleep to 200.225829ms 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 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/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 "potato" --- FAIL: TestServerSideMove (57.84s) === RUN TestServerSideMoveWithFilter run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:34:42 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-boxexim6hoci" 2026/07/31 05:34:42 DEBUG : Linkbox root 'rclone-test-boxexim6hoci': Using cached web token 2026/07/31 05:34:44 DEBUG : pacer: Reducing sleep to 200ms 2026/07/31 05:34:46 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:34:46 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:34:46 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:34:47 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:34:50 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:34:52 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/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:1925 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestServerSideMoveWithFilter Messages: listing wrong, want empty space (1), potato2 (60), potato3 (68) got empty space (1), potato (21), 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:1925 Error: Should be true Test: TestServerSideMoveWithFilter Messages: Unexpected file "potato" sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-togalen6boxi' -> Linkbox root 'rclone-test-boxexim6hoci' 2026/07/31 05:35:05 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:35:05 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:35:08 DEBUG : empty space: Excluded (Size Filter) 2026/07/31 05:35:08 DEBUG : empty space: Excluded 2026/07/31 05:35:09 DEBUG : potato: Excluded (Size Filter) 2026/07/31 05:35:09 DEBUG : potato: Excluded 2026/07/31 05:35:09 DEBUG : empty space: Excluded (Size Filter) 2026/07/31 05:35:09 DEBUG : empty space: Excluded 2026/07/31 05:35:09 DEBUG : potato2: Need to transfer - File not found at Destination 2026/07/31 05:35:09 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:35:09 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-boxexim6hoci') 2026/07/31 05:35:09 DEBUG : potato3: Sizes differ 2026/07/31 05:35:09 DEBUG : Linkbox root 'rclone-test-boxexim6hoci': Waiting for checks to finish 2026/07/31 05:35:09 DEBUG : Linkbox root 'rclone-test-boxexim6hoci': Waiting for transfers to finish 2026/07/31 05:35:09 DEBUG : potato3: Update: removing old file 2026/07/31 05:35:11 DEBUG : potato2: size = 60 OK 2026/07/31 05:35:11 INFO : potato2: Copied (new) 2026/07/31 05:35:12 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:35:13 INFO : potato2: Deleted 2026/07/31 05:35:13 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:35:13 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:35:14 DEBUG : potato3: size = 68 OK 2026/07/31 05:35:14 INFO : potato3: Copied (replaced existing) 2026/07/31 05:35:15 INFO : potato3: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1751 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1925 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestServerSideMoveWithFilter Messages: listing wrong, want empty space (1) got empty space (1), potato (21) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1751 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1925 Error: Should be true Test: TestServerSideMoveWithFilter Messages: Unexpected file "potato" 2026/07/31 05:35:24 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-pokujob1qage" 2026/07/31 05:35:24 DEBUG : Linkbox root 'rclone-test-pokujob1qage': Using cached web token 2026/07/31 05:35:25 DEBUG : empty space: Excluded (Size Filter) 2026/07/31 05:35:25 DEBUG : empty space: Excluded 2026/07/31 05:35:25 DEBUG : potato2: Need to transfer - File not found at Destination 2026/07/31 05:35:25 DEBUG : potato3: Need to transfer - File not found at Destination 2026/07/31 05:35:25 DEBUG : Linkbox root 'rclone-test-pokujob1qage': Waiting for checks to finish 2026/07/31 05:35:25 DEBUG : Linkbox root 'rclone-test-pokujob1qage': Waiting for transfers to finish 2026/07/31 05:35:29 DEBUG : potato2: size = 60 OK 2026/07/31 05:35:29 INFO : potato2: Copied (new) 2026/07/31 05:35:29 DEBUG : potato3: size = 68 OK 2026/07/31 05:35:29 INFO : potato3: Copied (new) 2026/07/31 05:35:31 INFO : potato2: Deleted 2026/07/31 05:35:31 INFO : potato3: Deleted 2026/07/31 05:35:31 DEBUG : Linkbox root 'rclone-test-pokujob1qage': Purge remote 2026/07/31 05:35:33 DEBUG : Linkbox root 'rclone-test-boxexim6hoci': Purge remote 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 Error: Should be true Test: TestServerSideMoveWithFilter Messages: listing wrong, want got 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/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: TestServerSideMoveWithFilter Messages: Unexpected file "potato" --- FAIL: TestServerSideMoveWithFilter (64.91s) === RUN TestSyncUTFNorm run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", 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:2576 Error: Should be true Test: TestSyncUTFNorm Messages: listing wrong, want Testêé (18) got Testêé (18), 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:2576 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncUTFNorm Messages: Unexpected file "potato" 2026/07/31 05:35:59 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:35:59 DEBUG : Testêé: size = 14 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:35:59 DEBUG : Testêé: size = 18 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:35:59 DEBUG : Testêé: Sizes differ 2026/07/31 05:35:59 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:35:59 DEBUG : Testêé: Update: removing old file 2026/07/31 05:36:02 DEBUG : Testêé: size = 14 OK 2026/07/31 05:36:02 INFO : Testêé: Copied (replaced existing) to: Testêé 2026/07/31 05:36:02 DEBUG : Waiting for deletions to finish 2026/07/31 05:36:02 ERROR : potato: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/07/31 05:36:02 ERROR : Linkbox root 'rclone-test-togalen6boxi': not deleting directories as there were IO errors sync_test.go:2582: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2582 Error: Received unexpected error: failed to delete 1 files Test: TestSyncUTFNorm 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:2582 Error: Should be true Test: TestSyncUTFNorm Messages: listing wrong, want got 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/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:2582 Error: Should be true Test: TestSyncUTFNorm Messages: Unexpected file "potato" --- FAIL: TestSyncUTFNorm (28.23s) === RUN TestSyncImmutable run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", 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:2603 Error: Should be true Test: TestSyncImmutable Messages: listing wrong, want got 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:2603 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncImmutable Messages: Unexpected file "potato" 2026/07/31 05:36:25 DEBUG : existing: Need to transfer - File not found at Destination 2026/07/31 05:36:25 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:36:25 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:36:27 DEBUG : existing: size = 6 OK 2026/07/31 05:36:27 INFO : existing: Copied (new) 2026/07/31 05:36:27 DEBUG : Waiting for deletions to finish 2026/07/31 05:36:28 ERROR : potato: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/07/31 05:36:28 ERROR : Linkbox root 'rclone-test-togalen6boxi': not deleting directories as there were IO errors sync_test.go:2610: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2610 Error: Received unexpected error: failed to delete 1 files Test: TestSyncImmutable 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:2610 Error: Should be true Test: TestSyncImmutable Messages: listing wrong, want got 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/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:2610 Error: Should be true Test: TestSyncImmutable Messages: Unexpected file "potato" --- FAIL: TestSyncImmutable (25.26s) === RUN TestSyncIgnoreCase run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" sync_test.go:2637: Skipping test as local or remote are case-insensitive 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:1259 /usr/local/go/src/testing/testing.go:1235 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2637 Error: Should be true Test: TestSyncIgnoreCase Messages: listing wrong, want got 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/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:2637 Error: Should be true Test: TestSyncIgnoreCase Messages: Unexpected file "potato" --- FAIL: TestSyncIgnoreCase (12.16s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" sync_test.go:2705: This test only runs on local 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:1259 /usr/local/go/src/testing/testing.go:1235 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2705 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2736 Error: Should be true Test: TestMaxTransfer/Hard Messages: listing wrong, want got 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/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:2705 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2736 Error: Should be true Test: TestMaxTransfer/Hard Messages: Unexpected file "potato" === RUN TestMaxTransfer/Soft run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" sync_test.go:2705: This test only runs on local 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:1259 /usr/local/go/src/testing/testing.go:1235 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2705 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2737 Error: Should be true Test: TestMaxTransfer/Soft Messages: listing wrong, want got 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/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:2705 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2737 Error: Should be true Test: TestMaxTransfer/Soft Messages: Unexpected file "potato" === RUN TestMaxTransfer/Cautious run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" sync_test.go:2705: This test only runs on local 2026/07/31 05:37:18 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:18 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:37:18 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:18 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:37:19 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:19 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:37:20 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:20 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:37:21 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:23 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:25 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:27 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:29 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:37:31 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:37:33 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/07/31 05:37:35 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/07/31 05:37:37 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "potato" failed: could not Remove: Linkbox error 403: not permit 2026/07/31 05:37:37 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/07/31 05:37:39 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:37:39 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/07/31 05:37:41 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:37:42 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:2705 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2738 Error: Should be true Test: TestMaxTransfer/Cautious Messages: listing wrong, want got 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/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:2705 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2738 Error: Should be true Test: TestMaxTransfer/Cautious Messages: Unexpected file "potato" --- FAIL: TestMaxTransfer (52.67s) --- FAIL: TestMaxTransfer/Hard (12.15s) --- FAIL: TestMaxTransfer/Soft (12.31s) --- FAIL: TestMaxTransfer/Cautious (28.20s) === RUN TestSyncConcurrentDelete run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:37:50 DEBUG : only0: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:37:50 DEBUG : only0: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:37:59 DEBUG : only2: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:37:59 DEBUG : only2: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:00 DEBUG : only2: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:38:00 DEBUG : only2: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:38:04 DEBUG : both3: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:04 DEBUG : both3: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:07 DEBUG : only3: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:07 DEBUG : only3: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:12 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:12 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:38:12 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:12 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:38:12 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:12 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:38:13 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:13 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:38:15 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:17 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:19 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:21 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:23 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:25 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "both5" to Linkbox root 'rclone-test-togalen6boxi': 1/10 (Update err in unmarshaling response: invalid character '<' looking for beginning of value) 2026/07/31 05:38:27 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:29 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:31 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:38:33 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:38:35 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:38:38 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:38:38 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:38:38 DEBUG : both5: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:39 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:38:39 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:38:40 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:38:41 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:38:42 DEBUG : pacer: Reducing sleep to 200ms 2026/07/31 05:38:42 DEBUG : only5: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:42 DEBUG : only5: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:42 DEBUG : only5: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:38:45 DEBUG : both6: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:45 DEBUG : both6: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:46 DEBUG : both6: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:38:46 DEBUG : both6: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:38:52 DEBUG : both7: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:52 DEBUG : both7: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:52 DEBUG : both7: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:38:55 DEBUG : only7: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:55 DEBUG : only7: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:58 DEBUG : both8: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:38:58 DEBUG : both8: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:38:58 DEBUG : both8: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:38:59 DEBUG : both8: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:39:02 DEBUG : only8: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:39:03 DEBUG : only8: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:39:03 DEBUG : only8: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:39:04 DEBUG : only8: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:39:07 DEBUG : both9: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:39:09 DEBUG : only9: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:39:09 DEBUG : only9: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:39:10 DEBUG : only9: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:39:10 DEBUG : only9: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:39:13 DEBUG : both10: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:39:14 DEBUG : both10: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:39:14 DEBUG : both10: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:39:15 DEBUG : both10: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:39:16 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:16 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:39:16 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:16 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:39:16 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:16 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:39:17 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:17 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:39:19 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:21 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:23 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:25 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:27 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:29 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "both10" to Linkbox root 'rclone-test-togalen6boxi': 1/10 (Update failed to read object: getting files failed: invalid character '<' looking for beginning of value) 2026/07/31 05:39:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:39:33 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:39:33 DEBUG : both10: Update: removing old file 2026/07/31 05:39:36 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:39:36 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:39:39 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:39:39 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:39:39 DEBUG : both10: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:39:39 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:39:39 DEBUG : both10: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:39:40 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:39:40 DEBUG : both10: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:39:41 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:39:41 DEBUG : both10: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:39:42 DEBUG : pacer: Reducing sleep to 200ms 2026/07/31 05:39:42 DEBUG : both10: Trying to read object after upload: try again in 1.6s (5/10) 2026/07/31 05:39:44 DEBUG : both10: Trying to read object after upload: try again in 3.2s (6/10) 2026/07/31 05:39:47 DEBUG : both10: Trying to read object after upload: try again in 6.4s (7/10) 2026/07/31 05:39:54 DEBUG : both10: Trying to read object after upload: try again in 12.8s (8/10) 2026/07/31 05:40:07 DEBUG : both10: Trying to read object after upload: try again in 25.6s (9/10) 2026/07/31 05:40:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:40:33 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:40:33 DEBUG : pacer: Reducing sleep to 300ms 2026/07/31 05:40:33 DEBUG : both10: Trying to read object after upload: try again in 51.2s (10/10) run.go:303: Failed to put "both10" to "Linkbox root 'rclone-test-togalen6boxi'": object not found 2026/07/31 05:41:25 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:41:25 DEBUG : pacer: Rate limited, increasing sleep to 600ms 2026/07/31 05:41:25 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:41:25 DEBUG : pacer: Rate limited, increasing sleep to 1.2s 2026/07/31 05:41:26 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:41:26 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:41:27 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:41:29 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:41:31 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:41:33 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:41:35 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:41:38 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:41:40 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:41:41 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:41:42 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:41:44 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:41:45 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:41:46 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:41:47 DEBUG : pacer: Reducing sleep to 200ms 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 /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/fstest/run.go:321 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2762 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2789 Error: Should be true Test: TestSyncConcurrentDelete Messages: listing wrong, want got 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/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/fstest/run.go:321 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2762 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2789 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncConcurrentDelete Messages: Unexpected file "potato" --- FAIL: TestSyncConcurrentDelete (270.56s) === RUN TestSyncConcurrentTruncate run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:42:21 DEBUG : only0: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:21 DEBUG : only0: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:42:22 DEBUG : only0: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:42:24 DEBUG : both1: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:25 DEBUG : both1: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:42:35 DEBUG : only3: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:36 DEBUG : only3: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:42:36 DEBUG : only3: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:42:39 DEBUG : both4: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:39 DEBUG : both4: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:42:43 DEBUG : both5: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:46 DEBUG : only5: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:48 DEBUG : both6: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:50 DEBUG : only6: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:53 DEBUG : both7: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:53 DEBUG : both7: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:42:54 DEBUG : both7: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:42:58 DEBUG : both8: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:42:59 DEBUG : both8: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:42:59 DEBUG : both8: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:43:02 DEBUG : only8: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:43:02 DEBUG : only8: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:43:05 DEBUG : both9: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:43:05 DEBUG : both9: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:43:05 DEBUG : both9: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:43:06 DEBUG : both9: Trying to read object after upload: try again in 800ms (4/10) 2026/07/31 05:43:09 DEBUG : only9: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:43:09 DEBUG : only9: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:43:14 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:14 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:43:14 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:14 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:43:14 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:14 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:43:15 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:15 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:43:17 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:19 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:21 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:23 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:25 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:27 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "only10" to Linkbox root 'rclone-test-togalen6boxi': 1/10 (Update failed to read object: getting files failed: invalid character '<' looking for beginning of value) 2026/07/31 05:43:29 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:31 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:33 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:35 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:43:37 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:43:37 DEBUG : only10: Update: removing old file 2026/07/31 05:43:40 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:43:40 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:43:43 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:43:43 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:43:43 DEBUG : only10: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:43:44 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:43:44 DEBUG : only10: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:43:44 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:43:45 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:43:45 DEBUG : pacer: Reducing sleep to 200ms 2026/07/31 05:43:46 DEBUG : both11: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:43:47 DEBUG : both11: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:43:55 DEBUG : only12: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:43:55 DEBUG : only12: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:43:56 DEBUG : only12: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:43:59 DEBUG : both13: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:43:59 DEBUG : both13: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:44:00 DEBUG : both13: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:44:03 DEBUG : only13: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:06 DEBUG : both14: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:09 DEBUG : only14: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:14 DEBUG : only15: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:14 DEBUG : only15: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:44:15 DEBUG : only15: Trying to read object after upload: try again in 400ms (3/10) 2026/07/31 05:44:16 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:16 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:44:16 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:16 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:44:17 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:17 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:44:17 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:17 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:44:19 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:21 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:23 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:25 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:27 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:29 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "both16" to Linkbox root 'rclone-test-togalen6boxi': 1/10 (Update err in unmarshaling response: invalid character '<' looking for beginning of value) 2026/07/31 05:44:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:33 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:35 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:44:37 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:44:39 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:44:42 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:44:42 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:44:42 DEBUG : both16: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:43 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:44:44 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:44:44 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:44:46 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:44:46 DEBUG : pacer: Reducing sleep to 200ms 2026/07/31 05:44:46 DEBUG : only16: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:49 DEBUG : both17: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:49 DEBUG : both17: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:44:52 DEBUG : only17: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:55 DEBUG : both18: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:58 DEBUG : only18: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:44:58 DEBUG : only18: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:45:01 DEBUG : both19: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:45:05 DEBUG : only19: Trying to read object after upload: try again in 100ms (1/10) 2026/07/31 05:45:05 DEBUG : only19: Trying to read object after upload: try again in 200ms (2/10) 2026/07/31 05:45:06 DEBUG : only19: 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:2775 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncConcurrentTruncate Messages: listing wrong, want both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (6), only1 (6), only10 (6), only11 (6), only12 (6), only13 (6), only14 (6), only15 (6), only16 (6), only17 (6), only18 (6), only19 (6), only2 (6), only3 (6), only4 (6), only5 (6), only6 (6), only7 (6), only8 (6), only9 (6) got both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (6), only1 (6), only10 (6), only11 (6), only12 (6), only13 (6), only14 (6), only15 (6), only16 (6), only17 (6), only18 (6), only19 (6), only2 (6), only3 (6), only4 (6), only5 (6), only6 (6), only7 (6), only8 (6), only9 (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:2775 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "potato" 2026/07/31 05:45:16 DEBUG : both0: size = 6 OK 2026/07/31 05:45:16 DEBUG : both0: Sizes identical 2026/07/31 05:45:16 DEBUG : both11: size = 6 OK 2026/07/31 05:45:16 DEBUG : both11: Sizes identical 2026/07/31 05:45:16 DEBUG : both10: size = 6 OK 2026/07/31 05:45:16 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for checks to finish 2026/07/31 05:45:16 DEBUG : both0: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both13: size = 6 OK 2026/07/31 05:45:16 DEBUG : both13: Sizes identical 2026/07/31 05:45:16 DEBUG : both10: Sizes identical 2026/07/31 05:45:16 DEBUG : both11: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both14: size = 6 OK 2026/07/31 05:45:16 DEBUG : both14: Sizes identical 2026/07/31 05:45:16 DEBUG : both12: size = 6 OK 2026/07/31 05:45:16 DEBUG : both12: Sizes identical 2026/07/31 05:45:16 DEBUG : both10: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both15: size = 6 OK 2026/07/31 05:45:16 DEBUG : both15: Sizes identical 2026/07/31 05:45:16 DEBUG : both12: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both16: size = 6 OK 2026/07/31 05:45:16 DEBUG : both16: Sizes identical 2026/07/31 05:45:16 DEBUG : both16: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both17: size = 6 OK 2026/07/31 05:45:16 DEBUG : both17: Sizes identical 2026/07/31 05:45:16 DEBUG : both17: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both18: size = 6 OK 2026/07/31 05:45:16 DEBUG : both18: Sizes identical 2026/07/31 05:45:16 DEBUG : both18: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both19: size = 6 OK 2026/07/31 05:45:16 DEBUG : both19: Sizes identical 2026/07/31 05:45:16 DEBUG : both19: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both1: size = 6 OK 2026/07/31 05:45:16 DEBUG : both1: Sizes identical 2026/07/31 05:45:16 DEBUG : both1: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both2: size = 6 OK 2026/07/31 05:45:16 DEBUG : both2: Sizes identical 2026/07/31 05:45:16 DEBUG : both2: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both3: size = 6 OK 2026/07/31 05:45:16 DEBUG : both3: Sizes identical 2026/07/31 05:45:16 DEBUG : both3: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both4: size = 6 OK 2026/07/31 05:45:16 DEBUG : both4: Sizes identical 2026/07/31 05:45:16 DEBUG : both4: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both5: size = 6 OK 2026/07/31 05:45:16 DEBUG : both5: Sizes identical 2026/07/31 05:45:16 DEBUG : both5: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both6: size = 6 OK 2026/07/31 05:45:16 DEBUG : both6: Sizes identical 2026/07/31 05:45:16 DEBUG : both6: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both7: size = 6 OK 2026/07/31 05:45:16 DEBUG : both7: Sizes identical 2026/07/31 05:45:16 DEBUG : both7: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both8: size = 6 OK 2026/07/31 05:45:16 DEBUG : both8: Sizes identical 2026/07/31 05:45:16 DEBUG : both8: Unchanged skipping 2026/07/31 05:45:16 DEBUG : both9: size = 6 OK 2026/07/31 05:45:16 DEBUG : both9: Sizes identical 2026/07/31 05:45:16 DEBUG : both9: Unchanged skipping 2026/07/31 05:45:16 DEBUG : only0: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only0: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only0: Sizes differ 2026/07/31 05:45:16 DEBUG : only10: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : both14: Unchanged skipping 2026/07/31 05:45:16 DEBUG : only10: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only10: Sizes differ 2026/07/31 05:45:16 DEBUG : both13: Unchanged skipping 2026/07/31 05:45:16 DEBUG : only11: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only11: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only11: Sizes differ 2026/07/31 05:45:16 DEBUG : both15: Unchanged skipping 2026/07/31 05:45:16 DEBUG : only12: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only12: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only12: Sizes differ 2026/07/31 05:45:16 ERROR : only0: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only10: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 DEBUG : only13: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only14: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only13: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 ERROR : only11: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 DEBUG : only13: Sizes differ 2026/07/31 05:45:16 DEBUG : only14: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only14: Sizes differ 2026/07/31 05:45:16 DEBUG : only15: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only15: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only15: Sizes differ 2026/07/31 05:45:16 DEBUG : only16: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only16: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only16: Sizes differ 2026/07/31 05:45:16 DEBUG : only17: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only17: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only17: Sizes differ 2026/07/31 05:45:16 ERROR : only13: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only12: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 DEBUG : only18: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only18: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only18: Sizes differ 2026/07/31 05:45:16 ERROR : only16: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 DEBUG : only19: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only19: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only19: Sizes differ 2026/07/31 05:45:16 DEBUG : only1: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only1: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only1: Sizes differ 2026/07/31 05:45:16 DEBUG : only2: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only2: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only2: Sizes differ 2026/07/31 05:45:16 DEBUG : only3: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only3: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only3: Sizes differ 2026/07/31 05:45:16 DEBUG : only4: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only4: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only4: Sizes differ 2026/07/31 05:45:16 DEBUG : only5: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only5: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only5: Sizes differ 2026/07/31 05:45:16 DEBUG : only6: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only6: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only6: Sizes differ 2026/07/31 05:45:16 DEBUG : only7: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only7: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only7: Sizes differ 2026/07/31 05:45:16 DEBUG : only8: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only8: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only8: Sizes differ 2026/07/31 05:45:16 ERROR : only18: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only19: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only1: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only2: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 DEBUG : only9: size = 0 (Local file system at /tmp/rclone2406418603) 2026/07/31 05:45:16 DEBUG : only9: size = 6 (Linkbox root 'rclone-test-togalen6boxi') 2026/07/31 05:45:16 DEBUG : only9: Sizes differ 2026/07/31 05:45:16 ERROR : only3: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Waiting for transfers to finish 2026/07/31 05:45:16 ERROR : only17: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only5: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only6: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only7: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only14: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only9: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only4: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only8: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : only15: Failed to copy: can't upload empty files to this remote 2026/07/31 05:45:16 ERROR : Linkbox root 'rclone-test-togalen6boxi': not deleting files as there were IO errors 2026/07/31 05:45:16 ERROR : Linkbox root 'rclone-test-togalen6boxi': not deleting directories as there were IO errors sync_test.go:2781: Skip test because remote cannot upload empty files 2026/07/31 05:45:23 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:23 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:45:23 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:23 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:45:24 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:24 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:45:25 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:25 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:45:26 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:28 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:30 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:32 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:34 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:45:36 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:172: removing file "both13" failed - try 1/3: sleeping 1s: could not Remove: invalid character '<' looking for beginning of value 2026/07/31 05:45:39 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:45:42 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:45:43 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:45:44 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:45:46 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:45:47 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:45:48 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:45:50 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:45:51 DEBUG : pacer: Reducing sleep to 200ms 2026/07/31 05:46:13 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:13 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:46:14 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:14 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:46:14 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:14 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:46:15 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:15 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:46:16 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:18 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:20 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:22 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:24 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:26 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:172: removing file "only19" failed - try 1/3: sleeping 1s: could not Remove: invalid character '<' looking for beginning of value 2026/07/31 05:46:28 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:30 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:32 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:34 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:36 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:46:40 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:46:42 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:46:43 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:46:45 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:46:46 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:46:47 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:46:49 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:46:50 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:46:51 DEBUG : pacer: Reducing sleep to 200ms 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:1259 /usr/local/go/src/testing/testing.go:1242 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2781 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793 Error: Should be true Test: TestSyncConcurrentTruncate Messages: listing wrong, want got 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/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:1242 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2781 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "potato" --- FAIL: TestSyncConcurrentTruncate (286.60s) === RUN TestSyncReplaceDirModTime run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:47:03 DEBUG : empty_dir: Making directory with metadata 2026/07/31 05:47:03 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/07/31 05:47:03 DEBUG : empty_on_remote: Making directory with metadata 2026/07/31 05:47:03 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/07/31 05:47:03 INFO : empty_on_remote: Making directory 2026/07/31 05:47:05 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/07/31 05:47:48 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2026/07/31 05:47:48 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2026/07/31 05:47:48 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2026/07/31 05:47:48 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 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:2857 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2864 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncReplaceDirModTime Messages: listing wrong, want file1 (5), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) got file1 (5), potato (21), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) 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:2857 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2864 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "potato" 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 2026/07/31 05:48:07 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:07 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:48:07 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:07 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:48:07 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:07 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:48:08 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:08 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:48:10 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:12 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:14 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:16 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:18 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:20 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:172: removing file "test_dir2/sub_dir/file3" failed - try 1/3: sleeping 1s: could not Remove: invalid character '<' looking for beginning of value 2026/07/31 05:48:22 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:24 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:26 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:28 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:30 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:32 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:34 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:36 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:38 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:48:41 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:48:42 DEBUG : pacer: Reducing sleep to 1.125s run.go:186: removing dir "test_dir2/sub_dir" failed - try 1/3: sleeping 1s: directory not empty 2026/07/31 05:48:43 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:48:46 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/07/31 05:48:46 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/07/31 05:48:48 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:48:48 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:48:49 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:48:49 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: TestSyncReplaceDirModTime Messages: listing wrong, want got 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/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: TestSyncReplaceDirModTime Messages: Unexpected file "potato" --- FAIL: TestSyncReplaceDirModTime (116.43s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", Modify Window "876000h0m0s" 2026/07/31 05:48:59 DEBUG : empty_dir: Making directory with metadata 2026/07/31 05:48:59 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/07/31 05:48:59 DEBUG : empty_on_remote: Making directory with metadata 2026/07/31 05:48:59 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/07/31 05:48:59 INFO : empty_on_remote: Making directory 2026/07/31 05:49:01 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/07/31 05:49:13 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2026/07/31 05:49:13 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2026/07/31 05:49:13 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2026/07/31 05:49:13 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2026/07/31 05:49:13 INFO : empty_dir: Set directory modification time (using DirSetModTime) 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:2857 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2868 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncReplaceDirModTimeWithEmptyDirs Messages: listing wrong, want file1 (5), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) got file1 (5), potato (21), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) 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:2857 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2868 Error: Should be true Test: TestSyncReplaceDirModTimeWithEmptyDirs Messages: Unexpected file "potato" 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 run.go:186: removing dir "test_dir2" failed - try 1/3: sleeping 1s: directory not empty fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/07/31 05:50:17 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:17 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:50:17 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:17 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:50:17 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:17 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:50:18 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:18 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:50:20 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:22 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:24 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:26 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:28 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:30 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:30 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: TestSyncReplaceDirModTimeWithEmptyDirs (90.48s) === RUN TestNothingToTransferWithEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: listing wrong, want sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got file1 (5), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: Unexpected file "file1" 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: Unexpected file "test_dir2/sub_dir/file3" 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: Unexpected file "test_dir1/file2" 2026/07/31 05:50:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/07/31 05:50:37 INFO : sub dir: Making directory 2026/07/31 05:50:37 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:39 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:50:41 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:50:43 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:50:46 DEBUG : pacer: Reducing sleep to 843.75ms 2026/07/31 05:50:46 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: listing wrong, want sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got file1 (5), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: Unexpected file "file1" 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: Unexpected file "test_dir2/sub_dir/file3" 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: Unexpected file "test_dir1/file2" 2026/07/31 05:51:33 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/07/31 05:51:35 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:51:37 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:51:39 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:51:41 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:51:44 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:51:45 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "potato" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:51:46 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "potato" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:51:48 DEBUG : pacer: Reducing sleep to 474.609375ms run.go:172: removing file "potato" failed: could not Remove: Linkbox error 403: not permit 2026/07/31 05:51:48 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:51:49 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:51:49 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:51:50 DEBUG : pacer: Reducing sleep to 200ms run.go:186: removing dir "sub dir2/very/very/very/very/very" failed - try 1/3: sleeping 1s: directory not empty 2026/07/31 05:52:19 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:19 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:52:20 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:20 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:52:20 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:20 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:52:21 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:52:22 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:24 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:26 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:28 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:30 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:32 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52: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: TestNothingToTransferWithEmptyDirs (122.74s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-togalen6boxi'", Local "Local file system at /tmp/rclone2406418603", 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: listing wrong, want sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got file1 (5), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: Unexpected file "file1" 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: Unexpected file "test_dir2/sub_dir/file3" 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:2879 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: Unexpected file "test_dir1/file2" 2026/07/31 05:52:39 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/07/31 05:52:39 INFO : sub dir: Making directory 2026/07/31 05:52:40 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:52:42 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:52:45 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:52:45 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: listing wrong, want sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got file1 (5), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: Unexpected file "file1" 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: Unexpected file "test_dir2/sub_dir/file3" 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:2903 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: Unexpected file "test_dir1/file2" 2026/07/31 05:53:33 ERROR : sub dir2/very/very/very/very/very: 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/07/31 05:53:35 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:53:37 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:53:39 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:53:41 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:53:43 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:53:46 DEBUG : pacer: Reducing sleep to 1.125s 2026/07/31 05:53:46 DEBUG : pacer: Reducing sleep to 843.75ms run.go:172: removing file "potato" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:53:47 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:172: removing file "potato" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/07/31 05:53:49 DEBUG : pacer: Reducing sleep to 474.609375ms run.go:172: removing file "potato" failed: could not Remove: Linkbox error 403: not permit 2026/07/31 05:53:50 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/07/31 05:53:50 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/07/31 05:53:51 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/07/31 05:53:51 DEBUG : pacer: Reducing sleep to 200ms run.go:186: removing dir "sub dir2" failed - try 1/3: sleeping 1s: directory not empty fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/07/31 05:54:21 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:21 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/07/31 05:54:21 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:21 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/07/31 05:54:22 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:22 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/07/31 05:54:23 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:23 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/07/31 05:54:24 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:26 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:28 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:30 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:32 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:34 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54: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: TestNothingToTransferWithoutEmptyDirs (121.79s) FAIL 2026/07/31 05:54:34 DEBUG : Linkbox root 'rclone-test-togalen6boxi': Purge remote 2026/07/31 05:54:36 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:38 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:40 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/07/31 05:54:43 DEBUG : pacer: Reducing sleep to 1.5s 2026/07/31 05:54:46 DEBUG : pacer: Reducing sleep to 1.125s "./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyOverSelf|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMove|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncIgnoreCase|TestSyncIgnoreErrors|TestSyncIgnoreExisting|TestSyncIgnoreTimes|TestSyncImmutable|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncUTFNorm)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Finished ERROR in 29m8.386811275s (try 4/5): exit status 1: Failed [TestCopyOverSelf TestServerSideMoveOverSelf TestSyncIgnoreTimes TestSyncIgnoreExisting TestSyncIgnoreErrors TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestServerSideMove TestServerSideMoveWithFilter TestSyncUTFNorm TestSyncImmutable TestSyncIgnoreCase TestMaxTransfer/Hard TestMaxTransfer/Soft TestMaxTransfer/Cautious TestSyncConcurrentDelete TestSyncConcurrentTruncate TestSyncReplaceDirModTime TestSyncReplaceDirModTimeWithEmptyDirs TestNothingToTransferWithEmptyDirs TestNothingToTransferWithoutEmptyDirs]