"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyURL|TestCount|TestDeduplicateRename|TestDeduplicateSmallest|TestDirMove|TestHashSums|TestListDirSortedFn|TestListJSON|TestLs|TestLsLong|TestLsWithFilesFrom|TestLsd|TestMergeDirs|TestMkdir|TestRcatSizeUploadHeaders|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestRmdirsWithFilter|TestStatJSON)$'" - Starting (try 2/5) 2026/06/29 01:48:55 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-gebapod0qali" 2026/06/29 01:48:55 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/06/29 01:48:55 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Using cached web token 2026/06/29 01:48:56 DEBUG : Creating backend with remote "/tmp/rclone754638642" === RUN TestDeduplicateSmallest run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2026/06/29 01:48:56 ERROR : error listing: directory not found --- SKIP: TestDeduplicateSmallest (0.24s) === RUN TestDeduplicateRename run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2026/06/29 01:48:56 ERROR : error listing: directory not found --- SKIP: TestDeduplicateRename (0.27s) === RUN TestMergeDirs run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" dedupe_test.go:256: Can't merge directories 2026/06/29 01:48:57 ERROR : error listing: directory not found --- SKIP: TestMergeDirs (0.27s) === RUN TestListDirSortedFn run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" run.go:303: Failed to put "sub dir/ignore dir/.ignore" to "Linkbox root 'rclone-test-gebapod0qali'": Update second step failed: Linkbox error 500: The file name needs to include a suffix, such as xxx.mp4 --- FAIL: TestListDirSortedFn (23.51s) === RUN TestListJSON run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" === RUN TestListJSON/Default === RUN TestListJSON/FilesOnly === RUN TestListJSON/DirsOnly === RUN TestListJSON/Recurse === RUN TestListJSON/SubDir === RUN TestListJSON/NoModTime === RUN TestListJSON/NoMimeType === RUN TestListJSON/ShowHash === RUN TestListJSON/HashTypes 2026/06/29 01:49:28 ERROR : file1: Failed to read hash: hash type not supported === RUN TestListJSON/Metadata --- PASS: TestListJSON (13.12s) --- PASS: TestListJSON/Default (0.22s) --- PASS: TestListJSON/FilesOnly (0.25s) --- PASS: TestListJSON/DirsOnly (0.20s) --- PASS: TestListJSON/Recurse (0.41s) --- PASS: TestListJSON/SubDir (0.23s) --- PASS: TestListJSON/NoModTime (0.20s) --- PASS: TestListJSON/NoMimeType (0.21s) --- PASS: TestListJSON/ShowHash (0.21s) --- PASS: TestListJSON/HashTypes (0.20s) --- PASS: TestListJSON/Metadata (0.20s) === RUN TestStatJSON run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" === 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/06/29 01:49:42 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-gebapod0qali/notfound" 2026/06/29 01:49:42 DEBUG : Linkbox root 'rclone-test-gebapod0qali/notfound': Using cached web token --- PASS: TestStatJSON (15.16s) --- PASS: TestStatJSON/Root (0.20s) --- PASS: TestStatJSON/RootFilesOnly (0.00s) --- PASS: TestStatJSON/RootDirsOnly (0.21s) --- PASS: TestStatJSON/Dir (0.41s) --- PASS: TestStatJSON/DirWithTrailingSlash (0.20s) --- PASS: TestStatJSON/File (0.21s) --- PASS: TestStatJSON/NotFound (0.43s) --- PASS: TestStatJSON/DirFilesOnly (0.21s) --- PASS: TestStatJSON/FileFilesOnly (0.27s) --- PASS: TestStatJSON/NotFoundFilesOnly (0.20s) --- PASS: TestStatJSON/DirDirsOnly (0.22s) --- PASS: TestStatJSON/FileDirsOnly (0.27s) --- PASS: TestStatJSON/NotFoundDirsOnly (0.20s) --- PASS: TestStatJSON/RootNotFound (1.40s) === RUN TestMkdir run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:49:48 INFO : Linkbox root 'rclone-test-gebapod0qali': Making directory 2026/06/29 01:49:49 INFO : Linkbox root 'rclone-test-gebapod0qali': Making directory --- PASS: TestMkdir (0.60s) === RUN TestLsd run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" --- PASS: TestLsd (7.72s) === RUN TestLs run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" --- PASS: TestLs (7.90s) === RUN TestLsWithFilesFrom run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:50:09 DEBUG : empty space: Excluded (FilesFrom Filter) 2026/06/29 01:50:09 DEBUG : empty space: Excluded --- PASS: TestLsWithFilesFrom (8.00s) === RUN TestLsLong run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" --- PASS: TestLsLong (7.47s) === RUN TestHashSums run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" --- PASS: TestHashSums (7.53s) === RUN TestCount run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" --- PASS: TestCount (14.45s) === RUN TestRmdirsNoLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:50:49 INFO : A2: Making directory 2026/06/29 01:50:51 INFO : A1/B2: Making directory 2026/06/29 01:50:52 INFO : A1/B2/C2: Making directory 2026/06/29 01:50:54 INFO : A1/B1/C3: Making directory 2026/06/29 01:50:55 INFO : A3: Making directory 2026/06/29 01:50:57 INFO : A3/B3: Making directory 2026/06/29 01:50:58 INFO : A3/B3/C4: Making directory 2026/06/29 01:51:05 DEBUG : removing 1 level 3 directories 2026/06/29 01:51:05 INFO : A3/B3/C4: Removing directory 2026/06/29 01:51:10 DEBUG : removing 2 level 3 directories 2026/06/29 01:51:10 INFO : A1/B2/C2: Removing directory 2026/06/29 01:51:10 INFO : A1/B1/C3: Removing directory 2026/06/29 01:51:12 DEBUG : removing 2 level 2 directories 2026/06/29 01:51:12 INFO : A3/B3: Removing directory 2026/06/29 01:51:12 INFO : A1/B2: Removing directory 2026/06/29 01:51:14 DEBUG : removing 2 level 1 directories 2026/06/29 01:51:14 INFO : A3: Removing directory 2026/06/29 01:51:14 INFO : A2: Removing directory 2026/06/29 01:51:21 DEBUG : removing 1 level 3 directories 2026/06/29 01:51:21 INFO : A1/B1/C1: Removing directory 2026/06/29 01:51:22 DEBUG : removing 1 level 2 directories 2026/06/29 01:51:22 INFO : A1/B1: Removing directory 2026/06/29 01:51:24 DEBUG : removing 1 level 1 directories 2026/06/29 01:51:24 INFO : A1: Removing directory 2026/06/29 01:51:25 DEBUG : removing 1 level 0 directories 2026/06/29 01:51:25 INFO : Linkbox root 'rclone-test-gebapod0qali': Removing directory 2026/06/29 01:51:27 ERROR : error listing: directory not found 2026/06/29 01:51:27 ERROR : error listing: directory not found --- PASS: TestRmdirsNoLeaveRoot (45.00s) === RUN TestRmdirsLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:51:29 INFO : A1: Making directory 2026/06/29 01:51:30 INFO : A1/B1: Making directory 2026/06/29 01:51:32 INFO : A1/B1/C1: Making directory 2026/06/29 01:51:35 DEBUG : removing 1 level 3 directories 2026/06/29 01:51:35 INFO : A1/B1/C1: Removing directory 2026/06/29 01:51:36 DEBUG : removing 1 level 2 directories 2026/06/29 01:51:36 INFO : A1/B1: Removing directory 2026/06/29 01:51:39 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token run.go:186: removing dir "A1" failed - try 1/3: sleeping 1s: getting files failed: login failed: invalid character '<' looking for beginning of value 2026/06/29 01:51:40 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token run.go:186: removing dir "A1" failed - try 2/3: sleeping 1.5s: getting files failed: login failed: invalid character '<' looking for beginning of value 2026/06/29 01:51:42 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token run.go:186: removing dir "A1" failed: getting files failed: login failed: invalid character '<' looking for beginning of value 2026/06/29 01:51:42 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token 2026/06/29 01:51:42 DEBUG : Saving config "web_token" in section "TestLinkbox" of the config file 2026/06/29 01:51:42 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Login successful 2026/06/29 01:51:42 DEBUG : pacer: low level retry 1/10 (error ) 2026/06/29 01:51:42 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/06/29 01:51:43 DEBUG : pacer: Reducing sleep to 300ms 2026/06/29 01:51:43 DEBUG : pacer: Reducing sleep to 225ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/06/29 01:51:44 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: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/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: Not equal: expected: []string{} actual : []string{"A1"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A1" } Test: TestRmdirsLeaveRoot Messages: directories --- FAIL: TestRmdirsLeaveRoot (24.12s) === RUN TestRmdirsWithFilter run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:51:52 INFO : A1: Making directory 2026/06/29 01:51:52 INFO : A1/B1: Making directory 2026/06/29 01:51:53 INFO : A1/B1/C1: Making directory 2026/06/29 01:51:56 DEBUG : removing 1 level 3 directories 2026/06/29 01:51:56 INFO : A1/B1/C1: Removing directory 2026/06/29 01:51:58 DEBUG : removing 1 level 2 directories 2026/06/29 01:51:58 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (10.67s) === RUN TestCopyURL run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:52:05 DEBUG : filename.txt: File name found in url 2026/06/29 01:52:07 DEBUG : headerfilename.txt: filename found in Content-Disposition header. --- PASS: TestCopyURL (14.44s) === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:52:33 INFO : A1/B2: Making directory 2026/06/29 01:52:34 INFO : A1/B1/C3: Making directory 2026/06/29 01:52:49 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 382h2m25.148061751s different from this computer 2026/06/29 01:52:53 DEBUG : A2/B1/three: size = 5 OK 2026/06/29 01:52:53 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/06/29 01:52:53 DEBUG : A2/B1/C2/five: size = 4 OK 2026/06/29 01:52:53 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/06/29 01:52:54 DEBUG : A2/B1/C1/four: size = 4 OK 2026/06/29 01:52:54 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/06/29 01:52:54 DEBUG : A2/one: size = 3 OK 2026/06/29 01:52:54 INFO : A1/one: Copied (new) to: A2/one 2026/06/29 01:52:54 DEBUG : A2/two: size = 3 OK 2026/06/29 01:52:54 INFO : A1/two: Copied (new) to: A2/two 2026/06/29 01:52:55 INFO : A1/B1/three: Deleted 2026/06/29 01:52:55 INFO : A1/B1/C2/five: Deleted 2026/06/29 01:52:56 INFO : A1/B1/C1/four: Deleted 2026/06/29 01:52:56 INFO : A1/one: Deleted 2026/06/29 01:52:56 INFO : A1/two: Deleted 2026/06/29 01:53:23 DEBUG : A3/two: size = 3 OK 2026/06/29 01:53:23 INFO : A2/two: Copied (new) to: A3/two 2026/06/29 01:53:23 DEBUG : A3/one: size = 3 OK 2026/06/29 01:53:23 INFO : A2/one: Copied (new) to: A3/one 2026/06/29 01:53:23 DEBUG : A3/B1/three: size = 5 OK 2026/06/29 01:53:23 INFO : A2/B1/three: Copied (new) to: A3/B1/three 2026/06/29 01:53:24 DEBUG : A3/B1/C1/four: size = 4 OK 2026/06/29 01:53:24 INFO : A2/B1/C1/four: Copied (new) to: A3/B1/C1/four 2026/06/29 01:53:24 DEBUG : A3/B1/C2/five: size = 4 OK 2026/06/29 01:53:24 INFO : A2/B1/C2/five: Copied (new) to: A3/B1/C2/five 2026/06/29 01:53:24 INFO : A2/two: Deleted 2026/06/29 01:53:24 INFO : A2/one: Deleted 2026/06/29 01:53:25 INFO : A2/B1/three: Deleted 2026/06/29 01:53:25 INFO : A2/B1/C1/four: Deleted 2026/06/29 01:53:25 INFO : A2/B1/C2/five: Deleted 2026/06/29 01:53:36 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token 2026/06/29 01:53:36 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token 2026/06/29 01:53:36 ERROR : A3/B1/C1: error listing: getting files failed: login failed: invalid character '<' looking for beginning of value 2026/06/29 01:53:36 ERROR : A3/B1/C2: error listing: getting files failed: login failed: invalid character '<' looking for beginning of value fstest.go:282: Error listing: getting files failed: login failed: invalid character '<' looking for beginning of value 2026/06/29 01:53:36 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token 2026/06/29 01:53:37 ERROR : error listing: getting files failed: login 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 /usr/local/go/src/testing/testing.go:1228 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:282 /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:1442 Error: Received unexpected error: getting files failed: login failed: invalid character '<' looking for beginning of value Test: TestDirMove --- FAIL: TestDirMove (80.17s) === RUN TestRcatSizeUploadHeaders run.go:198: Remote "Linkbox root 'rclone-test-gebapod0qali'", Local "Local file system at /tmp/rclone754638642", Modify Window "876000h0m0s" 2026/06/29 01:53:37 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token 2026/06/29 01:53:37 ERROR : potato1: Post request put error: Update err in unmarshaling response: invalid character '<' looking for beginning of value operations_test.go:1714: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1714 Error: Received unexpected error: Update err in unmarshaling response: invalid character '<' looking for beginning of value Test: TestRcatSizeUploadHeaders 2026/06/29 01:53:37 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Web API returned error "Linkbox error 0: " - refreshing token 2026/06/29 01:53:38 ERROR : error listing: getting files failed: login 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:1714 Error: Received unexpected error: getting files failed: login failed: invalid character '<' looking for beginning of value Test: TestRcatSizeUploadHeaders --- FAIL: TestRcatSizeUploadHeaders (1.00s) FAIL 2026/06/29 01:53:38 DEBUG : Linkbox root 'rclone-test-gebapod0qali': Purge remote 2026/06/29 01:53:38 NOTICE: purge failed: purge error: invalid character '<' looking for beginning of value "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyURL|TestCount|TestDeduplicateRename|TestDeduplicateSmallest|TestDirMove|TestHashSums|TestListDirSortedFn|TestListJSON|TestLs|TestLsLong|TestLsWithFilesFrom|TestLsd|TestMergeDirs|TestMkdir|TestRcatSizeUploadHeaders|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestRmdirsWithFilter|TestStatJSON)$'" - Finished ERROR in 4m42.656440883s (try 2/5): exit status 1: Failed [TestListDirSortedFn TestRmdirsLeaveRoot TestDirMove TestRcatSizeUploadHeaders]