"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyFile|TestCopyFileImmutable|TestCount|TestDelete|TestDirMove|TestDirMoveContext|TestDirMoveMoveError|TestParseSumFile|TestRmdirsLeaveRoot)$|^TestCheckDownload$/^5$|^TestRcat$/^withChecksum=false,ignoreChecksum=true$|^TestRcatSizeChecksum$/^NoHashes$'" - Starting (try 2/5) 2026/09/22 03:24:52 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-muyebaj6luwu" 2026/09/22 03:24:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/22 03:24:52 DEBUG : Linkbox root 'rclone-test-muyebaj6luwu': Using cached web token 2026/09/22 03:24:53 DEBUG : Creating backend with remote "/tmp/rclone2256357856" === RUN TestCheckDownload run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" === RUN TestCheckDownload/5 --- PASS: TestCheckDownload (17.31s) --- PASS: TestCheckDownload/5 (0.65s) === RUN TestParseSumFile run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:25:13 NOTICE: test.sum: improperly formatted checksum line 4 2026/09/22 03:25:13 NOTICE: test.sum: improperly formatted checksum line 5 2026/09/22 03:25:13 NOTICE: test.sum: improperly formatted checksum line 6 2026/09/22 03:25:13 NOTICE: test.sum: 2 warning(s) suppressed... 2026/09/22 03:25:13 DEBUG : test.sum: Update: removing old file 2026/09/22 03:25:17 NOTICE: test.sum: improperly formatted checksum line 4 2026/09/22 03:25:17 NOTICE: test.sum: improperly formatted checksum line 5 2026/09/22 03:25:17 NOTICE: test.sum: improperly formatted checksum line 6 2026/09/22 03:25:17 NOTICE: test.sum: 2 warning(s) suppressed... --- PASS: TestParseSumFile (8.63s) === RUN TestCheckSumDownload run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:25:19 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-muyebaj6luwu/data" 2026/09/22 03:25:19 DEBUG : Config file has changed externally - reloading 2026/09/22 03:25:19 DEBUG : Linkbox root 'rclone-test-muyebaj6luwu/data': Using cached web token 2026/09/22 03:25:19 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:19 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:25:20 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:20 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:25:20 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:20 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:25:21 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:25:22 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:24 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:26 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:28 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:30 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:32 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:34 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:36 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:38 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:40 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:25:43 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:25:44 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestCheckSumDownload/subtest1 2026/09/22 03:25:56 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest2 2026/09/22 03:26:00 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest3 2026/09/22 03:26:05 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest4 2026/09/22 03:26:09 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest5 2026/09/22 03:26:14 DEBUG : test.sum: Update: removing old file 2026/09/22 03:26:14 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:14 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:26:14 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:14 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:26:15 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:15 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:26:15 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:15 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:26:17 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:19 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:21 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:23 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:25 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:27 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:27 ERROR : test.sum: Update: failed to remove existing file: could not Remove: invalid character '<' looking for beginning of value 2026/09/22 03:26:29 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:31 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:33 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:35 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:37 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:39 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:41 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:26:43 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:26:46 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/22 03:26:47 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/22 03:26:48 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/22 03:26:49 DEBUG : pacer: Reducing sleep to 474.609375ms === NAME TestCheckSumDownload fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache 2026/09/22 03:26:50 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/22 03:26:50 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/22 03:26:51 DEBUG : pacer: Reducing sleep to 200.225829ms fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache 2026/09/22 03:26:53 DEBUG : pacer: Reducing sleep to 200ms 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/check_test.go:512 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:545 /usr/local/go/src/runtime/asm_amd64.s:1264 Error: Should be true Test: TestCheckSumDownload Messages: listing wrong, want data/banana (13), data/potato (15), test.sum (123) got data/banana (13), data/potato (15), test(1).sum (123), test.sum (123) 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/check_test.go:512 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:545 Error: Should be true Test: TestCheckSumDownload Messages: Unexpected file "test(1).sum" === RUN TestCheckSumDownload/subtest6 === NAME TestCheckSumDownload check_test.go:413: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:413 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: 2 actual : 1 Test: TestCheckSumDownload Messages: wrong error count in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:421 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "* potato", "+ orange", "= banana"} actual : []string{"", "+ orange", "= banana", "= potato"} Diff: --- Expected +++ Actual @@ -2,5 +2,5 @@ (string) "", - (string) (len=8) "* potato", (string) (len=8) "+ orange", - (string) (len=8) "= banana" + (string) (len=8) "= banana", + (string) (len=8) "= potato" } Test: TestCheckSumDownload Messages: wrong combined result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:424 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "banana"} actual : []string{"", "banana", "potato"} Diff: --- Expected +++ Actual @@ -1,4 +1,5 @@ -([]string) (len=2) { +([]string) (len=3) { (string) "", - (string) (len=6) "banana" + (string) (len=6) "banana", + (string) (len=6) "potato" } Test: TestCheckSumDownload Messages: wrong match result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong differ result in run 6 2026/09/22 03:26:59 DEBUG : data/banana: Update: removing old file 2026/09/22 03:27:03 DEBUG : data/potato: Update: removing old file 2026/09/22 03:27:06 DEBUG : test.sum: Update: removing old file 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/check_test.go:529 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:545 /usr/local/go/src/runtime/asm_amd64.s:1264 Error: Should be true Test: TestCheckSumDownload Messages: listing wrong, want data/banana (13), data/potato (15), test.sum (82) got data/banana (13), data/potato (15), test(1).sum (123), test.sum (82) 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/check_test.go:529 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:545 Error: Should be true Test: TestCheckSumDownload Messages: Unexpected file "test(1).sum" === RUN TestCheckSumDownload/subtest7 --- FAIL: TestCheckSumDownload (128.29s) --- PASS: TestCheckSumDownload/subtest1 (2.43s) --- PASS: TestCheckSumDownload/subtest2 (0.76s) --- PASS: TestCheckSumDownload/subtest3 (0.76s) --- PASS: TestCheckSumDownload/subtest4 (0.69s) --- PASS: TestCheckSumDownload/subtest5 (0.88s) --- PASS: TestCheckSumDownload/subtest6 (1.25s) --- PASS: TestCheckSumDownload/subtest7 (1.24s) === RUN TestCopyFile run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:27:27 DEBUG : file1: Need to transfer - File not found at Destination 2026/09/22 03:27:31 DEBUG : sub/file2: size = 14 OK 2026/09/22 03:27:31 INFO : file1: Copied (new) to: sub/file2 2026/09/22 03:27:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:31 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:27:31 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:31 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:27:32 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:32 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:27:33 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:33 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:27:34 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:36 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:38 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:40 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:42 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:27:44 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:27:44 DEBUG : sub/file2: size = 14 OK 2026/09/22 03:27:44 DEBUG : file1: Sizes identical 2026/09/22 03:27:44 DEBUG : file1: Unchanged skipping 2026/09/22 03:27:46 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/22 03:27:48 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/22 03:27:48 DEBUG : Linkbox root 'rclone-test-muyebaj6luwu': don't need to copy/move sub/file2, it is already at target location 2026/09/22 03:27:49 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/22 03:27:50 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/22 03:27:51 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/22 03:27:51 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/22 03:27:52 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/22 03:27:53 DEBUG : pacer: Reducing sleep to 200ms --- PASS: TestCopyFile (27.20s) === RUN TestCopyFileImmutable run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:27:54 DEBUG : existing: Need to transfer - File not found at Destination 2026/09/22 03:27:56 DEBUG : existing: size = 6 OK 2026/09/22 03:27:56 INFO : existing: Copied (new) 2026/09/22 03:27:57 DEBUG : existing: size = 6 OK 2026/09/22 03:27:57 DEBUG : existing: Sizes identical 2026/09/22 03:27:57 DEBUG : existing: Unchanged skipping 2026/09/22 03:27:57 DEBUG : existing: size = 8 (Local file system at /tmp/rclone2256357856) 2026/09/22 03:27:57 DEBUG : existing: size = 6 (Linkbox root 'rclone-test-muyebaj6luwu') 2026/09/22 03:27:57 DEBUG : existing: Sizes differ 2026/09/22 03:27:57 ERROR : existing: Source and destination exist but do not match: immutable file modified --- PASS: TestCopyFileImmutable (5.32s) === RUN TestCount run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" --- PASS: TestCount (14.61s) === RUN TestDelete run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:28:17 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:17 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:28:17 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:17 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:28:17 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:17 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:28:18 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:18 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:28:20 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:22 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:24 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:26 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:28 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:30 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "medium" to Linkbox root 'rclone-test-muyebaj6luwu': 1/10 (Update second step failed: invalid character '<' looking for beginning of value) 2026/09/22 03:28:32 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:34 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:36 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:38 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:40 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:42 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:44 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:28:46 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:28:48 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/22 03:28:51 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/22 03:28:51 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/22 03:28:52 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/22 03:28:52 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/22 03:28:54 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/22 03:28:54 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/22 03:28:54 DEBUG : pacer: Reducing sleep to 200ms 2026/09/22 03:28:54 DEBUG : Waiting for deletions to finish 2026/09/22 03:28:55 DEBUG : large: Excluded (Size Filter) 2026/09/22 03:28:55 DEBUG : large: Excluded 2026/09/22 03:28:56 INFO : medium: Deleted 2026/09/22 03:28:56 INFO : small: Deleted --- PASS: TestDelete (44.02s) === RUN TestRmdirsLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:28:58 INFO : A1: Making directory 2026/09/22 03:29:00 INFO : A1/B1: Making directory 2026/09/22 03:29:01 INFO : A1/B1/C1: Making directory 2026/09/22 03:29:04 DEBUG : removing 1 level 3 directories 2026/09/22 03:29:04 INFO : A1/B1/C1: Removing directory 2026/09/22 03:29:06 DEBUG : removing 1 level 2 directories 2026/09/22 03:29:06 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (11.71s) === RUN TestDirMoveMoveError run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:29:26 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:26 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:29:26 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:26 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:29:27 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:27 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:29:27 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:27 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:29:29 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:31 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:33 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:35 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:37 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:39 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:41 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:43 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:29:45 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:29:48 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/22 03:29:49 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/22 03:29:50 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/22 03:29:51 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/22 03:29:52 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/22 03:29:53 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/22 03:29:53 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/22 03:29:53 DEBUG : pacer: Reducing sleep to 200ms operations_test.go:1487: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1487 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1516 Error: Expected value not to be nil. Test: TestDirMoveMoveError Messages: the test needs a backend with Move 2026/09/22 03:30:22 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:22 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:30:23 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:23 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:30:23 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:23 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:30:24 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:24 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:30:25 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:27 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:29 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:31 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:33 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:35 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:173: removing file "A/file12" failed - try 1/3: sleeping 1s: could not Remove: invalid character '<' looking for beginning of value 2026/09/22 03:30:37 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:39 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:41 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:44 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:30:47 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:30:49 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/22 03:30:50 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/22 03:30:52 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/22 03:30:53 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/22 03:30:54 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/22 03:30:56 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/22 03:30:57 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/22 03:30:58 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestDirMoveMoveError (119.55s) === RUN TestDirMoveContext run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" operations_test.go:1487: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1487 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1540 Error: Expected value not to be nil. Test: TestDirMoveContext Messages: the test needs a backend with Move --- FAIL: TestDirMoveContext (10.48s) === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:31:34 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:34 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:31:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:35 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:31:35 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:35 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:31:36 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:36 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:31:37 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:39 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:41 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:43 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:45 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:31:48 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:31:50 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/22 03:31:52 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/22 03:31:52 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/22 03:31:52 INFO : A1/B2: Making directory 2026/09/22 03:31:53 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/22 03:31:55 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/22 03:31:55 INFO : A1/B1/C3: Making directory 2026/09/22 03:31:55 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/22 03:31:57 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/22 03:31:57 DEBUG : pacer: Reducing sleep to 200ms 2026/09/22 03:32:14 DEBUG : A2/one: size = 3 OK 2026/09/22 03:32:14 INFO : A1/one: Copied (new) to: A2/one 2026/09/22 03:32:14 DEBUG : A2/two: size = 3 OK 2026/09/22 03:32:14 INFO : A1/two: Copied (new) to: A2/two 2026/09/22 03:32:15 DEBUG : A2/B1/C2/five: size = 4 OK 2026/09/22 03:32:15 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/09/22 03:32:15 DEBUG : A2/B1/C1/four: size = 4 OK 2026/09/22 03:32:15 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/09/22 03:32:15 DEBUG : A2/B1/three: size = 5 OK 2026/09/22 03:32:15 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/09/22 03:32:16 INFO : A1/one: Deleted 2026/09/22 03:32:16 INFO : A1/two: Deleted 2026/09/22 03:32:17 INFO : A1/B1/C2/five: Deleted 2026/09/22 03:32:17 INFO : A1/B1/C1/four: Deleted 2026/09/22 03:32:17 INFO : A1/B1/three: Deleted 2026/09/22 03:32:20 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:20 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:32:20 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:20 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:32:21 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:21 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:32:22 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:22 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:32:23 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:25 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:27 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:29 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:31 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:33 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) operations_test.go:1587: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1587 Error: Received unexpected error: RenameDir rmdir: getting files failed: invalid character '<' looking for beginning of value Test: TestDirMove 2026/09/22 03:32:35 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:37 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:39 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:41 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:43 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:45 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:32:47 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/22 03:32:49 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/22 03:32:51 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/22 03:32:53 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/22 03:32:54 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/22 03:32:55 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/22 03:32:55 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/22 03:32:56 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/22 03:32:56 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestDirMove (116.33s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:33:16 DEBUG : Linkbox root 'rclone-test-muyebaj6luwu': File to upload is small (34 bytes), uploading instead of streaming 2026/09/22 03:33:19 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2026/09/22 03:33:19 DEBUG : ignore_checksum_small_file_from_pipe: Sizes identical 2026/09/22 03:33:19 DEBUG : Linkbox root 'rclone-test-muyebaj6luwu': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/09/22 03:33:21 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2026/09/22 03:33:21 DEBUG : ignore_checksum_big_file_from_pipe: Sizes identical --- PASS: TestRcat (7.70s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (7.70s) === RUN TestRcatSizeChecksum === RUN TestRcatSizeChecksum/NoHashes run.go:198: Remote "Linkbox root 'rclone-test-muyebaj6luwu'", Local "Local file system at /tmp/rclone2256357856", Modify Window "876000h0m0s" 2026/09/22 03:33:26 DEBUG : potato3: size = 60 OK 2026/09/22 03:33:28 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:28 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/09/22 03:33:28 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:28 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/09/22 03:33:28 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:28 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/09/22 03:33:29 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:29 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/22 03:33:31 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:33 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:35 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:37 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:39 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:41 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:41 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: TestRcatSizeChecksum (16.72s) --- FAIL: TestRcatSizeChecksum/NoHashes (16.72s) FAIL 2026/09/22 03:33:41 DEBUG : Linkbox root 'rclone-test-muyebaj6luwu': Purge remote 2026/09/22 03:33:43 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:45 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:47 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/09/22 03:33:50 DEBUG : pacer: Reducing sleep to 1.5s "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyFile|TestCopyFileImmutable|TestCount|TestDelete|TestDirMove|TestDirMoveContext|TestDirMoveMoveError|TestParseSumFile|TestRmdirsLeaveRoot)$|^TestCheckDownload$/^5$|^TestRcat$/^withChecksum=false,ignoreChecksum=true$|^TestRcatSizeChecksum$/^NoHashes$'" - Finished ERROR in 8m58.27586446s (try 2/5): exit status 1: Failed [TestCheckSumDownload TestDirMoveMoveError TestDirMoveContext TestDirMove TestRcatSizeChecksum/NoHashes]