"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose" - Starting (try 1/5) 2025/04/28 02:42:07 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-dikogeh2yiwe" 2025/04/28 02:42:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/28 02:42:08 DEBUG : Creating backend with remote "/tmp/rclone67733318" === RUN TestDoMultiThreadCopy --- PASS: TestDoMultiThreadCopy (0.00s) === RUN TestMultithreadCalculateNumChunks === RUN TestMultithreadCalculateNumChunks/{size:1_chunkSize:65536_wantNumChunks:1} === RUN TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:1_wantNumChunks:1048576} === RUN TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:2_wantNumChunks:524288} === RUN TestMultithreadCalculateNumChunks/{size:1048577_chunkSize:2_wantNumChunks:524289} === RUN TestMultithreadCalculateNumChunks/{size:1048575_chunkSize:2_wantNumChunks:524288} --- PASS: TestMultithreadCalculateNumChunks (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1_chunkSize:65536_wantNumChunks:1} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:1_wantNumChunks:1048576} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:2_wantNumChunks:524288} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048577_chunkSize:2_wantNumChunks:524289} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048575_chunkSize:2_wantNumChunks:524288} (0.00s) === RUN TestMultithreadCopy run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" multithread_test.go:121: multithread writing not supported 2025/04/28 02:42:09 ERROR : : error listing: directory not found --- SKIP: TestMultithreadCopy (0.20s) === RUN TestMultithreadCopyAbort run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" multithread_test.go:121: multithread writing not supported 2025/04/28 02:42:09 ERROR : : error listing: directory not found --- SKIP: TestMultithreadCopyAbort (0.20s) === RUN TestSizeDiffers --- PASS: TestSizeDiffers (0.00s) === RUN TestReOpen === RUN TestReOpen/Normal === RUN TestReOpen/Normal/Basics 2025/04/28 02:42:09 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/ErrorAtStart === RUN TestReOpen/Normal/WithErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/Normal/TooManyErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Normal/Seek 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Seek from 5 to 2 === RUN TestReOpen/Normal/AccountRead === RUN TestReOpen/Normal/AccountReadDelay 2025/04/28 02:42:09 DEBUG : potato: Seek from 10 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 10 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/AccountReadError === RUN TestReOpen/WithRangeOption === RUN TestReOpen/WithRangeOption/Basics 2025/04/28 02:42:09 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/ErrorAtStart === RUN TestReOpen/WithRangeOption/WithErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithRangeOption/TooManyErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithRangeOption/Seek 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Seek from 5 to 2 2025/04/28 02:42:09 DEBUG : potato: Seek from 7 to 4 === RUN TestReOpen/WithRangeOption/AccountRead === RUN TestReOpen/WithRangeOption/AccountReadDelay 2025/04/28 02:42:09 DEBUG : potato: Seek from 7 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 7 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/AccountReadError === RUN TestReOpen/WithSeekOption === RUN TestReOpen/WithSeekOption/Basics 2025/04/28 02:42:09 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/ErrorAtStart === RUN TestReOpen/WithSeekOption/WithErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithSeekOption/TooManyErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithSeekOption/Seek 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Seek from 5 to 2 2025/04/28 02:42:09 DEBUG : potato: Seek from 7 to 5 === RUN TestReOpen/WithSeekOption/AccountRead === RUN TestReOpen/WithSeekOption/AccountReadDelay 2025/04/28 02:42:09 DEBUG : potato: Seek from 8 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 8 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/AccountReadError === RUN TestReOpen/UnknownSize === RUN TestReOpen/UnknownSize/Basics 2025/04/28 02:42:09 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/ErrorAtStart === RUN TestReOpen/UnknownSize/WithErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/UnknownSize/TooManyErrors 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/04/28 02:42:09 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/UnknownSize/Seek 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/04/28 02:42:09 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/04/28 02:42:09 DEBUG : potato: Seek from 5 to 2 2025/04/28 02:42:09 DEBUG : potato: Seek from 7 to 6 === RUN TestReOpen/UnknownSize/AccountRead === RUN TestReOpen/UnknownSize/AccountReadDelay 2025/04/28 02:42:09 DEBUG : potato: Seek from 9 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 9 to 0 2025/04/28 02:42:09 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/AccountReadError --- PASS: TestReOpen (0.00s) --- PASS: TestReOpen/Normal (0.00s) --- PASS: TestReOpen/Normal/Basics (0.00s) --- PASS: TestReOpen/Normal/ErrorAtStart (0.00s) --- PASS: TestReOpen/Normal/WithErrors (0.00s) --- PASS: TestReOpen/Normal/TooManyErrors (0.00s) --- PASS: TestReOpen/Normal/Seek (0.00s) --- PASS: TestReOpen/Normal/AccountRead (0.00s) --- PASS: TestReOpen/Normal/AccountReadDelay (0.00s) --- PASS: TestReOpen/Normal/AccountReadError (0.00s) --- PASS: TestReOpen/WithRangeOption (0.00s) --- PASS: TestReOpen/WithRangeOption/Basics (0.00s) --- PASS: TestReOpen/WithRangeOption/ErrorAtStart (0.00s) --- PASS: TestReOpen/WithRangeOption/WithErrors (0.00s) --- PASS: TestReOpen/WithRangeOption/TooManyErrors (0.00s) --- PASS: TestReOpen/WithRangeOption/Seek (0.00s) --- PASS: TestReOpen/WithRangeOption/AccountRead (0.00s) --- PASS: TestReOpen/WithRangeOption/AccountReadDelay (0.00s) --- PASS: TestReOpen/WithRangeOption/AccountReadError (0.00s) --- PASS: TestReOpen/WithSeekOption (0.00s) --- PASS: TestReOpen/WithSeekOption/Basics (0.00s) --- PASS: TestReOpen/WithSeekOption/ErrorAtStart (0.00s) --- PASS: TestReOpen/WithSeekOption/WithErrors (0.00s) --- PASS: TestReOpen/WithSeekOption/TooManyErrors (0.00s) --- PASS: TestReOpen/WithSeekOption/Seek (0.00s) --- PASS: TestReOpen/WithSeekOption/AccountRead (0.00s) --- PASS: TestReOpen/WithSeekOption/AccountReadDelay (0.00s) --- PASS: TestReOpen/WithSeekOption/AccountReadError (0.00s) --- PASS: TestReOpen/UnknownSize (0.00s) --- PASS: TestReOpen/UnknownSize/Basics (0.00s) --- PASS: TestReOpen/UnknownSize/ErrorAtStart (0.00s) --- PASS: TestReOpen/UnknownSize/WithErrors (0.00s) --- PASS: TestReOpen/UnknownSize/TooManyErrors (0.00s) --- PASS: TestReOpen/UnknownSize/Seek (0.00s) --- PASS: TestReOpen/UnknownSize/AccountRead (0.00s) --- PASS: TestReOpen/UnknownSize/AccountReadDelay (0.00s) --- PASS: TestReOpen/UnknownSize/AccountReadError (0.00s) === RUN TestCheck run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:42:13 DEBUG : rutabaga: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:42:13 DEBUG : rutabaga: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:42:13 DEBUG : rutabaga: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:42:14 DEBUG : rutabaga: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:42:15 DEBUG : rutabaga: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:42:16 DEBUG : rutabaga: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:42:19 DEBUG : rutabaga: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:42:26 DEBUG : rutabaga: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:42:39 DEBUG : rutabaga: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:43:04 DEBUG : rutabaga: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "rutabaga" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 02:43:58 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCheck (115.67s) === RUN TestCheckFsError 2025/04/28 02:44:04 DEBUG : Creating backend with remote "nonexistent" 2025/04/28 02:44:04 DEBUG : Creating backend with remote "nonexistent" 2025/04/28 02:44:04 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: Waiting for checks to finish 2025/04/28 02:44:04 ERROR : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: error reading source root directory: directory not found 2025/04/28 02:44:04 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 4 differences found 2025/04/28 02:44:04 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 4 errors while checking --- PASS: TestCheckFsError (0.00s) === RUN TestCheckDownload run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:44:05 DEBUG : rutabaga: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:44:06 DEBUG : rutabaga: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:44:06 DEBUG : rutabaga: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:44:06 DEBUG : rutabaga: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:44:07 DEBUG : rutabaga: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:44:09 DEBUG : rutabaga: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:44:12 DEBUG : rutabaga: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:44:18 DEBUG : rutabaga: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:44:31 DEBUG : rutabaga: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:44:57 DEBUG : rutabaga: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "rutabaga" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 02:45:50 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCheckDownload (111.10s) === RUN TestCheckSizeOnly run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:45:57 DEBUG : rutabaga: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:45:57 DEBUG : rutabaga: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:45:57 DEBUG : rutabaga: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:45:57 DEBUG : rutabaga: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:45:58 DEBUG : rutabaga: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:46:00 DEBUG : rutabaga: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:46:03 DEBUG : rutabaga: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:46:10 DEBUG : rutabaga: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:46:22 DEBUG : rutabaga: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:46:48 DEBUG : rutabaga: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "rutabaga" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 02:47:41 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCheckSizeOnly (111.07s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestParseSumFile run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:47:49 DEBUG : test.sum: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:47:50 DEBUG : test.sum: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:47:50 DEBUG : test.sum: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:47:50 DEBUG : test.sum: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:47:51 DEBUG : test.sum: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:47:53 DEBUG : test.sum: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:47:56 DEBUG : test.sum: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:48:02 DEBUG : test.sum: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:48:15 DEBUG : test.sum: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:48:41 DEBUG : test.sum: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "test.sum" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 02:49:33 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestParseSumFile (112.82s) === RUN TestCheckSum run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:49:39 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-dikogeh2yiwe/data" 2025/04/28 02:49:39 DEBUG : Config file has changed externally - reloading check_test.go:353: Linkbox root 'rclone-test-dikogeh2yiwe/data' lacks md5, skipping 2025/04/28 02:49:40 ERROR : : error listing: directory not found --- SKIP: TestCheckSum (0.44s) === RUN TestCheckSumDownload run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:49:40 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-dikogeh2yiwe/data" 2025/04/28 02:49:45 DEBUG : data/banana: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:49:45 DEBUG : data/banana: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:49:45 DEBUG : data/banana: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:49:46 DEBUG : data/banana: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:49:46 DEBUG : data/banana: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:49:48 DEBUG : data/banana: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:49:51 DEBUG : data/banana: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:49:58 DEBUG : data/banana: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:50:11 DEBUG : data/banana: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:50:36 DEBUG : data/banana: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "data/banana" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 02:51:29 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCheckSumDownload (114.97s) === RUN TestApplyTransforms 2025/04/28 02:51:35 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-wehefot5zoge" 2025/04/28 02:51:35 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/28 02:51:35 DEBUG : Creating backend with remote "/tmp/rclone3460722695" run.go:180: Remote "Linkbox root 'rclone-test-wehefot5zoge'", Local "Local file system at /tmp/rclone3460722695", Modify Window "876000h0m0s" 2025/04/28 02:51:39 DEBUG : hello, world!: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:51:39 DEBUG : hello, world!: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:51:39 DEBUG : hello, world!: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:51:40 DEBUG : hello, world!: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:51:41 DEBUG : hello, world!: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:51:42 DEBUG : hello, world!: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:51:45 DEBUG : hello, world!: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:51:52 DEBUG : hello, world!: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:52:05 DEBUG : hello, world!: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:52:30 DEBUG : hello, world!: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "hello, world!" to "Linkbox root 'rclone-test-wehefot5zoge'": object not found 2025/04/28 02:53:21 DEBUG : Linkbox root 'rclone-test-wehefot5zoge': Purge remote --- FAIL: TestApplyTransforms (107.96s) === RUN TestTruncateString --- PASS: TestTruncateString (0.00s) === RUN TestCopyFile run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:53:23 DEBUG : file1: Need to transfer - File not found at Destination 2025/04/28 02:53:27 DEBUG : sub/file2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:53:27 DEBUG : sub/file2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:53:28 DEBUG : sub/file2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:53:28 DEBUG : sub/file2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:53:29 DEBUG : sub/file2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:53:31 DEBUG : sub/file2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:53:34 DEBUG : sub/file2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:53:40 DEBUG : sub/file2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:53:53 DEBUG : sub/file2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:54:19 DEBUG : sub/file2: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 02:55:10 ERROR : file1: Failed to copy: object not found copy_test.go:113: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:113 Error: Received unexpected error: object not found Test: TestCopyFile fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 02:55:11 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCopyFile (114.47s) === RUN TestCopyLongFile run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" copy_test.go:153: Test only runs on local 2025/04/28 02:55:17 ERROR : : error listing: directory not found --- SKIP: TestCopyLongFile (0.02s) === RUN TestCopyFileBackupDir run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" copy_test.go:173: Skipping test as remote does not support server-side move or copy 2025/04/28 02:55:17 ERROR : : error listing: directory not found --- SKIP: TestCopyFileBackupDir (0.20s) === RUN TestCopyFileCompareDest run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:55:17 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-dikogeh2yiwe/dst" 2025/04/28 02:55:18 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-dikogeh2yiwe/CompareDest" 2025/04/28 02:55:18 DEBUG : one: Need to transfer - File not found at Destination 2025/04/28 02:55:22 DEBUG : one: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:55:22 DEBUG : one: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:55:23 DEBUG : one: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:55:23 DEBUG : one: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:55:24 DEBUG : one: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:55:25 DEBUG : one: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:55:29 DEBUG : one: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:55:35 DEBUG : one: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:55:48 DEBUG : one: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:56:14 DEBUG : one: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 02:57:05 ERROR : one: Failed to copy: object not found copy_test.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:206 Error: Received unexpected error: object not found Test: TestCopyFileCompareDest 2025/04/28 02:57:05 ERROR : : error listing: directory not found --- FAIL: TestCopyFileCompareDest (107.38s) === RUN TestCopyFileCopyDest run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" copy_test.go:276: Skipping test as remote does not support server-side copy 2025/04/28 02:57:05 ERROR : : error listing: directory not found --- SKIP: TestCopyFileCopyDest (0.09s) === RUN TestCopyInplace run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" copy_test.go:370: Partial uploads not supported 2025/04/28 02:57:05 ERROR : : error listing: directory not found --- SKIP: TestCopyInplace (0.20s) === RUN TestCopyLongFileName run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" copy_test.go:403: Partial uploads not supported 2025/04/28 02:57:05 ERROR : : error listing: directory not found --- SKIP: TestCopyLongFileName (0.20s) === RUN TestCopyFileMaxTransfer run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:57:06 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2025/04/28 02:57:10 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:57:10 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:57:10 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:57:11 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:57:11 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:57:13 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:57:16 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:57:23 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:57:35 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:58:01 DEBUG : TestCopyFileMaxTransfer/file1: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 02:58:52 ERROR : TestCopyFileMaxTransfer/file1: Failed to copy: object not found copy_test.go:464: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:464 Error: Received unexpected error: object not found Test: TestCopyFileMaxTransfer fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 02:58:54 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCopyFileMaxTransfer (114.39s) === RUN TestDeduplicateInteractive run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:00 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateInteractive (0.02s) === RUN TestDeduplicateSkip run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:00 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateSkip (0.20s) === RUN TestDeduplicateSizeOnly run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:00 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateSizeOnly (0.20s) === RUN TestDeduplicateFirst run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:00 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateFirst (0.20s) === RUN TestDeduplicateNewest run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:01 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateNewest (0.20s) === RUN TestDeduplicateNewestByHash run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:36: Can't run this test without a hash 2025/04/28 02:59:01 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateNewestByHash (0.20s) === RUN TestDeduplicateOldest run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:01 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateOldest (0.21s) === RUN TestDeduplicateLargest run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:01 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateLargest (0.19s) === RUN TestDeduplicateSmallest run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:01 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateSmallest (0.20s) === RUN TestDeduplicateRename run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible 2025/04/28 02:59:02 ERROR : : error listing: directory not found --- SKIP: TestDeduplicateRename (0.20s) === RUN TestMergeDirs run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" dedupe_test.go:256: Can't merge directories 2025/04/28 02:59:02 ERROR : : error listing: directory not found --- SKIP: TestMergeDirs (0.20s) === RUN TestListDirSorted run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 02:59:05 DEBUG : a.txt: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 02:59:05 DEBUG : a.txt: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 02:59:05 DEBUG : a.txt: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 02:59:05 DEBUG : a.txt: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 02:59:06 DEBUG : a.txt: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 02:59:08 DEBUG : a.txt: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 02:59:11 DEBUG : a.txt: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 02:59:17 DEBUG : a.txt: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 02:59:30 DEBUG : a.txt: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 02:59:56 DEBUG : a.txt: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "a.txt" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:00:49 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestListDirSorted (112.80s) === RUN TestListDirSortedFn run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:00:56 DEBUG : a.txt: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:00:56 DEBUG : a.txt: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:00:56 DEBUG : a.txt: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:00:56 DEBUG : a.txt: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:00:57 DEBUG : a.txt: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:00:59 DEBUG : a.txt: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:01:02 DEBUG : a.txt: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:01:09 DEBUG : a.txt: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:01:21 DEBUG : a.txt: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:01:47 DEBUG : a.txt: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "a.txt" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:02:40 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestListDirSortedFn (111.07s) === RUN TestListJSON run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:02:49 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:02:49 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:02:49 DEBUG : file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:02:50 DEBUG : file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:02:50 DEBUG : file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:02:52 DEBUG : file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:02:55 DEBUG : file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:03:02 DEBUG : file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:03:15 DEBUG : file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:03:40 DEBUG : file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "file1" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:04:33 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestListJSON (113.16s) === RUN TestStatJSON run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:04:40 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:04:40 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:04:40 DEBUG : file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:04:41 DEBUG : file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:04:42 DEBUG : file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:04:43 DEBUG : file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:04:46 DEBUG : file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:04:53 DEBUG : file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:05:06 DEBUG : file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:05:31 DEBUG : file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "file1" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:06:24 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestStatJSON (111.07s) === RUN TestMkdir run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:06:30 INFO : Linkbox root 'rclone-test-dikogeh2yiwe': Making directory fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:06:31 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure 2025/04/28 03:06:37 INFO : Linkbox root 'rclone-test-dikogeh2yiwe': Making directory fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:06:39 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- PASS: TestMkdir (15.30s) === RUN TestLsd run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:06:50 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:06:50 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:06:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:06:51 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:06:52 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:06:54 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:06:57 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:07:03 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:07:16 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:07:42 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "sub dir/hello world" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:08:34 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestLsd (115.09s) === RUN TestLs run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:08:43 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:08:44 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:08:44 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:08:44 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:08:45 DEBUG : potato2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:08:47 DEBUG : potato2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:08:50 DEBUG : potato2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:08:56 DEBUG : potato2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:09:09 DEBUG : potato2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:09:35 DEBUG : potato2: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "potato2" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:10:27 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestLs (113.15s) === RUN TestLsWithFilesFrom run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:10:34 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:10:35 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:10:35 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:10:35 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:10:36 DEBUG : potato2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:10:38 DEBUG : potato2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:10:41 DEBUG : potato2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:10:47 DEBUG : potato2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:11:00 DEBUG : potato2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:11:26 DEBUG : potato2: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "potato2" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:12:18 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestLsWithFilesFrom (111.07s) === RUN TestLsLong run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:12:26 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:12:26 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:12:26 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:12:26 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:12:27 DEBUG : potato2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:12:29 DEBUG : potato2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:12:32 DEBUG : potato2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:12:38 DEBUG : potato2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:12:51 DEBUG : potato2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:13:17 DEBUG : potato2: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "potato2" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:14:10 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestLsLong (111.08s) === RUN TestHashSums run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:14:17 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:14:17 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:14:17 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:14:17 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:14:18 DEBUG : potato2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:14:20 DEBUG : potato2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:14:23 DEBUG : potato2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:14:30 DEBUG : potato2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:14:42 DEBUG : potato2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:15:08 DEBUG : potato2: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "potato2" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:16:01 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestHashSums (111.07s) === RUN TestHashSumsWithErrors 2025/04/28 03:16:07 DEBUG : Creating backend with remote ":memory:" 2025/04/28 03:16:07 DEBUG : Config file has changed externally - reloading 2025/04/28 03:16:07 ERROR : file1: hash unsupported: hash type not supported --- PASS: TestHashSumsWithErrors (0.00s) === RUN TestHashStream 2025/04/28 03:16:07 DEBUG : Creating md5 hash of 0 bytes read from input stream 2025/04/28 03:16:07 DEBUG : Creating md5 hash of 0 bytes read from input stream 2025/04/28 03:16:07 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2025/04/28 03:16:07 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2025/04/28 03:16:07 DEBUG : Creating md5 hash of 12 bytes read from input stream 2025/04/28 03:16:07 DEBUG : Creating md5 hash of 12 bytes read from input stream 2025/04/28 03:16:07 DEBUG : Creating sha1 hash of 12 bytes read from input stream 2025/04/28 03:16:07 DEBUG : Creating sha1 hash of 12 bytes read from input stream --- PASS: TestHashStream (0.00s) === RUN TestSuffixName --- PASS: TestSuffixName (0.00s) === RUN TestCount run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:16:08 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:16:08 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:16:08 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:16:09 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:16:09 DEBUG : potato2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:16:11 DEBUG : potato2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:16:14 DEBUG : potato2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:16:21 DEBUG : potato2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:16:33 DEBUG : potato2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:16:59 DEBUG : potato2: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "potato2" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:17:52 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCount (111.08s) === RUN TestDelete run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:18:01 DEBUG : small: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:18:01 DEBUG : small: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:18:01 DEBUG : small: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:18:02 DEBUG : small: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:18:02 DEBUG : small: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:18:04 DEBUG : small: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:18:07 DEBUG : small: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:18:14 DEBUG : small: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:18:27 DEBUG : small: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:18:52 DEBUG : small: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "small" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:19:45 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDelete (113.10s) === RUN TestMaxDelete run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:19:52 DEBUG : small: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:19:52 DEBUG : small: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:19:52 DEBUG : small: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:19:53 DEBUG : small: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:19:54 DEBUG : small: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:19:55 DEBUG : small: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:19:58 DEBUG : small: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:20:05 DEBUG : small: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:20:18 DEBUG : small: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:20:43 DEBUG : small: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "small" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:21:36 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure 2025/04/28 03:21:42 ERROR : : error listing: directory not found --- FAIL: TestMaxDelete (111.09s) === RUN TestMaxDeleteSizeLargeFile run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:21:43 DEBUG : small: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:21:43 DEBUG : small: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:21:44 DEBUG : small: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:21:44 DEBUG : small: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:21:45 DEBUG : small: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:21:46 DEBUG : small: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:21:50 DEBUG : small: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:21:56 DEBUG : small: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:22:09 DEBUG : small: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:22:35 DEBUG : small: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "small" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:23:27 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure 2025/04/28 03:23:33 ERROR : : error listing: directory not found --- FAIL: TestMaxDeleteSizeLargeFile (111.29s) === RUN TestMaxDeleteSize run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:23:34 DEBUG : small: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:23:35 DEBUG : small: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:23:35 DEBUG : small: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:23:35 DEBUG : small: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:23:36 DEBUG : small: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:23:38 DEBUG : small: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:23:41 DEBUG : small: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:23:47 DEBUG : small: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:24:00 DEBUG : small: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:24:26 DEBUG : small: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "small" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:25:18 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure 2025/04/28 03:25:24 ERROR : : error listing: directory not found --- FAIL: TestMaxDeleteSize (111.27s) === RUN TestReadFile run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:25:27 DEBUG : ReadFile: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:25:28 DEBUG : ReadFile: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:25:28 DEBUG : ReadFile: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:25:28 DEBUG : ReadFile: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:25:29 DEBUG : ReadFile: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:25:31 DEBUG : ReadFile: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:25:34 DEBUG : ReadFile: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:25:40 DEBUG : ReadFile: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:25:53 DEBUG : ReadFile: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:26:19 DEBUG : ReadFile: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "ReadFile" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:27:11 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure 2025/04/28 03:27:17 ERROR : : error listing: directory not found --- FAIL: TestReadFile (112.99s) === RUN TestRetry 2025/04/28 03:27:17 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5 2025/04/28 03:27:17 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5 2025/04/28 03:27:17 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/04/28 03:27:17 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/04/28 03:27:17 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/04/28 03:27:17 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/04/28 03:27:17 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG --- PASS: TestRetry (0.05s) === RUN TestCat run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:27:20 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:27:20 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:27:21 DEBUG : file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:27:21 DEBUG : file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:27:22 DEBUG : file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:27:24 DEBUG : file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:27:27 DEBUG : file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:27:33 DEBUG : file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:27:46 DEBUG : file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:28:12 DEBUG : file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "file1" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:29:04 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCat (112.79s) === RUN TestPurge 2025/04/28 03:29:10 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-vikakuf0yesa" 2025/04/28 03:29:10 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/28 03:29:11 DEBUG : Creating backend with remote "/tmp/rclone2950168471" run.go:180: Remote "Linkbox root 'rclone-test-vikakuf0yesa'", Local "Local file system at /tmp/rclone2950168471", Modify Window "876000h0m0s" 2025/04/28 03:29:21 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:29:21 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:29:22 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:29:22 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:29:23 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:29:24 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:29:28 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:29:34 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:29:47 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:30:12 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "A1/B1/C1/one" to "Linkbox root 'rclone-test-vikakuf0yesa'": object not found 2025/04/28 03:31:04 DEBUG : Linkbox root 'rclone-test-vikakuf0yesa': Purge remote --- FAIL: TestPurge (114.91s) === RUN TestRmdirsNoLeaveRoot run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:31:13 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:31:14 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:31:14 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:31:14 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:31:15 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:31:17 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:31:20 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:31:26 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:31:39 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:32:05 DEBUG : A1/B1/C1/one: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "A1/B1/C1/one" to "Linkbox root 'rclone-test-dikogeh2yiwe'": object not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:32:57 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestRmdirsNoLeaveRoot (118.25s) === RUN TestRmdirsLeaveRoot run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:33:04 INFO : A1: Making directory 2025/04/28 03:33:04 INFO : A1/B1: Making directory 2025/04/28 03:33:04 INFO : A1/B1/C1: Making directory fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:06 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:08 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /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{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) (len=2) "A1", - (string) (len=5) "A1/B1", - (string) (len=8) "A1/B1/C1" +([]string) { } Test: TestRmdirsLeaveRoot Messages: directories 2025/04/28 03:33:12 ERROR : Linkbox root 'rclone-test-dikogeh2yiwe': Failed to list "A1": directory not found 2025/04/28 03:33:12 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:13 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:15 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:764 Error: Not equal: expected: []string{"A1"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,3 +1,2 @@ -([]string) (len=1) { - (string) (len=2) "A1" +([]string) { } Test: TestRmdirsLeaveRoot Messages: directories 2025/04/28 03:33:19 ERROR : : error listing: directory not found --- FAIL: TestRmdirsLeaveRoot (15.98s) === RUN TestRmdirsWithFilter run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:33:20 INFO : A1: Making directory 2025/04/28 03:33:20 INFO : A1/B1: Making directory 2025/04/28 03:33:21 INFO : A1/B1/C1: Making directory fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:22 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:24 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:789 Error: Not equal: expected: []string{"A1", "A1/B1", "A1/B1/C1"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) (len=2) "A1", - (string) (len=5) "A1/B1", - (string) (len=8) "A1/B1/C1" +([]string) { } Test: TestRmdirsWithFilter Messages: directories 2025/04/28 03:33:28 ERROR : Linkbox root 'rclone-test-dikogeh2yiwe': Failed to list "": directory not found 2025/04/28 03:33:29 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:30 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:33:32 ERROR : : error listing: directory not found fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:803 Error: Not equal: expected: []string{"A1"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,3 +1,2 @@ -([]string) (len=1) { - (string) (len=2) "A1" +([]string) { } Test: TestRmdirsWithFilter Messages: directories 2025/04/28 03:33:36 ERROR : : error listing: directory not found --- FAIL: TestRmdirsWithFilter (16.15s) === RUN TestCopyURL run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:33:36 ERROR : : error listing: directory not found 2025/04/28 03:33:39 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:33:39 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:33:39 DEBUG : file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:33:39 DEBUG : file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:33:40 DEBUG : file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:33:42 DEBUG : file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:33:45 DEBUG : file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:33:51 DEBUG : file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:34:04 DEBUG : file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:34:30 DEBUG : file1: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 03:35:21 ERROR : file1: Post request put error: object not found operations_test.go:843: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:843 Error: Received unexpected error: object not found Test: TestCopyURL fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:35:23 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCopyURL (112.98s) === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:35:29 DEBUG : file1: Need to transfer - File not found at Destination 2025/04/28 03:35:30 DEBUG : sub/file2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:35:30 DEBUG : sub/file2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:35:31 DEBUG : sub/file2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:35:31 DEBUG : sub/file2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:35:32 DEBUG : sub/file2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:35:33 DEBUG : sub/file2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:35:37 DEBUG : sub/file2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:35:43 DEBUG : sub/file2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:35:56 DEBUG : sub/file2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:36:22 DEBUG : sub/file2: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 03:37:13 ERROR : file1: Failed to copy: object not found 2025/04/28 03:37:13 ERROR : file1: Not deleting source as copy failed: object not found operations_test.go:940: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:940 Error: Received unexpected error: object not found Test: TestMoveFile fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:37:14 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestMoveFile (111.72s) === RUN TestMoveFileWithIgnoreExisting run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:37:20 DEBUG : file1: Need to transfer - File not found at Destination 2025/04/28 03:37:23 DEBUG : file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:37:23 DEBUG : file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:37:23 DEBUG : file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:37:24 DEBUG : file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:37:24 DEBUG : file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:37:26 DEBUG : file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:37:29 DEBUG : file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:37:36 DEBUG : file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:37:48 DEBUG : file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:38:14 DEBUG : file1: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 03:39:05 ERROR : file1: Failed to copy: object not found 2025/04/28 03:39:05 ERROR : file1: Not deleting source as copy failed: object not found operations_test.go:968: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:968 Error: Received unexpected error: object not found Test: TestMoveFileWithIgnoreExisting fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:39:07 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestMoveFileWithIgnoreExisting (112.43s) === RUN TestCaseInsensitiveMoveFile run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:39:13 DEBUG : file1: Need to transfer - File not found at Destination 2025/04/28 03:39:14 DEBUG : sub/file2: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:39:15 DEBUG : sub/file2: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:39:15 DEBUG : sub/file2: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:39:15 DEBUG : sub/file2: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:39:16 DEBUG : sub/file2: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:39:18 DEBUG : sub/file2: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:39:21 DEBUG : sub/file2: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:39:27 DEBUG : sub/file2: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:39:40 DEBUG : sub/file2: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:40:06 DEBUG : sub/file2: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 03:40:57 ERROR : file1: Failed to copy: object not found 2025/04/28 03:40:57 ERROR : file1: Not deleting source as copy failed: object not found operations_test.go:997: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:997 Error: Received unexpected error: object not found Test: TestCaseInsensitiveMoveFile fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 03:40:58 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestCaseInsensitiveMoveFile (111.68s) === RUN TestCaseInsensitiveMoveFileDryRun run.go:180: Remote "Linkbox root 'rclone-test-dikogeh2yiwe'", Local "Local file system at /tmp/rclone67733318", Modify Window "876000h0m0s" 2025/04/28 03:41:07 DEBUG : hello: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 03:41:07 DEBUG : hello: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 03:41:07 DEBUG : hello: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 03:41:08 DEBUG : hello: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 03:41:09 DEBUG : hello: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 03:41:10 DEBUG : hello: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 03:41:13 DEBUG : hello: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 03:41:20 DEBUG : hello: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 03:41:33 DEBUG : hello: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 03:41:58 DEBUG : hello: Trying to read object after upload: try again in 51.2s (10/10) panic: test timed out after 1h0m0s running tests: TestCaseInsensitiveMoveFileDryRun (1m4s) goroutine 2842 [running]: testing.(*M).startAlarm.func1() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2373 +0x385 created by time.goFunc /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/time/sleep.go:215 +0x2d goroutine 1 [chan receive]: testing.(*T).Run(0xc0007541a0, {0x264063b?, 0x0?}, 0x2738010) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1751 +0x3ab testing.runTests.func1(0xc0007541a0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2168 +0x37 testing.tRunner(0xc0007541a0, 0xc000a07c18) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4 testing.runTests(0xc000abad08, {0x3d23860, 0x6d, 0x6d}, {0x857640?, 0x3d5bcc8?, 0x3d382c0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2166 +0x43d testing.(*M).Run(0xc0004377c0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2034 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc0004377c0) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5 github.com/rclone/rclone/fs/operations_test.TestMain(...) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:61 main.main() _testmain.go:265 +0xa9 goroutine 14 [syscall, 60 minutes]: os/signal.signal_recv() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/sigqueue.go:152 +0x29 os/signal.loop() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func1.1 in goroutine 1 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/os/signal/signal.go:151 +0x1f goroutine 15 [chan receive, 60 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 1883 [select]: github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc000396700) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:343 +0x13d created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 1882 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:408 +0xb6 goroutine 2791 [sleep]: time.Sleep(0xbebc20000) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/time.go:285 +0xf2 github.com/rclone/rclone/backend/linkbox.(*Object).Update(0xc0001ec100, {0x2a15f40, 0xc0003ee120}, {0x29ee860, 0xc0003ee300}, {0x2a20570, 0xc000532230}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/linkbox/linkbox.go:691 +0x14d7 github.com/rclone/rclone/backend/linkbox.(*Fs).Put(0xc000385680, {0x2a15f40, 0xc0003ee120}, {0x29ee860, 0xc0003ee300}, {0x2a20570, 0xc000532230}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/linkbox/linkbox.go:854 +0x194 github.com/rclone/rclone/fstest.(*Run).WriteObjectTo(0xc000532070, {0x2a15f40, 0xc0003ee120}, {0x2a2b540, 0xc000385680}, {0x25e1996, 0x5}, {0x25e19c8, 0x5}, {0x1dcd64ff, ...}, ...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:275 +0x3f8 github.com/rclone/rclone/fstest.(*Run).WriteObject(...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 github.com/rclone/rclone/fs/operations_test.TestCaseInsensitiveMoveFileDryRun(0xc00018a000) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1026 +0xe5 testing.tRunner(0xc00018a000, 0x2738010) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4 created by testing.(*T).Run in goroutine 1 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390 goroutine 2109 [chan receive, 13 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 2108 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 2158 [IO wait]: internal/poll.runtime_pollWait(0x7f4c7c0525e8, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc00033e080?, 0xc0008da000?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc00033e080, {0xc0008da000, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc00033e080, {0xc0008da000?, 0xc0008da07b?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0003de000, {0xc0008da000?, 0x7bb332?, 0xc0000a09a0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000114540, {0xc0008da000?, 0x18?, 0x10000006a08b8?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000982a08, {0xc0008da000?, 0x0?, 0xc000982a08?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000160638, {0x29f00a0, 0xc000982a08}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000160388, {0x7f4c7cccb458, 0xc000114540}, 0xc0000a0a10?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000160388, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000160388, {0xc000743000, 0x1000, 0xc0000a0ca0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 bufio.(*Reader).Read(0xc0002db500, {0xc0008e4120, 0x9, 0x3cb15d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:241 +0x197 io.ReadAtLeast({0x29ee760, 0xc0002db500}, {0xc0008e4120, 0x9, 0x9}, 0x9) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/io/io.go:335 +0x90 io.ReadFull(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/io/io.go:354 net/http.http2readFrameHeader({0xc0008e4120, 0x9, 0x3efc20?}, {0x29ee760?, 0xc0002db500?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/h2_bundle.go:1642 +0x65 net/http.(*http2Framer).ReadFrame(0xc0008e40e0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/h2_bundle.go:1909 +0x85 net/http.(*http2clientConnReadLoop).run(0xc0000a0fa8) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/h2_bundle.go:9496 +0xda net/http.(*http2ClientConn).readLoop(0xc000664480) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/h2_bundle.go:9392 +0x7c created by net/http.(*http2Transport).newClientConn in goroutine 2157 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/h2_bundle.go:8006 +0xd1b goroutine 195 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:234 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 147 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:232 +0x378 goroutine 483 [chan receive, 51 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 482 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose" - Finished ERROR in 1h0m0.967885947s (try 1/5): exit status 2: Failed [TestCheck TestCheckDownload TestCheckSizeOnly TestParseSumFile TestCheckSumDownload TestApplyTransforms TestCopyFile TestCopyFileCompareDest TestCopyFileMaxTransfer TestListDirSortedFn TestListJSON TestStatJSON TestLsd TestLs TestLsWithFilesFrom TestLsLong TestHashSums TestCount TestDelete TestMaxDelete TestMaxDeleteSizeLargeFile TestMaxDeleteSize TestReadFile TestCat TestPurge TestRmdirsNoLeaveRoot TestRmdirsLeaveRoot TestRmdirsWithFilter TestCopyURL TestMoveFile TestMoveFileWithIgnoreExisting]