"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyDirMetadata|TestDirMove|TestDirsEqual|TestMaxDelete|TestMaxDeleteSize|TestMkdirMetadata|TestMkdirModTime|TestRcatSize|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestSetDirModTime|TestTouchDir)$|^TestRcat$/^withChecksum=false,ignoreChecksum=false$|^TestRcatSizeChecksum$/^(IgnoreChecksum|NoHashes|SizeDiffers)$'" - Starting (try 5/5) 2026/09/08 03:45:39 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-luhewan9vacu" 2026/09/08 03:45:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/08 03:45:39 DEBUG : Linkbox root 'rclone-test-luhewan9vacu': Using cached web token 2026/09/08 03:45:40 DEBUG : Creating backend with remote "/tmp/rclone2763814510" === RUN TestCheckSumDownload run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:45:40 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-luhewan9vacu/data" 2026/09/08 03:45:40 DEBUG : Linkbox root 'rclone-test-luhewan9vacu/data': Using cached web token 2026/09/08 03:45:44 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:45:44 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:45:44 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:45:44 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:45:45 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:45:45 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:45:46 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:45:46 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:45:47 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:45:49 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:45:51 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:45:53 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:45:56 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:45:56 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:45:57 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/08 03:45:58 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:45:59 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:46:00 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:46:00 DEBUG : pacer: Reducing sleep to 200ms === RUN TestCheckSumDownload/subtest1 2026/09/08 03:46:04 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest2 2026/09/08 03:46:08 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest3 2026/09/08 03:46:13 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest4 2026/09/08 03:46:17 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest5 2026/09/08 03:46:22 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest6 2026/09/08 03:46:27 DEBUG : data/banana: Update: removing old file 2026/09/08 03:46:30 DEBUG : data/potato: Update: removing old file 2026/09/08 03:46:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:31 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:46:32 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:32 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:46:32 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:32 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:46:33 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:33 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:46:34 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:36 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:38 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:40 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:42 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:44 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) === NAME TestCheckSumDownload run.go:299: Retry Put of "data/potato" to Linkbox root 'rclone-test-luhewan9vacu': 1/10 (Update err in unmarshaling response: invalid character '<' looking for beginning of value) 2026/09/08 03:46:46 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:48 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:50 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:46:53 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:46:55 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:46:57 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:46:58 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:46:58 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/08 03:46:58 DEBUG : test.sum: Update: removing old file 2026/09/08 03:47:00 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:47:00 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:47:02 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:47:02 DEBUG : pacer: Reducing sleep to 200ms === RUN TestCheckSumDownload/subtest7 --- PASS: TestCheckSumDownload (89.45s) --- PASS: TestCheckSumDownload/subtest1 (1.53s) --- PASS: TestCheckSumDownload/subtest2 (0.46s) --- PASS: TestCheckSumDownload/subtest3 (0.69s) --- PASS: TestCheckSumDownload/subtest4 (0.67s) --- PASS: TestCheckSumDownload/subtest5 (0.70s) --- PASS: TestCheckSumDownload/subtest6 (0.84s) --- PASS: TestCheckSumDownload/subtest7 (0.79s) === RUN TestMaxDelete run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:47:16 DEBUG : Waiting for deletions to finish 2026/09/08 03:47:16 ERROR : large: Got fatal error on delete: --max-delete threshold reached 2026/09/08 03:47:17 INFO : medium: Deleted 2026/09/08 03:47:17 INFO : small: Deleted fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestMaxDelete (17.92s) === RUN TestMaxDeleteSize run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:47:34 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:34 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:47:34 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:34 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:47:34 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:34 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:47:35 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:35 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:47:37 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:39 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:41 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:43 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:45 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:47 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:47 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:283: Error listing: getting files failed: invalid character '<' looking for beginning of value 2026/09/08 03:47:49 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:51 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:47:53 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:47:56 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:47:57 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:47:59 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:47:59 DEBUG : pacer: Reducing sleep to 474.609375ms fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache 2026/09/08 03:48:00 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:48:01 DEBUG : pacer: Reducing sleep to 266.967773ms fstest.go:293: Sleeping for 6s just to make sure 2026/09/08 03:48:07 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:48:07 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestMaxDeleteSize (39.71s) === RUN TestRmdirsNoLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:48:14 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:48:14 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:48:14 INFO : A2: Making directory 2026/09/08 03:48:16 INFO : A1/B2: Making directory 2026/09/08 03:48:17 INFO : A1/B2/C2: Making directory 2026/09/08 03:48:19 INFO : A1/B1/C3: Making directory 2026/09/08 03:48:20 INFO : A3: Making directory 2026/09/08 03:48:22 INFO : A3/B3: Making directory 2026/09/08 03:48:24 INFO : A3/B3/C4: Making directory 2026/09/08 03:48:27 DEBUG : A1/two: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:48:30 DEBUG : removing 1 level 3 directories 2026/09/08 03:48:30 INFO : A3/B3/C4: Removing directory 2026/09/08 03:48:32 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:32 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:48:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:33 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:48:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:33 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:48:34 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:34 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:48:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:37 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:39 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:41 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:43 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:45 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:47 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:49 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:51 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:48:53 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:48:55 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:48:57 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:48:58 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:48:59 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/08 03:49:00 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:49:00 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:49:00 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:49:01 DEBUG : pacer: Reducing sleep to 200ms 2026/09/08 03:49:02 DEBUG : removing 2 level 3 directories 2026/09/08 03:49:02 INFO : A1/B2/C2: Removing directory 2026/09/08 03:49:02 INFO : A1/B1/C3: Removing directory 2026/09/08 03:49:04 DEBUG : removing 2 level 2 directories 2026/09/08 03:49:04 INFO : A3/B3: Removing directory 2026/09/08 03:49:04 INFO : A1/B2: Removing directory 2026/09/08 03:49:06 DEBUG : removing 2 level 1 directories 2026/09/08 03:49:06 INFO : A3: Removing directory 2026/09/08 03:49:06 INFO : A2: Removing directory fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:328: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:328 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:734 Error: Not equal: expected: []string{} actual : []string{"A1", "A1/B1", "A1/B1/C1"} Diff: --- Expected +++ Actual @@ -1,2 +1,5 @@ -([]string) { +([]string) (len=3) { + (string) (len=2) "A1", + (string) (len=5) "A1/B1", + (string) (len=8) "A1/B1/C1" } Test: TestRmdirsNoLeaveRoot Messages: directories run.go:186: removing dir "A1" failed - try 1/3: sleeping 1s: directory not empty --- FAIL: TestRmdirsNoLeaveRoot (83.19s) === RUN TestRmdirsLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:49:30 INFO : A1: Making directory 2026/09/08 03:49:32 INFO : A1/B1: Making directory 2026/09/08 03:49:33 INFO : A1/B1/C1: Making directory 2026/09/08 03:49:36 DEBUG : removing 1 level 3 directories 2026/09/08 03:49:36 INFO : A1/B1/C1: Removing directory 2026/09/08 03:49:38 DEBUG : removing 1 level 2 directories 2026/09/08 03:49:38 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (11.63s) === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:49:45 DEBUG : A1/one: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:49:46 DEBUG : A1/one: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:49:46 DEBUG : A1/one: Trying to read object after upload: try again in 400ms (3/10) 2026/09/08 03:49:47 DEBUG : A1/one: Trying to read object after upload: try again in 800ms (4/10) 2026/09/08 03:49:51 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:49:51 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:49:52 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:49:52 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:49:52 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:49:52 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:49:53 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:49:53 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:49:55 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:49:57 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:49:59 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:50:00 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:50:01 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/08 03:50:02 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:50:03 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:50:03 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:50:05 DEBUG : pacer: Reducing sleep to 200ms 2026/09/08 03:50:05 DEBUG : A1/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:50:05 DEBUG : A1/B1/C1/four: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:50:09 DEBUG : A1/B1/C2/five: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:50:09 DEBUG : A1/B1/C2/five: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:50:10 DEBUG : A1/B1/C2/five: Trying to read object after upload: try again in 400ms (3/10) 2026/09/08 03:50:10 DEBUG : A1/B1/C2/five: Trying to read object after upload: try again in 800ms (4/10) 2026/09/08 03:50:11 INFO : A1/B2: Making directory 2026/09/08 03:50:13 INFO : A1/B1/C3: Making directory 2026/09/08 03:50:32 DEBUG : A2/B1/three: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:50:32 DEBUG : A2/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:50:32 DEBUG : A2/B1/three: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:50:33 DEBUG : A2/B1/C2/five: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:50:33 DEBUG : A2/B1/C1/four: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:50:33 DEBUG : A2/one: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:50:33 DEBUG : A2/two: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:50:33 DEBUG : A2/B1/three: Trying to read object after upload: try again in 400ms (3/10) 2026/09/08 03:50:34 DEBUG : A2/B1/C2/five: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:50:34 DEBUG : A2/B1/C1/four: Trying to read object after upload: try again in 400ms (3/10) 2026/09/08 03:50:34 DEBUG : A2/one: size = 3 OK 2026/09/08 03:50:34 INFO : A1/one: Copied (new) to: A2/one 2026/09/08 03:50:34 DEBUG : A2/two: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:50:34 DEBUG : A2/B1/C2/five: Trying to read object after upload: try again in 400ms (3/10) 2026/09/08 03:50:35 DEBUG : A2/B1/three: Trying to read object after upload: try again in 800ms (4/10) 2026/09/08 03:50:35 DEBUG : A2/B1/C1/four: size = 4 OK 2026/09/08 03:50:35 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/09/08 03:50:35 DEBUG : A2/two: size = 3 OK 2026/09/08 03:50:35 INFO : A1/two: Copied (new) to: A2/two 2026/09/08 03:50:35 DEBUG : A2/B1/C2/five: Trying to read object after upload: try again in 800ms (4/10) 2026/09/08 03:50:36 INFO : A1/one: Deleted 2026/09/08 03:50:36 DEBUG : A2/B1/three: size = 5 OK 2026/09/08 03:50:36 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/09/08 03:50:36 DEBUG : A2/B1/C2/five: size = 4 OK 2026/09/08 03:50:36 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/09/08 03:50:37 INFO : A1/B1/C1/four: Deleted 2026/09/08 03:50:37 INFO : A1/two: Deleted 2026/09/08 03:50:37 INFO : A1/B1/three: Deleted 2026/09/08 03:50:38 INFO : A1/B1/C2/five: Deleted 2026/09/08 03:50:48 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:50:48 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:50:49 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:50:49 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:50:49 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:50:49 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:50:50 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:50:50 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:50:51 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:50:53 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:50:56 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:50:58 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:50:59 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:51:00 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:51:01 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/08 03:51:02 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:51:02 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:51:04 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:51:04 DEBUG : pacer: Reducing sleep to 200ms 2026/09/08 03:51:17 DEBUG : A3/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:51:17 DEBUG : A3/B1/C2/five: size = 4 OK 2026/09/08 03:51:17 INFO : A2/B1/C2/five: Copied (new) to: A3/B1/C2/five 2026/09/08 03:51:17 DEBUG : A3/B1/C1/four: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:51:17 DEBUG : A3/one: size = 3 OK 2026/09/08 03:51:17 INFO : A2/one: Copied (new) to: A3/one 2026/09/08 03:51:18 DEBUG : A3/two: size = 3 OK 2026/09/08 03:51:18 INFO : A2/two: Copied (new) to: A3/two 2026/09/08 03:51:18 DEBUG : A3/B1/C1/four: size = 4 OK 2026/09/08 03:51:18 INFO : A2/B1/C1/four: Copied (new) to: A3/B1/C1/four 2026/09/08 03:51:19 DEBUG : A3/B1/three: size = 5 OK 2026/09/08 03:51:19 INFO : A2/B1/three: Copied (new) to: A3/B1/three 2026/09/08 03:51:19 INFO : A2/B1/C2/five: Deleted 2026/09/08 03:51:19 INFO : A2/one: Deleted 2026/09/08 03:51:20 INFO : A2/two: Deleted 2026/09/08 03:51:20 INFO : A2/B1/C1/four: Deleted 2026/09/08 03:51:20 INFO : A2/B1/three: Deleted 2026/09/08 03:51:29 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:29 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:51:30 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:30 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:51:30 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:30 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:51:31 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:31 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:51:32 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:34 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:36 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:38 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:40 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:42 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:42 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:283: Error listing: getting files failed: invalid character '<' looking for beginning of value 2026/09/08 03:51:44 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:46 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:48 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:50 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:52 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:51:55 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:51:57 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:51:59 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:52:00 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:52:01 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/08 03:52:01 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:52:03 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:52:03 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:52:04 DEBUG : pacer: Reducing sleep to 200ms fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- FAIL: TestDirMove (161.67s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:52:24 DEBUG : Linkbox root 'rclone-test-luhewan9vacu': File to upload is small (34 bytes), uploading instead of streaming 2026/09/08 03:52:26 DEBUG : no_checksum_small_file_from_pipe: size = 34 OK 2026/09/08 03:52:26 NOTICE: Linkbox root 'rclone-test-luhewan9vacu': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2026/09/08 03:52:26 DEBUG : no_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/09/08 03:52:26 DEBUG : Linkbox root 'rclone-test-luhewan9vacu': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/09/08 03:52:28 DEBUG : no_checksum_big_file_from_pipe: size = 102401 OK 2026/09/08 03:52:28 DEBUG : no_checksum_big_file_from_pipe: Size of src and dst objects identical --- PASS: TestRcat (7.52s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (7.52s) === RUN TestRcatSize run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:52:33 DEBUG : potato1: size = 60 OK 2026/09/08 03:52:33 DEBUG : Linkbox root 'rclone-test-luhewan9vacu': File to upload is small (60 bytes), uploading instead of streaming 2026/09/08 03:52:35 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:35 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:52:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:35 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:52:36 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:36 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:52:36 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:36 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:52:38 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:40 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:42 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:44 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:46 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:48 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:48 DEBUG : potato2: Received error: Update failed to read object: getting files failed: invalid character '<' looking for beginning of value - low level retry 1/10 2026/09/08 03:52:50 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:52 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:54 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:52:56 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:52:56 DEBUG : potato2: Update: removing old file 2026/09/08 03:52:59 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:53:00 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/08 03:53:02 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:53:02 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/08 03:53:02 DEBUG : potato2: size = 60 OK 2026/09/08 03:53:02 DEBUG : potato2: Size of src and dst objects identical 2026/09/08 03:53:03 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:53:03 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:53:05 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:53:06 DEBUG : pacer: Reducing sleep to 200ms --- PASS: TestRcatSize (35.18s) === RUN TestRcatSizeChecksum === RUN TestRcatSizeChecksum/SizeDiffers run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:53:08 DEBUG : potato4: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:53:08 DEBUG : potato4: size = 60 (Linkbox root 'rclone-test-luhewan9vacu') 2026/09/08 03:53:08 DEBUG : potato4: size = 59 (Linkbox root 'rclone-test-luhewan9vacu') 2026/09/08 03:53:08 ERROR : potato4: corrupted on transfer: sizes differ src 60 vs dst(Linkbox root 'rclone-test-luhewan9vacu') 59 2026/09/08 03:53:08 INFO : potato4: Removing failed copy fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:351 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1815 Error: Should be true Test: TestRcatSizeChecksum/SizeDiffers Messages: listing wrong, want got potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:351 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1815 /usr/local/go/src/runtime/asm_amd64.s:1264 Error: Should be true Test: TestRcatSizeChecksum/SizeDiffers Messages: Unexpected file "potato4" run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/SizeDiffers Messages: listing wrong, want got potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/SizeDiffers Messages: Unexpected file "potato4" === RUN TestRcatSizeChecksum/IgnoreChecksum run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:53:33 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:53:33 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:53:33 DEBUG : potato2: size = 60 OK run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:53:38 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:38 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:53:38 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:38 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:53:38 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:38 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:53:39 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:39 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:53:41 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:43 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:45 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:47 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:49 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:51 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:173: removing file "potato4" failed: could not Remove: invalid character '<' looking for beginning of value 2026/09/08 03:53:53 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:55 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:53:57 DEBUG : pacer: Reducing sleep to 1.5s fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache 2026/09/08 03:53:59 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:54:01 DEBUG : pacer: Reducing sleep to 843.75ms fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache 2026/09/08 03:54:03 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/08 03:54:04 DEBUG : pacer: Reducing sleep to 474.609375ms fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/IgnoreChecksum Messages: listing wrong, want got potato2 (60), potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/IgnoreChecksum Messages: Unexpected file "potato2" fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/IgnoreChecksum Messages: Unexpected file "potato4" === RUN TestRcatSizeChecksum/NoHashes run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" 2026/09/08 03:54:08 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/08 03:54:08 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/08 03:54:09 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/08 03:54:10 DEBUG : pacer: Reducing sleep to 200ms 2026/09/08 03:54:10 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/09/08 03:54:11 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/09/08 03:54:11 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10) 2026/09/08 03:54:12 DEBUG : potato3: Trying to read object after upload: try again in 800ms (4/10) 2026/09/08 03:54:13 DEBUG : potato3: size = 60 OK run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/NoHashes Messages: listing wrong, want got potato2 (60), potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/NoHashes Messages: Unexpected file "potato2" fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 Error: Should be true Test: TestRcatSizeChecksum/NoHashes Messages: Unexpected file "potato4" --- FAIL: TestRcatSizeChecksum (82.60s) --- FAIL: TestRcatSizeChecksum/SizeDiffers (24.04s) --- FAIL: TestRcatSizeChecksum/IgnoreChecksum (37.33s) --- FAIL: TestRcatSizeChecksum/NoHashes (21.23s) === RUN TestTouchDir run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" operations_test.go:1842: Skipping test as remote does not support modtime run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache 2026/09/08 03:54:39 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:39 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:54:40 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:40 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:54:40 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:40 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:54:41 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:41 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:54:42 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:44 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:46 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:48 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:50 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:52 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:52 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:283: Error listing: getting files failed: invalid character '<' looking for beginning of value --- FAIL: TestTouchDir (23.69s) === RUN TestMkdirMetadata run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" operations_test.go:1880: Skipping test as remote does not support MkdirMetadata 2026/09/08 03:54:54 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:54:57 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:54:59 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:55:00 DEBUG : pacer: Reducing sleep to 843.75ms run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:55:01 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:55:03 DEBUG : pacer: Reducing sleep to 474.609375ms run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit 2026/09/08 03:55:04 DEBUG : pacer: Reducing sleep to 355.957031ms run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:55:05 DEBUG : pacer: Reducing sleep to 266.967773ms run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:55:07 DEBUG : pacer: Reducing sleep to 200.225829ms run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit 2026/09/08 03:55:07 DEBUG : pacer: Reducing sleep to 200ms fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1880 Error: Should be true Test: TestMkdirMetadata Messages: listing wrong, want got potato2 (60), potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1880 Error: Should be true Test: TestMkdirMetadata Messages: Unexpected file "potato2" fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1880 Error: Should be true Test: TestMkdirMetadata Messages: Unexpected file "potato4" --- FAIL: TestMkdirMetadata (22.81s) === RUN TestMkdirModTime run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" operations_test.go:1901: Skipping test as remote does not support DirSetModTime or MkdirMetadata run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1901 Error: Should be true Test: TestMkdirModTime Messages: listing wrong, want got potato2 (60), potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1901 Error: Should be true Test: TestMkdirModTime Messages: Unexpected file "potato2" fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1901 Error: Should be true Test: TestMkdirModTime Messages: Unexpected file "potato4" --- FAIL: TestMkdirModTime (15.24s) === RUN TestCopyDirMetadata run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" operations_test.go:1945: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1945 Error: Should be true Test: TestCopyDirMetadata Messages: listing wrong, want got potato2 (60), potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1945 Error: Should be true Test: TestCopyDirMetadata Messages: Unexpected file "potato2" fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1945 Error: Should be true Test: TestCopyDirMetadata Messages: Unexpected file "potato4" --- FAIL: TestCopyDirMetadata (15.28s) === RUN TestSetDirModTime run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" operations_test.go:1983: Skipping test as remote does not support DirSetModTime or WriteDirSetModTime 2026/09/08 03:55:46 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:46 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:55:46 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:46 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:55:46 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:46 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:55:47 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:47 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:55:49 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:51 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:53 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:55 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:55:57 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/08 03:55:59 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/08 03:56:01 DEBUG : pacer: Reducing sleep to 843.75ms run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:56:02 DEBUG : pacer: Reducing sleep to 632.8125ms run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:56:03 DEBUG : pacer: Reducing sleep to 474.609375ms run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit 2026/09/08 03:56:04 DEBUG : pacer: Reducing sleep to 355.957031ms run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:56:05 DEBUG : pacer: Reducing sleep to 266.967773ms run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit 2026/09/08 03:56:07 DEBUG : pacer: Reducing sleep to 200.225829ms run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit 2026/09/08 03:56:07 DEBUG : pacer: Reducing sleep to 200ms fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1983 Error: Should be true Test: TestSetDirModTime Messages: listing wrong, want got potato2 (60), potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1983 Error: Should be true Test: TestSetDirModTime Messages: Unexpected file "potato2" fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1983 Error: Should be true Test: TestSetDirModTime Messages: Unexpected file "potato4" --- FAIL: TestSetDirModTime (29.65s) === RUN TestDirsEqual run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" operations_test.go:2034: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:2034 Error: Should be true Test: TestDirsEqual Messages: listing wrong, want got potato2 (60), potato4 (59) fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:2034 Error: Should be true Test: TestDirsEqual Messages: Unexpected file "potato2" fstest.go:192: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /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:1460 /usr/local/go/src/testing/testing.go:1820 /usr/local/go/src/testing/testing.go:2187 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1402 /usr/local/go/src/testing/testing.go:1378 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:2034 Error: Should be true Test: TestDirsEqual Messages: Unexpected file "potato4" --- FAIL: TestDirsEqual (15.27s) === RUN TestRemoveExisting run.go:198: Remote "Linkbox root 'rclone-test-luhewan9vacu'", Local "Local file system at /tmp/rclone2763814510", Modify Window "876000h0m0s" operations_test.go:2103: Skipping as remote can't Move run.go:173: removing file "potato2" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato2" failed: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:173: removing file "potato4" failed: could not Remove: Linkbox error 403: not permit fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache 2026/09/08 03:56:39 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:39 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/08 03:56:39 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:39 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/08 03:56:40 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:40 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/08 03:56:41 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:41 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/08 03:56:42 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:44 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:46 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:48 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:50 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:52 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:52 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:283: Error listing: getting files failed: invalid character '<' looking for beginning of value --- FAIL: TestRemoveExisting (21.41s) FAIL 2026/09/08 03:56:52 DEBUG : Linkbox root 'rclone-test-luhewan9vacu': Purge remote 2026/09/08 03:56:54 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:56 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/08 03:56:59 DEBUG : pacer: Reducing sleep to 1.5s "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyDirMetadata|TestDirMove|TestDirsEqual|TestMaxDelete|TestMaxDeleteSize|TestMkdirMetadata|TestMkdirModTime|TestRcatSize|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestSetDirModTime|TestTouchDir)$|^TestRcat$/^withChecksum=false,ignoreChecksum=false$|^TestRcatSizeChecksum$/^(IgnoreChecksum|NoHashes|SizeDiffers)$'" - Finished ERROR in 11m20.645747306s (try 5/5): exit status 1: Failed [TestMaxDeleteSize TestRmdirsNoLeaveRoot TestDirMove TestRcatSizeChecksum/SizeDiffers TestRcatSizeChecksum/IgnoreChecksum TestRcatSizeChecksum/NoHashes TestTouchDir TestMkdirMetadata TestMkdirModTime TestCopyDirMetadata TestSetDirModTime TestDirsEqual TestRemoveExisting]