"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyFileMaxTransfer|TestMkdir|TestPurge)$|^TestStatJSON$/^RootNotFound$'" - Starting (try 2/5)
2026/08/18 03:04:59 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jazicaq5xuxo"
2026/08/18 03:04:59 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/18 03:04:59 DEBUG : Linkbox root 'rclone-test-jazicaq5xuxo': Using cached web token
2026/08/18 03:05:00 DEBUG : Creating backend with remote "/tmp/rclone3446473654"
=== RUN   TestCheckSumDownload
    run.go:198: Remote "Linkbox root 'rclone-test-jazicaq5xuxo'", Local "Local file system at /tmp/rclone3446473654", Modify Window "876000h0m0s"
2026/08/18 03:05:00 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jazicaq5xuxo/data"
2026/08/18 03:05:00 DEBUG : Linkbox root 'rclone-test-jazicaq5xuxo/data': Using cached web token
=== RUN   TestCheckSumDownload/subtest1
2026/08/18 03:05:12 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest2
2026/08/18 03:05:17 DEBUG : test.sum: Update: removing old file
2026/08/18 03:05:18 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:18 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/08/18 03:05:18 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:18 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/08/18 03:05:18 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:18 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/08/18 03:05:19 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:19 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/08/18 03:05:21 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:23 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:25 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:27 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:29 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:31 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-jazicaq5xuxo': 1/10 (Update err in unmarshaling response: invalid character '<' looking for beginning of value)
2026/08/18 03:05:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:05:35 DEBUG : pacer: Reducing sleep to 1.5s
2026/08/18 03:05:37 DEBUG : pacer: Reducing sleep to 1.125s
2026/08/18 03:05:40 DEBUG : pacer: Reducing sleep to 843.75ms
2026/08/18 03:05:40 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/08/18 03:05:41 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/08/18 03:05:41 DEBUG : pacer: Reducing sleep to 355.957031ms
=== RUN   TestCheckSumDownload/subtest3
2026/08/18 03:05:43 DEBUG : pacer: Reducing sleep to 200ms
2026/08/18 03:05:43 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest4
2026/08/18 03:05:47 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest5
2026/08/18 03:05:52 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest6
2026/08/18 03:05:56 DEBUG : data/banana: Update: removing old file
2026/08/18 03:05:59 DEBUG : data/potato: Update: removing old file
2026/08/18 03:06:03 DEBUG : test.sum: Update: removing old file
=== RUN   TestCheckSumDownload/subtest7
2026/08/18 03:06:13 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:13 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/08/18 03:06:13 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:13 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/08/18 03:06:13 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:13 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/08/18 03:06:14 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:14 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/08/18 03:06:16 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:18 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:20 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:22 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:24 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:26 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:26 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value
=== NAME  TestCheckSumDownload
    fstest.go:282: Error listing: getting files failed: invalid character '<' looking for beginning of value
--- FAIL: TestCheckSumDownload (85.49s)
    --- PASS: TestCheckSumDownload/subtest1 (1.33s)
    --- PASS: TestCheckSumDownload/subtest2 (0.46s)
    --- PASS: TestCheckSumDownload/subtest3 (1.15s)
    --- PASS: TestCheckSumDownload/subtest4 (0.69s)
    --- PASS: TestCheckSumDownload/subtest5 (0.66s)
    --- PASS: TestCheckSumDownload/subtest6 (0.67s)
    --- PASS: TestCheckSumDownload/subtest7 (0.68s)
=== RUN   TestCopyFileMaxTransfer
    run.go:198: Remote "Linkbox root 'rclone-test-jazicaq5xuxo'", Local "Local file system at /tmp/rclone3446473654", Modify Window "876000h0m0s"
