"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyFileCompareDest|TestDirMove|TestListDirSortedFn|TestMaxDelete|TestMaxDeleteSize|TestRcatSizeUploadHeaders|TestRmdirsNoLeaveRoot)$|^TestRcat$/^(withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=true)$'" - Starting (try 4/5) 2026/05/24 02:15:32 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-laxemul4poci" 2026/05/24 02:15:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/05/24 02:15:32 DEBUG : Linkbox root 'rclone-test-laxemul4poci': Using cached web token 2026/05/24 02:15:33 DEBUG : Creating backend with remote "/tmp/rclone1210978202" === RUN TestCheckSumDownload run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:15:33 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-laxemul4poci/data" 2026/05/24 02:15:33 DEBUG : Linkbox root 'rclone-test-laxemul4poci/data': Using cached web token 2026/05/24 02:15:40 DEBUG : test.sum: Trying to read object after upload: try again in 100ms (1/10) === RUN TestCheckSumDownload/subtest1 2026/05/24 02:15:44 DEBUG : test.sum: Update: removing old file === NAME TestCheckSumDownload 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:450 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestCheckSumDownload Messages: listing wrong, want data/banana (13), data/potato (15), test.sum (41) got data/banana (13), data/potato (15), test(1).sum (41) 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:450 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 Error: Should be true Test: TestCheckSumDownload Messages: Unexpected file "test(1).sum" fstest.go:203: Not found "test.sum" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:450 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 Error: Not equal: expected: 0 actual : 1 Test: TestCheckSumDownload Messages: 1 objects not found === RUN TestCheckSumDownload/subtest2 === NAME TestCheckSumDownload check_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:409 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: 1 actual : 0 Test: TestCheckSumDownload Messages: wrong error count in run 2 check_test.go:413: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:413 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: "" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 2 check_test.go:415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:415 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: 2 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 2 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:417 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "- potato", "= banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=8) "- potato", - (string) (len=8) "= banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong combined result in run 2 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:418 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong missingonsrc result in run 2 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 2 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:464 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestCheckSumDownload Messages: listing wrong, want data/banana (13), data/potato (15), test.sum (82) got data/banana (13), data/potato (15), test(1).sum (41), test.sum (82) 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:464 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 Error: Should be true Test: TestCheckSumDownload Messages: Unexpected file "test(1).sum" === RUN TestCheckSumDownload/subtest3 2026/05/24 02:16:08 DEBUG : test.sum: Update: removing old file 2026/05/24 02:16:11 DEBUG : test.sum: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:16:11 DEBUG : test.sum: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:16:12 DEBUG : test.sum: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:16:12 DEBUG : test.sum: Trying to read object after upload: try again in 800ms (4/10) 2026/05/24 02:16:13 DEBUG : test.sum: Trying to read object after upload: try again in 1.6s (5/10) 2026/05/24 02:16:15 DEBUG : test.sum: Trying to read object after upload: try again in 3.2s (6/10) === NAME TestCheckSumDownload 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:478 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestCheckSumDownload Messages: listing wrong, want data/banana (13), data/potato (15), test.sum (82) got data/banana (13), data/potato (15), test(1).sum (41), test.sum (82) 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/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:478 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 Error: Should be true Test: TestCheckSumDownload Messages: Unexpected file "test(1).sum" === RUN TestCheckSumDownload/subtest4 2026/05/24 02:16:28 DEBUG : test.sum: Update: removing old file 2026/05/24 02:16:31 DEBUG : test.sum: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:16:32 DEBUG : test.sum: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:16:32 DEBUG : test.sum: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:16:33 DEBUG : test.sum: Trying to read object after upload: try again in 800ms (4/10) 2026/05/24 02:16:34 DEBUG : test.sum: Trying to read object after upload: try again in 1.6s (5/10) 2026/05/24 02:16:36 DEBUG : test.sum: Trying to read object after upload: try again in 3.2s (6/10) 2026/05/24 02:16:39 DEBUG : test.sum: Trying to read object after upload: try again in 6.4s (7/10) 2026/05/24 02:16:46 DEBUG : test.sum: Trying to read object after upload: try again in 12.8s (8/10) 2026/05/24 02:16:59 DEBUG : test.sum: Trying to read object after upload: try again in 25.6s (9/10) 2026/05/24 02:17:24 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-laxemul4poci'": object not found --- FAIL: TestCheckSumDownload (170.39s) --- PASS: TestCheckSumDownload/subtest1 (1.02s) --- PASS: TestCheckSumDownload/subtest2 (0.42s) --- PASS: TestCheckSumDownload/subtest3 (0.97s) --- PASS: TestCheckSumDownload/subtest4 (0.96s) === RUN TestCopyFileCompareDest run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:18:23 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-laxemul4poci/dst" 2026/05/24 02:18:23 DEBUG : Linkbox root 'rclone-test-laxemul4poci/dst': Using cached web token 2026/05/24 02:18:24 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-laxemul4poci/CompareDest" 2026/05/24 02:18:24 DEBUG : Linkbox root 'rclone-test-laxemul4poci/CompareDest': Using cached web token 2026/05/24 02:18:25 DEBUG : one: Need to transfer - File not found at Destination 2026/05/24 02:18:29 DEBUG : one: size = 3 OK 2026/05/24 02:18:29 INFO : one: Copied (new) 2026/05/24 02:18:30 DEBUG : one: size = 5 (Local file system at /tmp/rclone1210978202) 2026/05/24 02:18:30 DEBUG : one: size = 3 (Linkbox root 'rclone-test-laxemul4poci/dst') 2026/05/24 02:18:30 DEBUG : one: Sizes differ 2026/05/24 02:18:30 DEBUG : one: Update: removing old file 2026/05/24 02:18:33 DEBUG : one: size = 5 OK 2026/05/24 02:18:33 INFO : one: Copied (replaced existing) 2026/05/24 02:18:34 DEBUG : dst/one: Update: removing old file 2026/05/24 02:18:41 DEBUG : one: size = 5 (Local file system at /tmp/rclone1210978202) 2026/05/24 02:18:41 DEBUG : one: size = 3 (Linkbox root 'rclone-test-laxemul4poci/dst') 2026/05/24 02:18:41 DEBUG : one: Sizes differ 2026/05/24 02:18:41 DEBUG : one: size = 5 OK 2026/05/24 02:18:41 DEBUG : one: Sizes identical 2026/05/24 02:18:41 DEBUG : one: Destination found in --compare-dest, skipping 2026/05/24 02:18:44 DEBUG : two: Need to transfer - File not found at Destination 2026/05/24 02:18:45 DEBUG : two: size = 3 OK 2026/05/24 02:18:45 DEBUG : two: Sizes identical 2026/05/24 02:18:45 DEBUG : two: Destination found in --compare-dest, skipping 2026/05/24 02:18:45 DEBUG : two: Need to transfer - File not found at Destination 2026/05/24 02:18:46 DEBUG : two: size = 3 OK 2026/05/24 02:18:46 DEBUG : two: Sizes identical 2026/05/24 02:18:46 DEBUG : two: Destination found in --compare-dest, skipping 2026/05/24 02:18:47 DEBUG : two: Need to transfer - File not found at Destination 2026/05/24 02:18:47 DEBUG : two: size = 5 (Local file system at /tmp/rclone1210978202) 2026/05/24 02:18:47 DEBUG : two: size = 3 (Linkbox root 'rclone-test-laxemul4poci/CompareDest') 2026/05/24 02:18:47 DEBUG : two: Sizes differ 2026/05/24 02:18:49 DEBUG : two: size = 5 OK 2026/05/24 02:18:49 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (35.85s) === RUN TestListDirSortedFn run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" run.go:303: Failed to put "sub dir/ignore dir/.ignore" to "Linkbox root 'rclone-test-laxemul4poci'": Update second step failed: Linkbox error 500: The file name needs to include a suffix, such as xxx.mp4 --- FAIL: TestListDirSortedFn (20.70s) === RUN TestMaxDelete run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:19:25 DEBUG : Waiting for deletions to finish 2026/05/24 02:19:26 ERROR : small: Got fatal error on delete: --max-delete threshold reached 2026/05/24 02:19:27 INFO : medium: Deleted 2026/05/24 02:19:27 INFO : large: Deleted --- PASS: TestMaxDelete (10.21s) === RUN TestMaxDeleteSize run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:19:36 DEBUG : Waiting for deletions to finish 2026/05/24 02:19:36 ERROR : small: Got fatal error on delete: --max-delete-size threshold reached 2026/05/24 02:19:37 INFO : large: Deleted 2026/05/24 02:19:38 INFO : medium: Deleted operations_test.go:492: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:492 Error: Not equal: expected: 1 actual : 3 Test: TestMaxDeleteSize run.go:172: removing file "large" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "large" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "large" failed: could not Remove: Linkbox error 403: not permit run.go:172: removing file "medium" failed - try 1/3: sleeping 1s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "medium" failed - try 2/3: sleeping 1.5s: could not Remove: Linkbox error 403: not permit run.go:172: removing file "medium" failed: could not Remove: Linkbox error 403: not permit 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: TestMaxDeleteSize (23.82s) === RUN TestRmdirsNoLeaveRoot run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:20:00 INFO : A2: Making directory 2026/05/24 02:20:02 INFO : A1/B2: Making directory 2026/05/24 02:20:04 INFO : A1/B2/C2: Making directory 2026/05/24 02:20:05 INFO : A1/B1/C3: Making directory 2026/05/24 02:20:07 INFO : A3: Making directory 2026/05/24 02:20:08 INFO : A3/B3: Making directory 2026/05/24 02:20:10 INFO : A3/B3/C4: Making directory 2026/05/24 02:20:13 DEBUG : A1/two: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:20:14 DEBUG : A1/two: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:20:14 DEBUG : A1/two: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:20:15 DEBUG : A1/two: Trying to read object after upload: try again in 800ms (4/10) 2026/05/24 02:20:18 DEBUG : removing 1 level 3 directories 2026/05/24 02:20:18 INFO : A3/B3/C4: Removing directory 2026/05/24 02:20:24 DEBUG : removing 2 level 3 directories 2026/05/24 02:20:24 INFO : A1/B2/C2: Removing directory 2026/05/24 02:20:24 INFO : A1/B1/C3: Removing directory 2026/05/24 02:20:26 DEBUG : removing 2 level 2 directories 2026/05/24 02:20:26 INFO : A3/B3: Removing directory 2026/05/24 02:20:26 INFO : A1/B2: Removing directory 2026/05/24 02:20:27 DEBUG : removing 2 level 1 directories 2026/05/24 02:20:27 INFO : A3: Removing directory 2026/05/24 02:20:27 INFO : A2: Removing directory 2026/05/24 02:20:28 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 run.go:186: removing dir "A2" failed - try 1/3: sleeping 1s: directory not found run.go:186: removing dir "A2" failed - try 2/3: sleeping 1.5s: directory not found run.go:186: removing dir "A2" failed: directory not found 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: TestRmdirsNoLeaveRoot (56.99s) === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:20:54 DEBUG : A1/one: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:20:54 DEBUG : A1/one: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:20:55 DEBUG : A1/one: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:20:55 DEBUG : A1/one: Trying to read object after upload: try again in 800ms (4/10) 2026/05/24 02:20:58 DEBUG : A1/two: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:20:58 DEBUG : A1/two: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:20:59 DEBUG : A1/two: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:21:03 DEBUG : A1/B1/three: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:21:07 DEBUG : A1/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:21:07 DEBUG : A1/B1/C1/four: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:21:07 DEBUG : A1/B1/C1/four: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:21:08 DEBUG : A1/B1/C1/four: Trying to read object after upload: try again in 800ms (4/10) 2026/05/24 02:21:09 DEBUG : A1/B1/C1/four: Trying to read object after upload: try again in 1.6s (5/10) 2026/05/24 02:21:14 DEBUG : A1/B1/C2/five: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:21:15 DEBUG : A1/B1/C2/five: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:21:15 DEBUG : A1/B1/C2/five: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:21:16 INFO : A1/B2: Making directory 2026/05/24 02:21:17 INFO : A1/B1/C3: Making directory 2026/05/24 02:21:36 DEBUG : A2/one: size = 3 OK 2026/05/24 02:21:36 INFO : A1/one: Copied (new) to: A2/one 2026/05/24 02:21:36 DEBUG : A2/two: size = 3 OK 2026/05/24 02:21:36 INFO : A1/two: Copied (new) to: A2/two 2026/05/24 02:21:37 DEBUG : A2/B1/three: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:21:37 DEBUG : A2/B1/C2/five: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:21:37 DEBUG : A2/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:21:37 DEBUG : A2/B1/three: size = 5 OK 2026/05/24 02:21:37 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/05/24 02:21:38 INFO : A1/one: Deleted 2026/05/24 02:21:38 DEBUG : A2/B1/C2/five: size = 4 OK 2026/05/24 02:21:38 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/05/24 02:21:38 DEBUG : A2/B1/C1/four: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:21:38 INFO : A1/two: Deleted 2026/05/24 02:21:38 DEBUG : A2/B1/C1/four: size = 4 OK 2026/05/24 02:21:38 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/05/24 02:21:39 INFO : A1/B1/three: Deleted 2026/05/24 02:21:39 INFO : A1/B1/C2/five: Deleted 2026/05/24 02:21:40 INFO : A1/B1/C1/four: Deleted 2026/05/24 02:22:06 DEBUG : A3/B1/C2/five: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:22:06 DEBUG : A3/one: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:22:06 DEBUG : A3/B1/C2/five: size = 4 OK 2026/05/24 02:22:06 INFO : A2/B1/C2/five: Copied (new) to: A3/B1/C2/five 2026/05/24 02:22:07 DEBUG : A3/two: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:22:07 DEBUG : A3/one: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:22:07 DEBUG : A3/B1/three: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:22:07 DEBUG : A3/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:22:08 DEBUG : A3/two: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:22:08 DEBUG : A3/one: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:22:08 DEBUG : A3/B1/three: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:22:08 DEBUG : A3/B1/C1/four: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:22:08 INFO : A2/B1/C2/five: Deleted 2026/05/24 02:22:08 DEBUG : A3/two: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:22:09 DEBUG : A3/one: size = 3 OK 2026/05/24 02:22:09 INFO : A2/one: Copied (new) to: A3/one 2026/05/24 02:22:09 DEBUG : A3/B1/three: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:22:09 DEBUG : A3/B1/C1/four: size = 4 OK 2026/05/24 02:22:09 INFO : A2/B1/C1/four: Copied (new) to: A3/B1/C1/four 2026/05/24 02:22:09 DEBUG : A3/two: size = 3 OK 2026/05/24 02:22:09 INFO : A2/two: Copied (new) to: A3/two 2026/05/24 02:22:10 DEBUG : A3/B1/three: size = 5 OK 2026/05/24 02:22:10 INFO : A2/B1/three: Copied (new) to: A3/B1/three 2026/05/24 02:22:10 INFO : A2/one: Deleted 2026/05/24 02:22:11 INFO : A2/B1/C1/four: Deleted 2026/05/24 02:22:11 INFO : A2/two: Deleted 2026/05/24 02:22:11 INFO : A2/B1/three: Deleted operations_test.go:1436: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1436 Error: Received unexpected error: RenameDir rmdir: directory not empty Test: TestDirMove 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: TestDirMove (114.91s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:22:46 DEBUG : Linkbox root 'rclone-test-laxemul4poci': File to upload is small (34 bytes), uploading instead of streaming 2026/05/24 02:22:48 DEBUG : ignore_checksum_small_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:22:48 DEBUG : ignore_checksum_small_file_from_pipe: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:22:48 DEBUG : ignore_checksum_small_file_from_pipe: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:22:49 DEBUG : ignore_checksum_small_file_from_pipe: Trying to read object after upload: try again in 800ms (4/10) 2026/05/24 02:22:50 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2026/05/24 02:22:50 DEBUG : ignore_checksum_small_file_from_pipe: Sizes identical 2026/05/24 02:22:50 DEBUG : Linkbox root 'rclone-test-laxemul4poci': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/05/24 02:22:52 DEBUG : ignore_checksum_big_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:22:52 DEBUG : ignore_checksum_big_file_from_pipe: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:22:53 DEBUG : ignore_checksum_big_file_from_pipe: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:22:53 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2026/05/24 02:22:53 DEBUG : ignore_checksum_big_file_from_pipe: Sizes 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=true run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:23:04 DEBUG : Linkbox root 'rclone-test-laxemul4poci': File to upload is small (34 bytes), uploading instead of streaming 2026/05/24 02:23:06 DEBUG : ignore_checksum_small_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:23:06 DEBUG : ignore_checksum_small_file_from_pipe: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:23:07 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2026/05/24 02:23:07 NOTICE: Linkbox root 'rclone-test-laxemul4poci': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2026/05/24 02:23:07 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/05/24 02:23:07 DEBUG : Linkbox root 'rclone-test-laxemul4poci': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2026/05/24 02:23:09 DEBUG : ignore_checksum_big_file_from_pipe: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:23:09 DEBUG : ignore_checksum_big_file_from_pipe: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:23:09 DEBUG : ignore_checksum_big_file_from_pipe: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:23:10 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2026/05/24 02:23:10 DEBUG : ignore_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 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: TestRcat (42.72s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (18.44s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (24.28s) === RUN TestRcatSizeUploadHeaders run.go:198: Remote "Linkbox root 'rclone-test-laxemul4poci'", Local "Local file system at /tmp/rclone1210978202", Modify Window "876000h0m0s" 2026/05/24 02:23:30 DEBUG : potato1: Trying to read object after upload: try again in 100ms (1/10) 2026/05/24 02:23:30 DEBUG : potato1: Trying to read object after upload: try again in 200ms (2/10) 2026/05/24 02:23:31 DEBUG : potato1: Trying to read object after upload: try again in 400ms (3/10) 2026/05/24 02:23:31 DEBUG : potato1: Trying to read object after upload: try again in 800ms (4/10) 2026/05/24 02:23:32 DEBUG : potato1: Trying to read object after upload: try again in 1.6s (5/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: TestRcatSizeUploadHeaders (15.18s) FAIL 2026/05/24 02:23:43 DEBUG : Linkbox root 'rclone-test-laxemul4poci': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCheckSumDownload|TestCopyFileCompareDest|TestDirMove|TestListDirSortedFn|TestMaxDelete|TestMaxDeleteSize|TestRcatSizeUploadHeaders|TestRmdirsNoLeaveRoot)$|^TestRcat$/^(withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=true)$'" - Finished ERROR in 8m12.801299168s (try 4/5): exit status 1: Failed [TestCheckSumDownload TestListDirSortedFn TestMaxDeleteSize TestRmdirsNoLeaveRoot TestDirMove]