"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestDirMove|TestIndexChanged|TestPurge|TestRmdirsWithFilter)$'" - Starting (try 3/5) 2026/10/05 07:26:43 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-qonepux4zele" 2026/10/05 07:26:43 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/05 07:26:43 DEBUG : Linkbox root 'rclone-test-qonepux4zele': Using cached web token 2026/10/05 07:26:44 DEBUG : Creating backend with remote "/tmp/rclone704625394" === RUN TestCheckSumDownload run.go:198: Remote "Linkbox root 'rclone-test-qonepux4zele'", Local "Local file system at /tmp/rclone704625394", Modify Window "876000h0m0s" 2026/10/05 07:26:44 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-qonepux4zele/data" 2026/10/05 07:26:44 DEBUG : Linkbox root 'rclone-test-qonepux4zele/data': Using cached web token 2026/10/05 07:26:45 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:45 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:26:45 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:45 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:26:45 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:45 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:26:46 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:46 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:26:48 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:50 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:52 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:54 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:56 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:58 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:58 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:58 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:26:58 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:58 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:26:58 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:58 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:26:59 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:26:59 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:27:01 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:03 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:05 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:07 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:09 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:27:12 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:27:12 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:27:14 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:27:15 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:27:15 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:27:17 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:27:17 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:27:17 DEBUG : pacer: Reducing sleep to 200ms === RUN TestCheckSumDownload/subtest1 2026/10/05 07:27:27 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest2 2026/10/05 07:27:32 DEBUG : test.sum: Update: removing old file === RUN TestCheckSumDownload/subtest3 === NAME TestCheckSumDownload check_test.go:408: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:408 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Received unexpected error: cannot open sum file: getting files failed: invalid character '<' looking for beginning of value Test: TestCheckSumDownload Messages: unexpected error in run 3 check_test.go:417: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:417 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: "" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 3 check_test.go:419: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:419 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: 2 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 3 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{"", "= banana", "= potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=8) "= banana", - (string) (len=8) "= potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong combined result in run 3 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", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=6) "banana", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 3 2026/10/05 07:27:50 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:52 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:54 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:56 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:27:58 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:00 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:02 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:04 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:06 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:08 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:11 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:28:14 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:28:14 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:28:15 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:28:16 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/10/05 07:28:18 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:28:18 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:28:18 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/10/05 07:28:21 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:482 /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 (82), 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:482 /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/subtest4 === NAME TestCheckSumDownload check_test.go:411: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:411 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: An error is expected but got nil. Test: TestCheckSumDownload Messages: no expected error in run 4 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: 1 actual : 0 Test: TestCheckSumDownload Messages: wrong error count in run 4 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{"", "* banana", "= potato"} actual : []string{"", "= banana", "= potato"} Diff: --- Expected +++ Actual @@ -2,3 +2,3 @@ (string) "", - (string) (len=8) "* banana", + (string) (len=8) "= banana", (string) (len=8) "= potato" Test: TestCheckSumDownload Messages: wrong combined result in run 4 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{"", "potato"} actual : []string{"", "banana", "potato"} Diff: --- Expected +++ Actual @@ -1,3 +1,4 @@ -([]string) (len=2) { +([]string) (len=3) { (string) "", + (string) (len=6) "banana", (string) (len=6) "potato" Test: TestCheckSumDownload Messages: wrong match result in run 4 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{"", "banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong differ result in run 4 2026/10/05 07:28:27 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:497 /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 (82), 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:497 /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/subtest5 2026/10/05 07:28:40 DEBUG : test.sum: Update: removing old file 2026/10/05 07:28:42 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:42 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:28:42 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:42 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:28:42 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:42 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:28:43 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:43 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:28:45 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:47 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:49 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:51 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:53 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:55 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) === NAME TestCheckSumDownload run.go:299: Retry Put of "test.sum" to Linkbox root 'rclone-test-qonepux4zele': 1/10 (Update second step failed: invalid character '<' looking for beginning of value) 2026/10/05 07:28:57 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:28:59 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:01 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:03 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:05 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:07 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:09 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:29:11 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:29:14 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:29:14 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:29:15 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:29:15 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache 2026/10/05 07:29:17 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:29:17 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:29:17 DEBUG : pacer: Reducing sleep to 200ms 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: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 (82), 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 2026/10/05 07:29:26 DEBUG : data/banana: Update: removing old file 2026/10/05 07:29:29 DEBUG : data/potato: Update: removing old file 2026/10/05 07:29:32 DEBUG : test.sum: Update: removing old file 2026/10/05 07:29:36 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:36 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:29:36 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:36 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:29:36 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:36 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:29:37 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:37 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:29:39 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:41 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:43 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:45 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:47 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:49 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:49 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value === NAME TestCheckSumDownload fstest.go:283: Error listing: getting files failed: invalid character '<' looking for beginning of value 2026/10/05 07:29:51 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:53 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:55 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:57 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:29:59 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:01 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:03 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:05 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:07 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:09 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:30:12 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:30:14 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:30:14 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:30:16 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:30:17 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:30:17 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:30:19 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:30:19 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestCheckSumDownload (215.03s) --- PASS: TestCheckSumDownload/subtest1 (5.10s) --- PASS: TestCheckSumDownload/subtest2 (0.92s) --- PASS: TestCheckSumDownload/subtest3 (13.04s) --- PASS: TestCheckSumDownload/subtest4 (1.37s) --- PASS: TestCheckSumDownload/subtest5 (1.10s) --- PASS: TestCheckSumDownload/subtest6 (1.26s) === RUN TestIndexChanged run.go:198: Remote "Linkbox root 'rclone-test-qonepux4zele'", Local "Local file system at /tmp/rclone704625394", Modify Window "876000h0m0s" 2026/10/05 07:30:34 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:34 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:30:34 DEBUG : pacer: Reducing sleep to 300ms 2026/10/05 07:30:34 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:34 DEBUG : pacer: Rate limited, increasing sleep to 600ms 2026/10/05 07:30:35 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:35 DEBUG : pacer: Rate limited, increasing sleep to 1.2s 2026/10/05 07:30:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:35 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:30:36 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:38 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:40 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:42 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:44 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:46 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:48 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:50 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:52 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:54 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:56 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:30:59 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:00 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:02 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:04 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:06 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:08 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:12 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:31:14 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:31:15 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:31:16 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:31:16 DEBUG : sub/deep/index.html: size = 12087 OK 2026/10/05 07:31:16 INFO : sub/deep/index.html: Copied (new) 2026/10/05 07:31:16 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:31:17 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:31:17 DEBUG : other/index.html: size = 12058 OK 2026/10/05 07:31:17 INFO : other/index.html: Copied (new) 2026/10/05 07:31:18 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:31:18 DEBUG : index.html: size = 12399 OK 2026/10/05 07:31:18 INFO : index.html: Copied (new) 2026/10/05 07:31:18 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:31:18 DEBUG : sub/index.html: size = 12306 OK 2026/10/05 07:31:18 INFO : sub/index.html: Copied (new) 2026/10/05 07:31:18 DEBUG : pacer: Reducing sleep to 200ms 2026/10/05 07:31:22 INFO : Linkbox root 'rclone-test-qonepux4zele': Partial index: listing 3 directories and walking 0 changed directories 2026/10/05 07:31:23 DEBUG : sub/deep/index.html: Update: removing old file 2026/10/05 07:31:23 DEBUG : index.html: Unchanged skipping 2026/10/05 07:31:23 DEBUG : sub/index.html: Unchanged skipping 2026/10/05 07:31:26 DEBUG : sub/deep/index.html: size = 12346 OK 2026/10/05 07:31:26 INFO : sub/deep/index.html: Copied (replaced existing) 2026/10/05 07:31:31 INFO : Linkbox root 'rclone-test-qonepux4zele': Partial index: listing 3 directories and walking 0 changed directories 2026/10/05 07:31:31 DEBUG : sub/index.html: Update: removing old file 2026/10/05 07:31:31 DEBUG : index.html: Unchanged skipping 2026/10/05 07:31:34 DEBUG : sub/new/index.html: size = 12085 OK 2026/10/05 07:31:34 INFO : sub/new/index.html: Copied (new) 2026/10/05 07:31:35 DEBUG : sub/index.html: size = 12554 OK 2026/10/05 07:31:35 INFO : sub/index.html: Copied (replaced existing) 2026/10/05 07:31:36 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:36 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:31:36 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:36 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:31:36 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:36 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:31:37 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:37 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:31:39 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:41 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:43 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:45 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:47 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:49 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:51 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:53 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:55 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:57 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:31:59 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:01 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:03 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:05 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:07 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:09 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "other/undeclared0.txt" to Linkbox root 'rclone-test-qonepux4zele': 1/10 (Update err in unmarshaling response: invalid character '<' looking for beginning of value) 2026/10/05 07:32:11 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:32:13 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:32:16 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:32:16 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:32:16 INFO : Linkbox root 'rclone-test-qonepux4zele': Partial index: listing 1 directories and walking 1 changed directories 2026/10/05 07:32:17 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:32:17 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:32:17 DEBUG : other/index.html: Update: removing old file 2026/10/05 07:32:18 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:32:18 DEBUG : index.html: Unchanged skipping 2026/10/05 07:32:19 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:32:19 DEBUG : pacer: Reducing sleep to 200ms 2026/10/05 07:32:21 DEBUG : other/index.html: size = 12597 OK 2026/10/05 07:32:21 INFO : other/index.html: Copied (replaced existing) 2026/10/05 07:32:24 INFO : Linkbox root 'rclone-test-qonepux4zele': Partial index: listing 1 directories and walking 0 changed directories 2026/10/05 07:32:24 DEBUG : other/index.html: Update: removing old file 2026/10/05 07:32:24 DEBUG : index.html: Unchanged skipping 2026/10/05 07:32:28 DEBUG : other/index.html: size = 12867 OK 2026/10/05 07:32:28 INFO : other/index.html: Copied (replaced existing) 2026/10/05 07:32:30 INFO : Linkbox root 'rclone-test-qonepux4zele': Nothing changed so nothing to index 2026/10/05 07:32:31 INFO : Linkbox root 'rclone-test-qonepux4zele': Root changed so doing a full index 2026/10/05 07:32:32 DEBUG : sub/index.html: Update: removing old file 2026/10/05 07:32:32 DEBUG : index.html: Unchanged skipping 2026/10/05 07:32:32 DEBUG : sub/new/index.html: Unchanged skipping 2026/10/05 07:32:33 DEBUG : other/index.html: Unchanged skipping 2026/10/05 07:32:33 DEBUG : sub/deep/index.html: Unchanged skipping 2026/10/05 07:32:35 DEBUG : sub/index.html: size = 12813 OK 2026/10/05 07:32:35 INFO : sub/index.html: Copied (replaced existing) 2026/10/05 07:32:38 INFO : Linkbox root 'rclone-test-qonepux4zele': Partial index would list 2 directories, more than 1, so doing a full index 2026/10/05 07:32:39 DEBUG : sub/index.html: Update: removing old file 2026/10/05 07:32:39 DEBUG : sub/new/index.html: Unchanged skipping 2026/10/05 07:32:40 DEBUG : other/index.html: Unchanged skipping 2026/10/05 07:32:40 DEBUG : sub/deep/index.html: Unchanged skipping 2026/10/05 07:32:40 DEBUG : index.html: Unchanged skipping 2026/10/05 07:32:42 DEBUG : sub/index.html: size = 13071 OK 2026/10/05 07:32:42 INFO : sub/index.html: Copied (replaced existing) 2026/10/05 07:32:45 INFO : Linkbox root 'rclone-test-qonepux4zele': Partial index: listing 1 directories and walking 1 changed directories 2026/10/05 07:32:45 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:45 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:32:45 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:45 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:32:45 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:45 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:32:46 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:46 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:32:48 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:50 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:52 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:54 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:56 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:58 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:32:58 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value index_test.go:55: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/index_test.go:55 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/index_test.go:452 Error: Received unexpected error: getting files failed: invalid character '<' looking for beginning of value Test: TestIndexChanged 2026/10/05 07:33:00 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:02 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:04 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:06 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:08 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:10 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:12 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:33:15 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:33:17 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:33:17 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:33:18 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:33:20 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:33:21 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:33:22 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:33:24 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestIndexChanged (205.83s) === RUN TestPurge 2026/10/05 07:33:45 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-xugiquj9zopi" 2026/10/05 07:33:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/05 07:33:45 DEBUG : Linkbox root 'rclone-test-xugiquj9zopi': Using cached web token 2026/10/05 07:33:46 DEBUG : Creating backend with remote "/tmp/rclone1973527830" run.go:198: Remote "Linkbox root 'rclone-test-xugiquj9zopi'", Local "Local file system at /tmp/rclone1973527830", Modify Window "876000h0m0s" 2026/10/05 07:33:54 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:54 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:33:54 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:54 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:33:55 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:55 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:33:56 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:56 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:33:57 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:33:59 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:01 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:03 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:05 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:07 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "A1/B1/C1/one" to Linkbox root 'rclone-test-xugiquj9zopi': 1/10 (Update failed to read object: getting files failed: invalid character '<' looking for beginning of value) 2026/10/05 07:34:09 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:11 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:34:11 DEBUG : A1/B1/C1/one: Update: removing old file 2026/10/05 07:34:14 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:34:15 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:34:17 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:34:18 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:34:18 INFO : A2: Making directory 2026/10/05 07:34:18 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:34:20 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:34:20 INFO : A1/B2: Making directory 2026/10/05 07:34:20 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:34:21 DEBUG : pacer: Reducing sleep to 200ms 2026/10/05 07:34:21 INFO : A1/B2/C2: Making directory 2026/10/05 07:34:23 INFO : A1/B1/C3: Making directory 2026/10/05 07:34:25 INFO : A3: Making directory 2026/10/05 07:34:26 INFO : A3/B3: Making directory 2026/10/05 07:34:28 INFO : A3/B3/C4: Making directory 2026/10/05 07:34:39 ERROR : error listing: directory not found 2026/10/05 07:34:39 DEBUG : Linkbox root 'rclone-test-xugiquj9zopi': Purge remote 2026/10/05 07:34:39 NOTICE: purge failed: directory not found --- PASS: TestPurge (54.36s) === RUN TestRmdirsWithFilter run.go:198: Remote "Linkbox root 'rclone-test-qonepux4zele'", Local "Local file system at /tmp/rclone704625394", Modify Window "876000h0m0s" 2026/10/05 07:34:39 INFO : A1: Making directory 2026/10/05 07:34:41 INFO : A1/B1: Making directory 2026/10/05 07:34:42 INFO : A1/B1/C1: Making directory 2026/10/05 07:34:45 DEBUG : removing 1 level 3 directories 2026/10/05 07:34:45 INFO : A1/B1/C1: Removing directory 2026/10/05 07:34:47 DEBUG : removing 1 level 2 directories 2026/10/05 07:34:47 INFO : A1/B1: Removing directory 2026/10/05 07:34:50 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:50 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:34:50 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:50 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:34:50 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:50 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:34:51 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:51 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:34:53 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:55 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:57 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:34:59 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:01 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:03 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:186: removing dir "A1" failed - try 1/3: sleeping 1s: purge error: invalid character '<' looking for beginning of value 2026/10/05 07:35:05 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:07 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:09 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:11 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:13 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:35:16 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:35:16 DEBUG : pacer: Reducing sleep to 843.75ms --- PASS: TestRmdirsWithFilter (37.17s) === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-qonepux4zele'", Local "Local file system at /tmp/rclone704625394", Modify Window "876000h0m0s" 2026/10/05 07:35:17 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:35:19 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:35:20 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:35:20 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:35:22 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:35:22 DEBUG : pacer: Reducing sleep to 200ms 2026/10/05 07:35:35 INFO : A1/B2: Making directory 2026/10/05 07:35:36 INFO : A1/B1/C3: Making directory 2026/10/05 07:35:50 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:50 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:35:51 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:51 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:35:51 DEBUG : pacer: Reducing sleep to 600ms 2026/10/05 07:35:52 DEBUG : pacer: Reducing sleep to 450ms 2026/10/05 07:35:52 DEBUG : pacer: Reducing sleep to 337.5ms 2026/10/05 07:35:53 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:53 DEBUG : pacer: Rate limited, increasing sleep to 675ms 2026/10/05 07:35:53 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:53 DEBUG : pacer: Rate limited, increasing sleep to 1.35s 2026/10/05 07:35:54 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:54 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:35:55 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:57 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:35:59 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:01 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:03 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:05 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:07 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:09 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:11 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:13 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:36:15 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:36:17 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:36:18 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:36:19 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:36:20 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:36:20 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:36:20 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:36:20 DEBUG : pacer: Reducing sleep to 200ms 2026/10/05 07:36:23 DEBUG : A2/B1/three: size = 5 OK 2026/10/05 07:36:23 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/10/05 07:36:23 DEBUG : A2/B1/C1/four: size = 4 OK 2026/10/05 07:36:23 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/10/05 07:36:23 DEBUG : A2/B1/C2/five: size = 4 OK 2026/10/05 07:36:23 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/10/05 07:36:24 DEBUG : A2/one: size = 3 OK 2026/10/05 07:36:24 INFO : A1/one: Copied (new) to: A2/one 2026/10/05 07:36:24 DEBUG : A2/two: size = 3 OK 2026/10/05 07:36:24 INFO : A1/two: Copied (new) to: A2/two 2026/10/05 07:36:25 INFO : A1/B1/three: Deleted 2026/10/05 07:36:25 INFO : A1/B1/C1/four: Deleted 2026/10/05 07:36:25 INFO : A1/B1/C2/five: Deleted 2026/10/05 07:36:26 INFO : A1/one: Deleted 2026/10/05 07:36:26 INFO : A1/two: Deleted 2026/10/05 07:36:47 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:47 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:36:47 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:47 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:36:47 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:47 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:36:48 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:48 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:36:50 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:52 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:54 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:56 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:36:58 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:00 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:02 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:04 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:06 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:08 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:10 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:12 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:14 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:37:16 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:37:17 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:37:19 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:37:19 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:37:20 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:37:20 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:37:21 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:37:21 DEBUG : pacer: Reducing sleep to 200ms 2026/10/05 07:37:25 DEBUG : A3/B1/C2/five: size = 4 OK 2026/10/05 07:37:25 INFO : A2/B1/C2/five: Copied (new) to: A3/B1/C2/five 2026/10/05 07:37:25 DEBUG : A3/one: size = 3 OK 2026/10/05 07:37:25 INFO : A2/one: Copied (new) to: A3/one 2026/10/05 07:37:26 DEBUG : A3/two: size = 3 OK 2026/10/05 07:37:26 INFO : A2/two: Copied (new) to: A3/two 2026/10/05 07:37:26 DEBUG : A3/B1/three: size = 5 OK 2026/10/05 07:37:26 INFO : A2/B1/three: Copied (new) to: A3/B1/three 2026/10/05 07:37:26 DEBUG : A3/B1/C1/four: size = 4 OK 2026/10/05 07:37:26 INFO : A2/B1/C1/four: Copied (new) to: A3/B1/C1/four 2026/10/05 07:37:26 INFO : A2/B1/C2/five: Deleted 2026/10/05 07:37:27 INFO : A2/one: Deleted 2026/10/05 07:37:27 INFO : A2/two: Deleted 2026/10/05 07:37:28 INFO : A2/B1/three: Deleted 2026/10/05 07:37:28 INFO : A2/B1/C1/four: Deleted 2026/10/05 07:37:39 INFO : Linkbox root 'rclone-test-qonepux4zele': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2026/10/05 07:37:43 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:43 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:37:43 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:43 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:37:44 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:44 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:37:44 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:44 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:37:46 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:48 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:50 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:52 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:54 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:37:56 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) operations_test.go:1646: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1646 Error: Received unexpected error: RenameDir mkdir: getting files failed: invalid character '<' looking for beginning of value Test: TestDirMove 2026/10/05 07:37:58 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:00 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:02 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:04 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:06 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:08 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:10 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:12 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:14 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:38:16 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:38:18 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:38:19 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:38:20 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/05 07:38:20 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/05 07:38:21 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/05 07:38:21 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/05 07:38:21 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/fs/operations/operations_test.go:1652 Error: Should be true Test: TestDirMove Messages: listing wrong, want A4/B1/C1/four (4), A4/B1/C2/five (4), A4/B1/three (5), A4/one (3), A4/two (3) got A3/B1/C1/four (4), A3/B1/C2/five (4), A3/B1/three (5), A3/one (3), A3/two (3) 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/fs/operations/operations_test.go:1652 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/one" 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/fs/operations/operations_test.go:1652 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/two" 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/fs/operations/operations_test.go:1652 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/B1/three" 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/fs/operations/operations_test.go:1652 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/B1/C1/four" 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/fs/operations/operations_test.go:1652 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/B1/C2/five" fstest.go:204: Not found "A4/B1/three" fstest.go:204: Not found "A4/B1/C1/four" fstest.go:204: Not found "A4/B1/C2/five" fstest.go:204: Not found "A4/one" fstest.go:204: Not found "A4/two" fstest.go:207: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:207 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:311 /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:1652 Error: Not equal: expected: 0 actual : 5 Test: TestDirMove Messages: 5 objects not found 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:1652 Error: Not equal: expected: []string{"A4", "A4/B1", "A4/B1/C1", "A4/B1/C2", "A4/B1/C3", "A4/B2"} actual : []string{"A3", "A3/B1", "A3/B1/C1", "A3/B1/C2", "A3/B1/C3", "A3/B2", "A4", "A4/B1"} Diff: --- Expected +++ Actual @@ -1,8 +1,10 @@ -([]string) (len=6) { +([]string) (len=8) { + (string) (len=2) "A3", + (string) (len=5) "A3/B1", + (string) (len=8) "A3/B1/C1", + (string) (len=8) "A3/B1/C2", + (string) (len=8) "A3/B1/C3", + (string) (len=5) "A3/B2", (string) (len=2) "A4", - (string) (len=5) "A4/B1", - (string) (len=8) "A4/B1/C1", - (string) (len=8) "A4/B1/C2", - (string) (len=8) "A4/B1/C3", - (string) (len=5) "A4/B2" + (string) (len=5) "A4/B1" } Test: TestDirMove Messages: directories 2026/10/05 07:38:51 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:51 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/10/05 07:38:51 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:51 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/10/05 07:38:52 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:52 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/10/05 07:38:53 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:53 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/05 07:38:54 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:56 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:38:58 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:39:00 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:39:02 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:39:04 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:186: removing dir "A3/B1" failed - try 1/3: sleeping 1s: purge error: invalid character '<' looking for beginning of value 2026/10/05 07:39:06 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:39:08 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:39:10 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:39:12 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/10/05 07:39:14 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/05 07:39:18 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/05 07:39:18 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/05 07:39:20 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/05 07:39:20 DEBUG : pacer: Reducing sleep to 474.609375ms --- FAIL: TestDirMove (244.00s) FAIL 2026/10/05 07:39:20 DEBUG : Linkbox root 'rclone-test-qonepux4zele': Purge remote 2026/10/05 07:39:22 DEBUG : pacer: Reducing sleep to 355.957031ms "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestDirMove|TestIndexChanged|TestPurge|TestRmdirsWithFilter)$'" - Finished ERROR in 12m39.113352202s (try 3/5): exit status 1: Failed [TestCheckSumDownload TestIndexChanged TestDirMove]