2026/08/18 03:06:28 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:30 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:32 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:34 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:06:36 DEBUG : pacer: Reducing sleep to 1.5s
2026/08/18 03:06:36 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination
2026/08/18 03:06:38 DEBUG : pacer: Reducing sleep to 1.125s
2026/08/18 03:06:41 DEBUG : pacer: Reducing sleep to 843.75ms
2026/08/18 03:06:41 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/08/18 03:06:42 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/08/18 03:06:43 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/08/18 03:06:44 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/08/18 03:06:44 DEBUG : TestCopyFileMaxTransfer/file1: size = 14 OK
2026/08/18 03:06:44 INFO  : TestCopyFileMaxTransfer/file1: Copied (new)
2026/08/18 03:06:44 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/08/18 03:06:44 DEBUG : pacer: Reducing sleep to 200ms
2026/08/18 03:06:44 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination
2026/08/18 03:06:45 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Update err in reading file: max transfer limit reached as set by --max-transfer
2026/08/18 03:06:45 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination
2026/08/18 03:06:46 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination
2026/08/18 03:06:49 DEBUG : TestCopyFileMaxTransfer/file4: size = 2062 OK
2026/08/18 03:06:49 INFO  : TestCopyFileMaxTransfer/file4: Copied (new)
--- PASS: TestCopyFileMaxTransfer (28.11s)
=== RUN   TestStatJSON
    run.go:198: Remote "Linkbox root 'rclone-test-jazicaq5xuxo'", Local "Local file system at /tmp/rclone3446473654", Modify Window "876000h0m0s"
=== RUN   TestStatJSON/RootNotFound
2026/08/18 03:07:00 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jazicaq5xuxo/notfound"
2026/08/18 03:07:00 DEBUG : Linkbox root 'rclone-test-jazicaq5xuxo/notfound': Using cached web token
--- PASS: TestStatJSON (12.65s)
    --- PASS: TestStatJSON/RootNotFound (1.83s)
=== RUN   TestMkdir
    run.go:198: Remote "Linkbox root 'rclone-test-jazicaq5xuxo'", Local "Local file system at /tmp/rclone3446473654", Modify Window "876000h0m0s"
2026/08/18 03:07:07 INFO  : Linkbox root 'rclone-test-jazicaq5xuxo': Making directory
2026/08/18 03:07:07 INFO  : Linkbox root 'rclone-test-jazicaq5xuxo': Making directory
--- PASS: TestMkdir (0.60s)
=== RUN   TestPurge
2026/08/18 03:07:07 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-dokoxuv6hafe"
2026/08/18 03:07:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/18 03:07:07 DEBUG : Linkbox root 'rclone-test-dokoxuv6hafe': Using cached web token
2026/08/18 03:07:08 DEBUG : Creating backend with remote "/tmp/rclone4027167297"
    run.go:198: Remote "Linkbox root 'rclone-test-dokoxuv6hafe'", Local "Local file system at /tmp/rclone4027167297", Modify Window "876000h0m0s"
2026/08/18 03:07:16 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:16 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/08/18 03:07:16 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:16 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/08/18 03:07:17 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:17 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/08/18 03:07:18 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:18 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/08/18 03:07:19 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:21 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:23 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:25 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:27 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:29 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-dokoxuv6hafe': 1/10 (Update failed to read object: getting files failed: invalid character '<' looking for beginning of value)
2026/08/18 03:07:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:33 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/08/18 03:07:35 DEBUG : pacer: Reducing sleep to 1.5s
2026/08/18 03:07:35 DEBUG : A1/B1/C1/one: Update: removing old file
2026/08/18 03:07:38 DEBUG : pacer: Reducing sleep to 1.125s
2026/08/18 03:07:39 DEBUG : pacer: Reducing sleep to 843.75ms
2026/08/18 03:07:41 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/08/18 03:07:41 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/08/18 03:07:41 INFO  : A2: Making directory
2026/08/18 03:07:42 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/08/18 03:07:44 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/08/18 03:07:44 INFO  : A1/B2: Making directory
2026/08/18 03:07:44 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/08/18 03:07:45 DEBUG : pacer: Reducing sleep to 200ms
2026/08/18 03:07:45 INFO  : A1/B2/C2: Making directory
2026/08/18 03:07:47 INFO  : A1/B1/C3: Making directory
2026/08/18 03:07:48 INFO  : A3: Making directory
2026/08/18 03:07:50 INFO  : A3/B3: Making directory
2026/08/18 03:07:51 INFO  : A3/B3/C4: Making directory
2026/08/18 03:08:02 ERROR : error listing: directory not found
2026/08/18 03:08:02 DEBUG : Linkbox root 'rclone-test-dokoxuv6hafe': Purge remote
2026/08/18 03:08:02 NOTICE: purge failed: directory not found
--- PASS: TestPurge (55.28s)
FAIL
2026/08/18 03:08:02 DEBUG : Linkbox root 'rclone-test-jazicaq5xuxo': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyFileMaxTransfer|TestMkdir|TestPurge)$|^TestStatJSON$/^RootNotFound$'" - Finished ERROR in 3m4.518434896s (try 2/5): exit status 1: Failed [TestCheckSumDownload]