"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose -fast-list" - Starting (try 1/5) 2026/11/03 01:38:47 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga" 2026/11/03 01:38:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:38:47 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0" 2026/11/03 01:38:48 DEBUG : Creating backend with remote "/tmp/rclone878498292" === 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 "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" multithread_test.go:120: multithread writing not supported --- SKIP: TestMultithreadCopy (0.21s) === RUN TestMultithreadCopyAbort run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" multithread_test.go:120: multithread writing not supported --- SKIP: TestMultithreadCopyAbort (0.25s) === RUN TestMultithreadCopyWriterAtErrors === RUN TestMultithreadCopyWriterAtErrors/open/fatal=false 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt === RUN TestMultithreadCopyWriterAtErrors/open/fatal=true 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt === RUN TestMultithreadCopyWriterAtErrors/write/fatal=false 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/11/03 01:38:49 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 1 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 2 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 0 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/11/03 01:38:49 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/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/11/03 01:38:49 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 1 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 2 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 0 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/11/03 01:38:49 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/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/11/03 01:38:49 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 1 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 2 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 3 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 0 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/11/03 01:38:49 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/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt 2026/11/03 01:38:49 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 1 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 2 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 3 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting 2026/11/03 01:38:49 DEBUG : file.txt: writing chunk 0 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished 2026/11/03 01:38:49 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit 2026/11/03 01:38:49 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/11/03 01:38:49 DEBUG : a: size = 0 OK 2026/11/03 01:38:49 DEBUG : a: size = 1 (memory) 2026/11/03 01:38:49 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/11/03 01:38:49 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/ErrorAtStart === RUN TestReOpen/Normal/WithErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/Normal/TooManyErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Normal/ReadAt 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/Normal/Seek 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 2 === RUN TestReOpen/Normal/AccountRead === RUN TestReOpen/Normal/AccountReadDelay 2026/11/03 01:38:49 DEBUG : potato: Seek from 10 to 0 2026/11/03 01:38:49 DEBUG : potato: Seek from 10 to 0 2026/11/03 01:38:49 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/AccountReadError === RUN TestReOpen/WithRangeOption === RUN TestReOpen/WithRangeOption/Basics 2026/11/03 01:38:49 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/ErrorAtStart === RUN TestReOpen/WithRangeOption/WithErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithRangeOption/TooManyErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithRangeOption/ReadAt 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/WithRangeOption/Seek 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 2 2026/11/03 01:38:49 DEBUG : potato: Seek from 7 to 4 === RUN TestReOpen/WithRangeOption/AccountRead === RUN TestReOpen/WithRangeOption/AccountReadDelay 2026/11/03 01:38:49 DEBUG : potato: Seek from 7 to 0 2026/11/03 01:38:49 DEBUG : potato: Seek from 7 to 0 2026/11/03 01:38:49 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/AccountReadError === RUN TestReOpen/WithSeekOption === RUN TestReOpen/WithSeekOption/Basics 2026/11/03 01:38:49 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/ErrorAtStart === RUN TestReOpen/WithSeekOption/WithErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithSeekOption/TooManyErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithSeekOption/ReadAt 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/WithSeekOption/Seek 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 2 2026/11/03 01:38:49 DEBUG : potato: Seek from 7 to 5 === RUN TestReOpen/WithSeekOption/AccountRead === RUN TestReOpen/WithSeekOption/AccountReadDelay 2026/11/03 01:38:49 DEBUG : potato: Seek from 8 to 0 2026/11/03 01:38:49 DEBUG : potato: Seek from 8 to 0 2026/11/03 01:38:49 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/AccountReadError === RUN TestReOpen/UnknownSize === RUN TestReOpen/UnknownSize/Basics 2026/11/03 01:38:49 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/ErrorAtStart === RUN TestReOpen/UnknownSize/WithErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/UnknownSize/TooManyErrors 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2026/11/03 01:38:49 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/UnknownSize/ReadAt 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 1 === RUN TestReOpen/UnknownSize/Seek 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2026/11/03 01:38:49 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2026/11/03 01:38:49 DEBUG : potato: Seek from 5 to 2 2026/11/03 01:38:49 DEBUG : potato: Seek from 7 to 6 === RUN TestReOpen/UnknownSize/AccountRead === RUN TestReOpen/UnknownSize/AccountReadDelay 2026/11/03 01:38:49 DEBUG : potato: Seek from 9 to 0 2026/11/03 01:38:49 DEBUG : potato: Seek from 9 to 0 2026/11/03 01:38:49 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/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 "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:38:51 DEBUG : rutabaga: md5 = 638c88341ade96878dc1f04f8023de91 OK === RUN TestCheck/1 === RUN TestCheck/2 2026/11/03 01:38:53 DEBUG : empty space: md5 = ebe42cb5fb87ad6c4393040990195818 OK === RUN TestCheck/3 2026/11/03 01:38:55 DEBUG : potato2: md5 = 4d5b0cb8c94f3ab85c9b5a527d134920 OK === RUN TestCheck/4 === RUN TestCheck/5 2026/11/03 01:38:57 DEBUG : remotepotato: md5 = 86ea1ab60065251360b40c0352897539 OK === RUN TestCheck/6 === RUN TestCheck/7 --- PASS: TestCheck (12.28s) --- PASS: TestCheck/1 (0.26s) --- PASS: TestCheck/2 (0.25s) --- PASS: TestCheck/3 (0.23s) --- PASS: TestCheck/4 (0.26s) --- PASS: TestCheck/5 (0.25s) --- PASS: TestCheck/6 (0.24s) --- PASS: TestCheck/7 (0.23s) === RUN TestCheckFsError 2026/11/03 01:39:01 DEBUG : Creating backend with remote "nonexistent" 2026/11/03 01:39:01 DEBUG : Creating backend with remote "nonexistent" 2026/11/03 01:39:01 DEBUG : Local file system at nonexistent: Waiting for checks to finish 2026/11/03 01:39:01 ERROR : Local file system at nonexistent: error reading source root directory: directory not found 2026/11/03 01:39:01 NOTICE: Local file system at nonexistent: 0 differences found 2026/11/03 01:39:01 NOTICE: Local file system at nonexistent: 2 errors while checking --- PASS: TestCheckFsError (0.00s) === RUN TestCheckDownload run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:39:03 DEBUG : rutabaga: md5 = 6c9e6dc489b46aa1ed1ba9bc8e6e0a06 OK === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 2026/11/03 01:39:06 DEBUG : empty space: md5 = f4bf3a623422e5aee47c63f6e3e2fd93 OK === RUN TestCheckDownload/3 2026/11/03 01:39:09 DEBUG : potato2: md5 = 044a0efd05701cae2b5ee12af2c8ba05 OK === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 2026/11/03 01:39:13 DEBUG : remotepotato: md5 = 033f4e1af7088619dfbcdcde35692ff7 OK === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (15.85s) --- PASS: TestCheckDownload/1 (0.93s) --- PASS: TestCheckDownload/2 (0.94s) --- PASS: TestCheckDownload/3 (0.79s) --- PASS: TestCheckDownload/4 (0.98s) --- PASS: TestCheckDownload/5 (0.90s) --- PASS: TestCheckDownload/6 (0.86s) --- PASS: TestCheckDownload/7 (0.82s) === RUN TestCheckSizeOnly run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:39:18 DEBUG : rutabaga: md5 = fdb73944d71cde2fc86c17d340005c5c OK === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 2026/11/03 01:39:20 DEBUG : empty space: md5 = 2030217a3c56bceba53eb8f2353a6c1b OK === RUN TestCheckSizeOnly/3 2026/11/03 01:39:22 DEBUG : potato2: md5 = 9e2f0c09c5ab9e3b54d970f26fa05730 OK === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 2026/11/03 01:39:25 DEBUG : remotepotato: md5 = 0bf64f10763102600500144143038420 OK === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (11.13s) --- PASS: TestCheckSizeOnly/1 (0.25s) --- PASS: TestCheckSizeOnly/2 (0.26s) --- PASS: TestCheckSizeOnly/3 (0.24s) --- PASS: TestCheckSizeOnly/4 (0.28s) --- PASS: TestCheckSizeOnly/5 (0.28s) --- PASS: TestCheckSizeOnly/6 (0.21s) --- PASS: TestCheckSizeOnly/7 (0.25s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestParseSumFile run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:39:29 DEBUG : test.sum: md5 = 4e177c6b389f14c10b4589e8d04307d3 OK 2026/11/03 01:39:30 NOTICE: test.sum: improperly formatted checksum line 4 2026/11/03 01:39:30 NOTICE: test.sum: improperly formatted checksum line 5 2026/11/03 01:39:30 NOTICE: test.sum: improperly formatted checksum line 6 2026/11/03 01:39:30 NOTICE: test.sum: 2 warning(s) suppressed... 2026/11/03 01:39:32 DEBUG : test.sum: md5 = dea8a2a8713f3f5bd9ba04b8f0e492e8 OK 2026/11/03 01:39:33 NOTICE: test.sum: improperly formatted checksum line 4 2026/11/03 01:39:33 NOTICE: test.sum: improperly formatted checksum line 5 2026/11/03 01:39:33 NOTICE: test.sum: improperly formatted checksum line 6 2026/11/03 01:39:33 NOTICE: test.sum: 2 warning(s) suppressed... --- PASS: TestParseSumFile (5.64s) === RUN TestCheckSum run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:39:34 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/data" 2026/11/03 01:39:34 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/vjrnln8ratgmqakfosrqe8espk" check_test.go:354: Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/data' lacks md5, skipping --- SKIP: TestCheckSum (1.99s) === RUN TestCheckSumDownload run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:39:36 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/data" 2026/11/03 01:39:36 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/vjrnln8ratgmqakfosrqe8espk" 2026/11/03 01:39:39 DEBUG : data/banana: md5 = fe01ba021390fdbd7abd59757990604d OK 2026/11/03 01:39:41 DEBUG : test.sum: md5 = 467fd9a9fbbea750a91a43964d36c787 OK === RUN TestCheckSumDownload/subtest1 2026/11/03 01:39:45 DEBUG : data/potato: md5 = c5fd509d275afddfeb469141f55cd7e8 OK 2026/11/03 01:39:47 DEBUG : test.sum: md5 = bd6a1d04fe81245991a922dec013a56d OK === RUN TestCheckSumDownload/subtest2 2026/11/03 01:39:50 DEBUG : test.sum: md5 = a01496a66ead92c1e08abc6b32781a95 OK === RUN TestCheckSumDownload/subtest3 2026/11/03 01:39:54 DEBUG : test.sum: md5 = 7184a1ad6ebd22f2f1b2dcfe8a080444 OK === RUN TestCheckSumDownload/subtest4 2026/11/03 01:39:58 DEBUG : test.sum: md5 = 32883a0df108a442522d29620eb83685 OK === RUN TestCheckSumDownload/subtest5 2026/11/03 01:40:02 DEBUG : test.sum: md5 = 8c6fc83d35819dac4b2d4e4b09809c50 OK === RUN TestCheckSumDownload/subtest6 2026/11/03 01:40:05 DEBUG : data/banana: md5 = 03f0beabdfdf9f4aa5324be05bda020d OK 2026/11/03 01:40:07 DEBUG : data/potato: md5 = 845dc1c929fb6a20cc2dadc9b7df3c4c OK 2026/11/03 01:40:08 DEBUG : test.sum: md5 = c56eaffb988d7845997cb64839356e5f OK === RUN TestCheckSumDownload/subtest7 --- PASS: TestCheckSumDownload (37.86s) --- PASS: TestCheckSumDownload/subtest1 (2.13s) --- PASS: TestCheckSumDownload/subtest2 (2.01s) --- PASS: TestCheckSumDownload/subtest3 (1.77s) --- PASS: TestCheckSumDownload/subtest4 (1.82s) --- PASS: TestCheckSumDownload/subtest5 (1.66s) --- PASS: TestCheckSumDownload/subtest6 (1.76s) --- PASS: TestCheckSumDownload/subtest7 (1.85s) === RUN TestCheckSumConcurrency 2026/11/03 01:40:13 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK 2026/11/03 01:40:13 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK 2026/11/03 01:40:13 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK 2026/11/03 01:40:13 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK 2026/11/03 01:40:13 NOTICE: Mock file system at checkSum: 0 differences found 2026/11/03 01:40:13 NOTICE: Mock file system at checkSum: 4 matching files --- PASS: TestCheckSumConcurrency (0.00s) === RUN TestCheckSumDownloadConcurrency 2026/11/03 01:40:13 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK 2026/11/03 01:40:13 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK 2026/11/03 01:40:13 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK 2026/11/03 01:40:13 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK 2026/11/03 01:40:13 NOTICE: Mock file system at checkSum: 0 differences found 2026/11/03 01:40:13 NOTICE: Mock file system at checkSum: 4 matching files --- PASS: TestCheckSumDownloadConcurrency (0.00s) === RUN TestApplyTransforms 2026/11/03 01:40:13 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-dutuket9husa" 2026/11/03 01:40:13 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:13 DEBUG : Creating backend with remote "TestDrive:crypt/vo734nv8ujsg8q0gbrc0brv1p4osdgjg3fr1pinhf8oob41ucak0" 2026/11/03 01:40:14 DEBUG : Creating backend with remote "/tmp/rclone3677716200" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa'", Local "Local file system at /tmp/rclone3677716200", Modify Window "1ms" 2026/11/03 01:40:17 DEBUG : hello, world!: md5 = 8b52bd4cdb3f076cec9a70fc49fb2d00 OK upper checkfile vs. lower remote (without normalization) 2026/11/03 01:40:17 ERROR : hello, world!: sum not found 2026/11/03 01:40:17 ERROR : HELLO, WORLD!: file not in Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa' 2026/11/03 01:40:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa': 1 files missing 2026/11/03 01:40:17 NOTICE: 1 hashes missing 2026/11/03 01:40:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa': 1 differences found 2026/11/03 01:40:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa': 2 errors while checking upper checkfile vs. lower remote (with normalization) 2026/11/03 01:40:18 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:18 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa': 0 differences found 2026/11/03 01:40:18 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa': 1 matching files 2026/11/03 01:40:18 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bugeloc7bemi" 2026/11/03 01:40:18 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:18 DEBUG : Creating backend with remote "TestDrive:crypt/5ng24mp2qvqg3afhicke9p7d2lma3f47dieroct9basg6l2bfqj0" 2026/11/03 01:40:19 DEBUG : Creating backend with remote "/tmp/rclone653755710" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi'", Local "Local file system at /tmp/rclone653755710", Modify Window "1ms" 2026/11/03 01:40:22 DEBUG : HELLO, WORLD!: md5 = e1cfe1bdc91c8aa547575b251329d43c OK lower checkfile vs. upper remote (without normalization) 2026/11/03 01:40:22 ERROR : HELLO, WORLD!: sum not found 2026/11/03 01:40:22 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi' 2026/11/03 01:40:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi': 1 files missing 2026/11/03 01:40:22 NOTICE: 1 hashes missing 2026/11/03 01:40:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi': 1 differences found 2026/11/03 01:40:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi': 2 errors while checking lower checkfile vs. upper remote (with normalization) 2026/11/03 01:40:23 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:23 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi': 0 differences found 2026/11/03 01:40:23 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi': 1 matching files 2026/11/03 01:40:23 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-xuqotur5viso" 2026/11/03 01:40:23 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:23 DEBUG : Creating backend with remote "TestDrive:crypt/i7uknqjht4qlp2lvt2cnv3l5a6daea0ssod1d5aj2dnk48kvlpk0" 2026/11/03 01:40:24 DEBUG : Creating backend with remote "/tmp/rclone1684869214" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso'", Local "Local file system at /tmp/rclone1684869214", Modify Window "1ms" 2026/11/03 01:40:26 DEBUG : HeLlO, wOrLd!: md5 = 1d9ac67839704bd838b6254a4cb87873 OK lower checkfile vs. upperlowermixed remote (without normalization) 2026/11/03 01:40:27 ERROR : HeLlO, wOrLd!: sum not found 2026/11/03 01:40:27 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso' 2026/11/03 01:40:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso': 1 files missing 2026/11/03 01:40:27 NOTICE: 1 hashes missing 2026/11/03 01:40:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso': 1 differences found 2026/11/03 01:40:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso': 2 errors while checking lower checkfile vs. upperlowermixed remote (with normalization) 2026/11/03 01:40:28 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:28 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso': 0 differences found 2026/11/03 01:40:28 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso': 1 matching files 2026/11/03 01:40:28 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bimohol5wexe" 2026/11/03 01:40:28 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:28 DEBUG : Creating backend with remote "TestDrive:crypt/4d59htq620vuigtpfn0vp2ikpcbmmm51u0h5ii1tdum010cra1e0" 2026/11/03 01:40:29 DEBUG : Creating backend with remote "/tmp/rclone2433356748" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe'", Local "Local file system at /tmp/rclone2433356748", Modify Window "1ms" 2026/11/03 01:40:31 DEBUG : HELLO, WORLD!: md5 = 66a52e3dc9685d3be35ec4202d64bae3 OK upperlowermixed checkfile vs. upper remote (without normalization) 2026/11/03 01:40:31 ERROR : HELLO, WORLD!: sum not found 2026/11/03 01:40:31 ERROR : HeLlO, wOrLd!: file not in Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe' 2026/11/03 01:40:31 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe': 1 files missing 2026/11/03 01:40:31 NOTICE: 1 hashes missing 2026/11/03 01:40:31 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe': 1 differences found 2026/11/03 01:40:31 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe': 2 errors while checking upperlowermixed checkfile vs. upper remote (with normalization) 2026/11/03 01:40:32 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:32 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe': 0 differences found 2026/11/03 01:40:32 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe': 1 matching files 2026/11/03 01:40:32 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-jixalof0vapa" 2026/11/03 01:40:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:32 DEBUG : Creating backend with remote "TestDrive:crypt/2dickbiaem20cqp9012nivfsi4mqo652ukdbrelmf119hlj4jchg" 2026/11/03 01:40:33 DEBUG : Creating backend with remote "/tmp/rclone3159842035" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa'", Local "Local file system at /tmp/rclone3159842035", Modify Window "1ms" 2026/11/03 01:40:35 DEBUG : 測試_Русский___ě_áñ: md5 = a484209cd915832e3d258b327667b2cc OK NFD checkfile vs. NFC remote (without normalization) 2026/11/03 01:40:36 ERROR : 測試_Русский___ě_áñ: sum not found 2026/11/03 01:40:36 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa' 2026/11/03 01:40:36 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa': 1 files missing 2026/11/03 01:40:36 NOTICE: 1 hashes missing 2026/11/03 01:40:36 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa': 1 differences found 2026/11/03 01:40:36 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa': 2 errors while checking NFD checkfile vs. NFC remote (with normalization) 2026/11/03 01:40:37 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:37 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa': 0 differences found 2026/11/03 01:40:37 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa': 1 matching files 2026/11/03 01:40:37 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-sufidag0keci" 2026/11/03 01:40:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:37 DEBUG : Creating backend with remote "TestDrive:crypt/m048g3u01hg413d27ovtpbrd5vaufl0jp3e1bgreli6df23l6idg" 2026/11/03 01:40:38 DEBUG : Creating backend with remote "/tmp/rclone591654008" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci'", Local "Local file system at /tmp/rclone591654008", Modify Window "1ms" 2026/11/03 01:40:40 DEBUG : 測試_Русский___ě_áñ: md5 = eb9185cc5c7cbc99f4d113fd32c04aa6 OK NFC checkfile vs. NFD remote (without normalization) 2026/11/03 01:40:41 ERROR : 測試_Русский___ě_áñ: sum not found 2026/11/03 01:40:41 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci' 2026/11/03 01:40:41 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci': 1 files missing 2026/11/03 01:40:41 NOTICE: 1 hashes missing 2026/11/03 01:40:41 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci': 1 differences found 2026/11/03 01:40:41 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci': 2 errors while checking NFC checkfile vs. NFD remote (with normalization) 2026/11/03 01:40:42 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:42 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci': 0 differences found 2026/11/03 01:40:42 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci': 1 matching files 2026/11/03 01:40:42 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-nexizip6bane" 2026/11/03 01:40:42 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:42 DEBUG : Creating backend with remote "TestDrive:crypt/no48io3av8r8pupom5di184r57gejosg6ftkd4254f1a081f14p0" 2026/11/03 01:40:43 DEBUG : Creating backend with remote "/tmp/rclone2001186793" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane'", Local "Local file system at /tmp/rclone2001186793", Modify Window "1ms" 2026/11/03 01:40:45 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = f16b29a30c50f5dcf0f91b1215c535e4 OK NFDx2 checkfile vs. both remote (without normalization) 2026/11/03 01:40:45 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2026/11/03 01:40:45 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane' 2026/11/03 01:40:45 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane': 1 files missing 2026/11/03 01:40:45 NOTICE: 1 hashes missing 2026/11/03 01:40:45 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane': 1 differences found 2026/11/03 01:40:45 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane': 2 errors while checking NFDx2 checkfile vs. both remote (with normalization) 2026/11/03 01:40:46 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:46 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane': 0 differences found 2026/11/03 01:40:46 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane': 1 matching files 2026/11/03 01:40:46 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-subivip1qoyu" 2026/11/03 01:40:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:46 DEBUG : Creating backend with remote "TestDrive:crypt/q80mlpj2825p6cmrhringqdqs4fl8tkmtkedv74v0ommrs3gtd50" 2026/11/03 01:40:47 DEBUG : Creating backend with remote "/tmp/rclone1271933089" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu'", Local "Local file system at /tmp/rclone1271933089", Modify Window "1ms" 2026/11/03 01:40:50 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 3e5fe387be70ffbceec48cba6563e869 OK NFCx2 checkfile vs. both remote (without normalization) 2026/11/03 01:40:50 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2026/11/03 01:40:50 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu' 2026/11/03 01:40:50 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu': 1 files missing 2026/11/03 01:40:50 NOTICE: 1 hashes missing 2026/11/03 01:40:50 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu': 1 differences found 2026/11/03 01:40:50 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu': 2 errors while checking NFCx2 checkfile vs. both remote (with normalization) 2026/11/03 01:40:51 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:51 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu': 0 differences found 2026/11/03 01:40:51 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu': 1 matching files 2026/11/03 01:40:51 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-koxedit9pule" 2026/11/03 01:40:51 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:51 DEBUG : Creating backend with remote "TestDrive:crypt/geghmdprcgc4iekr2h5an030aupt725g13o4rtl8vpotfghe4ajg" 2026/11/03 01:40:52 DEBUG : Creating backend with remote "/tmp/rclone16401591" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule'", Local "Local file system at /tmp/rclone16401591", Modify Window "1ms" 2026/11/03 01:40:54 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 68387c67f4d866026e7b3a5d9babf096 OK both checkfile vs. NFDx2 remote (without normalization) 2026/11/03 01:40:55 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2026/11/03 01:40:55 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule' 2026/11/03 01:40:55 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule': 1 files missing 2026/11/03 01:40:55 NOTICE: 1 hashes missing 2026/11/03 01:40:55 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule': 1 differences found 2026/11/03 01:40:55 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule': 2 errors while checking both checkfile vs. NFDx2 remote (with normalization) 2026/11/03 01:40:56 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:40:56 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule': 0 differences found 2026/11/03 01:40:56 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule': 1 matching files 2026/11/03 01:40:56 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-talucav6pujo" 2026/11/03 01:40:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:40:56 DEBUG : Creating backend with remote "TestDrive:crypt/062tr43potnan7mfaqdr5bck00rlrr6n4s3838s9l74nao4fmbp0" 2026/11/03 01:40:57 DEBUG : Creating backend with remote "/tmp/rclone3405338211" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo'", Local "Local file system at /tmp/rclone3405338211", Modify Window "1ms" 2026/11/03 01:40:59 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 78834558b36c0ef434f8441c185338a0 OK both checkfile vs. NFCx2 remote (without normalization) 2026/11/03 01:41:00 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2026/11/03 01:41:00 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo' 2026/11/03 01:41:00 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo': 1 files missing 2026/11/03 01:41:00 NOTICE: 1 hashes missing 2026/11/03 01:41:00 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo': 1 differences found 2026/11/03 01:41:00 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo': 2 errors while checking both checkfile vs. NFCx2 remote (with normalization) 2026/11/03 01:41:01 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2026/11/03 01:41:01 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo': 0 differences found 2026/11/03 01:41:01 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo': 1 matching files 2026/11/03 01:41:01 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-talucav6pujo': Purge remote 2026/11/03 01:41:01 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-koxedit9pule': Purge remote 2026/11/03 01:41:02 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-subivip1qoyu': Purge remote 2026/11/03 01:41:02 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-nexizip6bane': Purge remote 2026/11/03 01:41:03 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-sufidag0keci': Purge remote 2026/11/03 01:41:03 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-jixalof0vapa': Purge remote 2026/11/03 01:41:03 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-bimohol5wexe': Purge remote 2026/11/03 01:41:04 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-xuqotur5viso': Purge remote 2026/11/03 01:41:04 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-bugeloc7bemi': Purge remote 2026/11/03 01:41:05 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-dutuket9husa': Purge remote --- PASS: TestApplyTransforms (51.99s) === RUN TestTruncateString --- PASS: TestTruncateString (0.00s) === RUN TestCopyFile run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:41:06 DEBUG : file1: Need to transfer - File not found at Destination 2026/11/03 01:41:08 DEBUG : sub/file2: md5 = 17660beb5d1d083500af9092a4a17f4e OK 2026/11/03 01:41:08 DEBUG : sub/file2: size = 14 OK 2026/11/03 01:41:08 INFO : file1: Copied (new) to: sub/file2 2026/11/03 01:41:08 DEBUG : sub/file2: size = 14 OK 2026/11/03 01:41:08 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2026/11/03 01:41:08 DEBUG : file1: Unchanged skipping 2026/11/03 01:41:09 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': don't need to copy/move sub/file2, it is already at target location --- PASS: TestCopyFile (5.90s) === RUN TestCopyFileImmutable run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:41:12 DEBUG : existing: Need to transfer - File not found at Destination 2026/11/03 01:41:13 DEBUG : existing: md5 = 1afd068297b7783ba019a7eac983844a OK 2026/11/03 01:41:13 DEBUG : existing: size = 6 OK 2026/11/03 01:41:13 INFO : existing: Copied (new) 2026/11/03 01:41:14 DEBUG : existing: size = 6 OK 2026/11/03 01:41:14 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2026/11/03 01:41:14 DEBUG : existing: Unchanged skipping 2026/11/03 01:41:14 DEBUG : existing: size = 8 (Local file system at /tmp/rclone878498292) 2026/11/03 01:41:14 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 01:41:14 DEBUG : existing: Sizes differ 2026/11/03 01:41:14 ERROR : existing: Source and destination exist but do not match: immutable file modified --- PASS: TestCopyFileImmutable (4.17s) === RUN TestCopyLongFile run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" copy_test.go:188: Test only runs on local --- SKIP: TestCopyLongFile (0.44s) === RUN TestCopyFileBackupDir run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:41:18 DEBUG : dst/file1: md5 = 244bbf92e4eb40a415515fd1d483e4c2 OK 2026/11/03 01:41:19 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/backup" 2026/11/03 01:41:19 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/1nrff024r7pq65ecp72fc28jb0" 2026/11/03 01:41:20 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone878498292) 2026/11/03 01:41:20 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 01:41:20 DEBUG : dst/file1: Sizes differ 2026/11/03 01:41:22 INFO : dst/file1: Moved (server-side) 2026/11/03 01:41:24 DEBUG : dst/file1: md5 = 84ff17a8fbbb4c71c2ac48cc39c35876 OK 2026/11/03 01:41:24 DEBUG : dst/file1: size = 14 OK 2026/11/03 01:41:24 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (13.06s) === RUN TestCopyFileCompareDest run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:41:29 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/dst" 2026/11/03 01:41:29 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/31u3jie661vd5p8j7rtc3hgbh0" 2026/11/03 01:41:31 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/CompareDest" 2026/11/03 01:41:31 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/gveqi14airsml4bgu7krj116o8" 2026/11/03 01:41:32 DEBUG : one: Need to transfer - File not found at Destination 2026/11/03 01:41:35 DEBUG : one: md5 = 3464ed298e1cc0a5c6cbec3b6bac8bab OK 2026/11/03 01:41:35 DEBUG : one: size = 3 OK 2026/11/03 01:41:35 INFO : one: Copied (new) 2026/11/03 01:41:36 DEBUG : one: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:41:36 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/dst') 2026/11/03 01:41:36 DEBUG : one: Sizes differ 2026/11/03 01:41:37 DEBUG : one: md5 = 0075cbc9d3e2dd61b6b46e2c62842b22 OK 2026/11/03 01:41:37 DEBUG : one: size = 5 OK 2026/11/03 01:41:37 INFO : one: Copied (replaced existing) 2026/11/03 01:41:39 DEBUG : dst/one: md5 = 5d6738007e6e8f728094d47470b4a254 OK 2026/11/03 01:41:42 DEBUG : CompareDest/one: md5 = 9ae33e798fa58fb8bf5f5cdecf627493 OK 2026/11/03 01:41:42 DEBUG : one: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:41:42 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/dst') 2026/11/03 01:41:42 DEBUG : one: Sizes differ 2026/11/03 01:41:43 DEBUG : one: size = 5 OK 2026/11/03 01:41:43 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2026/11/03 01:41:43 DEBUG : one: Destination found in --compare-dest, skipping 2026/11/03 01:41:45 DEBUG : CompareDest/two: md5 = 5ba111eaad931fe993c6b41c43c008fb OK 2026/11/03 01:41:45 DEBUG : two: Need to transfer - File not found at Destination 2026/11/03 01:41:46 DEBUG : two: size = 3 OK 2026/11/03 01:41:46 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2026/11/03 01:41:46 DEBUG : two: Destination found in --compare-dest, skipping 2026/11/03 01:41:46 DEBUG : two: Need to transfer - File not found at Destination 2026/11/03 01:41:47 DEBUG : two: size = 3 OK 2026/11/03 01:41:47 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2026/11/03 01:41:47 DEBUG : two: Destination found in --compare-dest, skipping 2026/11/03 01:41:48 DEBUG : two: Need to transfer - File not found at Destination 2026/11/03 01:41:48 DEBUG : two: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:41:48 DEBUG : two: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/CompareDest') 2026/11/03 01:41:48 DEBUG : two: Sizes differ 2026/11/03 01:41:50 DEBUG : two: md5 = 88c4aadbf3de91f4737766fe4e54e2bd OK 2026/11/03 01:41:50 DEBUG : two: size = 5 OK 2026/11/03 01:41:50 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (25.21s) === RUN TestCopyFileCopyDestImmutable run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:41:54 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/dst" 2026/11/03 01:41:54 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/31u3jie661vd5p8j7rtc3hgbh0" 2026/11/03 01:41:58 DEBUG : dst/one: md5 = 826ceacc5ef4433cd0a459e243451c6e OK 2026/11/03 01:42:00 DEBUG : CopyDest/one: md5 = fddd74409d7dae91d28164a9da65026e OK 2026/11/03 01:42:01 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/CopyDest" 2026/11/03 01:42:01 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/d09o6po3f7bm6ce32vdgs8h9ls" 2026/11/03 01:42:02 DEBUG : one: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:42:02 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/dst') 2026/11/03 01:42:02 DEBUG : one: Sizes differ 2026/11/03 01:42:02 DEBUG : one: size = 5 OK 2026/11/03 01:42:02 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2026/11/03 01:42:02 DEBUG : one: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:42:02 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/dst') 2026/11/03 01:42:02 DEBUG : one: Sizes differ 2026/11/03 01:42:02 ERROR : one: Source and destination exist but do not match: immutable file modified --- PASS: TestCopyFileCopyDestImmutable (11.82s) === RUN TestCopyFileCopyDest run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:42:06 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/dst" 2026/11/03 01:42:06 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/31u3jie661vd5p8j7rtc3hgbh0" 2026/11/03 01:42:08 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/CopyDest" 2026/11/03 01:42:08 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/d09o6po3f7bm6ce32vdgs8h9ls" 2026/11/03 01:42:09 DEBUG : one: Need to transfer - File not found at Destination 2026/11/03 01:42:12 DEBUG : one: md5 = b974a1658d3145419ca386c84d79a721 OK 2026/11/03 01:42:12 DEBUG : one: size = 3 OK 2026/11/03 01:42:12 INFO : one: Copied (new) 2026/11/03 01:42:13 DEBUG : one: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:42:13 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/dst') 2026/11/03 01:42:13 DEBUG : one: Sizes differ 2026/11/03 01:42:15 DEBUG : one: md5 = 04347caf051172ec2caa89b4a897a6a7 OK 2026/11/03 01:42:15 DEBUG : one: size = 5 OK 2026/11/03 01:42:15 INFO : one: Copied (replaced existing) 2026/11/03 01:42:17 DEBUG : dst/one: md5 = 8d7fb0af3dcf03bf9a89211e5f79fdcc OK 2026/11/03 01:42:19 DEBUG : CopyDest/one: md5 = 6d8f904b15493891711ee62f81d6906a OK 2026/11/03 01:42:20 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/BackupDir" 2026/11/03 01:42:20 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/s6dbk3lfi7c9kfvo6j7bla9m0g" 2026/11/03 01:42:21 DEBUG : one: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:42:21 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/dst') 2026/11/03 01:42:21 DEBUG : one: Sizes differ 2026/11/03 01:42:21 DEBUG : one: size = 5 OK 2026/11/03 01:42:21 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2026/11/03 01:42:21 DEBUG : one: size = 5 (Local file system at /tmp/rclone878498292) 2026/11/03 01:42:21 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/dst') 2026/11/03 01:42:21 DEBUG : one: Sizes differ 2026/11/03 01:42:23 INFO : one: Moved (server-side) 2026/11/03 01:42:24 DEBUG : one: size = 5 OK 2026/11/03 01:42:24 INFO : one: Copied (server-side copy) 2026/11/03 01:42:24 DEBUG : one: Destination found in --copy-dest, using server-side copy 2026/11/03 01:42:26 DEBUG : CopyDest/two: md5 = 622acefc3a93f25bab1d85c09567d90e OK 2026/11/03 01:42:27 DEBUG : two: Need to transfer - File not found at Destination 2026/11/03 01:42:27 DEBUG : two: size = 3 OK 2026/11/03 01:42:27 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2026/11/03 01:42:28 DEBUG : two: size = 3 OK 2026/11/03 01:42:28 INFO : two: Copied (server-side copy) 2026/11/03 01:42:28 DEBUG : two: Destination found in --copy-dest, using server-side copy 2026/11/03 01:42:29 DEBUG : two: size = 3 OK 2026/11/03 01:42:29 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2026/11/03 01:42:29 DEBUG : two: Unchanged skipping 2026/11/03 01:42:31 DEBUG : CopyDest/three: md5 = 0187171119dad562e7a73a18550eb471 OK 2026/11/03 01:42:32 DEBUG : three: Need to transfer - File not found at Destination 2026/11/03 01:42:32 DEBUG : three: size = 7 (Local file system at /tmp/rclone878498292) 2026/11/03 01:42:32 DEBUG : three: size = 5 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga/CopyDest') 2026/11/03 01:42:32 DEBUG : three: Sizes differ 2026/11/03 01:42:32 DEBUG : three: Destination not found in --copy-dest 2026/11/03 01:42:33 DEBUG : three: md5 = 918a562f1fabd5878f90933ba964d969 OK 2026/11/03 01:42:33 DEBUG : three: size = 7 OK 2026/11/03 01:42:33 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (33.96s) === RUN TestCopyInplace run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" copy_test.go:434: Partial uploads not supported --- SKIP: TestCopyInplace (0.52s) === RUN TestCopyLongFileName run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" copy_test.go:467: Partial uploads not supported --- SKIP: TestCopyLongFileName (0.46s) === RUN TestCopyLongFileNameCollision run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" copy_test.go:500: Partial uploads not supported --- SKIP: TestCopyLongFileNameCollision (0.47s) === RUN TestCopyFileMaxTransfer run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:42:42 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2026/11/03 01:42:44 DEBUG : TestCopyFileMaxTransfer/file1: md5 = bd956e4d6b45f7744efda3a69116aa54 OK 2026/11/03 01:42:44 DEBUG : TestCopyFileMaxTransfer/file1: size = 14 OK 2026/11/03 01:42:44 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2026/11/03 01:42:44 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2026/11/03 01:42:45 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Post "https://www.googleapis.com/upload/drive/v3/files?alt=json&fields=id%2Cname%2Csize%2Cmd5Checksum%2Csha1Checksum%2Csha256Checksum%2Ctrashed%2CexplicitlyTrashed%2CmodifiedTime%2CcreatedTime%2CmimeType%2Cparents%2CwebViewLink%2CshortcutDetails%2CexportLinks%2CresourceKey&keepRevisionForever=false&prettyPrint=false&supportsAllDrives=true&uploadType=multipart": googleapi: Copy failed: max transfer limit reached as set by --max-transfer copy_test.go:563: Expecting error to contain accounting.ErrorMaxTransferLimitReachedFatal 2026/11/03 01:42:46 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination 2026/11/03 01:42:46 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination 2026/11/03 01:42:48 DEBUG : TestCopyFileMaxTransfer/file4: md5 = 819fce7d3bd87d9d138b9bae7adfde55 OK 2026/11/03 01:42:48 DEBUG : TestCopyFileMaxTransfer/file4: size = 2062 OK 2026/11/03 01:42:48 INFO : TestCopyFileMaxTransfer/file4: Copied (new) --- PASS: TestCopyFileMaxTransfer (9.38s) === RUN TestDeduplicateInteractive run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" dedupe_test.go:37: Can't run this test without a hash --- SKIP: TestDeduplicateInteractive (0.42s) === RUN TestDeduplicateSkip run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:42:54 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using skip mode. 2026/11/03 01:42:54 NOTICE: one: Found 2 files with duplicate names 2026/11/03 01:42:54 NOTICE: one: Skipping 2 files with duplicate names --- PASS: TestDeduplicateSkip (4.63s) === RUN TestDeduplicateSizeOnly run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:00 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using skip mode. 2026/11/03 01:43:00 NOTICE: one: Found 3 files with duplicate names 2026/11/03 01:43:00 NOTICE: one: Deleting 1/2 identical duplicates (size 11) 2026/11/03 01:43:01 INFO : one: Deleted 2026/11/03 01:43:01 NOTICE: one: Skipping 2 files with duplicate names --- PASS: TestDeduplicateSizeOnly (6.34s) === RUN TestDeduplicateFirst run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:06 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using first mode. 2026/11/03 01:43:07 NOTICE: one: Found 3 files with duplicate names 2026/11/03 01:43:07 INFO : one: Deleted 2026/11/03 01:43:08 INFO : one: Deleted 2026/11/03 01:43:08 NOTICE: one: Deleted 2 extra copies --- PASS: TestDeduplicateFirst (6.52s) === RUN TestDeduplicateNewest run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:12 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using newest mode. 2026/11/03 01:43:13 NOTICE: one: Found 3 files with duplicate names 2026/11/03 01:43:13 INFO : one: Deleted 2026/11/03 01:43:14 INFO : one: Deleted 2026/11/03 01:43:14 NOTICE: one: Deleted 2 extra copies --- PASS: TestDeduplicateNewest (6.35s) === RUN TestDeduplicateNewestByHash run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" dedupe_test.go:37: Can't run this test without a hash --- SKIP: TestDeduplicateNewestByHash (0.40s) === RUN TestDeduplicateOldest run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:19 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using oldest mode. 2026/11/03 01:43:20 NOTICE: one: Found 3 files with duplicate names 2026/11/03 01:43:20 INFO : one: Deleted 2026/11/03 01:43:21 INFO : one: Deleted 2026/11/03 01:43:21 NOTICE: one: Deleted 2 extra copies --- PASS: TestDeduplicateOldest (6.72s) === RUN TestDeduplicateLargest run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:26 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using largest mode. 2026/11/03 01:43:27 NOTICE: one: Found 3 files with duplicate names 2026/11/03 01:43:27 INFO : one: Deleted 2026/11/03 01:43:28 INFO : one: Deleted 2026/11/03 01:43:28 NOTICE: one: Deleted 2 extra copies --- PASS: TestDeduplicateLargest (6.68s) === RUN TestDeduplicateSmallest run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:33 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using smallest mode. 2026/11/03 01:43:33 NOTICE: one: Found 3 files with duplicate names 2026/11/03 01:43:34 INFO : one: Deleted 2026/11/03 01:43:34 INFO : one: Deleted 2026/11/03 01:43:34 NOTICE: one: Deleted 2 extra copies --- PASS: TestDeduplicateSmallest (6.47s) === RUN TestDeduplicateRename run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:40 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using rename mode. 2026/11/03 01:43:41 NOTICE: one.txt: Found 3 files with duplicate names 2026/11/03 01:43:41 INFO : one-2.txt: renamed from: one.txt 2026/11/03 01:43:43 INFO : one-3.txt: renamed from: one.txt 2026/11/03 01:43:43 INFO : one-4.txt: renamed from: one.txt --- PASS: TestDeduplicateRename (10.94s) === RUN TestDeduplicateRenameManyExisting run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:43:48 DEBUG : one-1.txt: md5 = f9021be202f2334d827256a41d88fb34 OK 2026/11/03 01:43:49 DEBUG : one-2.txt: md5 = 06b67b21a668c32894a1ed4a5bb7f476 OK 2026/11/03 01:43:51 DEBUG : one-3.txt: md5 = afba4156abaee5f046df44bf77e49798 OK 2026/11/03 01:43:52 DEBUG : one-4.txt: md5 = 8ba6f8532cf31012d535df5c51818329 OK 2026/11/03 01:43:54 DEBUG : one-5.txt: md5 = b7939074820d997d73a16597b2dbc14f OK 2026/11/03 01:43:55 DEBUG : one-6.txt: md5 = f02d310b798317be65cfc7f42ef8d7a7 OK 2026/11/03 01:43:56 DEBUG : one-7.txt: md5 = 520d1806ed6512fa9b6711e15455eca3 OK 2026/11/03 01:43:58 DEBUG : one-8.txt: md5 = 5be21248866a14a77036c7698cb502a4 OK 2026/11/03 01:43:59 DEBUG : one-9.txt: md5 = e495dccf0ca275fc4e924ce31e63f66d OK 2026/11/03 01:44:01 DEBUG : one-10.txt: md5 = 31e0f53409464fcbfe817cf89bc96349 OK 2026/11/03 01:44:02 DEBUG : one-11.txt: md5 = deec16dc05c6ec0e80e23ec65f6e8ad4 OK 2026/11/03 01:44:04 DEBUG : one-12.txt: md5 = 9bd3ea9b48031c6b3428bc5c7e8441fc OK 2026/11/03 01:44:05 DEBUG : one-13.txt: md5 = 5cfc0c400313c60292e1abf1cee65eef OK 2026/11/03 01:44:06 DEBUG : one-14.txt: md5 = 292f463bbdb517f951cc80e29ed845b9 OK 2026/11/03 01:44:08 DEBUG : one-15.txt: md5 = 1d3afec3726fbfe30344ea6631fc82a6 OK 2026/11/03 01:44:09 DEBUG : one-16.txt: md5 = e0ee976e4c87962b79473b1422d5279c OK 2026/11/03 01:44:11 DEBUG : one-17.txt: md5 = 1385bc5f28fa01263ad655a5a3aee962 OK 2026/11/03 01:44:12 DEBUG : one-18.txt: md5 = 7480a732e6ffc10ad4b1760c23d2c0df OK 2026/11/03 01:44:13 DEBUG : one-19.txt: md5 = 8a28f620d5993317595de5307149a612 OK 2026/11/03 01:44:15 DEBUG : one-20.txt: md5 = 897768999b8d04fabf85e6952a684c4a OK 2026/11/03 01:44:16 DEBUG : one-21.txt: md5 = 637cbb23acee7a0f6ab1a928bf672676 OK 2026/11/03 01:44:18 DEBUG : one-22.txt: md5 = b2edf46870b1048650cf266eb781c75f OK 2026/11/03 01:44:19 DEBUG : one-23.txt: md5 = e7ab77446adfdd1a4d4a52a0dbed9ace OK 2026/11/03 01:44:21 DEBUG : one-24.txt: md5 = c87eb5a56376b2921ae8b518af38ee7e OK 2026/11/03 01:44:22 DEBUG : one-25.txt: md5 = 4b42ef9edd0bbf5506f0e0a64fbf5574 OK 2026/11/03 01:44:24 DEBUG : one-26.txt: md5 = 706014ef995f986b7b61ab76691076a2 OK 2026/11/03 01:44:25 DEBUG : one-27.txt: md5 = 03c14e9eabcd010069408c880bcd62dd OK 2026/11/03 01:44:26 DEBUG : one-28.txt: md5 = b3d70d10bca114d58296bb5b6d624b35 OK 2026/11/03 01:44:28 DEBUG : one-29.txt: md5 = 4c4c87d3840a6f422437a117b6800aba OK 2026/11/03 01:44:29 DEBUG : one-30.txt: md5 = 0daf8f42e6347833c9468974fb5a7eb6 OK 2026/11/03 01:44:31 DEBUG : one-31.txt: md5 = 6c3b2db1d49e7e1b0c50b2c8221af035 OK 2026/11/03 01:44:32 DEBUG : one-32.txt: md5 = d8540a9fe70fa65f9b41bff0c0f4b871 OK 2026/11/03 01:44:34 DEBUG : one-33.txt: md5 = 610ea791ed9bcc8025fb004685fb33b3 OK 2026/11/03 01:44:35 DEBUG : one-34.txt: md5 = 3b6f73dc2f47bd10f2745b08c361a341 OK 2026/11/03 01:44:37 DEBUG : one-35.txt: md5 = e5a7d4fb2e328b18c3bcb9b04275e9b6 OK 2026/11/03 01:44:38 DEBUG : one-36.txt: md5 = 8006a99823c4fdbc62821cdeb8bd2a55 OK 2026/11/03 01:44:40 DEBUG : one-37.txt: md5 = 12ee84888125056a3604cbffe58eaf91 OK 2026/11/03 01:44:41 DEBUG : one-38.txt: md5 = cf571fe64a706e4271522dc4a633d55a OK 2026/11/03 01:44:43 DEBUG : one-39.txt: md5 = 1831ab9f2791d5b6b7a4d4a03b1c191b OK 2026/11/03 01:44:44 DEBUG : one-40.txt: md5 = 599cc69498a4d25fc037541388714e05 OK 2026/11/03 01:44:45 DEBUG : one-41.txt: md5 = 56d0a944f926cdc7ef6930d08b40e373 OK 2026/11/03 01:44:47 DEBUG : one-42.txt: md5 = 954b36637fae9909ec39f2738e1c1c16 OK 2026/11/03 01:44:48 DEBUG : one-43.txt: md5 = d7bb2fe45b4eded86f9a2e97637599ea OK 2026/11/03 01:44:50 DEBUG : one-44.txt: md5 = b1db9c230e37a16609e6e7f861d555d7 OK 2026/11/03 01:44:51 DEBUG : one-45.txt: md5 = 044a0e1f34d2934c9a3a9278f69151be OK 2026/11/03 01:44:53 DEBUG : one-46.txt: md5 = 8c7013304abeb6eaad44dfd02092fc49 OK 2026/11/03 01:44:54 DEBUG : one-47.txt: md5 = feb97a0975fd453c0949ba293db6c2a9 OK 2026/11/03 01:44:56 DEBUG : one-48.txt: md5 = e1ce097cc51a5d276deb13512d40d6c4 OK 2026/11/03 01:44:57 DEBUG : one-49.txt: md5 = 354c117b62b08b782e98ad94e7e27bb0 OK 2026/11/03 01:44:58 DEBUG : one-50.txt: md5 = b33341171e4d7929fbf55ff2d2934934 OK 2026/11/03 01:45:00 DEBUG : one-51.txt: md5 = 6c08cd1b70b6c78334da99a75c21be64 OK 2026/11/03 01:45:01 DEBUG : one-52.txt: md5 = 1e8cd6e6af885367393daf8e331e2789 OK 2026/11/03 01:45:03 DEBUG : one-53.txt: md5 = 1236d787f755d5cc6b635ccf41810e74 OK 2026/11/03 01:45:04 DEBUG : one-54.txt: md5 = 7381f5e3bdf424f012f22d115695155f OK 2026/11/03 01:45:06 DEBUG : one-55.txt: md5 = 546956b7c82d51f87376402fc374d725 OK 2026/11/03 01:45:07 DEBUG : one-56.txt: md5 = fd2d94d97a60b1f4f8d970ce4810081a OK 2026/11/03 01:45:09 DEBUG : one-57.txt: md5 = 75ccdc67c1ed35576232a63a3a6540f0 OK 2026/11/03 01:45:10 DEBUG : one-58.txt: md5 = 4f8b174669ee677d479ddef577c610fc OK 2026/11/03 01:45:12 DEBUG : one-59.txt: md5 = 62b5c98fd3603091da05168ae9e5aaf1 OK 2026/11/03 01:45:14 DEBUG : one-60.txt: md5 = 5b251a79d8c098d7629055f57a9b942a OK 2026/11/03 01:45:15 DEBUG : one-61.txt: md5 = d271eff146e87696ee0764f01aafefa0 OK 2026/11/03 01:45:17 DEBUG : one-62.txt: md5 = 9cccf35c73a9255704a7548dfc901295 OK 2026/11/03 01:45:18 DEBUG : one-63.txt: md5 = 70c3e8471bec7f510bf5facf907b2a35 OK 2026/11/03 01:45:20 DEBUG : one-64.txt: md5 = 0e8d032167bf421396fdf851c5a096ff OK 2026/11/03 01:45:21 DEBUG : one-65.txt: md5 = 3961b800a438367642931d64f062cbf0 OK 2026/11/03 01:45:23 DEBUG : one-66.txt: md5 = 3b484770ea39905166f477d0f77de449 OK 2026/11/03 01:45:24 DEBUG : one-67.txt: md5 = 860291a50922ae952bc5a83c862c487f OK 2026/11/03 01:45:25 DEBUG : one-68.txt: md5 = d4ab4d955d4ef4330b6b71a5408d74d3 OK 2026/11/03 01:45:27 DEBUG : one-69.txt: md5 = 3fa80f4d61fec411802acf9c9cc9d5d0 OK 2026/11/03 01:45:28 DEBUG : one-70.txt: md5 = c9d744861c09d0784e357e88cc20cadd OK 2026/11/03 01:45:30 DEBUG : one-71.txt: md5 = 20e67c8ad5818ac8f57284b602e60556 OK 2026/11/03 01:45:31 DEBUG : one-72.txt: md5 = a47da704b1a45dd39ca9b28642f43756 OK 2026/11/03 01:45:33 DEBUG : one-73.txt: md5 = 9a4853db366788e4972bc43aba5ce393 OK 2026/11/03 01:45:34 DEBUG : one-74.txt: md5 = 26ce1fd77870c718aca58c184545bd2a OK 2026/11/03 01:45:36 DEBUG : one-75.txt: md5 = 7306c69a2603e305ad57bff10483ea0f OK 2026/11/03 01:45:37 DEBUG : one-76.txt: md5 = 0edee208bd75d05e71a124fd378db1e5 OK 2026/11/03 01:45:39 DEBUG : one-77.txt: md5 = 9c1fc53688b5f7f81f190f992c4802cb OK 2026/11/03 01:45:40 DEBUG : one-78.txt: md5 = 8fadf5eca8b66bc4295f2be89c79fc74 OK 2026/11/03 01:45:42 DEBUG : one-79.txt: md5 = 2488fc19a8784f5818dbe73257bd942f OK 2026/11/03 01:45:43 DEBUG : one-80.txt: md5 = 4ca931be063434b61a341ad7f02f7224 OK 2026/11/03 01:45:45 DEBUG : one-81.txt: md5 = d32fc95b02b3bc4571abe1c5dfd435d1 OK 2026/11/03 01:45:46 DEBUG : one-82.txt: md5 = 810aa79074664f4310653438fe67a3ff OK 2026/11/03 01:45:48 DEBUG : one-83.txt: md5 = 71b555c3e55b19ff79da7951fa5d0391 OK 2026/11/03 01:45:49 DEBUG : one-84.txt: md5 = 3f6d1d010b990887cc6bf2f6c8e7cbe1 OK 2026/11/03 01:45:51 DEBUG : one-85.txt: md5 = a809fff53c42d6090525904e78e1dab8 OK 2026/11/03 01:45:52 DEBUG : one-86.txt: md5 = f6bbcd952be26ef9ef3186a0bbd1e30a OK 2026/11/03 01:45:54 DEBUG : one-87.txt: md5 = e9577e3f4d283e6deb3a4fddeb0e1764 OK 2026/11/03 01:45:55 DEBUG : one-88.txt: md5 = 9e7b964661a5a53b5a0f9c9cb5445469 OK 2026/11/03 01:45:57 DEBUG : one-89.txt: md5 = 7064fcf0f40d6f73b2f9f188b3dddc47 OK 2026/11/03 01:45:58 DEBUG : one-90.txt: md5 = 73629d95ee741b1344202d13f40e86c5 OK 2026/11/03 01:46:00 DEBUG : one-91.txt: md5 = 4ec7b854cc60e6cac2eb804d430f097e OK 2026/11/03 01:46:01 DEBUG : one-92.txt: md5 = adf86607ee3d97de163c2b1f2257f6ee OK 2026/11/03 01:46:02 DEBUG : one-93.txt: md5 = e8f214b359581af0eb978ff042d65e1f OK 2026/11/03 01:46:04 DEBUG : one-94.txt: md5 = 45e8a2b0b48879e7cc51319bf75cede5 OK 2026/11/03 01:46:05 DEBUG : one-95.txt: md5 = 8323824a85eff2a7214ba1360e924a9d OK 2026/11/03 01:46:07 DEBUG : one-96.txt: md5 = 4dedc6476638268e8cee0bbaa4ed05b2 OK 2026/11/03 01:46:09 DEBUG : one-97.txt: md5 = 2f4282b68558f3a23d5c4c4269808973 OK 2026/11/03 01:46:10 DEBUG : one-98.txt: md5 = 1177c1f0227ae9f2148dca1592b871a1 OK 2026/11/03 01:46:11 DEBUG : one-99.txt: md5 = 6fa7666c6238bfcc46715a4ab87c6d77 OK 2026/11/03 01:46:13 DEBUG : one-100.txt: md5 = a38956982a2eb78ddf573987db7ebccb OK 2026/11/03 01:46:14 DEBUG : one-101.txt: md5 = 7753381ea7f307f336f74bddc5981839 OK 2026/11/03 01:46:16 DEBUG : one-102.txt: md5 = 0c17ecb4098d0b95c364fcd72de57de2 OK 2026/11/03 01:46:17 DEBUG : one-103.txt: md5 = 32cd517da1ca1c51c7edaceff2e33f0f OK 2026/11/03 01:46:19 DEBUG : one-104.txt: md5 = bf3e6352ac6a86d9d266ae67dcff5cee OK 2026/11/03 01:46:20 DEBUG : one-105.txt: md5 = f305fc135b155567dd8583da91e55ed9 OK 2026/11/03 01:46:23 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Looking for duplicate names using rename mode. 2026/11/03 01:46:24 NOTICE: one.txt: Found 2 files with duplicate names 2026/11/03 01:46:24 INFO : one-106.txt: renamed from: one.txt 2026/11/03 01:46:25 INFO : one-107.txt: renamed from: one.txt --- PASS: TestDeduplicateRenameManyExisting (210.22s) === RUN TestMergeDirs run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:47:19 DEBUG : dupe1/one.txt: md5 = dde2d952de66906a185dc6c36fd8a149 OK 2026/11/03 01:47:21 DEBUG : dupe2/two.txt: md5 = 9681cc3b787e3b04d983eb4ef1bd75d6 OK 2026/11/03 01:47:23 DEBUG : dupe3/three.txt: md5 = 57e1ae4afe5fa56c469884fa6de14477 OK 2026/11/03 01:47:24 INFO : urj8gsducqbtvekeq181ntd2u8: merging "sfrom47189m9qr3mt4qonu281c" 2026/11/03 01:47:25 INFO : urj8gsducqbtvekeq181ntd2u8: removing empty directory 2026/11/03 01:47:26 INFO : 1u1r4ei7c628fnjg9blqt3j60o: merging "tr2hj63d80ftlmvm6a952snjcc" 2026/11/03 01:47:26 INFO : 1u1r4ei7c628fnjg9blqt3j60o: removing empty directory --- PASS: TestMergeDirs (13.80s) === RUN TestIndex run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:47:32 DEBUG : file1.txt: md5 = cbcf8fd674d7b8f6fb46827a00e10db4 OK 2026/11/03 01:47:34 DEBUG : sub/file2.txt: md5 = 02e9b451a1e679d6a36c08166c398f1f OK 2026/11/03 01:47:36 DEBUG : sub/deep/file3.txt: md5 = f7f54d2734eaa118c28b174b9ac9f7fa OK 2026/11/03 01:47:38 DEBUG : index.html: md5 = dca5a885ed77a761b0ad1c9dd0af0676 OK 2026/11/03 01:47:38 DEBUG : index.html: size = 12147 OK 2026/11/03 01:47:38 INFO : index.html: Copied (new) 2026/11/03 01:47:38 DEBUG : sub/deep/index.html: md5 = 91b200c5a89b3565b02e32414009bffb OK 2026/11/03 01:47:38 DEBUG : sub/deep/index.html: size = 12087 OK 2026/11/03 01:47:38 INFO : sub/deep/index.html: Copied (new) 2026/11/03 01:47:38 DEBUG : caddy.json: md5 = 7ddc23b8c390b9f294bf9b0ee7ac9b3a OK 2026/11/03 01:47:38 DEBUG : caddy.json: size = 259 OK 2026/11/03 01:47:38 INFO : caddy.json: Copied (new) 2026/11/03 01:47:38 DEBUG : index.json: md5 = 5ac2ee2cf64ad8236ee03a36c08d9fc0 OK 2026/11/03 01:47:38 DEBUG : index.json: size = 213 OK 2026/11/03 01:47:38 INFO : index.json: Copied (new) 2026/11/03 01:47:39 DEBUG : sub/deep/index.json: md5 = e308866f7c64bdba1a4df126d5938e6a OK 2026/11/03 01:47:39 DEBUG : sub/deep/index.json: size = 119 OK 2026/11/03 01:47:39 INFO : sub/deep/index.json: Copied (new) 2026/11/03 01:47:39 DEBUG : sub/index.html: md5 = e36a113cc22206ba074d36218fd5e7d6 OK 2026/11/03 01:47:39 DEBUG : sub/index.html: size = 12306 OK 2026/11/03 01:47:39 INFO : sub/index.html: Copied (new) 2026/11/03 01:47:39 DEBUG : sub/deep/caddy.json: md5 = e66ae5ff35cf75bc3c52b1f45d2c2741 OK 2026/11/03 01:47:39 DEBUG : sub/deep/caddy.json: size = 131 OK 2026/11/03 01:47:39 INFO : sub/deep/caddy.json: Copied (new) 2026/11/03 01:47:39 DEBUG : sub/index.json: md5 = 4768c6f7c8022c2c2c30770290ad419b OK 2026/11/03 01:47:39 DEBUG : sub/index.json: size = 215 OK 2026/11/03 01:47:39 INFO : sub/index.json: Copied (new) 2026/11/03 01:47:41 DEBUG : sub/caddy.json: md5 = 17c157177a0c7a7f7990471ee48072f4 OK 2026/11/03 01:47:41 DEBUG : sub/caddy.json: size = 261 OK 2026/11/03 01:47:41 INFO : sub/caddy.json: Copied (new) 2026/11/03 01:47:47 DEBUG : index.html: Unchanged skipping 2026/11/03 01:47:47 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:47:47 DEBUG : sub/deep/index.html: Unchanged skipping 2026/11/03 01:47:48 DEBUG : index.json: Unchanged skipping 2026/11/03 01:47:48 DEBUG : sub/index.json: Unchanged skipping 2026/11/03 01:47:48 DEBUG : sub/deep/index.json: Unchanged skipping 2026/11/03 01:47:48 DEBUG : caddy.json: Unchanged skipping 2026/11/03 01:47:48 DEBUG : sub/caddy.json: Unchanged skipping 2026/11/03 01:47:48 DEBUG : sub/deep/caddy.json: Unchanged skipping 2026/11/03 01:47:50 DEBUG : sub/deep/index.html: md5 = 60e88f6f84438d3def4088c83438e650 OK 2026/11/03 01:47:50 DEBUG : sub/deep/index.html: size = 12087 OK 2026/11/03 01:47:50 INFO : sub/deep/index.html: Copied (replaced existing) 2026/11/03 01:47:50 DEBUG : caddy.json: md5 = 854b97b038ab0de72566c787447e9391 OK 2026/11/03 01:47:50 DEBUG : caddy.json: size = 259 OK 2026/11/03 01:47:50 INFO : caddy.json: Copied (replaced existing) 2026/11/03 01:47:51 DEBUG : index.html: md5 = 47220015d49eda20b7b1ad03a8c7e333 OK 2026/11/03 01:47:51 DEBUG : index.html: size = 12147 OK 2026/11/03 01:47:51 INFO : index.html: Copied (replaced existing) 2026/11/03 01:47:51 DEBUG : index.json: md5 = 6c152d66b810be851e0c42d5447acced OK 2026/11/03 01:47:51 DEBUG : index.json: size = 213 OK 2026/11/03 01:47:51 INFO : index.json: Copied (replaced existing) 2026/11/03 01:47:52 DEBUG : sub/deep/index.json: md5 = 155d06dd0c435852ae5e6dede4fd953c OK 2026/11/03 01:47:52 DEBUG : sub/deep/index.json: size = 119 OK 2026/11/03 01:47:52 INFO : sub/deep/index.json: Copied (replaced existing) 2026/11/03 01:47:52 DEBUG : sub/deep/caddy.json: md5 = 84f28f5c7db5083f5a18da3dda50da2b OK 2026/11/03 01:47:52 DEBUG : sub/deep/caddy.json: size = 131 OK 2026/11/03 01:47:52 INFO : sub/deep/caddy.json: Copied (replaced existing) 2026/11/03 01:47:52 DEBUG : sub/index.html: md5 = f2e19e9e5a01581e4202182953da09f2 OK 2026/11/03 01:47:52 DEBUG : sub/index.html: size = 12306 OK 2026/11/03 01:47:52 INFO : sub/index.html: Copied (replaced existing) 2026/11/03 01:47:52 DEBUG : sub/index.json: md5 = e7402016d424973335838501cf08fbe5 OK 2026/11/03 01:47:52 DEBUG : sub/index.json: size = 215 OK 2026/11/03 01:47:52 INFO : sub/index.json: Copied (replaced existing) 2026/11/03 01:47:53 DEBUG : sub/caddy.json: md5 = 06122b75fa11e4f0b75be5b3472a04ae OK 2026/11/03 01:47:53 DEBUG : sub/caddy.json: size = 261 OK 2026/11/03 01:47:53 INFO : sub/caddy.json: Copied (replaced existing) 2026/11/03 01:47:54 DEBUG : sub/deep/file4.txt: md5 = d5f66472d25fd9bc2a1d7b55390ebf3e OK 2026/11/03 01:47:56 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:47:56 DEBUG : index.html: Unchanged skipping 2026/11/03 01:47:56 DEBUG : sub/deep/index.html: md5 = 3216d2a45436603eb30d1559678b1eb3 OK 2026/11/03 01:47:56 DEBUG : sub/deep/index.html: size = 12346 OK 2026/11/03 01:47:56 INFO : sub/deep/index.html: Copied (replaced existing) 2026/11/03 01:47:56 DEBUG : sub/deep/index.json: md5 = b4c19f87454a2b18685ce41055027573 OK 2026/11/03 01:47:56 DEBUG : sub/deep/index.json: size = 235 OK 2026/11/03 01:47:56 INFO : sub/deep/index.json: Copied (replaced existing) 2026/11/03 01:47:56 DEBUG : sub/index.json: Unchanged skipping 2026/11/03 01:47:56 DEBUG : sub/deep/caddy.json: md5 = 0c18a2d86b782b2da06c819f0b2af97f OK 2026/11/03 01:47:56 DEBUG : sub/deep/caddy.json: size = 260 OK 2026/11/03 01:47:56 INFO : sub/deep/caddy.json: Copied (replaced existing) 2026/11/03 01:47:56 DEBUG : index.json: Unchanged skipping 2026/11/03 01:47:57 DEBUG : sub/caddy.json: Unchanged skipping 2026/11/03 01:47:57 DEBUG : caddy.json: Unchanged skipping 2026/11/03 01:47:59 DEBUG : sub/deep/file5.txt: md5 = 88741442776c0f05a9fea16f99a895f8 OK 2026/11/03 01:48:00 NOTICE: sub/deep/caddy.json: Skipped copy as --dry-run is set (size 389) 2026/11/03 01:48:00 NOTICE: sub/deep/index.html: Skipped copy as --dry-run is set (size 12.309Ki) 2026/11/03 01:48:00 NOTICE: sub/deep/index.json: Skipped copy as --dry-run is set (size 351) 2026/11/03 01:48:01 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:48:01 DEBUG : index.html: Unchanged skipping 2026/11/03 01:48:01 DEBUG : sub/index.json: Unchanged skipping 2026/11/03 01:48:01 DEBUG : index.json: Unchanged skipping 2026/11/03 01:48:02 DEBUG : sub/caddy.json: Unchanged skipping 2026/11/03 01:48:02 DEBUG : caddy.json: Unchanged skipping --- PASS: TestIndex (41.01s) === RUN TestIndexDelete run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:48:13 DEBUG : file1.txt: md5 = ad12e55eee1e3891288577b27ef2e472 OK 2026/11/03 01:48:15 DEBUG : sub/file2.txt: md5 = 539514598ab541874c3e6d0274980ca5 OK 2026/11/03 01:48:17 DEBUG : sub/deep/file3.txt: md5 = 991568fddea31d5ac6fcfda71014472a OK 2026/11/03 01:48:19 DEBUG : sub/index.html: md5 = b1f6c8afeedb47344a5bdcc6333a9d07 OK 2026/11/03 01:48:19 DEBUG : sub/index.html: size = 12306 OK 2026/11/03 01:48:19 INFO : sub/index.html: Copied (new) 2026/11/03 01:48:19 DEBUG : sub/deep/index.html: md5 = d89aa52e18428364fcc5c32ef60d48fe OK 2026/11/03 01:48:19 DEBUG : sub/deep/index.html: size = 12087 OK 2026/11/03 01:48:19 INFO : sub/deep/index.html: Copied (new) 2026/11/03 01:48:19 DEBUG : index.html: md5 = 810600b52eaf54075735f1015605dba3 OK 2026/11/03 01:48:19 DEBUG : index.html: size = 12147 OK 2026/11/03 01:48:19 INFO : index.html: Copied (new) 2026/11/03 01:48:21 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:48:21 DEBUG : index.html: Unchanged skipping 2026/11/03 01:48:22 DEBUG : sub/deep/index.html: md5 = 185a2adbd8bc795430707519bbf837a7 OK 2026/11/03 01:48:22 DEBUG : sub/deep/index.html: size = 11829 OK 2026/11/03 01:48:22 INFO : sub/deep/index.html: Copied (replaced existing) --- PASS: TestIndexDelete (17.87s) === RUN TestIndexFilter run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:48:31 DEBUG : file1.txt: md5 = 81f979eb13b21c65a41fb007aa138bde OK 2026/11/03 01:48:33 DEBUG : sub/file2.txt: md5 = d6765dd79cd6d54a90a06886e4eac556 OK 2026/11/03 01:48:35 DEBUG : sub/deep/file3.txt: md5 = 14f6798b6d56ee023affe794a4816728 OK 2026/11/03 01:48:36 DEBUG : sub/deep/index.html: md5 = f7717d8345a6b3c4f11b76d453c644d4 OK 2026/11/03 01:48:39 DEBUG : other/notes.md: md5 = afd214db04c3bd15089728d27c3ebfb5 OK 2026/11/03 01:48:39 DEBUG : other/notes.md: Excluded (Path Filter) 2026/11/03 01:48:41 DEBUG : other/index.html: md5 = 8b5bb0aaeffb6b88ce73cb08ed8ea493 OK 2026/11/03 01:48:41 DEBUG : other/index.html: size = 11802 OK 2026/11/03 01:48:41 INFO : other/index.html: Copied (new) 2026/11/03 01:48:41 DEBUG : index.html: md5 = a315a7831321475050e2069f17f8d7d8 OK 2026/11/03 01:48:41 DEBUG : index.html: size = 12399 OK 2026/11/03 01:48:41 INFO : index.html: Copied (new) 2026/11/03 01:48:41 DEBUG : sub/index.html: md5 = bff2386856d065606a15ef5dc5e3c067 OK 2026/11/03 01:48:41 DEBUG : sub/index.html: size = 12056 OK 2026/11/03 01:48:41 INFO : sub/index.html: Copied (new) 2026/11/03 01:48:46 DEBUG : other/notes.md: Excluded (Path Filter) 2026/11/03 01:48:47 DEBUG : index.html: Unchanged skipping 2026/11/03 01:48:47 DEBUG : other/index.html: Unchanged skipping 2026/11/03 01:48:47 DEBUG : sub/index.html: Unchanged skipping --- PASS: TestIndexFilter (24.33s) === RUN TestIndexRules run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:48:55 DEBUG : file1.txt: md5 = 324f6cf24c49c15c0dd0200e00b8313a OK 2026/11/03 01:48:57 DEBUG : sub/file2.txt: md5 = d222a9f024927597a422fd6b723302cb OK 2026/11/03 01:48:59 DEBUG : sub/deep/file3.txt: md5 = c33ce60e6e983cb90a01d345f613cf69 OK 2026/11/03 01:49:01 DEBUG : sub/deep/index.html: md5 = e16382501a1e3615f890c47849b6a830 OK 2026/11/03 01:49:03 DEBUG : sub/index.html: md5 = 1c67caa49d5b66d6bb0bf0bff3f2e1ef OK 2026/11/03 01:49:03 DEBUG : sub/index.html: size = 12306 OK 2026/11/03 01:49:03 INFO : sub/index.html: Copied (new) 2026/11/03 01:49:03 DEBUG : index.html: md5 = f7793a8a87afcc3708e6741e71f8aad5 OK 2026/11/03 01:49:03 DEBUG : index.html: size = 12147 OK 2026/11/03 01:49:03 INFO : index.html: Copied (new) 2026/11/03 01:49:07 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:49:08 DEBUG : sub/deep/index.html: md5 = 12bb5ec7bb3d950c682a9b86240abfab OK 2026/11/03 01:49:08 DEBUG : sub/deep/index.html: size = 12087 OK 2026/11/03 01:49:08 INFO : sub/deep/index.html: Copied (replaced existing) --- PASS: TestIndexRules (21.02s) === RUN TestIndexMaxDepth run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:49:16 DEBUG : file1.txt: md5 = cd9a56c05f857b1fc7954a6c240edb50 OK 2026/11/03 01:49:19 DEBUG : sub/file2.txt: md5 = 96c01be29571391d8c057143f161cd8f OK 2026/11/03 01:49:21 DEBUG : sub/deep/file3.txt: md5 = 255c0344abef0f3805442ff3b7442a16 OK 2026/11/03 01:49:23 DEBUG : index.html: md5 = ff6e3bf1f82f682802993c2198b1e0bf OK 2026/11/03 01:49:23 DEBUG : index.html: size = 12147 OK 2026/11/03 01:49:23 INFO : index.html: Copied (new) --- PASS: TestIndexMaxDepth (14.30s) === RUN TestIndexLinkIndex run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:49:30 DEBUG : file1.txt: md5 = 413266a26a1f5da7b5ba3959a62fc157 OK 2026/11/03 01:49:32 DEBUG : sub/file2.txt: md5 = 4781f9e2310a7369ba736a0e0dacd225 OK 2026/11/03 01:49:35 DEBUG : sub/deep/file3.txt: md5 = 3870111155f40d0fc2d89484b2654e4b OK 2026/11/03 01:49:37 DEBUG : index.html: md5 = 6c902716f160d87ea18e0ed332a6435d OK 2026/11/03 01:49:37 DEBUG : index.html: size = 12167 OK 2026/11/03 01:49:37 INFO : index.html: Copied (new) 2026/11/03 01:49:37 DEBUG : sub/deep/index.html: md5 = 3d4b8cf8a029ebbc8fa95e76ccf38869 OK 2026/11/03 01:49:37 DEBUG : sub/deep/index.html: size = 12128 OK 2026/11/03 01:49:37 INFO : sub/deep/index.html: Copied (new) 2026/11/03 01:49:37 DEBUG : sub/index.html: md5 = 261d92557afc234374d0e82f8d0505c8 OK 2026/11/03 01:49:37 DEBUG : sub/index.html: size = 12347 OK 2026/11/03 01:49:37 INFO : sub/index.html: Copied (new) --- PASS: TestIndexLinkIndex (15.04s) === RUN TestIndexDirTime run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:49:45 DEBUG : file1.txt: md5 = 78b417850e7dfac6c21471ee6f592754 OK 2026/11/03 01:49:47 DEBUG : sub/file2.txt: md5 = 0aeeca2951a05c06773ca6882c4506da OK 2026/11/03 01:49:50 DEBUG : sub/deep/file3.txt: md5 = d5fc4598e4dc5cfd73f9fd473868c103 OK 2026/11/03 01:49:52 DEBUG : index.json: md5 = e911f912281e169e77a8290deeaf7f86 OK 2026/11/03 01:49:52 DEBUG : index.json: size = 257 OK 2026/11/03 01:49:52 INFO : index.json: Copied (new) 2026/11/03 01:49:52 DEBUG : sub/index.json: md5 = 63325d25951a2aa1b28bd6f7e728225e OK 2026/11/03 01:49:52 DEBUG : sub/index.json: size = 259 OK 2026/11/03 01:49:52 INFO : sub/index.json: Copied (new) 2026/11/03 01:49:52 DEBUG : sub/deep/index.json: md5 = 9946cea1a15c0b4f728a73dfd2ea244d OK 2026/11/03 01:49:52 DEBUG : sub/deep/index.json: size = 139 OK 2026/11/03 01:49:52 INFO : sub/deep/index.json: Copied (new) 2026/11/03 01:49:55 DEBUG : sub/deep/index.json: Unchanged skipping 2026/11/03 01:49:55 DEBUG : sub/index.json: md5 = dae7dd574121f5c9c399feab395f717b OK 2026/11/03 01:49:55 DEBUG : sub/index.json: size = 239 OK 2026/11/03 01:49:55 INFO : sub/index.json: Copied (replaced existing) 2026/11/03 01:49:55 DEBUG : index.json: md5 = aa4388665cab6ea23fc8c7f13b1a95cb OK 2026/11/03 01:49:55 DEBUG : index.json: size = 237 OK 2026/11/03 01:49:55 INFO : index.json: Copied (replaced existing) 2026/11/03 01:49:58 DEBUG : index.json: md5 = 5f142b9fa2e16c686d1dd05f32b274ed OK 2026/11/03 01:49:58 DEBUG : index.json: size = 213 OK 2026/11/03 01:49:58 INFO : index.json: Copied (replaced existing) 2026/11/03 01:49:58 DEBUG : sub/index.json: md5 = 620849d20009663070e7dcfc965e41fe OK 2026/11/03 01:49:58 DEBUG : sub/index.json: size = 215 OK 2026/11/03 01:49:58 INFO : sub/index.json: Copied (replaced existing) 2026/11/03 01:49:58 DEBUG : sub/deep/index.json: md5 = 95df68a6120c76694c2b86904bf95e64 OK 2026/11/03 01:49:58 DEBUG : sub/deep/index.json: size = 119 OK 2026/11/03 01:49:58 INFO : sub/deep/index.json: Copied (replaced existing) --- PASS: TestIndexDirTime (20.37s) === RUN TestIndexTemplate run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:50:06 DEBUG : file1.txt: md5 = 20b63242098d0e69125fb76c12fb390f OK 2026/11/03 01:50:08 DEBUG : sub/file2.txt: md5 = bbf00d857aa1e1b91d2ce65c09b7cf8b OK 2026/11/03 01:50:11 DEBUG : sub/deep/file3.txt: md5 = 81ef99a0a0bece7acbbcd8f40358112c OK 2026/11/03 01:50:13 DEBUG : sub/list.txt: md5 = 98da62d53c8b445979795a5acd5f857a OK 2026/11/03 01:50:13 DEBUG : sub/list.txt: size = 64 OK 2026/11/03 01:50:13 INFO : sub/list.txt: Copied (new) 2026/11/03 01:50:13 DEBUG : sub/deep/list.txt: md5 = ce19f034cbc1b23211e2d4bb2b5d79a3 OK 2026/11/03 01:50:13 DEBUG : sub/deep/list.txt: size = 47 OK 2026/11/03 01:50:13 INFO : sub/deep/list.txt: Copied (new) 2026/11/03 01:50:13 DEBUG : list.txt: md5 = f05fc9ffddc3294892708defbfd80026 OK 2026/11/03 01:50:13 DEBUG : list.txt: size = 59 OK 2026/11/03 01:50:13 INFO : list.txt: Copied (new) --- PASS: TestIndexTemplate (14.86s) === RUN TestIndexTemplateBuiltin --- PASS: TestIndexTemplateBuiltin (0.00s) === RUN TestRcIndex rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcIndex (0.00s) === RUN TestIndexNoHash index_test.go:385: Skipping test on non local remote --- SKIP: TestIndexNoHash (0.00s) === RUN TestIndexChanged run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:50:20 DEBUG : file1.txt: md5 = a837c193aa3289a3a5a15bdb959442c4 OK 2026/11/03 01:50:23 DEBUG : sub/file2.txt: md5 = 147e214dfe8b674777fce7bfc5f45c68 OK 2026/11/03 01:50:25 DEBUG : sub/deep/file3.txt: md5 = 54b5aeba0d15445b6888923e194509ab OK 2026/11/03 01:50:27 DEBUG : other/notes.md: md5 = b6d162f44c7a91d6dd0328cd19228552 OK 2026/11/03 01:50:30 DEBUG : sub/index.html: md5 = 209be7987aa8f5c42b2a162c1bb51b85 OK 2026/11/03 01:50:30 DEBUG : sub/index.html: size = 12306 OK 2026/11/03 01:50:30 INFO : sub/index.html: Copied (new) 2026/11/03 01:50:30 DEBUG : sub/deep/index.html: md5 = a9e2dd30635e9ab43c7ab7bdc069e978 OK 2026/11/03 01:50:30 DEBUG : sub/deep/index.html: size = 12087 OK 2026/11/03 01:50:30 INFO : sub/deep/index.html: Copied (new) 2026/11/03 01:50:30 DEBUG : index.html: md5 = 56eef7f9a928c0d5163952f7c54f31a8 OK 2026/11/03 01:50:30 DEBUG : index.html: size = 12399 OK 2026/11/03 01:50:30 INFO : index.html: Copied (new) 2026/11/03 01:50:30 DEBUG : other/index.html: md5 = c811993ff6dbcd02390d53a55d37aaad OK 2026/11/03 01:50:30 DEBUG : other/index.html: size = 12058 OK 2026/11/03 01:50:30 INFO : other/index.html: Copied (new) 2026/11/03 01:50:31 DEBUG : sub/deep/file4.txt: md5 = a8ca9584c18d36d11fbcfedb0187c4bf OK 2026/11/03 01:50:33 DEBUG : other/undeclared.txt: md5 = 2d00cdcf92e5e8991cc8114735506d2e OK 2026/11/03 01:50:33 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 3 directories and walking 0 changed directories 2026/11/03 01:50:34 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:50:34 DEBUG : index.html: Unchanged skipping 2026/11/03 01:50:35 DEBUG : sub/deep/index.html: md5 = 65e3c4fe9d07470248202c491eb0b957 OK 2026/11/03 01:50:35 DEBUG : sub/deep/index.html: size = 12346 OK 2026/11/03 01:50:35 INFO : sub/deep/index.html: Copied (replaced existing) 2026/11/03 01:50:39 DEBUG : sub/new/file5.txt: md5 = 64a9876cee66d3d8d1d4171ceb0c5b21 OK 2026/11/03 01:50:39 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 3 directories and walking 0 changed directories 2026/11/03 01:50:40 DEBUG : index.html: Unchanged skipping 2026/11/03 01:50:41 DEBUG : sub/index.html: md5 = 7e8a5c41744e1daaec6f8c6b8621573e OK 2026/11/03 01:50:41 DEBUG : sub/index.html: size = 12554 OK 2026/11/03 01:50:41 INFO : sub/index.html: Copied (replaced existing) 2026/11/03 01:50:41 DEBUG : sub/new/index.html: md5 = 3344c47da21feaf0c76dfbc60d8fbb24 OK 2026/11/03 01:50:41 DEBUG : sub/new/index.html: size = 12085 OK 2026/11/03 01:50:41 INFO : sub/new/index.html: Copied (new) 2026/11/03 01:50:44 DEBUG : other/undeclared0.txt: md5 = 0f3cb21d34bbf31caed998e1e05acd32 OK 2026/11/03 01:50:44 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 1 directories and walking 1 changed directories 2026/11/03 01:50:45 DEBUG : index.html: Unchanged skipping 2026/11/03 01:50:46 DEBUG : other/index.html: md5 = b052de12a142df2868dce09924684587 OK 2026/11/03 01:50:46 DEBUG : other/index.html: size = 12597 OK 2026/11/03 01:50:46 INFO : other/index.html: Copied (replaced existing) 2026/11/03 01:50:48 DEBUG : other/undeclared1.txt: md5 = 43b741a0c3d3bb0ccb1228fb5e7ce7a7 OK 2026/11/03 01:50:48 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 1 directories and walking 0 changed directories 2026/11/03 01:50:49 DEBUG : index.html: Unchanged skipping 2026/11/03 01:50:50 DEBUG : other/index.html: md5 = 9e47a30e6b58460f7db2c7972c108819 OK 2026/11/03 01:50:50 DEBUG : other/index.html: size = 12867 OK 2026/11/03 01:50:50 INFO : other/index.html: Copied (replaced existing) 2026/11/03 01:50:52 DEBUG : sub/file6.txt: md5 = 4054d62e2f81b7af607a7b364f283697 OK 2026/11/03 01:50:52 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Nothing changed so nothing to index 2026/11/03 01:50:53 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Root changed so doing a full index 2026/11/03 01:50:54 DEBUG : sub/new/index.html: Unchanged skipping 2026/11/03 01:50:54 DEBUG : sub/deep/index.html: Unchanged skipping 2026/11/03 01:50:54 DEBUG : index.html: Unchanged skipping 2026/11/03 01:50:54 DEBUG : other/index.html: Unchanged skipping 2026/11/03 01:50:55 DEBUG : sub/index.html: md5 = 48aca5476559c67c0fefb8a277e9cf4d OK 2026/11/03 01:50:55 DEBUG : sub/index.html: size = 12813 OK 2026/11/03 01:50:55 INFO : sub/index.html: Copied (replaced existing) 2026/11/03 01:50:57 DEBUG : sub/file7.txt: md5 = d33f6855ba6ad3f9c0330c6a4b56019d OK 2026/11/03 01:50:57 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index would list 2 directories, more than 1, so doing a full index 2026/11/03 01:50:59 DEBUG : index.html: Unchanged skipping 2026/11/03 01:50:59 DEBUG : sub/deep/index.html: Unchanged skipping 2026/11/03 01:50:59 DEBUG : sub/new/index.html: Unchanged skipping 2026/11/03 01:50:59 DEBUG : other/index.html: Unchanged skipping 2026/11/03 01:50:59 DEBUG : sub/index.html: md5 = 8e19904b7682a9dcfecca0659e53ab11 OK 2026/11/03 01:50:59 DEBUG : sub/index.html: size = 13071 OK 2026/11/03 01:50:59 INFO : sub/index.html: Copied (replaced existing) 2026/11/03 01:51:02 DEBUG : sub/deep/file8.txt: md5 = 21f9a57bbd38a7bd11608556d47b2c26 OK 2026/11/03 01:51:02 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 1 directories and walking 1 changed directories 2026/11/03 01:51:03 DEBUG : index.html: Unchanged skipping 2026/11/03 01:51:03 DEBUG : sub/new/index.html: Unchanged skipping 2026/11/03 01:51:03 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:51:04 DEBUG : sub/deep/index.html: md5 = 0bab038b83368ba5157737e0218d38ad OK 2026/11/03 01:51:04 DEBUG : sub/deep/index.html: size = 12604 OK 2026/11/03 01:51:04 INFO : sub/deep/index.html: Copied (replaced existing) 2026/11/03 01:51:06 DEBUG : sub/deep/file9.txt: md5 = 4a4e7d08a72564bc43694b7fccd03606 OK 2026/11/03 01:51:08 DEBUG : sub/file10.txt: md5 = e97605c3a11c35c0fe65d51a464a249d OK 2026/11/03 01:51:08 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 2 directories and walking 0 changed directories 2026/11/03 01:51:09 DEBUG : index.html: Unchanged skipping 2026/11/03 01:51:09 DEBUG : sub/index.html: md5 = 3d852c53c1a43b8202288dd0f67fbb34 OK 2026/11/03 01:51:09 DEBUG : sub/index.html: size = 13331 OK 2026/11/03 01:51:09 INFO : sub/index.html: Copied (replaced existing) --- PASS: TestIndexChanged (64.46s) === RUN TestIndexChangedDelete run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:51:25 DEBUG : file1.txt: md5 = 1fc6eb5bff8a068e431f38cb157e1a2c OK 2026/11/03 01:51:27 DEBUG : sub/file2.txt: md5 = 9fdf93527c60b44724da5833462267c5 OK 2026/11/03 01:51:29 DEBUG : sub/deep/file3.txt: md5 = 92256714d3e21eed0d152328cd025240 OK 2026/11/03 01:51:32 DEBUG : index.html: md5 = 1f7c81422704b3c47f87180b0e6b7bef OK 2026/11/03 01:51:32 DEBUG : index.html: size = 12147 OK 2026/11/03 01:51:32 INFO : index.html: Copied (new) 2026/11/03 01:51:32 DEBUG : sub/deep/index.html: md5 = b9e549b535cdc00b1646d0e8893095fa OK 2026/11/03 01:51:32 DEBUG : sub/deep/index.html: size = 12087 OK 2026/11/03 01:51:32 INFO : sub/deep/index.html: Copied (new) 2026/11/03 01:51:33 DEBUG : sub/index.html: md5 = cdf1176a9479b89ff7cc0e5eb8e22d19 OK 2026/11/03 01:51:33 DEBUG : sub/index.html: size = 12306 OK 2026/11/03 01:51:33 INFO : sub/index.html: Copied (new) 2026/11/03 01:51:34 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 3 directories and walking 0 changed directories 2026/11/03 01:51:35 DEBUG : sub/index.html: Unchanged skipping 2026/11/03 01:51:35 DEBUG : index.html: Unchanged skipping 2026/11/03 01:51:36 DEBUG : sub/deep/index.html: md5 = 35cba24708cf3c8d374a0077ed6f20e1 OK 2026/11/03 01:51:36 DEBUG : sub/deep/index.html: size = 11829 OK 2026/11/03 01:51:36 INFO : sub/deep/index.html: Copied (replaced existing) --- PASS: TestIndexChangedDelete (18.06s) === RUN TestIndexChangedFiles run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:51:43 DEBUG : file1.txt: md5 = 8e0341b1cea5d9874d35732fb29abdc4 OK 2026/11/03 01:51:45 DEBUG : sub/file2.txt: md5 = 4c49ca101d18a73bb48a1e28e540822d OK 2026/11/03 01:51:48 DEBUG : sub/deep/file3.txt: md5 = 2deee386ed42beffff447a94de114f44 OK 2026/11/03 01:51:50 DEBUG : - odd/file.txt: md5 = dcf436b29fa49f77eebf1500416a4f2b OK 2026/11/03 01:51:52 DEBUG : sub/deep/index.html: md5 = 6e46cbc6156ba2b0e8632bc9170be4cb OK 2026/11/03 01:51:52 DEBUG : sub/deep/index.html: size = 12087 OK 2026/11/03 01:51:52 INFO : sub/deep/index.html: Copied (new) 2026/11/03 01:51:52 DEBUG : - odd/index.html: md5 = 44f64db6d64075f99f37fd595bb45705 OK 2026/11/03 01:51:52 DEBUG : - odd/index.html: size = 12058 OK 2026/11/03 01:51:52 INFO : - odd/index.html: Copied (new) 2026/11/03 01:51:52 DEBUG : index.html: md5 = 410f878f7c3b4587ffa43d7fd5d801e2 OK 2026/11/03 01:51:52 DEBUG : index.html: size = 12401 OK 2026/11/03 01:51:52 INFO : index.html: Copied (new) 2026/11/03 01:51:52 DEBUG : sub/index.html: md5 = 776ba19064aa27d5d870c4e842878e21 OK 2026/11/03 01:51:52 DEBUG : sub/index.html: size = 12306 OK 2026/11/03 01:51:52 INFO : sub/index.html: Copied (new) 2026/11/03 01:51:54 DEBUG : - odd/file8.txt: md5 = 7adb3e19d6b907be55760dc3f6652e9a OK 2026/11/03 01:51:55 DEBUG : sub/file9.txt: md5 = c27dcf7d7a346075bfc23bf7bd6029f3 OK 2026/11/03 01:51:55 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 2 directories and walking 0 changed directories 2026/11/03 01:51:56 DEBUG : index.html: Unchanged skipping 2026/11/03 01:51:57 DEBUG : - odd/index.html: md5 = db279e7861189395f917d89388f5e933 OK 2026/11/03 01:51:57 DEBUG : - odd/index.html: size = 12316 OK 2026/11/03 01:51:57 INFO : - odd/index.html: Copied (replaced existing) 2026/11/03 01:51:59 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 4 directories and walking 0 changed directories 2026/11/03 01:52:01 DEBUG : index.html: Unchanged skipping 2026/11/03 01:52:01 DEBUG : - odd/index.html: Unchanged skipping 2026/11/03 01:52:01 DEBUG : sub/deep/index.html: Unchanged skipping 2026/11/03 01:52:01 DEBUG : sub/index.html: md5 = 714678f0ce3b89ec00e3de19a6eecd28 OK 2026/11/03 01:52:01 DEBUG : sub/index.html: size = 12565 OK 2026/11/03 01:52:01 INFO : sub/index.html: Copied (replaced existing) --- PASS: TestIndexChangedFiles (28.68s) === RUN TestIndexChangedDirTime run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:52:12 DEBUG : file1.txt: md5 = ad472a960e1217e23d657ddbf10cb105 OK 2026/11/03 01:52:14 DEBUG : sub/file2.txt: md5 = 9fc83a45ddfd3febbc56aa37c639e907 OK 2026/11/03 01:52:16 DEBUG : sub/deep/file3.txt: md5 = 0673aec57355675661d4ddc99f94d673 OK 2026/11/03 01:52:18 DEBUG : other/notes.md: md5 = 61f9f10edee21b7958ceaf7465330396 OK 2026/11/03 01:52:20 DEBUG : sub/index.json: md5 = dd8252c7789a171a8916491a5ab1dd87 OK 2026/11/03 01:52:20 DEBUG : sub/index.json: size = 259 OK 2026/11/03 01:52:20 INFO : sub/index.json: Copied (new) 2026/11/03 01:52:20 DEBUG : index.json: md5 = 1dee6f5adfe88ca395cf957e0f34e4e6 OK 2026/11/03 01:52:20 DEBUG : index.json: size = 379 OK 2026/11/03 01:52:20 INFO : index.json: Copied (new) 2026/11/03 01:52:20 DEBUG : other/index.json: md5 = 0aa6317f7a36edd80c16143216d36ac1 OK 2026/11/03 01:52:20 DEBUG : other/index.json: size = 144 OK 2026/11/03 01:52:20 INFO : other/index.json: Copied (new) 2026/11/03 01:52:20 DEBUG : sub/deep/index.json: md5 = c5925022bcda99923ab796bbd4485d6a OK 2026/11/03 01:52:20 DEBUG : sub/deep/index.json: size = 139 OK 2026/11/03 01:52:20 INFO : sub/deep/index.json: Copied (new) 2026/11/03 01:52:22 DEBUG : sub/deep/file4.txt: md5 = 456467d4cb8ab8c85c96729e6ff4c6db OK 2026/11/03 01:52:22 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Partial index: listing 3 directories and walking 0 changed directories 2026/11/03 01:52:24 DEBUG : sub/deep/index.json: md5 = 8ab9dbdc6f05c85051e9472c333ed3ab OK 2026/11/03 01:52:24 DEBUG : sub/deep/index.json: size = 275 OK 2026/11/03 01:52:24 INFO : sub/deep/index.json: Copied (replaced existing) 2026/11/03 01:52:25 DEBUG : index.json: md5 = b421c9a70c50dfa858e7b9b6111e2a84 OK 2026/11/03 01:52:25 DEBUG : index.json: size = 379 OK 2026/11/03 01:52:25 INFO : index.json: Copied (replaced existing) 2026/11/03 01:52:25 DEBUG : sub/index.json: md5 = 83002b07ef3f2d05458d66e999ca9635 OK 2026/11/03 01:52:25 DEBUG : sub/index.json: size = 259 OK 2026/11/03 01:52:25 INFO : sub/index.json: Copied (replaced existing) --- PASS: TestIndexChangedDirTime (22.87s) === RUN TestListDirSorted run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:52:35 DEBUG : a.txt: md5 = b376e5c569c118059280633c319ec7c2 OK 2026/11/03 01:52:36 DEBUG : zend.txt: md5 = ec9e8f763aa351f1ff70e2eb2a94f80f OK 2026/11/03 01:52:38 DEBUG : sub dir/hello world: md5 = e3133b8026b7e58752202733453b192e OK 2026/11/03 01:52:40 DEBUG : sub dir/hello world2: md5 = 1a200796ef0876252a5abe1c3b9bfad0 OK 2026/11/03 01:52:42 DEBUG : sub dir/ignore dir/.ignore: md5 = 26e64e22c70b255027ecb08ae11b5beb OK 2026/11/03 01:52:43 DEBUG : sub dir/ignore dir/should be ignored: md5 = 4311f75ea5d7df8a364160299594d0c6 OK 2026/11/03 01:52:46 DEBUG : sub dir/sub sub dir/hello world3: md5 = ef362e082bf92b51020613610c5048d7 OK 2026/11/03 01:52:47 DEBUG : a.txt: Excluded (Size Filter) 2026/11/03 01:52:47 DEBUG : a.txt: Excluded 2026/11/03 01:52:47 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2026/11/03 01:52:47 DEBUG : sub dir/hello world2: Excluded 2026/11/03 01:52:47 DEBUG : sub dir/hello world: Excluded (Size Filter) 2026/11/03 01:52:47 DEBUG : sub dir/hello world: Excluded 2026/11/03 01:52:48 DEBUG : sub dir/ignore dir: Excluded 2026/11/03 01:52:48 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2026/11/03 01:52:48 DEBUG : sub dir/hello world2: Excluded 2026/11/03 01:52:48 DEBUG : sub dir/hello world: Excluded (Size Filter) 2026/11/03 01:52:48 DEBUG : sub dir/hello world: Excluded 2026/11/03 01:52:48 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSorted (22.13s) === RUN TestListDirSortedFn run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:52:57 DEBUG : a.txt: md5 = 0475e769068c7192c587e132a20447b6 OK 2026/11/03 01:52:58 DEBUG : zend.txt: md5 = a3c18c54c5a762a40b646614e82e4f1f OK 2026/11/03 01:53:00 DEBUG : sub dir/hello world: md5 = c403a4aee223693d1905177059fb9447 OK 2026/11/03 01:53:02 DEBUG : sub dir/hello world2: md5 = 55f8ad031f27ad5b914f8624733c82ea OK 2026/11/03 01:53:04 DEBUG : sub dir/ignore dir/.ignore: md5 = 5f1fe6e68ac4cda3ddf179287c7a9ee7 OK 2026/11/03 01:53:06 DEBUG : sub dir/ignore dir/should be ignored: md5 = e2a4dc0d2868c2970702b812f6462aa3 OK 2026/11/03 01:53:08 DEBUG : sub dir/sub sub dir/hello world3: md5 = ee61cb6978dee81396100dc9dad36899 OK 2026/11/03 01:53:09 DEBUG : a.txt: Excluded (Size Filter) 2026/11/03 01:53:09 DEBUG : a.txt: Excluded 2026/11/03 01:53:10 DEBUG : sub dir/hello world: Excluded (Size Filter) 2026/11/03 01:53:10 DEBUG : sub dir/hello world: Excluded 2026/11/03 01:53:10 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2026/11/03 01:53:10 DEBUG : sub dir/hello world2: Excluded 2026/11/03 01:53:11 DEBUG : sub dir/ignore dir: Excluded 2026/11/03 01:53:11 DEBUG : sub dir/hello world: Excluded (Size Filter) 2026/11/03 01:53:11 DEBUG : sub dir/hello world: Excluded 2026/11/03 01:53:11 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2026/11/03 01:53:11 DEBUG : sub dir/hello world2: Excluded 2026/11/03 01:53:11 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSortedFn (22.63s) === RUN TestListJSON run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:53:19 DEBUG : file1: md5 = 1d6caa5ce025bc901357f3a950edca12 OK 2026/11/03 01:53:22 DEBUG : sub/file2: md5 = 345eb6eed95dfd8c08253a7d2cd3002e OK === RUN TestListJSON/Default === RUN TestListJSON/FilesOnly === RUN TestListJSON/DirsOnly === RUN TestListJSON/Recurse === RUN TestListJSON/SubDir === RUN TestListJSON/NoModTime === RUN TestListJSON/NoMimeType === RUN TestListJSON/ShowHash === RUN TestListJSON/HashTypes 2026/11/03 01:53:25 ERROR : file1: Failed to read hash: hash type not supported === RUN TestListJSON/Metadata 2026/11/03 01:53:25 DEBUG : eer8kka55qnghc34cq76ca668g: Fetching metadata 2026/11/03 01:53:26 DEBUG : 150fuo3cn4j1uenq6r4g4qk6t4: Fetching metadata --- PASS: TestListJSON (10.26s) --- PASS: TestListJSON/Default (0.24s) --- PASS: TestListJSON/FilesOnly (0.24s) --- PASS: TestListJSON/DirsOnly (0.25s) --- PASS: TestListJSON/Recurse (0.47s) --- PASS: TestListJSON/SubDir (0.61s) --- PASS: TestListJSON/NoModTime (0.26s) --- PASS: TestListJSON/NoMimeType (0.29s) --- PASS: TestListJSON/ShowHash (0.25s) --- PASS: TestListJSON/HashTypes (0.24s) --- PASS: TestListJSON/Metadata (0.69s) === RUN TestStatJSON run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:53:30 DEBUG : file1: md5 = 4e11e096ed1dbf2356aa793d20dcf192 OK 2026/11/03 01:53:32 DEBUG : sub/file2: md5 = 4c89e67425ed147a6ff4b73aae12ea50 OK === RUN TestStatJSON/Root === RUN TestStatJSON/RootFilesOnly === RUN TestStatJSON/RootDirsOnly === RUN TestStatJSON/Dir === RUN TestStatJSON/DirWithTrailingSlash === RUN TestStatJSON/File === RUN TestStatJSON/NotFound === RUN TestStatJSON/DirFilesOnly === RUN TestStatJSON/FileFilesOnly === RUN TestStatJSON/NotFoundFilesOnly === RUN TestStatJSON/DirDirsOnly === RUN TestStatJSON/FileDirsOnly === RUN TestStatJSON/NotFoundDirsOnly === RUN TestStatJSON/RootNotFound 2026/11/03 01:53:36 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/notfound" 2026/11/03 01:53:36 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/qe0i31qdkoejk60elps0ni5sqk" --- PASS: TestStatJSON (11.59s) --- PASS: TestStatJSON/Root (0.31s) --- PASS: TestStatJSON/RootFilesOnly (0.00s) --- PASS: TestStatJSON/RootDirsOnly (0.27s) --- PASS: TestStatJSON/Dir (0.51s) --- PASS: TestStatJSON/DirWithTrailingSlash (0.27s) --- PASS: TestStatJSON/File (0.24s) --- PASS: TestStatJSON/NotFound (0.51s) --- PASS: TestStatJSON/DirFilesOnly (0.23s) --- PASS: TestStatJSON/FileFilesOnly (0.30s) --- PASS: TestStatJSON/NotFoundFilesOnly (0.24s) --- PASS: TestStatJSON/DirDirsOnly (0.25s) --- PASS: TestStatJSON/FileDirsOnly (0.21s) --- PASS: TestStatJSON/NotFoundDirsOnly (0.25s) --- PASS: TestStatJSON/RootNotFound (1.70s) === RUN TestStatJSONMemory 2026/11/03 01:53:40 DEBUG : Creating backend with remote ":memory:" 2026/11/03 01:53:40 DEBUG : Memory root '': File to upload is small (5 bytes), uploading instead of streaming 2026/11/03 01:53:40 DEBUG : sub/file1: size = 5 OK 2026/11/03 01:53:40 DEBUG : sub/file1: md5 = 5d41402abc4b2a76b9719d911017c592 OK 2026/11/03 01:53:40 DEBUG : sub/file1: Size and md5 of src and dst objects identical === RUN TestStatJSONMemory/Dir === RUN TestStatJSONMemory/DirWithTrailingSlash === RUN TestStatJSONMemory/File === RUN TestStatJSONMemory/NotFound --- PASS: TestStatJSONMemory (0.00s) --- PASS: TestStatJSONMemory/Dir (0.00s) --- PASS: TestStatJSONMemory/DirWithTrailingSlash (0.00s) --- PASS: TestStatJSONMemory/File (0.00s) --- PASS: TestStatJSONMemory/NotFound (0.00s) === RUN TestStatJSONConfinement --- PASS: TestStatJSONConfinement (0.00s) === RUN TestMkdir run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:53:40 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Making directory 2026/11/03 01:53:40 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Making directory --- PASS: TestMkdir (0.77s) === RUN TestLsd run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:53:43 DEBUG : sub dir/hello world: md5 = 7ec8c081912f9add573f697cc2cc10be OK --- PASS: TestLsd (5.04s) === RUN TestLs run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:53:47 DEBUG : potato2: md5 = c104b413580fd06b0dcf3076e828f924 OK 2026/11/03 01:53:49 DEBUG : empty space: md5 = e913d48ed4da865d60b0ba4bded2f388 OK --- PASS: TestLs (4.85s) === RUN TestLsWithFilesFrom run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:53:52 DEBUG : potato2: md5 = 5e2f172452529818debd12436e69dddc OK 2026/11/03 01:53:54 DEBUG : empty space: md5 = ca8919f5d6619ede70c780a37178b14a OK 2026/11/03 01:53:54 DEBUG : empty space: Excluded (FilesFrom Filter) --- PASS: TestLsWithFilesFrom (5.46s) === RUN TestLsLong run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:53:57 DEBUG : potato2: md5 = 049681a502df956406fc2895796963df OK 2026/11/03 01:53:59 DEBUG : empty space: md5 = a1f96a82156ea6aa75cb28b9fefedd55 OK --- PASS: TestLsLong (4.75s) === RUN TestHashSums run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:54:02 DEBUG : potato2: md5 = d3e2239138e27508cbb57cc6fd887a17 OK 2026/11/03 01:54:04 DEBUG : empty space: md5 = 2f1fb55cd850ef921a4a878f1fd6513d OK --- PASS: TestHashSums (4.49s) === RUN TestHashSumsWithErrors 2026/11/03 01:54:05 DEBUG : Creating backend with remote ":memory:" 2026/11/03 01:54:05 ERROR : file1: hash unsupported: hash type not supported 2026/11/03 01:54:05 ERROR : sub/file1: hash unsupported: hash type not supported 2026/11/03 01:54:05 ERROR : sub/file1: hash unsupported: hash type not supported --- PASS: TestHashSumsWithErrors (0.00s) === RUN TestHashStream 2026/11/03 01:54:05 DEBUG : Creating md5 hash of 0 bytes read from input stream 2026/11/03 01:54:05 DEBUG : Creating md5 hash of 0 bytes read from input stream 2026/11/03 01:54:05 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2026/11/03 01:54:05 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2026/11/03 01:54:05 DEBUG : Creating md5 hash of 12 bytes read from input stream 2026/11/03 01:54:05 DEBUG : Creating md5 hash of 12 bytes read from input stream 2026/11/03 01:54:05 DEBUG : Creating sha1 hash of 12 bytes read from input stream 2026/11/03 01:54:05 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:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:54:07 DEBUG : potato2: md5 = de25c35df7476c8703d102fd52b6e98f OK 2026/11/03 01:54:08 DEBUG : empty space: md5 = fbfa6c1e98fbb0eabe0c4137586c2d55 OK 2026/11/03 01:54:10 DEBUG : sub dir/potato3: md5 = 3921a19d9800face7893092984a78a25 OK --- PASS: TestCount (8.54s) === RUN TestDelete run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:54:15 DEBUG : small: md5 = 14fede00cfb7760f06b05f86dc12f152 OK 2026/11/03 01:54:17 DEBUG : medium: md5 = a9f98c49f93b528d0a7acb0bbaa0c1c1 OK 2026/11/03 01:54:18 DEBUG : large: md5 = ba711585d93272093019321c28b4f71c OK 2026/11/03 01:54:19 DEBUG : Waiting for deletions to finish 2026/11/03 01:54:19 DEBUG : large: Excluded (Size Filter) 2026/11/03 01:54:19 INFO : medium: Deleted 2026/11/03 01:54:19 INFO : small: Deleted --- PASS: TestDelete (6.85s) === RUN TestDeleteFatalError run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:54:22 DEBUG : file0: md5 = 912276c28417b66b803c15d60e9670b8 OK 2026/11/03 01:54:24 DEBUG : file1: md5 = 64bc88ffdd9748ea7a1f5c3056fd08c8 OK 2026/11/03 01:54:25 DEBUG : file2: md5 = 5c187cd88c1c31dd56307c7c11b5b889 OK 2026/11/03 01:54:27 DEBUG : file3: md5 = 6d3d8edbad23ae434fb188330a1051db OK 2026/11/03 01:54:28 DEBUG : file4: md5 = 935403039faddac30824f94573c04966 OK 2026/11/03 01:54:30 DEBUG : file5: md5 = c08270fe3301c1739789cedc968c8068 OK 2026/11/03 01:54:31 DEBUG : file6: md5 = b83fb19eb0646074457d15f2165901c7 OK 2026/11/03 01:54:32 DEBUG : file7: md5 = 507a7686b25ab6ac85ccc870e717114a OK 2026/11/03 01:54:34 DEBUG : file8: md5 = 400ba2919c231a96aac94e6a5e7896c2 OK 2026/11/03 01:54:35 DEBUG : file9: md5 = 5f9cd4215e673aa2d2ee461778b0414e OK 2026/11/03 01:54:37 DEBUG : file10: md5 = 2f65a16eee4cbda231d71c6d583b95b2 OK 2026/11/03 01:54:38 DEBUG : file11: md5 = 8c10a646ed55e3bc96ab5e0f97a034fe OK 2026/11/03 01:54:40 DEBUG : file12: md5 = 0c6ce230f0e1504c2ce121a6d43a127b OK 2026/11/03 01:54:41 DEBUG : file13: md5 = 393063e36f46a26092575066480d8a10 OK 2026/11/03 01:54:43 DEBUG : file14: md5 = af4d273eae5fd2e9090dae47d158d40d OK 2026/11/03 01:54:44 DEBUG : file15: md5 = c2715ee3d4f959cd633eccbc2cfc01ef OK 2026/11/03 01:54:45 DEBUG : file16: md5 = 95c0cd85817f6f30275896eb5e2f0952 OK 2026/11/03 01:54:47 DEBUG : file17: md5 = 278fc07ff77bcee8a29377d3d01d395b OK 2026/11/03 01:54:48 DEBUG : file18: md5 = 43718e75854874aeeefbb80878f1e07f OK 2026/11/03 01:54:50 DEBUG : file19: md5 = 91ac00cb58d4640e2b3b73cdd6e76409 OK 2026/11/03 01:54:50 DEBUG : Waiting for deletions to finish 2026/11/03 01:54:50 ERROR : file8: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file7: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file14: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file10: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file9: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file13: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file15: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file18: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file11: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file3: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file0: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file17: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file16: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file2: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file19: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file6: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file4: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file5: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file1: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:54:50 ERROR : file12: Got fatal error on delete: --max-delete threshold reached --- PASS: TestDeleteFatalError (39.24s) === RUN TestMaxDelete run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:55:01 DEBUG : small: md5 = ba211cb9eac07b19b4ac831fc531ec3a OK 2026/11/03 01:55:03 DEBUG : medium: md5 = 56d750dd5d334ce9ad4be374f8f22e4b OK 2026/11/03 01:55:04 DEBUG : large: md5 = a6defcb28e27223fcfa2176888c62360 OK 2026/11/03 01:55:04 DEBUG : Waiting for deletions to finish 2026/11/03 01:55:05 ERROR : medium: Got fatal error on delete: --max-delete threshold reached 2026/11/03 01:55:05 INFO : large: Deleted 2026/11/03 01:55:05 INFO : small: Deleted --- PASS: TestMaxDelete (6.97s) === RUN TestMaxDeleteSizeLargeFile run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:55:08 DEBUG : small: md5 = 6abb9e5acee12722058c2f21382f6116 OK 2026/11/03 01:55:10 DEBUG : medium: md5 = c367d1ffafd3ef3ac28cdb078ccb4027 OK 2026/11/03 01:55:11 DEBUG : large: md5 = f83b14b5db3655148a513fdb7e32584d OK 2026/11/03 01:55:11 DEBUG : Waiting for deletions to finish 2026/11/03 01:55:12 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached 2026/11/03 01:55:12 INFO : medium: Deleted 2026/11/03 01:55:12 INFO : small: Deleted --- PASS: TestMaxDeleteSizeLargeFile (7.30s) === RUN TestMaxDeleteSize run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:55:15 DEBUG : small: md5 = c3ee6333a6e371255a726d087abe26fa OK 2026/11/03 01:55:17 DEBUG : medium: md5 = ef9746da975cedaa156cee3a57865f52 OK 2026/11/03 01:55:18 DEBUG : large: md5 = 81590de5f18a2e3a5fafa11b637030bd OK 2026/11/03 01:55:19 DEBUG : Waiting for deletions to finish 2026/11/03 01:55:19 ERROR : medium: Got fatal error on delete: --max-delete-size threshold reached 2026/11/03 01:55:19 INFO : small: Deleted 2026/11/03 01:55:19 INFO : large: Deleted --- PASS: TestMaxDeleteSize (7.09s) === RUN TestReadFile run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:55:22 DEBUG : ReadFile: md5 = 12a255ffd8bb55e5cda6c65efd1b746d OK --- PASS: TestReadFile (3.99s) === RUN TestRetry 2026/11/03 01:55:25 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5 2026/11/03 01:55:25 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5 2026/11/03 01:55:25 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms 2026/11/03 01:55:25 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms 2026/11/03 01:55:25 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms 2026/11/03 01:55:25 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms --- PASS: TestRetry (0.04s) === RUN TestRetryAfterContextCancel 2026/11/03 01:55:25 DEBUG : Sleeping for 1h0m0s (as indicated by the server) to obey Retry-After error: BANG: trying again in 1h0m0s --- PASS: TestRetryAfterContextCancel (0.00s) === RUN TestRetryAfterLastTry --- PASS: TestRetryAfterLastTry (0.00s) === RUN TestCat run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:55:27 DEBUG : file1: md5 = 5ebb172839255a3ee8cf1fd03a8fe763 OK 2026/11/03 01:55:28 DEBUG : file2: md5 = efd6ceed0dd59c5fc1e56f6f5b9e138a OK --- PASS: TestCat (16.21s) === RUN TestPurge 2026/11/03 01:55:41 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-yeyawij6banu" 2026/11/03 01:55:41 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:55:41 DEBUG : Creating backend with remote "TestDrive:crypt/8083db06a5jifp7q44vk17rnm753v7a4mb2oms755fga0c6laa40" 2026/11/03 01:55:42 DEBUG : Creating backend with remote "/tmp/rclone1134252571" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-yeyawij6banu'", Local "Local file system at /tmp/rclone1134252571", Modify Window "1ms" 2026/11/03 01:55:47 DEBUG : A1/B1/C1/one: md5 = 8b44a0fd095dd226da1df9b66728b247 OK 2026/11/03 01:55:47 INFO : A2: Making directory 2026/11/03 01:55:48 INFO : A1/B2: Making directory 2026/11/03 01:55:49 INFO : A1/B2/C2: Making directory 2026/11/03 01:55:49 INFO : A1/B1/C3: Making directory 2026/11/03 01:55:50 INFO : A3: Making directory 2026/11/03 01:55:51 INFO : A3/B3: Making directory 2026/11/03 01:55:52 INFO : A3/B3/C4: Making directory 2026/11/03 01:55:54 DEBUG : A1/two: md5 = 583f773cf63db00dcd838e1c2820c2e1 OK 2026/11/03 01:55:58 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-yeyawij6banu': Purge remote 2026/11/03 01:55:58 NOTICE: purge failed: directory not found --- PASS: TestPurge (16.41s) === RUN TestRmdirsNoLeaveRoot run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:56:02 DEBUG : A1/B1/C1/one: md5 = c821ac131370fda82a7467255d7b1b60 OK 2026/11/03 01:56:02 INFO : A2: Making directory 2026/11/03 01:56:03 INFO : A1/B2: Making directory 2026/11/03 01:56:03 INFO : A1/B2/C2: Making directory 2026/11/03 01:56:04 INFO : A1/B1/C3: Making directory 2026/11/03 01:56:05 INFO : A3: Making directory 2026/11/03 01:56:06 INFO : A3/B3: Making directory 2026/11/03 01:56:06 INFO : A3/B3/C4: Making directory 2026/11/03 01:56:09 DEBUG : A1/two: md5 = 6db39a44f1b38d963cbeacfa8f99e31d OK 2026/11/03 01:56:10 DEBUG : removing 1 level 3 directories 2026/11/03 01:56:10 INFO : A3/B3/C4: Removing directory 2026/11/03 01:56:13 DEBUG : removing 2 level 3 directories 2026/11/03 01:56:13 INFO : A1/B2/C2: Removing directory 2026/11/03 01:56:13 INFO : A1/B1/C3: Removing directory 2026/11/03 01:56:13 DEBUG : removing 2 level 2 directories 2026/11/03 01:56:13 INFO : A3/B3: Removing directory 2026/11/03 01:56:13 INFO : A1/B2: Removing directory 2026/11/03 01:56:14 DEBUG : removing 2 level 1 directories 2026/11/03 01:56:14 INFO : A3: Removing directory 2026/11/03 01:56:14 INFO : A2: Removing directory 2026/11/03 01:56:18 DEBUG : removing 1 level 3 directories 2026/11/03 01:56:18 INFO : A1/B1/C1: Removing directory 2026/11/03 01:56:19 DEBUG : removing 1 level 2 directories 2026/11/03 01:56:19 INFO : A1/B1: Removing directory 2026/11/03 01:56:19 DEBUG : removing 1 level 1 directories 2026/11/03 01:56:19 INFO : A1: Removing directory 2026/11/03 01:56:20 DEBUG : removing 1 level 0 directories 2026/11/03 01:56:20 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Removing directory --- PASS: TestRmdirsNoLeaveRoot (23.70s) === RUN TestRmdirsLeaveRoot run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:56:22 INFO : A1: Making directory 2026/11/03 01:56:23 INFO : A1/B1: Making directory 2026/11/03 01:56:24 INFO : A1/B1/C1: Making directory 2026/11/03 01:56:26 DEBUG : removing 1 level 3 directories 2026/11/03 01:56:26 INFO : A1/B1/C1: Removing directory 2026/11/03 01:56:27 DEBUG : removing 1 level 2 directories 2026/11/03 01:56:27 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (8.07s) === RUN TestRmdirsWithFilter run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:56:30 INFO : A1: Making directory 2026/11/03 01:56:30 INFO : A1/B1: Making directory 2026/11/03 01:56:31 INFO : A1/B1/C1: Making directory 2026/11/03 01:56:34 DEBUG : removing 1 level 3 directories 2026/11/03 01:56:34 INFO : A1/B1/C1: Removing directory 2026/11/03 01:56:34 DEBUG : removing 1 level 2 directories 2026/11/03 01:56:34 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (7.61s) === RUN TestCopyURL run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:56:39 DEBUG : file1: md5 = 56a7545692cba50b1b914c057c9202fd OK 2026/11/03 01:56:39 DEBUG : file1: size = 14 OK 2026/11/03 01:56:39 DEBUG : filename.txt: File name found in url 2026/11/03 01:56:41 DEBUG : filename.txt: md5 = ab7064e9e90c5678edebf41bef71a656 OK 2026/11/03 01:56:41 DEBUG : filename.txt: size = 14 OK 2026/11/03 01:56:41 DEBUG : headerfilename.txt: filename found in Content-Disposition header. 2026/11/03 01:56:42 DEBUG : headerfilename.txt: md5 = 39d0f018050f5dd08b3af14ce6684305 OK 2026/11/03 01:56:42 DEBUG : headerfilename.txt: size = 14 OK 2026/11/03 01:56:44 DEBUG : file2: md5 = ba5e4b45750dab9a3c7eb26ead037917 OK 2026/11/03 01:56:44 DEBUG : file2: size = 14 OK --- PASS: TestCopyURL (9.43s) === RUN TestCopyURLDownloadHeaders run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:56:48 DEBUG : file1: md5 = 0771b94dc95f831d95d13492448a746a OK 2026/11/03 01:56:48 DEBUG : file1: size = 14 OK --- PASS: TestCopyURLDownloadHeaders (2.46s) === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:56:49 DEBUG : file1: Need to transfer - File not found at Destination 2026/11/03 01:56:51 DEBUG : sub/file2: md5 = 991fe4a0cf65d4d78737a9a26e5a140f OK 2026/11/03 01:56:51 DEBUG : sub/file2: size = 14 OK 2026/11/03 01:56:51 INFO : file1: Copied (new) to: sub/file2 2026/11/03 01:56:51 INFO : file1: Deleted 2026/11/03 01:56:52 DEBUG : sub/file2: size = 14 OK 2026/11/03 01:56:52 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2026/11/03 01:56:52 DEBUG : file1: Unchanged skipping 2026/11/03 01:56:52 INFO : file1: Deleted 2026/11/03 01:56:53 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (6.13s) === RUN TestMoveFileWithIgnoreExisting run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:56:55 DEBUG : file1: Need to transfer - File not found at Destination 2026/11/03 01:56:57 DEBUG : file1: md5 = 96cea80404d3fab2196bc43ea5a11318 OK 2026/11/03 01:56:57 DEBUG : file1: size = 14 OK 2026/11/03 01:56:57 INFO : file1: Copied (new) 2026/11/03 01:56:57 INFO : file1: Deleted 2026/11/03 01:56:57 DEBUG : file1: Destination exists, skipping 2026/11/03 01:56:57 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set --- PASS: TestMoveFileWithIgnoreExisting (3.47s) === RUN TestMoveFileImmutable run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:57:00 DEBUG : existing: md5 = 01be3fba2760c55cf472df1a1dffaa0f OK 2026/11/03 01:57:01 DEBUG : existing: size = 8 (Local file system at /tmp/rclone878498292) 2026/11/03 01:57:01 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 01:57:01 DEBUG : existing: Sizes differ 2026/11/03 01:57:01 ERROR : existing: Source and destination exist but do not match: immutable file modified --- PASS: TestMoveFileImmutable (3.07s) === RUN TestCaseInsensitiveMoveFile run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" --- PASS: TestCaseInsensitiveMoveFile (0.46s) === RUN TestMoveOntoItself === RUN TestMoveOntoItself/viaSubdir=false,disableMove=false 2026/11/03 01:57:02 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-sabihiv5boto" 2026/11/03 01:57:02 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:57:02 DEBUG : Creating backend with remote "TestDrive:crypt/qs6pa59tl6g3lehr3kgkrkgo1k5dcj9kg88vga0t2j6l8cst7lb0" 2026/11/03 01:57:03 DEBUG : Creating backend with remote "/tmp/rclone902612768" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-sabihiv5boto'", Local "Local file system at /tmp/rclone902612768", Modify Window "1ms" 2026/11/03 01:57:06 DEBUG : sub/file1: md5 = e93988c84ef081ebdbffe1bb39df482e OK 2026/11/03 01:57:07 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-sabihiv5boto': Purge remote === RUN TestMoveOntoItself/viaSubdir=false,disableMove=true 2026/11/03 01:57:08 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cicowil3hise" 2026/11/03 01:57:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:57:08 DEBUG : Creating backend with remote "TestDrive:crypt/vbt3kel77svvaqmutda0s70te3867505ddc8s0kpbs7l9rv27bug" 2026/11/03 01:57:09 DEBUG : Creating backend with remote "/tmp/rclone3050191091" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cicowil3hise'", Local "Local file system at /tmp/rclone3050191091", Modify Window "1ms" 2026/11/03 01:57:12 DEBUG : sub/file1: md5 = aece3c8d53f5d7891a01b54d576394c1 OK 2026/11/03 01:57:12 DEBUG : Reset feature "Move" 2026/11/03 01:57:12 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cicowil3hise': Purge remote === RUN TestMoveOntoItself/viaSubdir=true,disableMove=false 2026/11/03 01:57:13 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-kuwonir1yoxo" 2026/11/03 01:57:13 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:57:13 DEBUG : Creating backend with remote "TestDrive:crypt/nu7k3lehbqn0k0lvgtqhuv59pesltc93r9fre44u0fqls4a5n7vg" 2026/11/03 01:57:14 DEBUG : Creating backend with remote "/tmp/rclone2415298914" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-kuwonir1yoxo'", Local "Local file system at /tmp/rclone2415298914", Modify Window "1ms" 2026/11/03 01:57:17 DEBUG : sub/file1: md5 = 1a37368384b5d4ffb312e7cfaad6bc4f OK 2026/11/03 01:57:17 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-kuwonir1yoxo/sub" 2026/11/03 01:57:17 DEBUG : Creating backend with remote "TestDrive:crypt/nu7k3lehbqn0k0lvgtqhuv59pesltc93r9fre44u0fqls4a5n7vg/150fuo3cn4j1uenq6r4g4qk6t4" 2026/11/03 01:57:18 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-kuwonir1yoxo': Purge remote === RUN TestMoveOntoItself/viaSubdir=true,disableMove=true 2026/11/03 01:57:19 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-qatonaq1vema" 2026/11/03 01:57:19 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:57:19 DEBUG : Creating backend with remote "TestDrive:crypt/mddfdt55io49jheq7fp1u99b3ji9afgnvbrfm3n2k1vlrail19q0" 2026/11/03 01:57:20 DEBUG : Creating backend with remote "/tmp/rclone3575211985" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-qatonaq1vema'", Local "Local file system at /tmp/rclone3575211985", Modify Window "1ms" 2026/11/03 01:57:23 DEBUG : sub/file1: md5 = c9fddd88f3afc1144076a19b8e26644d OK 2026/11/03 01:57:23 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-qatonaq1vema/sub" 2026/11/03 01:57:23 DEBUG : Creating backend with remote "TestDrive:crypt/mddfdt55io49jheq7fp1u99b3ji9afgnvbrfm3n2k1vlrail19q0/150fuo3cn4j1uenq6r4g4qk6t4" 2026/11/03 01:57:24 DEBUG : Reset feature "Move" 2026/11/03 01:57:24 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-qatonaq1vema': Purge remote --- PASS: TestMoveOntoItself (23.03s) --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=false (5.35s) --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=true (5.21s) --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=false (6.20s) --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=true (6.27s) === RUN TestMoveUnicodeEquivalentWithoutServerSideMove 2026/11/03 01:57:25 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-feqenuv2zece" 2026/11/03 01:57:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:57:25 DEBUG : Creating backend with remote "TestDrive:crypt/43d2ni5meleuo52ib55kv2mphcn8h4es6nvm5l5m7v3pfvle6f10" 2026/11/03 01:57:26 DEBUG : Creating backend with remote "/tmp/rclone2023676955" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-feqenuv2zece'", Local "Local file system at /tmp/rclone2023676955", Modify Window "1ms" 2026/11/03 01:57:26 DEBUG : Reset feature "Move" 2026/11/03 01:57:29 DEBUG : sub/équivalent.txt: md5 = fd9d5c146e117da253d64878374eaacc OK 2026/11/03 01:57:30 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt-rclone-move-hucaraj7 2026/11/03 01:57:30 DEBUG : sub/équivalent.txt-rclone-move-hucaraj7: size = 14 OK 2026/11/03 01:57:30 INFO : sub/équivalent.txt: Copied (server-side copy) to: sub/équivalent.txt-rclone-move-hucaraj7 2026/11/03 01:57:31 INFO : sub/équivalent.txt: Deleted 2026/11/03 01:57:31 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt 2026/11/03 01:57:32 DEBUG : sub/équivalent.txt: size = 14 OK 2026/11/03 01:57:32 INFO : sub/équivalent.txt-rclone-move-hucaraj7: Copied (server-side copy) to: sub/équivalent.txt 2026/11/03 01:57:32 INFO : sub/équivalent.txt-rclone-move-hucaraj7: Deleted 2026/11/03 01:57:33 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-feqenuv2zece': Purge remote --- PASS: TestMoveUnicodeEquivalentWithoutServerSideMove (8.17s) === RUN TestCaseInsensitiveMoveWithoutServerSideMove 2026/11/03 01:57:33 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cagofoz8yaro" 2026/11/03 01:57:33 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/03 01:57:33 DEBUG : Creating backend with remote "TestDrive:crypt/bucav6t7ajvloi12hrjfte2403utn4qps858rt76ol9istujv1cg" 2026/11/03 01:57:34 DEBUG : Creating backend with remote "/tmp/rclone2761922341" run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cagofoz8yaro'", Local "Local file system at /tmp/rclone2761922341", Modify Window "1ms" operations_test.go:1198: remote is case sensitive 2026/11/03 01:57:34 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cagofoz8yaro': Purge remote 2026/11/03 01:57:35 NOTICE: purge failed: directory not found --- SKIP: TestCaseInsensitiveMoveWithoutServerSideMove (1.28s) === RUN TestCaseInsensitiveMoveFileDryRun run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" --- PASS: TestCaseInsensitiveMoveFileDryRun (0.45s) === RUN TestMoveFileBackupDir run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:57:37 DEBUG : dst/file1: md5 = ea8dfa39b7f2ed59ae381b208e7001a4 OK 2026/11/03 01:57:38 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cidafac3siga/backup" 2026/11/03 01:57:38 DEBUG : Creating backend with remote "TestDrive:crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0/1nrff024r7pq65ecp72fc28jb0" 2026/11/03 01:57:39 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone878498292) 2026/11/03 01:57:39 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 01:57:39 DEBUG : dst/file1: Sizes differ 2026/11/03 01:57:42 INFO : dst/file1: Moved (server-side) 2026/11/03 01:57:43 DEBUG : dst/file1: md5 = 428a05de5571936c1fcda4a59ccaa96d OK 2026/11/03 01:57:43 DEBUG : dst/file1: size = 14 OK 2026/11/03 01:57:43 INFO : dst/file1: Copied (new) 2026/11/03 01:57:43 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (12.99s) === RUN TestSameConfig --- PASS: TestSameConfig (0.00s) === RUN TestSame --- PASS: TestSame (0.00s) === RUN TestOverlappingFilterCheckWithoutFilter --- PASS: TestOverlappingFilterCheckWithoutFilter (0.00s) === RUN TestOverlappingFilterCheckWithFilter --- PASS: TestOverlappingFilterCheckWithFilter (0.00s) === RUN TestListFormat --- PASS: TestListFormat (0.00s) === RUN TestDirMoveMoveError run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:57:50 DEBUG : A/file0: md5 = 9c7d24c64c5b2ebbf0f59002af040b86 OK 2026/11/03 01:57:52 DEBUG : A/file1: md5 = bd62bc926df2660c5dfe3262d88ad427 OK 2026/11/03 01:57:53 DEBUG : A/file2: md5 = b16676d0abab8d64ffaa62819d7f6580 OK 2026/11/03 01:57:54 DEBUG : A/file3: md5 = 8a68e7735ca9c5d7bdfbf8a6aa6f28a6 OK 2026/11/03 01:57:56 DEBUG : A/file4: md5 = f938f9b1515a1b26b5c52b6778b747f8 OK 2026/11/03 01:57:57 DEBUG : A/file5: md5 = 47db52cd69798f8bb9a317b2577f290c OK 2026/11/03 01:57:59 DEBUG : A/file6: md5 = 05c8b832f89e45e537dce9dabdc1a55b OK 2026/11/03 01:58:00 DEBUG : A/file7: md5 = 4864f2a965ff6c3f013df1a9b2080033 OK 2026/11/03 01:58:02 DEBUG : A/file8: md5 = b09fb302701b698a2f135883e09d0883 OK 2026/11/03 01:58:03 DEBUG : A/file9: md5 = ecba39165e36bd20da139b63a6c739dc OK 2026/11/03 01:58:05 DEBUG : A/file10: md5 = 75fac1854d18253ee8e020460d2fc462 OK 2026/11/03 01:58:06 DEBUG : A/file11: md5 = 2f7d5eaec988c981fa77596d85c5d2d2 OK 2026/11/03 01:58:07 DEBUG : A/file12: md5 = 0a58109873bbfc195e58656bffd23035 OK 2026/11/03 01:58:09 DEBUG : A/file13: md5 = d4814cbd0fa52ac0031d7c9e3574e8d0 OK 2026/11/03 01:58:10 DEBUG : A/file14: md5 = 9fd82359ba9ab695b9844b45faebd225 OK 2026/11/03 01:58:12 DEBUG : A/file15: md5 = 12ec6abd6e572c1289e927b8bb2a6d05 OK 2026/11/03 01:58:13 DEBUG : A/file16: md5 = 5132b749c2f04da674273a2ea9e89777 OK 2026/11/03 01:58:14 DEBUG : A/file17: md5 = dfd5f45827c21236ad1d559c396521d5 OK 2026/11/03 01:58:16 DEBUG : A/file18: md5 = 7a9ecd950adf645b84ecf74d9716f362 OK 2026/11/03 01:58:17 DEBUG : A/file19: md5 = d2e55ef83c3d62edd3f0b864d0499a2a OK operations_test.go:1563: Skipping test on non local remote --- SKIP: TestDirMoveMoveError (40.34s) === RUN TestDirMoveContext run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:58:32 DEBUG : A/one: md5 = acef6365abfac00794ea302b9239614c OK 2026/11/03 01:58:34 DEBUG : A/two: md5 = 1f2ac1b38559aba0f7e3db409b43ee40 OK operations_test.go:1563: Skipping test on non local remote --- SKIP: TestDirMoveContext (7.85s) === RUN TestDirMove run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:58:38 DEBUG : A1/one: md5 = e43064a35025ab0a052097434771ef84 OK 2026/11/03 01:58:40 DEBUG : A1/two: md5 = 5855a376ba1e3757d2e1fab6840d2aeb OK 2026/11/03 01:58:42 DEBUG : A1/B1/three: md5 = 12b184c3b6aed3bb1526a722d9299143 OK 2026/11/03 01:58:44 DEBUG : A1/B1/C1/four: md5 = 479b710941d747fcba421130e42cc362 OK 2026/11/03 01:58:46 DEBUG : A1/B1/C2/five: md5 = 4fde87d6c892122078a425daf5e8f7ee OK 2026/11/03 01:58:46 INFO : A1/B2: Making directory 2026/11/03 01:58:47 INFO : A1/B1/C3: Making directory 2026/11/03 01:58:57 INFO : A2/one: Moved (server-side) to: A3/one 2026/11/03 01:58:57 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2026/11/03 01:58:57 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2026/11/03 01:58:57 INFO : A2/two: Moved (server-side) to: A3/two 2026/11/03 01:58:57 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2026/11/03 01:59:02 INFO : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2026/11/03 01:59:08 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2026/11/03 01:59:08 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four 2026/11/03 01:59:08 INFO : A3/one: Moved (server-side) to: A4/one 2026/11/03 01:59:08 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2026/11/03 01:59:09 INFO : A3/two: Moved (server-side) to: A4/two --- PASS: TestDirMove (44.55s) === RUN TestGetFsInfo run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" --- PASS: TestGetFsInfo (0.46s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:59:22 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': File to upload is small (34 bytes), uploading instead of streaming 2026/11/03 01:59:23 DEBUG : no_checksum_small_file_from_pipe: md5 = d21a8b0dc31d0f203280c9158bc07120 OK 2026/11/03 01:59:23 DEBUG : no_checksum_small_file_from_pipe: size = 34 OK 2026/11/03 01:59:23 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2026/11/03 01:59:23 DEBUG : no_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/11/03 01:59:24 DEBUG : qc9k4uauqa9ls6a2r6lo8jf4b1m7r0510pkurois1cc70egbs4h0: Sending chunk 0 length 102465 2026/11/03 01:59:24 DEBUG : no_checksum_big_file_from_pipe: md5 = 4b9a6788227e9b026213a0d796acd12e OK 2026/11/03 01:59:24 DEBUG : no_checksum_big_file_from_pipe: size = 102401 OK 2026/11/03 01:59:24 DEBUG : no_checksum_big_file_from_pipe: Size of src and dst objects identical === RUN TestRcat/withChecksum=true,ignoreChecksum=false run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:59:26 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': File to upload is small (34 bytes), uploading instead of streaming 2026/11/03 01:59:28 DEBUG : with_checksum_small_file_from_pipe: md5 = ce8cfe3fecdf00bf2ab4f55f0dd41d19 OK 2026/11/03 01:59:28 DEBUG : with_checksum_small_file_from_pipe: size = 34 OK 2026/11/03 01:59:28 DEBUG : with_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/11/03 01:59:28 DEBUG : e74jo8a7lr1aimg2u78fct67gnuetc1qujiofaci0c8fnq7rjt1d4i296pcklqhgdihs03etvgdi4: Sending chunk 0 length 102465 2026/11/03 01:59:30 DEBUG : with_checksum_big_file_from_pipe: md5 = 0b95ff9ac1727888b2417e60150f3193 OK 2026/11/03 01:59:30 DEBUG : with_checksum_big_file_from_pipe: size = 102401 OK 2026/11/03 01:59:30 DEBUG : with_checksum_big_file_from_pipe: Size of src and dst objects identical === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:59:32 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': File to upload is small (34 bytes), uploading instead of streaming 2026/11/03 01:59:33 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2026/11/03 01:59:33 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2026/11/03 01:59:34 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465 2026/11/03 01:59:35 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2026/11/03 01:59:35 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) === RUN TestRcat/withChecksum=true,ignoreChecksum=true run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:59:37 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': File to upload is small (34 bytes), uploading instead of streaming 2026/11/03 01:59:38 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2026/11/03 01:59:38 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical 2026/11/03 01:59:39 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465 2026/11/03 01:59:40 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2026/11/03 01:59:40 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical --- PASS: TestRcat (20.41s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (4.85s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (5.28s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (5.17s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (5.11s) === RUN TestRcatMetadata run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" === RUN TestRcatMetadata/Normal 2026/11/03 01:59:42 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': File to upload is small (48 bytes), uploading instead of streaming 2026/11/03 01:59:43 DEBUG : rcat_metadata: md5 = 896da4162c6a4719c807aa91895454b5 OK 2026/11/03 01:59:43 DEBUG : rcat_metadata: size = 48 OK 2026/11/03 01:59:43 DEBUG : rcat_metadata: Size of src and dst objects identical === RUN TestRcatMetadata/ViaDisk 2026/11/03 01:59:45 DEBUG : rijssoobhbn85c5p1imhg55m6frank1nlplla6hkdjlqmqb2471g: Sending chunk 0 length 111 2026/11/03 01:59:46 DEBUG : rcat_metadata_uploadcutoff0: md5 = 89342b5492f3b29ae66a52ddbc8ee588 OK 2026/11/03 01:59:46 DEBUG : rcat_metadata_uploadcutoff0: size = 63 OK 2026/11/03 01:59:46 DEBUG : rcat_metadata_uploadcutoff0: Size of src and dst objects identical --- PASS: TestRcatMetadata (6.17s) --- PASS: TestRcatMetadata/Normal (2.75s) --- PASS: TestRcatMetadata/ViaDisk (2.95s) === RUN TestRcatSize run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:59:49 DEBUG : potato1: md5 = 6d5ec56b60434df5d0f1dccc7f6ca35f OK 2026/11/03 01:59:49 DEBUG : potato1: size = 60 OK 2026/11/03 01:59:49 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': File to upload is small (60 bytes), uploading instead of streaming 2026/11/03 01:59:51 DEBUG : potato2: md5 = 2f0662001074268a7a9506acddcf7eb6 OK 2026/11/03 01:59:51 DEBUG : potato2: size = 60 OK 2026/11/03 01:59:51 DEBUG : potato2: Size of src and dst objects identical --- PASS: TestRcatSize (4.26s) === RUN TestRcatSizeShortEOF run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:59:54 DEBUG : potato1: md5 = 0d3a6f51cae10460a6dcb32e125fab3a OK 2026/11/03 01:59:54 DEBUG : potato1: size = 120 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 01:59:54 DEBUG : potato1: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 01:59:54 ERROR : potato1: corrupted on transfer: sizes differ src 120 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 60 2026/11/03 01:59:54 INFO : potato1: Removing failed copy --- PASS: TestRcatSizeShortEOF (2.48s) === RUN TestRcatSizeMetadata run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 01:59:56 DEBUG : potato1: md5 = ea763194ff8089ce2e82c4171b5d604e OK 2026/11/03 01:59:56 DEBUG : potato1: size = 60 OK 2026/11/03 01:59:56 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': File to upload is small (60 bytes), uploading instead of streaming 2026/11/03 01:59:57 DEBUG : potato2: md5 = 5588cd4d5ee2e7ba0006f693c2438385 OK 2026/11/03 01:59:57 DEBUG : potato2: size = 60 OK 2026/11/03 01:59:57 DEBUG : potato2: Size of src and dst objects identical --- PASS: TestRcatSizeMetadata (4.96s) === RUN TestRcatSizeUploadHeaders run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:01 DEBUG : potato1: md5 = bc9baba8ad9008ea9713f2f30dda47bf OK 2026/11/03 02:00:01 DEBUG : potato1: size = 60 OK --- PASS: TestRcatSizeUploadHeaders (2.36s) === RUN TestRcatSizeChecksum === RUN TestRcatSizeChecksum/Corrupted run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" operations_test.go:2048: Skipping as destination doesn't support hashes === RUN TestRcatSizeChecksum/SizeDiffers run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:04 DEBUG : potato4: md5 = 753a26caa756355d90fd8a3a2304668d OK 2026/11/03 02:00:04 DEBUG : potato4: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 02:00:04 DEBUG : potato4: size = 59 (Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 2026/11/03 02:00:04 ERROR : potato4: corrupted on transfer: sizes differ src 60 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga') 59 2026/11/03 02:00:04 INFO : potato4: Removing failed copy === RUN TestRcatSizeChecksum/IgnoreChecksum run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:07 DEBUG : potato2: size = 60 OK === RUN TestRcatSizeChecksum/NoHashes run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:09 DEBUG : potato3: md5 = e03e8e340fc273e7ef2a580f4b44c97d OK 2026/11/03 02:00:09 DEBUG : potato3: size = 60 OK --- PASS: TestRcatSizeChecksum (8.12s) --- SKIP: TestRcatSizeChecksum/Corrupted (0.45s) --- PASS: TestRcatSizeChecksum/SizeDiffers (2.84s) --- PASS: TestRcatSizeChecksum/IgnoreChecksum (2.33s) --- PASS: TestRcatSizeChecksum/NoHashes (2.51s) === RUN TestTouchDir run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:11 DEBUG : potato2: md5 = c3c8de6607ea6b581394e24a006ddaa7 OK 2026/11/03 02:00:13 DEBUG : empty space: md5 = d75991a57192b78b1a956a7274d0b827 OK 2026/11/03 02:00:15 DEBUG : sub dir/potato3: md5 = 2a135f9ece18cec0b1bcbe66efc2fc91 OK 2026/11/03 02:00:16 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Touching "sub dir/potato3" 2026/11/03 02:00:16 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Touching "empty space" 2026/11/03 02:00:16 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Touching "potato2" --- PASS: TestTouchDir (9.68s) === RUN TestMkdirMetadata run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:20 DEBUG : dir with metadata: Making directory with metadata 2026/11/03 02:00:21 INFO : dir with metadata: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) --- PASS: TestMkdirMetadata (2.58s) === RUN TestMkdirModTime run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:22 DEBUG : directory with modtime: Making directory with metadata 2026/11/03 02:00:23 INFO : directory with modtime: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/11/03 02:00:24 NOTICE: dry run directory with modtime: Skipped make directory as --dry-run is set --- PASS: TestMkdirModTime (2.64s) === RUN TestCopyDirMetadata run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:25 DEBUG : dir with metadata to be copied: Making directory with metadata 2026/11/03 02:00:25 INFO : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/11/03 02:00:25 DEBUG : Google drive root 'crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0': Skipping btime metadata as can't update it on an existing file: 2026-11-03T02:00:25.450269059Z 2026/11/03 02:00:26 INFO : non existent directory: Updated directory metadata 2026/11/03 02:00:28 DEBUG : Google drive root 'crypt/spmrg4mtt1qbghjk4jc023gh4dvj2l6svrg4d8en54emujhsadn0': Skipping btime metadata as can't update it on an existing file: 2026-11-03T02:00:25.450269059Z 2026/11/03 02:00:28 INFO : existing directory: Updated directory metadata --- PASS: TestCopyDirMetadata (4.67s) === RUN TestSetDirModTime run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:30 DEBUG : set modtime on non existent directory: Skipping set directory modification time as --no-update-dir-modtime is set 2026/11/03 02:00:32 INFO : set modtime on existing directory: Set directory modification time (using SetModTime) 2026/11/03 02:00:32 INFO : set modtime on existing directory: Set directory modification time (using DirSetModTime) --- PASS: TestSetDirModTime (4.49s) === RUN TestDirsEqual run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:34 DEBUG : dir with metadata to be copied: Making directory with metadata 2026/11/03 02:00:34 INFO : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/11/03 02:00:34 DEBUG : dst: Making directory with metadata 2026/11/03 02:00:35 INFO : dst: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/11/03 02:00:35 DEBUG : dst: Directory modification time the same (differ by -999.999µs, within tolerance 1ms) 2026/11/03 02:00:35 INFO : dst: Set directory modification time (using SetModTime) 2026/11/03 02:00:36 INFO : dst: Set directory modification time (using SetModTime) 2026/11/03 02:00:36 DEBUG : dst: Directory modification time the same (differ by 1ns, within tolerance 1ms) 2026/11/03 02:00:37 INFO : dst: Set directory modification time (using SetModTime) 2026/11/03 02:00:37 DEBUG : dst: Destination directory is newer than source, skipping --- PASS: TestDirsEqual (3.84s) === RUN TestRemoveExisting run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga'", Local "Local file system at /tmp/rclone878498292", Modify Window "1ms" 2026/11/03 02:00:40 DEBUG : sub dir/test remove existing: md5 = e42d8cbbd009b7db1df6c01f0577f924 OK 2026/11/03 02:00:42 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: md5 = 6fd36e0fec2795f26bb19dd561c669e6 OK 2026/11/03 02:00:44 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.nuyuvow3" before starting 2026/11/03 02:00:45 DEBUG : sub dir/test remove existing.nuyuvow3: TEST: removing renamed existing file after operation 2026/11/03 02:00:46 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.bepoloj2" before starting 2026/11/03 02:00:47 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.bepoloj2: TEST: renaming existing back after failed operation 2026/11/03 02:00:48 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.lesimed6" before starting 2026/11/03 02:00:49 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.lesimed6: TEST: removing renamed existing file after operation --- PASS: TestRemoveExisting (13.67s) === RUN TestRcatInputFailurePreservesDestination 2026/11/03 02:00:52 DEBUG : Creating backend with remote "/tmp/TestRcatInputFailurePreservesDestination3738503637/001" 2026/11/03 02:00:52 DEBUG : Config file has changed externally - reloading --- PASS: TestRcatInputFailurePreservesDestination (0.00s) === RUN TestRcAbout rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcAbout (0.00s) === RUN TestRcCleanup rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcCleanup (0.00s) === RUN TestRcCopyfile rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcCopyfile (0.00s) === RUN TestRcCopyurl rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcCopyurl (0.00s) === RUN TestRcDelete rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcDelete (0.00s) === RUN TestRcDeletefile rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcDeletefile (0.00s) === RUN TestRcDeletefileBackupDir rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcDeletefileBackupDir (0.00s) === RUN TestRcList rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcList (0.00s) === RUN TestRcStat rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcStat (0.00s) === RUN TestRcSetTier rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcSetTier (0.00s) === RUN TestRcSetTierFile rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcSetTierFile (0.00s) === RUN TestRcMkdir rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcMkdir (0.00s) === RUN TestRcMovefile rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcMovefile (0.00s) === RUN TestRcPurge rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcPurge (0.00s) === RUN TestRcRmdir rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcRmdir (0.00s) === RUN TestRcRmdirs rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcRmdirs (0.00s) === RUN TestRcSize rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcSize (0.00s) === RUN TestRcPublicLink rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcPublicLink (0.00s) === RUN TestRcFsInfo rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcFsInfo (0.00s) === RUN TestUploadFile rc_test.go:31: Skipping test on non local remote --- SKIP: TestUploadFile (0.00s) === RUN TestRcCommand rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcCommand (0.00s) === RUN TestRcDu rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcDu (0.00s) === RUN TestRcCheck rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcCheck (0.00s) === RUN TestRcHashsum rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcHashsum (0.00s) === RUN TestRcHashsumSingleFile rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcHashsumSingleFile (0.00s) === RUN TestRcHashsumFile rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcHashsumFile (0.00s) === RUN TestRcGetFile rc_test.go:31: Skipping test on non local remote --- SKIP: TestRcGetFile (0.00s) PASS 2026/11/03 02:00:52 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cidafac3siga': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose -fast-list" - Finished OK in 22m5.106977212s (try 1/5)