"./operations.test -test.v -test.timeout 1h0m0s -remote TestKoofr: -verbose" - Starting (try 1/5) 2026/10/04 03:01:34 DEBUG : Creating backend with remote "TestKoofr:rclone-test-pedinol2yami" 2026/10/04 03:01:34 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/04 03:01:34 DEBUG : Creating backend with remote "/tmp/rclone2000856799" === 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:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" multithread_test.go:120: multithread writing not supported 2026/10/04 03:01:34 ERROR : error listing: directory not found --- SKIP: TestMultithreadCopy (0.06s) === RUN TestMultithreadCopyAbort run.go:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" multithread_test.go:120: multithread writing not supported 2026/10/04 03:01:35 ERROR : error listing: directory not found --- SKIP: TestMultithreadCopyAbort (0.06s) === RUN TestMultithreadCopyWriterAtErrors === RUN TestMultithreadCopyWriterAtErrors/open/fatal=false 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt === RUN TestMultithreadCopyWriterAtErrors/open/fatal=true 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt === RUN TestMultithreadCopyWriterAtErrors/write/fatal=false 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/10/04 03:01:35 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 1 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 0 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 2 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found === RUN TestMultithreadCopyWriterAtErrors/write/fatal=true 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/10/04 03:01:35 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 1 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 0 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 2 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found === RUN TestMultithreadCopyWriterAtErrors/close/fatal=false 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/10/04 03:01:35 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 1 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 0 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 2 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 3 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found === RUN TestMultithreadCopyWriterAtErrors/close/fatal=true 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/10/04 03:01:35 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 1 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 2 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 0 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting 2026/10/04 03:01:35 DEBUG : file.txt: writing chunk 3 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/10/04 03:01:35 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found --- PASS: TestMultithreadCopyWriterAtErrors (0.00s) --- PASS: TestMultithreadCopyWriterAtErrors/open/fatal=false (0.00s) --- PASS: TestMultithreadCopyWriterAtErrors/open/fatal=true (0.00s) --- PASS: TestMultithreadCopyWriterAtErrors/write/fatal=false (0.00s) --- PASS: TestMultithreadCopyWriterAtErrors/write/fatal=true (0.00s) --- PASS: TestMultithreadCopyWriterAtErrors/close/fatal=false (0.00s) --- PASS: TestMultithreadCopyWriterAtErrors/close/fatal=true (0.00s) === RUN TestSizeDiffers 2026/10/04 03:01:35 DEBUG : a: size = 0 OK 2026/10/04 03:01:35 DEBUG : a: size = 1 (memory) 2026/10/04 03:01:35 DEBUG : a: size = 2 (memory) --- PASS: TestSizeDiffers (0.00s) === RUN TestDirTransferEntry --- PASS: TestDirTransferEntry (0.00s) === RUN TestReOpen === RUN TestReOpen/Normal === RUN TestReOpen/Normal/Basics 2026/10/04 03:01:35 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/ErrorAtStart === RUN TestReOpen/Normal/WithErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/Normal/TooManyErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Normal/ReadAt 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/Normal/Seek 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 2 === RUN TestReOpen/Normal/AccountRead === RUN TestReOpen/Normal/AccountReadDelay 2026/10/04 03:01:35 DEBUG : potato: Seek from 10 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 10 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/AccountReadError === RUN TestReOpen/WithRangeOption === RUN TestReOpen/WithRangeOption/Basics 2026/10/04 03:01:35 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/ErrorAtStart === RUN TestReOpen/WithRangeOption/WithErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithRangeOption/TooManyErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithRangeOption/ReadAt 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/WithRangeOption/Seek 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 2 2026/10/04 03:01:35 DEBUG : potato: Seek from 7 to 4 === RUN TestReOpen/WithRangeOption/AccountRead === RUN TestReOpen/WithRangeOption/AccountReadDelay 2026/10/04 03:01:35 DEBUG : potato: Seek from 7 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 7 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/AccountReadError === RUN TestReOpen/WithSeekOption === RUN TestReOpen/WithSeekOption/Basics 2026/10/04 03:01:35 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/ErrorAtStart === RUN TestReOpen/WithSeekOption/WithErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithSeekOption/TooManyErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithSeekOption/ReadAt 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/WithSeekOption/Seek 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 2 2026/10/04 03:01:35 DEBUG : potato: Seek from 7 to 5 === RUN TestReOpen/WithSeekOption/AccountRead === RUN TestReOpen/WithSeekOption/AccountReadDelay 2026/10/04 03:01:35 DEBUG : potato: Seek from 8 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 8 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/AccountReadError === RUN TestReOpen/UnknownSize === RUN TestReOpen/UnknownSize/Basics 2026/10/04 03:01:35 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/ErrorAtStart === RUN TestReOpen/UnknownSize/WithErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/UnknownSize/TooManyErrors 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/10/04 03:01:35 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/UnknownSize/ReadAt 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/UnknownSize/Seek 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/10/04 03:01:35 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/10/04 03:01:35 DEBUG : potato: Seek from 5 to 2 2026/10/04 03:01:35 DEBUG : potato: Seek from 7 to 6 === RUN TestReOpen/UnknownSize/AccountRead === RUN TestReOpen/UnknownSize/AccountReadDelay 2026/10/04 03:01:35 DEBUG : potato: Seek from 9 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 9 to 0 2026/10/04 03:01:35 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/AccountReadError --- PASS: TestReOpen (0.01s) --- 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/ReadAt (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/ReadAt (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/ReadAt (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/ReadAt (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:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" === RUN TestCheck/1 === RUN TestCheck/2 === RUN TestCheck/3 === RUN TestCheck/4 === RUN TestCheck/5 === RUN TestCheck/6 === RUN TestCheck/7 --- PASS: TestCheck (5.80s) --- PASS: TestCheck/1 (0.08s) --- PASS: TestCheck/2 (0.07s) --- PASS: TestCheck/3 (0.06s) --- PASS: TestCheck/4 (0.10s) --- PASS: TestCheck/5 (0.08s) --- PASS: TestCheck/6 (0.12s) --- PASS: TestCheck/7 (1.20s) === RUN TestCheckFsError 2026/10/04 03:01:40 DEBUG : Creating backend with remote "nonexistent" 2026/10/04 03:01:40 DEBUG : Creating backend with remote "nonexistent" 2026/10/04 03:01:40 DEBUG : Local file system at nonexistent: Waiting for checks to finish 2026/10/04 03:01:40 ERROR : Local file system at nonexistent: error reading source root directory: directory not found 2026/10/04 03:01:40 NOTICE: Local file system at nonexistent: 0 differences found 2026/10/04 03:01:40 NOTICE: Local file system at nonexistent: 2 errors while checking --- PASS: TestCheckFsError (0.00s) === RUN TestCheckDownload run.go:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 === RUN TestCheckDownload/3 === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (4.73s) --- PASS: TestCheckDownload/1 (0.35s) --- PASS: TestCheckDownload/2 (0.23s) --- PASS: TestCheckDownload/3 (0.21s) --- PASS: TestCheckDownload/4 (0.47s) --- PASS: TestCheckDownload/5 (0.20s) --- PASS: TestCheckDownload/6 (0.18s) --- PASS: TestCheckDownload/7 (0.19s) === RUN TestCheckSizeOnly run.go:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 === RUN TestCheckSizeOnly/3 === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (3.49s) --- PASS: TestCheckSizeOnly/1 (0.07s) --- PASS: TestCheckSizeOnly/2 (0.07s) --- PASS: TestCheckSizeOnly/3 (0.11s) --- PASS: TestCheckSizeOnly/4 (0.09s) --- PASS: TestCheckSizeOnly/5 (0.10s) --- PASS: TestCheckSizeOnly/6 (0.07s) --- PASS: TestCheckSizeOnly/7 (0.06s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestParseSumFile run.go:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" 2026/10/04 03:01:49 NOTICE: test.sum: improperly formatted checksum line 4 2026/10/04 03:01:49 NOTICE: test.sum: improperly formatted checksum line 5 2026/10/04 03:01:49 NOTICE: test.sum: improperly formatted checksum line 6 2026/10/04 03:01:49 NOTICE: test.sum: 2 warning(s) suppressed... 2026/10/04 03:01:50 NOTICE: test.sum: improperly formatted checksum line 4 2026/10/04 03:01:50 NOTICE: test.sum: improperly formatted checksum line 5 2026/10/04 03:01:50 NOTICE: test.sum: improperly formatted checksum line 6 2026/10/04 03:01:50 NOTICE: test.sum: 2 warning(s) suppressed... --- PASS: TestParseSumFile (1.44s) === RUN TestCheckSum run.go:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" 2026/10/04 03:01:50 DEBUG : Creating backend with remote "TestKoofr:rclone-test-pedinol2yami/data" check_test.go:351: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:351 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 Error: Received unexpected error: Invalid response status! Got 503, expected [200]; headers: map[Cache-Control:[no-cache] Content-Length:[107] Content-Type:[text/html]], content:

503 Service Unavailable

No server is available to handle this request. Test: TestCheckSum --- FAIL: TestCheckSum (4.34s) === RUN TestCheckSumDownload run.go:198: Remote "koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami", Local "Local file system at /tmp/rclone2000856799", Modify Window "1ms" 2026/10/04 03:01:54 DEBUG : Creating backend with remote "TestKoofr:rclone-test-pedinol2yami/data" === RUN TestCheckSumDownload/subtest1 === RUN TestCheckSumDownload/subtest2 === RUN TestCheckSumDownload/subtest3 === RUN TestCheckSumDownload/subtest4 === RUN TestCheckSumDownload/subtest5 === NAME TestCheckSumDownload 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:432 Error: Not equal: expected: 1 actual : 4 Test: TestCheckSumDownload Messages: wrong error count in run 5 check_test.go:417: Error Trace: /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:432 Error: "2026/10/04 03:02:05 ERROR : error listing: Invalid response status! Got 503, expected [200]; headers: map[Cache-Control:[no-cache] Content-Length:[107] Content-Type:[text/html]], content:

503 Service Unavailable

\nNo server is available to handle this request.\n\n2026/10/04 03:02:05 ERROR : banana: file not in koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data\n2026/10/04 03:02:05 ERROR : orange: file not in koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data\n2026/10/04 03:02:05 ERROR : potato: file not in koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data\n2026/10/04 03:02:05 NOTICE: koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data: 3 files missing\n2026/10/04 03:02:05 NOTICE: koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data: 0 differences found\n2026/10/04 03:02:05 NOTICE: koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data: 4 errors while checking\n" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 5 check_test.go:419: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:419 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: 2 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 5 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:421 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "+ orange", "= banana", "= potato"} actual : []string{"", "+ banana", "+ orange", "+ potato"} Diff: --- Expected +++ Actual @@ -2,5 +2,5 @@ (string) "", + (string) (len=8) "+ banana", (string) (len=8) "+ orange", - (string) (len=8) "= banana", - (string) (len=8) "= potato" + (string) (len=8) "+ potato" } Test: TestCheckSumDownload Messages: wrong combined result in run 5 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:423 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "orange"} actual : []string{"", "banana", "orange", "potato"} Diff: --- Expected +++ Actual @@ -1,4 +1,6 @@ -([]string) (len=2) { +([]string) (len=4) { (string) "", - (string) (len=6) "orange" + (string) (len=6) "banana", + (string) (len=6) "orange", + (string) (len=6) "potato" } Test: TestCheckSumDownload Messages: wrong missingondst result in run 5 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:424 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "banana", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=6) "banana", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 5 === RUN TestCheckSumDownload/subtest6 === NAME TestCheckSumDownload 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:432 Error: Not equal: expected: 2 actual : 4 Test: TestCheckSumDownload Messages: wrong error count in run 6 check_test.go:417: Error Trace: /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:432 Error: "2026/10/04 03:02:06 ERROR : error listing: Invalid response status! Got 503, expected [200]; headers: map[Cache-Control:[no-cache] Content-Length:[107] Content-Type:[text/html]], content:

503 Service Unavailable

\nNo server is available to handle this request.\n\n2026/10/04 03:02:06 ERROR : banana: file not in koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data\n2026/10/04 03:02:06 ERROR : orange: file not in koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data\n2026/10/04 03:02:06 ERROR : potato: file not in koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data\n2026/10/04 03:02:06 NOTICE: koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data: 3 files missing\n2026/10/04 03:02:06 NOTICE: koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data: 0 differences found\n2026/10/04 03:02:06 NOTICE: koofr:4266cdc3-3d29-4a88-ac94-738914c162b4:rclone-test-pedinol2yami/data: 4 errors while checking\n" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 6 check_test.go:419: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:419 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: 2 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:421 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "* potato", "+ orange", "= banana"} actual : []string{"", "+ banana", "+ orange", "+ potato"} Diff: --- Expected +++ Actual @@ -2,5 +2,5 @@ (string) "", - (string) (len=8) "* potato", + (string) (len=8) "+ banana", (string) (len=8) "+ orange", - (string) (len=8) "= banana" + (string) (len=8) "+ potato" } Test: TestCheckSumDownload Messages: wrong combined result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:423 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "orange"} actual : []string{"", "banana", "orange", "potato"} Diff: --- Expected +++ Actual @@ -1,4 +1,6 @@ -([]string) (len=2) { +([]string) (len=4) { (string) "", - (string) (len=6) "orange" + (string) (len=6) "banana", + (string) (len=6) "orange", + (string) (len=6) "potato" } Test: TestCheckSumDownload Messages: wrong missingondst result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:424 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 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 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 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 differ result in run 6 === RUN TestCheckSumDownload/subtest7 --- FAIL: TestCheckSumDownload (16.78s) --- PASS: TestCheckSumDownload/subtest1 (1.06s) --- PASS: TestCheckSumDownload/subtest2 (0.86s) --- PASS: TestCheckSumDownload/subtest3 (1.06s) --- PASS: TestCheckSumDownload/subtest4 (1.71s) --- PASS: TestCheckSumDownload/subtest5 (0.35s) --- PASS: TestCheckSumDownload/subtest6 (0.34s) --- PASS: TestCheckSumDownload/subtest7 (1.11s) === RUN TestCheckSumConcurrency 2026/10/04 03:02:11 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK 2026/10/04 03:02:11 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK 2026/10/04 03:02:11 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK 2026/10/04 03:02:11 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK 2026/10/04 03:02:11 NOTICE: Mock file system at checkSum: 0 differences found 2026/10/04 03:02:11 NOTICE: Mock file system at checkSum: 4 matching files --- PASS: TestCheckSumConcurrency (0.00s) === RUN TestCheckSumDownloadConcurrency 2026/10/04 03:02:11 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK 2026/10/04 03:02:11 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK 2026/10/04 03:02:11 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK 2026/10/04 03:02:11 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK 2026/10/04 03:02:11 NOTICE: Mock file system at checkSum: 0 differences found 2026/10/04 03:02:11 NOTICE: Mock file system at checkSum: 4 matching files --- PASS: TestCheckSumDownloadConcurrency (0.00s) === RUN TestApplyTransforms 2026/10/04 03:02:11 DEBUG : Creating backend with remote "TestKoofr:rclone-test-jusodix5sihi" 2026/10/04 03:02:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/04 03:02:13 NOTICE: Failed to open remote "TestKoofr:": Invalid response status! Got 503, expected [200]; headers: map[Cache-Control:[no-cache] Content-Length:[107] Content-Type:[text/html]], content:

503 Service Unavailable

No server is available to handle this request. "./operations.test -test.v -test.timeout 1h0m0s -remote TestKoofr: -verbose" - Finished ERROR in 38.805410993s (try 1/5): exit status 1: Failed [TestCheckSum TestCheckSumDownload]