"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^TestCheckSumDownload$'" - Starting (try 2/5)
2026/09/25 02:01:51 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jiwemim4yuta"
2026/09/25 02:01:51 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/09/25 02:01:51 DEBUG : Linkbox root 'rclone-test-jiwemim4yuta': Using cached web token
2026/09/25 02:01:52 DEBUG : Creating backend with remote "/tmp/rclone2788052086"
=== RUN   TestCheckSumDownload
    run.go:198: Remote "Linkbox root 'rclone-test-jiwemim4yuta'", Local "Local file system at /tmp/rclone2788052086", Modify Window "876000h0m0s"
2026/09/25 02:01:52 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jiwemim4yuta/data"
2026/09/25 02:01:52 DEBUG : Linkbox root 'rclone-test-jiwemim4yuta/data': Using cached web token
=== RUN   TestCheckSumDownload/subtest1
2026/09/25 02:02:06 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest2
2026/09/25 02:02:10 DEBUG : test.sum: Update: removing old file
2026/09/25 02:02:11 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/09/25 02:02:11 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/09/25 02:02:12 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/09/25 02:02:12 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/09/25 02:02:12 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/09/25 02:02:12 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/09/25 02:02:13 DEBUG : pacer: Reducing sleep to 1.2s
2026/09/25 02:02:16 DEBUG : pacer: Reducing sleep to 900ms
2026/09/25 02:02:16 DEBUG : pacer: Reducing sleep to 675ms
2026/09/25 02:02:17 DEBUG : pacer: Reducing sleep to 506.25ms
2026/09/25 02:02:18 DEBUG : pacer: Reducing sleep to 379.6875ms
=== RUN   TestCheckSumDownload/subtest3
2026/09/25 02:02:19 DEBUG : pacer: Reducing sleep to 200ms
2026/09/25 02:02:19 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest4
2026/09/25 02:02:23 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest5
2026/09/25 02:02:28 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest6
2026/09/25 02:02:33 DEBUG : data/banana: Update: removing old file
2026/09/25 02:02:37 DEBUG : data/potato: Update: removing old file
2026/09/25 02:02:40 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (58.56s)
    --- PASS: TestCheckSumDownload/subtest1 (1.85s)
    --- PASS: TestCheckSumDownload/subtest2 (0.49s)
    --- PASS: TestCheckSumDownload/subtest3 (1.13s)
    --- PASS: TestCheckSumDownload/subtest4 (0.66s)
    --- PASS: TestCheckSumDownload/subtest5 (0.66s)
    --- PASS: TestCheckSumDownload/subtest6 (0.68s)
    --- PASS: TestCheckSumDownload/subtest7 (0.68s)
PASS
2026/09/25 02:02:51 DEBUG : Linkbox root 'rclone-test-jiwemim4yuta': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^TestCheckSumDownload$'" - Finished OK in 1m0.891573227s (try 2/5)