"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose" - Starting (try 1/5)
2026/10/28 04:48:35 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada"
2026/10/28 04:48:35 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:48:35 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg"
2026/10/28 04:48:36 DEBUG : Creating backend with remote "/tmp/rclone3097667400"
=== 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    multithread_test.go:120: multithread writing not supported
--- SKIP: TestMultithreadCopy (0.22s)
=== RUN   TestMultithreadCopyAbort
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    multithread_test.go:120: multithread writing not supported
--- SKIP: TestMultithreadCopyAbort (0.24s)
=== RUN   TestMultithreadCopyWriterAtErrors
=== RUN   TestMultithreadCopyWriterAtErrors/open/fatal=false
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
=== RUN   TestMultithreadCopyWriterAtErrors/open/fatal=true
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
=== RUN   TestMultithreadCopyWriterAtErrors/write/fatal=false
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/10/28 04:48:36 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 1
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 0
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 2
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
=== RUN   TestMultithreadCopyWriterAtErrors/write/fatal=true
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/10/28 04:48:36 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 1
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 2
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 0
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
=== RUN   TestMultithreadCopyWriterAtErrors/close/fatal=false
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/10/28 04:48:36 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 1
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 2
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 3
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 0
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
=== RUN   TestMultithreadCopyWriterAtErrors/close/fatal=true
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/10/28 04:48:36 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 1
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 2
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 3
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/10/28 04:48:36 DEBUG : file.txt: writing chunk 0
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/10/28 04:48:36 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
--- PASS: TestMultithreadCopyWriterAtErrors (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/open/fatal=false (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/open/fatal=true (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/write/fatal=false (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/write/fatal=true (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/close/fatal=false (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/close/fatal=true (0.00s)
=== RUN   TestSizeDiffers
2026/10/28 04:48:36 DEBUG : a: size = 0 OK
2026/10/28 04:48:36 DEBUG : a: size = 1 (memory)
2026/10/28 04:48:36 DEBUG : a: size = 2 (memory)
--- PASS: TestSizeDiffers (0.00s)
=== RUN   TestDirTransferEntry
--- PASS: TestDirTransferEntry (0.00s)
=== RUN   TestReOpen
=== RUN   TestReOpen/Normal
=== RUN   TestReOpen/Normal/Basics
2026/10/28 04:48:36 DEBUG : potato: Seek from 10 to 0
=== RUN   TestReOpen/Normal/ErrorAtStart
=== RUN   TestReOpen/Normal/WithErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/Normal/TooManyErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/Normal/ReadAt
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/Normal/Seek
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 2
=== RUN   TestReOpen/Normal/AccountRead
=== RUN   TestReOpen/Normal/AccountReadDelay
2026/10/28 04:48:36 DEBUG : potato: Seek from 10 to 0
2026/10/28 04:48:36 DEBUG : potato: Seek from 10 to 0
2026/10/28 04:48:36 DEBUG : potato: Seek from 10 to 0
=== RUN   TestReOpen/Normal/AccountReadError
=== RUN   TestReOpen/WithRangeOption
=== RUN   TestReOpen/WithRangeOption/Basics
2026/10/28 04:48:36 DEBUG : potato: Seek from 7 to 0
=== RUN   TestReOpen/WithRangeOption/ErrorAtStart
=== RUN   TestReOpen/WithRangeOption/WithErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/WithRangeOption/TooManyErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/WithRangeOption/ReadAt
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/WithRangeOption/Seek
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 2
2026/10/28 04:48:36 DEBUG : potato: Seek from 7 to 4
=== RUN   TestReOpen/WithRangeOption/AccountRead
=== RUN   TestReOpen/WithRangeOption/AccountReadDelay
2026/10/28 04:48:36 DEBUG : potato: Seek from 7 to 0
2026/10/28 04:48:36 DEBUG : potato: Seek from 7 to 0
2026/10/28 04:48:36 DEBUG : potato: Seek from 7 to 0
=== RUN   TestReOpen/WithRangeOption/AccountReadError
=== RUN   TestReOpen/WithSeekOption
=== RUN   TestReOpen/WithSeekOption/Basics
2026/10/28 04:48:36 DEBUG : potato: Seek from 8 to 0
=== RUN   TestReOpen/WithSeekOption/ErrorAtStart
=== RUN   TestReOpen/WithSeekOption/WithErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/WithSeekOption/TooManyErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/WithSeekOption/ReadAt
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/WithSeekOption/Seek
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 2
2026/10/28 04:48:36 DEBUG : potato: Seek from 7 to 5
=== RUN   TestReOpen/WithSeekOption/AccountRead
=== RUN   TestReOpen/WithSeekOption/AccountReadDelay
2026/10/28 04:48:36 DEBUG : potato: Seek from 8 to 0
2026/10/28 04:48:36 DEBUG : potato: Seek from 8 to 0
2026/10/28 04:48:36 DEBUG : potato: Seek from 8 to 0
=== RUN   TestReOpen/WithSeekOption/AccountReadError
=== RUN   TestReOpen/UnknownSize
=== RUN   TestReOpen/UnknownSize/Basics
2026/10/28 04:48:36 DEBUG : potato: Seek from 9 to 0
=== RUN   TestReOpen/UnknownSize/ErrorAtStart
=== RUN   TestReOpen/UnknownSize/WithErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/UnknownSize/TooManyErrors
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/10/28 04:48:36 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/UnknownSize/ReadAt
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/UnknownSize/Seek
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/10/28 04:48:36 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/10/28 04:48:36 DEBUG : potato: Seek from 5 to 2
2026/10/28 04:48:36 DEBUG : potato: Seek from 7 to 6
=== RUN   TestReOpen/UnknownSize/AccountRead
=== RUN   TestReOpen/UnknownSize/AccountReadDelay
2026/10/28 04:48:36 DEBUG : potato: Seek from 9 to 0
2026/10/28 04:48:36 DEBUG : potato: Seek from 9 to 0
2026/10/28 04:48:36 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:48:39 DEBUG : rutabaga: md5 = 06aac84a9a8a53274ca0811e57319962 OK
=== RUN   TestCheck/1
=== RUN   TestCheck/2
2026/10/28 04:48:41 DEBUG : empty space: md5 = 2c277969ab3929e29437545f82da2226 OK
=== RUN   TestCheck/3
2026/10/28 04:48:44 DEBUG : potato2: md5 = be672a2c3637ff5ffd9850cbe36ae2f5 OK
=== RUN   TestCheck/4
=== RUN   TestCheck/5
2026/10/28 04:48:46 DEBUG : remotepotato: md5 = 91623575bf13b6feca42201078440ae2 OK
=== RUN   TestCheck/6
=== RUN   TestCheck/7
--- PASS: TestCheck (13.40s)
    --- PASS: TestCheck/1 (0.27s)
    --- PASS: TestCheck/2 (0.29s)
    --- PASS: TestCheck/3 (0.27s)
    --- PASS: TestCheck/4 (0.25s)
    --- PASS: TestCheck/5 (0.27s)
    --- PASS: TestCheck/6 (0.31s)
    --- PASS: TestCheck/7 (0.29s)
=== RUN   TestCheckFsError
2026/10/28 04:48:50 DEBUG : Creating backend with remote "nonexistent"
2026/10/28 04:48:50 DEBUG : Config file has changed externally - reloading
2026/10/28 04:48:50 DEBUG : Creating backend with remote "nonexistent"
2026/10/28 04:48:50 DEBUG : Local file system at nonexistent: Waiting for checks to finish
2026/10/28 04:48:50 ERROR : Local file system at nonexistent: error reading source root directory: directory not found
2026/10/28 04:48:50 NOTICE: Local file system at nonexistent: 0 differences found
2026/10/28 04:48:50 NOTICE: Local file system at nonexistent: 2 errors while checking
--- PASS: TestCheckFsError (0.01s)
=== RUN   TestCheckDownload
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:48:51 DEBUG : rutabaga: md5 = 7c73d3106af4d8f57a51b9e2ade898cf OK
=== RUN   TestCheckDownload/1
=== RUN   TestCheckDownload/2
2026/10/28 04:48:55 DEBUG : empty space: md5 = 8b7484e84c20fd3f06f63700073a4014 OK
=== RUN   TestCheckDownload/3
2026/10/28 04:48:58 DEBUG : potato2: md5 = bf33e74f90492edd64e7f9a0af911b20 OK
=== RUN   TestCheckDownload/4
=== RUN   TestCheckDownload/5
2026/10/28 04:49:01 DEBUG : remotepotato: md5 = 310889ff779b16f0259b6d7c90e285af OK
=== RUN   TestCheckDownload/6
=== RUN   TestCheckDownload/7
--- PASS: TestCheckDownload (16.44s)
    --- PASS: TestCheckDownload/1 (1.09s)
    --- PASS: TestCheckDownload/2 (0.89s)
    --- PASS: TestCheckDownload/3 (0.82s)
    --- PASS: TestCheckDownload/4 (1.05s)
    --- PASS: TestCheckDownload/5 (0.79s)
    --- PASS: TestCheckDownload/6 (0.84s)
    --- PASS: TestCheckDownload/7 (0.80s)
=== RUN   TestCheckSizeOnly
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:49:08 DEBUG : rutabaga: md5 = e7387831e4ee53644b58f218f77ff171 OK
=== RUN   TestCheckSizeOnly/1
=== RUN   TestCheckSizeOnly/2
2026/10/28 04:49:10 DEBUG : empty space: md5 = 6e65b47e9f709f21ce307361ad205858 OK
=== RUN   TestCheckSizeOnly/3
2026/10/28 04:49:12 DEBUG : potato2: md5 = 6bbd727efdb1e0e07d86b613619ac1d0 OK
=== RUN   TestCheckSizeOnly/4
=== RUN   TestCheckSizeOnly/5
2026/10/28 04:49:15 DEBUG : remotepotato: md5 = 9a678e56f85f2149262bc6f229f221aa OK
=== RUN   TestCheckSizeOnly/6
=== RUN   TestCheckSizeOnly/7
--- PASS: TestCheckSizeOnly (12.21s)
    --- PASS: TestCheckSizeOnly/1 (0.25s)
    --- PASS: TestCheckSizeOnly/2 (0.28s)
    --- PASS: TestCheckSizeOnly/3 (0.25s)
    --- PASS: TestCheckSizeOnly/4 (0.26s)
    --- PASS: TestCheckSizeOnly/5 (0.24s)
    --- PASS: TestCheckSizeOnly/6 (0.31s)
    --- PASS: TestCheckSizeOnly/7 (0.25s)
=== RUN   TestCheckEqualReaders
--- PASS: TestCheckEqualReaders (0.00s)
=== RUN   TestParseSumFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:49:20 DEBUG : test.sum: md5 = 5aa9b85478853b611e550525daede81a OK
2026/10/28 04:49:21 NOTICE: test.sum: improperly formatted checksum line 4
2026/10/28 04:49:21 NOTICE: test.sum: improperly formatted checksum line 5
2026/10/28 04:49:21 NOTICE: test.sum: improperly formatted checksum line 6
2026/10/28 04:49:21 NOTICE: test.sum: 2 warning(s) suppressed...
2026/10/28 04:49:22 DEBUG : test.sum: md5 = f6a7a2154f7b1e17cf74892cd3fce7fb OK
2026/10/28 04:49:23 NOTICE: test.sum: improperly formatted checksum line 4
2026/10/28 04:49:23 NOTICE: test.sum: improperly formatted checksum line 5
2026/10/28 04:49:23 NOTICE: test.sum: improperly formatted checksum line 6
2026/10/28 04:49:23 NOTICE: test.sum: 2 warning(s) suppressed...
--- PASS: TestParseSumFile (6.10s)
=== RUN   TestCheckSum
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:49:24 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/data"
2026/10/28 04:49:24 DEBUG : Config file has changed externally - reloading
2026/10/28 04:49:25 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/vjrnln8ratgmqakfosrqe8espk"
    check_test.go:354: Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/data' lacks md5, skipping
--- SKIP: TestCheckSum (2.07s)
=== RUN   TestCheckSumDownload
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:49:27 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/data"
2026/10/28 04:49:27 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/vjrnln8ratgmqakfosrqe8espk"
2026/10/28 04:49:31 DEBUG : data/banana: md5 = cdf2682f80a657309297faed0affb1c9 OK
2026/10/28 04:49:32 DEBUG : test.sum: md5 = 0c226167224e5c01a202c9e59703971c OK
=== RUN   TestCheckSumDownload/subtest1
2026/10/28 04:49:37 DEBUG : data/potato: md5 = 18d23ff3d5e5e61fba7e46b0d375787d OK
2026/10/28 04:49:38 DEBUG : test.sum: md5 = 7c57d2ba5bc51a9d1d3c89371513480d OK
=== RUN   TestCheckSumDownload/subtest2
2026/10/28 04:49:42 DEBUG : test.sum: md5 = 3dcd80dd29d6276c9cbcafa7e42855f7 OK
=== RUN   TestCheckSumDownload/subtest3
2026/10/28 04:49:46 DEBUG : test.sum: md5 = 8239e3b8c08402d4743f90d93cdc8e6f OK
=== RUN   TestCheckSumDownload/subtest4
2026/10/28 04:49:50 DEBUG : test.sum: md5 = 51890540f83eabda0bb92e85ed1929ae OK
=== RUN   TestCheckSumDownload/subtest5
2026/10/28 04:49:54 DEBUG : test.sum: md5 = 0ac758f6fef2a46467fe5edcc7f2f575 OK
=== RUN   TestCheckSumDownload/subtest6
2026/10/28 04:49:58 DEBUG : data/banana: md5 = 569a5fa374393279b705bd41a05b75d5 OK
2026/10/28 04:50:00 DEBUG : data/potato: md5 = b2c804e3c68c4e74c0d3169f6dc84c8e OK
2026/10/28 04:50:01 DEBUG : test.sum: md5 = edd32498b85ca150e3636e4a659fca64 OK
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (40.57s)
    --- PASS: TestCheckSumDownload/subtest1 (2.14s)
    --- PASS: TestCheckSumDownload/subtest2 (1.76s)
    --- PASS: TestCheckSumDownload/subtest3 (1.88s)
    --- PASS: TestCheckSumDownload/subtest4 (2.02s)
    --- PASS: TestCheckSumDownload/subtest5 (1.73s)
    --- PASS: TestCheckSumDownload/subtest6 (1.83s)
    --- PASS: TestCheckSumDownload/subtest7 (1.91s)
=== RUN   TestCheckSumConcurrency
2026/10/28 04:50:07 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK
2026/10/28 04:50:07 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK
2026/10/28 04:50:07 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK
2026/10/28 04:50:07 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK
2026/10/28 04:50:07 NOTICE: Mock file system at checkSum: 0 differences found
2026/10/28 04:50:07 NOTICE: Mock file system at checkSum: 4 matching files
--- PASS: TestCheckSumConcurrency (0.00s)
=== RUN   TestCheckSumDownloadConcurrency
2026/10/28 04:50:07 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK
2026/10/28 04:50:07 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK
2026/10/28 04:50:07 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK
2026/10/28 04:50:07 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK
2026/10/28 04:50:07 NOTICE: Mock file system at checkSum: 0 differences found
2026/10/28 04:50:07 NOTICE: Mock file system at checkSum: 4 matching files
--- PASS: TestCheckSumDownloadConcurrency (0.00s)
=== RUN   TestApplyTransforms
2026/10/28 04:50:07 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-piticew3masi"
2026/10/28 04:50:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:07 DEBUG : Creating backend with remote "TestDrive:crypt/l8h75f9ur3e7d1hj75moopn80hivp0fv1b3ne8tip8qmv8o7kqcg"
2026/10/28 04:50:08 DEBUG : Creating backend with remote "/tmp/rclone418518463"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi'", Local "Local file system at /tmp/rclone418518463", Modify Window "1ms"
2026/10/28 04:50:11 DEBUG : hello, world!: md5 = f4e39d88bb5e306bb30bd4f3f9e6114f OK
upper checkfile vs. lower remote (without normalization)
2026/10/28 04:50:11 ERROR : hello, world!: sum not found
2026/10/28 04:50:11 ERROR : HELLO, WORLD!: file not in Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi'
2026/10/28 04:50:11 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi': 1 files missing
2026/10/28 04:50:11 NOTICE: 1 hashes missing
2026/10/28 04:50:11 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi': 1 differences found
2026/10/28 04:50:11 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi': 2 errors while checking
upper checkfile vs. lower remote (with normalization)
2026/10/28 04:50:12 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:12 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi': 0 differences found
2026/10/28 04:50:12 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi': 1 matching files
2026/10/28 04:50:12 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-diyiluh5radu"
2026/10/28 04:50:12 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:12 DEBUG : Creating backend with remote "TestDrive:crypt/46nen1apl6adfeis15v8rkgf1lm45pqdj1u559741ohc05bd9vqg"
2026/10/28 04:50:13 DEBUG : Creating backend with remote "/tmp/rclone2273879949"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu'", Local "Local file system at /tmp/rclone2273879949", Modify Window "1ms"
2026/10/28 04:50:16 DEBUG : HELLO, WORLD!: md5 = 45b68a29f624b5a3e2e6e9e6530fb4d9 OK
lower checkfile vs. upper remote (without normalization)
2026/10/28 04:50:16 ERROR : HELLO, WORLD!: sum not found
2026/10/28 04:50:16 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu'
2026/10/28 04:50:16 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu': 1 files missing
2026/10/28 04:50:16 NOTICE: 1 hashes missing
2026/10/28 04:50:16 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu': 1 differences found
2026/10/28 04:50:16 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu': 2 errors while checking
lower checkfile vs. upper remote (with normalization)
2026/10/28 04:50:17 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu': 0 differences found
2026/10/28 04:50:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu': 1 matching files
2026/10/28 04:50:17 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pofaser2cevu"
2026/10/28 04:50:17 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:17 DEBUG : Creating backend with remote "TestDrive:crypt/29bc1d7n8f6snrhlspgr97hd2iq5nl5snbsiroofack8j03oksjg"
2026/10/28 04:50:18 DEBUG : Creating backend with remote "/tmp/rclone1766380665"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu'", Local "Local file system at /tmp/rclone1766380665", Modify Window "1ms"
2026/10/28 04:50:21 DEBUG : HeLlO, wOrLd!: md5 = be01102681aadfbd55ce533ed724a2f8 OK
lower checkfile vs. upperlowermixed remote (without normalization)
2026/10/28 04:50:21 ERROR : HeLlO, wOrLd!: sum not found
2026/10/28 04:50:21 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu'
2026/10/28 04:50:21 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu': 1 files missing
2026/10/28 04:50:21 NOTICE: 1 hashes missing
2026/10/28 04:50:21 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu': 1 differences found
2026/10/28 04:50:21 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu': 2 errors while checking
lower checkfile vs. upperlowermixed remote (with normalization)
2026/10/28 04:50:22 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu': 0 differences found
2026/10/28 04:50:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu': 1 matching files
2026/10/28 04:50:22 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-todifev6juli"
2026/10/28 04:50:22 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:22 DEBUG : Creating backend with remote "TestDrive:crypt/t64reo6tc6j0fae3vnvisgp77eef4a8d0t7rbsdofe7oihlr1ggg"
2026/10/28 04:50:23 DEBUG : Creating backend with remote "/tmp/rclone3248770160"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli'", Local "Local file system at /tmp/rclone3248770160", Modify Window "1ms"
2026/10/28 04:50:26 DEBUG : HELLO, WORLD!: md5 = 6995c8b4e1c17d8e9028ea6ccfa31e8e OK
upperlowermixed checkfile vs. upper remote (without normalization)
2026/10/28 04:50:26 ERROR : HELLO, WORLD!: sum not found
2026/10/28 04:50:26 ERROR : HeLlO, wOrLd!: file not in Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli'
2026/10/28 04:50:26 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli': 1 files missing
2026/10/28 04:50:26 NOTICE: 1 hashes missing
2026/10/28 04:50:26 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli': 1 differences found
2026/10/28 04:50:26 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli': 2 errors while checking
upperlowermixed checkfile vs. upper remote (with normalization)
2026/10/28 04:50:27 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli': 0 differences found
2026/10/28 04:50:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli': 1 matching files
2026/10/28 04:50:27 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-volujiz7boze"
2026/10/28 04:50:27 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:27 DEBUG : Creating backend with remote "TestDrive:crypt/74gkq1rsjmtaqq46ui4m1k5iqlj6ob28qv67n2mudph5uv0ks810"
2026/10/28 04:50:29 DEBUG : Creating backend with remote "/tmp/rclone1781027692"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze'", Local "Local file system at /tmp/rclone1781027692", Modify Window "1ms"
2026/10/28 04:50:31 DEBUG : 測試_Русский___ě_áñ: md5 = 690baba9bb6811f4ce9f4849840f9473 OK
NFD checkfile vs. NFC remote (without normalization)
2026/10/28 04:50:32 ERROR : 測試_Русский___ě_áñ: sum not found
2026/10/28 04:50:32 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze'
2026/10/28 04:50:32 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze': 1 files missing
2026/10/28 04:50:32 NOTICE: 1 hashes missing
2026/10/28 04:50:32 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze': 1 differences found
2026/10/28 04:50:32 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze': 2 errors while checking
NFD checkfile vs. NFC remote (with normalization)
2026/10/28 04:50:33 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:33 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze': 0 differences found
2026/10/28 04:50:33 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze': 1 matching files
2026/10/28 04:50:33 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bujayud1goge"
2026/10/28 04:50:33 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:33 DEBUG : Creating backend with remote "TestDrive:crypt/hlu1funjmq4hj77agotvn6u23ff0pkq371gvlubhu5vapqbnts1g"
2026/10/28 04:50:34 DEBUG : Creating backend with remote "/tmp/rclone988040899"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge'", Local "Local file system at /tmp/rclone988040899", Modify Window "1ms"
2026/10/28 04:50:37 DEBUG : 測試_Русский___ě_áñ: md5 = 0a387e49d5f9062b5c1f98adbc26f8aa OK
NFC checkfile vs. NFD remote (without normalization)
2026/10/28 04:50:37 ERROR : 測試_Русский___ě_áñ: sum not found
2026/10/28 04:50:37 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge'
2026/10/28 04:50:37 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge': 1 files missing
2026/10/28 04:50:37 NOTICE: 1 hashes missing
2026/10/28 04:50:37 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge': 1 differences found
2026/10/28 04:50:37 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge': 2 errors while checking
NFC checkfile vs. NFD remote (with normalization)
2026/10/28 04:50:38 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:38 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge': 0 differences found
2026/10/28 04:50:38 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge': 1 matching files
2026/10/28 04:50:38 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-gavenib4xavi"
2026/10/28 04:50:38 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:38 DEBUG : Creating backend with remote "TestDrive:crypt/u7r1sjn2qs9t1fdm8u6um4jo9g9diab8gujss8p6a7593a2ulg00"
2026/10/28 04:50:39 DEBUG : Creating backend with remote "/tmp/rclone3189337019"
2026/10/28 04:50:39 DEBUG : Config file has changed externally - reloading
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi'", Local "Local file system at /tmp/rclone3189337019", Modify Window "1ms"
2026/10/28 04:50:42 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = c747673df70101ac42f12e6501eb29de OK
NFDx2 checkfile vs. both remote (without normalization)
2026/10/28 04:50:42 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/10/28 04:50:42 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi'
2026/10/28 04:50:42 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi': 1 files missing
2026/10/28 04:50:42 NOTICE: 1 hashes missing
2026/10/28 04:50:42 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi': 1 differences found
2026/10/28 04:50:42 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi': 2 errors while checking
NFDx2 checkfile vs. both remote (with normalization)
2026/10/28 04:50:43 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:43 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi': 0 differences found
2026/10/28 04:50:43 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi': 1 matching files
2026/10/28 04:50:43 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-nemeqoc9feqo"
2026/10/28 04:50:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:43 DEBUG : Creating backend with remote "TestDrive:crypt/oqno3vate4jmidnfr83okegadvido7pogntac98v0dseq9mmdugg"
2026/10/28 04:50:44 DEBUG : Creating backend with remote "/tmp/rclone1364857833"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo'", Local "Local file system at /tmp/rclone1364857833", Modify Window "1ms"
2026/10/28 04:50:47 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 3dd8f41d5433f20ad3ecb47774d9ace4 OK
NFCx2 checkfile vs. both remote (without normalization)
2026/10/28 04:50:48 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/10/28 04:50:48 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo'
2026/10/28 04:50:48 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo': 1 files missing
2026/10/28 04:50:48 NOTICE: 1 hashes missing
2026/10/28 04:50:48 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo': 1 differences found
2026/10/28 04:50:48 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo': 2 errors while checking
NFCx2 checkfile vs. both remote (with normalization)
2026/10/28 04:50:48 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:48 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo': 0 differences found
2026/10/28 04:50:48 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo': 1 matching files
2026/10/28 04:50:48 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-kiwuyaq9luvu"
2026/10/28 04:50:48 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:49 DEBUG : Creating backend with remote "TestDrive:crypt/j2v324cm5lfevf5246k1svqft4m6g4knre126nk5blmdu8in4h40"
2026/10/28 04:50:50 DEBUG : Creating backend with remote "/tmp/rclone2080053286"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu'", Local "Local file system at /tmp/rclone2080053286", Modify Window "1ms"
2026/10/28 04:50:52 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 6a8ff60c6cca912a187bcfd3e8448491 OK
both checkfile vs. NFDx2 remote (without normalization)
2026/10/28 04:50:53 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/10/28 04:50:53 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu'
2026/10/28 04:50:53 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu': 1 files missing
2026/10/28 04:50:53 NOTICE: 1 hashes missing
2026/10/28 04:50:53 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu': 1 differences found
2026/10/28 04:50:53 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu': 2 errors while checking
both checkfile vs. NFDx2 remote (with normalization)
2026/10/28 04:50:54 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:54 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu': 0 differences found
2026/10/28 04:50:54 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu': 1 matching files
2026/10/28 04:50:54 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-veduxev7pibu"
2026/10/28 04:50:54 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 04:50:54 DEBUG : Creating backend with remote "TestDrive:crypt/7gflaflsa41lpt909pushnnqc89c04calrkk1r2n8k4ap067kklg"
2026/10/28 04:50:55 DEBUG : Creating backend with remote "/tmp/rclone1802860284"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu'", Local "Local file system at /tmp/rclone1802860284", Modify Window "1ms"
2026/10/28 04:50:57 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 03ccabf8ee644eb095ee25a8b514c2b2 OK
both checkfile vs. NFCx2 remote (without normalization)
2026/10/28 04:50:58 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/10/28 04:50:58 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu'
2026/10/28 04:50:58 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu': 1 files missing
2026/10/28 04:50:58 NOTICE: 1 hashes missing
2026/10/28 04:50:58 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu': 1 differences found
2026/10/28 04:50:58 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu': 2 errors while checking
both checkfile vs. NFCx2 remote (with normalization)
2026/10/28 04:50:59 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/10/28 04:50:59 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu': 0 differences found
2026/10/28 04:50:59 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu': 1 matching files
2026/10/28 04:50:59 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-veduxev7pibu': Purge remote
2026/10/28 04:51:00 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-kiwuyaq9luvu': Purge remote
2026/10/28 04:51:00 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-nemeqoc9feqo': Purge remote
2026/10/28 04:51:01 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-gavenib4xavi': Purge remote
2026/10/28 04:51:01 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-bujayud1goge': Purge remote
2026/10/28 04:51:02 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-volujiz7boze': Purge remote
2026/10/28 04:51:02 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-todifev6juli': Purge remote
2026/10/28 04:51:03 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pofaser2cevu': Purge remote
2026/10/28 04:51:03 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-diyiluh5radu': Purge remote
2026/10/28 04:51:04 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-piticew3masi': Purge remote
--- PASS: TestApplyTransforms (57.47s)
=== RUN   TestTruncateString
--- PASS: TestTruncateString (0.00s)
=== RUN   TestCopyFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:51:05 DEBUG : file1: Need to transfer - File not found at Destination
2026/10/28 04:51:07 DEBUG : sub/file2: md5 = 1a75b0f333dc6c9f172ec15186719378 OK
2026/10/28 04:51:07 DEBUG : sub/file2: size = 14 OK
2026/10/28 04:51:07 INFO  : file1: Copied (new) to: sub/file2
2026/10/28 04:51:08 DEBUG : sub/file2: size = 14 OK
2026/10/28 04:51:08 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/10/28 04:51:08 DEBUG : file1: Unchanged skipping
2026/10/28 04:51:09 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestCopyFile (7.08s)
=== RUN   TestCopyFileImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:51:12 DEBUG : existing: Need to transfer - File not found at Destination
2026/10/28 04:51:13 DEBUG : existing: md5 = a61b53e4314374c11fbcea9eef667abc OK
2026/10/28 04:51:13 DEBUG : existing: size = 6 OK
2026/10/28 04:51:13 INFO  : existing: Copied (new)
2026/10/28 04:51:14 DEBUG : existing: size = 6 OK
2026/10/28 04:51:14 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/10/28 04:51:14 DEBUG : existing: Unchanged skipping
2026/10/28 04:51:15 DEBUG : existing: size = 8 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:51:15 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 04:51:15 DEBUG : existing: Sizes differ
2026/10/28 04:51:15 ERROR : existing: Source and destination exist but do not match: immutable file modified
--- PASS: TestCopyFileImmutable (4.72s)
=== RUN   TestCopyLongFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    copy_test.go:188: Test only runs on local
--- SKIP: TestCopyLongFile (0.49s)
=== RUN   TestCopyFileBackupDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:51:19 DEBUG : dst/file1: md5 = 9e04f22411377f993d31a3ebd090095b OK
2026/10/28 04:51:20 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/backup"
2026/10/28 04:51:20 DEBUG : Config file has changed externally - reloading
2026/10/28 04:51:20 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/1nrff024r7pq65ecp72fc28jb0"
2026/10/28 04:51:22 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:51:22 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 04:51:22 DEBUG : dst/file1: Sizes differ
2026/10/28 04:51:25 INFO  : dst/file1: Moved (server-side)
2026/10/28 04:51:26 DEBUG : dst/file1: md5 = 015e3d165778405bb350b6a0ad626682 OK
2026/10/28 04:51:26 DEBUG : dst/file1: size = 14 OK
2026/10/28 04:51:26 INFO  : dst/file1: Copied (new)
--- PASS: TestCopyFileBackupDir (14.72s)
=== RUN   TestCopyFileCompareDest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:51:32 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/dst"
2026/10/28 04:51:32 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/31u3jie661vd5p8j7rtc3hgbh0"
2026/10/28 04:51:33 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/CompareDest"
2026/10/28 04:51:33 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/gveqi14airsml4bgu7krj116o8"
2026/10/28 04:51:35 DEBUG : one: Need to transfer - File not found at Destination
2026/10/28 04:51:38 DEBUG : one: md5 = bbaddfe3e68d19414ffb24dc30253d32 OK
2026/10/28 04:51:38 DEBUG : one: size = 3 OK
2026/10/28 04:51:38 INFO  : one: Copied (new)
2026/10/28 04:51:39 DEBUG : one: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:51:39 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/dst')
2026/10/28 04:51:39 DEBUG : one: Sizes differ
2026/10/28 04:51:41 DEBUG : one: md5 = d1f210ed8168edf04c401f7babd102ad OK
2026/10/28 04:51:41 DEBUG : one: size = 5 OK
2026/10/28 04:51:41 INFO  : one: Copied (replaced existing)
2026/10/28 04:51:43 DEBUG : dst/one: md5 = 9517efbcbc47696b4a98f1c8c243eaeb OK
2026/10/28 04:51:46 DEBUG : CompareDest/one: md5 = 911f5354e5e9666004ac6dd17c33e77a OK
2026/10/28 04:51:47 DEBUG : one: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:51:47 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/dst')
2026/10/28 04:51:47 DEBUG : one: Sizes differ
2026/10/28 04:51:47 DEBUG : one: size = 5 OK
2026/10/28 04:51:47 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/10/28 04:51:47 DEBUG : one: Destination found in --compare-dest, skipping
2026/10/28 04:51:49 DEBUG : CompareDest/two: md5 = b834fb332db9ab9dd8bffd81d6dc85ef OK
2026/10/28 04:51:50 DEBUG : two: Need to transfer - File not found at Destination
2026/10/28 04:51:50 DEBUG : two: size = 3 OK
2026/10/28 04:51:50 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/10/28 04:51:50 DEBUG : two: Destination found in --compare-dest, skipping
2026/10/28 04:51:51 DEBUG : two: Need to transfer - File not found at Destination
2026/10/28 04:51:51 DEBUG : two: size = 3 OK
2026/10/28 04:51:51 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/10/28 04:51:51 DEBUG : two: Destination found in --compare-dest, skipping
2026/10/28 04:51:53 DEBUG : two: Need to transfer - File not found at Destination
2026/10/28 04:51:53 DEBUG : two: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:51:53 DEBUG : two: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/CompareDest')
2026/10/28 04:51:53 DEBUG : two: Sizes differ
2026/10/28 04:51:54 DEBUG : two: md5 = c010fa14a418e0d63de9ad201d26ac5c OK
2026/10/28 04:51:54 DEBUG : two: size = 5 OK
2026/10/28 04:51:54 INFO  : two: Copied (new)
--- PASS: TestCopyFileCompareDest (28.28s)
=== RUN   TestCopyFileCopyDestImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:52:00 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/dst"
2026/10/28 04:52:00 DEBUG : Config file has changed externally - reloading
2026/10/28 04:52:00 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/31u3jie661vd5p8j7rtc3hgbh0"
2026/10/28 04:52:04 DEBUG : dst/one: md5 = a8171a6e0226c27e63ce3c3cd58d334c OK
2026/10/28 04:52:07 DEBUG : CopyDest/one: md5 = 1d9cd4a4626bdfe774c3fcfc1bcd7d57 OK
2026/10/28 04:52:08 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/CopyDest"
2026/10/28 04:52:08 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/d09o6po3f7bm6ce32vdgs8h9ls"
2026/10/28 04:52:09 DEBUG : one: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:52:09 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/dst')
2026/10/28 04:52:09 DEBUG : one: Sizes differ
2026/10/28 04:52:09 DEBUG : one: size = 5 OK
2026/10/28 04:52:09 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/10/28 04:52:09 DEBUG : one: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:52:09 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/dst')
2026/10/28 04:52:09 DEBUG : one: Sizes differ
2026/10/28 04:52:09 ERROR : one: Source and destination exist but do not match: immutable file modified
--- PASS: TestCopyFileCopyDestImmutable (13.14s)
=== RUN   TestCopyFileCopyDest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:52:13 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/dst"
2026/10/28 04:52:13 DEBUG : Config file has changed externally - reloading
2026/10/28 04:52:13 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/31u3jie661vd5p8j7rtc3hgbh0"
2026/10/28 04:52:15 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/CopyDest"
2026/10/28 04:52:15 DEBUG : Config file has changed externally - reloading
2026/10/28 04:52:15 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/d09o6po3f7bm6ce32vdgs8h9ls"
2026/10/28 04:52:17 DEBUG : one: Need to transfer - File not found at Destination
2026/10/28 04:52:19 DEBUG : one: md5 = 65410c575e7380085da09d54b9a38f9d OK
2026/10/28 04:52:19 DEBUG : one: size = 3 OK
2026/10/28 04:52:19 INFO  : one: Copied (new)
2026/10/28 04:52:21 DEBUG : one: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:52:21 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/dst')
2026/10/28 04:52:21 DEBUG : one: Sizes differ
2026/10/28 04:52:22 DEBUG : one: md5 = 2d4ed3d8241643a6a59db18ea6b12bea OK
2026/10/28 04:52:22 DEBUG : one: size = 5 OK
2026/10/28 04:52:22 INFO  : one: Copied (replaced existing)
2026/10/28 04:52:25 DEBUG : dst/one: md5 = 8ec61d5e9374d1e3f500c2b55e15edac OK
2026/10/28 04:52:28 DEBUG : CopyDest/one: md5 = 1741de59f61c115ff1dc0f27c0064393 OK
2026/10/28 04:52:29 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/BackupDir"
2026/10/28 04:52:29 DEBUG : Config file has changed externally - reloading
2026/10/28 04:52:29 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/s6dbk3lfi7c9kfvo6j7bla9m0g"
2026/10/28 04:52:30 DEBUG : one: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:52:30 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/dst')
2026/10/28 04:52:30 DEBUG : one: Sizes differ
2026/10/28 04:52:31 DEBUG : one: size = 5 OK
2026/10/28 04:52:31 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/10/28 04:52:31 DEBUG : one: size = 5 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:52:31 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/dst')
2026/10/28 04:52:31 DEBUG : one: Sizes differ
2026/10/28 04:52:33 INFO  : one: Moved (server-side)
2026/10/28 04:52:34 DEBUG : one: size = 5 OK
2026/10/28 04:52:34 INFO  : one: Copied (server-side copy)
2026/10/28 04:52:34 DEBUG : one: Destination found in --copy-dest, using server-side copy
2026/10/28 04:52:36 DEBUG : CopyDest/two: md5 = c0dbfda641befed19045c8ac41eb8419 OK
2026/10/28 04:52:37 DEBUG : two: Need to transfer - File not found at Destination
2026/10/28 04:52:37 DEBUG : two: size = 3 OK
2026/10/28 04:52:37 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/10/28 04:52:39 DEBUG : two: size = 3 OK
2026/10/28 04:52:39 INFO  : two: Copied (server-side copy)
2026/10/28 04:52:39 DEBUG : two: Destination found in --copy-dest, using server-side copy
2026/10/28 04:52:40 DEBUG : two: size = 3 OK
2026/10/28 04:52:40 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/10/28 04:52:40 DEBUG : two: Unchanged skipping
2026/10/28 04:52:42 DEBUG : CopyDest/three: md5 = fef99b3d0235a2a1915aa47cc94578b1 OK
2026/10/28 04:52:43 DEBUG : three: Need to transfer - File not found at Destination
2026/10/28 04:52:43 DEBUG : three: size = 7 (Local file system at /tmp/rclone3097667400)
2026/10/28 04:52:43 DEBUG : three: size = 5 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada/CopyDest')
2026/10/28 04:52:43 DEBUG : three: Sizes differ
2026/10/28 04:52:43 DEBUG : three: Destination not found in --copy-dest
2026/10/28 04:52:45 DEBUG : three: md5 = 6f93f708b11cc4a2e666894d6f924724 OK
2026/10/28 04:52:45 DEBUG : three: size = 7 OK
2026/10/28 04:52:45 INFO  : three: Copied (new)
--- PASS: TestCopyFileCopyDest (39.29s)
=== RUN   TestCopyInplace
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    copy_test.go:434: Partial uploads not supported
--- SKIP: TestCopyInplace (0.51s)
=== RUN   TestCopyLongFileName
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    copy_test.go:467: Partial uploads not supported
--- SKIP: TestCopyLongFileName (0.47s)
=== RUN   TestCopyLongFileNameCollision
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    copy_test.go:500: Partial uploads not supported
--- SKIP: TestCopyLongFileNameCollision (0.52s)
=== RUN   TestCopyFileMaxTransfer
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:52:54 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination
2026/10/28 04:52:57 DEBUG : TestCopyFileMaxTransfer/file1: md5 = fb18907ad9f28bf87ec0cbd1348aa42e OK
2026/10/28 04:52:57 DEBUG : TestCopyFileMaxTransfer/file1: size = 14 OK
2026/10/28 04:52:57 INFO  : TestCopyFileMaxTransfer/file1: Copied (new)
2026/10/28 04:52:57 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination
2026/10/28 04:52:58 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/10/28 04:52:59 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination
2026/10/28 04:52:59 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination
2026/10/28 04:53:01 DEBUG : TestCopyFileMaxTransfer/file4: md5 = 47267e6886eff0657fa2c0332e4949e9 OK
2026/10/28 04:53:01 DEBUG : TestCopyFileMaxTransfer/file4: size = 2062 OK
2026/10/28 04:53:01 INFO  : TestCopyFileMaxTransfer/file4: Copied (new)
--- PASS: TestCopyFileMaxTransfer (10.48s)
=== RUN   TestDeduplicateInteractive
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    dedupe_test.go:37: Can't run this test without a hash
--- SKIP: TestDeduplicateInteractive (0.47s)
=== RUN   TestDeduplicateSkip
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:53:08 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using skip mode.
2026/10/28 04:53:08 NOTICE: one: Found 2 files with duplicate names
2026/10/28 04:53:08 NOTICE: one: Skipping 2 files with duplicate names
--- PASS: TestDeduplicateSkip (5.60s)
=== RUN   TestDeduplicateSizeOnly
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:53:15 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using skip mode.
2026/10/28 04:53:16 NOTICE: one: Found 3 files with duplicate names
2026/10/28 04:53:16 NOTICE: one: Deleting 1/2 identical duplicates (size 11)
2026/10/28 04:53:16 INFO  : one: Deleted
2026/10/28 04:53:16 NOTICE: one: Skipping 2 files with duplicate names
--- PASS: TestDeduplicateSizeOnly (7.68s)
=== RUN   TestDeduplicateFirst
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:53:22 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using first mode.
2026/10/28 04:53:23 NOTICE: one: Found 3 files with duplicate names
2026/10/28 04:53:24 INFO  : one: Deleted
2026/10/28 04:53:24 INFO  : one: Deleted
2026/10/28 04:53:24 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateFirst (7.54s)
=== RUN   TestDeduplicateNewest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:53:30 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using newest mode.
2026/10/28 04:53:31 NOTICE: one: Found 3 files with duplicate names
2026/10/28 04:53:31 INFO  : one: Deleted
2026/10/28 04:53:32 INFO  : one: Deleted
2026/10/28 04:53:32 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateNewest (7.56s)
=== RUN   TestDeduplicateNewestByHash
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    dedupe_test.go:37: Can't run this test without a hash
--- SKIP: TestDeduplicateNewestByHash (0.52s)
=== RUN   TestDeduplicateOldest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:53:38 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using oldest mode.
2026/10/28 04:53:39 NOTICE: one: Found 3 files with duplicate names
2026/10/28 04:53:39 INFO  : one: Deleted
2026/10/28 04:53:40 INFO  : one: Deleted
2026/10/28 04:53:40 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateOldest (7.34s)
=== RUN   TestDeduplicateLargest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:53:46 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using largest mode.
2026/10/28 04:53:46 NOTICE: one: Found 3 files with duplicate names
2026/10/28 04:53:47 INFO  : one: Deleted
2026/10/28 04:53:47 INFO  : one: Deleted
2026/10/28 04:53:47 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateLargest (8.00s)
=== RUN   TestDeduplicateSmallest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:53:53 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using smallest mode.
2026/10/28 04:53:54 NOTICE: one: Found 3 files with duplicate names
2026/10/28 04:53:55 INFO  : one: Deleted
2026/10/28 04:53:55 INFO  : one: Deleted
2026/10/28 04:53:55 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateSmallest (7.54s)
=== RUN   TestDeduplicateRename
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:54:03 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using rename mode.
2026/10/28 04:54:03 NOTICE: one.txt: Found 3 files with duplicate names
2026/10/28 04:54:04 INFO  : one-2.txt: renamed from: one.txt
2026/10/28 04:54:05 INFO  : one-3.txt: renamed from: one.txt
2026/10/28 04:54:05 INFO  : one-4.txt: renamed from: one.txt
--- PASS: TestDeduplicateRename (11.97s)
=== RUN   TestDeduplicateRenameManyExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:54:10 DEBUG : one-1.txt: md5 = 203a6b7ff8baec00aad3aac12106aca9 OK
2026/10/28 04:54:12 DEBUG : one-2.txt: md5 = 29cf3629372d81778de931fa19dc351d OK
2026/10/28 04:54:14 DEBUG : one-3.txt: md5 = 8c7ead1027e32efd6820039bd20c26f6 OK
2026/10/28 04:54:15 DEBUG : one-4.txt: md5 = 95b82611f4517754ef2c0600438ca56d OK
2026/10/28 04:54:17 DEBUG : one-5.txt: md5 = 432332ced22b6120993402d838fa7f73 OK
2026/10/28 04:54:18 DEBUG : one-6.txt: md5 = 4d36fc673dd3006e014d0b215f862d3a OK
2026/10/28 04:54:20 DEBUG : one-7.txt: md5 = 9d60dda0945198629a3265eea613706f OK
2026/10/28 04:54:22 DEBUG : one-8.txt: md5 = 7cdf1849a5c72c13f2cb3782b840cbe6 OK
2026/10/28 04:54:23 DEBUG : one-9.txt: md5 = 6606dc39825fe33dcbccd93748232348 OK
2026/10/28 04:54:25 DEBUG : one-10.txt: md5 = d4794ab3f5b0acf9e1f50f6870253130 OK
2026/10/28 04:54:27 DEBUG : one-11.txt: md5 = 7462961eb5bb4fc41c1b3d8772c84654 OK
2026/10/28 04:54:28 DEBUG : one-12.txt: md5 = db6a4877de2b42d0ed1571ec4dad507b OK
2026/10/28 04:54:30 DEBUG : one-13.txt: md5 = 505ad883f88d618b8c1f54f9b335594c OK
2026/10/28 04:54:32 DEBUG : one-14.txt: md5 = bdd42d8a39be44ad7525e13b1f4e005e OK
2026/10/28 04:54:34 DEBUG : one-15.txt: md5 = 5408de0d65c7ede0e92abf8610edb022 OK
2026/10/28 04:54:35 DEBUG : one-16.txt: md5 = c19e8b2d1aeab40f95b00bee11159948 OK
2026/10/28 04:54:37 DEBUG : one-17.txt: md5 = ad06ce608f5155ed970fdc793015ae39 OK
2026/10/28 04:54:38 DEBUG : one-18.txt: md5 = e65654d496e60cab03d80d7032d7ac53 OK
2026/10/28 04:54:40 DEBUG : one-19.txt: md5 = 497a73e60a9bb6e6e4e8450af3fba697 OK
2026/10/28 04:54:42 DEBUG : one-20.txt: md5 = b3fda44f6ef178e83e0914db419559cd OK
2026/10/28 04:54:43 DEBUG : one-21.txt: md5 = cf4e28cb25ee91ad32fa8fd2101a6dc1 OK
2026/10/28 04:54:45 DEBUG : one-22.txt: md5 = c6b40d28fa1a62c0a80a19ce1cf7bb53 OK
2026/10/28 04:54:46 DEBUG : one-23.txt: md5 = d879c53a7140ed91e1ddb4ef48d74738 OK
2026/10/28 04:54:48 DEBUG : one-24.txt: md5 = d03301d2eb788b54ddc82de0b0bc891e OK
2026/10/28 04:54:50 DEBUG : one-25.txt: md5 = 23742b11d1ac419dfd16835eb77da822 OK
2026/10/28 04:54:51 DEBUG : one-26.txt: md5 = a819550a3ef7a90f1c18e2af8bd02fe8 OK
2026/10/28 04:54:53 DEBUG : one-27.txt: md5 = 7c52e455dde63363bc26d04198c29bd2 OK
2026/10/28 04:54:55 DEBUG : one-28.txt: md5 = 421b94b54439c53f1980666059524ee2 OK
2026/10/28 04:54:56 DEBUG : one-29.txt: md5 = fcbe7e8213684b254a5dad070c1b545f OK
2026/10/28 04:54:58 DEBUG : one-30.txt: md5 = a333d2358bf04701917d0852e0797828 OK
2026/10/28 04:55:00 DEBUG : one-31.txt: md5 = 5878ea6c11e019434d1e4230c702cc7c OK
2026/10/28 04:55:01 DEBUG : one-32.txt: md5 = d8e0dadf6e01da2cbffa2267d14bfd1d OK
2026/10/28 04:55:03 DEBUG : one-33.txt: md5 = f2688b46ac8584a3f22566896d5485dc OK
2026/10/28 04:55:04 DEBUG : one-34.txt: md5 = 2b67b5e9e3cf578ff0b3acc1db96020a OK
2026/10/28 04:55:06 DEBUG : one-35.txt: md5 = a2056af0d2d03ae47e86aa4bb49da731 OK
2026/10/28 04:55:07 DEBUG : one-36.txt: md5 = 1760a6305a4678f5fa32d9f3c8bebaad OK
2026/10/28 04:55:09 DEBUG : one-37.txt: md5 = 65aec71c7a7654fe1004f13c4685060c OK
2026/10/28 04:55:10 DEBUG : one-38.txt: md5 = 7ef7100ba079397fe6110d7ee047a632 OK
2026/10/28 04:55:12 DEBUG : one-39.txt: md5 = a853716b3a1677574f05cf4154434e33 OK
2026/10/28 04:55:14 DEBUG : one-40.txt: md5 = 6c9a013817e1304fb03d6487441132e0 OK
2026/10/28 04:55:15 DEBUG : one-41.txt: md5 = fb07605b0129cbbeddd661d72e0d8dce OK
2026/10/28 04:55:17 DEBUG : one-42.txt: md5 = 4ccf5062f6884c77fbd30837e7d6554e OK
2026/10/28 04:55:19 DEBUG : one-43.txt: md5 = 41d03c772eeb8b6a22f5313025ddedb6 OK
2026/10/28 04:55:20 DEBUG : one-44.txt: md5 = aae9d38cb27f91332a5b03d0460b59b5 OK
2026/10/28 04:55:22 DEBUG : one-45.txt: md5 = 3b8a672f8529c24c66eeadaf5b5688a6 OK
2026/10/28 04:55:24 DEBUG : one-46.txt: md5 = e3dc19f291c7f5c7bd56255baa1ff928 OK
2026/10/28 04:55:25 DEBUG : one-47.txt: md5 = 1381b82174f26ccfea3fe15d5fe4f363 OK
2026/10/28 04:55:27 DEBUG : one-48.txt: md5 = 4de6a9516d7b1195250ccfea3c0cf1d1 OK
2026/10/28 04:55:28 DEBUG : one-49.txt: md5 = ce2687030c82acd81c8578fd1a6d7e86 OK
2026/10/28 04:55:30 DEBUG : one-50.txt: md5 = c65a0e935ac620f1307763720d3dc3a9 OK
2026/10/28 04:55:32 DEBUG : one-51.txt: md5 = 672bc1b559c7ba4da0cccc38f505ca73 OK
2026/10/28 04:55:33 DEBUG : one-52.txt: md5 = a289c8e20fcf51fc003f59278c149448 OK
2026/10/28 04:55:35 DEBUG : one-53.txt: md5 = 5ed46cbcde2e8e2f9c727a2a62e6d02a OK
2026/10/28 04:55:37 DEBUG : one-54.txt: md5 = c71d26db42f784797fb51de398236fe4 OK
2026/10/28 04:55:38 DEBUG : one-55.txt: md5 = 7cd89e754fa6fcf87f11d70ebea684fc OK
2026/10/28 04:55:40 DEBUG : one-56.txt: md5 = 8a5e564bebac8cda8b2ab69afc81f9bc OK
2026/10/28 04:55:42 DEBUG : one-57.txt: md5 = 9ea28952f5a846ee0537958a5de2a4eb OK
2026/10/28 04:55:43 DEBUG : one-58.txt: md5 = 2d7fb1bfa6258453a5e4618423f840ab OK
2026/10/28 04:55:45 DEBUG : one-59.txt: md5 = 0b557dbe7096e71bcef1c7b3efe6da03 OK
2026/10/28 04:55:46 DEBUG : one-60.txt: md5 = b907c02e84cd77c841ac9182c97b4ec8 OK
2026/10/28 04:55:48 DEBUG : one-61.txt: md5 = f8fd7a740947417ddf8beef9b9b4f609 OK
2026/10/28 04:55:50 DEBUG : one-62.txt: md5 = 97416f1c36616732aab7cfdacf3a71e8 OK
2026/10/28 04:55:51 DEBUG : one-63.txt: md5 = d223ea9a05780e5a74b1be90afac057c OK
2026/10/28 04:55:53 DEBUG : one-64.txt: md5 = e43facd31f9ba9729d84869865fe26cb OK
2026/10/28 04:55:54 DEBUG : one-65.txt: md5 = df2fa0ce7999c4692b41ad93a3daf474 OK
2026/10/28 04:55:56 DEBUG : one-66.txt: md5 = 954d5dee0b59388817d79835ff71edba OK
2026/10/28 04:55:57 DEBUG : one-67.txt: md5 = 079a314c2e1160f8795ca41aa44a4d4b OK
2026/10/28 04:55:59 DEBUG : one-68.txt: md5 = a64524a1f6bcbed5677e74e04866359f OK
2026/10/28 04:56:01 DEBUG : one-69.txt: md5 = aaeca0546994147cba8e423663b23134 OK
2026/10/28 04:56:03 DEBUG : one-70.txt: md5 = 41567294d2299be77515ee3cb97acb4d OK
2026/10/28 04:56:04 DEBUG : one-71.txt: md5 = f85fe0e6e31861fa6d7d72fced2e1133 OK
2026/10/28 04:56:06 DEBUG : one-72.txt: md5 = 9e35c876039f4d6de27994d919792119 OK
2026/10/28 04:56:07 DEBUG : one-73.txt: md5 = 0cd2a03935e1d0d987a75427d21d5e37 OK
2026/10/28 04:56:09 DEBUG : one-74.txt: md5 = 7cd4622bb990b62266532001eee3c3cb OK
2026/10/28 04:56:11 DEBUG : one-75.txt: md5 = 47bdf1355f67f1084828d739e8135150 OK
2026/10/28 04:56:12 DEBUG : one-76.txt: md5 = 0a10b96b0c26b51d478e0751f631ba32 OK
2026/10/28 04:56:14 DEBUG : one-77.txt: md5 = d3afcfa3d3692cb6e2191f8eade099ce OK
2026/10/28 04:56:16 DEBUG : one-78.txt: md5 = f3067ce27df4dee41f86ede7bdbe2965 OK
2026/10/28 04:56:17 DEBUG : one-79.txt: md5 = e468cc4ffa3fed97de7c703b0e94f917 OK
2026/10/28 04:56:19 DEBUG : one-80.txt: md5 = 1f5e7ed7b32d08d3a9134603307302da OK
2026/10/28 04:56:21 DEBUG : one-81.txt: md5 = 832e23d1910f2281e9e9d358afeeb746 OK
2026/10/28 04:56:22 DEBUG : one-82.txt: md5 = 94439fce93db3b29c79acc3d565bff11 OK
2026/10/28 04:56:24 DEBUG : one-83.txt: md5 = 6cc0e1edb1a845cbf3062cce91ade2b7 OK
2026/10/28 04:56:25 DEBUG : one-84.txt: md5 = ac68d3871f62561d51f3533e5f174303 OK
2026/10/28 04:56:27 DEBUG : one-85.txt: md5 = 6ea0c6942c24d343618ba7835cd492a3 OK
2026/10/28 04:56:29 DEBUG : one-86.txt: md5 = 3f8e712a4e84dca0c3dfb7bab6115bb2 OK
2026/10/28 04:56:30 DEBUG : one-87.txt: md5 = c3d223ecc7c97963215f7b8e95facfcf OK
2026/10/28 04:56:32 DEBUG : one-88.txt: md5 = f4701d17a5d3d3edddd81b1ab55a4d55 OK
2026/10/28 04:56:34 DEBUG : one-89.txt: md5 = 54212a7fd5b7e4efdd05ac9dd78d78d0 OK
2026/10/28 04:56:35 DEBUG : one-90.txt: md5 = aa1578ad4d67bb5ce380b046305c6da6 OK
2026/10/28 04:56:37 DEBUG : one-91.txt: md5 = b8cf2fc357dd82674b3f5146ad29cb2c OK
2026/10/28 04:56:38 DEBUG : one-92.txt: md5 = 0c8e2022d98defb2bc8a30868b494938 OK
2026/10/28 04:56:40 DEBUG : one-93.txt: md5 = f36222cbc7f212feb3f22fb6102971a2 OK
2026/10/28 04:56:41 DEBUG : one-94.txt: md5 = 3e9f8a0eed22887b182330e662ba14ed OK
2026/10/28 04:56:43 DEBUG : one-95.txt: md5 = 520edd8d10f7eea062636cdc1ad66ddb OK
2026/10/28 04:56:45 DEBUG : one-96.txt: md5 = 2d03ed7c725ad065c5604ecd7c0222b9 OK
2026/10/28 04:56:46 DEBUG : one-97.txt: md5 = 9505ac6f119f6f73b142ca834dba062b OK
2026/10/28 04:56:48 DEBUG : one-98.txt: md5 = c1f09b77c8bf0464c16f7dc2d27030fb OK
2026/10/28 04:56:50 DEBUG : one-99.txt: md5 = 5caa631302c8cafd7d31812dc4171b9f OK
2026/10/28 04:56:51 DEBUG : one-100.txt: md5 = af6f5fecce04f00bb8230ae00705d203 OK
2026/10/28 04:56:53 DEBUG : one-101.txt: md5 = 604103ba61dd6cd4e924bb35ca60a66c OK
2026/10/28 04:56:55 DEBUG : one-102.txt: md5 = 94a6c1e658fb0c2a27b013e6bff72b14 OK
2026/10/28 04:56:56 DEBUG : one-103.txt: md5 = 0e347dd263f0ada37b34117548c0fc01 OK
2026/10/28 04:56:58 DEBUG : one-104.txt: md5 = 22053431200350a8acd0b3d363b60919 OK
2026/10/28 04:56:59 DEBUG : one-105.txt: md5 = 50d4311ef6c05dfe11b04c517b83c8e8 OK
2026/10/28 04:57:02 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Looking for duplicate names using rename mode.
2026/10/28 04:57:03 NOTICE: one.txt: Found 2 files with duplicate names
2026/10/28 04:57:04 INFO  : one-106.txt: renamed from: one.txt
2026/10/28 04:57:05 INFO  : one-107.txt: renamed from: one.txt
--- PASS: TestDeduplicateRenameManyExisting (237.99s)
=== RUN   TestMergeDirs
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:58:09 DEBUG : dupe1/one.txt: md5 = ff9559998d27d0746f0f109003539614 OK
2026/10/28 04:58:12 DEBUG : dupe2/two.txt: md5 = ca513efe9bc67b8e6d120992956fc63e OK
2026/10/28 04:58:14 DEBUG : dupe3/three.txt: md5 = 0114952543aeb30a8772a058d440fe34 OK
2026/10/28 04:58:15 INFO  : urj8gsducqbtvekeq181ntd2u8: merging "sfrom47189m9qr3mt4qonu281c"
2026/10/28 04:58:16 INFO  : urj8gsducqbtvekeq181ntd2u8: removing empty directory
2026/10/28 04:58:17 INFO  : 1u1r4ei7c628fnjg9blqt3j60o: merging "tr2hj63d80ftlmvm6a952snjcc"
2026/10/28 04:58:18 INFO  : 1u1r4ei7c628fnjg9blqt3j60o: removing empty directory
--- PASS: TestMergeDirs (16.36s)
=== RUN   TestIndex
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:58:24 DEBUG : file1.txt: md5 = b8c2eb44f7f9f9da9717ade9cb79e94a OK
2026/10/28 04:58:27 DEBUG : sub/file2.txt: md5 = 427b1d531974d51121d96384af44d359 OK
2026/10/28 04:58:29 DEBUG : sub/deep/file3.txt: md5 = 23e4c3005165bdef1b644c8e6f7915bf OK
2026/10/28 04:58:32 DEBUG : index.json: md5 = a820418a5f37311347d81c0acbf2f5ae OK
2026/10/28 04:58:32 DEBUG : index.json: size = 213 OK
2026/10/28 04:58:32 INFO  : index.json: Copied (new)
2026/10/28 04:58:32 DEBUG : sub/deep/index.html: md5 = 4f57fb46adcdeda76b49097c0d3104c4 OK
2026/10/28 04:58:32 DEBUG : sub/deep/index.html: size = 12087 OK
2026/10/28 04:58:32 INFO  : sub/deep/index.html: Copied (new)
2026/10/28 04:58:32 DEBUG : caddy.json: md5 = b158e429c20840bee52a00ca81dc96e7 OK
2026/10/28 04:58:32 DEBUG : caddy.json: size = 259 OK
2026/10/28 04:58:32 INFO  : caddy.json: Copied (new)
2026/10/28 04:58:32 DEBUG : index.html: md5 = 6e42c53f497a160c90d83ad401ea7cc0 OK
2026/10/28 04:58:32 DEBUG : index.html: size = 12147 OK
2026/10/28 04:58:32 INFO  : index.html: Copied (new)
2026/10/28 04:58:33 DEBUG : sub/deep/index.json: md5 = d96e1acbdca623e3881852750db9f034 OK
2026/10/28 04:58:33 DEBUG : sub/deep/index.json: size = 119 OK
2026/10/28 04:58:33 INFO  : sub/deep/index.json: Copied (new)
2026/10/28 04:58:33 DEBUG : sub/deep/caddy.json: md5 = c9e32ec7ea6e876c226aa37f50b85d33 OK
2026/10/28 04:58:33 DEBUG : sub/deep/caddy.json: size = 131 OK
2026/10/28 04:58:33 INFO  : sub/deep/caddy.json: Copied (new)
2026/10/28 04:58:33 DEBUG : sub/index.html: md5 = ec3388cc895d2b281c4eecd7dc393a02 OK
2026/10/28 04:58:33 DEBUG : sub/index.html: size = 12306 OK
2026/10/28 04:58:33 INFO  : sub/index.html: Copied (new)
2026/10/28 04:58:33 DEBUG : sub/index.json: md5 = 34c83b4af3b8f4497d26dc5314e9cb0b OK
2026/10/28 04:58:33 DEBUG : sub/index.json: size = 215 OK
2026/10/28 04:58:33 INFO  : sub/index.json: Copied (new)
2026/10/28 04:58:35 DEBUG : sub/caddy.json: md5 = 24fe7d41dce6a19e12781ad5b4575dfc OK
2026/10/28 04:58:35 DEBUG : sub/caddy.json: size = 261 OK
2026/10/28 04:58:35 INFO  : sub/caddy.json: Copied (new)
2026/10/28 04:58:41 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 04:58:41 DEBUG : index.html: Unchanged skipping
2026/10/28 04:58:41 DEBUG : sub/deep/index.html: Unchanged skipping
2026/10/28 04:58:41 DEBUG : index.json: Unchanged skipping
2026/10/28 04:58:41 DEBUG : sub/index.json: Unchanged skipping
2026/10/28 04:58:42 DEBUG : sub/deep/index.json: Unchanged skipping
2026/10/28 04:58:42 DEBUG : caddy.json: Unchanged skipping
2026/10/28 04:58:42 DEBUG : sub/caddy.json: Unchanged skipping
2026/10/28 04:58:42 DEBUG : sub/deep/caddy.json: Unchanged skipping
2026/10/28 04:58:44 DEBUG : caddy.json: md5 = 24d30d55a84087a06d3092ecdf0291fa OK
2026/10/28 04:58:44 DEBUG : caddy.json: size = 259 OK
2026/10/28 04:58:44 INFO  : caddy.json: Copied (replaced existing)
2026/10/28 04:58:44 DEBUG : index.html: md5 = 1b71ecedc9fb3ede7291991953a84b62 OK
2026/10/28 04:58:44 DEBUG : index.html: size = 12147 OK
2026/10/28 04:58:44 INFO  : index.html: Copied (replaced existing)
2026/10/28 04:58:44 DEBUG : sub/deep/index.html: md5 = 82d408f262279c156754325586bb6a85 OK
2026/10/28 04:58:44 DEBUG : sub/deep/index.html: size = 12087 OK
2026/10/28 04:58:44 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/10/28 04:58:44 DEBUG : index.json: md5 = 69a970ac0db8c779a9a00caf191a9a32 OK
2026/10/28 04:58:44 DEBUG : index.json: size = 213 OK
2026/10/28 04:58:44 INFO  : index.json: Copied (replaced existing)
2026/10/28 04:58:46 DEBUG : sub/index.json: md5 = 4c12c18bb090d026e100da9c6f68a930 OK
2026/10/28 04:58:46 DEBUG : sub/index.json: size = 215 OK
2026/10/28 04:58:46 INFO  : sub/index.json: Copied (replaced existing)
2026/10/28 04:58:46 DEBUG : sub/deep/caddy.json: md5 = f26a6bdf28dff984036708e86b5fb6a4 OK
2026/10/28 04:58:46 DEBUG : sub/deep/caddy.json: size = 131 OK
2026/10/28 04:58:46 INFO  : sub/deep/caddy.json: Copied (replaced existing)
2026/10/28 04:58:46 DEBUG : sub/deep/index.json: md5 = 2e82ff91f0c62eca40aa367ae37984ec OK
2026/10/28 04:58:46 DEBUG : sub/deep/index.json: size = 119 OK
2026/10/28 04:58:46 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/10/28 04:58:46 DEBUG : sub/index.html: md5 = 37e5b6e3d962f44d3856d0b484bb3086 OK
2026/10/28 04:58:46 DEBUG : sub/index.html: size = 12306 OK
2026/10/28 04:58:46 INFO  : sub/index.html: Copied (replaced existing)
2026/10/28 04:58:47 DEBUG : sub/caddy.json: md5 = 1697a8dae98a8c6e8f216a524dc2dd65 OK
2026/10/28 04:58:47 DEBUG : sub/caddy.json: size = 261 OK
2026/10/28 04:58:47 INFO  : sub/caddy.json: Copied (replaced existing)
2026/10/28 04:58:49 DEBUG : sub/deep/file4.txt: md5 = 76439edeb88379c78c16e37c77aa1a61 OK
2026/10/28 04:58:50 DEBUG : index.html: Unchanged skipping
2026/10/28 04:58:50 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 04:58:51 DEBUG : sub/deep/index.html: md5 = c4a6ae62ab0847dce361612adc2c112b OK
2026/10/28 04:58:51 DEBUG : sub/deep/index.html: size = 12346 OK
2026/10/28 04:58:51 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/10/28 04:58:51 DEBUG : sub/deep/caddy.json: md5 = 3e995f2aa911341195106f25bdeee21c OK
2026/10/28 04:58:51 DEBUG : sub/deep/caddy.json: size = 260 OK
2026/10/28 04:58:51 INFO  : sub/deep/caddy.json: Copied (replaced existing)
2026/10/28 04:58:51 DEBUG : index.json: Unchanged skipping
2026/10/28 04:58:51 DEBUG : sub/index.json: Unchanged skipping
2026/10/28 04:58:51 DEBUG : sub/deep/index.json: md5 = 2ac80a7c041e162abbeb810019c4b8b3 OK
2026/10/28 04:58:51 DEBUG : sub/deep/index.json: size = 235 OK
2026/10/28 04:58:51 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/10/28 04:58:52 DEBUG : caddy.json: Unchanged skipping
2026/10/28 04:58:52 DEBUG : sub/caddy.json: Unchanged skipping
2026/10/28 04:58:54 DEBUG : sub/deep/file5.txt: md5 = e77295d1109be315a0ab550d38afbe4b OK
2026/10/28 04:58:55 NOTICE: sub/deep/caddy.json: Skipped copy as --dry-run is set (size 389)
2026/10/28 04:58:55 NOTICE: sub/deep/index.json: Skipped copy as --dry-run is set (size 351)
2026/10/28 04:58:55 NOTICE: sub/deep/index.html: Skipped copy as --dry-run is set (size 12.309Ki)
2026/10/28 04:58:56 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 04:58:56 DEBUG : index.html: Unchanged skipping
2026/10/28 04:58:56 DEBUG : index.json: Unchanged skipping
2026/10/28 04:58:56 DEBUG : sub/index.json: Unchanged skipping
2026/10/28 04:58:57 DEBUG : caddy.json: Unchanged skipping
2026/10/28 04:58:57 DEBUG : sub/caddy.json: Unchanged skipping
--- PASS: TestIndex (45.93s)
=== RUN   TestIndexDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:59:10 DEBUG : file1.txt: md5 = ba882a307552bb5cdbd0305b5ffda0f3 OK
2026/10/28 04:59:13 DEBUG : sub/file2.txt: md5 = 0c8caa57a05c7b48b37b983d4213d78f OK
2026/10/28 04:59:15 DEBUG : sub/deep/file3.txt: md5 = cb554e6a6afe1b45413ac4dd7b113917 OK
2026/10/28 04:59:18 DEBUG : index.html: md5 = da8e85a58fd1faf61af0f37654d8c310 OK
2026/10/28 04:59:18 DEBUG : index.html: size = 12147 OK
2026/10/28 04:59:18 INFO  : index.html: Copied (new)
2026/10/28 04:59:18 DEBUG : sub/deep/index.html: md5 = 75770d849bf88be6ea80238825f2f854 OK
2026/10/28 04:59:18 DEBUG : sub/deep/index.html: size = 12087 OK
2026/10/28 04:59:18 INFO  : sub/deep/index.html: Copied (new)
2026/10/28 04:59:18 DEBUG : sub/index.html: md5 = fd5cf304f9a3141334625cc96b25fc0a OK
2026/10/28 04:59:18 DEBUG : sub/index.html: size = 12306 OK
2026/10/28 04:59:18 INFO  : sub/index.html: Copied (new)
2026/10/28 04:59:20 DEBUG : index.html: Unchanged skipping
2026/10/28 04:59:20 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 04:59:21 DEBUG : sub/deep/index.html: md5 = 919d754c2cffa20a46a831291730dce5 OK
2026/10/28 04:59:21 DEBUG : sub/deep/index.html: size = 11829 OK
2026/10/28 04:59:21 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexDelete (20.26s)
=== RUN   TestIndexFilter
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:59:31 DEBUG : file1.txt: md5 = 617bab3ceac55be41fb8c8aaefb77ae4 OK
2026/10/28 04:59:33 DEBUG : sub/file2.txt: md5 = e1bc51f4fc0a53ef2a006e4d4e8b74c8 OK
2026/10/28 04:59:36 DEBUG : sub/deep/file3.txt: md5 = 8dac6329090e1db77e0a66eedd1490c2 OK
2026/10/28 04:59:37 DEBUG : sub/deep/index.html: md5 = 541f8ad1003b426783f4c48732ed6e8a OK
2026/10/28 04:59:40 DEBUG : other/notes.md: md5 = fc317f83a78954ed36c73162fc4ca8a4 OK
2026/10/28 04:59:40 DEBUG : other/notes.md: Excluded (Path Filter)
2026/10/28 04:59:42 DEBUG : sub/index.html: md5 = 9023176e533ced34640d8e454a7f35ad OK
2026/10/28 04:59:42 DEBUG : sub/index.html: size = 12056 OK
2026/10/28 04:59:42 INFO  : sub/index.html: Copied (new)
2026/10/28 04:59:42 DEBUG : index.html: md5 = 278949bbb3823434a473463f5a613015 OK
2026/10/28 04:59:42 DEBUG : index.html: size = 12399 OK
2026/10/28 04:59:42 INFO  : index.html: Copied (new)
2026/10/28 04:59:42 DEBUG : other/index.html: md5 = bbe6aabe6350f954e25de86dbd77ce47 OK
2026/10/28 04:59:42 DEBUG : other/index.html: size = 11802 OK
2026/10/28 04:59:42 INFO  : other/index.html: Copied (new)
2026/10/28 04:59:48 DEBUG : other/notes.md: Excluded (Path Filter)
2026/10/28 04:59:48 DEBUG : other/index.html: Unchanged skipping
2026/10/28 04:59:48 DEBUG : index.html: Unchanged skipping
2026/10/28 04:59:48 DEBUG : sub/index.html: Unchanged skipping
--- PASS: TestIndexFilter (27.55s)
=== RUN   TestIndexRules
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 04:59:58 DEBUG : file1.txt: md5 = ca55653f46da153ec481d00877b97910 OK
2026/10/28 05:00:01 DEBUG : sub/file2.txt: md5 = 9a36fa9361531692cf229305eca4ef22 OK
2026/10/28 05:00:04 DEBUG : sub/deep/file3.txt: md5 = adadae50ab9ad3dcda8a4c3a632aceed OK
2026/10/28 05:00:05 DEBUG : sub/deep/index.html: md5 = 094693fd2d2890ae33552119e98369e9 OK
2026/10/28 05:00:07 DEBUG : sub/index.html: md5 = 655e7f722d9c735b2126866e316829b7 OK
2026/10/28 05:00:07 DEBUG : sub/index.html: size = 12306 OK
2026/10/28 05:00:07 INFO  : sub/index.html: Copied (new)
2026/10/28 05:00:08 DEBUG : index.html: md5 = 5827ca1d7aa8b0590eeee00ca03971ba OK
2026/10/28 05:00:08 DEBUG : index.html: size = 12147 OK
2026/10/28 05:00:08 INFO  : index.html: Copied (new)
2026/10/28 05:00:13 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 05:00:13 DEBUG : sub/deep/index.html: md5 = 39a0dd4e282e23c07b0e9d3ef78f98a7 OK
2026/10/28 05:00:13 DEBUG : sub/deep/index.html: size = 12087 OK
2026/10/28 05:00:13 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexRules (24.31s)
=== RUN   TestIndexMaxDepth
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:00:23 DEBUG : file1.txt: md5 = 86d182651150d6e4915c0e1c92586963 OK
2026/10/28 05:00:25 DEBUG : sub/file2.txt: md5 = e28a6a94a7877581ed8d3c5287900434 OK
2026/10/28 05:00:28 DEBUG : sub/deep/file3.txt: md5 = 88f88b36ccfd7a28ffe875c9201146f3 OK
2026/10/28 05:00:31 DEBUG : index.html: md5 = 0cc62237e20704c87ffabd6461fea364 OK
2026/10/28 05:00:31 DEBUG : index.html: size = 12147 OK
2026/10/28 05:00:31 INFO  : index.html: Copied (new)
--- PASS: TestIndexMaxDepth (17.73s)
=== RUN   TestIndexLinkIndex
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:00:40 DEBUG : file1.txt: md5 = 76741eba05b5582eef032afdb1dc824a OK
2026/10/28 05:00:43 DEBUG : sub/file2.txt: md5 = f789a6f5fe537790a5400f0cb1ea7bc1 OK
2026/10/28 05:00:45 DEBUG : sub/deep/file3.txt: md5 = 5f5c11ebb6efa045913d22d588efd351 OK
2026/10/28 05:00:48 DEBUG : sub/index.html: md5 = d0ee3daee8f7f3251ea399f512b8e50e OK
2026/10/28 05:00:48 DEBUG : sub/index.html: size = 12347 OK
2026/10/28 05:00:48 INFO  : sub/index.html: Copied (new)
2026/10/28 05:00:48 DEBUG : index.html: md5 = 299505f7b903d5904b2ba8e2a02e8142 OK
2026/10/28 05:00:48 DEBUG : index.html: size = 12167 OK
2026/10/28 05:00:48 INFO  : index.html: Copied (new)
2026/10/28 05:00:48 DEBUG : sub/deep/index.html: md5 = 2c7357150944e4541c072d26c53bef49 OK
2026/10/28 05:00:48 DEBUG : sub/deep/index.html: size = 12128 OK
2026/10/28 05:00:48 INFO  : sub/deep/index.html: Copied (new)
--- PASS: TestIndexLinkIndex (18.99s)
=== RUN   TestIndexDirTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:00:59 DEBUG : file1.txt: md5 = c0148d5b0959d5061ca5967b30144ce9 OK
2026/10/28 05:01:02 DEBUG : sub/file2.txt: md5 = 1eb8e56e9b0813ceaa5aed25bace3ac1 OK
2026/10/28 05:01:04 DEBUG : sub/deep/file3.txt: md5 = 620e958f2abc30206271aac10876c4ff OK
2026/10/28 05:01:07 DEBUG : index.json: md5 = 7dbf281b98581994131d112aca9dd855 OK
2026/10/28 05:01:07 DEBUG : index.json: size = 257 OK
2026/10/28 05:01:07 INFO  : index.json: Copied (new)
2026/10/28 05:01:07 DEBUG : sub/index.json: md5 = 98a25555507e51a2d00103c9e5ca0a28 OK
2026/10/28 05:01:07 DEBUG : sub/index.json: size = 259 OK
2026/10/28 05:01:07 INFO  : sub/index.json: Copied (new)
2026/10/28 05:01:07 DEBUG : sub/deep/index.json: md5 = e9463fe2f73dbd05948b8d2587ae64a7 OK
2026/10/28 05:01:07 DEBUG : sub/deep/index.json: size = 139 OK
2026/10/28 05:01:07 INFO  : sub/deep/index.json: Copied (new)
2026/10/28 05:01:09 DEBUG : sub/deep/index.json: Unchanged skipping
2026/10/28 05:01:10 DEBUG : sub/index.json: md5 = 912eaca7b2dbfe0648d2044777605e72 OK
2026/10/28 05:01:10 DEBUG : sub/index.json: size = 239 OK
2026/10/28 05:01:10 INFO  : sub/index.json: Copied (replaced existing)
2026/10/28 05:01:11 DEBUG : index.json: md5 = 554ad9ec06053bdbe4b3040cd3003bbb OK
2026/10/28 05:01:11 DEBUG : index.json: size = 237 OK
2026/10/28 05:01:11 INFO  : index.json: Copied (replaced existing)
2026/10/28 05:01:14 DEBUG : sub/deep/index.json: md5 = 37a6e3b5db7538232f9ea5b9619234e5 OK
2026/10/28 05:01:14 DEBUG : sub/deep/index.json: size = 119 OK
2026/10/28 05:01:14 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/10/28 05:01:14 DEBUG : sub/index.json: md5 = 693759249bf81cae4e331cebf947ecc0 OK
2026/10/28 05:01:14 DEBUG : sub/index.json: size = 215 OK
2026/10/28 05:01:14 INFO  : sub/index.json: Copied (replaced existing)
2026/10/28 05:01:14 DEBUG : index.json: md5 = c7aa10c2078cceecd63fef253a43f279 OK
2026/10/28 05:01:14 DEBUG : index.json: size = 213 OK
2026/10/28 05:01:14 INFO  : index.json: Copied (replaced existing)
--- PASS: TestIndexDirTime (23.78s)
=== RUN   TestIndexTemplate
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:01:23 DEBUG : file1.txt: md5 = 43f1cbc4c2fbab1353dd825131921729 OK
2026/10/28 05:01:26 DEBUG : sub/file2.txt: md5 = 346fc5fa95625c22e403bcb10413547a OK
2026/10/28 05:01:28 DEBUG : sub/deep/file3.txt: md5 = 0d8d4e64981f263980d0b1c7656b07ad OK
2026/10/28 05:01:31 DEBUG : sub/list.txt: md5 = a3be2384247439ee1e3cce9507a78b4a OK
2026/10/28 05:01:31 DEBUG : sub/list.txt: size = 64 OK
2026/10/28 05:01:31 INFO  : sub/list.txt: Copied (new)
2026/10/28 05:01:31 DEBUG : list.txt: md5 = b4d58ee9ad8240717ae28c03c7cb77bb OK
2026/10/28 05:01:31 DEBUG : list.txt: size = 59 OK
2026/10/28 05:01:31 INFO  : list.txt: Copied (new)
2026/10/28 05:01:31 DEBUG : sub/deep/list.txt: md5 = 915faea219db60d066e4bfb2fd3973db OK
2026/10/28 05:01:31 DEBUG : sub/deep/list.txt: size = 47 OK
2026/10/28 05:01:31 INFO  : sub/deep/list.txt: Copied (new)
--- PASS: TestIndexTemplate (16.65s)
=== 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:01:40 DEBUG : file1.txt: md5 = 393ab59336c9705cdb8bbed6b16d2a68 OK
2026/10/28 05:01:42 DEBUG : sub/file2.txt: md5 = ef0ed05a564a441a2f04f4db60bc0093 OK
2026/10/28 05:01:45 DEBUG : sub/deep/file3.txt: md5 = d2b3f989c003b44e916b33a9de06c518 OK
2026/10/28 05:01:47 DEBUG : other/notes.md: md5 = b47ae90d6ad7c14637edbd3ac46323be OK
2026/10/28 05:01:50 DEBUG : sub/index.html: md5 = 970b2c359113fb6ce81f80b9856109c9 OK
2026/10/28 05:01:50 DEBUG : sub/index.html: size = 12306 OK
2026/10/28 05:01:50 INFO  : sub/index.html: Copied (new)
2026/10/28 05:01:50 DEBUG : index.html: md5 = f71e38762d353383f15fdc126d6ee52a OK
2026/10/28 05:01:50 DEBUG : index.html: size = 12399 OK
2026/10/28 05:01:50 INFO  : index.html: Copied (new)
2026/10/28 05:01:50 DEBUG : sub/deep/index.html: md5 = 1774201fb99c83856e3ce633ae4fbf2f OK
2026/10/28 05:01:50 DEBUG : sub/deep/index.html: size = 12087 OK
2026/10/28 05:01:50 INFO  : sub/deep/index.html: Copied (new)
2026/10/28 05:01:50 DEBUG : other/index.html: md5 = 24e7ab7b5c545f28d4bd0386fd0fa3e3 OK
2026/10/28 05:01:50 DEBUG : other/index.html: size = 12058 OK
2026/10/28 05:01:50 INFO  : other/index.html: Copied (new)
2026/10/28 05:01:51 DEBUG : sub/deep/file4.txt: md5 = fcf8bc71a5e52723e074ced170a57315 OK
2026/10/28 05:01:53 DEBUG : other/undeclared.txt: md5 = f82e68b5bcca76e761b6ab41108dbe26 OK
2026/10/28 05:01:53 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 3 directories and walking 0 changed directories
2026/10/28 05:01:55 DEBUG : index.html: Unchanged skipping
2026/10/28 05:01:55 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 05:01:55 DEBUG : sub/deep/index.html: md5 = b478e73f00640a60af20c60fb1832732 OK
2026/10/28 05:01:55 DEBUG : sub/deep/index.html: size = 12346 OK
2026/10/28 05:01:55 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/10/28 05:02:00 DEBUG : sub/new/file5.txt: md5 = 50516dfa2a3ce586c9b250f590c4af54 OK
2026/10/28 05:02:00 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 3 directories and walking 0 changed directories
2026/10/28 05:02:01 DEBUG : index.html: Unchanged skipping
2026/10/28 05:02:02 DEBUG : sub/index.html: md5 = fe75f5317ef802733bde31d91ef6d3e7 OK
2026/10/28 05:02:02 DEBUG : sub/index.html: size = 12554 OK
2026/10/28 05:02:02 INFO  : sub/index.html: Copied (replaced existing)
2026/10/28 05:02:02 DEBUG : sub/new/index.html: md5 = 7227fd418a0ae69f0d349dc197513599 OK
2026/10/28 05:02:02 DEBUG : sub/new/index.html: size = 12085 OK
2026/10/28 05:02:02 INFO  : sub/new/index.html: Copied (new)
2026/10/28 05:02:06 DEBUG : other/undeclared0.txt: md5 = d5a982928a890fdbc6d0caafcd76b842 OK
2026/10/28 05:02:06 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 1 directories and walking 1 changed directories
2026/10/28 05:02:07 DEBUG : index.html: Unchanged skipping
2026/10/28 05:02:08 DEBUG : other/index.html: md5 = cbad810996da2033b12ea9357e39973d OK
2026/10/28 05:02:08 DEBUG : other/index.html: size = 12597 OK
2026/10/28 05:02:08 INFO  : other/index.html: Copied (replaced existing)
2026/10/28 05:02:11 DEBUG : other/undeclared1.txt: md5 = 04871c3e50b8c49b1169ea151a055a5d OK
2026/10/28 05:02:11 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 1 directories and walking 0 changed directories
2026/10/28 05:02:12 DEBUG : index.html: Unchanged skipping
2026/10/28 05:02:13 DEBUG : other/index.html: md5 = 9b5157855e115c85f5d69eb6e9e913c9 OK
2026/10/28 05:02:13 DEBUG : other/index.html: size = 12867 OK
2026/10/28 05:02:13 INFO  : other/index.html: Copied (replaced existing)
2026/10/28 05:02:15 DEBUG : sub/file6.txt: md5 = 3723177eaea5322a91dc0a45f4722611 OK
2026/10/28 05:02:15 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Nothing changed so nothing to index
2026/10/28 05:02:16 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Root changed so doing a full index
2026/10/28 05:02:18 DEBUG : sub/new/index.html: Unchanged skipping
2026/10/28 05:02:18 DEBUG : index.html: Unchanged skipping
2026/10/28 05:02:18 DEBUG : other/index.html: Unchanged skipping
2026/10/28 05:02:18 DEBUG : sub/deep/index.html: Unchanged skipping
2026/10/28 05:02:19 DEBUG : sub/index.html: md5 = 6f0d84b3effc1a125382a966838a9022 OK
2026/10/28 05:02:19 DEBUG : sub/index.html: size = 12813 OK
2026/10/28 05:02:19 INFO  : sub/index.html: Copied (replaced existing)
2026/10/28 05:02:21 DEBUG : sub/file7.txt: md5 = 74edd1ce96b13ab9d878fc7e531e60d4 OK
2026/10/28 05:02:21 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index would list 2 directories, more than 1, so doing a full index
2026/10/28 05:02:23 DEBUG : index.html: Unchanged skipping
2026/10/28 05:02:23 DEBUG : sub/new/index.html: Unchanged skipping
2026/10/28 05:02:23 DEBUG : sub/deep/index.html: Unchanged skipping
2026/10/28 05:02:23 DEBUG : other/index.html: Unchanged skipping
2026/10/28 05:02:24 DEBUG : sub/index.html: md5 = 3853a895d6c758647b97fcba0721a404 OK
2026/10/28 05:02:24 DEBUG : sub/index.html: size = 13071 OK
2026/10/28 05:02:24 INFO  : sub/index.html: Copied (replaced existing)
2026/10/28 05:02:26 DEBUG : sub/deep/file8.txt: md5 = 35ab0254bef1e1e8459f9ad70d9088d2 OK
2026/10/28 05:02:26 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 1 directories and walking 1 changed directories
2026/10/28 05:02:28 DEBUG : sub/new/index.html: Unchanged skipping
2026/10/28 05:02:28 DEBUG : index.html: Unchanged skipping
2026/10/28 05:02:28 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 05:02:29 DEBUG : sub/deep/index.html: md5 = 5b0d3132193f676669136f0ced572dfc OK
2026/10/28 05:02:29 DEBUG : sub/deep/index.html: size = 12604 OK
2026/10/28 05:02:29 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/10/28 05:02:31 DEBUG : sub/deep/file9.txt: md5 = 25bc7a78885dfe5a24cefca030c428c0 OK
2026/10/28 05:02:33 DEBUG : sub/file10.txt: md5 = 0870a60d314df7685b2eb169f698739c OK
2026/10/28 05:02:33 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 2 directories and walking 0 changed directories
2026/10/28 05:02:34 DEBUG : index.html: Unchanged skipping
2026/10/28 05:02:35 DEBUG : sub/index.html: md5 = d40a4105bc05dc6c0ccccb6079967799 OK
2026/10/28 05:02:35 DEBUG : sub/index.html: size = 13331 OK
2026/10/28 05:02:35 INFO  : sub/index.html: Copied (replaced existing)
--- PASS: TestIndexChanged (74.97s)
=== RUN   TestIndexChangedDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:02:55 DEBUG : file1.txt: md5 = 7810a5c16e274a9393627037520dc315 OK
2026/10/28 05:02:57 DEBUG : sub/file2.txt: md5 = 05596466c0531cd76e1eb02c6b90cbdd OK
2026/10/28 05:03:00 DEBUG : sub/deep/file3.txt: md5 = 08a8ab924527abbd8351c5362bb0e13f OK
2026/10/28 05:03:02 DEBUG : sub/deep/index.html: md5 = 421763450a9b3c21ad7398d011aeffef OK
2026/10/28 05:03:02 DEBUG : sub/deep/index.html: size = 12087 OK
2026/10/28 05:03:02 INFO  : sub/deep/index.html: Copied (new)
2026/10/28 05:03:02 DEBUG : index.html: md5 = 6d489ccc40c7164ee2e17627aca4cbc8 OK
2026/10/28 05:03:02 DEBUG : index.html: size = 12147 OK
2026/10/28 05:03:02 INFO  : index.html: Copied (new)
2026/10/28 05:03:02 DEBUG : sub/index.html: md5 = 1d851d8abef511917ea7a2b7e4926089 OK
2026/10/28 05:03:02 DEBUG : sub/index.html: size = 12306 OK
2026/10/28 05:03:02 INFO  : sub/index.html: Copied (new)
2026/10/28 05:03:03 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 3 directories and walking 0 changed directories
2026/10/28 05:03:05 DEBUG : index.html: Unchanged skipping
2026/10/28 05:03:05 DEBUG : sub/index.html: Unchanged skipping
2026/10/28 05:03:05 DEBUG : sub/deep/index.html: md5 = 57af5b6c7248fbcc425ddb8f3662185b OK
2026/10/28 05:03:05 DEBUG : sub/deep/index.html: size = 11829 OK
2026/10/28 05:03:05 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexChangedDelete (19.09s)
=== RUN   TestIndexChangedFiles
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:03:14 DEBUG : file1.txt: md5 = 7d7b88dd8ed8bc2ece6d2de3e899082b OK
2026/10/28 05:03:16 DEBUG : sub/file2.txt: md5 = a112cda8434641b890dbcd9e84cac0ba OK
2026/10/28 05:03:19 DEBUG : sub/deep/file3.txt: md5 = 39d704653c103e411b6aeb0ef05b9fb7 OK
2026/10/28 05:03:22 DEBUG : - odd/file.txt: md5 = 6a945917dbf2452128f661d5046cf70e OK
2026/10/28 05:03:24 DEBUG : index.html: md5 = 098eae5f41006dc06a70ccfe6e2f91e9 OK
2026/10/28 05:03:24 DEBUG : index.html: size = 12401 OK
2026/10/28 05:03:24 INFO  : index.html: Copied (new)
2026/10/28 05:03:24 DEBUG : sub/index.html: md5 = 24cef3affd226e4cd928a60f094bdd7a OK
2026/10/28 05:03:24 DEBUG : sub/index.html: size = 12306 OK
2026/10/28 05:03:24 INFO  : sub/index.html: Copied (new)
2026/10/28 05:03:24 DEBUG : - odd/index.html: md5 = f93353b337ecce7c58d0280bd9f9e1fd OK
2026/10/28 05:03:24 DEBUG : - odd/index.html: size = 12058 OK
2026/10/28 05:03:24 INFO  : - odd/index.html: Copied (new)
2026/10/28 05:03:25 DEBUG : sub/deep/index.html: md5 = 72ca3efff199481c0002cfc6a44bc9a6 OK
2026/10/28 05:03:25 DEBUG : sub/deep/index.html: size = 12087 OK
2026/10/28 05:03:25 INFO  : sub/deep/index.html: Copied (new)
2026/10/28 05:03:26 DEBUG : - odd/file8.txt: md5 = 95f4c53a9d906f69494b20b8bc082164 OK
2026/10/28 05:03:28 DEBUG : sub/file9.txt: md5 = 706958157b270b68a22471df2ee33646 OK
2026/10/28 05:03:28 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 2 directories and walking 0 changed directories
2026/10/28 05:03:29 DEBUG : index.html: Unchanged skipping
2026/10/28 05:03:30 DEBUG : - odd/index.html: md5 = 8306088c2b451c5be1f07b77c9c4c024 OK
2026/10/28 05:03:30 DEBUG : - odd/index.html: size = 12316 OK
2026/10/28 05:03:30 INFO  : - odd/index.html: Copied (replaced existing)
2026/10/28 05:03:32 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 4 directories and walking 0 changed directories
2026/10/28 05:03:33 DEBUG : index.html: Unchanged skipping
2026/10/28 05:03:33 DEBUG : - odd/index.html: Unchanged skipping
2026/10/28 05:03:33 DEBUG : sub/deep/index.html: Unchanged skipping
2026/10/28 05:03:34 DEBUG : sub/index.html: md5 = 153fe74554a7475f52a41beffbfdacca OK
2026/10/28 05:03:34 DEBUG : sub/index.html: size = 12565 OK
2026/10/28 05:03:34 INFO  : sub/index.html: Copied (replaced existing)
--- PASS: TestIndexChangedFiles (32.38s)
=== RUN   TestIndexChangedDirTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:03:46 DEBUG : file1.txt: md5 = 84f0ce741253af582f6f830f9c178c13 OK
2026/10/28 05:03:49 DEBUG : sub/file2.txt: md5 = 347956bf33411d9a224e4312909a6bee OK
2026/10/28 05:03:52 DEBUG : sub/deep/file3.txt: md5 = 8385ba8ead1e8efbf873f96c35f1299c OK
2026/10/28 05:03:54 DEBUG : other/notes.md: md5 = f3827ba27a2c2e5acb9e6970f394e99b OK
2026/10/28 05:03:56 DEBUG : other/index.json: md5 = f71d68d533ae6eba3c48b80fc8a7f986 OK
2026/10/28 05:03:56 DEBUG : other/index.json: size = 144 OK
2026/10/28 05:03:56 INFO  : other/index.json: Copied (new)
2026/10/28 05:03:56 DEBUG : sub/index.json: md5 = 24669a7fcc852b19ece1fbabac74b5f4 OK
2026/10/28 05:03:56 DEBUG : sub/index.json: size = 259 OK
2026/10/28 05:03:56 INFO  : sub/index.json: Copied (new)
2026/10/28 05:03:56 DEBUG : index.json: md5 = ec9d712f355d7cb4a88247f1e7a2c6f9 OK
2026/10/28 05:03:56 DEBUG : index.json: size = 379 OK
2026/10/28 05:03:56 INFO  : index.json: Copied (new)
2026/10/28 05:03:57 DEBUG : sub/deep/index.json: md5 = 87a192e57bcd48169af1032861377198 OK
2026/10/28 05:03:57 DEBUG : sub/deep/index.json: size = 139 OK
2026/10/28 05:03:57 INFO  : sub/deep/index.json: Copied (new)
2026/10/28 05:03:58 DEBUG : sub/deep/file4.txt: md5 = ad4c5f43ebf1c6399be322b1aa89a532 OK
2026/10/28 05:03:58 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Partial index: listing 3 directories and walking 0 changed directories
2026/10/28 05:04:01 DEBUG : sub/deep/index.json: md5 = a55d2549b2b4bc4de2dea62e0f82dbbc OK
2026/10/28 05:04:01 DEBUG : sub/deep/index.json: size = 275 OK
2026/10/28 05:04:01 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/10/28 05:04:01 DEBUG : sub/index.json: md5 = 73bf1ae818d7f1c5262e2cad7832e6d6 OK
2026/10/28 05:04:01 DEBUG : sub/index.json: size = 259 OK
2026/10/28 05:04:01 INFO  : sub/index.json: Copied (replaced existing)
2026/10/28 05:04:02 DEBUG : index.json: md5 = 6c7ceffe29142ef5b10221693e2b0e01 OK
2026/10/28 05:04:02 DEBUG : index.json: size = 379 OK
2026/10/28 05:04:02 INFO  : index.json: Copied (replaced existing)
--- PASS: TestIndexChangedDirTime (26.97s)
=== RUN   TestListDirSorted
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:04:13 DEBUG : a.txt: md5 = 68ce7fea26338e37c0d6f6fe53bb7b1b OK
2026/10/28 05:04:15 DEBUG : zend.txt: md5 = dcdd323539e1f6dac1c71dbf73f0cb13 OK
2026/10/28 05:04:17 DEBUG : sub dir/hello world: md5 = ab5b142f1f1f95585a9ab4cbb4363b18 OK
2026/10/28 05:04:19 DEBUG : sub dir/hello world2: md5 = 037147b786d86dd84c1970f90f48cab8 OK
2026/10/28 05:04:21 DEBUG : sub dir/ignore dir/.ignore: md5 = 52b7e2a8bae621abd0513e416e6cbf00 OK
2026/10/28 05:04:23 DEBUG : sub dir/ignore dir/should be ignored: md5 = 43c800ed555d3b256dd70cbd7e5e4a5f OK
2026/10/28 05:04:25 DEBUG : sub dir/sub sub dir/hello world3: md5 = 4a89094d02068c97320d7c10009b1d3a OK
2026/10/28 05:04:27 DEBUG : a.txt: Excluded (Size Filter)
2026/10/28 05:04:27 DEBUG : a.txt: Excluded
2026/10/28 05:04:27 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/10/28 05:04:27 DEBUG : sub dir/hello world: Excluded
2026/10/28 05:04:27 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/10/28 05:04:27 DEBUG : sub dir/hello world2: Excluded
2026/10/28 05:04:28 DEBUG : sub dir/ignore dir: Excluded
2026/10/28 05:04:28 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/10/28 05:04:28 DEBUG : sub dir/hello world: Excluded
2026/10/28 05:04:28 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/10/28 05:04:28 DEBUG : sub dir/hello world2: Excluded
2026/10/28 05:04:29 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSorted (24.79s)
=== RUN   TestListDirSortedFn
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:04:38 DEBUG : a.txt: md5 = beb05790f4e2f8cd102ddd3e0e40155e OK
2026/10/28 05:04:39 DEBUG : zend.txt: md5 = 22a6a29cfa7d92c43abb8866c1f68de9 OK
2026/10/28 05:04:42 DEBUG : sub dir/hello world: md5 = 7deb66bd2ab8a090f5500552a583afb2 OK
2026/10/28 05:04:44 DEBUG : sub dir/hello world2: md5 = ab734aeca9cbec9dfde77356a617bd13 OK
2026/10/28 05:04:46 DEBUG : sub dir/ignore dir/.ignore: md5 = ac883a4d83b1539e83cbc84654f4e36a OK
2026/10/28 05:04:48 DEBUG : sub dir/ignore dir/should be ignored: md5 = 6d865e5fb33a2fc815908b93a44a32e4 OK
2026/10/28 05:04:51 DEBUG : sub dir/sub sub dir/hello world3: md5 = 2542fa74dd7686696304ed4241661146 OK
2026/10/28 05:04:52 DEBUG : a.txt: Excluded (Size Filter)
2026/10/28 05:04:52 DEBUG : a.txt: Excluded
2026/10/28 05:04:52 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/10/28 05:04:52 DEBUG : sub dir/hello world2: Excluded
2026/10/28 05:04:52 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/10/28 05:04:52 DEBUG : sub dir/hello world: Excluded
2026/10/28 05:04:53 DEBUG : sub dir/ignore dir: Excluded
2026/10/28 05:04:53 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/10/28 05:04:53 DEBUG : sub dir/hello world2: Excluded
2026/10/28 05:04:53 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/10/28 05:04:53 DEBUG : sub dir/hello world: Excluded
2026/10/28 05:04:54 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSortedFn (25.13s)
=== RUN   TestListJSON
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:03 DEBUG : file1: md5 = 478df05344919a68351584805b5296e4 OK
2026/10/28 05:05:05 DEBUG : sub/file2: md5 = 7a98eb1ae6c73d569d2363d42aa5434b 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/10/28 05:05:09 ERROR : file1: Failed to read hash: hash type not supported
=== RUN   TestListJSON/Metadata
2026/10/28 05:05:09 DEBUG : eer8kka55qnghc34cq76ca668g: Fetching metadata
2026/10/28 05:05:09 DEBUG : 150fuo3cn4j1uenq6r4g4qk6t4: Fetching metadata
--- PASS: TestListJSON (10.78s)
    --- PASS: TestListJSON/Default (0.28s)
    --- PASS: TestListJSON/FilesOnly (0.29s)
    --- PASS: TestListJSON/DirsOnly (0.25s)
    --- PASS: TestListJSON/Recurse (0.57s)
    --- PASS: TestListJSON/SubDir (0.25s)
    --- PASS: TestListJSON/NoModTime (0.29s)
    --- PASS: TestListJSON/NoMimeType (0.29s)
    --- PASS: TestListJSON/ShowHash (0.27s)
    --- PASS: TestListJSON/HashTypes (0.28s)
    --- PASS: TestListJSON/Metadata (0.78s)
=== RUN   TestStatJSON
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:14 DEBUG : file1: md5 = 88d19a3f554b158ce2eb3fe5f8327370 OK
2026/10/28 05:05:16 DEBUG : sub/file2: md5 = 8fdbb403059085549b352c81af82e4fa 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/10/28 05:05:21 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/notfound"
2026/10/28 05:05:21 DEBUG : Config file has changed externally - reloading
2026/10/28 05:05:21 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/qe0i31qdkoejk60elps0ni5sqk"
--- PASS: TestStatJSON (13.09s)
    --- PASS: TestStatJSON/Root (0.32s)
    --- PASS: TestStatJSON/RootFilesOnly (0.00s)
    --- PASS: TestStatJSON/RootDirsOnly (0.31s)
    --- PASS: TestStatJSON/Dir (0.52s)
    --- PASS: TestStatJSON/DirWithTrailingSlash (0.27s)
    --- PASS: TestStatJSON/File (0.27s)
    --- PASS: TestStatJSON/NotFound (0.49s)
    --- PASS: TestStatJSON/DirFilesOnly (0.29s)
    --- PASS: TestStatJSON/FileFilesOnly (0.27s)
    --- PASS: TestStatJSON/NotFoundFilesOnly (0.22s)
    --- PASS: TestStatJSON/DirDirsOnly (0.25s)
    --- PASS: TestStatJSON/FileDirsOnly (0.27s)
    --- PASS: TestStatJSON/NotFoundDirsOnly (0.34s)
    --- PASS: TestStatJSON/RootNotFound (1.82s)
=== RUN   TestStatJSONMemory
2026/10/28 05:05:25 DEBUG : Creating backend with remote ":memory:"
2026/10/28 05:05:25 DEBUG : Memory root '': File to upload is small (5 bytes), uploading instead of streaming
2026/10/28 05:05:25 DEBUG : sub/file1: size = 5 OK
2026/10/28 05:05:25 DEBUG : sub/file1: md5 = 5d41402abc4b2a76b9719d911017c592 OK
2026/10/28 05:05:25 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:25 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Making directory
2026/10/28 05:05:25 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Making directory
--- PASS: TestMkdir (0.67s)
=== RUN   TestLsd
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:28 DEBUG : sub dir/hello world: md5 = 4ceb26b5a5470e952cabb1c6688806af OK
--- PASS: TestLsd (5.34s)
=== RUN   TestLs
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:33 DEBUG : potato2: md5 = 4dc774dc7fdd091f952505b67120d605 OK
2026/10/28 05:05:34 DEBUG : empty space: md5 = 25a4d7c7958c8329a606623614b65cb0 OK
--- PASS: TestLs (5.14s)
=== RUN   TestLsWithFilesFrom
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:38 DEBUG : potato2: md5 = d6fa72e2f9eb5d3e3582043afe415505 OK
2026/10/28 05:05:40 DEBUG : empty space: md5 = 2fc7edb2e2cbe9e2b9cf0fc10be9186a OK
2026/10/28 05:05:40 DEBUG : empty space: Excluded (FilesFrom Filter)
2026/10/28 05:05:40 DEBUG : empty space: Excluded
--- PASS: TestLsWithFilesFrom (5.67s)
=== RUN   TestLsLong
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:44 DEBUG : potato2: md5 = c8f1606eed6d2ba2a3a2f52d632c25f4 OK
2026/10/28 05:05:45 DEBUG : empty space: md5 = a812d32779ea2eb481b9e99cd69b5807 OK
--- PASS: TestLsLong (5.79s)
=== RUN   TestHashSums
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:49 DEBUG : potato2: md5 = fa39b3a087c6d4c2fb0a8679f71165c7 OK
2026/10/28 05:05:51 DEBUG : empty space: md5 = 7390063aa26bb0d32a2d55b2e657dd9e OK
--- PASS: TestHashSums (5.18s)
=== RUN   TestHashSumsWithErrors
2026/10/28 05:05:53 DEBUG : Creating backend with remote ":memory:"
2026/10/28 05:05:53 ERROR : file1: hash unsupported: hash type not supported
2026/10/28 05:05:53 ERROR : sub/file1: hash unsupported: hash type not supported
2026/10/28 05:05:53 ERROR : sub/file1: hash unsupported: hash type not supported
--- PASS: TestHashSumsWithErrors (0.00s)
=== RUN   TestHashStream
2026/10/28 05:05:53 DEBUG : Creating md5 hash of 0 bytes read from input stream
2026/10/28 05:05:53 DEBUG : Creating md5 hash of 0 bytes read from input stream
2026/10/28 05:05:53 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2026/10/28 05:05:53 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2026/10/28 05:05:53 DEBUG : Creating md5 hash of 12 bytes read from input stream
2026/10/28 05:05:53 DEBUG : Creating md5 hash of 12 bytes read from input stream
2026/10/28 05:05:53 DEBUG : Creating sha1 hash of 12 bytes read from input stream
2026/10/28 05:05:53 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:05:55 DEBUG : potato2: md5 = af05a7390e7a99c6f4f5b5281faef5ba OK
2026/10/28 05:05:56 DEBUG : empty space: md5 = 1ab0174cdfd40e7c7ee0275d146ced47 OK
2026/10/28 05:05:59 DEBUG : sub dir/potato3: md5 = b4a94f59f93567c6a1ac88d981572302 OK
--- PASS: TestCount (9.85s)
=== RUN   TestDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:06:04 DEBUG : small: md5 = e9d6c09ad1cb47d2030906efa0b92043 OK
2026/10/28 05:06:06 DEBUG : medium: md5 = 3b42d1487463631acf15c6db58f41b7d OK
2026/10/28 05:06:08 DEBUG : large: md5 = 78d75a05c3798caad272a9526b263984 OK
2026/10/28 05:06:08 DEBUG : Waiting for deletions to finish
2026/10/28 05:06:08 DEBUG : large: Excluded (Size Filter)
2026/10/28 05:06:09 INFO  : small: Deleted
2026/10/28 05:06:09 INFO  : medium: Deleted
--- PASS: TestDelete (7.36s)
=== RUN   TestDeleteFatalError
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:06:12 DEBUG : file0: md5 = 292e80ee17126d4de15efe83eada97aa OK
2026/10/28 05:06:13 DEBUG : file1: md5 = 6346d807a408c1189e133c22519041b8 OK
2026/10/28 05:06:15 DEBUG : file2: md5 = 16d37f6b0e5d601f0e9d583d03d4e318 OK
2026/10/28 05:06:17 DEBUG : file3: md5 = bccbad00e8945ac005bb5ed813a68541 OK
2026/10/28 05:06:18 DEBUG : file4: md5 = aa9595a10dd39c1b2f06055fb0791f13 OK
2026/10/28 05:06:20 DEBUG : file5: md5 = b670d071da19cb5c4866579c155f610b OK
2026/10/28 05:06:22 DEBUG : file6: md5 = 968c4301107fa12430401f7842c5d002 OK
2026/10/28 05:06:23 DEBUG : file7: md5 = 600034d606ca80e836e02c70d28ada54 OK
2026/10/28 05:06:25 DEBUG : file8: md5 = 6963d61477e38706aec03e9c77985ea6 OK
2026/10/28 05:06:26 DEBUG : file9: md5 = cfc63684350d295d94c908e0e43b9107 OK
2026/10/28 05:06:28 DEBUG : file10: md5 = 75789d3adeb38adbe42b17510aff9a7a OK
2026/10/28 05:06:29 DEBUG : file11: md5 = b3a35e0ac36749dd08ed3aba16d18f2d OK
2026/10/28 05:06:31 DEBUG : file12: md5 = b769fad94746ee269ff3f8290a5df287 OK
2026/10/28 05:06:33 DEBUG : file13: md5 = 974bdc8c11a9af0c1be1687058c46810 OK
2026/10/28 05:06:34 DEBUG : file14: md5 = b62aa79ce106788e10d6507cb370e81d OK
2026/10/28 05:06:36 DEBUG : file15: md5 = 594c56dd505f79b4383e438d75edbd72 OK
2026/10/28 05:06:37 DEBUG : file16: md5 = 78216c29a36bb1a31c259fb8e6f2d1e7 OK
2026/10/28 05:06:39 DEBUG : file17: md5 = d47905eebe7bca3f8c9baec390c21f83 OK
2026/10/28 05:06:41 DEBUG : file18: md5 = 734cb3b1f8b6d2a7b8a359b5cd41872a OK
2026/10/28 05:06:42 DEBUG : file19: md5 = d2c449a27324d3945dacb003e22c3e82 OK
2026/10/28 05:06:42 DEBUG : Waiting for deletions to finish
2026/10/28 05:06:43 ERROR : file0: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file13: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file16: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file6: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file11: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file8: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file9: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file1: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file15: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file4: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file3: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file17: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file12: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file7: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file14: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file10: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file5: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file2: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file18: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:06:43 ERROR : file19: Got fatal error on delete: --max-delete threshold reached
--- PASS: TestDeleteFatalError (43.80s)
=== RUN   TestMaxDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:06:56 DEBUG : small: md5 = 403d79d8873b6af64baac63a02ed2bfd OK
2026/10/28 05:06:57 DEBUG : medium: md5 = 93986d2f7b5bbed70a508746a3f8d61f OK
2026/10/28 05:06:59 DEBUG : large: md5 = d2f1bcf52866fabcb7e484c136823f59 OK
2026/10/28 05:06:59 DEBUG : Waiting for deletions to finish
2026/10/28 05:06:59 ERROR : large: Got fatal error on delete: --max-delete threshold reached
2026/10/28 05:07:00 INFO  : small: Deleted
2026/10/28 05:07:00 INFO  : medium: Deleted
--- PASS: TestMaxDelete (7.77s)
=== RUN   TestMaxDeleteSizeLargeFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:07:03 DEBUG : small: md5 = 687162d83f55adedc8b4913805d8669e OK
2026/10/28 05:07:05 DEBUG : medium: md5 = c6d066f85012972c863df4d356a6013b OK
2026/10/28 05:07:07 DEBUG : large: md5 = 88140a221d1b42f95edfbc13c1bb9c77 OK
2026/10/28 05:07:07 DEBUG : Waiting for deletions to finish
2026/10/28 05:07:07 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached
2026/10/28 05:07:08 INFO  : small: Deleted
2026/10/28 05:07:08 INFO  : medium: Deleted
--- PASS: TestMaxDeleteSizeLargeFile (7.59s)
=== RUN   TestMaxDeleteSize
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:07:11 DEBUG : small: md5 = d44d0ee115821f9bd98c73421c2f4d06 OK
2026/10/28 05:07:13 DEBUG : medium: md5 = 7b59a0e118d268ac1f0b82df6d3f8f34 OK
2026/10/28 05:07:14 DEBUG : large: md5 = 9469c21cba3347f25fc2af4fde4fad69 OK
2026/10/28 05:07:15 DEBUG : Waiting for deletions to finish
2026/10/28 05:07:15 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached
2026/10/28 05:07:15 INFO  : medium: Deleted
2026/10/28 05:07:15 INFO  : small: Deleted
--- PASS: TestMaxDeleteSize (7.97s)
=== RUN   TestReadFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:07:19 DEBUG : ReadFile: md5 = 7fda931216c5076023abc6eedecca76d OK
--- PASS: TestReadFile (4.48s)
=== RUN   TestRetry
2026/10/28 05:07:22 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5
2026/10/28 05:07:22 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5
2026/10/28 05:07:22 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/10/28 05:07:22 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/10/28 05:07:22 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/10/28 05:07:22 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/10/28 05:07:22 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:07:23 DEBUG : file1: md5 = 821c3849691ca60b40b5aeb7e33c2031 OK
2026/10/28 05:07:25 DEBUG : file2: md5 = fad7a0d7ba93081455e5110a2cf16f64 OK
--- PASS: TestCat (14.11s)
=== RUN   TestPurge
2026/10/28 05:07:36 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-yuhevap3gase"
2026/10/28 05:07:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 05:07:36 DEBUG : Creating backend with remote "TestDrive:crypt/4571oancfhnqv5h9ld7pap9hnakt02oi8on9u7tnhbboq2i61u10"
2026/10/28 05:07:37 DEBUG : Creating backend with remote "/tmp/rclone1983679671"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-yuhevap3gase'", Local "Local file system at /tmp/rclone1983679671", Modify Window "1ms"
2026/10/28 05:07:42 DEBUG : A1/B1/C1/one: md5 = 371a130a8ee603a1ba8fe7443e006309 OK
2026/10/28 05:07:42 INFO  : A2: Making directory
2026/10/28 05:07:43 INFO  : A1/B2: Making directory
2026/10/28 05:07:44 INFO  : A1/B2/C2: Making directory
2026/10/28 05:07:45 INFO  : A1/B1/C3: Making directory
2026/10/28 05:07:46 INFO  : A3: Making directory
2026/10/28 05:07:46 INFO  : A3/B3: Making directory
2026/10/28 05:07:47 INFO  : A3/B3/C4: Making directory
2026/10/28 05:07:50 DEBUG : A1/two: md5 = 2e3364bcf87442f0be441e6112e515d8 OK
2026/10/28 05:07:54 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-yuhevap3gase': Purge remote
2026/10/28 05:07:54 NOTICE: purge failed: directory not found
--- PASS: TestPurge (17.74s)
=== RUN   TestRmdirsNoLeaveRoot
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:07:58 DEBUG : A1/B1/C1/one: md5 = 36a4956a50f80ff1127144331cc974db OK
2026/10/28 05:07:58 INFO  : A2: Making directory
2026/10/28 05:07:59 INFO  : A1/B2: Making directory
2026/10/28 05:08:00 INFO  : A1/B2/C2: Making directory
2026/10/28 05:08:01 INFO  : A1/B1/C3: Making directory
2026/10/28 05:08:02 INFO  : A3: Making directory
2026/10/28 05:08:03 INFO  : A3/B3: Making directory
2026/10/28 05:08:03 INFO  : A3/B3/C4: Making directory
2026/10/28 05:08:06 DEBUG : A1/two: md5 = 5a530534dcd529ee3ae701178d356a91 OK
2026/10/28 05:08:07 DEBUG : removing 1 level 3 directories
2026/10/28 05:08:07 INFO  : A3/B3/C4: Removing directory
2026/10/28 05:08:10 DEBUG : removing 2 level 3 directories
2026/10/28 05:08:10 INFO  : A1/B2/C2: Removing directory
2026/10/28 05:08:10 INFO  : A1/B1/C3: Removing directory
2026/10/28 05:08:11 DEBUG : removing 2 level 2 directories
2026/10/28 05:08:11 INFO  : A3/B3: Removing directory
2026/10/28 05:08:11 INFO  : A1/B2: Removing directory
2026/10/28 05:08:12 DEBUG : removing 2 level 1 directories
2026/10/28 05:08:12 INFO  : A3: Removing directory
2026/10/28 05:08:12 INFO  : A2: Removing directory
2026/10/28 05:08:17 DEBUG : removing 1 level 3 directories
2026/10/28 05:08:17 INFO  : A1/B1/C1: Removing directory
2026/10/28 05:08:17 DEBUG : removing 1 level 2 directories
2026/10/28 05:08:17 INFO  : A1/B1: Removing directory
2026/10/28 05:08:18 DEBUG : removing 1 level 1 directories
2026/10/28 05:08:18 INFO  : A1: Removing directory
2026/10/28 05:08:19 DEBUG : removing 1 level 0 directories
2026/10/28 05:08:19 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Removing directory
--- PASS: TestRmdirsNoLeaveRoot (26.95s)
=== RUN   TestRmdirsLeaveRoot
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:08:22 INFO  : A1: Making directory
2026/10/28 05:08:23 INFO  : A1/B1: Making directory
2026/10/28 05:08:23 INFO  : A1/B1/C1: Making directory
2026/10/28 05:08:26 DEBUG : removing 1 level 3 directories
2026/10/28 05:08:26 INFO  : A1/B1/C1: Removing directory
2026/10/28 05:08:27 DEBUG : removing 1 level 2 directories
2026/10/28 05:08:27 INFO  : A1/B1: Removing directory
--- PASS: TestRmdirsLeaveRoot (9.43s)
=== RUN   TestRmdirsWithFilter
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:08:30 INFO  : A1: Making directory
2026/10/28 05:08:31 INFO  : A1/B1: Making directory
2026/10/28 05:08:32 INFO  : A1/B1/C1: Making directory
2026/10/28 05:08:35 DEBUG : removing 1 level 3 directories
2026/10/28 05:08:35 INFO  : A1/B1/C1: Removing directory
2026/10/28 05:08:36 DEBUG : removing 1 level 2 directories
2026/10/28 05:08:36 INFO  : A1/B1: Removing directory
--- PASS: TestRmdirsWithFilter (8.97s)
=== RUN   TestCopyURL
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:08:41 DEBUG : file1: md5 = 56046af73ff740ce798c0e590e13cc64 OK
2026/10/28 05:08:41 DEBUG : file1: size = 14 OK
2026/10/28 05:08:42 DEBUG : filename.txt: File name found in url
2026/10/28 05:08:43 DEBUG : filename.txt: md5 = bf3913bb2c8724b186902745b4a190cf OK
2026/10/28 05:08:43 DEBUG : filename.txt: size = 14 OK
2026/10/28 05:08:43 DEBUG : headerfilename.txt: filename found in Content-Disposition header.
2026/10/28 05:08:45 DEBUG : headerfilename.txt: md5 = 20d77bccb37bbb64c56d5c87d22c65f7 OK
2026/10/28 05:08:45 DEBUG : headerfilename.txt: size = 14 OK
2026/10/28 05:08:46 DEBUG : file2: md5 = c00c799a2b513e38c4d045f68b28dee0 OK
2026/10/28 05:08:46 DEBUG : file2: size = 14 OK
--- PASS: TestCopyURL (10.39s)
=== RUN   TestCopyURLDownloadHeaders
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:08:51 DEBUG : file1: md5 = 9969738f559e18f6672b4d65ec4c5128 OK
2026/10/28 05:08:51 DEBUG : file1: size = 14 OK
--- PASS: TestCopyURLDownloadHeaders (2.66s)
=== RUN   TestCopyURLToWriter
--- PASS: TestCopyURLToWriter (0.00s)
=== RUN   TestMoveFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:08:52 DEBUG : file1: Need to transfer - File not found at Destination
2026/10/28 05:08:55 DEBUG : sub/file2: md5 = a1cebd313726784ac8df3c97d0918337 OK
2026/10/28 05:08:55 DEBUG : sub/file2: size = 14 OK
2026/10/28 05:08:55 INFO  : file1: Copied (new) to: sub/file2
2026/10/28 05:08:55 INFO  : file1: Deleted
2026/10/28 05:08:56 DEBUG : sub/file2: size = 14 OK
2026/10/28 05:08:56 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/10/28 05:08:56 DEBUG : file1: Unchanged skipping
2026/10/28 05:08:56 INFO  : file1: Deleted
2026/10/28 05:08:56 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestMoveFile (6.87s)
=== RUN   TestMoveFileWithIgnoreExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:08:59 DEBUG : file1: Need to transfer - File not found at Destination
2026/10/28 05:09:01 DEBUG : file1: md5 = 7ac0f1a58068eb49a6055bbbb96f885b OK
2026/10/28 05:09:01 DEBUG : file1: size = 14 OK
2026/10/28 05:09:01 INFO  : file1: Copied (new)
2026/10/28 05:09:01 INFO  : file1: Deleted
2026/10/28 05:09:01 DEBUG : file1: Destination exists, skipping
2026/10/28 05:09:01 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set
--- PASS: TestMoveFileWithIgnoreExisting (3.77s)
=== RUN   TestMoveFileImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:09:04 DEBUG : existing: md5 = e5316ac0a86ffcb2550b62c4c3418bde OK
2026/10/28 05:09:05 DEBUG : existing: size = 8 (Local file system at /tmp/rclone3097667400)
2026/10/28 05:09:05 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 05:09:05 DEBUG : existing: Sizes differ
2026/10/28 05:09:05 ERROR : existing: Source and destination exist but do not match: immutable file modified
--- PASS: TestMoveFileImmutable (3.40s)
=== RUN   TestCaseInsensitiveMoveFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
--- PASS: TestCaseInsensitiveMoveFile (0.48s)
=== RUN   TestMoveOntoItself
=== RUN   TestMoveOntoItself/viaSubdir=false,disableMove=false
2026/10/28 05:09:07 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-depanut5zuco"
2026/10/28 05:09:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 05:09:07 DEBUG : Creating backend with remote "TestDrive:crypt/otspis1m6g4erciih6654bhcu8dfhq67mh46ndgj0g0rk3nhg3vg"
2026/10/28 05:09:08 DEBUG : Creating backend with remote "/tmp/rclone4100831086"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-depanut5zuco'", Local "Local file system at /tmp/rclone4100831086", Modify Window "1ms"
2026/10/28 05:09:11 DEBUG : sub/file1: md5 = 620f3c30289cc4a0013e95ad14aaff2a OK
2026/10/28 05:09:12 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-depanut5zuco': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=false,disableMove=true
2026/10/28 05:09:13 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-cacemaz1xoli"
2026/10/28 05:09:13 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 05:09:13 DEBUG : Creating backend with remote "TestDrive:crypt/ddhcfk1op82b1p3676sosjd8h6ovbuq82353oe3hvbc2l28moeig"
2026/10/28 05:09:14 DEBUG : Creating backend with remote "/tmp/rclone1164592347"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-cacemaz1xoli'", Local "Local file system at /tmp/rclone1164592347", Modify Window "1ms"
2026/10/28 05:09:17 DEBUG : sub/file1: md5 = 96d8a7062f2ad5e1b514e39678af9d30 OK
2026/10/28 05:09:17 DEBUG : Reset feature "Move"
2026/10/28 05:09:18 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-cacemaz1xoli': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=true,disableMove=false
2026/10/28 05:09:19 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-nufuyuj1suqo"
2026/10/28 05:09:19 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 05:09:19 DEBUG : Creating backend with remote "TestDrive:crypt/7jb8hhs9dh7jg2f0t941ud72epec7u4oall90gdqis3trob74g0g"
2026/10/28 05:09:20 DEBUG : Creating backend with remote "/tmp/rclone3336971066"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-nufuyuj1suqo'", Local "Local file system at /tmp/rclone3336971066", Modify Window "1ms"
2026/10/28 05:09:23 DEBUG : sub/file1: md5 = 0c1c8d66e120d2f3a1360e332187d4cc OK
2026/10/28 05:09:23 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-nufuyuj1suqo/sub"
2026/10/28 05:09:23 DEBUG : Creating backend with remote "TestDrive:crypt/7jb8hhs9dh7jg2f0t941ud72epec7u4oall90gdqis3trob74g0g/150fuo3cn4j1uenq6r4g4qk6t4"
2026/10/28 05:09:25 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-nufuyuj1suqo': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=true,disableMove=true
2026/10/28 05:09:26 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-qanulam6wexe"
2026/10/28 05:09:26 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 05:09:26 DEBUG : Creating backend with remote "TestDrive:crypt/licquqf6al1c9afg32anadmc8of1fs9nt8i1lbcihmlrp066qpkg"
2026/10/28 05:09:27 DEBUG : Creating backend with remote "/tmp/rclone2118631430"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-qanulam6wexe'", Local "Local file system at /tmp/rclone2118631430", Modify Window "1ms"
2026/10/28 05:09:30 DEBUG : sub/file1: md5 = 556da8e8018decd7b608d314f8a64c7c OK
2026/10/28 05:09:30 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-qanulam6wexe/sub"
2026/10/28 05:09:30 DEBUG : Creating backend with remote "TestDrive:crypt/licquqf6al1c9afg32anadmc8of1fs9nt8i1lbcihmlrp066qpkg/150fuo3cn4j1uenq6r4g4qk6t4"
2026/10/28 05:09:31 DEBUG : Reset feature "Move"
2026/10/28 05:09:32 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-qanulam6wexe': Purge remote
--- PASS: TestMoveOntoItself (25.62s)
    --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=false (5.97s)
    --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=true (5.96s)
    --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=false (6.95s)
    --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=true (6.74s)
=== RUN   TestMoveUnicodeEquivalentWithoutServerSideMove
2026/10/28 05:09:32 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-fobolax4zove"
2026/10/28 05:09:32 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 05:09:32 DEBUG : Creating backend with remote "TestDrive:crypt/p0a8cr3ac73t31g0m43cooc5mablo0f3617hfc9tuchs3v11t7fg"
2026/10/28 05:09:33 DEBUG : Creating backend with remote "/tmp/rclone156981512"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-fobolax4zove'", Local "Local file system at /tmp/rclone156981512", Modify Window "1ms"
2026/10/28 05:09:33 DEBUG : Reset feature "Move"
2026/10/28 05:09:37 DEBUG : sub/équivalent.txt: md5 = 97d767e29d6d3a6948a33cfd79b71bef OK
2026/10/28 05:09:37 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt-rclone-move-muzesoq0
2026/10/28 05:09:38 DEBUG : sub/équivalent.txt-rclone-move-muzesoq0: size = 14 OK
2026/10/28 05:09:38 INFO  : sub/équivalent.txt: Copied (server-side copy) to: sub/équivalent.txt-rclone-move-muzesoq0
2026/10/28 05:09:39 INFO  : sub/équivalent.txt: Deleted
2026/10/28 05:09:39 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt
2026/10/28 05:09:40 DEBUG : sub/équivalent.txt: size = 14 OK
2026/10/28 05:09:40 INFO  : sub/équivalent.txt-rclone-move-muzesoq0: Copied (server-side copy) to: sub/équivalent.txt
2026/10/28 05:09:41 INFO  : sub/équivalent.txt-rclone-move-muzesoq0: Deleted
2026/10/28 05:09:41 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-fobolax4zove': Purge remote
--- PASS: TestMoveUnicodeEquivalentWithoutServerSideMove (9.54s)
=== RUN   TestCaseInsensitiveMoveWithoutServerSideMove
2026/10/28 05:09:42 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-xomoqal3giwa"
2026/10/28 05:09:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/28 05:09:42 DEBUG : Creating backend with remote "TestDrive:crypt/1pq976j89hkfij5m6hin7q57025j6u237gm5s6lq0f3t0cdjmrc0"
2026/10/28 05:09:43 DEBUG : Creating backend with remote "/tmp/rclone333434600"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-xomoqal3giwa'", Local "Local file system at /tmp/rclone333434600", Modify Window "1ms"
    operations_test.go:1196: remote is case sensitive
2026/10/28 05:09:43 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-xomoqal3giwa': Purge remote
2026/10/28 05:09:43 NOTICE: purge failed: directory not found
--- SKIP: TestCaseInsensitiveMoveWithoutServerSideMove (1.28s)
=== RUN   TestCaseInsensitiveMoveFileDryRun
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
--- PASS: TestCaseInsensitiveMoveFileDryRun (0.44s)
=== RUN   TestMoveFileBackupDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:09:46 DEBUG : dst/file1: md5 = 120513477d5abdb183c238fd2331b2d3 OK
2026/10/28 05:09:47 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-riqitop7wada/backup"
2026/10/28 05:09:47 DEBUG : Creating backend with remote "TestDrive:crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg/1nrff024r7pq65ecp72fc28jb0"
2026/10/28 05:09:49 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone3097667400)
2026/10/28 05:09:49 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 05:09:49 DEBUG : dst/file1: Sizes differ
2026/10/28 05:09:52 INFO  : dst/file1: Moved (server-side)
2026/10/28 05:09:53 DEBUG : dst/file1: md5 = 4e8d4b86fa0642345268cd14f0d0924e OK
2026/10/28 05:09:53 DEBUG : dst/file1: size = 14 OK
2026/10/28 05:09:53 INFO  : dst/file1: Copied (new)
2026/10/28 05:09:53 INFO  : dst/file1: Deleted
--- PASS: TestMoveFileBackupDir (15.17s)
=== 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:10:01 DEBUG : A/file0: md5 = 74dc5d732f8c2392fb13cbe1898985af OK
2026/10/28 05:10:03 DEBUG : A/file1: md5 = 1b2d23cefae88b35544a5823ddf3e0b1 OK
2026/10/28 05:10:05 DEBUG : A/file2: md5 = fcb99cb4768654f0db93bab5c70cb8f7 OK
2026/10/28 05:10:06 DEBUG : A/file3: md5 = ccab0e8c06acee7a8a65b1c1cfa16ffd OK
2026/10/28 05:10:08 DEBUG : A/file4: md5 = bd202a8a2927dd1e69b7b23e19b19cb1 OK
2026/10/28 05:10:09 DEBUG : A/file5: md5 = 6ce9a597103578639817d081064c2c87 OK
2026/10/28 05:10:11 DEBUG : A/file6: md5 = 30cb40ce3d0af32ef89dc947ddb2cadc OK
2026/10/28 05:10:13 DEBUG : A/file7: md5 = 35348661f4d42cc72f3072b0440cb955 OK
2026/10/28 05:10:14 DEBUG : A/file8: md5 = 7e295839cad571656f877a9e5de78e0d OK
2026/10/28 05:10:16 DEBUG : A/file9: md5 = c99f048c00288bd230ddc9c033b2efb7 OK
2026/10/28 05:10:17 DEBUG : A/file10: md5 = fb9674801193ab3c9e1c6177504c7fb8 OK
2026/10/28 05:10:19 DEBUG : A/file11: md5 = 9e0a7a154f3fd460870e8f5b1cdd7b7f OK
2026/10/28 05:10:21 DEBUG : A/file12: md5 = 879237e78949752d31f67089b13fddc1 OK
2026/10/28 05:10:22 DEBUG : A/file13: md5 = 120220e378c3e87569cd59dac831b628 OK
2026/10/28 05:10:24 DEBUG : A/file14: md5 = c9aa60f000d93c423c4d818fdac499c8 OK
2026/10/28 05:10:26 DEBUG : A/file15: md5 = fe9e573d9b7cc7769838ba87df393d48 OK
2026/10/28 05:10:27 DEBUG : A/file16: md5 = 40606c58a7a88a054b9c6c9a3301f071 OK
2026/10/28 05:10:29 DEBUG : A/file17: md5 = 35b43e49e63001e77d93dfa15ce66bb1 OK
2026/10/28 05:10:30 DEBUG : A/file18: md5 = 91c71b6b02201228479c5cc90c2b2a80 OK
2026/10/28 05:10:32 DEBUG : A/file19: md5 = d54a77055117a8567a4e755cb71eecf7 OK
    operations_test.go:1561: Skipping test on non local remote
--- SKIP: TestDirMoveMoveError (46.22s)
=== RUN   TestDirMoveContext
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:10:47 DEBUG : A/one: md5 = 378ed002ed7c27d09e226a1980ef5d43 OK
2026/10/28 05:10:49 DEBUG : A/two: md5 = 9f3626f8400fc00779d50c43bc10ae2b OK
    operations_test.go:1561: Skipping test on non local remote
--- SKIP: TestDirMoveContext (6.81s)
=== RUN   TestDirMove
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:10:54 DEBUG : A1/one: md5 = 124964f274c118b02882d1183a75a505 OK
2026/10/28 05:10:56 DEBUG : A1/two: md5 = c2d60b40a1e56087426d14627ac24e58 OK
2026/10/28 05:10:58 DEBUG : A1/B1/three: md5 = 012cce82beaf962f48968740eb43a8ca OK
2026/10/28 05:11:01 DEBUG : A1/B1/C1/four: md5 = aff6c55960cbfd779a2e82d305ee2069 OK
2026/10/28 05:11:04 DEBUG : A1/B1/C2/five: md5 = ba349f99b7fddfca22db262ed7ae1255 OK
2026/10/28 05:11:04 INFO  : A1/B2: Making directory
2026/10/28 05:11:05 INFO  : A1/B1/C3: Making directory
2026/10/28 05:11:16 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2026/10/28 05:11:16 INFO  : A2/one: Moved (server-side) to: A3/one
2026/10/28 05:11:16 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2026/10/28 05:11:16 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2026/10/28 05:11:16 INFO  : A2/two: Moved (server-side) to: A3/two
2026/10/28 05:11:22 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2026/10/28 05:11:29 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
2026/10/28 05:11:30 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
2026/10/28 05:11:30 INFO  : A3/two: Moved (server-side) to: A4/two
2026/10/28 05:11:30 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2026/10/28 05:11:30 INFO  : A3/one: Moved (server-side) to: A4/one
--- PASS: TestDirMove (53.08s)
=== RUN   TestGetFsInfo
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:11:45 DEBUG : Config file has changed externally - reloading
--- PASS: TestGetFsInfo (0.46s)
=== RUN   TestRcat
=== RUN   TestRcat/withChecksum=false,ignoreChecksum=false
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:11:46 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': File to upload is small (34 bytes), uploading instead of streaming
2026/10/28 05:11:47 DEBUG : no_checksum_small_file_from_pipe: md5 = 22977fa807c1dad94528323e525a4da2 OK
2026/10/28 05:11:47 DEBUG : no_checksum_small_file_from_pipe: size = 34 OK
2026/10/28 05:11:47 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2026/10/28 05:11:47 DEBUG : no_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/10/28 05:11:48 DEBUG : qc9k4uauqa9ls6a2r6lo8jf4b1m7r0510pkurois1cc70egbs4h0: Sending chunk 0 length 102465
2026/10/28 05:11:49 DEBUG : no_checksum_big_file_from_pipe: md5 = 53b1293c3b3a6ff7ad588c1324cdf0f7 OK
2026/10/28 05:11:49 DEBUG : no_checksum_big_file_from_pipe: size = 102401 OK
2026/10/28 05:11:49 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:11:51 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': File to upload is small (34 bytes), uploading instead of streaming
2026/10/28 05:11:53 DEBUG : with_checksum_small_file_from_pipe: md5 = 0d9e6c4519ede117cd30c3855a469a6d OK
2026/10/28 05:11:53 DEBUG : with_checksum_small_file_from_pipe: size = 34 OK
2026/10/28 05:11:53 DEBUG : with_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/10/28 05:11:54 DEBUG : e74jo8a7lr1aimg2u78fct67gnuetc1qujiofaci0c8fnq7rjt1d4i296pcklqhgdihs03etvgdi4: Sending chunk 0 length 102465
2026/10/28 05:11:55 DEBUG : with_checksum_big_file_from_pipe: md5 = b29daa5cc909a0f614c45957e1462dec OK
2026/10/28 05:11:55 DEBUG : with_checksum_big_file_from_pipe: size = 102401 OK
2026/10/28 05:11:55 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:11:57 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': File to upload is small (34 bytes), uploading instead of streaming
2026/10/28 05:11:59 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK
2026/10/28 05:11:59 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/10/28 05:12:00 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465
2026/10/28 05:12:01 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK
2026/10/28 05:12:01 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-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:03 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': File to upload is small (34 bytes), uploading instead of streaming
2026/10/28 05:12:05 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK
2026/10/28 05:12:05 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/10/28 05:12:05 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465
2026/10/28 05:12:06 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK
2026/10/28 05:12:06 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical
--- PASS: TestRcat (23.13s)
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (5.93s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (5.59s)
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (5.83s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (5.79s)
=== RUN   TestRcatMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
=== RUN   TestRcatMetadata/Normal
2026/10/28 05:12:09 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': File to upload is small (48 bytes), uploading instead of streaming
2026/10/28 05:12:10 DEBUG : rcat_metadata: md5 = f5f9349c749c4577851d3fb168a29bce OK
2026/10/28 05:12:10 DEBUG : rcat_metadata: size = 48 OK
2026/10/28 05:12:10 DEBUG : rcat_metadata: Size of src and dst objects identical
=== RUN   TestRcatMetadata/ViaDisk
2026/10/28 05:12:12 DEBUG : rijssoobhbn85c5p1imhg55m6frank1nlplla6hkdjlqmqb2471g: Sending chunk 0 length 111
2026/10/28 05:12:13 DEBUG : rcat_metadata_uploadcutoff0: md5 = 6f3cd1f1feb37be8038b85e3ec7f78f6 OK
2026/10/28 05:12:13 DEBUG : rcat_metadata_uploadcutoff0: size = 63 OK
2026/10/28 05:12:13 DEBUG : rcat_metadata_uploadcutoff0: Size of src and dst objects identical
--- PASS: TestRcatMetadata (6.50s)
    --- PASS: TestRcatMetadata/Normal (2.96s)
    --- PASS: TestRcatMetadata/ViaDisk (3.10s)
=== RUN   TestRcatSize
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:17 DEBUG : potato1: md5 = 49b802d4e3d8de62e90090c31aaf1920 OK
2026/10/28 05:12:17 DEBUG : potato1: size = 60 OK
2026/10/28 05:12:17 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': File to upload is small (60 bytes), uploading instead of streaming
2026/10/28 05:12:18 DEBUG : potato2: md5 = 49f8877de9febaacb1d4f6f407e83bac OK
2026/10/28 05:12:18 DEBUG : potato2: size = 60 OK
2026/10/28 05:12:18 DEBUG : potato2: Size of src and dst objects identical
--- PASS: TestRcatSize (5.10s)
=== RUN   TestRcatSizeShortEOF
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:22 DEBUG : potato1: md5 = e93363cec4525876103be7241fc046fc OK
2026/10/28 05:12:22 DEBUG : potato1: size = 120 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 05:12:22 DEBUG : potato1: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 05:12:22 ERROR : potato1: corrupted on transfer: sizes differ src 120 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada') 60
2026/10/28 05:12:22 INFO  : potato1: Removing failed copy
--- PASS: TestRcatSizeShortEOF (2.55s)
=== RUN   TestRcatSizeMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:24 DEBUG : potato1: md5 = f3907a4a4ee2b78c94a790d4720c5bd3 OK
2026/10/28 05:12:24 DEBUG : potato1: size = 60 OK
2026/10/28 05:12:24 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': File to upload is small (60 bytes), uploading instead of streaming
2026/10/28 05:12:26 DEBUG : potato2: md5 = 58b577dd8cdcfb82b097caf8aa56dfe2 OK
2026/10/28 05:12:26 DEBUG : potato2: size = 60 OK
2026/10/28 05:12:26 DEBUG : potato2: Size of src and dst objects identical
--- PASS: TestRcatSizeMetadata (5.61s)
=== RUN   TestRcatSizeUploadHeaders
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:30 DEBUG : potato1: md5 = 1fa7d34e6736731c07d20d2651757992 OK
2026/10/28 05:12:30 DEBUG : potato1: size = 60 OK
--- PASS: TestRcatSizeUploadHeaders (2.65s)
=== RUN   TestRcatSizeChecksum
=== RUN   TestRcatSizeChecksum/Corrupted
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
    operations_test.go:2046: Skipping as destination doesn't support hashes
=== RUN   TestRcatSizeChecksum/SizeDiffers
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:33 DEBUG : potato4: md5 = a22e60af92faa341beba01bc76e7fc3f OK
2026/10/28 05:12:33 DEBUG : potato4: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 05:12:33 DEBUG : potato4: size = 59 (Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada')
2026/10/28 05:12:33 ERROR : potato4: corrupted on transfer: sizes differ src 60 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada') 59
2026/10/28 05:12:33 INFO  : potato4: Removing failed copy
=== RUN   TestRcatSizeChecksum/IgnoreChecksum
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:36 DEBUG : potato2: size = 60 OK
=== RUN   TestRcatSizeChecksum/NoHashes
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:39 DEBUG : potato3: md5 = 81694372e1b293287d5bbacced6437a5 OK
2026/10/28 05:12:39 DEBUG : potato3: size = 60 OK
--- PASS: TestRcatSizeChecksum (8.77s)
    --- SKIP: TestRcatSizeChecksum/Corrupted (0.45s)
    --- PASS: TestRcatSizeChecksum/SizeDiffers (2.74s)
    --- PASS: TestRcatSizeChecksum/IgnoreChecksum (2.81s)
    --- PASS: TestRcatSizeChecksum/NoHashes (2.77s)
=== RUN   TestTouchDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:41 DEBUG : potato2: md5 = 32a2485513df34baf84d8bcfb241c5dc OK
2026/10/28 05:12:43 DEBUG : empty space: md5 = 4b8d7ecf16bb8b002567fa0247b3880f OK
2026/10/28 05:12:46 DEBUG : sub dir/potato3: md5 = 004f616128e77490a2360403c74d3f53 OK
2026/10/28 05:12:47 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Touching "sub dir/potato3"
2026/10/28 05:12:47 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Touching "potato2"
2026/10/28 05:12:47 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Touching "empty space"
--- PASS: TestTouchDir (11.68s)
=== RUN   TestMkdirMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:51 DEBUG : dir with metadata: Making directory with metadata
2026/10/28 05:12:52 INFO  : dir with metadata: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
--- PASS: TestMkdirMetadata (2.75s)
=== RUN   TestMkdirModTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:54 DEBUG : directory with modtime: Making directory with metadata
2026/10/28 05:12:55 INFO  : directory with modtime: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/10/28 05:12:55 NOTICE: dry run directory with modtime: Skipped make directory as --dry-run is set
--- PASS: TestMkdirModTime (2.66s)
=== RUN   TestCopyDirMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:12:57 DEBUG : dir with metadata to be copied: Making directory with metadata
2026/10/28 05:12:57 INFO  : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/10/28 05:12:57 DEBUG : Google drive root 'crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg': Skipping btime metadata as can't update it on an existing file: 2026-10-28T05:12:57.224690053Z
2026/10/28 05:12:58 INFO  : non existent directory: Updated directory metadata
2026/10/28 05:13:00 DEBUG : Google drive root 'crypt/8jqjocakbpg575sqrb3jg3jbfqrd3ugdv5se2hnih68ead12r9gg': Skipping btime metadata as can't update it on an existing file: 2026-10-28T05:12:57.224690053Z
2026/10/28 05:13:01 INFO  : existing directory: Updated directory metadata
--- PASS: TestCopyDirMetadata (5.66s)
=== RUN   TestSetDirModTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:13:02 DEBUG : set modtime on non existent directory: Skipping set directory modification time as --no-update-dir-modtime is set
2026/10/28 05:13:05 INFO  : set modtime on existing directory: Set directory modification time (using SetModTime)
2026/10/28 05:13:05 INFO  : set modtime on existing directory: Set directory modification time (using DirSetModTime)
--- PASS: TestSetDirModTime (4.91s)
=== RUN   TestDirsEqual
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:13:07 DEBUG : dir with metadata to be copied: Making directory with metadata
2026/10/28 05:13:07 INFO  : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/10/28 05:13:07 DEBUG : dst: Making directory with metadata
2026/10/28 05:13:08 INFO  : dst: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/10/28 05:13:08 DEBUG : dst: Directory modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/10/28 05:13:09 INFO  : dst: Set directory modification time (using SetModTime)
2026/10/28 05:13:09 INFO  : dst: Set directory modification time (using SetModTime)
2026/10/28 05:13:09 DEBUG : dst: Directory modification time the same (differ by 1ns, within tolerance 1ms)
2026/10/28 05:13:10 INFO  : dst: Set directory modification time (using SetModTime)
2026/10/28 05:13:10 DEBUG : dst: Destination directory is newer than source, skipping
--- PASS: TestDirsEqual (4.31s)
=== RUN   TestRemoveExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada'", Local "Local file system at /tmp/rclone3097667400", Modify Window "1ms"
2026/10/28 05:13:14 DEBUG : sub dir/test remove existing: md5 = 5f224d085184639706ab30e0c64340d1 OK
2026/10/28 05:13:16 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: md5 = 74fbf0542c419bbf5dcbc168991bff11 OK
2026/10/28 05:13:18 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.gapetod9" before starting
2026/10/28 05:13:20 DEBUG : sub dir/test remove existing.gapetod9: TEST: removing renamed existing file after operation
2026/10/28 05:13:21 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.xahecan5" before starting
2026/10/28 05:13:22 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.xahecan5: TEST: renaming existing back after failed operation
2026/10/28 05:13:24 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.cexaleb3" before starting
2026/10/28 05:13:25 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.cexaleb3: TEST: removing renamed existing file after operation
--- PASS: TestRemoveExisting (15.81s)
=== RUN   TestRcatInputFailurePreservesDestination
2026/10/28 05:13:27 DEBUG : Creating backend with remote "/tmp/TestRcatInputFailurePreservesDestination3530176176/001"
--- 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/10/28 05:13:27 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-riqitop7wada': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose" - Finished OK in 24m53.356999844s (try 1/5)