"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCaseInsensitiveMoveFileDryRun|TestCat|TestCheckSum|TestCheckSumDownload|TestCopyDirMetadata|TestCopyFile|TestCopyFileBackupDir|TestCopyFileCompareDest|TestCopyFileCopyDest|TestCopyFileMaxTransfer|TestCopyInplace|TestCopyLongFile|TestCopyLongFileName|TestCopyLongFileNameCollision|TestCopyURL|TestCopyURLDownloadHeaders|TestCount|TestDeduplicateFirst|TestDeduplicateInteractive|TestDeduplicateLargest|TestDeduplicateNewest|TestDeduplicateNewestByHash|TestDeduplicateOldest|TestDeduplicateRename|TestDeduplicateSizeOnly|TestDeduplicateSkip|TestDeduplicateSmallest|TestDelete|TestDirMove|TestDirsEqual|TestGetFsInfo|TestHashSums|TestLs|TestLsLong|TestLsWithFilesFrom|TestLsd|TestMaxDelete|TestMaxDeleteSize|TestMaxDeleteSizeLargeFile|TestMergeDirs|TestMkdir|TestMkdirMetadata|TestMkdirModTime|TestMoveFile|TestMoveFileBackupDir|TestMoveFileWithIgnoreExisting|TestParseSumFile|TestRcatMetadata|TestRcatSize|TestRcatSizeMetadata|TestRcatSizeUploadHeaders|TestReadFile|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestRmdirsWithFilter|TestSetDirModTime|TestStatJSON|TestTouchDir)$|^TestCheckDownload$/^2$|^TestListJSON$/^(Default|FilesOnly|HashTypes|Metadata|NoMimeType|NoModTime|Recurse|ShowHash)$|^TestRcat$/^(withChecksum=false,ignoreChecksum=false|withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=false|withChecksum=true,ignoreChecksum=true)$'" - Starting (try 2/5) 2026/08/04 02:39:45 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-sihonaz7dena" 2026/08/04 02:39:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/04 02:39:45 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': Using cached web token 2026/08/04 02:39:46 DEBUG : Creating backend with remote "/tmp/rclone1617524713" === RUN TestCheckDownload run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" === RUN TestCheckDownload/2 2026/08/04 02:39:55 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:39:55 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:39:55 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:39:56 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:39:57 DEBUG : potato2: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 02:40:01 DEBUG : remotepotato: Trying to read object after upload: try again in 100ms (1/10) === NAME TestCheckDownload fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestCheckDownload (29.23s) --- PASS: TestCheckDownload/2 (0.41s) === RUN TestParseSumFile run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:40:17 DEBUG : test.sum: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:40:18 DEBUG : test.sum: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:40:18 DEBUG : test.sum: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:40:19 NOTICE: test.sum: improperly formatted checksum line 4 2026/08/04 02:40:19 NOTICE: test.sum: improperly formatted checksum line 5 2026/08/04 02:40:19 NOTICE: test.sum: improperly formatted checksum line 6 2026/08/04 02:40:19 NOTICE: test.sum: 2 warning(s) suppressed... 2026/08/04 02:40:19 DEBUG : test.sum: Update: removing old file 2026/08/04 02:40:23 NOTICE: test.sum: improperly formatted checksum line 4 2026/08/04 02:40:23 NOTICE: test.sum: improperly formatted checksum line 5 2026/08/04 02:40:23 NOTICE: test.sum: improperly formatted checksum line 6 2026/08/04 02:40:23 NOTICE: test.sum: 2 warning(s) suppressed... --- PASS: TestParseSumFile (9.35s) === RUN TestCheckSum run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:40:25 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-sihonaz7dena/data" 2026/08/04 02:40:25 DEBUG : Linkbox root 'rclone-test-sihonaz7dena/data': Using cached web token check_test.go:350: Linkbox root 'rclone-test-sihonaz7dena/data' lacks md5, skipping --- SKIP: TestCheckSum (2.04s) === RUN TestCheckSumDownload run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:40:27 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-sihonaz7dena/data" 2026/08/04 02:40:27 DEBUG : Linkbox root 'rclone-test-sihonaz7dena/data': Using cached web token 2026/08/04 02:40:32 DEBUG : data/banana: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:40:32 DEBUG : data/banana: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:40:35 DEBUG : test.sum: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:40:35 DEBUG : test.sum: Trying to read object after upload: try again in 200ms (2/10) === RUN TestCheckSumDownload/subtest1 2026/08/04 02:40:39 DEBUG : data/potato: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:40:39 DEBUG : test.sum: Update: removing old file 2026/08/04 02:40:42 DEBUG : test.sum: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:40:42 DEBUG : test.sum: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:40:43 DEBUG : test.sum: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:40:43 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:40:43 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:40:44 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:40:44 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:40:44 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:40:44 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:40:45 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:40:45 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:40:46 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:40:48 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:40:50 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:40:52 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:40:52 DEBUG : test.sum: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:40:54 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:40:54 DEBUG : test.sum: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 02:40:56 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:40:56 DEBUG : test.sum: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 02:41:00 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:41:00 DEBUG : test.sum: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 02:41:06 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:41:06 DEBUG : test.sum: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 02:41:19 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:41:19 DEBUG : test.sum: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/04 02:41:45 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:41:45 DEBUG : test.sum: Trying to read object after upload: try again in 51.2s (10/10) === NAME TestCheckSumDownload run.go:303: Failed to put "test.sum" to "Linkbox root 'rclone-test-sihonaz7dena'": object not found 2026/08/04 02:42:37 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:42:38 DEBUG : pacer: Reducing sleep to 200ms run.go:186: removing dir "data" failed - try 1/3: sleeping 1s: directory not empty run.go:186: removing dir "data" failed - try 2/3: sleeping 1.5s: directory not empty --- FAIL: TestCheckSumDownload (138.81s) --- PASS: TestCheckSumDownload/subtest1 (0.83s) === RUN TestCopyFile run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:42:46 DEBUG : file1: Need to transfer - File not found at Destination 2026/08/04 02:42:49 DEBUG : sub/file2: size = 14 OK 2026/08/04 02:42:49 INFO : file1: Copied (new) to: sub/file2 2026/08/04 02:42:50 DEBUG : sub/file2: size = 14 OK 2026/08/04 02:42:50 DEBUG : file1: Sizes identical 2026/08/04 02:42:50 DEBUG : file1: Unchanged skipping 2026/08/04 02:42:50 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': don't need to copy/move sub/file2, it is already at target location run.go:186: removing dir "sub" failed - try 1/3: sleeping 1s: directory not empty --- PASS: TestCopyFile (10.02s) === RUN TestCopyLongFile run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" copy_test.go:154: Test only runs on local --- SKIP: TestCopyLongFile (0.41s) === RUN TestCopyFileBackupDir run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" copy_test.go:174: Skipping test as remote does not support server-side move or copy --- SKIP: TestCopyFileBackupDir (0.42s) === RUN TestCopyFileCompareDest run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:42:56 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-sihonaz7dena/dst" 2026/08/04 02:42:56 DEBUG : Linkbox root 'rclone-test-sihonaz7dena/dst': Using cached web token 2026/08/04 02:42:58 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-sihonaz7dena/CompareDest" 2026/08/04 02:42:58 DEBUG : Linkbox root 'rclone-test-sihonaz7dena/CompareDest': Using cached web token 2026/08/04 02:42:59 DEBUG : one: Need to transfer - File not found at Destination 2026/08/04 02:43:03 DEBUG : one: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:43:04 DEBUG : one: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:43:04 DEBUG : one: size = 3 OK 2026/08/04 02:43:04 INFO : one: Copied (new) 2026/08/04 02:43:05 DEBUG : one: size = 5 (Local file system at /tmp/rclone1617524713) 2026/08/04 02:43:05 DEBUG : one: size = 3 (Linkbox root 'rclone-test-sihonaz7dena/dst') 2026/08/04 02:43:05 DEBUG : one: Sizes differ 2026/08/04 02:43:05 DEBUG : one: Update: removing old file 2026/08/04 02:43:09 DEBUG : one: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:43:09 DEBUG : one: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:43:09 DEBUG : one: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:43:10 DEBUG : one: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:43:11 DEBUG : one: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 02:43:13 DEBUG : one: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 02:43:16 DEBUG : one: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 02:43:23 DEBUG : one: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 02:43:36 DEBUG : one: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/04 02:44:01 DEBUG : one: Trying to read object after upload: try again in 51.2s (10/10) 2026/08/04 02:44:53 ERROR : one: Failed to copy: object not found copy_test.go:220: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:220 Error: Received unexpected error: object not found Test: TestCopyFileCompareDest run.go:186: removing dir "dst" failed - try 1/3: sleeping 1s: directory not empty --- FAIL: TestCopyFileCompareDest (121.21s) === RUN TestCopyFileCopyDest run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" copy_test.go:277: Skipping test as remote does not support server-side copy --- SKIP: TestCopyFileCopyDest (0.40s) === RUN TestCopyInplace run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" copy_test.go:371: Partial uploads not supported run.go:186: removing dir "dst" failed - try 1/3: sleeping 1s: directory not found run.go:186: removing dir "dst" failed - try 2/3: sleeping 1.5s: directory not found run.go:186: removing dir "dst" failed: directory not found --- SKIP: TestCopyInplace (4.50s) === RUN TestCopyLongFileName run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" copy_test.go:404: Partial uploads not supported --- SKIP: TestCopyLongFileName (0.41s) === RUN TestCopyLongFileNameCollision run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" copy_test.go:437: Partial uploads not supported --- SKIP: TestCopyLongFileNameCollision (0.40s) === RUN TestCopyFileMaxTransfer run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:45:03 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2026/08/04 02:45:07 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:45:07 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:45:08 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:45:08 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:45:09 DEBUG : TestCopyFileMaxTransfer/file1: size = 14 OK 2026/08/04 02:45:09 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2026/08/04 02:45:10 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2026/08/04 02:45:10 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Update err in reading file: max transfer limit reached as set by --max-transfer 2026/08/04 02:45:11 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination 2026/08/04 02:45:11 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination 2026/08/04 02:45:14 DEBUG : TestCopyFileMaxTransfer/file4: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:45:15 DEBUG : TestCopyFileMaxTransfer/file4: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:45:15 DEBUG : TestCopyFileMaxTransfer/file4: size = 2062 OK 2026/08/04 02:45:15 INFO : TestCopyFileMaxTransfer/file4: Copied (new) run.go:186: removing dir "TestCopyFileMaxTransfer" failed - try 1/3: sleeping 1s: directory not empty fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestCopyFileMaxTransfer (26.10s) === RUN TestDeduplicateInteractive run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateInteractive (0.42s) === RUN TestDeduplicateSkip run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSkip (0.46s) === RUN TestDeduplicateSizeOnly run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSizeOnly (0.67s) === RUN TestDeduplicateFirst run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateFirst (0.40s) === RUN TestDeduplicateNewest run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateNewest (0.41s) === RUN TestDeduplicateNewestByHash run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:36: Can't run this test without a hash --- SKIP: TestDeduplicateNewestByHash (0.48s) === RUN TestDeduplicateOldest run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateOldest (0.42s) === RUN TestDeduplicateLargest run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateLargest (0.40s) === RUN TestDeduplicateSmallest run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSmallest (0.41s) === RUN TestDeduplicateRename run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateRename (0.44s) === RUN TestMergeDirs run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" dedupe_test.go:256: Can't merge directories --- SKIP: TestMergeDirs (0.41s) === RUN TestListJSON run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:45:36 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:45:40 DEBUG : sub/file2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:45:40 DEBUG : sub/file2: Trying to read object after upload: try again in 200ms (2/10) === RUN TestListJSON/Default === RUN TestListJSON/FilesOnly === RUN TestListJSON/Recurse === RUN TestListJSON/NoModTime === RUN TestListJSON/NoMimeType === RUN TestListJSON/ShowHash === RUN TestListJSON/HashTypes 2026/08/04 02:45:43 ERROR : file1: Failed to read hash: hash type not supported === RUN TestListJSON/Metadata 2026/08/04 02:45:43 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:43 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:45:43 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:43 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:45:44 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:44 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:45:44 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:44 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:45:46 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:48 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:50 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:52 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:54 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:45:56 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:45:58 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:46:01 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:46:01 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:46:03 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:46:03 DEBUG : pacer: Reducing sleep to 355.957031ms === NAME TestListJSON run.go:186: removing dir "sub" failed - try 1/3: sleeping 1s: directory not empty 2026/08/04 02:46:04 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:46:06 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:46:06 DEBUG : pacer: Reducing sleep to 200ms --- PASS: TestListJSON (31.90s) --- PASS: TestListJSON/Default (0.21s) --- PASS: TestListJSON/FilesOnly (0.20s) --- PASS: TestListJSON/Recurse (0.44s) --- PASS: TestListJSON/NoModTime (0.27s) --- PASS: TestListJSON/NoMimeType (0.20s) --- PASS: TestListJSON/ShowHash (0.21s) --- PASS: TestListJSON/HashTypes (0.20s) --- PASS: TestListJSON/Metadata (13.22s) === RUN TestStatJSON run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:46:08 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) === RUN TestStatJSON/Root === RUN TestStatJSON/RootFilesOnly === RUN TestStatJSON/RootDirsOnly === RUN TestStatJSON/Dir === RUN TestStatJSON/DirWithTrailingSlash === RUN TestStatJSON/File === RUN TestStatJSON/NotFound === RUN TestStatJSON/DirFilesOnly === RUN TestStatJSON/FileFilesOnly === RUN TestStatJSON/NotFoundFilesOnly === RUN TestStatJSON/DirDirsOnly === RUN TestStatJSON/FileDirsOnly === RUN TestStatJSON/NotFoundDirsOnly === RUN TestStatJSON/RootNotFound 2026/08/04 02:46:16 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-sihonaz7dena/notfound" 2026/08/04 02:46:16 DEBUG : Config file has changed externally - reloading 2026/08/04 02:46:16 DEBUG : Linkbox root 'rclone-test-sihonaz7dena/notfound': Using cached web token === NAME TestStatJSON run.go:186: removing dir "sub" failed - try 1/3: sleeping 1s: directory not empty fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestStatJSON (25.51s) --- PASS: TestStatJSON/Root (0.21s) --- PASS: TestStatJSON/RootFilesOnly (0.00s) --- PASS: TestStatJSON/RootDirsOnly (0.20s) --- PASS: TestStatJSON/Dir (0.42s) --- PASS: TestStatJSON/DirWithTrailingSlash (0.24s) --- PASS: TestStatJSON/File (0.20s) --- PASS: TestStatJSON/NotFound (0.43s) --- PASS: TestStatJSON/DirFilesOnly (0.21s) --- PASS: TestStatJSON/FileFilesOnly (0.20s) --- PASS: TestStatJSON/NotFoundFilesOnly (0.26s) --- PASS: TestStatJSON/DirDirsOnly (0.20s) --- PASS: TestStatJSON/FileDirsOnly (0.20s) --- PASS: TestStatJSON/NotFoundDirsOnly (0.21s) --- PASS: TestStatJSON/RootNotFound (1.58s) === RUN TestMkdir run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:46:32 INFO : Linkbox root 'rclone-test-sihonaz7dena': Making directory 2026/08/04 02:46:32 INFO : Linkbox root 'rclone-test-sihonaz7dena': Making directory --- PASS: TestMkdir (0.66s) === RUN TestLsd run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/08/04 02:46:44 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:44 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:46:44 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:44 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:46:45 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:45 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:46:46 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:46 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:46:47 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:49 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:51 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:53 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:55 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:46:57 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:46:59 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:47:01 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:47:03 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:47:03 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:47:05 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:47:05 DEBUG : pacer: Reducing sleep to 266.967773ms --- PASS: TestLsd (33.10s) === RUN TestLs run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:47:06 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:47:06 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:47:10 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestLs (23.26s) === RUN TestLsWithFilesFrom run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:47:31 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:47:31 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:47:33 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:47:34 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:47:34 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:47:35 DEBUG : empty space: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:47:36 DEBUG : empty space: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 02:47:38 DEBUG : empty space: Excluded (FilesFrom Filter) 2026/08/04 02:47:38 DEBUG : empty space: Excluded fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestLsWithFilesFrom (20.51s) === RUN TestLsLong run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:47:49 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:47:49 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:47:49 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:47:49 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:47:50 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:47:50 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:47:51 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:47:51 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:47:52 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:47:54 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:47:56 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:47:58 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:48:00 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:48:03 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:48:03 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:48:03 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:48:04 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:48:04 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:48:05 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:48:05 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:48:06 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:48:07 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:48:07 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestLsLong (37.13s) === RUN TestHashSums run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:48:28 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:48:29 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:48:29 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:48:30 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestHashSums (17.36s) === RUN TestCount run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:48:45 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:45 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:48:46 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:46 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:48:46 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:46 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:48:47 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:47 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:48:48 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:50 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:52 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:54 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:56 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:48:59 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:49:01 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:49:02 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:49:04 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:49:05 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:49:05 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:49:05 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:49:05 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:49:06 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:49:06 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:49:08 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:49:10 DEBUG : sub dir/potato3: Trying to read object after upload: try again in 100ms (1/10) run.go:186: removing dir "sub dir" failed - try 1/3: sleeping 1s: directory not empty --- PASS: TestCount (34.20s) === RUN TestDelete run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:49:20 DEBUG : small: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:49:20 DEBUG : small: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:49:21 DEBUG : small: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:49:24 DEBUG : medium: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:49:26 DEBUG : Waiting for deletions to finish 2026/08/04 02:49:26 DEBUG : large: Excluded (Size Filter) 2026/08/04 02:49:26 DEBUG : large: Excluded 2026/08/04 02:49:28 INFO : medium: Deleted 2026/08/04 02:49:28 INFO : small: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestDelete (27.39s) === RUN TestMaxDelete run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:49:45 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:45 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:49:45 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:45 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:49:46 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:46 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:49:47 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:47 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:49:48 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:50 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:52 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:54 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:56 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:49:58 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:00 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:50:04 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:50:04 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:50:04 DEBUG : small: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:50:05 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:50:06 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:50:07 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:50:08 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:50:08 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:50:08 DEBUG : medium: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:50:09 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:50:11 DEBUG : Waiting for deletions to finish 2026/08/04 02:50:11 ERROR : small: Got fatal error on delete: --max-delete threshold reached 2026/08/04 02:50:13 INFO : large: Deleted 2026/08/04 02:50:13 INFO : medium: Deleted operations_test.go:453: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:453 Error: Not equal: expected: 1 actual : 2 Test: TestMaxDelete fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestMaxDelete (37.70s) === RUN TestMaxDeleteSizeLargeFile run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:50:25 DEBUG : small: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:50:27 DEBUG : medium: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:50:30 DEBUG : large: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:50:30 DEBUG : large: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:50:30 DEBUG : large: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:50:31 DEBUG : large: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:50:32 DEBUG : large: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 02:50:34 DEBUG : Waiting for deletions to finish 2026/08/04 02:50:34 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached 2026/08/04 02:50:36 INFO : medium: Deleted 2026/08/04 02:50:36 INFO : small: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/08/04 02:50:44 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:44 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:50:44 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:44 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:50:44 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:44 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:50:45 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:45 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:50:47 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:49 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:51 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:53 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:55 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:57 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:50:57 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value run.go:182: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:182 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:473 Error: Received unexpected error: getting files failed: invalid character '<' looking for beginning of value Test: TestMaxDeleteSizeLargeFile 2026/08/04 02:50:59 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:51:02 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:51:02 DEBUG : pacer: Reducing sleep to 843.75ms --- FAIL: TestMaxDeleteSizeLargeFile (39.57s) === RUN TestMaxDeleteSize run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:51:04 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:51:04 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:51:06 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:51:06 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:51:07 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:51:07 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:51:09 DEBUG : medium: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:51:09 DEBUG : medium: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:51:12 DEBUG : Waiting for deletions to finish 2026/08/04 02:51:12 ERROR : small: Got fatal error on delete: --max-delete-size threshold reached 2026/08/04 02:51:13 INFO : large: Deleted 2026/08/04 02:51:13 INFO : medium: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestMaxDeleteSize (20.94s) === RUN TestReadFile run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:51:25 DEBUG : ReadFile: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:51:26 DEBUG : ReadFile: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:51:26 DEBUG : ReadFile: Trying to read object after upload: try again in 400ms (3/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestReadFile (13.72s) === RUN TestCat run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:51:39 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:51:40 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:51:40 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:40 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:51:40 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:40 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:51:40 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:40 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:51:41 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:41 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:51:43 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:45 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:47 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:49 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:51 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:53 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "file1" to Linkbox root 'rclone-test-sihonaz7dena': 1/10 (Update failed to read object: getting files failed: invalid character '<' looking for beginning of value) 2026/08/04 02:51:55 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:57 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:51:59 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:51:59 DEBUG : file1: Update: removing old file 2026/08/04 02:52:02 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:52:03 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:52:05 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:52:05 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:52:05 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:52:06 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:52:06 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:52:06 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:52:06 DEBUG : file1: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:52:07 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:52:07 DEBUG : file1: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:52:08 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:52:08 DEBUG : file1: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/04 02:52:10 DEBUG : file1: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/04 02:52:13 DEBUG : file1: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/04 02:52:20 DEBUG : file1: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/04 02:52:33 DEBUG : file1: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/04 02:52:58 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:52:58 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:52:59 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:52:59 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:52:59 DEBUG : pacer: Reducing sleep to 600ms 2026/08/04 02:52:59 DEBUG : file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:303: Failed to put "file1" to "Linkbox root 'rclone-test-sihonaz7dena'": object not found 2026/08/04 02:53:51 DEBUG : pacer: Reducing sleep to 450ms 2026/08/04 02:53:52 DEBUG : pacer: Reducing sleep to 337.5ms 2026/08/04 02:53:53 DEBUG : pacer: Reducing sleep to 253.125ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/08/04 02:53:54 DEBUG : pacer: Reducing sleep to 200ms fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestCat (143.25s) === RUN TestRmdirsNoLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:54:07 INFO : A2: Making directory 2026/08/04 02:54:09 INFO : A1/B2: Making directory 2026/08/04 02:54:10 INFO : A1/B2/C2: Making directory 2026/08/04 02:54:12 INFO : A1/B1/C3: Making directory 2026/08/04 02:54:13 INFO : A3: Making directory 2026/08/04 02:54:15 INFO : A3/B3: Making directory 2026/08/04 02:54:16 INFO : A3/B3/C4: Making directory 2026/08/04 02:54:22 DEBUG : removing 1 level 3 directories 2026/08/04 02:54:22 INFO : A3/B3/C4: Removing directory 2026/08/04 02:54:28 DEBUG : removing 2 level 3 directories 2026/08/04 02:54:28 INFO : A1/B2/C2: Removing directory 2026/08/04 02:54:28 INFO : A1/B1/C3: Removing directory 2026/08/04 02:54:30 DEBUG : removing 2 level 2 directories 2026/08/04 02:54:30 INFO : A3/B3: Removing directory 2026/08/04 02:54:30 INFO : A1/B2: Removing directory 2026/08/04 02:54:32 DEBUG : removing 2 level 1 directories 2026/08/04 02:54:32 INFO : A3: Removing directory 2026/08/04 02:54:32 INFO : A2: Removing directory 2026/08/04 02:54:32 ERROR : A3: Failed to rmdir: directory not empty operations_test.go:705: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:705 Error: Received unexpected error: failed to remove directories: directory not empty Test: TestRmdirsNoLeaveRoot 2026/08/04 02:54:35 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:35 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:54:36 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:36 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:54:36 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:36 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:54:37 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:37 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:54:38 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:40 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:42 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:44 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:46 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:48 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:48 ERROR : A1/B1: error listing: getting files failed: invalid character '<' looking for beginning of value run.go:182: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:182 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:705 Error: Received unexpected error: getting files failed: invalid character '<' looking for beginning of value Test: TestRmdirsNoLeaveRoot --- FAIL: TestRmdirsNoLeaveRoot (48.01s) === RUN TestRmdirsLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:54:48 INFO : A1: Making directory 2026/08/04 02:54:48 INFO : A1/B1: Making directory 2026/08/04 02:54:48 INFO : A1/B1/C1: Making directory 2026/08/04 02:54:50 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:52 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:54 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:56 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:54:58 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:01 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:55:03 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:55:04 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:55:05 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:55:06 DEBUG : pacer: Reducing sleep to 474.609375ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/08/04 02:55:07 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:55:08 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:55:08 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:55:08 DEBUG : pacer: Reducing sleep to 200ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:750 Error: Should be true Test: TestRmdirsLeaveRoot Messages: listing wrong, want got A1/B1/C1/one (3) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:750 Error: Should be true Test: TestRmdirsLeaveRoot Messages: Unexpected file "A1/B1/C1/one" fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:750 Error: Not equal: expected: []string{"A1", "A1/B1", "A1/B1/C1"} actual : []string{"A1", "A1/B1", "A1/B1/C1", "A3"} Diff: --- Expected +++ Actual @@ -1,5 +1,6 @@ -([]string) (len=3) { +([]string) (len=4) { (string) (len=2) "A1", (string) (len=5) "A1/B1", - (string) (len=8) "A1/B1/C1" + (string) (len=8) "A1/B1/C1", + (string) (len=2) "A3" } Test: TestRmdirsLeaveRoot Messages: directories fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:764 Error: Should be true Test: TestRmdirsLeaveRoot Messages: listing wrong, want got A1/B1/C1/one (3) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:764 Error: Should be true Test: TestRmdirsLeaveRoot Messages: Unexpected file "A1/B1/C1/one" fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:764 Error: Not equal: expected: []string{"A1"} actual : []string{"A1", "A1/B1", "A1/B1/C1", "A3"} Diff: --- Expected +++ Actual @@ -1,3 +1,6 @@ -([]string) (len=1) { - (string) (len=2) "A1" +([]string) (len=4) { + (string) (len=2) "A1", + (string) (len=5) "A1/B1", + (string) (len=8) "A1/B1/C1", + (string) (len=2) "A3" } Test: TestRmdirsLeaveRoot Messages: directories run.go:186: removing dir "A1/B1/C1" failed - try 1/3: sleeping 1s: directory not empty run.go:186: removing dir "A1/B1" failed - try 1/3: sleeping 1s: directory not empty run.go:186: removing dir "A1" failed - try 1/3: sleeping 1s: directory not empty 2026/08/04 02:55:39 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:39 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:55:40 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:40 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:55:40 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:40 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:55:41 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:41 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:55:42 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:44 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:46 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:48 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:50 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:52 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:186: removing dir "A1" failed - try 2/3: sleeping 1.5s: getting files failed: invalid character '<' looking for beginning of value 2026/08/04 02:55:54 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:56 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:55:58 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:00 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:03 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:56:06 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:56:06 DEBUG : pacer: Reducing sleep to 843.75ms --- FAIL: TestRmdirsLeaveRoot (77.62s) === RUN TestRmdirsWithFilter run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:56:06 INFO : A1: Making directory 2026/08/04 02:56:07 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:56:09 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:56:09 INFO : A1/B1: Making directory 2026/08/04 02:56:09 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:56:11 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:56:11 INFO : A1/B1/C1: Making directory 2026/08/04 02:56:11 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:56:12 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:56:14 DEBUG : removing 1 level 3 directories 2026/08/04 02:56:14 INFO : A1/B1/C1: Removing directory 2026/08/04 02:56:16 DEBUG : removing 1 level 2 directories 2026/08/04 02:56:16 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (13.73s) === RUN TestCopyURL run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:56:22 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:56:22 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:56:23 DEBUG : file1: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 02:56:23 DEBUG : file1: Trying to read object after upload: try again in 800ms (4/10) 2026/08/04 02:56:25 DEBUG : filename.txt: File name found in url 2026/08/04 02:56:27 DEBUG : filename.txt: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:56:27 DEBUG : filename.txt: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:56:28 DEBUG : headerfilename.txt: filename found in Content-Disposition header. 2026/08/04 02:56:28 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:28 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:56:28 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:28 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:56:28 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:28 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:56:29 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:29 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:56:31 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:33 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:35 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:37 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:39 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:41 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:41 ERROR : headerfilename.txt: Post request put error: Update err in unmarshaling response: invalid character '<' looking for beginning of value operations_test.go:863: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:863 Error: Received unexpected error: Update err in unmarshaling response: invalid character '<' looking for beginning of value Test: TestCopyURL 2026/08/04 02:56:43 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:45 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:47 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:49 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:51 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:53 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:55 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:57 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:56:59 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:01 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:01 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value run.go:182: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:182 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:863 Error: Received unexpected error: getting files failed: invalid character '<' looking for beginning of value Test: TestCopyURL --- FAIL: TestCopyURL (41.00s) === RUN TestCopyURLDownloadHeaders run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:57:03 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:57:03 DEBUG : file1: Update: removing old file 2026/08/04 02:57:06 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:57:06 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:57:09 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:57:09 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:57:09 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:57:10 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:57:10 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:57:10 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:57:11 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:57:12 DEBUG : pacer: Reducing sleep to 200ms --- PASS: TestCopyURLDownloadHeaders (12.67s) === RUN TestMoveFile run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:57:14 DEBUG : file1: Need to transfer - File not found at Destination 2026/08/04 02:57:17 DEBUG : sub/file2: size = 14 OK 2026/08/04 02:57:17 INFO : file1: Copied (new) to: sub/file2 2026/08/04 02:57:17 INFO : file1: Deleted 2026/08/04 02:57:18 DEBUG : sub/file2: size = 14 OK 2026/08/04 02:57:18 DEBUG : file1: Sizes identical 2026/08/04 02:57:18 DEBUG : file1: Unchanged skipping 2026/08/04 02:57:18 INFO : file1: Deleted 2026/08/04 02:57:18 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (8.73s) === RUN TestMoveFileWithIgnoreExisting run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:57:22 DEBUG : file1: Need to transfer - File not found at Destination 2026/08/04 02:57:24 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:57:25 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 02:57:25 DEBUG : file1: size = 14 OK 2026/08/04 02:57:25 INFO : file1: Copied (new) 2026/08/04 02:57:25 INFO : file1: Deleted 2026/08/04 02:57:26 DEBUG : file1: Destination exists, skipping 2026/08/04 02:57:26 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestMoveFileWithIgnoreExisting Messages: listing wrong, want got file1 (14) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestMoveFileWithIgnoreExisting Messages: Unexpected file "file1" --- FAIL: TestMoveFileWithIgnoreExisting (13.48s) === RUN TestCaseInsensitiveMoveFileDryRun run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:57:36 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:36 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:57:36 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:36 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:57:36 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:36 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:57:37 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:37 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:57:39 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:41 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:43 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:45 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:47 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:49 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "hello" to Linkbox root 'rclone-test-sihonaz7dena': 1/10 (getting files failed: invalid character '<' looking for beginning of value) 2026/08/04 02:57:51 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:53 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:55 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:57 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:57:59 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:01 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:03 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:05 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:58:07 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:58:08 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:58:11 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:58:11 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:58:11 DEBUG : hello: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:58:12 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:58:12 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:58:12 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:58:13 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:58:13 NOTICE: hello: Skipped rename to HELLO as --dry-run is set --- PASS: TestCaseInsensitiveMoveFileDryRun (38.93s) === RUN TestMoveFileBackupDir run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1063: Skipping test as remote does not support server-side move or copy --- SKIP: TestMoveFileBackupDir (0.40s) === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 02:58:19 DEBUG : A1/one: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 02:58:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:31 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:58:32 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:32 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:58:32 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:32 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:58:33 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:33 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:58:34 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:36 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:38 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:40 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:42 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:44 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:299: Retry Put of "A1/B1/C2/five" to Linkbox root 'rclone-test-sihonaz7dena': 1/10 (Update failed to read object: getting files failed: invalid character '<' looking for beginning of value) 2026/08/04 02:58:47 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:49 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:51 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:53 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:55 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:57 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:58:59 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:01 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:03 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:05 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 02:59:05 DEBUG : A1/B1/C2/five: Update: removing old file 2026/08/04 02:59:08 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 02:59:08 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 02:59:10 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 02:59:11 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 02:59:11 INFO : A1/B2: Making directory 2026/08/04 02:59:11 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 02:59:13 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 02:59:13 INFO : A1/B1/C3: Making directory 2026/08/04 02:59:13 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 02:59:15 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 02:59:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:31 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 02:59:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:31 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 02:59:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:31 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 02:59:32 DEBUG : pacer: Reducing sleep to 1.2s 2026/08/04 02:59:32 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:32 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 02:59:33 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:35 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:37 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:39 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:41 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:43 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:45 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:47 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:49 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:51 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:53 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:55 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:57 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 02:59:59 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:01 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:03 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:06 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:00:09 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 03:00:09 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:00:09 DEBUG : A2/B1/C2/five: size = 4 OK 2026/08/04 03:00:09 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/08/04 03:00:11 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:00:12 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:00:12 DEBUG : A2/B1/three: size = 5 OK 2026/08/04 03:00:12 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/08/04 03:00:12 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:00:13 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 03:00:13 DEBUG : A2/one: size = 3 OK 2026/08/04 03:00:13 INFO : A1/one: Copied (new) to: A2/one 2026/08/04 03:00:13 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:00:13 DEBUG : A2/two: size = 3 OK 2026/08/04 03:00:13 INFO : A1/two: Copied (new) to: A2/two 2026/08/04 03:00:14 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 03:00:14 DEBUG : A2/B1/C1/four: size = 4 OK 2026/08/04 03:00:14 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/08/04 03:00:14 INFO : A1/B1/C2/five: Deleted 2026/08/04 03:00:15 INFO : A1/B1/three: Deleted 2026/08/04 03:00:15 INFO : A1/one: Deleted 2026/08/04 03:00:15 INFO : A1/two: Deleted 2026/08/04 03:00:15 INFO : A1/B1/C1/four: Deleted operations_test.go:1411: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1411 Error: Received unexpected error: RenameDir rmdir: directory not empty Test: TestDirMove 2026/08/04 03:00:32 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:32 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 03:00:32 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:32 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 03:00:32 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:32 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 03:00:33 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:33 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 03:00:35 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:37 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:39 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:41 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:43 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:45 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) run.go:186: removing dir "A2/B1/C3" failed - try 1/3: sleeping 1s: getting files failed: invalid character '<' looking for beginning of value 2026/08/04 03:00:47 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:49 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:51 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:53 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:55 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:57 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:00:59 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:01 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:03 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:05 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:01:08 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 03:01:08 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:01:11 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:01:11 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:01:13 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:01:13 DEBUG : pacer: Reducing sleep to 266.967773ms run.go:186: removing dir "A2/B1" failed - try 1/3: sleeping 1s: directory not empty 2026/08/04 03:01:14 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:01:16 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestDirMove (185.59s) === RUN TestGetFsInfo run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 03:01:21 DEBUG : Config file has changed externally - reloading --- PASS: TestGetFsInfo (0.40s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 03:01:21 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': File to upload is small (34 bytes), uploading instead of streaming 2026/08/04 03:01:23 DEBUG : no_checksum_small_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:01:24 DEBUG : no_checksum_small_file_from_pipe: size = 34 OK 2026/08/04 03:01:24 NOTICE: Linkbox root 'rclone-test-sihonaz7dena': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2026/08/04 03:01:24 DEBUG : no_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/08/04 03:01:24 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/08/04 03:01:26 DEBUG : no_checksum_big_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:01:26 DEBUG : no_checksum_big_file_from_pipe: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:01:26 DEBUG : no_checksum_big_file_from_pipe: size = 102401 OK 2026/08/04 03:01:26 DEBUG : no_checksum_big_file_from_pipe: Size of src and dst objects identical fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure === RUN TestRcat/withChecksum=true,ignoreChecksum=false run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 03:01:37 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': File to upload is small (34 bytes), uploading instead of streaming 2026/08/04 03:01:38 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:38 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 03:01:38 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:38 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 03:01:38 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:38 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 03:01:39 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:39 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 03:01:41 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:43 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:45 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:47 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:49 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:51 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:51 DEBUG : with_checksum_small_file_from_pipe: Received error: Update second step failed: invalid character '<' looking for beginning of value - low level retry 1/10 2026/08/04 03:01:53 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:55 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:57 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:01:59 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:01 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:03 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:05 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:02:07 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/04 03:02:10 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:02:10 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:02:10 DEBUG : with_checksum_small_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:02:11 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:02:11 DEBUG : with_checksum_small_file_from_pipe: size = 34 OK 2026/08/04 03:02:11 DEBUG : with_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/08/04 03:02:11 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/08/04 03:02:11 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:02:12 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 03:02:13 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:02:14 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 03:02:14 DEBUG : with_checksum_big_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/08/04 03:02:14 DEBUG : with_checksum_big_file_from_pipe: Trying to read object after upload: try again in 200ms (2/10) 2026/08/04 03:02:14 DEBUG : with_checksum_big_file_from_pipe: Trying to read object after upload: try again in 400ms (3/10) 2026/08/04 03:02:15 DEBUG : with_checksum_big_file_from_pipe: size = 102401 OK 2026/08/04 03:02:15 DEBUG : with_checksum_big_file_from_pipe: Size of src and dst objects identical === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 03:02:18 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': File to upload is small (34 bytes), uploading instead of streaming 2026/08/04 03:02:20 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2026/08/04 03:02:20 DEBUG : ignore_checksum_small_file_from_pipe: Sizes identical 2026/08/04 03:02:20 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/08/04 03:02:22 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2026/08/04 03:02:22 DEBUG : ignore_checksum_big_file_from_pipe: Sizes identical === RUN TestRcat/withChecksum=true,ignoreChecksum=true run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 03:02:26 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': File to upload is small (34 bytes), uploading instead of streaming 2026/08/04 03:02:28 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2026/08/04 03:02:28 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/08/04 03:02:28 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/08/04 03:02:30 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2026/08/04 03:02:30 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical 2026/08/04 03:02:33 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:33 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/04 03:02:33 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:33 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/04 03:02:34 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:34 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/04 03:02:34 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:34 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/04 03:02:36 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:38 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:40 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:42 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:44 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:46 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:46 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:282: Error listing: getting files failed: invalid character '<' looking for beginning of value --- FAIL: TestRcat (85.04s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (16.19s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (41.09s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (7.44s) --- FAIL: TestRcat/withChecksum=true,ignoreChecksum=true (20.32s) === RUN TestRcatMetadata run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1563: Skipping as destination doesn't support user metadata 2026/08/04 03:02:48 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:50 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:52 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:54 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:56 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:02:58 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:03:00 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:03:02 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:03:04 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/04 03:03:06 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/04 03:03:08 DEBUG : pacer: Reducing sleep to 1.125s --- SKIP: TestRcatMetadata (22.19s) === RUN TestRcatSize run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" 2026/08/04 03:03:10 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/04 03:03:11 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/04 03:03:13 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/04 03:03:13 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/04 03:03:13 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': File to upload is small (60 bytes), uploading instead of streaming 2026/08/04 03:03:13 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/04 03:03:14 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/04 03:03:16 DEBUG : pacer: Reducing sleep to 200ms 2026/08/04 03:03:16 DEBUG : potato2: size = 60 OK 2026/08/04 03:03:16 DEBUG : potato2: Size of src and dst objects identical --- PASS: TestRcatSize (11.07s) === RUN TestRcatSizeMetadata run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1644: Skipping as destination doesn't support user metadata --- SKIP: TestRcatSizeMetadata (0.43s) === RUN TestRcatSizeUploadHeaders run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" --- PASS: TestRcatSizeUploadHeaders (3.74s) === RUN TestTouchDir run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1735: Skipping test as remote does not support modtime --- SKIP: TestTouchDir (0.43s) === RUN TestMkdirMetadata run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1773: Skipping test as remote does not support MkdirMetadata --- SKIP: TestMkdirMetadata (0.42s) === RUN TestMkdirModTime run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1792: Skipping test as remote does not support DirSetModTime or MkdirMetadata --- SKIP: TestMkdirModTime (0.41s) === RUN TestCopyDirMetadata run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1813: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata --- SKIP: TestCopyDirMetadata (0.40s) === RUN TestSetDirModTime run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1849: Skipping test as remote does not support DirSetModTime or WriteDirSetModTime --- SKIP: TestSetDirModTime (0.41s) === RUN TestDirsEqual run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1893: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata --- SKIP: TestDirsEqual (0.42s) === RUN TestRemoveExisting run.go:198: Remote "Linkbox root 'rclone-test-sihonaz7dena'", Local "Local file system at /tmp/rclone1617524713", Modify Window "876000h0m0s" operations_test.go:1962: Skipping as remote can't Move --- SKIP: TestRemoveExisting (0.40s) FAIL 2026/08/04 03:03:26 DEBUG : Linkbox root 'rclone-test-sihonaz7dena': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCaseInsensitiveMoveFileDryRun|TestCat|TestCheckSum|TestCheckSumDownload|TestCopyDirMetadata|TestCopyFile|TestCopyFileBackupDir|TestCopyFileCompareDest|TestCopyFileCopyDest|TestCopyFileMaxTransfer|TestCopyInplace|TestCopyLongFile|TestCopyLongFileName|TestCopyLongFileNameCollision|TestCopyURL|TestCopyURLDownloadHeaders|TestCount|TestDeduplicateFirst|TestDeduplicateInteractive|TestDeduplicateLargest|TestDeduplicateNewest|TestDeduplicateNewestByHash|TestDeduplicateOldest|TestDeduplicateRename|TestDeduplicateSizeOnly|TestDeduplicateSkip|TestDeduplicateSmallest|TestDelete|TestDirMove|TestDirsEqual|TestGetFsInfo|TestHashSums|TestLs|TestLsLong|TestLsWithFilesFrom|TestLsd|TestMaxDelete|TestMaxDeleteSize|TestMaxDeleteSizeLargeFile|TestMergeDirs|TestMkdir|TestMkdirMetadata|TestMkdirModTime|TestMoveFile|TestMoveFileBackupDir|TestMoveFileWithIgnoreExisting|TestParseSumFile|TestRcatMetadata|TestRcatSize|TestRcatSizeMetadata|TestRcatSizeUploadHeaders|TestReadFile|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestRmdirsWithFilter|TestSetDirModTime|TestStatJSON|TestTouchDir)$|^TestCheckDownload$/^2$|^TestListJSON$/^(Default|FilesOnly|HashTypes|Metadata|NoMimeType|NoModTime|Recurse|ShowHash)$|^TestRcat$/^(withChecksum=false,ignoreChecksum=false|withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=false|withChecksum=true,ignoreChecksum=true)$'" - Finished ERROR in 23m42.86329943s (try 2/5): exit status 1: Failed [TestCheckSumDownload TestCopyFileCompareDest TestMaxDelete TestMaxDeleteSizeLargeFile TestCat TestRmdirsNoLeaveRoot TestRmdirsLeaveRoot TestCopyURL TestMoveFileWithIgnoreExisting TestDirMove TestRcat/withChecksum=true,ignoreChecksum=true]